builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1450292197.56 results: success (0) buildid: 20151216101138 builduid: c14a76ad50ee4feba7919d9cee80cc50 revision: e735b7607ae25e5769d49fb848292d56889330fe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.562188) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.562568) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.562847) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006322 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.586096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.586395) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.608560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.608833) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.671359) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.671648) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.672071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.672346) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 10:56:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.3M=0s 2015-12-16 10:56:38 (43.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.107419 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.794820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.795172) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020151 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.846497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:37.846807) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e735b7607ae25e5769d49fb848292d56889330fe --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 e735b7607ae25e5769d49fb848292d56889330fe --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=e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 10:56:38,184 truncating revision to first 12 chars 2015-12-16 10:56:38,184 Setting DEBUG logging. 2015-12-16 10:56:38,184 attempt 1/10 2015-12-16 10:56:38,184 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e735b7607ae2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 10:56:38,482 unpacking tar archive at: fx-team-e735b7607ae2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675338 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:38.535869) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:38.536201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:38.547383) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:38.547653) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 10:56:38.548046) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-12-16 10:56:38.548328) ========= /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=e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:56:38 INFO - MultiFileLogger online at 20151216 10:56:38 in /builds/slave/test 10:56:38 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 10:56:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:56:38 INFO - {'append_to_log': False, 10:56:38 INFO - 'base_work_dir': '/builds/slave/test', 10:56:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:56:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:56:38 INFO - 'branch': 'Fx-Team-Non-PGO', 10:56:38 INFO - 'buildbot_json_path': 'buildprops.json', 10:56:38 INFO - 'config_files': ('talos/linux_config.py',), 10:56:38 INFO - 'default_actions': ('clobber', 10:56:38 INFO - 'read-buildbot-config', 10:56:38 INFO - 'download-and-extract', 10:56:38 INFO - 'populate-webroot', 10:56:38 INFO - 'create-virtualenv', 10:56:38 INFO - 'install', 10:56:38 INFO - 'run-tests'), 10:56:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:56:38 INFO - 'download_minidump_stackwalk': True, 10:56:38 INFO - 'download_symbols': 'ondemand', 10:56:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:56:38 INFO - 'tooltool.py': '/tools/tooltool.py', 10:56:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:56:38 INFO - '/tools/misc-python/virtualenv.py')}, 10:56:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:56:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:56:38 INFO - 'installer_path': 'installer.exe', 10:56:38 INFO - 'log_level': 'info', 10:56:38 INFO - 'log_name': 'talos', 10:56:38 INFO - 'log_to_console': True, 10:56:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:56:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:56:38 INFO - 'opt_config_files': (), 10:56:38 INFO - 'pip_index': False, 10:56:38 INFO - 'sps_profile': False, 10:56:38 INFO - 'sps_profile_interval': 0, 10:56:38 INFO - 'suite': 'dromaeojs', 10:56:38 INFO - 'system_bits': '64', 10:56:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:56:38 INFO - 'title': 'talos-linux64-ix-058', 10:56:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:56:38 INFO - 'use_talos_json': True, 10:56:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:56:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:56:38 INFO - 'work_dir': 'build'} 10:56:38 INFO - ##### 10:56:38 INFO - ##### Running clobber step. 10:56:38 INFO - ##### 10:56:38 INFO - Running pre-action listener: _resource_record_pre_action 10:56:38 INFO - Running main action method: clobber 10:56:38 INFO - rmtree: /builds/slave/test/build 10:56:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:56:39 INFO - Running post-action listener: _resource_record_post_action 10:56:39 INFO - ##### 10:56:39 INFO - ##### Running read-buildbot-config step. 10:56:39 INFO - ##### 10:56:39 INFO - Running pre-action listener: _resource_record_pre_action 10:56:39 INFO - Running main action method: read_buildbot_config 10:56:39 INFO - Using buildbot properties: 10:56:39 INFO - { 10:56:39 INFO - "properties": { 10:56:39 INFO - "buildnumber": 2222, 10:56:39 INFO - "product": "firefox", 10:56:39 INFO - "script_repo_revision": "production", 10:56:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:56:39 INFO - "repository": "", 10:56:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:56:39 INFO - "buildid": "20151216101138", 10:56:39 INFO - "slavename": "talos-linux64-ix-058", 10:56:39 INFO - "pgo_build": "False", 10:56:39 INFO - "basedir": "/builds/slave/test", 10:56:39 INFO - "project": "", 10:56:39 INFO - "platform": "ubuntu64_hw", 10:56:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:56:39 INFO - "slavebuilddir": "test", 10:56:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:56:39 INFO - "branch": "fx-team", 10:56:39 INFO - "repo_path": "integration/fx-team", 10:56:39 INFO - "stage_platform": "linux64", 10:56:39 INFO - "builduid": "c14a76ad50ee4feba7919d9cee80cc50", 10:56:39 INFO - "revision": "e735b7607ae25e5769d49fb848292d56889330fe" 10:56:39 INFO - }, 10:56:39 INFO - "sourcestamp": { 10:56:39 INFO - "repository": "", 10:56:39 INFO - "hasPatch": false, 10:56:39 INFO - "project": "", 10:56:39 INFO - "branch": "fx-team-linux64-talos", 10:56:39 INFO - "changes": [ 10:56:39 INFO - { 10:56:39 INFO - "category": null, 10:56:39 INFO - "files": [ 10:56:39 INFO - { 10:56:39 INFO - "url": null, 10:56:39 INFO - "name": "https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 10:56:39 INFO - } 10:56:39 INFO - ], 10:56:39 INFO - "repository": "", 10:56:39 INFO - "rev": "e735b7607ae25e5769d49fb848292d56889330fe", 10:56:39 INFO - "who": "pbrosset@mozilla.com", 10:56:39 INFO - "when": 1450292151, 10:56:39 INFO - "number": 7367596, 10:56:39 INFO - "comments": "Bug 1224932 - Center the element in the layout-view; r=bgrins", 10:56:39 INFO - "project": "", 10:56:39 INFO - "at": "Wed 16 Dec 2015 10:55:51", 10:56:39 INFO - "branch": "fx-team-linux64-talos", 10:56:39 INFO - "revlink": "", 10:56:39 INFO - "properties": [ 10:56:39 INFO - [ 10:56:39 INFO - "buildid", 10:56:39 INFO - "20151216101138", 10:56:39 INFO - "Change" 10:56:39 INFO - ], 10:56:39 INFO - [ 10:56:39 INFO - "builduid", 10:56:39 INFO - "c14a76ad50ee4feba7919d9cee80cc50", 10:56:39 INFO - "Change" 10:56:39 INFO - ], 10:56:39 INFO - [ 10:56:39 INFO - "pgo_build", 10:56:39 INFO - "False", 10:56:39 INFO - "Change" 10:56:39 INFO - ] 10:56:39 INFO - ], 10:56:39 INFO - "revision": "e735b7607ae25e5769d49fb848292d56889330fe" 10:56:39 INFO - } 10:56:39 INFO - ], 10:56:39 INFO - "revision": "e735b7607ae25e5769d49fb848292d56889330fe" 10:56:39 INFO - } 10:56:39 INFO - } 10:56:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 10:56:39 INFO - Running post-action listener: _resource_record_post_action 10:56:39 INFO - ##### 10:56:39 INFO - ##### Running download-and-extract step. 10:56:39 INFO - ##### 10:56:39 INFO - Running pre-action listener: _resource_record_pre_action 10:56:39 INFO - Running main action method: download_and_extract 10:56:39 INFO - mkdir: /builds/slave/test/build/tests 10:56:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:39 INFO - https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:56:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/test_packages.json 10:56:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/test_packages.json 10:56:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:56:43 INFO - Downloaded 1302 bytes. 10:56:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:56:43 INFO - Using the following test package requirements: 10:56:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:56:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:43 INFO - u'jsshell-linux-x86_64.zip'], 10:56:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:56:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:56:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:56:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:56:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 10:56:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 10:56:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:56:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:56:43 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')]} 10:56:43 INFO - https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:56:44 INFO - Downloaded 21870297 bytes. 10:56:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:56:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:56:45 INFO - Return code: 0 10:56:45 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:56:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:56:45 INFO - https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:56:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:56:58 INFO - Downloaded 21870297 bytes. 10:56:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:56:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 10:56:58 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:56:59 INFO - Return code: 0 10:56: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')]} 10:56:59 INFO - https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:57:00 INFO - Downloaded 11132052 bytes. 10:57:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 10:57:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 10:57:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:57:00 INFO - Return code: 0 10:57:00 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')]} 10:57:00 INFO - https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:57:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:57:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:57:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:57:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:57:08 INFO - Downloaded 57745490 bytes. 10:57:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:57:08 INFO - mkdir: /builds/slave/test/properties 10:57:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:57:08 INFO - Writing to file /builds/slave/test/properties/build_url 10:57:08 INFO - Contents: 10:57:08 INFO - build_url:https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 10:57:08 INFO - Running post-action listener: _resource_record_post_action 10:57:08 INFO - Running post-action listener: set_extra_try_arguments 10:57:08 INFO - ##### 10:57:08 INFO - ##### Running populate-webroot step. 10:57:08 INFO - ##### 10:57:08 INFO - Running pre-action listener: _resource_record_pre_action 10:57:08 INFO - Running main action method: populate_webroot 10:57:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:57:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:57:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:57:08 INFO - '--tppagecycles', 10:57:08 INFO - '7'], 10:57:08 INFO - 'tests': ['tsvgm']}}, 10:57:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:57:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:57:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:57:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:57:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:57:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:57:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:08 INFO - 'talos_options': ['--e10s'], 10:57:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:57:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:08 INFO - 'tests': ['damp', 'tps']}, 10:57:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:08 INFO - 'talos_options': ['--e10s'], 10:57:08 INFO - 'tests': ['damp', 'tps']}, 10:57:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:57:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:57:08 INFO - 'other': {'tests': ['a11yr', 10:57:08 INFO - 'ts_paint', 10:57:08 INFO - 'tpaint', 10:57:08 INFO - 'sessionrestore', 10:57:08 INFO - 'sessionrestore_no_auto_restore']}, 10:57:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:57:08 INFO - 'tests': ['a11yr', 10:57:08 INFO - 'ts_paint', 10:57:08 INFO - 'tpaint', 10:57:08 INFO - 'sessionrestore', 10:57:08 INFO - 'sessionrestore_no_auto_restore']}, 10:57:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:57:08 INFO - 'tests': ['a11yr', 10:57:08 INFO - 'ts_paint', 10:57:08 INFO - 'tpaint', 10:57:08 INFO - 'sessionrestore', 10:57:08 INFO - 'sessionrestore_no_auto_restore']}, 10:57:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:57:08 INFO - 'tests': ['a11yr', 10:57:08 INFO - 'ts_paint', 10:57:08 INFO - 'tpaint', 10:57:08 INFO - 'sessionrestore', 10:57:08 INFO - 'sessionrestore_no_auto_restore']}, 10:57:08 INFO - 'other_l64': {'tests': ['a11yr', 10:57:08 INFO - 'ts_paint', 10:57:08 INFO - 'tpaint', 10:57:08 INFO - 'sessionrestore', 10:57:08 INFO - 'sessionrestore_no_auto_restore']}, 10:57:08 INFO - 'other_nol64': {'tests': ['a11yr', 10:57:08 INFO - 'ts_paint', 10:57:08 INFO - 'tpaint', 10:57:08 INFO - 'sessionrestore', 10:57:08 INFO - 'sessionrestore_no_auto_restore']}, 10:57:08 INFO - 'svgr': {'tests': ['tsvgx', 10:57:08 INFO - 'tsvgr_opacity', 10:57:08 INFO - 'tart', 10:57:08 INFO - 'tscrollx', 10:57:08 INFO - 'cart']}, 10:57:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:57:08 INFO - 'tests': ['tsvgx', 10:57:08 INFO - 'tsvgr_opacity', 10:57:08 INFO - 'tart', 10:57:08 INFO - 'tscrollx', 10:57:08 INFO - 'cart']}, 10:57:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:08 INFO - 'tests': ['tp5o']}, 10:57:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:08 INFO - 'talos_options': ['--e10s'], 10:57:08 INFO - 'tests': ['tp5o']}, 10:57:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:08 INFO - 'talos_options': ['--xperf_path', 10:57:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:08 INFO - 'tests': ['tp5n']}, 10:57:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:57:08 INFO - 'talos_options': ['--e10s', 10:57:08 INFO - '--xperf_path', 10:57:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:57:08 INFO - 'tests': ['tp5n']}}, 10:57:08 INFO - 'talos.zip': {'path': '', 10:57:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:57:08 INFO - Running post-action listener: _resource_record_post_action 10:57:08 INFO - ##### 10:57:08 INFO - ##### Running create-virtualenv step. 10:57:08 INFO - ##### 10:57:08 INFO - Running pre-action listener: _resource_record_pre_action 10:57:08 INFO - Running main action method: create_virtualenv 10:57:08 INFO - Creating virtualenv /builds/slave/test/build/venv 10:57:08 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 10:57:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:57:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:57:08 INFO - Using real prefix '/usr' 10:57:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:57:09 INFO - Installing distribute.............................................................................................................................................................................................done. 10:57:11 INFO - Installing pip.................done. 10:57:11 INFO - Return code: 0 10:57:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0f02f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e10b0>, '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 0x14e1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', '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 10:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:57:11 INFO - Using env: {'DISPLAY': ':0', 10:57:11 INFO - 'HOME': '/home/cltbld', 10:57:11 INFO - 'LANG': 'en_US.UTF-8', 10:57:11 INFO - 'LANGUAGE': 'en_US:en', 10:57:11 INFO - 'LOGNAME': 'cltbld', 10:57:11 INFO - 'MAIL': '/var/mail/cltbld', 10:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:11 INFO - 'MOZ_NO_REMOTE': '1', 10:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:11 INFO - 'NO_EM_RESTART': '1', 10:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:11 INFO - 'PWD': '/builds/slave/test', 10:57:11 INFO - 'SHELL': '/bin/bash', 10:57:11 INFO - 'SHLVL': '1', 10:57:11 INFO - 'TERM': 'linux', 10:57:11 INFO - 'TMOUT': '86400', 10:57:11 INFO - 'USER': 'cltbld', 10:57:11 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', 10:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:11 INFO - '_': '/tools/buildbot/bin/python'} 10:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:11 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 10:57:11 INFO - Cleaning up... 10:57:11 INFO - Return code: 0 10:57:11 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe0f02f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e10b0>, '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 0x14e1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', '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 10:57:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:57:11 INFO - Using env: {'DISPLAY': ':0', 10:57:11 INFO - 'HOME': '/home/cltbld', 10:57:11 INFO - 'LANG': 'en_US.UTF-8', 10:57:11 INFO - 'LANGUAGE': 'en_US:en', 10:57:11 INFO - 'LOGNAME': 'cltbld', 10:57:11 INFO - 'MAIL': '/var/mail/cltbld', 10:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:11 INFO - 'MOZ_NO_REMOTE': '1', 10:57:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:11 INFO - 'NO_EM_RESTART': '1', 10:57:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:11 INFO - 'PWD': '/builds/slave/test', 10:57:11 INFO - 'SHELL': '/bin/bash', 10:57:11 INFO - 'SHLVL': '1', 10:57:11 INFO - 'TERM': 'linux', 10:57:11 INFO - 'TMOUT': '86400', 10:57:11 INFO - 'USER': 'cltbld', 10:57:11 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', 10:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:11 INFO - '_': '/tools/buildbot/bin/python'} 10:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:11 INFO - Downloading/unpacking psutil>=0.7.1 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:13 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:57:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:57:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:13 INFO - Installing collected packages: psutil 10:57:13 INFO - Running setup.py install for psutil 10:57:13 INFO - building 'psutil._psutil_linux' extension 10:57:13 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 10:57:13 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 10:57:13 INFO - building 'psutil._psutil_posix' extension 10:57:13 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 10:57:13 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 10:57:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:57:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:57:13 INFO - Successfully installed psutil 10:57:13 INFO - Cleaning up... 10:57:14 INFO - Return code: 0 10:57:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fe0f02f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e10b0>, '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 0x14e1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', '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 10:57:14 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 10:57:14 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 10:57:14 INFO - Using env: {'DISPLAY': ':0', 10:57:14 INFO - 'HOME': '/home/cltbld', 10:57:14 INFO - 'LANG': 'en_US.UTF-8', 10:57:14 INFO - 'LANGUAGE': 'en_US:en', 10:57:14 INFO - 'LOGNAME': 'cltbld', 10:57:14 INFO - 'MAIL': '/var/mail/cltbld', 10:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:14 INFO - 'MOZ_NO_REMOTE': '1', 10:57:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:14 INFO - 'NO_EM_RESTART': '1', 10:57:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:14 INFO - 'PWD': '/builds/slave/test', 10:57:14 INFO - 'SHELL': '/bin/bash', 10:57:14 INFO - 'SHLVL': '1', 10:57:14 INFO - 'TERM': 'linux', 10:57:14 INFO - 'TMOUT': '86400', 10:57:14 INFO - 'USER': 'cltbld', 10:57:14 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', 10:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:14 INFO - '_': '/tools/buildbot/bin/python'} 10:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:57:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:57:16 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:57:16 INFO - Installing collected packages: mozsystemmonitor 10:57:16 INFO - Running setup.py install for mozsystemmonitor 10:57:16 INFO - Successfully installed mozsystemmonitor 10:57:16 INFO - Cleaning up... 10:57:16 INFO - Return code: 0 10:57:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:57:16 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')]} 10:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:16 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')]} 10:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:16 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 0x7fe0f02f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e10b0>, '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 0x14e1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', '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 10:57:16 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 10:57:16 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 10:57:16 INFO - Using env: {'DISPLAY': ':0', 10:57:16 INFO - 'HOME': '/home/cltbld', 10:57:16 INFO - 'LANG': 'en_US.UTF-8', 10:57:16 INFO - 'LANGUAGE': 'en_US:en', 10:57:16 INFO - 'LOGNAME': 'cltbld', 10:57:16 INFO - 'MAIL': '/var/mail/cltbld', 10:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:16 INFO - 'MOZ_NO_REMOTE': '1', 10:57:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:16 INFO - 'NO_EM_RESTART': '1', 10:57:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:16 INFO - 'PWD': '/builds/slave/test', 10:57:16 INFO - 'SHELL': '/bin/bash', 10:57:16 INFO - 'SHLVL': '1', 10:57:16 INFO - 'TERM': 'linux', 10:57:16 INFO - 'TMOUT': '86400', 10:57:16 INFO - 'USER': 'cltbld', 10:57:16 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', 10:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:16 INFO - '_': '/tools/buildbot/bin/python'} 10:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:16 INFO - Downloading/unpacking blobuploader==1.2.4 10:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:18 INFO - Downloading blobuploader-1.2.4.tar.gz 10:57:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:57:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:57:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:18 INFO - Downloading docopt-0.6.1.tar.gz 10:57:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:57:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:57:18 INFO - Installing collected packages: blobuploader, requests, docopt 10:57:18 INFO - Running setup.py install for blobuploader 10:57:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:57:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:57:18 INFO - Running setup.py install for requests 10:57:19 INFO - Running setup.py install for docopt 10:57:19 INFO - Successfully installed blobuploader requests docopt 10:57:19 INFO - Cleaning up... 10:57:19 INFO - Return code: 0 10:57:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:19 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 0x7fe0f02f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e10b0>, '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 0x14e1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', '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 10:57:19 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 10:57:19 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 10:57:19 INFO - Using env: {'DISPLAY': ':0', 10:57:19 INFO - 'HOME': '/home/cltbld', 10:57:19 INFO - 'LANG': 'en_US.UTF-8', 10:57:19 INFO - 'LANGUAGE': 'en_US:en', 10:57:19 INFO - 'LOGNAME': 'cltbld', 10:57:19 INFO - 'MAIL': '/var/mail/cltbld', 10:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:19 INFO - 'MOZ_NO_REMOTE': '1', 10:57:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:19 INFO - 'NO_EM_RESTART': '1', 10:57:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:19 INFO - 'PWD': '/builds/slave/test', 10:57:19 INFO - 'SHELL': '/bin/bash', 10:57:19 INFO - 'SHLVL': '1', 10:57:19 INFO - 'TERM': 'linux', 10:57:19 INFO - 'TMOUT': '86400', 10:57:19 INFO - 'USER': 'cltbld', 10:57:19 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', 10:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:19 INFO - '_': '/tools/buildbot/bin/python'} 10:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:19 INFO - Running setup.py (path:/tmp/pip-aJg0NC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:19 INFO - Running setup.py (path:/tmp/pip-85wZty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:19 INFO - Running setup.py (path:/tmp/pip-SbV4ym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:19 INFO - Running setup.py (path:/tmp/pip-d6Scxe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:19 INFO - Running setup.py (path:/tmp/pip-KM3B73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:19 INFO - Running setup.py (path:/tmp/pip-bsGGKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:20 INFO - Running setup.py (path:/tmp/pip-fdrsLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:20 INFO - Running setup.py (path:/tmp/pip-DNvOtu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:20 INFO - Running setup.py (path:/tmp/pip-84hXdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:20 INFO - Running setup.py (path:/tmp/pip-Iipyld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:20 INFO - Running setup.py (path:/tmp/pip-IEj4bJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:20 INFO - Running setup.py (path:/tmp/pip-omfnBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:20 INFO - Running setup.py (path:/tmp/pip-LR6qK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:20 INFO - Running setup.py (path:/tmp/pip-twDryC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:20 INFO - Running setup.py (path:/tmp/pip-sFksh3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:20 INFO - Running setup.py (path:/tmp/pip-YisxZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:20 INFO - Running setup.py (path:/tmp/pip-LKx32n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:57:20 INFO - Running setup.py install for manifestparser 10:57:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:57:20 INFO - Running setup.py install for mozcrash 10:57:21 INFO - Running setup.py install for mozdebug 10:57:21 INFO - Running setup.py install for mozdevice 10:57:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:57:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:57:21 INFO - Running setup.py install for mozfile 10:57:21 INFO - Running setup.py install for mozhttpd 10:57:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:57:21 INFO - Running setup.py install for mozinfo 10:57:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:57:21 INFO - Running setup.py install for mozInstall 10:57:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:57:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:57:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:57:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:57:21 INFO - Running setup.py install for mozleak 10:57:21 INFO - Running setup.py install for mozlog 10:57:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:57:21 INFO - Running setup.py install for moznetwork 10:57:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:57:21 INFO - Running setup.py install for mozprocess 10:57:22 INFO - Running setup.py install for mozprofile 10:57:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:57:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:57:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:57:22 INFO - Running setup.py install for mozrunner 10:57:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:57:22 INFO - Running setup.py install for mozscreenshot 10:57:22 INFO - Running setup.py install for moztest 10:57:22 INFO - Running setup.py install for mozversion 10:57:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:57:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:57:22 INFO - Cleaning up... 10:57:22 INFO - Return code: 0 10:57:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57: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')]} 10:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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/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 0x7fe0f02f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e10b0>, '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 0x14e1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', '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 10:57: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/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 10:57: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/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 10:57:22 INFO - Using env: {'DISPLAY': ':0', 10:57:22 INFO - 'HOME': '/home/cltbld', 10:57:22 INFO - 'LANG': 'en_US.UTF-8', 10:57:22 INFO - 'LANGUAGE': 'en_US:en', 10:57:22 INFO - 'LOGNAME': 'cltbld', 10:57:22 INFO - 'MAIL': '/var/mail/cltbld', 10:57:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:22 INFO - 'MOZ_NO_REMOTE': '1', 10:57:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:22 INFO - 'NO_EM_RESTART': '1', 10:57:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:22 INFO - 'PWD': '/builds/slave/test', 10:57:22 INFO - 'SHELL': '/bin/bash', 10:57:22 INFO - 'SHLVL': '1', 10:57:22 INFO - 'TERM': 'linux', 10:57:22 INFO - 'TMOUT': '86400', 10:57:22 INFO - 'USER': 'cltbld', 10:57:22 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', 10:57:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:22 INFO - '_': '/tools/buildbot/bin/python'} 10:57:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:22 INFO - Running setup.py (path:/tmp/pip-HZq2IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:22 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)) 10:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:22 INFO - Running setup.py (path:/tmp/pip-dIvSGf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:22 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)) 10:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:22 INFO - Running setup.py (path:/tmp/pip-M8NM27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:23 INFO - Running setup.py (path:/tmp/pip-xxUOdE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:23 INFO - Running setup.py (path:/tmp/pip-Z__ztG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:23 INFO - Running setup.py (path:/tmp/pip-3EUJWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:23 INFO - Running setup.py (path:/tmp/pip-t7QLeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:23 INFO - Running setup.py (path:/tmp/pip-w3lNaO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:23 INFO - Running setup.py (path:/tmp/pip-tUhtoN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:23 INFO - Running setup.py (path:/tmp/pip-8qIW8Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:23 INFO - Running setup.py (path:/tmp/pip-l3dOKI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:23 INFO - Running setup.py (path:/tmp/pip-BaBLjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:23 INFO - Running setup.py (path:/tmp/pip-3P7HYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:23 INFO - Running setup.py (path:/tmp/pip-EgJCAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:23 INFO - Running setup.py (path:/tmp/pip-eYhiKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:23 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)) 10:57:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:23 INFO - Running setup.py (path:/tmp/pip-E_90ZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:24 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)) 10:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:24 INFO - Running setup.py (path:/tmp/pip-CKTED9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:24 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)) 10:57:24 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)) 10:57:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:57:24 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)) 10:57:24 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)) 10:57:24 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)) 10:57:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:25 INFO - Downloading blessings-1.5.1.tar.gz 10:57:25 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 10:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:25 INFO - Installing collected packages: blessings 10:57:25 INFO - Running setup.py install for blessings 10:57:25 INFO - Successfully installed blessings 10:57:25 INFO - Cleaning up... 10:57:26 INFO - Return code: 0 10:57:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:57:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:26 INFO - Reading from file tmpfile_stdout 10:57:26 INFO - Current package versions: 10:57:26 INFO - argparse == 1.2.1 10:57:26 INFO - blessings == 1.5.1 10:57:26 INFO - blobuploader == 1.2.4 10:57:26 INFO - docopt == 0.6.1 10:57:26 INFO - manifestparser == 1.1 10:57:26 INFO - mozInstall == 1.12 10:57:26 INFO - mozcrash == 0.16 10:57:26 INFO - mozdebug == 0.1 10:57:26 INFO - mozdevice == 0.47 10:57:26 INFO - mozfile == 1.2 10:57:26 INFO - mozhttpd == 0.7 10:57:26 INFO - mozinfo == 0.9 10:57:26 INFO - mozleak == 0.1 10:57:26 INFO - mozlog == 3.1 10:57:26 INFO - moznetwork == 0.27 10:57:26 INFO - mozprocess == 0.22 10:57:26 INFO - mozprofile == 0.27 10:57:26 INFO - mozrunner == 6.11 10:57:26 INFO - mozscreenshot == 0.1 10:57:26 INFO - mozsystemmonitor == 0.0 10:57:26 INFO - moztest == 0.7 10:57:26 INFO - mozversion == 1.4 10:57:26 INFO - psutil == 3.1.1 10:57:26 INFO - requests == 1.2.3 10:57:26 INFO - wsgiref == 0.1.2 10:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe0f02f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e10b0>, '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 0x14e1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', '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 10:57:26 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 10:57:26 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 10:57:26 INFO - Using env: {'DISPLAY': ':0', 10:57:26 INFO - 'HOME': '/home/cltbld', 10:57:26 INFO - 'LANG': 'en_US.UTF-8', 10:57:26 INFO - 'LANGUAGE': 'en_US:en', 10:57:26 INFO - 'LOGNAME': 'cltbld', 10:57:26 INFO - 'MAIL': '/var/mail/cltbld', 10:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:26 INFO - 'MOZ_NO_REMOTE': '1', 10:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:26 INFO - 'NO_EM_RESTART': '1', 10:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:26 INFO - 'PWD': '/builds/slave/test', 10:57:26 INFO - 'SHELL': '/bin/bash', 10:57:26 INFO - 'SHLVL': '1', 10:57:26 INFO - 'TERM': 'linux', 10:57:26 INFO - 'TMOUT': '86400', 10:57:26 INFO - 'USER': 'cltbld', 10:57:26 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', 10:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:26 INFO - '_': '/tools/buildbot/bin/python'} 10:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:26 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)) 10:57:26 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)) 10:57:26 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)) 10:57:26 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)) 10:57:26 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)) 10:57:26 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)) 10:57:26 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)) 10:57:26 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)) 10:57:26 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)) 10:57:26 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)) 10:57:26 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)) 10:57:26 INFO - Cleaning up... 10:57:26 INFO - Return code: 0 10:57:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe0f02f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e10b0>, '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 0x14e1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', '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 10:57:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:57:26 INFO - Using env: {'DISPLAY': ':0', 10:57:26 INFO - 'HOME': '/home/cltbld', 10:57:26 INFO - 'LANG': 'en_US.UTF-8', 10:57:26 INFO - 'LANGUAGE': 'en_US:en', 10:57:26 INFO - 'LOGNAME': 'cltbld', 10:57:26 INFO - 'MAIL': '/var/mail/cltbld', 10:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:26 INFO - 'MOZ_NO_REMOTE': '1', 10:57:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:26 INFO - 'NO_EM_RESTART': '1', 10:57:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:26 INFO - 'PWD': '/builds/slave/test', 10:57:26 INFO - 'SHELL': '/bin/bash', 10:57:26 INFO - 'SHLVL': '1', 10:57:26 INFO - 'TERM': 'linux', 10:57:26 INFO - 'TMOUT': '86400', 10:57:26 INFO - 'USER': 'cltbld', 10:57:26 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', 10:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:26 INFO - '_': '/tools/buildbot/bin/python'} 10:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:26 INFO - Downloading/unpacking jsonschema 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:57:28 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 10:57:28 INFO - Downloading/unpacking functools32 (from jsonschema) 10:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:28 INFO - Downloading functools32-3.2.3-2.tar.gz 10:57:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:57:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:57:28 INFO - warning: no files found matching '*.txt' 10:57:28 INFO - no previously-included directories found matching 'build' 10:57:28 INFO - no previously-included directories found matching 'dist' 10:57:28 INFO - no previously-included directories found matching '.git*' 10:57:28 INFO - Installing collected packages: jsonschema, functools32 10:57:28 INFO - Running setup.py install for functools32 10:57:28 INFO - warning: no files found matching '*.txt' 10:57:28 INFO - no previously-included directories found matching 'build' 10:57:28 INFO - no previously-included directories found matching 'dist' 10:57:28 INFO - no previously-included directories found matching '.git*' 10:57:28 INFO - Successfully installed jsonschema functools32 10:57:28 INFO - Cleaning up... 10:57:28 INFO - Return code: 0 10:57:28 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:57:28 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')]} 10:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:28 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')]} 10:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:28 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 0x7fe0f02f0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13848a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1452240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e10b0>, '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 0x14e1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2440>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', '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 10:57:28 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 10:57:28 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 10:57:28 INFO - Using env: {'DISPLAY': ':0', 10:57:28 INFO - 'HOME': '/home/cltbld', 10:57:28 INFO - 'LANG': 'en_US.UTF-8', 10:57:28 INFO - 'LANGUAGE': 'en_US:en', 10:57:28 INFO - 'LOGNAME': 'cltbld', 10:57:28 INFO - 'MAIL': '/var/mail/cltbld', 10:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:28 INFO - 'MOZ_NO_REMOTE': '1', 10:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:28 INFO - 'NO_EM_RESTART': '1', 10:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:28 INFO - 'PWD': '/builds/slave/test', 10:57:28 INFO - 'SHELL': '/bin/bash', 10:57:28 INFO - 'SHLVL': '1', 10:57:28 INFO - 'TERM': 'linux', 10:57:28 INFO - 'TMOUT': '86400', 10:57:28 INFO - 'USER': 'cltbld', 10:57:28 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', 10:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:28 INFO - '_': '/tools/buildbot/bin/python'} 10:57:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:29 INFO - Downloading/unpacking flake8 10:57:29 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 10:57:29 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 10:57:29 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 10:57:29 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 10:57:29 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 10:57:29 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 10:57:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:57:30 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 10:57:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:57:30 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 10:57:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:31 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 10:57:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:57:31 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 10:57:31 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 10:57:31 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 10:57:31 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 10:57:31 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 10:57:31 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 10:57:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:57:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:31 INFO - no previously-included directories found matching 'docs/_build' 10:57:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:57:31 INFO - Running setup.py install for pep8 10:57:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:31 INFO - no previously-included directories found matching 'docs/_build' 10:57:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:57:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:57:31 INFO - Cleaning up... 10:57:31 INFO - Return code: 0 10:57:31 INFO - Running post-action listener: _resource_record_post_action 10:57:31 INFO - Running post-action listener: _start_resource_monitoring 10:57:31 INFO - Starting resource monitoring. 10:57:31 INFO - ##### 10:57:31 INFO - ##### Running install step. 10:57:31 INFO - ##### 10:57:31 INFO - Running pre-action listener: _resource_record_pre_action 10:57:31 INFO - Running main action method: install 10:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:31 INFO - Reading from file tmpfile_stdout 10:57:31 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:57:31 INFO - Reading from file tmpfile_stdout 10:57:31 INFO - Output received: 10:57:31 INFO - Usage: mozinstall [options] installer 10:57:31 INFO - Options: 10:57:31 INFO - -h, --help show this help message and exit 10:57:31 INFO - -d DEST, --destination=DEST 10:57:31 INFO - Directory to install application into. [default: 10:57:31 INFO - "/builds/slave/test"] 10:57:31 INFO - --app=APP Application being installed. [default: firefox] 10:57:31 INFO - mkdir: /builds/slave/test/build/application 10:57:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:57:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:57:46 INFO - Reading from file tmpfile_stdout 10:57:46 INFO - Output received: 10:57:46 INFO - /builds/slave/test/build/application/firefox/firefox 10:57:46 INFO - Running post-action listener: _resource_record_post_action 10:57:46 INFO - ##### 10:57:46 INFO - ##### Running run-tests step. 10:57:46 INFO - ##### 10:57:46 INFO - Running pre-action listener: _resource_record_pre_action 10:57:46 INFO - Running main action method: run_tests 10:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:57:46 INFO - Python 2.7.3 10:57:46 INFO - Return code: 0 10:57:46 INFO - grabbing minidump binary from tooltool 10:57:46 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')]} 10:57:46 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 0x14e10b0>, '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 0x14e1fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14e2440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:57:46 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 10:57:46 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 10:57:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:46 INFO - Return code: 0 10:57:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:57:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:57:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:57:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:57:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:57:47 INFO - Return code: 0 10:57:47 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/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] in /builds/slave/test/build 10:57:47 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/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost 10:57:47 INFO - Using env: {'DISPLAY': ':0', 10:57:47 INFO - 'HOME': '/home/cltbld', 10:57:47 INFO - 'LANG': 'en_US.UTF-8', 10:57:47 INFO - 'LANGUAGE': 'en_US:en', 10:57:47 INFO - 'LOGNAME': 'cltbld', 10:57:47 INFO - 'MAIL': '/var/mail/cltbld', 10:57:47 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:57:47 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:57:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:47 INFO - 'MOZ_NO_REMOTE': '1', 10:57:47 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:57:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:57:47 INFO - 'NO_EM_RESTART': '1', 10:57:47 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:57:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:47 INFO - 'PWD': '/builds/slave/test', 10:57:47 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:57:47 INFO - 'SHELL': '/bin/bash', 10:57:47 INFO - 'SHLVL': '1', 10:57:47 INFO - 'TERM': 'linux', 10:57:47 INFO - 'TMOUT': '86400', 10:57:47 INFO - 'USER': 'cltbld', 10:57:47 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294', 10:57:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:47 INFO - '_': '/tools/buildbot/bin/python'} 10:57:47 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/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] with output_timeout 3600 10:57:47 INFO - mozversion INFO | application_buildid: 20151216101138 10:57:47 INFO - mozversion INFO | application_changeset: e735b7607ae25e5769d49fb848292d56889330fe 10:57:47 INFO - mozversion INFO | application_display_name: Nightly 10:57:47 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:47 INFO - mozversion INFO | application_name: Firefox 10:57:47 INFO - mozversion INFO | application_remotingname: firefox 10:57:47 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:57:47 INFO - mozversion INFO | application_vendor: Mozilla 10:57:47 INFO - mozversion INFO | application_version: 46.0a1 10:57:47 INFO - mozversion INFO | platform_buildid: 20151216101138 10:57:47 INFO - mozversion INFO | platform_changeset: e735b7607ae25e5769d49fb848292d56889330fe 10:57:47 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:57:47 INFO - mozversion INFO | platform_version: 46.0a1 10:57:47 INFO - 2015-12-16 10:57:47,682 DEBUG : using testdate: 1450292267 10:57:47 INFO - 2015-12-16 10:57:47,682 DEBUG : actual date: 1450292267 10:57:47 INFO - 2015-12-16 10:57:47,691 INFO : starting webserver on 'localhost:49567' 10:57:47 INFO - 2015-12-16 10:57:47,692 INFO : Starting test suite talos-linux64-ix-058 10:57:47 INFO - 2015-12-16 10:57:47,692 INFO : Starting test dromaeo_css 10:57:47 INFO - 2015-12-16 10:57:47,693 DEBUG : operating with platform_type : linux_ 10:57:47 INFO - 2015-12-16 10:57:47,693 INFO : Initialising browser for dromaeo_css test... 10:57:47 INFO - 2015-12-16 10:57:47,705 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF2dhNm/profile http://localhost:49567/getInfo.html 10:57:52 INFO - 2015-12-16 10:57:52,539 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:57:52 INFO - 2015-12-16 10:57:52,539 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:57:52 INFO - 2015-12-16 10:57:52,539 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:57:52 INFO - 2015-12-16 10:57:52,539 DEBUG : BROWSER_OUTPUT: __metrics 10:57:52 INFO - 2015-12-16 10:57:52,608 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] 10:57:52 INFO - 2015-12-16 10:57:52,676 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] 10:57:53 INFO - 2015-12-16 10:57:53,625 INFO : Browser initialized. 10:57:53 INFO - 2015-12-16 10:57:53,625 INFO : Running cycle 1/1 for dromaeo_css test... 10:57:53 INFO - 2015-12-16 10:57:53,626 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpF2dhNm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:58:05 INFO - 2015-12-16 10:58:05,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 142479360 10:58:05 INFO - 2015-12-16 10:58:05,640 DEBUG : BROWSER_OUTPUT: 10:58:56 INFO - 2015-12-16 10:58:56,906 DEBUG : BROWSER_OUTPUT: 1450292336905 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:01:08 INFO - 2015-12-16 11:01:08,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49567/tests/dromaeo/cssquery-ext.html) 11:01:09 INFO - 2015-12-16 11:01:09,989 DEBUG : BROWSER_OUTPUT: RSS: Main: 251117568 11:01:09 INFO - 2015-12-16 11:01:09,990 DEBUG : BROWSER_OUTPUT: 11:04:12 INFO - 2015-12-16 11:04:12,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-ext.html (next: http://localhost:49567/tests/dromaeo/cssquery-jquery.html) 11:04:13 INFO - 2015-12-16 11:04:13,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 220467200 11:04:13 INFO - 2015-12-16 11:04:13,117 DEBUG : BROWSER_OUTPUT: 11:07:15 INFO - 2015-12-16 11:07:15,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49567/tests/dromaeo/cssquery-mootools.html) 11:07:15 INFO - 2015-12-16 11:07:15,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 218030080 11:07:15 INFO - 2015-12-16 11:07:15,674 DEBUG : BROWSER_OUTPUT: 11:10:17 INFO - 2015-12-16 11:10:17,578 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49567/tests/dromaeo/cssquery-prototype.html) 11:10:18 INFO - 2015-12-16 11:10:18,159 DEBUG : BROWSER_OUTPUT: RSS: Main: 198418432 11:10:18 INFO - 2015-12-16 11:10:18,159 DEBUG : BROWSER_OUTPUT: 11:13:20 INFO - 2015-12-16 11:13:20,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49567/tests/dromaeo/cssquery-yui.html) 11:13:21 INFO - 2015-12-16 11:13:21,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 182710272 11:13:21 INFO - 2015-12-16 11:13:21,460 DEBUG : BROWSER_OUTPUT: 11:16:23 INFO - 2015-12-16 11:16:23,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/dromaeo/cssquery-yui.html (next: http://localhost:49567/tests/dromaeo/cssquery-dojo.html) 11:16:24 INFO - 2015-12-16 11:16:24,209 DEBUG : BROWSER_OUTPUT: RSS: Main: 250155008 11:16:24 INFO - 2015-12-16 11:16:24,209 DEBUG : BROWSER_OUTPUT: 11:16:24 INFO - 2015-12-16 11:16:24,209 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:16:24 INFO - 2015-12-16 11:16:24,210 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:16:24 INFO - 2015-12-16 11:16:24,210 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:16:24 INFO - 2015-12-16 11:16:24,210 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:16:24 INFO - 2015-12-16 11:16:24,210 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2623.3572774670206;2710.4443589064244;2729.2221716810714;2743.588461730739;2752.944941101178;4475.395821564096;4595.908081838361;4777.570018698317;4778.450478195009;4801.975990120049;4715.3162791395225;4739.052189562084;4754.453237877645;4791.592714619262;4902.142125128097;4298.097399546099;4324.394584758128;4349.173657005159;4448.599626033656;4499.460064792213;4419.734815911055;4464.151811155886;4472.597466228039;4477.843275485358;4516.322551617267;4144.3990621359735;4239.046214601721;4254.680898932562;4367.432233809616;4408.29467285236;4349.69552131351;4349.80425880833;4363.716358436724;4383.364412160251;4404.735715857027;4119.876403707864;4331.112122014979;4334.674899382559;4343.326784348431;4394.318880573516;4553.908921821545;4568.703034302793;4578.610818080467;4669.649776266793;4705.764711764398;5036.093503169428;5047.899042019139;5052.873678158076;5055.949440505585;5092.719900405476;4926.704397736147;5060.2662613920775;5079.593632509391;5079.8984020319385;5082.517160869711;4647.721136731807;4660.673752837337;4681.578657920803;4809.134355815917;4814.566688998007;5256.763445644955;5261.13191323435;5268.894622107537;5274.050670879278;5277.2875661785165;5038.3198268234055;5045.621578381636;5048.7475626219275;5050.898982020339;5088.0587091388215;4919.7540122993705;5010.549050585465;5021.698698078054;5023.572996295283;5139.357580302462;5052.9242061369105;5057.620678449131;5058.114829904752;5063.721495317793;5112.130937740593;5024.824131155465;5027.824026159067;5028.7737051832755;5028.899422011613;5033.5469807716745;4004.9599504004586;4056.0671045659665;4108.63022327986;4152.522459917088;4234.640055595247;3720.8325625346924;3724.031751744512;3751.868684596026;3752.9061773455883;3764.0778009387877;4411.713238639478;4412.448443944507;4412.4705035395955;4448.9110217796115;4454.26504626733;4835.879103022382;4950.257461380822;4952.182889823139;4971.577415919615;5118.283440318359;4321.114171594815;4328.415663885336;4347.391365208873;4355.586219309161;4385.956140438619;4431.268840641258;4433.933490997638;4449.844255451108;4453;4472.418585583919;4650.627949763943;4786.976065119652;4787.257975013878;4798.760061996886;4807.134715751198;4995.325631039763;5068.239764035424;5075;5085.4406015337545;5133.486651334837;4840.370751802243;4866.197077482318;4889.291052797395;4890.975545122252;4929.433115191799;4768.403949506312;4896.338994235875;4905.092557876804;5048.268001139741;5092.312537807348;4988.276699878425;5060.51925067118;5074.11203039474;5077.619178561548;5091.516305950929;4895.388076490439;4964.478729733326;4966.354373931365;4967;5011.649184557192;4716.976415117902;4775.164346239325;4825.638077144298;4964.652474326763;5032.370953630796;4717.410323709536;4738.50245724194;4757.3577567028005;4792.448868380181;4803.351547541037;4946.08497427977;4996.475370086234;4998.050370429607;5005.249212618136;5050.444451110448;4664.300354946785;4818.469968303554;4874.731889746098;4884.609231261419;4923.852284431473 11:16:24 INFO - 2015-12-16 11:16:24,213 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.6516428276547;576.8067697321397;580.0660935893213;583.34665175004;591.5149577346576;26512.60231096535;35583.4662480063;35642;35754.28491430173;35777.46333804995;38465;39226.21547569047;39244;39317.606823931754;39387.40918886219;6847.315268473138;6941.548799328028;6945.791626251221;7703.768886933387;7864.0956290026525;7003.369696727294;7106.040684507603;9939.75150621233;10029.498525073754;10122.74693132674;9778.706638800848;9867.506624668773;9871.90128098717;9874.90125098747;9876.802463950717;7163.391111755507;9819.06718861707;9948.651797187063;9965.302428829984;9967.800643987151;7084.929150708478;10139.290249682525;10407.895921040768;10408.115310198642;10410.271281010333;36640.816795916115;37193.25613487715;37216.627833721584;37282;37325.81337093324;2988.656304524964;3000.819950802959;3012.186709588421;3493.755437119403;3571;26949.461010779676;27409;27784.58323125155;27940;27987.720122798713;3186.681331866818;3227.4190645683766;3247.2044349134612;3248.4802431611065;3321.1531059579893;214877;216309;216382;216673;288434.9999999979;40944.795276023426;52625;53433.73283133637;54021;54481.91036179254;47813.5218647816;47946.280805787945;47971.682548570796;47995.28007079827;48129.75935120302;12856;13012.089153759145;13014;13014.089013769135;13016.787146185172;10801.243912926177;11040.227184097035;11053.723656908642;11058.668239952653;11065.557377704963;18046.819531804776;18157.7276340855;18185.272589096552;18190.45428637143;18190.727139092924;6941.514094013472;7281.490295679251;7307.744228951961;7338.229485903903;7365.158710322419;823.3248736036393;889.3107841422949;889.7820034091689;954.9727364255327;1040.869891263592;22806;24146.154884578955;24288.392790180034;24575.87712061428;24590.508189836462;962.7159987803615;999.4453078541334;1072.4155335342257;1074.3285446595878;1109.7614012987246;12826.486940522462;12889;13044.413001414769;13061.673458163432;13084.934575327063;263121;267355;268217;269138;269605;44832.55167448349;44834;44900.10199796051;44991;45073.77463112663;1196.461592283476;1215.143323956626;1215.7933151364289;1224.3143839449758;1227.5642147037852;23514.294571162893;28764.85617571899;31666.841665791522;32055.198620034687;32325.35349293048;41564.79217603893;41655.37516937188;42144.36783448189;42207;42225.36661950134;226547;229691;230319;230672;230896;28872.989445369312;29289.414211716074;36129.819350903075;36412;36925;41162;41758.791206043774;42003;42575;42686.359704603834;35107;35222.8238858804;35283.294334113685;37704.81147594244;39289.80355098206;29901.10296691103;32988.34023319568;33741.66258337385;35538.64461355457;37245;34909.8254508736;35412.114697132776;35539.11152221112;35764.64235357613;35820.462693059104;31444.37111257808;31487.21281967969;32045.359092817547;32419.35161296808;34311.485327720606;23816;23855.880720596288;23903.16338928199;23910.431839367437;24073.879630602434 11:16:24 INFO - 2015-12-16 11:16:24,215 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.3059141099396;337.35733427819997;339.3789365461206;340.67465570380284;347.5169514375019;11984.7603047939;12286.324252166127;14528.128312301269;14750.262486875667;15147.545573632795;12237.326947017911;14603.342849571769;14682.706345873075;15031.624209394744;15080.924595377008;4564.726116433025;4708.976455117737;4883.096627123985;4948.5298896604945;5022.899542009158;4965.180745177059;4982.750862456881;4991.226359914219;4996.425411077718;5002.399712034543;4820.542048505386;4924.482929292409;4936.234883593049;4948.901021979558;5095;5071.594272458213;5100.285959965608;5100.821471248507;5104.081265372231;5108.846734597968;4452.732836029816;4546.863594092182;4574.61115805157;4579.7252164870215;4583.541645835423;18999.145038473303;19229;19354.709679354823;19451;19473.707894381594;1840.7791065072277;1969.2516843599483;1985.384530795458;2022.5853699991467;2077.2833372486466;12545;12622.558210462681;12659.620211393672;12874.871251287555;13028.934855325757;1697.7283634618525;1715.0995727243173;1747.4757572728258;1772.7429522719262;1815.591491914322;49717;51502.7424862877;51579.22631160536;51890.740546297406;51947.480525194645;9426.95286523563;9534.856977145348;9688.32181747285;9717.56270967808;9777.706668799947;10679.252452328263;10827.729306767395;11237.775244495228;12182.634520964386;12194.81707774384;6698.296678848651;6736.427403670645;6776.05135281061;6799.694013769392;6942.236354001056;6062.9090563641585;6089.725962331706;6215.627062376272;6407.295197528269;6412.935870641327;5768.625039372428;5811;5813.82558523245;5853.473187413153;5882.735276912549;1570.3169121432213;1590.618251619603;1646.925888335004;1682.6466442047308;1696.1095424902026;851.1190917400461;881.7442941547008;882.1134759566595;892.4020905993;965.1024547171058;14637.634059148606;15486.457973971083;15515.301811418512;15805.604859878365;16263.674726505404;838.8070743728977;850.1753299299669;863.2720602894822;903.3766700976437;962.1869520255373;7467.290607392289;8944.418612790278;9089.409188402733;9365.250779937725;9475.620975160917;496521;507097;515972;516947.15264236636;519571;34714;51790.22314665283;53246.46753532415;55067.898642026936;69524.3047569528;1029;1051.6161601015574;1054.5887104029434;1055.0609957138154;1062.2351906627216;13519.526816561372;14167.433302667778;14261.429542818587;14467;14484.275786210437;28621.713782861905;29213.85393073021;29631.77761667927;30348.544771827997;30599.694003060577;38561.22877542378;39289;39340.2131957365;39928;40456;8143.470674406145;8243.299319557906;8420.200080992296;8428.11504791988;8498.660053597787;10173.389596624227;10299.794004120025;11137.443127843737;15208.847911520743;15447.304871281043;12524.686882828002;12920.806187907001;13046.54337098197;13080.411381487665;13427.798583021067;12209.450574723982;12399.814002790146;12656.936715316733;12715.55495557651;12809.487620495076;13930.512432064828;13938;14013.649658758613;14270.215138167501;14363.56909292723;8737.956310218407;8872.378933474594;8890.866637000321;8898.154675305836;9247.630094796403;13719.1082579632;13845.653858653613;13941.721165576835;14172.503962361268;14233.857661423668 11:16:24 INFO - 2015-12-16 11:16:24,216 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1263.9684007899796;1687.9662406751866;1702.1829521829522;1728.153204929584;1756.3764863473464;5869.178315035893;7085.645717714113;7231.132264128312;7243.674034668439;7258.637068146598;6924.896126558106;7084.22073571908;7087.503874728771;7091.255418181094;7096.183938847034;2026.422469596169;2067.7105205271273;2069.0999415254414;2071.161179722215;2072.512959454527;2079.4385515910694;2098.380977611608;2110.7150534677776;2122.7877212278727;2124.702541644171;2016.4656366063004;2071.575327057957;2098.08733201058;2109.567538654572;2113.281484295347;2081.604495145925;2094.7591027031935;2117.7035215069905;2117.904694288753;2118.5656940327194;2015.3550863723615;2040.2655044184082;2046.5906818636183;2049.1496029147884;2095.769465358809;7186.604736739478;7198.424126069955;7257.92742072583;7277.090363704537;7286.089238845145;4159.708820382574;4206.957930420687;4216.051388437577;4236.301010333292;4239.236937351276;2656.681198256202;2680.088769818252;2716.6739991201184;2731.4400547887835;2768.6677598688084;837.5267973594961;840.6503821818034;859.2181115185151;868.7480630617176;870.6212797433137;9686.46724430156;9709.563069661812;9712.22302215821;9718.902810971871;9730.270229732798;3863.459115723801;3874.6706529945272;3946.7631942083567;3949.1706741584017;3969.1069509360163;8379.539125348165;8382.119877412906;8400.831983360298;8409.789755256168;8423.705170319132;4251;4251.149770046003;4255.893467698421;4259.488861336659;4266.168097221012;3266.3304022675293;3350.246194606194;3847.403652433877;3891.105045839416;3902.512185976753;3476.652334766503;3491.738119641037;3492.877749278763;3503.106707789548;3537.8407971641336;1102.1733699725205;1108.2740804772886;1114.3648120571359;1122.4275619434147;1123.1969142063301;1191.839101721274;1201.6335017819474;1212.496813822254;1222.2483172848633;1241.1994263700044;6654.401103900575;6730.125083739083;6761;6764.661766911733;6766.086578311963;411.22073670394434;414.2812220796915;416.7686933751797;417.2218811915755;428.7277578737524;5357.11607584752;5406.864828379322;5409.6754194747655;5410.810621628224;5418.701971391612;8457.830843383097;8590.87113693295;8743.693970710994;8759.912400876037;8787;8682.696105636272;8699.478031318142;8758.956205218934;8768.956155219183;8783.297336213087;6735.562188457832;6852.657367131624;6882.7591034313555;6888.724451022003;6926.411255043277;6503.837404064936;6510.44661203803;6550.803475895731;6552.57408268461;6562.146920900253;7623.923760762322;7638.350740187147;7744.186860379579;7815.765527034198;7853.764387068397;7827.295543401121;7983.2415920487465;8099.676012959416;8170.0604430488875;8199.385046121684;5447.836564903059;5579.051561234681;5592.664440133605;6387.776427825004;6457.192850893638;5983.162357270073;6448.774292899726;6515.478761698958;6533.444657204001;6556.80329590094;6358.618482891041;6671.566348187353;6693;6758.42553382968;6768.9661551691925;5951.464368206882;5992.550558708202;6157.0456579230295;6574.342565743387;6664.866702666017;6448.645324507197;6532.5753826001155;6537.738490460329;6539.21529416454;6541.6402097885075;5862.208601838697;5878.94121058801;5941.257342832146;5941.821745347646;5979.282486101695;6069.939300607114;6083.330833608388;6084.939150608438;6087.391260873877;6097.085437184281 11:16:24 INFO - 2015-12-16 11:16:24,218 DEBUG : BROWSER_OUTPUT: |4;prototype.html;294.4581969176715;302.7199840147863;305.2003750174543;310.73121749686516;310.73276981795664;5250.816221432246;5271.73641317934;5346.465353464651;5371.5165635092835;5372.650777699457;5248.370195576526;5255.316808814849;5260.947390526094;5263.0526505229045;5285.709285989269;3958.940615890764;4100.302948498747;4100.733452325604;4103.09731858992;4107.13750112476;4017.4576432181575;4057.2088442753675;4131.958680413188;4175.331946888498;4182.53992060873;4106.8562600309;4115.670746340301;4120.402541631476;4128.8761337159785;4133.23535145999;3927.096767743435;3985.0834308109297;4014.7992600370158;4129.029678025661;4132.359484279927;3616.439451884962;3623.5108260385036;3636.909077273063;3638.3450978823803;3645.0887278180453;5114.872128196787;5124.256982737482;5140.203268493389;5140.331756871583;5144.639875208737;4742.454617718938;4753.405824271966;4753.429588449374;4757.310190022427;4758.310045043484;5429.701366424845;5576;5586.692731899744;5590.357108932443;5590.385057643656;3959.208158368338;3959.40608908666;3959.5842436544326;3962.7027972902147;3967.444557761916;5901.4098590141075;5904.793332233351;5914.674692891889;5920;5923.141144534018;4074.083331250445;4077.368007958771;4078.388241763759;4079.938800917989;4088;3946.131850992777;4099.077707515785;4131.008557946071;4138.317177665712;4140.254754144283;4693.55411235932;4696.624270058387;4697.647676424282;4699.812007519729;4701.764911754467;5601.943980560224;5619.157126430986;5629.802956896489;5629.943700562942;5638.492535671728;1409.2460533614467;1425.180521200314;1425.3728359521986;1426.9500567480295;1427.3862239237228;955.049725523095;957.6552441121191;964.8552717092492;981.7005813226891;984.2814745236018;4947.2579113133315;4949.950500495021;4950.18321976877;4953.777080031407;4956.430010548833;5825.79609713658;5831.679257640785;5833.766649334064;5833.795817146464;5837.445442682938;4929.630277729185;4954.083494553519;4958.504149585085;4962.478939711351;4962.950370496321;3078.4304903592906;3123.0630810756684;3151.8108913465267;3152.274976755359;3158.8104713717253;5558;5635.267415236075;5641.012822756002;5642.266505354278;5648.406917273627;6059.303180134253;6093.817185484442;6094.329623741385;6100.755969761249;6106.572539922163;5511.807086751945;5628.774849006076;5637.379888212294;5639.971800141055;5646.181303711021;5804.912926306024;5875.353711091691;5879.764809407576;5881.32364778056;5911.7635294587735;5765.279340082489;5767.077267637158;5771.7402716877;5772.163036359789;5777.306723193244;5600.4959553640365;5606.915896261477;5608.383077861514;5613.158026296088;5619.241402410622;4012.518497780285;4078.775667338325;4110.301248787773;4111;4140.958590414178;5833.125031245348;5840.357560668238;5846.210761547307;5848.94151058501;5849.181114643869;5584.664920104807;5597.272354593877;5599.356074051373;5600.635958662674;5605.915911261416;5457.20870473787;5571.442855714558;5598.636088654224;5616.157576363415;5623.044082505902;5447.12845944647;5483.150111732688;5491.752871120889;5499.670019798825;5509.173623956439;5473.343198816167;5637.943620563742;5664.801731939362;5672.943270567406;5681.318241811009;5434.891302173855;5568.1091025435735;5579.191017302387;5583.274174357308;5589.944100558942 11:16:24 INFO - 2015-12-16 11:16:24,219 DEBUG : BROWSER_OUTPUT: |5;yui.html;663.7809522857458;692.8856738638125;755.1391413788282;767.4321002458179;777.8755399136138;11441.141914356425;11746.236494627865;11749.236299640528;11755.764884702301;11766.882331176706;10927.836082458769;13525.458981640748;13914.721705565882;13934.930325348385;13937.372818223179;638.8850006998738;645.5706954875003;822.3256929317947;836.9916300837006;837.6523742646795;821.40858581821;828.9461185022955;835.7534527314426;835.9791005224857;835.9791005224857;860.8450478913825;870.2254993056185;871.3464901324007;875.4922145155826;875.6366108065146;654.5614438326332;659.4164164714215;846.9788255293605;847.0555330806168;861.8621020636668;644.8774732800799;645.1000853808957;645.2676212498801;645.5835985789187;645.8772833161731;12392.876071239263;12798.48806047757;12830.486780528767;12834.743305133845;12861.099723019392;10564.947175264075;11222.214444988855;11265;11407.486663100097;11491.827622585668;9328.113829186217;9369.437833729999;9411;9459.90540094597;9678.128968392879;3206.502992036238;3249.155219642886;3259.9348013039844;3281.2289112058647;3314.983425082859;37216.627833721315;42441.787791060844;42555.57444425578;42676.14647707029;42825.0751163617;8548.615312310962;8715.694950676696;8824.602892869836;9033.77415564616;9101.40840845343;15376.923115384576;15538.145402002998;15542.9222853885;15657.138857362726;15659.921700391653;6244.12582238487;6378;6415.230172379251;6524.445422139076;6534.052562378429;3564.3940530109944;3587.65917237862;3614.4397618369194;3627.9637203628154;3654.4335627977707;2550.6301586269888;2578.162097318379;2580.83224590401;2583.702874169457;2585.3665851866413;444.32240832730344;452.5632764382387;455.68785382012766;455.8062823300084;457.0219729778277;525.9263703081572;591.1339887065384;607.3501353551658;619.0899377914459;630.5775130662468;7941.36469082472;8042;8157.714479993172;8157.974764319142;8221.260086592236;471.582649355323;496.4985364781597;580.3702982264206;619.6653806944199;657.5002997721671;3693.1505753676806;4046.0491784430637;4088.693347998912;4103.097318589906;4283.418349521392;50560.74719626379;51429;51531.96936061258;51599.226011609855;51673.48326516762;44347.77826110849;44679.77660111744;44744.105117898114;44912.55087449084;45126.09747805026;38032.61967380346;38427.615723842966;38940.221195576494;40940;41962.37056444156;8022.719204828037;8081.613134613777;8362.163783621589;8448.915510844812;8482;31301.8434907824;31343.21641958878;31773.682263177074;31788.682113178573;31872.840635796674;35382.29235415226;35812.641873581975;37972.62027379691;39351.40972885352;39541.40687889742;10036.447995360326;10166.694999150037;10193.439360835226;10223.897761022294;10235.7441063974;11110.555577777122;11131.220814543229;11247.493862776359;11796.351200684045;11804.645860624196;10438.895611044096;10466.215033872642;10567.207459440726;10571.471426428801;10755.408452535186;10574.524146413276;10738.248322617343;10837;10928.836067459153;11081.667549973514;10704.839427408751;10706.839397409201;10737.46312684347;10744.086752626114;10945.781084378426;9166.67916622915;9220.538973051454;9282.58228379711;9604.567794449405;9659.517024148623;8808.427452215585;8852.778680533038;9018.909810901807;9323.440593564408;9334.33520603907 11:16:24 INFO - 2015-12-16 11:16:24,219 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:16:24 INFO - 2015-12-16 11:16:24,219 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:16:24 INFO - 2015-12-16 11:16:24,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,976 11:16:24 INFO - 2015-12-16 11:16:24,219 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:16:24 INFO - 2015-12-16 11:16:24,219 DEBUG : BROWSER_OUTPUT: __startTimestamp1450293384207__endTimestamp 11:16:24 INFO - 2015-12-16 11:16:24,219 DEBUG : BROWSER_OUTPUT: 11:16:24 INFO - 2015-12-16 11:16:24,219 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:16:24 INFO - 2015-12-16 11:16:24,219 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:16:24 INFO - 2015-12-16 11:16:24,219 DEBUG : BROWSER_OUTPUT: 11:16:24 INFO - 2015-12-16 11:16:24,220 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4668.39 Median:4798.76 stddev:489.60 (10.2%) stddev-sans-first:464.08 11:16:24 INFO - 2015-12-16 11:16:24,220 DEBUG : BROWSER_OUTPUT: Values: 2623.4 2710.4 2729.2 2743.6 2752.9 4475.4 4595.9 4777.6 4778.5 4802.0 4715.3 4739.1 4754.5 4791.6 4902.1 4298.1 4324.4 4349.2 4448.6 4499.5 4419.7 4464.2 4472.6 4477.8 4516.3 4144.4 4239.0 4254.7 4367.4 4408.3 4349.7 4349.8 4363.7 4383.4 4404.7 4119.9 4331.1 4334.7 4343.3 4394.3 4553.9 4568.7 4578.6 4669.6 4705.8 5036.1 5047.9 5052.9 5055.9 5092.7 4926.7 5060.3 5079.6 5079.9 5082.5 4647.7 4660.7 4681.6 4809.1 4814.6 5256.8 5261.1 5268.9 5274.1 5277.3 5038.3 5045.6 5048.7 5050.9 5088.1 4919.8 5010.5 5021.7 5023.6 5139.4 5052.9 5057.6 5058.1 5063.7 5112.1 5024.8 5027.8 5028.8 5028.9 5033.5 4005.0 4056.1 4108.6 4152.5 4234.6 3720.8 3724.0 3751.9 3752.9 3764.1 4411.7 4412.4 4412.5 4448.9 4454.3 4835.9 4950.3 4952.2 4971.6 5118.3 4321.1 4328.4 4347.4 4355.6 4386.0 4431.3 4433.9 4449.8 4453.0 4472.4 4650.6 4787.0 4787.3 4798.8 4807.1 4995.3 5068.2 5075.0 5085.4 5133.5 4840.4 4866.2 4889.3 4891.0 4929.4 4768.4 4896.3 4905.1 5048.3 5092.3 4988.3 5060.5 5074.1 5077.6 5091.5 4895.4 4964.5 4966.4 4967.0 5011.6 4717.0 4775.2 4825.6 4964.7 5032.4 4717.4 4738.5 4757.4 4792.4 4803.4 4946.1 4996.5 4998.1 5005.2 5050.4 4664.3 4818.5 4874.7 4884.6 4923.9 11:16:24 INFO - 2015-12-16 11:16:24,220 DEBUG : BROWSER_OUTPUT: 11:16:24 INFO - 2015-12-16 11:16:24,220 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40566.46 Median:19300.38 stddev:63334.35 (328.2%) stddev-sans-first:63440.76 11:16:24 INFO - 2015-12-16 11:16:24,220 DEBUG : BROWSER_OUTPUT: Values: 554.7 576.8 580.1 583.3 591.5 26512.6 35583.5 35642.0 35754.3 35777.5 38465.0 39226.2 39244.0 39317.6 39387.4 6847.3 6941.5 6945.8 7703.8 7864.1 7003.4 7106.0 9939.8 10029.5 10122.7 9778.7 9867.5 9871.9 9874.9 9876.8 7163.4 9819.1 9948.7 9965.3 9967.8 7084.9 10139.3 10407.9 10408.1 10410.3 36640.8 37193.3 37216.6 37282.0 37325.8 2988.7 3000.8 3012.2 3493.8 3571.0 26949.5 27409.0 27784.6 27940.0 27987.7 3186.7 3227.4 3247.2 3248.5 3321.2 214877.0 216309.0 216382.0 216673.0 288435.0 40944.8 52625.0 53433.7 54021.0 54481.9 47813.5 47946.3 47971.7 47995.3 48129.8 12856.0 13012.1 13014.0 13014.1 13016.8 10801.2 11040.2 11053.7 11058.7 11065.6 18046.8 18157.7 18185.3 18190.5 18190.7 6941.5 7281.5 7307.7 7338.2 7365.2 823.3 889.3 889.8 955.0 1040.9 22806.0 24146.2 24288.4 24575.9 24590.5 962.7 999.4 1072.4 1074.3 1109.8 12826.5 12889.0 13044.4 13061.7 13084.9 263121.0 267355.0 268217.0 269138.0 269605.0 44832.6 44834.0 44900.1 44991.0 45073.8 1196.5 1215.1 1215.8 1224.3 1227.6 23514.3 28764.9 31666.8 32055.2 32325.4 41564.8 41655.4 42144.4 42207.0 42225.4 226547.0 229691.0 230319.0 230672.0 230896.0 28873.0 29289.4 36129.8 36412.0 36925.0 41162.0 41758.8 42003.0 42575.0 42686.4 35107.0 35222.8 35283.3 37704.8 39289.8 29901.1 32988.3 33741.7 35538.6 37245.0 34909.8 35412.1 35539.1 35764.6 35820.5 31444.4 31487.2 32045.4 32419.4 34311.5 23816.0 23855.9 23903.2 23910.4 24073.9 11:16:24 INFO - 2015-12-16 11:16:24,220 DEBUG : BROWSER_OUTPUT: 11:16:24 INFO - 2015-12-16 11:16:24,220 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26098.28 Median:36637.61 stddev:83206.57 (227.1%) stddev-sans-first:83417.49 11:16:24 INFO - 2015-12-16 11:16:24,221 DEBUG : BROWSER_OUTPUT: Values: 331.3 337.4 339.4 340.7 347.5 11984.8 12286.3 14528.1 14750.3 15147.5 12237.3 14603.3 14682.7 15031.6 15080.9 4564.7 4709.0 4883.1 4948.5 5022.9 4965.2 4982.8 4991.2 4996.4 5002.4 4820.5 4924.5 4936.2 4948.9 5095.0 5071.6 5100.3 5100.8 5104.1 5108.8 4452.7 4546.9 4574.6 4579.7 4583.5 18999.1 19229.0 19354.7 19451.0 19473.7 1840.8 1969.3 1985.4 2022.6 2077.3 12545.0 12622.6 12659.6 12874.9 13028.9 1697.7 1715.1 1747.5 1772.7 1815.6 49717.0 51502.7 51579.2 51890.7 51947.5 9427.0 9534.9 9688.3 9717.6 9777.7 10679.3 10827.7 11237.8 12182.6 12194.8 6698.3 6736.4 6776.1 6799.7 6942.2 6062.9 6089.7 6215.6 6407.3 6412.9 5768.6 5811.0 5813.8 5853.5 5882.7 1570.3 1590.6 1646.9 1682.6 1696.1 851.1 881.7 882.1 892.4 965.1 14637.6 15486.5 15515.3 15805.6 16263.7 838.8 850.2 863.3 903.4 962.2 7467.3 8944.4 9089.4 9365.3 9475.6 496521.0 507097.0 515972.0 516947.2 519571.0 34714.0 51790.2 53246.5 55067.9 69524.3 1029.0 1051.6 1054.6 1055.1 1062.2 13519.5 14167.4 14261.4 14467.0 14484.3 28621.7 29213.9 29631.8 30348.5 30599.7 38561.2 39289.0 39340.2 39928.0 40456.0 8143.5 8243.3 8420.2 8428.1 8498.7 10173.4 10299.8 11137.4 15208.8 15447.3 12524.7 12920.8 13046.5 13080.4 13427.8 12209.5 12399.8 12656.9 12715.6 12809.5 13930.5 13938.0 14013.6 14270.2 14363.6 8738.0 8872.4 8890.9 8898.2 9247.6 13719.1 13845.7 13941.7 14172.5 14233.9 11:16:24 INFO - 2015-12-16 11:16:24,221 DEBUG : BROWSER_OUTPUT: 11:16:24 INFO - 2015-12-16 11:16:24,222 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4991.76 Median:5987.86 stddev:2618.59 (43.7%) stddev-sans-first:2610.95 11:16:24 INFO - 2015-12-16 11:16:24,222 DEBUG : BROWSER_OUTPUT: Values: 1264.0 1688.0 1702.2 1728.2 1756.4 5869.2 7085.6 7231.1 7243.7 7258.6 6924.9 7084.2 7087.5 7091.3 7096.2 2026.4 2067.7 2069.1 2071.2 2072.5 2079.4 2098.4 2110.7 2122.8 2124.7 2016.5 2071.6 2098.1 2109.6 2113.3 2081.6 2094.8 2117.7 2117.9 2118.6 2015.4 2040.3 2046.6 2049.1 2095.8 7186.6 7198.4 7257.9 7277.1 7286.1 4159.7 4207.0 4216.1 4236.3 4239.2 2656.7 2680.1 2716.7 2731.4 2768.7 837.5 840.7 859.2 868.7 870.6 9686.5 9709.6 9712.2 9718.9 9730.3 3863.5 3874.7 3946.8 3949.2 3969.1 8379.5 8382.1 8400.8 8409.8 8423.7 4251.0 4251.1 4255.9 4259.5 4266.2 3266.3 3350.2 3847.4 3891.1 3902.5 3476.7 3491.7 3492.9 3503.1 3537.8 1102.2 1108.3 1114.4 1122.4 1123.2 1191.8 1201.6 1212.5 1222.2 1241.2 6654.4 6730.1 6761.0 6764.7 6766.1 411.2 414.3 416.8 417.2 428.7 5357.1 5406.9 5409.7 5410.8 5418.7 8457.8 8590.9 8743.7 8759.9 8787.0 8682.7 8699.5 8759.0 8769.0 8783.3 6735.6 6852.7 6882.8 6888.7 6926.4 6503.8 6510.4 6550.8 6552.6 6562.1 7623.9 7638.4 7744.2 7815.8 7853.8 7827.3 7983.2 8099.7 8170.1 8199.4 5447.8 5579.1 5592.7 6387.8 6457.2 5983.2 6448.8 6515.5 6533.4 6556.8 6358.6 6671.6 6693.0 6758.4 6769.0 5951.5 5992.6 6157.0 6574.3 6664.9 6448.6 6532.6 6537.7 6539.2 6541.6 5862.2 5878.9 5941.3 5941.8 5979.3 6069.9 6083.3 6084.9 6087.4 6097.1 11:16:24 INFO - 2015-12-16 11:16:24,222 DEBUG : BROWSER_OUTPUT: 11:16:24 INFO - 2015-12-16 11:16:24,222 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4674.59 Median:5278.72 stddev:1380.11 (26.1%) stddev-sans-first:1344.26 11:16:24 INFO - 2015-12-16 11:16:24,222 DEBUG : BROWSER_OUTPUT: Values: 294.5 302.7 305.2 310.7 310.7 5250.8 5271.7 5346.5 5371.5 5372.7 5248.4 5255.3 5260.9 5263.1 5285.7 3958.9 4100.3 4100.7 4103.1 4107.1 4017.5 4057.2 4132.0 4175.3 4182.5 4106.9 4115.7 4120.4 4128.9 4133.2 3927.1 3985.1 4014.8 4129.0 4132.4 3616.4 3623.5 3636.9 3638.3 3645.1 5114.9 5124.3 5140.2 5140.3 5144.6 4742.5 4753.4 4753.4 4757.3 4758.3 5429.7 5576.0 5586.7 5590.4 5590.4 3959.2 3959.4 3959.6 3962.7 3967.4 5901.4 5904.8 5914.7 5920.0 5923.1 4074.1 4077.4 4078.4 4079.9 4088.0 3946.1 4099.1 4131.0 4138.3 4140.3 4693.6 4696.6 4697.6 4699.8 4701.8 5601.9 5619.2 5629.8 5629.9 5638.5 1409.2 1425.2 1425.4 1427.0 1427.4 955.0 957.7 964.9 981.7 984.3 4947.3 4950.0 4950.2 4953.8 4956.4 5825.8 5831.7 5833.8 5833.8 5837.4 4929.6 4954.1 4958.5 4962.5 4963.0 3078.4 3123.1 3151.8 3152.3 3158.8 5558.0 5635.3 5641.0 5642.3 5648.4 6059.3 6093.8 6094.3 6100.8 6106.6 5511.8 5628.8 5637.4 5640.0 5646.2 5804.9 5875.4 5879.8 5881.3 5911.8 5765.3 5767.1 5771.7 5772.2 5777.3 5600.5 5606.9 5608.4 5613.2 5619.2 4012.5 4078.8 4110.3 4111.0 4141.0 5833.1 5840.4 5846.2 5848.9 5849.2 5584.7 5597.3 5599.4 5600.6 5605.9 5457.2 5571.4 5598.6 5616.2 5623.0 5447.1 5483.2 5491.8 5499.7 5509.2 5473.3 5637.9 5664.8 5672.9 5681.3 5434.9 5568.1 5579.2 5583.3 5589.9 11:16:24 INFO - 2015-12-16 11:16:24,222 DEBUG : BROWSER_OUTPUT: 11:16:24 INFO - 2015-12-16 11:16:24,222 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12333.19 Median:22396.05 stddev:13858.44 (61.9%) stddev-sans-first:13869.61 11:16:24 INFO - 2015-12-16 11:16:24,224 DEBUG : BROWSER_OUTPUT: Values: 663.8 692.9 755.1 767.4 777.9 11441.1 11746.2 11749.2 11755.8 11766.9 10927.8 13525.5 13914.7 13934.9 13937.4 638.9 645.6 822.3 837.0 837.7 821.4 828.9 835.8 836.0 836.0 860.8 870.2 871.3 875.5 875.6 654.6 659.4 847.0 847.1 861.9 644.9 645.1 645.3 645.6 645.9 12392.9 12798.5 12830.5 12834.7 12861.1 10564.9 11222.2 11265.0 11407.5 11491.8 9328.1 9369.4 9411.0 9459.9 9678.1 3206.5 3249.2 3259.9 3281.2 3315.0 37216.6 42441.8 42555.6 42676.1 42825.1 8548.6 8715.7 8824.6 9033.8 9101.4 15376.9 15538.1 15542.9 15657.1 15659.9 6244.1 6378.0 6415.2 6524.4 6534.1 3564.4 3587.7 3614.4 3628.0 3654.4 2550.6 2578.2 2580.8 2583.7 2585.4 444.3 452.6 455.7 455.8 457.0 525.9 591.1 607.4 619.1 630.6 7941.4 8042.0 8157.7 8158.0 8221.3 471.6 496.5 580.4 619.7 657.5 3693.2 4046.0 4088.7 4103.1 4283.4 50560.7 51429.0 51532.0 51599.2 51673.5 44347.8 44679.8 44744.1 44912.6 45126.1 38032.6 38427.6 38940.2 40940.0 41962.4 8022.7 8081.6 8362.2 8448.9 8482.0 31301.8 31343.2 31773.7 31788.7 31872.8 35382.3 35812.6 37972.6 39351.4 39541.4 10036.4 10166.7 10193.4 10223.9 10235.7 11110.6 11131.2 11247.5 11796.4 11804.6 10438.9 10466.2 10567.2 10571.5 10755.4 10574.5 10738.2 10837.0 10928.8 11081.7 10704.8 10706.8 10737.5 10744.1 10945.8 9166.7 9220.5 9282.6 9604.6 9659.5 8808.4 8852.8 9018.9 9323.4 9334.3 11:16:24 INFO - 2015-12-16 11:16:24,224 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:16:24 INFO - 2015-12-16 11:16:24,224 DEBUG : BROWSER_OUTPUT: 11:16:24 INFO - 2015-12-16 11:16:24,926 INFO : Browser exited with error code: 0 11:16:24 INFO - 2015-12-16 11:16:24,952 INFO : Completed test dromaeo_css (00:18:37) 11:16:24 INFO - 2015-12-16 11:16:24,952 INFO : Starting test kraken 11:16:24 INFO - 2015-12-16 11:16:24,952 DEBUG : operating with platform_type : linux_ 11:16:24 INFO - 2015-12-16 11:16:24,952 INFO : Initialising browser for kraken test... 11:16:24 INFO - 2015-12-16 11:16:24,958 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy2SnRZ/profile http://localhost:49567/getInfo.html 11:16:29 INFO - 2015-12-16 11:16:29,342 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:16:29 INFO - 2015-12-16 11:16:29,342 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:16:29 INFO - 2015-12-16 11:16:29,342 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:16:29 INFO - 2015-12-16 11:16:29,342 DEBUG : BROWSER_OUTPUT: __metrics 11:16:29 INFO - 2015-12-16 11:16:29,423 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:16:29 INFO - 2015-12-16 11:16:29,479 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:16:29 ERROR - 2015-12-16 11:16:29,495 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 11:16:30 INFO - 2015-12-16 11:16:30,277 INFO : Browser initialized. 11:16:30 INFO - 2015-12-16 11:16:30,278 INFO : Running cycle 1/1 for kraken test... 11:16:30 INFO - 2015-12-16 11:16:30,278 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy2SnRZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:16:42 INFO - 2015-12-16 11:16:42,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 142290944 11:16:42 INFO - 2015-12-16 11:16:42,256 DEBUG : BROWSER_OUTPUT: 11:16:44 INFO - 2015-12-16 11:16:44,843 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49567/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:45 INFO - 2015-12-16 11:16:45,436 DEBUG : BROWSER_OUTPUT: RSS: Main: 175599616 11:16:45 INFO - 2015-12-16 11:16:45,437 DEBUG : BROWSER_OUTPUT: 11:16:48 INFO - 2015-12-16 11:16:48,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49567/tests/kraken/driver.html?testName=audio-dft) 11:16:48 INFO - 2015-12-16 11:16:48,784 DEBUG : BROWSER_OUTPUT: RSS: Main: 165150720 11:16:48 INFO - 2015-12-16 11:16:48,784 DEBUG : BROWSER_OUTPUT: 11:16:51 INFO - 2015-12-16 11:16:51,783 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49567/tests/kraken/driver.html?testName=audio-fft) 11:16:52 INFO - 2015-12-16 11:16:52,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 152600576 11:16:52 INFO - 2015-12-16 11:16:52,344 DEBUG : BROWSER_OUTPUT: 11:16:54 INFO - 2015-12-16 11:16:54,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49567/tests/kraken/driver.html?testName=audio-oscillator) 11:16:54 INFO - 2015-12-16 11:16:54,980 DEBUG : BROWSER_OUTPUT: RSS: Main: 156680192 11:16:54 INFO - 2015-12-16 11:16:54,980 DEBUG : BROWSER_OUTPUT: 11:16:57 INFO - 2015-12-16 11:16:57,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49567/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:57 INFO - 2015-12-16 11:16:57,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 157188096 11:16:57 INFO - 2015-12-16 11:16:57,800 DEBUG : BROWSER_OUTPUT: 11:17:00 INFO - 2015-12-16 11:17:00,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49567/tests/kraken/driver.html?testName=imaging-darkroom) 11:17:01 INFO - 2015-12-16 11:17:01,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 156995584 11:17:01 INFO - 2015-12-16 11:17:01,378 DEBUG : BROWSER_OUTPUT: 11:17:04 INFO - 2015-12-16 11:17:04,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49567/tests/kraken/driver.html?testName=imaging-desaturate) 11:17:05 INFO - 2015-12-16 11:17:05,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 157208576 11:17:05 INFO - 2015-12-16 11:17:05,398 DEBUG : BROWSER_OUTPUT: 11:17:08 INFO - 2015-12-16 11:17:08,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49567/tests/kraken/driver.html?testName=json-parse-financial) 11:17:08 INFO - 2015-12-16 11:17:08,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 157011968 11:17:08 INFO - 2015-12-16 11:17:08,786 DEBUG : BROWSER_OUTPUT: 11:17:10 INFO - 2015-12-16 11:17:10,601 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49567/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:17:11 INFO - 2015-12-16 11:17:11,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 167071744 11:17:11 INFO - 2015-12-16 11:17:11,167 DEBUG : BROWSER_OUTPUT: 11:17:13 INFO - 2015-12-16 11:17:13,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:17:13 INFO - 2015-12-16 11:17:13,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 165306368 11:17:13 INFO - 2015-12-16 11:17:13,664 DEBUG : BROWSER_OUTPUT: 11:17:15 INFO - 2015-12-16 11:17:15,810 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:17:16 INFO - 2015-12-16 11:17:16,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 177696768 11:17:16 INFO - 2015-12-16 11:17:16,396 DEBUG : BROWSER_OUTPUT: 11:17:18 INFO - 2015-12-16 11:17:18,931 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:17:19 INFO - 2015-12-16 11:17:19,516 DEBUG : BROWSER_OUTPUT: RSS: Main: 183308288 11:17:19 INFO - 2015-12-16 11:17:19,516 DEBUG : BROWSER_OUTPUT: 11:17:22 INFO - 2015-12-16 11:17:22,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:22 INFO - 2015-12-16 11:17:22,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 179982336 11:17:22 INFO - 2015-12-16 11:17:22,717 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49567/tests/kraken/driver.html?testName=ai-astar) 11:17:24 INFO - 2015-12-16 11:17:24,750 DEBUG : BROWSER_OUTPUT: RSS: Main: 238575616 11:17:24 INFO - 2015-12-16 11:17:24,750 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,754 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:17:24 INFO - 2015-12-16 11:17:24,754 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:17:24 INFO - 2015-12-16 11:17:24,754 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:17:24 INFO - 2015-12-16 11:17:24,754 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:17:24 INFO - 2015-12-16 11:17:24,754 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;114;109;115;114;114;103;113;116;105 11:17:24 INFO - 2015-12-16 11:17:24,754 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;130;150;175;142;171;157;130;170;131 11:17:24 INFO - 2015-12-16 11:17:24,754 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;161;161;163;161;162;162;161;161 11:17:24 INFO - 2015-12-16 11:17:24,755 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;94;95;73;72;74;100;90;72 11:17:24 INFO - 2015-12-16 11:17:24,755 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;135;94;95;94;137;96;97;128 11:17:24 INFO - 2015-12-16 11:17:24,755 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;111;109;109;110;110;110 11:17:24 INFO - 2015-12-16 11:17:24,755 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;150;146;146;146;147;147;147;147 11:17:24 INFO - 2015-12-16 11:17:24,755 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;96;96;95;96;95 11:17:24 INFO - 2015-12-16 11:17:24,755 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;75;75;74;72;73;74;73;82;71;71 11:17:24 INFO - 2015-12-16 11:17:24,755 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;69;70;68;68;69;68 11:17:24 INFO - 2015-12-16 11:17:24,756 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;86;85;85;85;85;85;84;85;85 11:17:24 INFO - 2015-12-16 11:17:24,756 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;139;121;135;121;119;125;118;123;136;135 11:17:24 INFO - 2015-12-16 11:17:24,756 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;152;149;149;147;137;149;146;147;136 11:17:24 INFO - 2015-12-16 11:17:24,756 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;71;69;70;69;69;77;71;70 11:17:24 INFO - 2015-12-16 11:17:24,756 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:17:24 INFO - 2015-12-16 11:17:24,756 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:17:24 INFO - 2015-12-16 11:17:24,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1009 11:17:24 INFO - 2015-12-16 11:17:24,756 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:17:24 INFO - 2015-12-16 11:17:24,757 DEBUG : BROWSER_OUTPUT: __startTimestamp1450293444752__endTimestamp 11:17:24 INFO - 2015-12-16 11:17:24,757 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,760 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:17:24 INFO - 2015-12-16 11:17:24,760 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:17:24 INFO - 2015-12-16 11:17:24,760 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,760 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.60 Median:114.00 stddev:4.43 (3.9%) stddev-sans-first:4.67 11:17:24 INFO - 2015-12-16 11:17:24,760 DEBUG : BROWSER_OUTPUT: Values: 113.0 114.0 109.0 115.0 114.0 114.0 103.0 113.0 116.0 105.0 11:17:24 INFO - 2015-12-16 11:17:24,760 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,760 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.80 Median:154.50 stddev:17.44 (11.3%) stddev-sans-first:18.49 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: Values: 152.0 130.0 150.0 175.0 142.0 171.0 157.0 130.0 170.0 131.0 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.73 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 161.0 161.0 163.0 161.0 162.0 162.0 161.0 161.0 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:73.50 stddev:11.75 (16.0%) stddev-sans-first:11.96 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 94.0 95.0 73.0 72.0 74.0 100.0 90.0 72.0 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:95.00 stddev:18.54 (19.5%) stddev-sans-first:19.17 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 135.0 94.0 95.0 94.0 137.0 96.0 97.0 128.0 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 111.0 109.0 109.0 110.0 110.0 110.0 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.00 stddev:1.20 (0.8%) stddev-sans-first:1.22 11:17:24 INFO - 2015-12-16 11:17:24,761 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 150.0 146.0 146.0 146.0 147.0 147.0 147.0 147.0 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 96.0 95.0 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.00 Median:74.00 stddev:3.16 (4.3%) stddev-sans-first:3.33 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: Values: 75.0 75.0 74.0 72.0 73.0 74.0 73.0 82.0 71.0 71.0 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:68.50 stddev:0.71 (1.0%) stddev-sans-first:0.73 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 69.0 70.0 68.0 68.0 69.0 68.0 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,762 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:0.57 (0.7%) stddev-sans-first:0.50 11:17:24 INFO - 2015-12-16 11:17:24,763 DEBUG : BROWSER_OUTPUT: Values: 84.0 86.0 85.0 85.0 85.0 85.0 85.0 84.0 85.0 85.0 11:17:24 INFO - 2015-12-16 11:17:24,763 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,763 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:130.00 stddev:8.09 (6.2%) stddev-sans-first:7.37 11:17:24 INFO - 2015-12-16 11:17:24,763 DEBUG : BROWSER_OUTPUT: Values: 139.0 121.0 135.0 121.0 119.0 125.0 118.0 123.0 136.0 135.0 11:17:24 INFO - 2015-12-16 11:17:24,763 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,763 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.10 Median:148.00 stddev:5.65 (3.8%) stddev-sans-first:5.54 11:17:24 INFO - 2015-12-16 11:17:24,763 DEBUG : BROWSER_OUTPUT: Values: 139.0 152.0 149.0 149.0 147.0 137.0 149.0 146.0 147.0 136.0 11:17:24 INFO - 2015-12-16 11:17:24,763 DEBUG : BROWSER_OUTPUT: 11:17:24 INFO - 2015-12-16 11:17:24,764 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.00 stddev:2.37 (3.4%) stddev-sans-first:2.50 11:17:24 INFO - 2015-12-16 11:17:24,764 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 69.0 70.0 69.0 69.0 77.0 71.0 70.0 11:17:24 INFO - 2015-12-16 11:17:24,764 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:17:24 INFO - 2015-12-16 11:17:24,764 DEBUG : BROWSER_OUTPUT: 11:17:25 INFO - 2015-12-16 11:17:25,677 INFO : Browser exited with error code: 0 11:17:25 INFO - 2015-12-16 11:17:25,732 INFO : Completed test kraken (00:01:00) 11:17:25 INFO - 2015-12-16 11:17:25,732 INFO : Starting test v8_7 11:17:25 INFO - 2015-12-16 11:17:25,732 DEBUG : operating with platform_type : linux_ 11:17:25 INFO - 2015-12-16 11:17:25,732 INFO : Initialising browser for v8_7 test... 11:17:25 INFO - 2015-12-16 11:17:25,738 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnz38y9/profile http://localhost:49567/getInfo.html 11:17:29 INFO - 2015-12-16 11:17:29,907 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:17:29 INFO - 2015-12-16 11:17:29,907 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:17:29 INFO - 2015-12-16 11:17:29,907 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:17:29 INFO - 2015-12-16 11:17:29,908 DEBUG : BROWSER_OUTPUT: __metrics 11:17:30 INFO - 2015-12-16 11:17:30,049 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:17:30 INFO - 2015-12-16 11:17:30,105 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:17:31 INFO - 2015-12-16 11:17:31,258 INFO : Browser initialized. 11:17:31 INFO - 2015-12-16 11:17:31,259 INFO : Running cycle 1/1 for v8_7 test... 11:17:31 INFO - 2015-12-16 11:17:31,259 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnz38y9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:17:43 INFO - 2015-12-16 11:17:43,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 142835712 11:17:43 INFO - 2015-12-16 11:17:43,299 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,690 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49567/tests/v8_7/run.html (next: http://localhost:49567/tests/v8_7/run.html) 11:18:04 INFO - 2015-12-16 11:18:04,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 443252736 11:18:04 INFO - 2015-12-16 11:18:04,940 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,940 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:18:04 INFO - 2015-12-16 11:18:04,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:18:04 INFO - 2015-12-16 11:18:04,941 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:18:04 INFO - 2015-12-16 11:18:04,941 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:18:04 INFO - 2015-12-16 11:18:04,941 DEBUG : BROWSER_OUTPUT: |0;Richards;166.75004168751042 11:18:04 INFO - 2015-12-16 11:18:04,941 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.68768768768768 11:18:04 INFO - 2015-12-16 11:18:04,941 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 11:18:04 INFO - 2015-12-16 11:18:04,942 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5223.958333333333 11:18:04 INFO - 2015-12-16 11:18:04,942 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1966.6011787819255 11:18:04 INFO - 2015-12-16 11:18:04,942 DEBUG : BROWSER_OUTPUT: |5;Earley;784.3137254901961 11:18:04 INFO - 2015-12-16 11:18:04,942 DEBUG : BROWSER_OUTPUT: |6;Boyer;12256.09756097561 11:18:04 INFO - 2015-12-16 11:18:04,942 DEBUG : BROWSER_OUTPUT: |7;RegExp;27648.64864864865 11:18:04 INFO - 2015-12-16 11:18:04,942 DEBUG : BROWSER_OUTPUT: |8;Splay;608.6427267194157 11:18:04 INFO - 2015-12-16 11:18:04,943 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 11:18:04 INFO - 2015-12-16 11:18:04,943 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:18:04 INFO - 2015-12-16 11:18:04,943 DEBUG : BROWSER_OUTPUT: __startTimestamp1450293484938__endTimestamp 11:18:04 INFO - 2015-12-16 11:18:04,943 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,943 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:18:04 INFO - 2015-12-16 11:18:04,943 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:18:04 INFO - 2015-12-16 11:18:04,944 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,944 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.75 Median:166.75 stddev:0.00 (0.0%) 11:18:04 INFO - 2015-12-16 11:18:04,944 DEBUG : BROWSER_OUTPUT: Values: 166.8 11:18:04 INFO - 2015-12-16 11:18:04,944 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,944 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.69 Median:187.69 stddev:0.00 (0.0%) 11:18:04 INFO - 2015-12-16 11:18:04,944 DEBUG : BROWSER_OUTPUT: Values: 187.7 11:18:04 INFO - 2015-12-16 11:18:04,945 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,945 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 11:18:04 INFO - 2015-12-16 11:18:04,945 DEBUG : BROWSER_OUTPUT: Values: 278.8 11:18:04 INFO - 2015-12-16 11:18:04,945 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,945 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5223.96 Median:5223.96 stddev:0.00 (0.0%) 11:18:04 INFO - 2015-12-16 11:18:04,945 DEBUG : BROWSER_OUTPUT: Values: 5224.0 11:18:04 INFO - 2015-12-16 11:18:04,945 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,945 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1966.60 Median:1966.60 stddev:0.00 (0.0%) 11:18:04 INFO - 2015-12-16 11:18:04,945 DEBUG : BROWSER_OUTPUT: Values: 1966.6 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: Values: 784.3 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12256.10 Median:12256.10 stddev:0.00 (0.0%) 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: Values: 12256.1 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27648.65 Median:27648.65 stddev:0.00 (0.0%) 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: Values: 27648.6 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.64 Median:608.64 stddev:0.00 (0.0%) 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: Values: 608.6 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 11:18:04 INFO - 2015-12-16 11:18:04,946 DEBUG : BROWSER_OUTPUT: Values: 4835.7 11:18:04 INFO - 2015-12-16 11:18:04,947 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:18:04 INFO - 2015-12-16 11:18:04,947 DEBUG : BROWSER_OUTPUT: 11:18:05 INFO - 2015-12-16 11:18:05,841 INFO : Browser exited with error code: 0 11:18:05 INFO - 2015-12-16 11:18:05,858 INFO : Completed test v8_7 (00:00:40) 11:18:05 INFO - 2015-12-16 11:18:05,989 INFO : Completed test suite (00:20:18) 11:18:05 INFO - 2015-12-16 11:18:05,989 DEBUG : Working with test: dromaeo_css 11:18:05 INFO - 2015-12-16 11:18:05,989 DEBUG : Generating results file: dromaeo_css 11:18:05 INFO - 2015-12-16 11:18:05,990 DEBUG : Working with test: kraken 11:18:05 INFO - 2015-12-16 11:18:05,990 DEBUG : Generating results file: kraken 11:18:05 INFO - 2015-12-16 11:18:05,991 INFO : javascript benchmark 11:18:05 INFO - 2015-12-16 11:18:05,991 DEBUG : Working with test: v8_7 11:18:05 INFO - 2015-12-16 11:18:05,991 DEBUG : Generating results file: v8_7 11:18:05 INFO - 2015-12-16 11:18:05,991 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:18:06 INFO - 2015-12-16 11:18:06,051 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:18:06 INFO - 2015-12-16 11:18:06,051 DEBUG : process_Request line: dromaeo_css 6319.95 graph.html#tests=[[72,132,35]] 11:18:06 INFO - 2015-12-16 11:18:06,051 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:18:06 INFO - 2015-12-16 11:18:06,085 DEBUG : process_Request line: kraken 1534.80 graph.html#tests=[[232,132,35]] 11:18:06 INFO - 2015-12-16 11:18:06,086 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:18:06 INFO - 2015-12-16 11:18:06,118 DEBUG : process_Request line: v8_7 19719.18 graph.html#tests=[[230,132,35]] 11:18:06 INFO - 2015-12-16 11:18:06,119 INFO : javascript benchmark 11:18:06 INFO - 2015-12-16 11:18:06,122 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2623.3572774670206, 2710.4443589064244, 2729.2221716810714, 2743.588461730739, 2752.944941101178, 4475.395821564096, 4595.908081838361, 4777.570018698317, 4778.450478195009, 4801.975990120049, 4715.3162791395225, 4739.052189562084, 4754.453237877645, 4791.592714619262, 4902.142125128097, 4298.097399546099, 4324.394584758128, 4349.173657005159, 4448.599626033656, 4499.460064792213, 4419.734815911055, 4464.151811155886, 4472.597466228039, 4477.843275485358, 4516.322551617267, 4144.3990621359735, 4239.046214601721, 4254.680898932562, 4367.432233809616, 4408.29467285236, 4349.69552131351, 4349.80425880833, 4363.716358436724, 4383.364412160251, 4404.735715857027, 4119.876403707864, 4331.112122014979, 4334.674899382559, 4343.326784348431, 4394.318880573516, 4553.908921821545, 4568.703034302793, 4578.610818080467, 4669.649776266793, 4705.764711764398, 5036.093503169428, 5047.899042019139, 5052.873678158076, 5055.949440505585, 5092.719900405476, 4926.704397736147, 5060.2662613920775, 5079.593632509391, 5079.8984020319385, 5082.517160869711, 4647.721136731807, 4660.673752837337, 4681.578657920803, 4809.134355815917, 4814.566688998007, 5256.763445644955, 5261.13191323435, 5268.894622107537, 5274.050670879278, 5277.2875661785165, 5038.3198268234055, 5045.621578381636, 5048.7475626219275, 5050.898982020339, 5088.0587091388215, 4919.7540122993705, 5010.549050585465, 5021.698698078054, 5023.572996295283, 5139.357580302462, 5052.9242061369105, 5057.620678449131, 5058.114829904752, 5063.721495317793, 5112.130937740593, 5024.824131155465, 5027.824026159067, 5028.7737051832755, 5028.899422011613, 5033.5469807716745, 4004.9599504004586, 4056.0671045659665, 4108.63022327986, 4152.522459917088, 4234.640055595247, 3720.8325625346924, 3724.031751744512, 3751.868684596026, 3752.9061773455883, 3764.0778009387877, 4411.713238639478, 4412.448443944507, 4412.4705035395955, 4448.9110217796115, 4454.26504626733, 4835.879103022382, 4950.257461380822, 4952.182889823139, 4971.577415919615, 5118.283440318359, 4321.114171594815, 4328.415663885336, 4347.391365208873, 4355.586219309161, 4385.956140438619, 4431.268840641258, 4433.933490997638, 4449.844255451108, 4453.0, 4472.418585583919, 4650.627949763943, 4786.976065119652, 4787.257975013878, 4798.760061996886, 4807.134715751198, 4995.325631039763, 5068.239764035424, 5075.0, 5085.4406015337545, 5133.486651334837, 4840.370751802243, 4866.197077482318, 4889.291052797395, 4890.975545122252, 4929.433115191799, 4768.403949506312, 4896.338994235875, 4905.092557876804, 5048.268001139741, 5092.312537807348, 4988.276699878425, 5060.51925067118, 5074.11203039474, 5077.619178561548, 5091.516305950929, 4895.388076490439, 4964.478729733326, 4966.354373931365, 4967.0, 5011.649184557192, 4716.976415117902, 4775.164346239325, 4825.638077144298, 4964.652474326763, 5032.370953630796, 4717.410323709536, 4738.50245724194, 4757.3577567028005, 4792.448868380181, 4803.351547541037, 4946.08497427977, 4996.475370086234, 4998.050370429607, 5005.249212618136, 5050.444451110448, 4664.300354946785, 4818.469968303554, 4874.731889746098, 4884.609231261419, 4923.852284431473], "unit": "score", "name": "dojo.html", "value": 4637.985711306945}, {"lowerIsBetter": false, "replicates": [554.6516428276547, 576.8067697321397, 580.0660935893213, 583.34665175004, 591.5149577346576, 26512.60231096535, 35583.4662480063, 35642.0, 35754.28491430173, 35777.46333804995, 38465.0, 39226.21547569047, 39244.0, 39317.606823931754, 39387.40918886219, 6847.315268473138, 6941.548799328028, 6945.791626251221, 7703.768886933387, 7864.0956290026525, 7003.369696727294, 7106.040684507603, 9939.75150621233, 10029.498525073754, 10122.74693132674, 9778.706638800848, 9867.506624668773, 9871.90128098717, 9874.90125098747, 9876.802463950717, 7163.391111755507, 9819.06718861707, 9948.651797187063, 9965.302428829984, 9967.800643987151, 7084.929150708478, 10139.290249682525, 10407.895921040768, 10408.115310198642, 10410.271281010333, 36640.816795916115, 37193.25613487715, 37216.627833721584, 37282.0, 37325.81337093324, 2988.656304524964, 3000.819950802959, 3012.186709588421, 3493.755437119403, 3571.0, 26949.461010779676, 27409.0, 27784.58323125155, 27940.0, 27987.720122798713, 3186.681331866818, 3227.4190645683766, 3247.2044349134612, 3248.4802431611065, 3321.1531059579893, 214877.0, 216309.0, 216382.0, 216673.0, 288434.9999999979, 40944.795276023426, 52625.0, 53433.73283133637, 54021.0, 54481.91036179254, 47813.5218647816, 47946.280805787945, 47971.682548570796, 47995.28007079827, 48129.75935120302, 12856.0, 13012.089153759145, 13014.0, 13014.089013769135, 13016.787146185172, 10801.243912926177, 11040.227184097035, 11053.723656908642, 11058.668239952653, 11065.557377704963, 18046.819531804776, 18157.7276340855, 18185.272589096552, 18190.45428637143, 18190.727139092924, 6941.514094013472, 7281.490295679251, 7307.744228951961, 7338.229485903903, 7365.158710322419, 823.3248736036393, 889.3107841422949, 889.7820034091689, 954.9727364255327, 1040.869891263592, 22806.0, 24146.154884578955, 24288.392790180034, 24575.87712061428, 24590.508189836462, 962.7159987803615, 999.4453078541334, 1072.4155335342257, 1074.3285446595878, 1109.7614012987246, 12826.486940522462, 12889.0, 13044.413001414769, 13061.673458163432, 13084.934575327063, 263121.0, 267355.0, 268217.0, 269138.0, 269605.0, 44832.55167448349, 44834.0, 44900.10199796051, 44991.0, 45073.77463112663, 1196.461592283476, 1215.143323956626, 1215.7933151364289, 1224.3143839449758, 1227.5642147037852, 23514.294571162893, 28764.85617571899, 31666.841665791522, 32055.198620034687, 32325.35349293048, 41564.79217603893, 41655.37516937188, 42144.36783448189, 42207.0, 42225.36661950134, 226547.0, 229691.0, 230319.0, 230672.0, 230896.0, 28872.989445369312, 29289.414211716074, 36129.819350903075, 36412.0, 36925.0, 41162.0, 41758.791206043774, 42003.0, 42575.0, 42686.359704603834, 35107.0, 35222.8238858804, 35283.294334113685, 37704.81147594244, 39289.80355098206, 29901.10296691103, 32988.34023319568, 33741.66258337385, 35538.64461355457, 37245.0, 34909.8254508736, 35412.114697132776, 35539.11152221112, 35764.64235357613, 35820.462693059104, 31444.37111257808, 31487.21281967969, 32045.359092817547, 32419.35161296808, 34311.485327720606, 23816.0, 23855.880720596288, 23903.16338928199, 23910.431839367437, 24073.879630602434], "unit": "score", "name": "ext.html", "value": 17199.012194406703}, {"lowerIsBetter": false, "replicates": [331.3059141099396, 337.35733427819997, 339.3789365461206, 340.67465570380284, 347.5169514375019, 11984.7603047939, 12286.324252166127, 14528.128312301269, 14750.262486875667, 15147.545573632795, 12237.326947017911, 14603.342849571769, 14682.706345873075, 15031.624209394744, 15080.924595377008, 4564.726116433025, 4708.976455117737, 4883.096627123985, 4948.5298896604945, 5022.899542009158, 4965.180745177059, 4982.750862456881, 4991.226359914219, 4996.425411077718, 5002.399712034543, 4820.542048505386, 4924.482929292409, 4936.234883593049, 4948.901021979558, 5095.0, 5071.594272458213, 5100.285959965608, 5100.821471248507, 5104.081265372231, 5108.846734597968, 4452.732836029816, 4546.863594092182, 4574.61115805157, 4579.7252164870215, 4583.541645835423, 18999.145038473303, 19229.0, 19354.709679354823, 19451.0, 19473.707894381594, 1840.7791065072277, 1969.2516843599483, 1985.384530795458, 2022.5853699991467, 2077.2833372486466, 12545.0, 12622.558210462681, 12659.620211393672, 12874.871251287555, 13028.934855325757, 1697.7283634618525, 1715.0995727243173, 1747.4757572728258, 1772.7429522719262, 1815.591491914322, 49717.0, 51502.7424862877, 51579.22631160536, 51890.740546297406, 51947.480525194645, 9426.95286523563, 9534.856977145348, 9688.32181747285, 9717.56270967808, 9777.706668799947, 10679.252452328263, 10827.729306767395, 11237.775244495228, 12182.634520964386, 12194.81707774384, 6698.296678848651, 6736.427403670645, 6776.05135281061, 6799.694013769392, 6942.236354001056, 6062.9090563641585, 6089.725962331706, 6215.627062376272, 6407.295197528269, 6412.935870641327, 5768.625039372428, 5811.0, 5813.82558523245, 5853.473187413153, 5882.735276912549, 1570.3169121432213, 1590.618251619603, 1646.925888335004, 1682.6466442047308, 1696.1095424902026, 851.1190917400461, 881.7442941547008, 882.1134759566595, 892.4020905993, 965.1024547171058, 14637.634059148606, 15486.457973971083, 15515.301811418512, 15805.604859878365, 16263.674726505404, 838.8070743728977, 850.1753299299669, 863.2720602894822, 903.3766700976437, 962.1869520255373, 7467.290607392289, 8944.418612790278, 9089.409188402733, 9365.250779937725, 9475.620975160917, 496521.0, 507097.0, 515972.0, 516947.15264236636, 519571.0, 34714.0, 51790.22314665283, 53246.46753532415, 55067.898642026936, 69524.3047569528, 1029.0, 1051.6161601015574, 1054.5887104029434, 1055.0609957138154, 1062.2351906627216, 13519.526816561372, 14167.433302667778, 14261.429542818587, 14467.0, 14484.275786210437, 28621.713782861905, 29213.85393073021, 29631.77761667927, 30348.544771827997, 30599.694003060577, 38561.22877542378, 39289.0, 39340.2131957365, 39928.0, 40456.0, 8143.470674406145, 8243.299319557906, 8420.200080992296, 8428.11504791988, 8498.660053597787, 10173.389596624227, 10299.794004120025, 11137.443127843737, 15208.847911520743, 15447.304871281043, 12524.686882828002, 12920.806187907001, 13046.54337098197, 13080.411381487665, 13427.798583021067, 12209.450574723982, 12399.814002790146, 12656.936715316733, 12715.55495557651, 12809.487620495076, 13930.512432064828, 13938.0, 14013.649658758613, 14270.215138167501, 14363.56909292723, 8737.956310218407, 8872.378933474594, 8890.866637000321, 8898.154675305836, 9247.630094796403, 13719.1082579632, 13845.653858653613, 13941.721165576835, 14172.503962361268, 14233.857661423668], "unit": "score", "name": "jquery.html", "value": 8119.687859364653}, {"lowerIsBetter": false, "replicates": [1263.9684007899796, 1687.9662406751866, 1702.1829521829522, 1728.153204929584, 1756.3764863473464, 5869.178315035893, 7085.645717714113, 7231.132264128312, 7243.674034668439, 7258.637068146598, 6924.896126558106, 7084.22073571908, 7087.503874728771, 7091.255418181094, 7096.183938847034, 2026.422469596169, 2067.7105205271273, 2069.0999415254414, 2071.161179722215, 2072.512959454527, 2079.4385515910694, 2098.380977611608, 2110.7150534677776, 2122.7877212278727, 2124.702541644171, 2016.4656366063004, 2071.575327057957, 2098.08733201058, 2109.567538654572, 2113.281484295347, 2081.604495145925, 2094.7591027031935, 2117.7035215069905, 2117.904694288753, 2118.5656940327194, 2015.3550863723615, 2040.2655044184082, 2046.5906818636183, 2049.1496029147884, 2095.769465358809, 7186.604736739478, 7198.424126069955, 7257.92742072583, 7277.090363704537, 7286.089238845145, 4159.708820382574, 4206.957930420687, 4216.051388437577, 4236.301010333292, 4239.236937351276, 2656.681198256202, 2680.088769818252, 2716.6739991201184, 2731.4400547887835, 2768.6677598688084, 837.5267973594961, 840.6503821818034, 859.2181115185151, 868.7480630617176, 870.6212797433137, 9686.46724430156, 9709.563069661812, 9712.22302215821, 9718.902810971871, 9730.270229732798, 3863.459115723801, 3874.6706529945272, 3946.7631942083567, 3949.1706741584017, 3969.1069509360163, 8379.539125348165, 8382.119877412906, 8400.831983360298, 8409.789755256168, 8423.705170319132, 4251.0, 4251.149770046003, 4255.893467698421, 4259.488861336659, 4266.168097221012, 3266.3304022675293, 3350.246194606194, 3847.403652433877, 3891.105045839416, 3902.512185976753, 3476.652334766503, 3491.738119641037, 3492.877749278763, 3503.106707789548, 3537.8407971641336, 1102.1733699725205, 1108.2740804772886, 1114.3648120571359, 1122.4275619434147, 1123.1969142063301, 1191.839101721274, 1201.6335017819474, 1212.496813822254, 1222.2483172848633, 1241.1994263700044, 6654.401103900575, 6730.125083739083, 6761.0, 6764.661766911733, 6766.086578311963, 411.22073670394434, 414.2812220796915, 416.7686933751797, 417.2218811915755, 428.7277578737524, 5357.11607584752, 5406.864828379322, 5409.6754194747655, 5410.810621628224, 5418.701971391612, 8457.830843383097, 8590.87113693295, 8743.693970710994, 8759.912400876037, 8787.0, 8682.696105636272, 8699.478031318142, 8758.956205218934, 8768.956155219183, 8783.297336213087, 6735.562188457832, 6852.657367131624, 6882.7591034313555, 6888.724451022003, 6926.411255043277, 6503.837404064936, 6510.44661203803, 6550.803475895731, 6552.57408268461, 6562.146920900253, 7623.923760762322, 7638.350740187147, 7744.186860379579, 7815.765527034198, 7853.764387068397, 7827.295543401121, 7983.2415920487465, 8099.676012959416, 8170.0604430488875, 8199.385046121684, 5447.836564903059, 5579.051561234681, 5592.664440133605, 6387.776427825004, 6457.192850893638, 5983.162357270073, 6448.774292899726, 6515.478761698958, 6533.444657204001, 6556.80329590094, 6358.618482891041, 6671.566348187353, 6693.0, 6758.42553382968, 6768.9661551691925, 5951.464368206882, 5992.550558708202, 6157.0456579230295, 6574.342565743387, 6664.866702666017, 6448.645324507197, 6532.5753826001155, 6537.738490460329, 6539.21529416454, 6541.6402097885075, 5862.208601838697, 5878.94121058801, 5941.257342832146, 5941.821745347646, 5979.282486101695, 6069.939300607114, 6083.330833608388, 6084.939150608438, 6087.391260873877, 6097.085437184281], "unit": "score", "name": "mootools.html", "value": 4029.8741582078246}, {"lowerIsBetter": false, "replicates": [294.4581969176715, 302.7199840147863, 305.2003750174543, 310.73121749686516, 310.73276981795664, 5250.816221432246, 5271.73641317934, 5346.465353464651, 5371.5165635092835, 5372.650777699457, 5248.370195576526, 5255.316808814849, 5260.947390526094, 5263.0526505229045, 5285.709285989269, 3958.940615890764, 4100.302948498747, 4100.733452325604, 4103.09731858992, 4107.13750112476, 4017.4576432181575, 4057.2088442753675, 4131.958680413188, 4175.331946888498, 4182.53992060873, 4106.8562600309, 4115.670746340301, 4120.402541631476, 4128.8761337159785, 4133.23535145999, 3927.096767743435, 3985.0834308109297, 4014.7992600370158, 4129.029678025661, 4132.359484279927, 3616.439451884962, 3623.5108260385036, 3636.909077273063, 3638.3450978823803, 3645.0887278180453, 5114.872128196787, 5124.256982737482, 5140.203268493389, 5140.331756871583, 5144.639875208737, 4742.454617718938, 4753.405824271966, 4753.429588449374, 4757.310190022427, 4758.310045043484, 5429.701366424845, 5576.0, 5586.692731899744, 5590.357108932443, 5590.385057643656, 3959.208158368338, 3959.40608908666, 3959.5842436544326, 3962.7027972902147, 3967.444557761916, 5901.4098590141075, 5904.793332233351, 5914.674692891889, 5920.0, 5923.141144534018, 4074.083331250445, 4077.368007958771, 4078.388241763759, 4079.938800917989, 4088.0, 3946.131850992777, 4099.077707515785, 4131.008557946071, 4138.317177665712, 4140.254754144283, 4693.55411235932, 4696.624270058387, 4697.647676424282, 4699.812007519729, 4701.764911754467, 5601.943980560224, 5619.157126430986, 5629.802956896489, 5629.943700562942, 5638.492535671728, 1409.2460533614467, 1425.180521200314, 1425.3728359521986, 1426.9500567480295, 1427.3862239237228, 955.049725523095, 957.6552441121191, 964.8552717092492, 981.7005813226891, 984.2814745236018, 4947.2579113133315, 4949.950500495021, 4950.18321976877, 4953.777080031407, 4956.430010548833, 5825.79609713658, 5831.679257640785, 5833.766649334064, 5833.795817146464, 5837.445442682938, 4929.630277729185, 4954.083494553519, 4958.504149585085, 4962.478939711351, 4962.950370496321, 3078.4304903592906, 3123.0630810756684, 3151.8108913465267, 3152.274976755359, 3158.8104713717253, 5558.0, 5635.267415236075, 5641.012822756002, 5642.266505354278, 5648.406917273627, 6059.303180134253, 6093.817185484442, 6094.329623741385, 6100.755969761249, 6106.572539922163, 5511.807086751945, 5628.774849006076, 5637.379888212294, 5639.971800141055, 5646.181303711021, 5804.912926306024, 5875.353711091691, 5879.764809407576, 5881.32364778056, 5911.7635294587735, 5765.279340082489, 5767.077267637158, 5771.7402716877, 5772.163036359789, 5777.306723193244, 5600.4959553640365, 5606.915896261477, 5608.383077861514, 5613.158026296088, 5619.241402410622, 4012.518497780285, 4078.775667338325, 4110.301248787773, 4111.0, 4140.958590414178, 5833.125031245348, 5840.357560668238, 5846.210761547307, 5848.94151058501, 5849.181114643869, 5584.664920104807, 5597.272354593877, 5599.356074051373, 5600.635958662674, 5605.915911261416, 5457.20870473787, 5571.442855714558, 5598.636088654224, 5616.157576363415, 5623.044082505902, 5447.12845944647, 5483.150111732688, 5491.752871120889, 5499.670019798825, 5509.173623956439, 5473.343198816167, 5637.943620563742, 5664.801731939362, 5672.943270567406, 5681.318241811009, 5434.891302173855, 5568.1091025435735, 5579.191017302387, 5583.274174357308, 5589.944100558942], "unit": "score", "name": "prototype.html", "value": 4228.926668579825}, {"lowerIsBetter": false, "replicates": [663.7809522857458, 692.8856738638125, 755.1391413788282, 767.4321002458179, 777.8755399136138, 11441.141914356425, 11746.236494627865, 11749.236299640528, 11755.764884702301, 11766.882331176706, 10927.836082458769, 13525.458981640748, 13914.721705565882, 13934.930325348385, 13937.372818223179, 638.8850006998738, 645.5706954875003, 822.3256929317947, 836.9916300837006, 837.6523742646795, 821.40858581821, 828.9461185022955, 835.7534527314426, 835.9791005224857, 835.9791005224857, 860.8450478913825, 870.2254993056185, 871.3464901324007, 875.4922145155826, 875.6366108065146, 654.5614438326332, 659.4164164714215, 846.9788255293605, 847.0555330806168, 861.8621020636668, 644.8774732800799, 645.1000853808957, 645.2676212498801, 645.5835985789187, 645.8772833161731, 12392.876071239263, 12798.48806047757, 12830.486780528767, 12834.743305133845, 12861.099723019392, 10564.947175264075, 11222.214444988855, 11265.0, 11407.486663100097, 11491.827622585668, 9328.113829186217, 9369.437833729999, 9411.0, 9459.90540094597, 9678.128968392879, 3206.502992036238, 3249.155219642886, 3259.9348013039844, 3281.2289112058647, 3314.983425082859, 37216.627833721315, 42441.787791060844, 42555.57444425578, 42676.14647707029, 42825.0751163617, 8548.615312310962, 8715.694950676696, 8824.602892869836, 9033.77415564616, 9101.40840845343, 15376.923115384576, 15538.145402002998, 15542.9222853885, 15657.138857362726, 15659.921700391653, 6244.12582238487, 6378.0, 6415.230172379251, 6524.445422139076, 6534.052562378429, 3564.3940530109944, 3587.65917237862, 3614.4397618369194, 3627.9637203628154, 3654.4335627977707, 2550.6301586269888, 2578.162097318379, 2580.83224590401, 2583.702874169457, 2585.3665851866413, 444.32240832730344, 452.5632764382387, 455.68785382012766, 455.8062823300084, 457.0219729778277, 525.9263703081572, 591.1339887065384, 607.3501353551658, 619.0899377914459, 630.5775130662468, 7941.36469082472, 8042.0, 8157.714479993172, 8157.974764319142, 8221.260086592236, 471.582649355323, 496.4985364781597, 580.3702982264206, 619.6653806944199, 657.5002997721671, 3693.1505753676806, 4046.0491784430637, 4088.693347998912, 4103.097318589906, 4283.418349521392, 50560.74719626379, 51429.0, 51531.96936061258, 51599.226011609855, 51673.48326516762, 44347.77826110849, 44679.77660111744, 44744.105117898114, 44912.55087449084, 45126.09747805026, 38032.61967380346, 38427.615723842966, 38940.221195576494, 40940.0, 41962.37056444156, 8022.719204828037, 8081.613134613777, 8362.163783621589, 8448.915510844812, 8482.0, 31301.8434907824, 31343.21641958878, 31773.682263177074, 31788.682113178573, 31872.840635796674, 35382.29235415226, 35812.641873581975, 37972.62027379691, 39351.40972885352, 39541.40687889742, 10036.447995360326, 10166.694999150037, 10193.439360835226, 10223.897761022294, 10235.7441063974, 11110.555577777122, 11131.220814543229, 11247.493862776359, 11796.351200684045, 11804.645860624196, 10438.895611044096, 10466.215033872642, 10567.207459440726, 10571.471426428801, 10755.408452535186, 10574.524146413276, 10738.248322617343, 10837.0, 10928.836067459153, 11081.667549973514, 10704.839427408751, 10706.839397409201, 10737.46312684347, 10744.086752626114, 10945.781084378426, 9166.67916622915, 9220.538973051454, 9282.58228379711, 9604.567794449405, 9659.517024148623, 8808.427452215585, 8852.778680533038, 9018.909810901807, 9323.440593564408, 9334.33520603907], "unit": "score", "name": "yui.html", "value": 5772.22883854099}], "name": "dromaeo_css", "value": 6319.953221177697}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 114.0, 109.0, 115.0, 114.0, 114.0, 103.0, 113.0, 116.0, 105.0], "unit": "score", "name": "ai-astar", "value": 111.6}, {"lowerIsBetter": true, "replicates": [152.0, 130.0, 150.0, 175.0, 142.0, 171.0, 157.0, 130.0, 170.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 150.8}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 161.0, 161.0, 163.0, 161.0, 162.0, 162.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 94.0, 95.0, 73.0, 72.0, 74.0, 100.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 135.0, 94.0, 95.0, 94.0, 137.0, 96.0, 97.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 111.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 150.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [75.0, 75.0, 74.0, 72.0, 73.0, 74.0, 73.0, 82.0, 71.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 74.0}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 69.0, 70.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [84.0, 86.0, 85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [139.0, 121.0, 135.0, 121.0, 119.0, 125.0, 118.0, 123.0, 136.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [139.0, 152.0, 149.0, 149.0, 147.0, 137.0, 149.0, 146.0, 147.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.1}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 69.0, 70.0, 69.0, 69.0, 77.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1534.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.75004168751042], "unit": "score", "name": "Richards", "value": 211.70609399999992}, {"lowerIsBetter": false, "replicates": [187.68768768768768], "unit": "score", "name": "DeltaBlue", "value": 352.2767040000001}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5223.958333333333], "unit": "score", "name": "Decrypt", "value": 50.95389032901295}, {"lowerIsBetter": false, "replicates": [1966.6011787819255], "unit": "score", "name": "RayTrace", "value": 376.2781228771229}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12256.09756097561], "unit": "score", "name": "Boyer", "value": 54.378075621890574}, {"lowerIsBetter": false, "replicates": [27648.64864864865], "unit": "score", "name": "RegExp", "value": 32.94862658846528}, {"lowerIsBetter": false, "replicates": [608.6427267194157], "unit": "score", "name": "Splay", "value": 133.88971299999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19719.17923477144}]} 11:18:06 INFO - RETURN: dromaeo_css: 6319.95 11:18:06 INFO - RETURN: kraken: 1534.80 11:18:06 INFO - RETURN: v8_7: 19719.18 11:18:06 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19719.18"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1534.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6319.95"}}} 11:18:06 INFO - Return code: 0 11:18:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:18:06 ERROR - # TBPL SUCCESS # 11:18:06 INFO - Running post-action listener: _resource_record_post_action 11:18:06 INFO - Running post-run listener: _resource_record_post_run 11:18:07 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 510300160; Read time: 12; Write time: 568572 11:18:07 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 232615936; Read time: 0; Write time: 384600 11:18:07 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277684224; Read time: 12; Write time: 183972 11:18:07 INFO - Running post-run listener: _upload_blobber_files 11:18:07 INFO - Blob upload gear active. 11:18:07 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:18:07 INFO - Copying logs to upload dir... 11:18:07 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1288.515818 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2015-12-16 11:18:07.078804) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:18:07.082557) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010090 build_url: 'https://queue.taskcluster.net/v1/task/D-vLIti1RuqWtOQvR8qK3w/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 11:18:07.135567) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:18:07.136027) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1450291238.641466-705218294 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004443 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 11:18:07.185892) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:18:07.186227) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 11:18:07.186522) ========= ========= Total master_lag: 0.24 =========