builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1450228394.22 results: success (0) buildid: 20151215155559 builduid: 6e9a2defd0d44185a6b2d4d404632c2b revision: ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.215566) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.216013) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.216297) ========= 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=6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006299 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.238877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.239190) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.252288) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.252588) ========= 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=6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004503 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.302057) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.302365) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.302704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.302968) ========= 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=6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-15 17:13:14-- 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% 41.6M=0s 2015-12-15 17:13:14 (41.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100843 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.416413) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.416789) ========= 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=6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017307 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.466163) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:14.466513) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f --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 ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f --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=6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-15 17:13:14,799 truncating revision to first 12 chars 2015-12-15 17:13:14,800 Setting DEBUG logging. 2015-12-15 17:13:14,800 attempt 1/10 2015-12-15 17:13:14,800 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ed5eee4f80f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-15 17:13:15,039 unpacking tar archive at: fx-team-ed5eee4f80f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.529727 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:15.009296) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:15.009641) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:15.018393) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:15.018757) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-15 17:13:15.019193) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-15 17:13:15.019494) ========= /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=6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:13:15 INFO - MultiFileLogger online at 20151215 17:13:15 in /builds/slave/test 17:13:15 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 17:13:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:13:15 INFO - {'append_to_log': False, 17:13:15 INFO - 'base_work_dir': '/builds/slave/test', 17:13:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 17:13:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:13:15 INFO - 'branch': 'Fx-Team-Non-PGO', 17:13:15 INFO - 'buildbot_json_path': 'buildprops.json', 17:13:15 INFO - 'config_files': ('talos/linux_config.py',), 17:13:15 INFO - 'default_actions': ('clobber', 17:13:15 INFO - 'read-buildbot-config', 17:13:15 INFO - 'download-and-extract', 17:13:15 INFO - 'populate-webroot', 17:13:15 INFO - 'create-virtualenv', 17:13:15 INFO - 'install', 17:13:15 INFO - 'run-tests'), 17:13:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:13:15 INFO - 'download_minidump_stackwalk': True, 17:13:15 INFO - 'download_symbols': 'ondemand', 17:13:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:13:15 INFO - 'tooltool.py': '/tools/tooltool.py', 17:13:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:13:15 INFO - '/tools/misc-python/virtualenv.py')}, 17:13:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:13:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:13:15 INFO - 'installer_path': 'installer.exe', 17:13:15 INFO - 'log_level': 'info', 17:13:15 INFO - 'log_name': 'talos', 17:13:15 INFO - 'log_to_console': True, 17:13:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:13:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:13:15 INFO - 'opt_config_files': (), 17:13:15 INFO - 'pip_index': False, 17:13:15 INFO - 'sps_profile': False, 17:13:15 INFO - 'sps_profile_interval': 0, 17:13:15 INFO - 'suite': 'dromaeojs', 17:13:15 INFO - 'system_bits': '64', 17:13:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:13:15 INFO - 'title': 'talos-linux64-ix-018', 17:13:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:13:15 INFO - 'use_talos_json': True, 17:13:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:13:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:13:15 INFO - 'work_dir': 'build'} 17:13:15 INFO - ##### 17:13:15 INFO - ##### Running clobber step. 17:13:15 INFO - ##### 17:13:15 INFO - Running pre-action listener: _resource_record_pre_action 17:13:15 INFO - Running main action method: clobber 17:13:15 INFO - rmtree: /builds/slave/test/build 17:13:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:13:15 INFO - Running post-action listener: _resource_record_post_action 17:13:15 INFO - ##### 17:13:15 INFO - ##### Running read-buildbot-config step. 17:13:15 INFO - ##### 17:13:15 INFO - Running pre-action listener: _resource_record_pre_action 17:13:15 INFO - Running main action method: read_buildbot_config 17:13:15 INFO - Using buildbot properties: 17:13:15 INFO - { 17:13:15 INFO - "properties": { 17:13:15 INFO - "buildnumber": 1013, 17:13:15 INFO - "product": "firefox", 17:13:15 INFO - "script_repo_revision": "production", 17:13:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 17:13:15 INFO - "repository": "", 17:13:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 17:13:15 INFO - "buildid": "20151215155559", 17:13:15 INFO - "slavename": "talos-linux64-ix-018", 17:13:15 INFO - "pgo_build": "False", 17:13:15 INFO - "basedir": "/builds/slave/test", 17:13:15 INFO - "project": "", 17:13:15 INFO - "platform": "ubuntu64_hw", 17:13:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:13:15 INFO - "slavebuilddir": "test", 17:13:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 17:13:15 INFO - "branch": "fx-team", 17:13:15 INFO - "repo_path": "integration/fx-team", 17:13:15 INFO - "stage_platform": "linux64", 17:13:15 INFO - "builduid": "6e9a2defd0d44185a6b2d4d404632c2b", 17:13:15 INFO - "revision": "ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f" 17:13:15 INFO - }, 17:13:15 INFO - "sourcestamp": { 17:13:15 INFO - "repository": "", 17:13:15 INFO - "hasPatch": false, 17:13:15 INFO - "project": "", 17:13:15 INFO - "branch": "fx-team-linux64-talos", 17:13:15 INFO - "changes": [ 17:13:15 INFO - { 17:13:15 INFO - "category": null, 17:13:15 INFO - "files": [ 17:13:15 INFO - { 17:13:15 INFO - "url": null, 17:13:15 INFO - "name": "https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2" 17:13:15 INFO - } 17:13:15 INFO - ], 17:13:15 INFO - "repository": "", 17:13:15 INFO - "rev": "ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f", 17:13:15 INFO - "who": "kwierso@gmail.com", 17:13:15 INFO - "when": 1450228341, 17:13:15 INFO - "number": 7364233, 17:13:15 INFO - "comments": "Merge m-c to fx-team, a=merge", 17:13:15 INFO - "project": "", 17:13:15 INFO - "at": "Tue 15 Dec 2015 17:12:21", 17:13:15 INFO - "branch": "fx-team-linux64-talos", 17:13:15 INFO - "revlink": "", 17:13:15 INFO - "properties": [ 17:13:15 INFO - [ 17:13:15 INFO - "buildid", 17:13:15 INFO - "20151215155559", 17:13:15 INFO - "Change" 17:13:15 INFO - ], 17:13:15 INFO - [ 17:13:15 INFO - "builduid", 17:13:15 INFO - "6e9a2defd0d44185a6b2d4d404632c2b", 17:13:15 INFO - "Change" 17:13:15 INFO - ], 17:13:15 INFO - [ 17:13:15 INFO - "pgo_build", 17:13:15 INFO - "False", 17:13:15 INFO - "Change" 17:13:15 INFO - ] 17:13:15 INFO - ], 17:13:15 INFO - "revision": "ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f" 17:13:15 INFO - } 17:13:15 INFO - ], 17:13:15 INFO - "revision": "ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f" 17:13:15 INFO - } 17:13:15 INFO - } 17:13:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:13:15 INFO - Running post-action listener: _resource_record_post_action 17:13:15 INFO - ##### 17:13:15 INFO - ##### Running download-and-extract step. 17:13:15 INFO - ##### 17:13:15 INFO - Running pre-action listener: _resource_record_pre_action 17:13:15 INFO - Running main action method: download_and_extract 17:13:15 INFO - mkdir: /builds/slave/test/build/tests 17:13:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:13:15 INFO - https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:13:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/test_packages.json 17:13:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/test_packages.json 17:13:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:13:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:13:16 INFO - Downloaded 1302 bytes. 17:13:16 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:13:16 INFO - Using the following test package requirements: 17:13:16 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:16 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:13:16 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'jsshell-linux-x86_64.zip'], 17:13:16 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:13:16 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:16 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:13:16 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:13:16 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:13:16 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:13:16 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:13:16 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:13:16 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:13: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')]} 17:13:16 INFO - https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:18 INFO - Downloaded 21863347 bytes. 17:13:18 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 17:13:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:18 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 17:13:19 INFO - Return code: 0 17:13:19 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 17:13: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')]} 17:13:19 INFO - https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:13:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:20 INFO - Downloaded 21863347 bytes. 17:13:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 17:13:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:13:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 17:13:22 INFO - Return code: 0 17:13: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')]} 17:13:22 INFO - https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:13:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:23 INFO - Downloaded 11132052 bytes. 17:13:23 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 17:13:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:13:23 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 17:13:23 INFO - Return code: 0 17:13:23 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')]} 17:13:23 INFO - https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:13:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:13:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:13:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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 17:13:25 INFO - Downloaded 57747060 bytes. 17:13:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:13:25 INFO - mkdir: /builds/slave/test/properties 17:13:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:13:25 INFO - Writing to file /builds/slave/test/properties/build_url 17:13:25 INFO - Contents: 17:13:25 INFO - build_url:https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:13:25 INFO - Running post-action listener: _resource_record_post_action 17:13:25 INFO - Running post-action listener: set_extra_try_arguments 17:13:25 INFO - ##### 17:13:25 INFO - ##### Running populate-webroot step. 17:13:25 INFO - ##### 17:13:25 INFO - Running pre-action listener: _resource_record_pre_action 17:13:25 INFO - Running main action method: populate_webroot 17:13:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:13:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:13:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:13:25 INFO - '--tppagecycles', 17:13:25 INFO - '7'], 17:13:25 INFO - 'tests': ['tsvgm']}}, 17:13:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:13:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:13:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:13:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:13:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:13:25 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:13:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:25 INFO - 'talos_options': ['--e10s'], 17:13:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:13:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:25 INFO - 'tests': ['damp', 'tps']}, 17:13:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:25 INFO - 'talos_options': ['--e10s'], 17:13:25 INFO - 'tests': ['damp', 'tps']}, 17:13:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:13:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:13:25 INFO - 'other': {'tests': ['a11yr', 17:13:25 INFO - 'ts_paint', 17:13:25 INFO - 'tpaint', 17:13:25 INFO - 'sessionrestore', 17:13:25 INFO - 'sessionrestore_no_auto_restore']}, 17:13:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:13:25 INFO - 'tests': ['a11yr', 17:13:25 INFO - 'ts_paint', 17:13:25 INFO - 'tpaint', 17:13:25 INFO - 'sessionrestore', 17:13:25 INFO - 'sessionrestore_no_auto_restore']}, 17:13:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:13:25 INFO - 'tests': ['a11yr', 17:13:25 INFO - 'ts_paint', 17:13:25 INFO - 'tpaint', 17:13:25 INFO - 'sessionrestore', 17:13:25 INFO - 'sessionrestore_no_auto_restore']}, 17:13:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:13:25 INFO - 'tests': ['a11yr', 17:13:25 INFO - 'ts_paint', 17:13:25 INFO - 'tpaint', 17:13:25 INFO - 'sessionrestore', 17:13:25 INFO - 'sessionrestore_no_auto_restore']}, 17:13:25 INFO - 'other_l64': {'tests': ['a11yr', 17:13:25 INFO - 'ts_paint', 17:13:25 INFO - 'tpaint', 17:13:25 INFO - 'sessionrestore', 17:13:25 INFO - 'sessionrestore_no_auto_restore']}, 17:13:25 INFO - 'other_nol64': {'tests': ['a11yr', 17:13:25 INFO - 'ts_paint', 17:13:25 INFO - 'tpaint', 17:13:25 INFO - 'sessionrestore', 17:13:25 INFO - 'sessionrestore_no_auto_restore']}, 17:13:25 INFO - 'svgr': {'tests': ['tsvgx', 17:13:25 INFO - 'tsvgr_opacity', 17:13:25 INFO - 'tart', 17:13:25 INFO - 'tscrollx', 17:13:25 INFO - 'cart']}, 17:13:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:13:25 INFO - 'tests': ['tsvgx', 17:13:25 INFO - 'tsvgr_opacity', 17:13:25 INFO - 'tart', 17:13:25 INFO - 'tscrollx', 17:13:25 INFO - 'cart']}, 17:13:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:25 INFO - 'tests': ['tp5o']}, 17:13:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:25 INFO - 'talos_options': ['--e10s'], 17:13:25 INFO - 'tests': ['tp5o']}, 17:13:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:25 INFO - 'talos_options': ['--xperf_path', 17:13:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:25 INFO - 'tests': ['tp5n']}, 17:13:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:13:25 INFO - 'talos_options': ['--e10s', 17:13:25 INFO - '--xperf_path', 17:13:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:13:25 INFO - 'tests': ['tp5n']}}, 17:13:25 INFO - 'talos.zip': {'path': '', 17:13:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:13:25 INFO - Running post-action listener: _resource_record_post_action 17:13:25 INFO - ##### 17:13:25 INFO - ##### Running create-virtualenv step. 17:13:25 INFO - ##### 17:13:25 INFO - Running pre-action listener: _resource_record_pre_action 17:13:25 INFO - Running main action method: create_virtualenv 17:13:25 INFO - Creating virtualenv /builds/slave/test/build/venv 17:13:25 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 17:13:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:13:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:13:25 INFO - Using real prefix '/usr' 17:13:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:13:26 INFO - Installing distribute.............................................................................................................................................................................................done. 17:13:28 INFO - Installing pip.................done. 17:13:28 INFO - Return code: 0 17:13:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a21e16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21750b0>, '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 0x2175fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2176440>, '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': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', '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 17:13: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', 'pip>=1.5'] in /builds/slave/test/build 17:13: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 pip>=1.5 17:13:28 INFO - Using env: {'DISPLAY': ':0', 17:13:28 INFO - 'HOME': '/home/cltbld', 17:13:28 INFO - 'LANG': 'en_US.UTF-8', 17:13:28 INFO - 'LANGUAGE': 'en_US:en', 17:13:28 INFO - 'LOGNAME': 'cltbld', 17:13:28 INFO - 'MAIL': '/var/mail/cltbld', 17:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:28 INFO - 'MOZ_NO_REMOTE': '1', 17:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:28 INFO - 'NO_EM_RESTART': '1', 17:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:28 INFO - 'PWD': '/builds/slave/test', 17:13:28 INFO - 'SHELL': '/bin/bash', 17:13:28 INFO - 'SHLVL': '1', 17:13:28 INFO - 'TERM': 'linux', 17:13:28 INFO - 'TMOUT': '86400', 17:13:28 INFO - 'USER': 'cltbld', 17:13:28 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', 17:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:28 INFO - '_': '/tools/buildbot/bin/python'} 17:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:28 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 17:13:28 INFO - Cleaning up... 17:13:28 INFO - Return code: 0 17:13:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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', '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 0x7f7a21e16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21750b0>, '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 0x2175fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2176440>, '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': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', '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 17:13: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', 'psutil>=0.7.1'] in /builds/slave/test/build 17:13: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 psutil>=0.7.1 17:13:28 INFO - Using env: {'DISPLAY': ':0', 17:13:28 INFO - 'HOME': '/home/cltbld', 17:13:28 INFO - 'LANG': 'en_US.UTF-8', 17:13:28 INFO - 'LANGUAGE': 'en_US:en', 17:13:28 INFO - 'LOGNAME': 'cltbld', 17:13:28 INFO - 'MAIL': '/var/mail/cltbld', 17:13:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:28 INFO - 'MOZ_NO_REMOTE': '1', 17:13:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:28 INFO - 'NO_EM_RESTART': '1', 17:13:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:28 INFO - 'PWD': '/builds/slave/test', 17:13:28 INFO - 'SHELL': '/bin/bash', 17:13:28 INFO - 'SHLVL': '1', 17:13:28 INFO - 'TERM': 'linux', 17:13:28 INFO - 'TMOUT': '86400', 17:13:28 INFO - 'USER': 'cltbld', 17:13:28 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', 17:13:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:28 INFO - '_': '/tools/buildbot/bin/python'} 17:13:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:28 INFO - Downloading/unpacking psutil>=0.7.1 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:13:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:13:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:13:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:30 INFO - Installing collected packages: psutil 17:13:30 INFO - Running setup.py install for psutil 17:13:30 INFO - building 'psutil._psutil_linux' extension 17:13:30 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 17:13:30 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 17:13:30 INFO - building 'psutil._psutil_posix' extension 17:13:30 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 17:13:31 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 17:13:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:13:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:13:31 INFO - Successfully installed psutil 17:13:31 INFO - Cleaning up... 17:13:31 INFO - Return code: 0 17:13:31 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:13:31 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')]} 17:13:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:31 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')]} 17:13:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:31 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 0x7f7a21e16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21750b0>, '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 0x2175fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2176440>, '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': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', '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 17:13:31 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 17:13:31 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 17:13:31 INFO - Using env: {'DISPLAY': ':0', 17:13:31 INFO - 'HOME': '/home/cltbld', 17:13:31 INFO - 'LANG': 'en_US.UTF-8', 17:13:31 INFO - 'LANGUAGE': 'en_US:en', 17:13:31 INFO - 'LOGNAME': 'cltbld', 17:13:31 INFO - 'MAIL': '/var/mail/cltbld', 17:13:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:31 INFO - 'MOZ_NO_REMOTE': '1', 17:13:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:31 INFO - 'NO_EM_RESTART': '1', 17:13:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:31 INFO - 'PWD': '/builds/slave/test', 17:13:31 INFO - 'SHELL': '/bin/bash', 17:13:31 INFO - 'SHLVL': '1', 17:13:31 INFO - 'TERM': 'linux', 17:13:31 INFO - 'TMOUT': '86400', 17:13:31 INFO - 'USER': 'cltbld', 17:13:31 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', 17:13:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:31 INFO - '_': '/tools/buildbot/bin/python'} 17:13:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:31 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13: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 17:13:33 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:13:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:13:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:13:33 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:13:33 INFO - Installing collected packages: mozsystemmonitor 17:13:33 INFO - Running setup.py install for mozsystemmonitor 17:13:33 INFO - Successfully installed mozsystemmonitor 17:13:33 INFO - Cleaning up... 17:13:33 INFO - Return code: 0 17:13:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:13:33 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')]} 17:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:33 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')]} 17:13:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:33 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 0x7f7a21e16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21750b0>, '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 0x2175fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2176440>, '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': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', '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 17:13:33 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 17:13:33 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 17:13:33 INFO - Using env: {'DISPLAY': ':0', 17:13:33 INFO - 'HOME': '/home/cltbld', 17:13:33 INFO - 'LANG': 'en_US.UTF-8', 17:13:33 INFO - 'LANGUAGE': 'en_US:en', 17:13:33 INFO - 'LOGNAME': 'cltbld', 17:13:33 INFO - 'MAIL': '/var/mail/cltbld', 17:13:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:33 INFO - 'MOZ_NO_REMOTE': '1', 17:13:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:33 INFO - 'NO_EM_RESTART': '1', 17:13:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:33 INFO - 'PWD': '/builds/slave/test', 17:13:33 INFO - 'SHELL': '/bin/bash', 17:13:33 INFO - 'SHLVL': '1', 17:13:33 INFO - 'TERM': 'linux', 17:13:33 INFO - 'TMOUT': '86400', 17:13:33 INFO - 'USER': 'cltbld', 17:13:33 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', 17:13:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:33 INFO - '_': '/tools/buildbot/bin/python'} 17:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:33 INFO - Downloading/unpacking blobuploader==1.2.4 17:13:33 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 17:13:33 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 17:13:33 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 17:13:33 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 17:13:33 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 17:13:33 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 17:13:35 INFO - Downloading blobuploader-1.2.4.tar.gz 17:13:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:13:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:13:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:35 INFO - Downloading docopt-0.6.1.tar.gz 17:13:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:13:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:13:35 INFO - Installing collected packages: blobuploader, requests, docopt 17:13:35 INFO - Running setup.py install for blobuploader 17:13:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:13:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:13:36 INFO - Running setup.py install for requests 17:13:36 INFO - Running setup.py install for docopt 17:13:36 INFO - Successfully installed blobuploader requests docopt 17:13:36 INFO - Cleaning up... 17:13:36 INFO - Return code: 0 17:13:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13:36 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')]} 17:13:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:36 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')]} 17:13:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:36 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 0x7f7a21e16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21750b0>, '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 0x2175fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2176440>, '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': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', '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 17:13:36 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 17:13:36 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 17:13:36 INFO - Using env: {'DISPLAY': ':0', 17:13:36 INFO - 'HOME': '/home/cltbld', 17:13:36 INFO - 'LANG': 'en_US.UTF-8', 17:13:36 INFO - 'LANGUAGE': 'en_US:en', 17:13:36 INFO - 'LOGNAME': 'cltbld', 17:13:36 INFO - 'MAIL': '/var/mail/cltbld', 17:13:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:36 INFO - 'MOZ_NO_REMOTE': '1', 17:13:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:36 INFO - 'NO_EM_RESTART': '1', 17:13:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:36 INFO - 'PWD': '/builds/slave/test', 17:13:36 INFO - 'SHELL': '/bin/bash', 17:13:36 INFO - 'SHLVL': '1', 17:13:36 INFO - 'TERM': 'linux', 17:13:36 INFO - 'TMOUT': '86400', 17:13:36 INFO - 'USER': 'cltbld', 17:13:36 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', 17:13:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:36 INFO - '_': '/tools/buildbot/bin/python'} 17:13:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:36 INFO - Running setup.py (path:/tmp/pip-zl3A0i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:36 INFO - Running setup.py (path:/tmp/pip-enVinG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:36 INFO - Running setup.py (path:/tmp/pip-pIfKTS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:36 INFO - Running setup.py (path:/tmp/pip-4gQ5DV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:37 INFO - Running setup.py (path:/tmp/pip-CGge1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:37 INFO - Running setup.py (path:/tmp/pip-ArW647-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:37 INFO - Running setup.py (path:/tmp/pip-2LH2qp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:37 INFO - Running setup.py (path:/tmp/pip-ZBo19r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:37 INFO - Running setup.py (path:/tmp/pip-88X_hE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:37 INFO - Running setup.py (path:/tmp/pip-qAvutU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:37 INFO - Running setup.py (path:/tmp/pip-dC5Qj6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:37 INFO - Running setup.py (path:/tmp/pip-93fABo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:37 INFO - Running setup.py (path:/tmp/pip-SoXjEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:37 INFO - Running setup.py (path:/tmp/pip-me9HF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:37 INFO - Running setup.py (path:/tmp/pip-Dq0OZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:37 INFO - Running setup.py (path:/tmp/pip-8iFgoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:37 INFO - Running setup.py (path:/tmp/pip-PgGVXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:13:37 INFO - Running setup.py install for manifestparser 17:13:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:13:38 INFO - Running setup.py install for mozcrash 17:13:38 INFO - Running setup.py install for mozdebug 17:13:38 INFO - Running setup.py install for mozdevice 17:13:38 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:13:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:13:38 INFO - Running setup.py install for mozfile 17:13:38 INFO - Running setup.py install for mozhttpd 17:13:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:13:38 INFO - Running setup.py install for mozinfo 17:13:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:13:38 INFO - Running setup.py install for mozInstall 17:13:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:13:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:13:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:13:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:13:38 INFO - Running setup.py install for mozleak 17:13:38 INFO - Running setup.py install for mozlog 17:13:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:13:38 INFO - Running setup.py install for moznetwork 17:13:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:13:39 INFO - Running setup.py install for mozprocess 17:13:39 INFO - Running setup.py install for mozprofile 17:13:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:13:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:13:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:13:39 INFO - Running setup.py install for mozrunner 17:13:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:13:39 INFO - Running setup.py install for mozscreenshot 17:13:39 INFO - Running setup.py install for moztest 17:13:39 INFO - Running setup.py install for mozversion 17:13:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:13:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:13:39 INFO - Cleaning up... 17:13:39 INFO - Return code: 0 17:13:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:39 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 0x7f7a21e16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21750b0>, '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 0x2175fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2176440>, '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': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', '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 17:13:39 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 17:13:39 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 17:13:39 INFO - Using env: {'DISPLAY': ':0', 17:13:39 INFO - 'HOME': '/home/cltbld', 17:13:39 INFO - 'LANG': 'en_US.UTF-8', 17:13:39 INFO - 'LANGUAGE': 'en_US:en', 17:13:39 INFO - 'LOGNAME': 'cltbld', 17:13:39 INFO - 'MAIL': '/var/mail/cltbld', 17:13:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:39 INFO - 'MOZ_NO_REMOTE': '1', 17:13:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:39 INFO - 'NO_EM_RESTART': '1', 17:13:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:39 INFO - 'PWD': '/builds/slave/test', 17:13:39 INFO - 'SHELL': '/bin/bash', 17:13:39 INFO - 'SHLVL': '1', 17:13:39 INFO - 'TERM': 'linux', 17:13:39 INFO - 'TMOUT': '86400', 17:13:39 INFO - 'USER': 'cltbld', 17:13:39 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', 17:13:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:39 INFO - '_': '/tools/buildbot/bin/python'} 17:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:13:39 INFO - Running setup.py (path:/tmp/pip-5gAHr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:13:39 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:13:40 INFO - Running setup.py (path:/tmp/pip-190W3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:13:40 INFO - Running setup.py (path:/tmp/pip-04awQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:13:40 INFO - Running setup.py (path:/tmp/pip-XJu1oi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:13:40 INFO - Running setup.py (path:/tmp/pip-dr_N06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:13:40 INFO - Running setup.py (path:/tmp/pip-Y3BSXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:13:40 INFO - Running setup.py (path:/tmp/pip-dif19p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:13:40 INFO - Running setup.py (path:/tmp/pip-kXj0Vp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:13:40 INFO - Running setup.py (path:/tmp/pip-EPc2ZE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:13:40 INFO - Running setup.py (path:/tmp/pip-JAqaRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:13:40 INFO - Running setup.py (path:/tmp/pip-2BlK4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:13:40 INFO - Running setup.py (path:/tmp/pip-jE0wey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:13:40 INFO - Running setup.py (path:/tmp/pip-DS_V22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:13:40 INFO - Running setup.py (path:/tmp/pip-NX0rVv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:13:40 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)) 17:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:40 INFO - Running setup.py (path:/tmp/pip-3JMbDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:13:41 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)) 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:13:41 INFO - Running setup.py (path:/tmp/pip-S3mY7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:13:41 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)) 17:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:13:41 INFO - Running setup.py (path:/tmp/pip-NhIOwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:13:41 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)) 17:13:41 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)) 17:13:41 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)) 17:13:41 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)) 17:13:41 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)) 17:13:41 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)) 17:13:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:13:41 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 17:13:41 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 17:13:41 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 17:13:41 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 17:13:41 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 17:13:41 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 17:13:42 INFO - Downloading blessings-1.5.1.tar.gz 17:13:42 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 17:13:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:13:43 INFO - Installing collected packages: blessings 17:13:43 INFO - Running setup.py install for blessings 17:13:43 INFO - Successfully installed blessings 17:13:43 INFO - Cleaning up... 17:13:43 INFO - Return code: 0 17:13:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:13:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:43 INFO - Reading from file tmpfile_stdout 17:13:43 INFO - Current package versions: 17:13:43 INFO - argparse == 1.2.1 17:13:43 INFO - blessings == 1.5.1 17:13:43 INFO - blobuploader == 1.2.4 17:13:43 INFO - docopt == 0.6.1 17:13:43 INFO - manifestparser == 1.1 17:13:43 INFO - mozInstall == 1.12 17:13:43 INFO - mozcrash == 0.16 17:13:43 INFO - mozdebug == 0.1 17:13:43 INFO - mozdevice == 0.47 17:13:43 INFO - mozfile == 1.2 17:13:43 INFO - mozhttpd == 0.7 17:13:43 INFO - mozinfo == 0.9 17:13:43 INFO - mozleak == 0.1 17:13:43 INFO - mozlog == 3.1 17:13:43 INFO - moznetwork == 0.27 17:13:43 INFO - mozprocess == 0.22 17:13:43 INFO - mozprofile == 0.27 17:13:43 INFO - mozrunner == 6.11 17:13:43 INFO - mozscreenshot == 0.1 17:13:43 INFO - mozsystemmonitor == 0.0 17:13:43 INFO - moztest == 0.7 17:13:43 INFO - mozversion == 1.4 17:13:43 INFO - psutil == 3.1.1 17:13:43 INFO - requests == 1.2.3 17:13:43 INFO - wsgiref == 0.1.2 17:13:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:43 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 0x7f7a21e16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21750b0>, '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 0x2175fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2176440>, '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': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', '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 17:13:43 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 17:13:43 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 17:13:43 INFO - Using env: {'DISPLAY': ':0', 17:13:43 INFO - 'HOME': '/home/cltbld', 17:13:43 INFO - 'LANG': 'en_US.UTF-8', 17:13:43 INFO - 'LANGUAGE': 'en_US:en', 17:13:43 INFO - 'LOGNAME': 'cltbld', 17:13:43 INFO - 'MAIL': '/var/mail/cltbld', 17:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:43 INFO - 'MOZ_NO_REMOTE': '1', 17:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:43 INFO - 'NO_EM_RESTART': '1', 17:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:43 INFO - 'PWD': '/builds/slave/test', 17:13:43 INFO - 'SHELL': '/bin/bash', 17:13:43 INFO - 'SHLVL': '1', 17:13:43 INFO - 'TERM': 'linux', 17:13:43 INFO - 'TMOUT': '86400', 17:13:43 INFO - 'USER': 'cltbld', 17:13:43 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', 17:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:43 INFO - '_': '/tools/buildbot/bin/python'} 17:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:43 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)) 17:13:43 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)) 17:13:43 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)) 17:13:43 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)) 17:13:43 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)) 17:13:43 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)) 17:13:43 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)) 17:13:43 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)) 17:13:43 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)) 17:13:43 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)) 17:13:43 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)) 17:13:43 INFO - Cleaning up... 17:13:43 INFO - Return code: 0 17:13:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:43 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 0x7f7a21e16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21750b0>, '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 0x2175fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2176440>, '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': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', '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 17:13:43 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 17:13:43 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 17:13:43 INFO - Using env: {'DISPLAY': ':0', 17:13:43 INFO - 'HOME': '/home/cltbld', 17:13:43 INFO - 'LANG': 'en_US.UTF-8', 17:13:43 INFO - 'LANGUAGE': 'en_US:en', 17:13:43 INFO - 'LOGNAME': 'cltbld', 17:13:43 INFO - 'MAIL': '/var/mail/cltbld', 17:13:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:43 INFO - 'MOZ_NO_REMOTE': '1', 17:13:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:43 INFO - 'NO_EM_RESTART': '1', 17:13:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:43 INFO - 'PWD': '/builds/slave/test', 17:13:43 INFO - 'SHELL': '/bin/bash', 17:13:43 INFO - 'SHLVL': '1', 17:13:43 INFO - 'TERM': 'linux', 17:13:43 INFO - 'TMOUT': '86400', 17:13:43 INFO - 'USER': 'cltbld', 17:13:43 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', 17:13:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:43 INFO - '_': '/tools/buildbot/bin/python'} 17:13:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:43 INFO - Downloading/unpacking jsonschema 17:13:43 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 17:13:43 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 17:13:43 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 17:13:43 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 17:13:43 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 17:13:43 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 17:13:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:13:45 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 17:13:45 INFO - Downloading/unpacking functools32 (from jsonschema) 17:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:45 INFO - Downloading functools32-3.2.3-2.tar.gz 17:13:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:13:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:13:45 INFO - warning: no files found matching '*.txt' 17:13:45 INFO - no previously-included directories found matching 'build' 17:13:45 INFO - no previously-included directories found matching 'dist' 17:13:45 INFO - no previously-included directories found matching '.git*' 17:13:45 INFO - Installing collected packages: jsonschema, functools32 17:13:45 INFO - Running setup.py install for functools32 17:13:45 INFO - warning: no files found matching '*.txt' 17:13:45 INFO - no previously-included directories found matching 'build' 17:13:45 INFO - no previously-included directories found matching 'dist' 17:13:45 INFO - no previously-included directories found matching '.git*' 17:13:45 INFO - Successfully installed jsonschema functools32 17:13:45 INFO - Cleaning up... 17:13:45 INFO - Return code: 0 17:13:45 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:13: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')]} 17:13:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:13:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13: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')]} 17:13:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:13:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:13:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7a21e16f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20188a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20e6240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21750b0>, '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 0x2175fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2176440>, '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': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', '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 17:13:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 17:13:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 17:13:45 INFO - Using env: {'DISPLAY': ':0', 17:13:45 INFO - 'HOME': '/home/cltbld', 17:13:45 INFO - 'LANG': 'en_US.UTF-8', 17:13:45 INFO - 'LANGUAGE': 'en_US:en', 17:13:45 INFO - 'LOGNAME': 'cltbld', 17:13:45 INFO - 'MAIL': '/var/mail/cltbld', 17:13:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:13:45 INFO - 'MOZ_NO_REMOTE': '1', 17:13:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:13:45 INFO - 'NO_EM_RESTART': '1', 17:13:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:13:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:13:45 INFO - 'PWD': '/builds/slave/test', 17:13:45 INFO - 'SHELL': '/bin/bash', 17:13:45 INFO - 'SHLVL': '1', 17:13:45 INFO - 'TERM': 'linux', 17:13:45 INFO - 'TMOUT': '86400', 17:13:45 INFO - 'USER': 'cltbld', 17:13:45 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', 17:13:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:13:45 INFO - '_': '/tools/buildbot/bin/python'} 17:13:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:13:46 INFO - Downloading/unpacking flake8 17:13:46 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 17:13:46 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 17:13:46 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 17:13:46 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 17:13:46 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 17:13:46 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 17:13:47 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:13:47 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 17:13:47 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:13:48 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 17:13:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:48 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 17:13:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:13:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:13:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:13:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:13:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:13:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:48 INFO - no previously-included directories found matching 'docs/_build' 17:13:48 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:13:48 INFO - Running setup.py install for pep8 17:13:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:13:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:13:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:13:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:13:48 INFO - no previously-included directories found matching 'docs/_build' 17:13:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:13:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:13:48 INFO - Cleaning up... 17:13:48 INFO - Return code: 0 17:13:48 INFO - Running post-action listener: _resource_record_post_action 17:13:48 INFO - Running post-action listener: _start_resource_monitoring 17:13:48 INFO - Starting resource monitoring. 17:13:48 INFO - ##### 17:13:48 INFO - ##### Running install step. 17:13:48 INFO - ##### 17:13:48 INFO - Running pre-action listener: _resource_record_pre_action 17:13:48 INFO - Running main action method: install 17:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:13:48 INFO - Reading from file tmpfile_stdout 17:13:48 INFO - Detecting whether we're running mozinstall >=1.0... 17:13:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:13:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:13:49 INFO - Reading from file tmpfile_stdout 17:13:49 INFO - Output received: 17:13:49 INFO - Usage: mozinstall [options] installer 17:13:49 INFO - Options: 17:13:49 INFO - -h, --help show this help message and exit 17:13:49 INFO - -d DEST, --destination=DEST 17:13:49 INFO - Directory to install application into. [default: 17:13:49 INFO - "/builds/slave/test"] 17:13:49 INFO - --app=APP Application being installed. [default: firefox] 17:13:49 INFO - mkdir: /builds/slave/test/build/application 17:13:49 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'] 17:13:49 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 17:14:03 INFO - Reading from file tmpfile_stdout 17:14:03 INFO - Output received: 17:14:03 INFO - /builds/slave/test/build/application/firefox/firefox 17:14:03 INFO - Running post-action listener: _resource_record_post_action 17:14:03 INFO - ##### 17:14:03 INFO - ##### Running run-tests step. 17:14:03 INFO - ##### 17:14:03 INFO - Running pre-action listener: _resource_record_pre_action 17:14:03 INFO - Running main action method: run_tests 17:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:14:03 INFO - Python 2.7.3 17:14:03 INFO - Return code: 0 17:14:03 INFO - grabbing minidump binary from tooltool 17:14:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:14:03 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 0x21750b0>, '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 0x2175fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2176440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:14:03 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 17:14:03 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 17:14:03 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:14:03 INFO - Return code: 0 17:14:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:14:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:14:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:14:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:14:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:14:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:14:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:14:04 INFO - Return code: 0 17:14:04 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/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] in /builds/slave/test/build 17:14:04 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/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-018 --webServer localhost 17:14:04 INFO - Using env: {'DISPLAY': ':0', 17:14:04 INFO - 'HOME': '/home/cltbld', 17:14:04 INFO - 'LANG': 'en_US.UTF-8', 17:14:04 INFO - 'LANGUAGE': 'en_US:en', 17:14:04 INFO - 'LOGNAME': 'cltbld', 17:14:04 INFO - 'MAIL': '/var/mail/cltbld', 17:14:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:14:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:14:04 INFO - 'MOZ_NO_REMOTE': '1', 17:14:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:14:04 INFO - 'NO_EM_RESTART': '1', 17:14:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:14:04 INFO - 'PWD': '/builds/slave/test', 17:14:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:14:04 INFO - 'SHELL': '/bin/bash', 17:14:04 INFO - 'SHLVL': '1', 17:14:04 INFO - 'TERM': 'linux', 17:14:04 INFO - 'TMOUT': '86400', 17:14:04 INFO - 'USER': 'cltbld', 17:14:04 INFO - 'XDG_SESSION_COOKIE': '6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579', 17:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:14:04 INFO - '_': '/tools/buildbot/bin/python'} 17:14:04 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/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-018', '--webServer', 'localhost'] with output_timeout 3600 17:14:04 INFO - mozversion INFO | application_buildid: 20151215155559 17:14:04 INFO - mozversion INFO | application_changeset: ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f 17:14:04 INFO - mozversion INFO | application_display_name: Nightly 17:14:04 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:14:04 INFO - mozversion INFO | application_name: Firefox 17:14:04 INFO - mozversion INFO | application_remotingname: firefox 17:14:04 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 17:14:04 INFO - mozversion INFO | application_vendor: Mozilla 17:14:04 INFO - mozversion INFO | application_version: 46.0a1 17:14:04 INFO - mozversion INFO | platform_buildid: 20151215155559 17:14:04 INFO - mozversion INFO | platform_changeset: ed5eee4f80f9e7ec86bafc60bc2de8c5c7d0415f 17:14:04 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 17:14:04 INFO - mozversion INFO | platform_version: 46.0a1 17:14:04 INFO - 2015-12-15 17:14:04,810 DEBUG : using testdate: 1450228444 17:14:04 INFO - 2015-12-15 17:14:04,810 DEBUG : actual date: 1450228444 17:14:04 INFO - 2015-12-15 17:14:04,824 INFO : starting webserver on 'localhost:53882' 17:14:04 INFO - 2015-12-15 17:14:04,825 INFO : Starting test suite talos-linux64-ix-018 17:14:04 INFO - 2015-12-15 17:14:04,825 INFO : Starting test dromaeo_css 17:14:04 INFO - 2015-12-15 17:14:04,825 DEBUG : operating with platform_type : linux_ 17:14:04 INFO - 2015-12-15 17:14:04,826 INFO : Initialising browser for dromaeo_css test... 17:14:04 INFO - 2015-12-15 17:14:04,841 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQcTCrt/profile http://localhost:53882/getInfo.html 17:14:08 INFO - 2015-12-15 17:14:08,827 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:14:08 INFO - 2015-12-15 17:14:08,828 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:14:08 INFO - 2015-12-15 17:14:08,828 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:14:08 INFO - 2015-12-15 17:14:08,828 DEBUG : BROWSER_OUTPUT: __metrics 17:14:08 INFO - 2015-12-15 17:14:08,871 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] 17:14:08 INFO - 2015-12-15 17:14:08,947 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] 17:14:10 INFO - 2015-12-15 17:14:10,410 INFO : Browser initialized. 17:14:10 INFO - 2015-12-15 17:14:10,410 INFO : Running cycle 1/1 for dromaeo_css test... 17:14:10 INFO - 2015-12-15 17:14:10,411 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQcTCrt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:14:22 INFO - 2015-12-15 17:14:22,453 DEBUG : BROWSER_OUTPUT: RSS: Main: 141934592 17:14:22 INFO - 2015-12-15 17:14:22,453 DEBUG : BROWSER_OUTPUT: 17:15:13 INFO - 2015-12-15 17:15:13,849 DEBUG : BROWSER_OUTPUT: 1450228513845 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] 17:17:25 INFO - 2015-12-15 17:17:25,927 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53882/tests/dromaeo/cssquery-ext.html) 17:17:26 INFO - 2015-12-15 17:17:26,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 240451584 17:17:26 INFO - 2015-12-15 17:17:26,971 DEBUG : BROWSER_OUTPUT: 17:20:29 INFO - 2015-12-15 17:20:29,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/dromaeo/cssquery-ext.html (next: http://localhost:53882/tests/dromaeo/cssquery-jquery.html) 17:20:29 INFO - 2015-12-15 17:20:29,966 DEBUG : BROWSER_OUTPUT: RSS: Main: 220622848 17:20:29 INFO - 2015-12-15 17:20:29,966 DEBUG : BROWSER_OUTPUT: 17:23:32 INFO - 2015-12-15 17:23:32,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53882/tests/dromaeo/cssquery-mootools.html) 17:23:32 INFO - 2015-12-15 17:23:32,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 219869184 17:23:32 INFO - 2015-12-15 17:23:32,657 DEBUG : BROWSER_OUTPUT: 17:26:34 INFO - 2015-12-15 17:26:34,545 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53882/tests/dromaeo/cssquery-prototype.html) 17:26:35 INFO - 2015-12-15 17:26:35,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 201728000 17:26:35 INFO - 2015-12-15 17:26:35,127 DEBUG : BROWSER_OUTPUT: 17:29:37 INFO - 2015-12-15 17:29:37,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53882/tests/dromaeo/cssquery-yui.html) 17:29:38 INFO - 2015-12-15 17:29:38,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 210132992 17:29:38 INFO - 2015-12-15 17:29:38,534 DEBUG : BROWSER_OUTPUT: 17:32:41 INFO - 2015-12-15 17:32:41,139 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/dromaeo/cssquery-yui.html (next: http://localhost:53882/tests/dromaeo/cssquery-dojo.html) 17:32:41 INFO - 2015-12-15 17:32:41,397 DEBUG : BROWSER_OUTPUT: RSS: Main: 255766528 17:32:41 INFO - 2015-12-15 17:32:41,397 DEBUG : BROWSER_OUTPUT: 17:32:41 INFO - 2015-12-15 17:32:41,398 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:32:41 INFO - 2015-12-15 17:32:41,398 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:32:41 INFO - 2015-12-15 17:32:41,398 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:32:41 INFO - 2015-12-15 17:32:41,398 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:32:41 INFO - 2015-12-15 17:32:41,398 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2634.538955682756;2729.0175536806746;2732.016474069336;2739.8082134250612;2758.6000029995657;4494.842680506183;4609.723416595007;4692.436907571092;4760.857174284768;4776.522347765226;4622.260438329868;4707.411573553306;4713.410823647044;4747.667663263573;4861.9513804861945;4327.870163895072;4370.650347972162;4403.6256918161835;4440;4491.326301054835;4398.472183337988;4435.401220835178;4468.4414448193975;4470.977645111786;4501.189785838547;4189.958100419002;4220.6412454941365;4290.377895205209;4295.334223195409;4327.004788898539;4380.759058251795;4384.758838263894;4385.101054283864;4418;4433.401490798733;4362.978185109086;4374.387585737999;4375.1031038637;4385.342198670193;4393.384926110347;4455.688101832873;4580.427446569179;4598.770061496945;4631.953680463186;4732.479427262998;5089.694618322913;5096.643234973553;5101.642884998052;5102.540771330598;5144.048351055029;5082.669626474304;5094.235864620299;5102.464241254689;5106.336176297094;5113.054084994288;4543.068670922453;4621.6764826462495;4658.254679251304;4664.603508701798;4779.832705855279;5237.921431178535;5280.9207861882105;5283.07546179417;5288.576913846883;5292.179712144623;5055.721935293521;5070.847874563769;5080.77136528857;5085.059264036166;5123.0522353364;4810.8797280068275;4938.753062346868;4938.851834444972;4942.678725882806;5034.8237811677145;5087.567556757643;5095.235714642759;5123.129068058439;5131.61512886535;5135.024345374367;5053.69677819332;5065.772040258197;5066.645334826527;5071.442141364447;5111.616628752859;4045.1707399982934;4211.494620645542;4234.132002939452;4243.427137336482;4303.289957157097;3655.5796083450746;3672.8530858765885;3704.4258139988347;3720.4977328060363;3748.9128152835374;4377.080813029236;4402.207602631493;4403.801828917706;4414.161309351213;4453.042595841845;4894;5133.512316329943;5138.820141295037;5145.048166089286;5153.665011774223;4307.1601037797955;4318.244307246219;4336.457942757155;4378.956210437918;4403.647708183337;4472.843450479283;4521.186186486464;4533.478649955231;4533.9319910201375;4553.385292985471;4633.443986721615;4848.0546293472435;4855.247436647325;4857.392825896763;4875.658703890694;5015.3730783652045;5041.168207245763;5055.87360315995;5094.490550944876;5125.128728116304;4839;4851.102546028996;4854.708717476963;4859.785128499197;4903.632227582874;5069.822556210515;5075.593952483866;5081.034603425337;5087.949120508748;5119.820806271762;4870.1233777920315;4964.106460837084;5003.499650034967;5013.047520971004;5138.152204886152;4917.1149193145575;4963.975180124076;4970.428400733962;4977.477364876636;4986.127427700066;4938.111139994836;4938.209886418156;4953.578945789648;4958.504149585013;4961.330220420197;4637.536246375335;4712.246040633482;4724.527547245386;4728.31439441286;4914.213725803854;4922.532359425849;4948.975255123702;4973.477784832685;4974.701517908937;4978.377702787152;4856.145515300394;4867.951320486892;4869.269609558452;4870.09903167915;4908.239222920453 17:32:41 INFO - 2015-12-15 17:32:41,399 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.7317560746449;573.8536673148346;576.9826905192846;584.8625572990344;589.1663296435544;27540.173794786162;27924.3018924527;27942.86028569854;27947.720522794767;27981.160565183076;28100.859495702545;28677.13968580941;36370.454443183306;37251.441228381525;37307.813460932724;7844.8038799030055;7985.281324680777;7990.560519171472;7996.960015199945;7998.32014278787;7822.882656760153;7935.087464941519;7937.642806073712;7939.761807145795;7940.086890007637;7274.381677557414;7472.925270747304;10148.847767283496;10411.583536658525;10418.426986515738;9868.753281167992;9997.950010249975;10007.249456290807;10015.048570385801;10026.749331266703;7244.094488188976;7441.813954651123;9613.51932403377;9720.125188733047;9750.46372449515;39534.80232598819;41096;41148.38277425841;41161.588384116076;41196.79401603003;3052.282713562311;3114.4549703801745;3497.5453191085;3557.48416479609;3683.1344634010984;27938.860305698545;28077.438451231064;28145.155645330673;28390.29024274389;28810.711892881012;3143.167060728909;3144.701253380925;3147.59081319427;3154.463741164008;3183.6657150999276;215671;217268;217444;217615;217764;53479;53862.7306863471;53871.19193212105;53899.19151212735;53977.46022539724;57432.71283643555;57654;57657;57679.423205768246;57708.13437798437;14024.509142179975;14341.067830590979;14341.211233382055;14350.354234059283;14350.923680723987;11384.43077846121;11419.200655954004;11438.656840294805;11445.084393248686;11447.713807154722;18185.7272140918;18457.261709531467;18563.16465759044;18631.347902823607;18668.719969200472;7054.294570542905;7259.07634476864;7262.891056634155;7324.08448943882;7466.664000120008;870.7344260000634;873.6418068591847;907.491804589432;1022.6983040003217;1080.5461706083306;26301.47397052048;26644.678195756558;26882.32794180122;26891.86554067217;26954.191374258804;855.3157474020759;926.7868241143567;942.6088173408097;959.8800149981253;984.1585444444896;12757.298348590917;13147.95435291784;13203.73592528144;13342.53301134475;13376.866231337563;254230;258130;259150;259513;259627;37487;38358.6164138355;43521;44584.10831783346;44676.55323446789;1155.7052951497483;1157.65270418874;1203.3802591665299;1217.6955761059735;1221.6396163131897;22300.888495557418;24658.260252192464;25593.488130236918;26190.73809261959;26567.867160664846;36372.27255454823;36876.446853297755;36885.26229475449;36907.6309236915;36924.815375922946;156471;156998;157493;157702;158637;25070;25284.115055972954;25357.239282821545;25358.366040849127;25369.365765856;32034.839825800722;33740.83129584337;36267.27465450729;37490.81254593709;38882.80558597302;31275;32196.517052244704;32550.186245344055;32629.18427039343;32746;31806.84096579502;33197.17007074843;33642.158946026546;33668;33912.66087339095;31256.37487250197;32474.35051299008;32677.18307042343;32683.18292042623;32732.181695457803;27495.175144745688;29707.405851883275;30121.397572047998;30893.69106308908;31717;23043.423914402276;23766.643500347855;23951.76048239495;24036.87981560081;24932.753362332172 17:32:41 INFO - 2015-12-15 17:32:41,400 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.7263257812304;332.66733266733274;332.82360349015033;337.0780914199662;337.82433134769923;12708.301043442607;13109.868901310983;15086.3211155498;15494.84505154948;15939.203039848018;9716.514174291293;9987.950060249688;10081.69754907352;14588.489402870902;14623.415063397451;4447.621952134073;4556.612687921514;4561.29299958507;4563.041761230145;4564.383808185886;3374.105861946586;3492.807895565743;4865.245886887538;5028.547430731233;5197.480251974791;5187.19598462239;5224.320838291017;5228.058949389108;5239.397469291023;5264.026155161288;5090.821821236257;5251.448597897204;5272.99813035522;5297.258383826267;5310.20346947957;5111.846644600668;5113.130767769489;5113.897722045575;5116.360454943132;5116.692998420107;12636.49454021838;18683.813161868344;19004.904975475172;19024.334148304744;19779.10994005273;1838.9356372526897;1863.1988245054622;1877.6150889067708;1885.4437940807495;1896.6111947050822;8796.384253102286;9141.45151290918;10293.639722609747;12529.561465348668;12846.935765321114;1738.391562952969;1756.2623698046723;1757.1477833250863;1779.599590092232;1797.2092279397023;47970.28044579299;53348.73325633386;55956;57123.71438142824;57449.7127514364;9149.81700365989;9358.485283309346;9444.763880903032;9465.47939863314;9536.332456727963;11805.763884722257;11805.76388472243;11819.468123934443;11841.23032002917;11841.467133978991;6915.239323674392;6989.0564773755905;7060.7881763547175;7110.822229444305;7182.784516464514;6935.370188005814;6999.530098679233;7149.857002859913;7203.747868824566;7238.384737297283;4115.1975364804175;4167.041580436517;4168.958310416918;4195.244855925963;4199.4120823084795;1604.4945842059715;1640.270079814471;1647.8846480746233;1653.189936930895;1679.3534489221493;788.5899332347262;818.3739439328918;828.8881001064779;832.8500869843365;933.9866245124116;13344.399502022432;15317.693646127238;15948.122853243183;16036.198190090448;16133.838661613469;816.6570040582969;832.2260297922869;870.0951010948669;873.4060838629792;915.7756349694367;8654.567271636393;8835.955820220857;8959.641614335354;9284.303677224236;9503.809923801486;467967;469429;471412;481276;488103;66769.66615166893;69425.65287173532;70628;70829.64585177042;71217;1095.0637205189448;1095.7205912492263;1105.2760441910561;1121.0247085035908;1121.3496172220093;14860.925695371454;14954.252287385805;15095.849041509444;15140.772888406904;15420.537383878502;30313.848430757706;30553.083407497812;31769.20576985594;31925.840370797996;33761.83119084389;36140.45789313215;40249.798751006056;40498;41230.79384603058;42209.57790422179;8033.517988920684;8303.584820759059;8347.165283471604;8362.247397734232;8362.958185209034;9610.087041731025;11888.702782430162;16371.263293151598;16500.587485312964;16548.586285342964;13312.534061307808;13537.33610489268;13787.103838250481;13854.376553054935;14045.789313160107;12681.492740290654;12814.55149069778;13609.79585306241;13877.167369957835;13888.791668125188;10706;11148.331100134017;13298.401571929093;13365.599032029055;13965.930170349084;8523.786905327417;8568.871466927876;8607.65569377218;8725;8728.78178045554;8934.424191182112;13356.532521361705;13393.531226407029;13746.65633359174;13840.100393474391 17:32:41 INFO - 2015-12-15 17:32:41,404 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1456.8470310617392;1678.756580295857;1736.1839935230446;1744.4243399678107;1758.3933542927693;5820.796272130471;6791.11715476988;7004.054452648891;7033.8593228135405;7047.04864843246;7056.894146587805;7200.24397438268;7233.385162261201;7243.565386076839;7257.673404696789;1748.1346733367002;1769.1596491666419;1997.6803711406178;2025.1696804310236;2048.774634790172;2069.9172033118657;2070.420282320945;2071.554615757612;2076.09689784944;2076.885771282579;2012.1750082466192;2017.959640807183;2046.8567200295986;2051.569170474202;2053.0863765624304;2031.8476114291486;2043.4074118505616;2055.8869262190574;2056.578401427711;2091;2046.887421191834;2070.6272870883236;2074.3051077888927;2074.543600407908;2075.335892514396;7290.854182916312;7362.963185184093;7377.114746230487;7385.704571817121;7389.039424874785;4221.767802770877;4307.375430562583;4314;4326.156399502099;4326.524082350938;2663.8268512546624;2745.2999485131363;2756.2695885590333;2759.599858020596;2776.4447110577967;799.0770659887838;805;819.7335865843565;825.2820046559472;834.0491839303199;9681.273904457194;9766.169875560587;9782.853257201077;9796.608135674565;9811.313208075437;3856.9421458678144;3944.7633142011573;3960.584138665456;3967.3850553164307;3974.841006359771;8451.746447606582;8452.535110568855;8473.915260847436;8479.448835825651;8497.277731392776;4266.466691663542;4268.423762791983;4282.336237883133;4286.978565107217;4289.356596510548;3891.1633998690418;3909.6481316681634;3910.335243008695;3913.5890731472787;3917.118648304109;2872.4973129702216;2905.956410653842;3260.543523906655;3349.949750753741;3387.271736576648;1063.851060851466;1081.7025318037445;1084.0947808579767;1086.4296244471716;1088.434014312553;928.331601247101;932.3613324872484;994.5822754443151;1196.7307355844866;1196.8503937007874;6720.260771315151;6727.091842601284;6769.559978601375;6795.966020169867;6799.592024478448;1039.870016247969;1042.9843552346722;1045.2474218562622;1046.534292239946;1069.2408390043156;5365.034293827149;5429.592780541475;5436.728163591804;5444.128939369682;5444.455554444524;8627.266682332072;8730.91269087301;8779.604917778588;8866.689665861664;8940.73177804667;8586.356023298153;8647.913520864711;8681.956590217009;8714.433561818461;8725.083866194085;6814.454843612499;6829.658517074126;6904;6905.723771049203;6927.653617319113;6605.504587156079;6614.702338394687;6615.900761488678;6643.734250629921;6645.534812563074;7643.923560764543;7777.72777952769;7800.1419843816;7814.062312522534;7881.133075361591;7771.533707977539;8007.279344858991;8160.877586836321;8165.755027349189;8239.464434811718;6447.516436267392;6476.676166191766;6477.1579694639395;6490.740370385321;6506.056621789719;6140.293866205265;6460.418562329413;6465.353464653497;6510.153680021567;6517.022446633043;6549.770758023446;6562.278149403466;6641.169853768279;6648.235452922782;6706.228783689743;6369.299377068426;6386.521010924293;6427.325130861379;6482.384173503509;6523.18460192476;6617.205935287796;6682.532222744361;6690.698918548775;6699.564528305645;6699.698513566998;6004.639721616717;6044.879102418015;6060.212172417558;6063.454289114001;6076.848078797889;6170.290416602148;6285.308616052322;6293.874122517615;6301.464375528131;6303.338149494237 17:32:41 INFO - 2015-12-15 17:32:41,404 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.496653239694;296.830806440329;305.43646971337887;305.4959317126742;307.2334525359229;5243.0824605694;5255.106631872576;5289.629725919182;5394.487523685253;5452;5242.947570524294;5323.627346085776;5339.5728341732665;5349.144136938091;5351.25082488452;3907.960920390788;4135.648469880064;4146.523149837762;4152.68854835887;4158.500979882411;3995.900102497432;3998.820053097618;4073.368627862671;4112.753234805921;4118.794060296988;4056.127932494513;4059.5331536873196;4066.715329926906;4067.1662309226685;4070.409790580364;3842.5581058178386;3884.3202439573242;3946.3291240489184;4064.0652649890544;4071.124708187739;3540.0087975366937;3540.805255710935;3544.7518673692853;3548.0952357148763;3560.412531932228;5098.337216161913;5103.821366252163;5114.207297868837;5115.565176959963;5126.102931986888;4619.237825758746;4655.138799322136;4666.2767271073035;4672.229082201433;4673.6027437667835;5398.4871437213405;5515.393306736256;5545.584081193927;5557.749901254453;5558.527525160326;3850.5764365919727;3851.84592616295;3853.6917046636204;3854.5759966403675;3854.9421758673643;5763;5845.941540584582;5848.093545500455;5850.912236316459;5856.209411729405;3973.106051138471;3982.0443093657314;3985.5815139409942;3985.6811455083525;3986.661133803659;3720.2001569662652;3757.5866654667966;4028.738132021409;4030.314846476106;4032.717709760347;4495.145922274757;4538.818447262072;4548.499665036843;4563.224251877123;4639.37368455261;5542.113261878161;5553.861153471114;5554.583406244547;5556.277683901148;5556.416576259516;1391.2626308056747;1420.843707192208;1421.7440860644977;1421.978670319946;1423.0607798852707;931.8881734191805;932.072587775168;944.622151139536;954.289054654287;959.1080295325274;4873.098476781735;4883.877903052381;4883.902321953541;4888.462269150391;4894.461609222983;5782.132680098019;5789.8263052108505;5791.739371728282;5794.913076303858;5796.101604251347;4877.244027175793;4877.658563900563;4888.242322440027;4890.24201248807;4892.804287828447;3036.1954082168245;3087.07387783664;3119.064280715776;3120.2979329651102;3121.32891428344;5534.252875861707;5541.695206763667;5543.029969755357;5543.057680194296;5543.556515478752;5992.730327135289;5993.400659934059;5994.430529099815;6001;6002.6098303611;5520.365158006881;5532.972335138379;5533.087040638249;5535.169724541351;5536.501714845684;5655.717214139194;5830.591858569859;5833.883322333614;5837.795677151279;5840.8247752567495;5678.488935995781;5686.800961966312;5689.089745640843;5693.686847223276;5703.058995265735;5499.477549632778;5511.145772405283;5517.69652669107;5519.2824932758485;5520.66875987442;3923.1957448723515;3928.704973202044;3954.3277642800217;4011.7793521356607;4012.578679238755;5564.415736347625;5738.139279108167;5836.678982655994;5849.151872978479;5854.619449735754;5444.646098003617;5579.163125531203;5599.692016939108;5604.411536788579;5608.635438696635;5556.777728890799;5569.610127291213;5573.665580065209;5575.804846830341;5583.134614134816;5351.464853514617;5468.4531546845;5483.2323474712775;5483.506484416422;5483.561315094863;5630.127330263816;5630.718464076698;5640;5642.294713160855;5644.181593668977;5496.477834605706;5497.725113744217;5504.614676972574;5504.862378440571;5512 17:32:41 INFO - 2015-12-15 17:32:41,404 DEBUG : BROWSER_OUTPUT: |5;yui.html;692.6744430117849;703.9401650859677;703.9753608623696;750.5646724899559;788.4756636836504;12138.089643276757;12330.44512996915;12362.381880905963;12391.566295179658;12447.190932589387;11201.271917325388;11393.715157121076;11402.372869492174;11435.599754008612;11459.968602825744;597.7847974729104;613.9140520327157;781.4646966827742;784.1922819495928;787.2363807107125;785.0775338976708;796.0725754496005;797.5533701127388;797.6570074867805;800.8238187598748;825.1088824070019;831.3432388413146;834.4325858416274;834.5326617094447;835.2107258640588;830.6967956695762;832.0556168748484;832.8292699996516;834.6035633074272;834.7954751086023;619.9349068347803;622.1103821535203;622.2532960447436;622.3682961793783;622.5206590924962;10906.127509799197;10936.781264374747;10970.835437468444;10983.011528962352;11024.559017639285;9685.612575496973;10323.79352412955;11332.886671133265;11435.656930292105;11688.47401866918;9491.19324857388;9572.952135239279;9631.373960692603;9654;9692.854607180827;3308.17295676081;3316.154380632923;3341.465365541502;3353.9161520961925;3375.0718552398043;35549;35715.28569428623;39693.20613587741;43783.34324985128;44463.55536444659;9625.133737963617;9688.176504997013;9720.465374404475;9971.102600765966;9972.202223822076;16254.51236462908;16382;16426.42507512231;16465.588360291087;16495.175241237892;6389.648569328731;6410.67946602668;6508.707108180143;6628.767993120314;6727.966360168266;3476.2004738909686;3497.45789402643;3659.0852286928266;3665.065408320861;3697.242065376591;2370.585147599163;2396.317049640879;2396.6405039244255;2404.9038038478616;2404.9158279460135;484.6655807492889;487.16694452486644;489.5716248282753;490.04441339388336;491.9631027672867;578.5631847954851;607.1287702147432;619.4394073363613;642.7455550871606;646.5377255262509;8027.237412445808;8863.468191908507;9005.414648047987;9057.18485336323;9309.44143351401;494.63397086156704;624.0747294596222;637.0348921384107;647.2912161183497;669.5079116849112;3558.5729712434154;3622.1125824173246;3840.5967373425947;3863.439801228806;3929.292727309112;44912.326315105296;46475.5352446478;47845.76077119592;47914.281285780744;48089.75955120272;41415.378769318486;41542.79228603838;41711;41876.162476750906;42917.35623965643;33621;36811.81594092066;40143.598564014574;42321.57678423238;42333.788331058764;7946;8164.306033987177;8502.659893604186;8816.013205126817;8957.59690813928;31849.203769905936;32036.35927281488;32351.19122021874;32401;33321.66678333186;37854;38155.2368952625;38312.616873830906;38595;39209.41185882157;10008.699739007841;10032.247581431568;10163.7459063524;10233.181345492492;10377.429241391494;11218.046466050477;11219.382933938385;11317.207795454238;12077.154599177973;12080.45637946277;11039.116870650489;11132.332060076422;11144.33134011962;11593.362365070003;11604.245724027911;10630.84053739179;10688.786224275316;11007.174461915229;11415.828762568402;11429.714257143305;10055.346402483816;10137.138343240907;10202.642907498202;10213.897861021294;10634.41510716918;9018.729438116867;9422.62309507612;9494.620215191315;9563.187129094105;9749.317547771589;8606.741797746077;9298.95350523243;9300.209482193819;9320.300977426585;9358.578863951003 17:32:41 INFO - 2015-12-15 17:32:41,404 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:32:41 INFO - 2015-12-15 17:32:41,404 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:32:41 INFO - 2015-12-15 17:32:41,405 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,846 17:32:41 INFO - 2015-12-15 17:32:41,405 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:32:41 INFO - 2015-12-15 17:32:41,405 DEBUG : BROWSER_OUTPUT: __startTimestamp1450229561394__endTimestamp 17:32:41 INFO - 2015-12-15 17:32:41,405 DEBUG : BROWSER_OUTPUT: 17:32:41 INFO - 2015-12-15 17:32:41,405 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:32:41 INFO - 2015-12-15 17:32:41,405 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:32:41 INFO - 2015-12-15 17:32:41,405 DEBUG : BROWSER_OUTPUT: 17:32:41 INFO - 2015-12-15 17:32:41,405 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4683.70 Median:4851.10 stddev:494.00 (10.2%) stddev-sans-first:468.63 17:32:41 INFO - 2015-12-15 17:32:41,407 DEBUG : BROWSER_OUTPUT: Values: 2634.5 2729.0 2732.0 2739.8 2758.6 4494.8 4609.7 4692.4 4760.9 4776.5 4622.3 4707.4 4713.4 4747.7 4862.0 4327.9 4370.7 4403.6 4440.0 4491.3 4398.5 4435.4 4468.4 4471.0 4501.2 4190.0 4220.6 4290.4 4295.3 4327.0 4380.8 4384.8 4385.1 4418.0 4433.4 4363.0 4374.4 4375.1 4385.3 4393.4 4455.7 4580.4 4598.8 4632.0 4732.5 5089.7 5096.6 5101.6 5102.5 5144.0 5082.7 5094.2 5102.5 5106.3 5113.1 4543.1 4621.7 4658.3 4664.6 4779.8 5237.9 5280.9 5283.1 5288.6 5292.2 5055.7 5070.8 5080.8 5085.1 5123.1 4810.9 4938.8 4938.9 4942.7 5034.8 5087.6 5095.2 5123.1 5131.6 5135.0 5053.7 5065.8 5066.6 5071.4 5111.6 4045.2 4211.5 4234.1 4243.4 4303.3 3655.6 3672.9 3704.4 3720.5 3748.9 4377.1 4402.2 4403.8 4414.2 4453.0 4894.0 5133.5 5138.8 5145.0 5153.7 4307.2 4318.2 4336.5 4379.0 4403.6 4472.8 4521.2 4533.5 4533.9 4553.4 4633.4 4848.1 4855.2 4857.4 4875.7 5015.4 5041.2 5055.9 5094.5 5125.1 4839.0 4851.1 4854.7 4859.8 4903.6 5069.8 5075.6 5081.0 5087.9 5119.8 4870.1 4964.1 5003.5 5013.0 5138.2 4917.1 4964.0 4970.4 4977.5 4986.1 4938.1 4938.2 4953.6 4958.5 4961.3 4637.5 4712.2 4724.5 4728.3 4914.2 4922.5 4949.0 4973.5 4974.7 4978.4 4856.1 4868.0 4869.3 4870.1 4908.2 17:32:41 INFO - 2015-12-15 17:32:41,407 DEBUG : BROWSER_OUTPUT: 17:32:41 INFO - 2015-12-15 17:32:41,407 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37122.38 Median:3151.03 stddev:55916.79 (1774.6%) stddev-sans-first:56006.30 17:32:41 INFO - 2015-12-15 17:32:41,407 DEBUG : BROWSER_OUTPUT: Values: 570.7 573.9 577.0 584.9 589.2 27540.2 27924.3 27942.9 27947.7 27981.2 28100.9 28677.1 36370.5 37251.4 37307.8 7844.8 7985.3 7990.6 7997.0 7998.3 7822.9 7935.1 7937.6 7939.8 7940.1 7274.4 7472.9 10148.8 10411.6 10418.4 9868.8 9998.0 10007.2 10015.0 10026.7 7244.1 7441.8 9613.5 9720.1 9750.5 39534.8 41096.0 41148.4 41161.6 41196.8 3052.3 3114.5 3497.5 3557.5 3683.1 27938.9 28077.4 28145.2 28390.3 28810.7 3143.2 3144.7 3147.6 3154.5 3183.7 215671.0 217268.0 217444.0 217615.0 217764.0 53479.0 53862.7 53871.2 53899.2 53977.5 57432.7 57654.0 57657.0 57679.4 57708.1 14024.5 14341.1 14341.2 14350.4 14350.9 11384.4 11419.2 11438.7 11445.1 11447.7 18185.7 18457.3 18563.2 18631.3 18668.7 7054.3 7259.1 7262.9 7324.1 7466.7 870.7 873.6 907.5 1022.7 1080.5 26301.5 26644.7 26882.3 26891.9 26954.2 855.3 926.8 942.6 959.9 984.2 12757.3 13148.0 13203.7 13342.5 13376.9 254230.0 258130.0 259150.0 259513.0 259627.0 37487.0 38358.6 43521.0 44584.1 44676.6 1155.7 1157.7 1203.4 1217.7 1221.6 22300.9 24658.3 25593.5 26190.7 26567.9 36372.3 36876.4 36885.3 36907.6 36924.8 156471.0 156998.0 157493.0 157702.0 158637.0 25070.0 25284.1 25357.2 25358.4 25369.4 32034.8 33740.8 36267.3 37490.8 38882.8 31275.0 32196.5 32550.2 32629.2 32746.0 31806.8 33197.2 33642.2 33668.0 33912.7 31256.4 32474.4 32677.2 32683.2 32732.2 27495.2 29707.4 30121.4 30893.7 31717.0 23043.4 23766.6 23951.8 24036.9 24932.8 17:32:41 INFO - 2015-12-15 17:32:41,407 DEBUG : BROWSER_OUTPUT: 17:32:41 INFO - 2015-12-15 17:32:41,407 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25601.08 Median:22698.92 stddev:77678.40 (342.2%) stddev-sans-first:77873.13 17:32:41 INFO - 2015-12-15 17:32:41,407 DEBUG : BROWSER_OUTPUT: Values: 331.7 332.7 332.8 337.1 337.8 12708.3 13109.9 15086.3 15494.8 15939.2 9716.5 9988.0 10081.7 14588.5 14623.4 4447.6 4556.6 4561.3 4563.0 4564.4 3374.1 3492.8 4865.2 5028.5 5197.5 5187.2 5224.3 5228.1 5239.4 5264.0 5090.8 5251.4 5273.0 5297.3 5310.2 5111.8 5113.1 5113.9 5116.4 5116.7 12636.5 18683.8 19004.9 19024.3 19779.1 1838.9 1863.2 1877.6 1885.4 1896.6 8796.4 9141.5 10293.6 12529.6 12846.9 1738.4 1756.3 1757.1 1779.6 1797.2 47970.3 53348.7 55956.0 57123.7 57449.7 9149.8 9358.5 9444.8 9465.5 9536.3 11805.8 11805.8 11819.5 11841.2 11841.5 6915.2 6989.1 7060.8 7110.8 7182.8 6935.4 6999.5 7149.9 7203.7 7238.4 4115.2 4167.0 4169.0 4195.2 4199.4 1604.5 1640.3 1647.9 1653.2 1679.4 788.6 818.4 828.9 832.9 934.0 13344.4 15317.7 15948.1 16036.2 16133.8 816.7 832.2 870.1 873.4 915.8 8654.6 8836.0 8959.6 9284.3 9503.8 467967.0 469429.0 471412.0 481276.0 488103.0 66769.7 69425.7 70628.0 70829.6 71217.0 1095.1 1095.7 1105.3 1121.0 1121.3 14860.9 14954.3 15095.8 15140.8 15420.5 30313.8 30553.1 31769.2 31925.8 33761.8 36140.5 40249.8 40498.0 41230.8 42209.6 8033.5 8303.6 8347.2 8362.2 8363.0 9610.1 11888.7 16371.3 16500.6 16548.6 13312.5 13537.3 13787.1 13854.4 14045.8 12681.5 12814.6 13609.8 13877.2 13888.8 10706.0 11148.3 13298.4 13365.6 13965.9 8523.8 8568.9 8607.7 8725.0 8728.8 8934.4 13356.5 13393.5 13746.7 13840.1 17:32:41 INFO - 2015-12-15 17:32:41,407 DEBUG : BROWSER_OUTPUT: 17:32:41 INFO - 2015-12-15 17:32:41,407 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5045.53 Median:6406.92 stddev:2634.69 (41.1%) stddev-sans-first:2628.28 17:32:41 INFO - 2015-12-15 17:32:41,409 DEBUG : BROWSER_OUTPUT: Values: 1456.8 1678.8 1736.2 1744.4 1758.4 5820.8 6791.1 7004.1 7033.9 7047.0 7056.9 7200.2 7233.4 7243.6 7257.7 1748.1 1769.2 1997.7 2025.2 2048.8 2069.9 2070.4 2071.6 2076.1 2076.9 2012.2 2018.0 2046.9 2051.6 2053.1 2031.8 2043.4 2055.9 2056.6 2091.0 2046.9 2070.6 2074.3 2074.5 2075.3 7290.9 7363.0 7377.1 7385.7 7389.0 4221.8 4307.4 4314.0 4326.2 4326.5 2663.8 2745.3 2756.3 2759.6 2776.4 799.1 805.0 819.7 825.3 834.0 9681.3 9766.2 9782.9 9796.6 9811.3 3856.9 3944.8 3960.6 3967.4 3974.8 8451.7 8452.5 8473.9 8479.4 8497.3 4266.5 4268.4 4282.3 4287.0 4289.4 3891.2 3909.6 3910.3 3913.6 3917.1 2872.5 2906.0 3260.5 3349.9 3387.3 1063.9 1081.7 1084.1 1086.4 1088.4 928.3 932.4 994.6 1196.7 1196.9 6720.3 6727.1 6769.6 6796.0 6799.6 1039.9 1043.0 1045.2 1046.5 1069.2 5365.0 5429.6 5436.7 5444.1 5444.5 8627.3 8730.9 8779.6 8866.7 8940.7 8586.4 8647.9 8682.0 8714.4 8725.1 6814.5 6829.7 6904.0 6905.7 6927.7 6605.5 6614.7 6615.9 6643.7 6645.5 7643.9 7777.7 7800.1 7814.1 7881.1 7771.5 8007.3 8160.9 8165.8 8239.5 6447.5 6476.7 6477.2 6490.7 6506.1 6140.3 6460.4 6465.4 6510.2 6517.0 6549.8 6562.3 6641.2 6648.2 6706.2 6369.3 6386.5 6427.3 6482.4 6523.2 6617.2 6682.5 6690.7 6699.6 6699.7 6004.6 6044.9 6060.2 6063.5 6076.8 6170.3 6285.3 6293.9 6301.5 6303.3 17:32:41 INFO - 2015-12-15 17:32:41,409 DEBUG : BROWSER_OUTPUT: 17:32:41 INFO - 2015-12-15 17:32:41,409 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4617.18 Median:5344.36 stddev:1374.80 (25.7%) stddev-sans-first:1339.81 17:32:41 INFO - 2015-12-15 17:32:41,410 DEBUG : BROWSER_OUTPUT: Values: 293.5 296.8 305.4 305.5 307.2 5243.1 5255.1 5289.6 5394.5 5452.0 5242.9 5323.6 5339.6 5349.1 5351.3 3908.0 4135.6 4146.5 4152.7 4158.5 3995.9 3998.8 4073.4 4112.8 4118.8 4056.1 4059.5 4066.7 4067.2 4070.4 3842.6 3884.3 3946.3 4064.1 4071.1 3540.0 3540.8 3544.8 3548.1 3560.4 5098.3 5103.8 5114.2 5115.6 5126.1 4619.2 4655.1 4666.3 4672.2 4673.6 5398.5 5515.4 5545.6 5557.7 5558.5 3850.6 3851.8 3853.7 3854.6 3854.9 5763.0 5845.9 5848.1 5850.9 5856.2 3973.1 3982.0 3985.6 3985.7 3986.7 3720.2 3757.6 4028.7 4030.3 4032.7 4495.1 4538.8 4548.5 4563.2 4639.4 5542.1 5553.9 5554.6 5556.3 5556.4 1391.3 1420.8 1421.7 1422.0 1423.1 931.9 932.1 944.6 954.3 959.1 4873.1 4883.9 4883.9 4888.5 4894.5 5782.1 5789.8 5791.7 5794.9 5796.1 4877.2 4877.7 4888.2 4890.2 4892.8 3036.2 3087.1 3119.1 3120.3 3121.3 5534.3 5541.7 5543.0 5543.1 5543.6 5992.7 5993.4 5994.4 6001.0 6002.6 5520.4 5533.0 5533.1 5535.2 5536.5 5655.7 5830.6 5833.9 5837.8 5840.8 5678.5 5686.8 5689.1 5693.7 5703.1 5499.5 5511.1 5517.7 5519.3 5520.7 3923.2 3928.7 3954.3 4011.8 4012.6 5564.4 5738.1 5836.7 5849.2 5854.6 5444.6 5579.2 5599.7 5604.4 5608.6 5556.8 5569.6 5573.7 5575.8 5583.1 5351.5 5468.5 5483.2 5483.5 5483.6 5630.1 5630.7 5640.0 5642.3 5644.2 5496.5 5497.7 5504.6 5504.9 5512.0 17:32:41 INFO - 2015-12-15 17:32:41,410 DEBUG : BROWSER_OUTPUT: 17:32:41 INFO - 2015-12-15 17:32:41,410 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12116.25 Median:42625.57 stddev:13303.09 (31.2%) stddev-sans-first:13312.75 17:32:41 INFO - 2015-12-15 17:32:41,410 DEBUG : BROWSER_OUTPUT: Values: 692.7 703.9 704.0 750.6 788.5 12138.1 12330.4 12362.4 12391.6 12447.2 11201.3 11393.7 11402.4 11435.6 11460.0 597.8 613.9 781.5 784.2 787.2 785.1 796.1 797.6 797.7 800.8 825.1 831.3 834.4 834.5 835.2 830.7 832.1 832.8 834.6 834.8 619.9 622.1 622.3 622.4 622.5 10906.1 10936.8 10970.8 10983.0 11024.6 9685.6 10323.8 11332.9 11435.7 11688.5 9491.2 9573.0 9631.4 9654.0 9692.9 3308.2 3316.2 3341.5 3353.9 3375.1 35549.0 35715.3 39693.2 43783.3 44463.6 9625.1 9688.2 9720.5 9971.1 9972.2 16254.5 16382.0 16426.4 16465.6 16495.2 6389.6 6410.7 6508.7 6628.8 6728.0 3476.2 3497.5 3659.1 3665.1 3697.2 2370.6 2396.3 2396.6 2404.9 2404.9 484.7 487.2 489.6 490.0 492.0 578.6 607.1 619.4 642.7 646.5 8027.2 8863.5 9005.4 9057.2 9309.4 494.6 624.1 637.0 647.3 669.5 3558.6 3622.1 3840.6 3863.4 3929.3 44912.3 46475.5 47845.8 47914.3 48089.8 41415.4 41542.8 41711.0 41876.2 42917.4 33621.0 36811.8 40143.6 42321.6 42333.8 7946.0 8164.3 8502.7 8816.0 8957.6 31849.2 32036.4 32351.2 32401.0 33321.7 37854.0 38155.2 38312.6 38595.0 39209.4 10008.7 10032.2 10163.7 10233.2 10377.4 11218.0 11219.4 11317.2 12077.2 12080.5 11039.1 11132.3 11144.3 11593.4 11604.2 10630.8 10688.8 11007.2 11415.8 11429.7 10055.3 10137.1 10202.6 10213.9 10634.4 9018.7 9422.6 9494.6 9563.2 9749.3 8606.7 9299.0 9300.2 9320.3 9358.6 17:32:41 INFO - 2015-12-15 17:32:41,411 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:32:41 INFO - 2015-12-15 17:32:41,411 DEBUG : BROWSER_OUTPUT: 17:32:42 INFO - 2015-12-15 17:32:42,123 INFO : Browser exited with error code: 0 17:32:42 INFO - 2015-12-15 17:32:42,142 INFO : Completed test dromaeo_css (00:18:37) 17:32:42 INFO - 2015-12-15 17:32:42,142 INFO : Starting test kraken 17:32:42 INFO - 2015-12-15 17:32:42,142 DEBUG : operating with platform_type : linux_ 17:32:42 INFO - 2015-12-15 17:32:42,142 INFO : Initialising browser for kraken test... 17:32:42 INFO - 2015-12-15 17:32:42,148 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyC07aT/profile http://localhost:53882/getInfo.html 17:32:46 INFO - 2015-12-15 17:32:46,243 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:32:46 INFO - 2015-12-15 17:32:46,244 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:32:46 INFO - 2015-12-15 17:32:46,244 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:32:46 INFO - 2015-12-15 17:32:46,244 DEBUG : BROWSER_OUTPUT: __metrics 17:32:46 INFO - 2015-12-15 17:32:46,300 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] 17:32:46 INFO - 2015-12-15 17:32:46,381 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] 17:32:47 INFO - 2015-12-15 17:32:47,217 INFO : Browser initialized. 17:32:47 INFO - 2015-12-15 17:32:47,217 INFO : Running cycle 1/1 for kraken test... 17:32:47 INFO - 2015-12-15 17:32:47,217 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyC07aT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:32:59 INFO - 2015-12-15 17:32:59,222 DEBUG : BROWSER_OUTPUT: RSS: Main: 143355904 17:32:59 INFO - 2015-12-15 17:32:59,222 DEBUG : BROWSER_OUTPUT: 17:33:01 INFO - 2015-12-15 17:33:01,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53882/tests/kraken/driver.html?testName=audio-beat-detection) 17:33:02 INFO - 2015-12-15 17:33:02,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 179781632 17:33:02 INFO - 2015-12-15 17:33:02,431 DEBUG : BROWSER_OUTPUT: 17:33:05 INFO - 2015-12-15 17:33:05,129 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53882/tests/kraken/driver.html?testName=audio-dft) 17:33:05 INFO - 2015-12-15 17:33:05,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 168640512 17:33:05 INFO - 2015-12-15 17:33:05,710 DEBUG : BROWSER_OUTPUT: 17:33:08 INFO - 2015-12-15 17:33:08,730 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53882/tests/kraken/driver.html?testName=audio-fft) 17:33:09 INFO - 2015-12-15 17:33:09,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 155738112 17:33:09 INFO - 2015-12-15 17:33:09,296 DEBUG : BROWSER_OUTPUT: 17:33:11 INFO - 2015-12-15 17:33:11,333 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53882/tests/kraken/driver.html?testName=audio-oscillator) 17:33:11 INFO - 2015-12-15 17:33:11,914 DEBUG : BROWSER_OUTPUT: RSS: Main: 155504640 17:33:11 INFO - 2015-12-15 17:33:11,914 DEBUG : BROWSER_OUTPUT: 17:33:14 INFO - 2015-12-15 17:33:14,153 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53882/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:33:14 INFO - 2015-12-15 17:33:14,722 DEBUG : BROWSER_OUTPUT: RSS: Main: 158449664 17:33:14 INFO - 2015-12-15 17:33:14,722 DEBUG : BROWSER_OUTPUT: 17:33:17 INFO - 2015-12-15 17:33:17,701 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53882/tests/kraken/driver.html?testName=imaging-darkroom) 17:33:18 INFO - 2015-12-15 17:33:18,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 157683712 17:33:18 INFO - 2015-12-15 17:33:18,287 DEBUG : BROWSER_OUTPUT: 17:33:21 INFO - 2015-12-15 17:33:21,679 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53882/tests/kraken/driver.html?testName=imaging-desaturate) 17:33:22 INFO - 2015-12-15 17:33:22,260 DEBUG : BROWSER_OUTPUT: RSS: Main: 159178752 17:33:22 INFO - 2015-12-15 17:33:22,260 DEBUG : BROWSER_OUTPUT: 17:33:25 INFO - 2015-12-15 17:33:25,082 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53882/tests/kraken/driver.html?testName=json-parse-financial) 17:33:25 INFO - 2015-12-15 17:33:25,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 157270016 17:33:25 INFO - 2015-12-15 17:33:25,665 DEBUG : BROWSER_OUTPUT: 17:33:27 INFO - 2015-12-15 17:33:27,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53882/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:33:27 INFO - 2015-12-15 17:33:27,991 DEBUG : BROWSER_OUTPUT: RSS: Main: 166838272 17:33:27 INFO - 2015-12-15 17:33:27,992 DEBUG : BROWSER_OUTPUT: 17:33:29 INFO - 2015-12-15 17:33:29,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53882/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:33:30 INFO - 2015-12-15 17:33:30,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 167546880 17:33:30 INFO - 2015-12-15 17:33:30,496 DEBUG : BROWSER_OUTPUT: 17:33:32 INFO - 2015-12-15 17:33:32,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53882/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:33:33 INFO - 2015-12-15 17:33:33,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 174264320 17:33:33 INFO - 2015-12-15 17:33:33,189 DEBUG : BROWSER_OUTPUT: 17:33:35 INFO - 2015-12-15 17:33:35,744 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:33:36 INFO - 2015-12-15 17:33:36,331 DEBUG : BROWSER_OUTPUT: RSS: Main: 181817344 17:33:36 INFO - 2015-12-15 17:33:36,331 DEBUG : BROWSER_OUTPUT: 17:33:38 INFO - 2015-12-15 17:33:38,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:33:39 INFO - 2015-12-15 17:33:39,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 180097024 17:33:39 INFO - 2015-12-15 17:33:39,541 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53882/tests/kraken/driver.html?testName=ai-astar) 17:33:41 INFO - 2015-12-15 17:33:41,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 237592576 17:33:41 INFO - 2015-12-15 17:33:41,575 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,578 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:33:41 INFO - 2015-12-15 17:33:41,578 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:33:41 INFO - 2015-12-15 17:33:41,578 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:33:41 INFO - 2015-12-15 17:33:41,579 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:33:41 INFO - 2015-12-15 17:33:41,579 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;109;113;113;114;105;112;115;113 17:33:41 INFO - 2015-12-15 17:33:41,579 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;135;152;166;131;150;152;129;166;129 17:33:41 INFO - 2015-12-15 17:33:41,579 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;161;162;161;168;163;160;161 17:33:41 INFO - 2015-12-15 17:33:41,579 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;89;90;72;78;73;111;89;77 17:33:41 INFO - 2015-12-15 17:33:41,579 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;94;129;95;96;95;134;95;95;128 17:33:41 INFO - 2015-12-15 17:33:41,579 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;110;110;110;109;109 17:33:41 INFO - 2015-12-15 17:33:41,580 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;146;146;146;146;147;147 17:33:41 INFO - 2015-12-15 17:33:41,580 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;96;95;95;95;96;97;95 17:33:41 INFO - 2015-12-15 17:33:41,580 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;69;69;72;69;69;71;79;70;69 17:33:41 INFO - 2015-12-15 17:33:41,580 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;70;68;69;68;69;69 17:33:41 INFO - 2015-12-15 17:33:41,580 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;92;82;83;85;82;84;84;83;85 17:33:41 INFO - 2015-12-15 17:33:41,580 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;127;125;119;127;126;137;126;123;121 17:33:41 INFO - 2015-12-15 17:33:41,580 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;148;147;149;155;138;150;149;143;134 17:33:41 INFO - 2015-12-15 17:33:41,581 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;69;70;68;71;69;71;70;67 17:33:41 INFO - 2015-12-15 17:33:41,581 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:33:41 INFO - 2015-12-15 17:33:41,581 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:33:41 INFO - 2015-12-15 17:33:41,581 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1010 17:33:41 INFO - 2015-12-15 17:33:41,581 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:33:41 INFO - 2015-12-15 17:33:41,581 DEBUG : BROWSER_OUTPUT: __startTimestamp1450229621577__endTimestamp 17:33:41 INFO - 2015-12-15 17:33:41,581 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,585 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:33:41 INFO - 2015-12-15 17:33:41,585 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:33:41 INFO - 2015-12-15 17:33:41,585 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,585 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.88 (2.6%) stddev-sans-first:3.06 17:33:41 INFO - 2015-12-15 17:33:41,585 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 109.0 113.0 113.0 114.0 105.0 112.0 115.0 113.0 17:33:41 INFO - 2015-12-15 17:33:41,585 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,585 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.50 Median:152.00 stddev:14.49 (9.5%) stddev-sans-first:15.04 17:33:41 INFO - 2015-12-15 17:33:41,585 DEBUG : BROWSER_OUTPUT: Values: 155.0 135.0 152.0 166.0 131.0 150.0 152.0 129.0 166.0 129.0 17:33:41 INFO - 2015-12-15 17:33:41,585 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,585 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.00 Median:161.50 stddev:2.26 (1.4%) stddev-sans-first:2.40 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 161.0 162.0 161.0 168.0 163.0 160.0 161.0 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:82.60 Median:77.50 stddev:12.32 (15.9%) stddev-sans-first:12.67 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 89.0 90.0 72.0 78.0 73.0 111.0 89.0 77.0 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:95.00 stddev:17.08 (18.0%) stddev-sans-first:17.75 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: Values: 96.0 94.0 129.0 95.0 96.0 95.0 134.0 95.0 95.0 128.0 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 109.0 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,586 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 97.0 95.0 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.00 Median:70.50 stddev:3.16 (4.5%) stddev-sans-first:3.27 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: Values: 73.0 69.0 69.0 72.0 69.0 69.0 71.0 79.0 70.0 69.0 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 70.0 68.0 69.0 68.0 69.0 69.0 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:2.97 (3.5%) stddev-sans-first:3.05 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: Values: 82.0 92.0 82.0 83.0 85.0 82.0 84.0 84.0 83.0 85.0 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.80 Median:126.00 stddev:5.51 (4.4%) stddev-sans-first:5.07 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: Values: 117.0 127.0 125.0 119.0 127.0 126.0 137.0 126.0 123.0 121.0 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:148.50 stddev:6.87 (4.6%) stddev-sans-first:6.49 17:33:41 INFO - 2015-12-15 17:33:41,587 DEBUG : BROWSER_OUTPUT: Values: 136.0 148.0 147.0 149.0 155.0 138.0 150.0 149.0 143.0 134.0 17:33:41 INFO - 2015-12-15 17:33:41,588 DEBUG : BROWSER_OUTPUT: 17:33:41 INFO - 2015-12-15 17:33:41,588 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.25 (1.8%) stddev-sans-first:1.32 17:33:41 INFO - 2015-12-15 17:33:41,588 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 70.0 68.0 71.0 69.0 71.0 70.0 67.0 17:33:41 INFO - 2015-12-15 17:33:41,588 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:33:41 INFO - 2015-12-15 17:33:41,588 DEBUG : BROWSER_OUTPUT: 17:33:42 INFO - 2015-12-15 17:33:42,475 INFO : Browser exited with error code: 0 17:33:42 INFO - 2015-12-15 17:33:42,524 INFO : Completed test kraken (00:01:00) 17:33:42 INFO - 2015-12-15 17:33:42,524 INFO : Starting test v8_7 17:33:42 INFO - 2015-12-15 17:33:42,524 DEBUG : operating with platform_type : linux_ 17:33:42 INFO - 2015-12-15 17:33:42,524 INFO : Initialising browser for v8_7 test... 17:33:42 INFO - 2015-12-15 17:33:42,530 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4m1MFl/profile http://localhost:53882/getInfo.html 17:33:46 INFO - 2015-12-15 17:33:46,552 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:33:46 INFO - 2015-12-15 17:33:46,552 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:33:46 INFO - 2015-12-15 17:33:46,553 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:33:46 INFO - 2015-12-15 17:33:46,553 DEBUG : BROWSER_OUTPUT: __metrics 17:33:46 INFO - 2015-12-15 17:33:46,613 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:33:46 INFO - 2015-12-15 17:33:46,674 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] 17:33:47 INFO - 2015-12-15 17:33:47,501 INFO : Browser initialized. 17:33:47 INFO - 2015-12-15 17:33:47,501 INFO : Running cycle 1/1 for v8_7 test... 17:33:47 INFO - 2015-12-15 17:33:47,501 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4m1MFl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:33:59 INFO - 2015-12-15 17:33:59,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 142598144 17:33:59 INFO - 2015-12-15 17:33:59,460 DEBUG : BROWSER_OUTPUT: 17:34:20 INFO - 2015-12-15 17:34:20,879 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:53882/tests/v8_7/run.html (next: http://localhost:53882/tests/v8_7/run.html) 17:34:21 INFO - 2015-12-15 17:34:21,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 443514880 17:34:21 INFO - 2015-12-15 17:34:21,137 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,137 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:34:21 INFO - 2015-12-15 17:34:21,137 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:34:21 INFO - 2015-12-15 17:34:21,137 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:34:21 INFO - 2015-12-15 17:34:21,138 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:34:21 INFO - 2015-12-15 17:34:21,138 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 17:34:21 INFO - 2015-12-15 17:34:21,138 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.9508319312021 17:34:21 INFO - 2015-12-15 17:34:21,138 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.55153203342616 17:34:21 INFO - 2015-12-15 17:34:21,138 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 17:34:21 INFO - 2015-12-15 17:34:21,138 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2010.0401606425703 17:34:21 INFO - 2015-12-15 17:34:21,138 DEBUG : BROWSER_OUTPUT: |5;Earley;788.0220646178093 17:34:21 INFO - 2015-12-15 17:34:21,138 DEBUG : BROWSER_OUTPUT: |6;Boyer;12432.098765432098 17:34:21 INFO - 2015-12-15 17:34:21,139 DEBUG : BROWSER_OUTPUT: |7;RegExp;27297.297297297297 17:34:21 INFO - 2015-12-15 17:34:21,139 DEBUG : BROWSER_OUTPUT: |8;Splay;602.7727546714889 17:34:21 INFO - 2015-12-15 17:34:21,139 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 17:34:21 INFO - 2015-12-15 17:34:21,139 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:34:21 INFO - 2015-12-15 17:34:21,139 DEBUG : BROWSER_OUTPUT: __startTimestamp1450229661131__endTimestamp 17:34:21 INFO - 2015-12-15 17:34:21,139 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,139 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:34:21 INFO - 2015-12-15 17:34:21,139 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:34:21 INFO - 2015-12-15 17:34:21,140 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,140 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 17:34:21 INFO - 2015-12-15 17:34:21,140 DEBUG : BROWSER_OUTPUT: Values: 165.8 17:34:21 INFO - 2015-12-15 17:34:21,140 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,140 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.95 Median:186.95 stddev:0.00 (0.0%) 17:34:21 INFO - 2015-12-15 17:34:21,140 DEBUG : BROWSER_OUTPUT: Values: 187.0 17:34:21 INFO - 2015-12-15 17:34:21,140 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,141 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 17:34:21 INFO - 2015-12-15 17:34:21,141 DEBUG : BROWSER_OUTPUT: Values: 278.6 17:34:21 INFO - 2015-12-15 17:34:21,141 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,141 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 17:34:21 INFO - 2015-12-15 17:34:21,141 DEBUG : BROWSER_OUTPUT: Values: 5133.3 17:34:21 INFO - 2015-12-15 17:34:21,141 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,141 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2010.04 Median:2010.04 stddev:0.00 (0.0%) 17:34:21 INFO - 2015-12-15 17:34:21,141 DEBUG : BROWSER_OUTPUT: Values: 2010.0 17:34:21 INFO - 2015-12-15 17:34:21,142 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,142 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:788.02 Median:788.02 stddev:0.00 (0.0%) 17:34:21 INFO - 2015-12-15 17:34:21,142 DEBUG : BROWSER_OUTPUT: Values: 788.0 17:34:21 INFO - 2015-12-15 17:34:21,142 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,142 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12432.10 Median:12432.10 stddev:0.00 (0.0%) 17:34:21 INFO - 2015-12-15 17:34:21,142 DEBUG : BROWSER_OUTPUT: Values: 12432.1 17:34:21 INFO - 2015-12-15 17:34:21,142 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,142 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27297.30 Median:27297.30 stddev:0.00 (0.0%) 17:34:21 INFO - 2015-12-15 17:34:21,143 DEBUG : BROWSER_OUTPUT: Values: 27297.3 17:34:21 INFO - 2015-12-15 17:34:21,143 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,143 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.77 Median:602.77 stddev:0.00 (0.0%) 17:34:21 INFO - 2015-12-15 17:34:21,143 DEBUG : BROWSER_OUTPUT: Values: 602.8 17:34:21 INFO - 2015-12-15 17:34:21,143 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,143 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:34:21 INFO - 2015-12-15 17:34:21,143 DEBUG : BROWSER_OUTPUT: Values: 4845.4 17:34:21 INFO - 2015-12-15 17:34:21,144 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:34:21 INFO - 2015-12-15 17:34:21,144 DEBUG : BROWSER_OUTPUT: 17:34:21 INFO - 2015-12-15 17:34:21,995 INFO : Browser exited with error code: 0 17:34:22 INFO - 2015-12-15 17:34:22,012 INFO : Completed test v8_7 (00:00:39) 17:34:22 INFO - 2015-12-15 17:34:22,149 INFO : Completed test suite (00:20:17) 17:34:22 INFO - 2015-12-15 17:34:22,149 DEBUG : Working with test: dromaeo_css 17:34:22 INFO - 2015-12-15 17:34:22,149 DEBUG : Generating results file: dromaeo_css 17:34:22 INFO - 2015-12-15 17:34:22,150 DEBUG : Working with test: kraken 17:34:22 INFO - 2015-12-15 17:34:22,150 DEBUG : Generating results file: kraken 17:34:22 INFO - 2015-12-15 17:34:22,150 INFO : javascript benchmark 17:34:22 INFO - 2015-12-15 17:34:22,151 DEBUG : Working with test: v8_7 17:34:22 INFO - 2015-12-15 17:34:22,151 DEBUG : Generating results file: v8_7 17:34:22 INFO - 2015-12-15 17:34:22,151 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:34:22 INFO - 2015-12-15 17:34:22,202 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 17:34:22 INFO - 2015-12-15 17:34:22,202 DEBUG : process_Request line: dromaeo_css 6279.97 graph.html#tests=[[72,132,35]] 17:34:22 INFO - 2015-12-15 17:34:22,202 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:34:22 INFO - 2015-12-15 17:34:22,233 DEBUG : process_Request line: kraken 1523.10 graph.html#tests=[[232,132,35]] 17:34:22 INFO - 2015-12-15 17:34:22,233 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:34:22 INFO - 2015-12-15 17:34:22,261 DEBUG : process_Request line: v8_7 19733.58 graph.html#tests=[[230,132,35]] 17:34:22 INFO - 2015-12-15 17:34:22,263 INFO : javascript benchmark 17:34:22 INFO - 2015-12-15 17:34:22,266 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2634.538955682756, 2729.0175536806746, 2732.016474069336, 2739.8082134250612, 2758.6000029995657, 4494.842680506183, 4609.723416595007, 4692.436907571092, 4760.857174284768, 4776.522347765226, 4622.260438329868, 4707.411573553306, 4713.410823647044, 4747.667663263573, 4861.9513804861945, 4327.870163895072, 4370.650347972162, 4403.6256918161835, 4440.0, 4491.326301054835, 4398.472183337988, 4435.401220835178, 4468.4414448193975, 4470.977645111786, 4501.189785838547, 4189.958100419002, 4220.6412454941365, 4290.377895205209, 4295.334223195409, 4327.004788898539, 4380.759058251795, 4384.758838263894, 4385.101054283864, 4418.0, 4433.401490798733, 4362.978185109086, 4374.387585737999, 4375.1031038637, 4385.342198670193, 4393.384926110347, 4455.688101832873, 4580.427446569179, 4598.770061496945, 4631.953680463186, 4732.479427262998, 5089.694618322913, 5096.643234973553, 5101.642884998052, 5102.540771330598, 5144.048351055029, 5082.669626474304, 5094.235864620299, 5102.464241254689, 5106.336176297094, 5113.054084994288, 4543.068670922453, 4621.6764826462495, 4658.254679251304, 4664.603508701798, 4779.832705855279, 5237.921431178535, 5280.9207861882105, 5283.07546179417, 5288.576913846883, 5292.179712144623, 5055.721935293521, 5070.847874563769, 5080.77136528857, 5085.059264036166, 5123.0522353364, 4810.8797280068275, 4938.753062346868, 4938.851834444972, 4942.678725882806, 5034.8237811677145, 5087.567556757643, 5095.235714642759, 5123.129068058439, 5131.61512886535, 5135.024345374367, 5053.69677819332, 5065.772040258197, 5066.645334826527, 5071.442141364447, 5111.616628752859, 4045.1707399982934, 4211.494620645542, 4234.132002939452, 4243.427137336482, 4303.289957157097, 3655.5796083450746, 3672.8530858765885, 3704.4258139988347, 3720.4977328060363, 3748.9128152835374, 4377.080813029236, 4402.207602631493, 4403.801828917706, 4414.161309351213, 4453.042595841845, 4894.0, 5133.512316329943, 5138.820141295037, 5145.048166089286, 5153.665011774223, 4307.1601037797955, 4318.244307246219, 4336.457942757155, 4378.956210437918, 4403.647708183337, 4472.843450479283, 4521.186186486464, 4533.478649955231, 4533.9319910201375, 4553.385292985471, 4633.443986721615, 4848.0546293472435, 4855.247436647325, 4857.392825896763, 4875.658703890694, 5015.3730783652045, 5041.168207245763, 5055.87360315995, 5094.490550944876, 5125.128728116304, 4839.0, 4851.102546028996, 4854.708717476963, 4859.785128499197, 4903.632227582874, 5069.822556210515, 5075.593952483866, 5081.034603425337, 5087.949120508748, 5119.820806271762, 4870.1233777920315, 4964.106460837084, 5003.499650034967, 5013.047520971004, 5138.152204886152, 4917.1149193145575, 4963.975180124076, 4970.428400733962, 4977.477364876636, 4986.127427700066, 4938.111139994836, 4938.209886418156, 4953.578945789648, 4958.504149585013, 4961.330220420197, 4637.536246375335, 4712.246040633482, 4724.527547245386, 4728.31439441286, 4914.213725803854, 4922.532359425849, 4948.975255123702, 4973.477784832685, 4974.701517908937, 4978.377702787152, 4856.145515300394, 4867.951320486892, 4869.269609558452, 4870.09903167915, 4908.239222920453], "unit": "score", "name": "dojo.html", "value": 4652.760529462578}, {"lowerIsBetter": false, "replicates": [570.7317560746449, 573.8536673148346, 576.9826905192846, 584.8625572990344, 589.1663296435544, 27540.173794786162, 27924.3018924527, 27942.86028569854, 27947.720522794767, 27981.160565183076, 28100.859495702545, 28677.13968580941, 36370.454443183306, 37251.441228381525, 37307.813460932724, 7844.8038799030055, 7985.281324680777, 7990.560519171472, 7996.960015199945, 7998.32014278787, 7822.882656760153, 7935.087464941519, 7937.642806073712, 7939.761807145795, 7940.086890007637, 7274.381677557414, 7472.925270747304, 10148.847767283496, 10411.583536658525, 10418.426986515738, 9868.753281167992, 9997.950010249975, 10007.249456290807, 10015.048570385801, 10026.749331266703, 7244.094488188976, 7441.813954651123, 9613.51932403377, 9720.125188733047, 9750.46372449515, 39534.80232598819, 41096.0, 41148.38277425841, 41161.588384116076, 41196.79401603003, 3052.282713562311, 3114.4549703801745, 3497.5453191085, 3557.48416479609, 3683.1344634010984, 27938.860305698545, 28077.438451231064, 28145.155645330673, 28390.29024274389, 28810.711892881012, 3143.167060728909, 3144.701253380925, 3147.59081319427, 3154.463741164008, 3183.6657150999276, 215671.0, 217268.0, 217444.0, 217615.0, 217764.0, 53479.0, 53862.7306863471, 53871.19193212105, 53899.19151212735, 53977.46022539724, 57432.71283643555, 57654.0, 57657.0, 57679.423205768246, 57708.13437798437, 14024.509142179975, 14341.067830590979, 14341.211233382055, 14350.354234059283, 14350.923680723987, 11384.43077846121, 11419.200655954004, 11438.656840294805, 11445.084393248686, 11447.713807154722, 18185.7272140918, 18457.261709531467, 18563.16465759044, 18631.347902823607, 18668.719969200472, 7054.294570542905, 7259.07634476864, 7262.891056634155, 7324.08448943882, 7466.664000120008, 870.7344260000634, 873.6418068591847, 907.491804589432, 1022.6983040003217, 1080.5461706083306, 26301.47397052048, 26644.678195756558, 26882.32794180122, 26891.86554067217, 26954.191374258804, 855.3157474020759, 926.7868241143567, 942.6088173408097, 959.8800149981253, 984.1585444444896, 12757.298348590917, 13147.95435291784, 13203.73592528144, 13342.53301134475, 13376.866231337563, 254230.0, 258130.0, 259150.0, 259513.0, 259627.0, 37487.0, 38358.6164138355, 43521.0, 44584.10831783346, 44676.55323446789, 1155.7052951497483, 1157.65270418874, 1203.3802591665299, 1217.6955761059735, 1221.6396163131897, 22300.888495557418, 24658.260252192464, 25593.488130236918, 26190.73809261959, 26567.867160664846, 36372.27255454823, 36876.446853297755, 36885.26229475449, 36907.6309236915, 36924.815375922946, 156471.0, 156998.0, 157493.0, 157702.0, 158637.0, 25070.0, 25284.115055972954, 25357.239282821545, 25358.366040849127, 25369.365765856, 32034.839825800722, 33740.83129584337, 36267.27465450729, 37490.81254593709, 38882.80558597302, 31275.0, 32196.517052244704, 32550.186245344055, 32629.18427039343, 32746.0, 31806.84096579502, 33197.17007074843, 33642.158946026546, 33668.0, 33912.66087339095, 31256.37487250197, 32474.35051299008, 32677.18307042343, 32683.18292042623, 32732.181695457803, 27495.175144745688, 29707.405851883275, 30121.397572047998, 30893.69106308908, 31717.0, 23043.423914402276, 23766.643500347855, 23951.76048239495, 24036.87981560081, 24932.753362332172], "unit": "score", "name": "ext.html", "value": 16485.17233389534}, {"lowerIsBetter": false, "replicates": [331.7263257812304, 332.66733266733274, 332.82360349015033, 337.0780914199662, 337.82433134769923, 12708.301043442607, 13109.868901310983, 15086.3211155498, 15494.84505154948, 15939.203039848018, 9716.514174291293, 9987.950060249688, 10081.69754907352, 14588.489402870902, 14623.415063397451, 4447.621952134073, 4556.612687921514, 4561.29299958507, 4563.041761230145, 4564.383808185886, 3374.105861946586, 3492.807895565743, 4865.245886887538, 5028.547430731233, 5197.480251974791, 5187.19598462239, 5224.320838291017, 5228.058949389108, 5239.397469291023, 5264.026155161288, 5090.821821236257, 5251.448597897204, 5272.99813035522, 5297.258383826267, 5310.20346947957, 5111.846644600668, 5113.130767769489, 5113.897722045575, 5116.360454943132, 5116.692998420107, 12636.49454021838, 18683.813161868344, 19004.904975475172, 19024.334148304744, 19779.10994005273, 1838.9356372526897, 1863.1988245054622, 1877.6150889067708, 1885.4437940807495, 1896.6111947050822, 8796.384253102286, 9141.45151290918, 10293.639722609747, 12529.561465348668, 12846.935765321114, 1738.391562952969, 1756.2623698046723, 1757.1477833250863, 1779.599590092232, 1797.2092279397023, 47970.28044579299, 53348.73325633386, 55956.0, 57123.71438142824, 57449.7127514364, 9149.81700365989, 9358.485283309346, 9444.763880903032, 9465.47939863314, 9536.332456727963, 11805.763884722257, 11805.76388472243, 11819.468123934443, 11841.23032002917, 11841.467133978991, 6915.239323674392, 6989.0564773755905, 7060.7881763547175, 7110.822229444305, 7182.784516464514, 6935.370188005814, 6999.530098679233, 7149.857002859913, 7203.747868824566, 7238.384737297283, 4115.1975364804175, 4167.041580436517, 4168.958310416918, 4195.244855925963, 4199.4120823084795, 1604.4945842059715, 1640.270079814471, 1647.8846480746233, 1653.189936930895, 1679.3534489221493, 788.5899332347262, 818.3739439328918, 828.8881001064779, 832.8500869843365, 933.9866245124116, 13344.399502022432, 15317.693646127238, 15948.122853243183, 16036.198190090448, 16133.838661613469, 816.6570040582969, 832.2260297922869, 870.0951010948669, 873.4060838629792, 915.7756349694367, 8654.567271636393, 8835.955820220857, 8959.641614335354, 9284.303677224236, 9503.809923801486, 467967.0, 469429.0, 471412.0, 481276.0, 488103.0, 66769.66615166893, 69425.65287173532, 70628.0, 70829.64585177042, 71217.0, 1095.0637205189448, 1095.7205912492263, 1105.2760441910561, 1121.0247085035908, 1121.3496172220093, 14860.925695371454, 14954.252287385805, 15095.849041509444, 15140.772888406904, 15420.537383878502, 30313.848430757706, 30553.083407497812, 31769.20576985594, 31925.840370797996, 33761.83119084389, 36140.45789313215, 40249.798751006056, 40498.0, 41230.79384603058, 42209.57790422179, 8033.517988920684, 8303.584820759059, 8347.165283471604, 8362.247397734232, 8362.958185209034, 9610.087041731025, 11888.702782430162, 16371.263293151598, 16500.587485312964, 16548.586285342964, 13312.534061307808, 13537.33610489268, 13787.103838250481, 13854.376553054935, 14045.789313160107, 12681.492740290654, 12814.55149069778, 13609.79585306241, 13877.167369957835, 13888.791668125188, 10706.0, 11148.331100134017, 13298.401571929093, 13365.599032029055, 13965.930170349084, 8523.786905327417, 8568.871466927876, 8607.65569377218, 8725.0, 8728.78178045554, 8934.424191182112, 13356.532521361705, 13393.531226407029, 13746.65633359174, 13840.100393474391], "unit": "score", "name": "jquery.html", "value": 8067.092422154683}, {"lowerIsBetter": false, "replicates": [1456.8470310617392, 1678.756580295857, 1736.1839935230446, 1744.4243399678107, 1758.3933542927693, 5820.796272130471, 6791.11715476988, 7004.054452648891, 7033.8593228135405, 7047.04864843246, 7056.894146587805, 7200.24397438268, 7233.385162261201, 7243.565386076839, 7257.673404696789, 1748.1346733367002, 1769.1596491666419, 1997.6803711406178, 2025.1696804310236, 2048.774634790172, 2069.9172033118657, 2070.420282320945, 2071.554615757612, 2076.09689784944, 2076.885771282579, 2012.1750082466192, 2017.959640807183, 2046.8567200295986, 2051.569170474202, 2053.0863765624304, 2031.8476114291486, 2043.4074118505616, 2055.8869262190574, 2056.578401427711, 2091.0, 2046.887421191834, 2070.6272870883236, 2074.3051077888927, 2074.543600407908, 2075.335892514396, 7290.854182916312, 7362.963185184093, 7377.114746230487, 7385.704571817121, 7389.039424874785, 4221.767802770877, 4307.375430562583, 4314.0, 4326.156399502099, 4326.524082350938, 2663.8268512546624, 2745.2999485131363, 2756.2695885590333, 2759.599858020596, 2776.4447110577967, 799.0770659887838, 805.0, 819.7335865843565, 825.2820046559472, 834.0491839303199, 9681.273904457194, 9766.169875560587, 9782.853257201077, 9796.608135674565, 9811.313208075437, 3856.9421458678144, 3944.7633142011573, 3960.584138665456, 3967.3850553164307, 3974.841006359771, 8451.746447606582, 8452.535110568855, 8473.915260847436, 8479.448835825651, 8497.277731392776, 4266.466691663542, 4268.423762791983, 4282.336237883133, 4286.978565107217, 4289.356596510548, 3891.1633998690418, 3909.6481316681634, 3910.335243008695, 3913.5890731472787, 3917.118648304109, 2872.4973129702216, 2905.956410653842, 3260.543523906655, 3349.949750753741, 3387.271736576648, 1063.851060851466, 1081.7025318037445, 1084.0947808579767, 1086.4296244471716, 1088.434014312553, 928.331601247101, 932.3613324872484, 994.5822754443151, 1196.7307355844866, 1196.8503937007874, 6720.260771315151, 6727.091842601284, 6769.559978601375, 6795.966020169867, 6799.592024478448, 1039.870016247969, 1042.9843552346722, 1045.2474218562622, 1046.534292239946, 1069.2408390043156, 5365.034293827149, 5429.592780541475, 5436.728163591804, 5444.128939369682, 5444.455554444524, 8627.266682332072, 8730.91269087301, 8779.604917778588, 8866.689665861664, 8940.73177804667, 8586.356023298153, 8647.913520864711, 8681.956590217009, 8714.433561818461, 8725.083866194085, 6814.454843612499, 6829.658517074126, 6904.0, 6905.723771049203, 6927.653617319113, 6605.504587156079, 6614.702338394687, 6615.900761488678, 6643.734250629921, 6645.534812563074, 7643.923560764543, 7777.72777952769, 7800.1419843816, 7814.062312522534, 7881.133075361591, 7771.533707977539, 8007.279344858991, 8160.877586836321, 8165.755027349189, 8239.464434811718, 6447.516436267392, 6476.676166191766, 6477.1579694639395, 6490.740370385321, 6506.056621789719, 6140.293866205265, 6460.418562329413, 6465.353464653497, 6510.153680021567, 6517.022446633043, 6549.770758023446, 6562.278149403466, 6641.169853768279, 6648.235452922782, 6706.228783689743, 6369.299377068426, 6386.521010924293, 6427.325130861379, 6482.384173503509, 6523.18460192476, 6617.205935287796, 6682.532222744361, 6690.698918548775, 6699.564528305645, 6699.698513566998, 6004.639721616717, 6044.879102418015, 6060.212172417558, 6063.454289114001, 6076.848078797889, 6170.290416602148, 6285.308616052322, 6293.874122517615, 6301.464375528131, 6303.338149494237], "unit": "score", "name": "mootools.html", "value": 4127.490891306024}, {"lowerIsBetter": false, "replicates": [293.496653239694, 296.830806440329, 305.43646971337887, 305.4959317126742, 307.2334525359229, 5243.0824605694, 5255.106631872576, 5289.629725919182, 5394.487523685253, 5452.0, 5242.947570524294, 5323.627346085776, 5339.5728341732665, 5349.144136938091, 5351.25082488452, 3907.960920390788, 4135.648469880064, 4146.523149837762, 4152.68854835887, 4158.500979882411, 3995.900102497432, 3998.820053097618, 4073.368627862671, 4112.753234805921, 4118.794060296988, 4056.127932494513, 4059.5331536873196, 4066.715329926906, 4067.1662309226685, 4070.409790580364, 3842.5581058178386, 3884.3202439573242, 3946.3291240489184, 4064.0652649890544, 4071.124708187739, 3540.0087975366937, 3540.805255710935, 3544.7518673692853, 3548.0952357148763, 3560.412531932228, 5098.337216161913, 5103.821366252163, 5114.207297868837, 5115.565176959963, 5126.102931986888, 4619.237825758746, 4655.138799322136, 4666.2767271073035, 4672.229082201433, 4673.6027437667835, 5398.4871437213405, 5515.393306736256, 5545.584081193927, 5557.749901254453, 5558.527525160326, 3850.5764365919727, 3851.84592616295, 3853.6917046636204, 3854.5759966403675, 3854.9421758673643, 5763.0, 5845.941540584582, 5848.093545500455, 5850.912236316459, 5856.209411729405, 3973.106051138471, 3982.0443093657314, 3985.5815139409942, 3985.6811455083525, 3986.661133803659, 3720.2001569662652, 3757.5866654667966, 4028.738132021409, 4030.314846476106, 4032.717709760347, 4495.145922274757, 4538.818447262072, 4548.499665036843, 4563.224251877123, 4639.37368455261, 5542.113261878161, 5553.861153471114, 5554.583406244547, 5556.277683901148, 5556.416576259516, 1391.2626308056747, 1420.843707192208, 1421.7440860644977, 1421.978670319946, 1423.0607798852707, 931.8881734191805, 932.072587775168, 944.622151139536, 954.289054654287, 959.1080295325274, 4873.098476781735, 4883.877903052381, 4883.902321953541, 4888.462269150391, 4894.461609222983, 5782.132680098019, 5789.8263052108505, 5791.739371728282, 5794.913076303858, 5796.101604251347, 4877.244027175793, 4877.658563900563, 4888.242322440027, 4890.24201248807, 4892.804287828447, 3036.1954082168245, 3087.07387783664, 3119.064280715776, 3120.2979329651102, 3121.32891428344, 5534.252875861707, 5541.695206763667, 5543.029969755357, 5543.057680194296, 5543.556515478752, 5992.730327135289, 5993.400659934059, 5994.430529099815, 6001.0, 6002.6098303611, 5520.365158006881, 5532.972335138379, 5533.087040638249, 5535.169724541351, 5536.501714845684, 5655.717214139194, 5830.591858569859, 5833.883322333614, 5837.795677151279, 5840.8247752567495, 5678.488935995781, 5686.800961966312, 5689.089745640843, 5693.686847223276, 5703.058995265735, 5499.477549632778, 5511.145772405283, 5517.69652669107, 5519.2824932758485, 5520.66875987442, 3923.1957448723515, 3928.704973202044, 3954.3277642800217, 4011.7793521356607, 4012.578679238755, 5564.415736347625, 5738.139279108167, 5836.678982655994, 5849.151872978479, 5854.619449735754, 5444.646098003617, 5579.163125531203, 5599.692016939108, 5604.411536788579, 5608.635438696635, 5556.777728890799, 5569.610127291213, 5573.665580065209, 5575.804846830341, 5583.134614134816, 5351.464853514617, 5468.4531546845, 5483.2323474712775, 5483.506484416422, 5483.561315094863, 5630.127330263816, 5630.718464076698, 5640.0, 5642.294713160855, 5644.181593668977, 5496.477834605706, 5497.725113744217, 5504.614676972574, 5504.862378440571, 5512.0], "unit": "score", "name": "prototype.html", "value": 4173.705227953237}, {"lowerIsBetter": false, "replicates": [692.6744430117849, 703.9401650859677, 703.9753608623696, 750.5646724899559, 788.4756636836504, 12138.089643276757, 12330.44512996915, 12362.381880905963, 12391.566295179658, 12447.190932589387, 11201.271917325388, 11393.715157121076, 11402.372869492174, 11435.599754008612, 11459.968602825744, 597.7847974729104, 613.9140520327157, 781.4646966827742, 784.1922819495928, 787.2363807107125, 785.0775338976708, 796.0725754496005, 797.5533701127388, 797.6570074867805, 800.8238187598748, 825.1088824070019, 831.3432388413146, 834.4325858416274, 834.5326617094447, 835.2107258640588, 830.6967956695762, 832.0556168748484, 832.8292699996516, 834.6035633074272, 834.7954751086023, 619.9349068347803, 622.1103821535203, 622.2532960447436, 622.3682961793783, 622.5206590924962, 10906.127509799197, 10936.781264374747, 10970.835437468444, 10983.011528962352, 11024.559017639285, 9685.612575496973, 10323.79352412955, 11332.886671133265, 11435.656930292105, 11688.47401866918, 9491.19324857388, 9572.952135239279, 9631.373960692603, 9654.0, 9692.854607180827, 3308.17295676081, 3316.154380632923, 3341.465365541502, 3353.9161520961925, 3375.0718552398043, 35549.0, 35715.28569428623, 39693.20613587741, 43783.34324985128, 44463.55536444659, 9625.133737963617, 9688.176504997013, 9720.465374404475, 9971.102600765966, 9972.202223822076, 16254.51236462908, 16382.0, 16426.42507512231, 16465.588360291087, 16495.175241237892, 6389.648569328731, 6410.67946602668, 6508.707108180143, 6628.767993120314, 6727.966360168266, 3476.2004738909686, 3497.45789402643, 3659.0852286928266, 3665.065408320861, 3697.242065376591, 2370.585147599163, 2396.317049640879, 2396.6405039244255, 2404.9038038478616, 2404.9158279460135, 484.6655807492889, 487.16694452486644, 489.5716248282753, 490.04441339388336, 491.9631027672867, 578.5631847954851, 607.1287702147432, 619.4394073363613, 642.7455550871606, 646.5377255262509, 8027.237412445808, 8863.468191908507, 9005.414648047987, 9057.18485336323, 9309.44143351401, 494.63397086156704, 624.0747294596222, 637.0348921384107, 647.2912161183497, 669.5079116849112, 3558.5729712434154, 3622.1125824173246, 3840.5967373425947, 3863.439801228806, 3929.292727309112, 44912.326315105296, 46475.5352446478, 47845.76077119592, 47914.281285780744, 48089.75955120272, 41415.378769318486, 41542.79228603838, 41711.0, 41876.162476750906, 42917.35623965643, 33621.0, 36811.81594092066, 40143.598564014574, 42321.57678423238, 42333.788331058764, 7946.0, 8164.306033987177, 8502.659893604186, 8816.013205126817, 8957.59690813928, 31849.203769905936, 32036.35927281488, 32351.19122021874, 32401.0, 33321.66678333186, 37854.0, 38155.2368952625, 38312.616873830906, 38595.0, 39209.41185882157, 10008.699739007841, 10032.247581431568, 10163.7459063524, 10233.181345492492, 10377.429241391494, 11218.046466050477, 11219.382933938385, 11317.207795454238, 12077.154599177973, 12080.45637946277, 11039.116870650489, 11132.332060076422, 11144.33134011962, 11593.362365070003, 11604.245724027911, 10630.84053739179, 10688.786224275316, 11007.174461915229, 11415.828762568402, 11429.714257143305, 10055.346402483816, 10137.138343240907, 10202.642907498202, 10213.897861021294, 10634.41510716918, 9018.729438116867, 9422.62309507612, 9494.620215191315, 9563.187129094105, 9749.317547771589, 8606.741797746077, 9298.95350523243, 9300.209482193819, 9320.300977426585, 9358.578863951003], "unit": "score", "name": "yui.html", "value": 5754.020765512571}], "name": "dromaeo_css", "value": 6279.966285023435}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 109.0, 113.0, 113.0, 114.0, 105.0, 112.0, 115.0, 113.0], "unit": "score", "name": "ai-astar", "value": 111.9}, {"lowerIsBetter": true, "replicates": [155.0, 135.0, 152.0, 166.0, 131.0, 150.0, 152.0, 129.0, 166.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 161.0, 162.0, 161.0, 168.0, 163.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 89.0, 90.0, 72.0, 78.0, 73.0, 111.0, 89.0, 77.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [96.0, 94.0, 129.0, 95.0, 96.0, 95.0, 134.0, 95.0, 95.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 97.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [73.0, 69.0, 69.0, 72.0, 69.0, 69.0, 71.0, 79.0, 70.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 70.0, 68.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [82.0, 92.0, 82.0, 83.0, 85.0, 82.0, 84.0, 84.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [117.0, 127.0, 125.0, 119.0, 127.0, 126.0, 137.0, 126.0, 123.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.8}, {"lowerIsBetter": true, "replicates": [136.0, 148.0, 147.0, 149.0, 155.0, 138.0, 150.0, 149.0, 143.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 70.0, 68.0, 71.0, 69.0, 71.0, 70.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1523.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [186.9508319312021], "unit": "score", "name": "DeltaBlue", "value": 353.66518199999996}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2010.0401606425703], "unit": "score", "name": "RayTrace", "value": 368.1463756243757}, {"lowerIsBetter": false, "replicates": [788.0220646178093], "unit": "score", "name": "Earley", "value": 845.7415470000001}, {"lowerIsBetter": false, "replicates": [12432.098765432098], "unit": "score", "name": "Boyer", "value": 53.608245283018846}, {"lowerIsBetter": false, "replicates": [27297.297297297297], "unit": "score", "name": "RegExp", "value": 33.37271782178218}, {"lowerIsBetter": false, "replicates": [602.7727546714889], "unit": "score", "name": "Splay", "value": 135.19356900000005}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19733.575467333285}]} 17:34:22 INFO - RETURN: dromaeo_css: 6279.97 17:34:22 INFO - RETURN: kraken: 1523.10 17:34:22 INFO - RETURN: v8_7: 19733.58 17:34:22 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19733.58"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1523.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6279.97"}}} 17:34:22 INFO - Return code: 0 17:34:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:34:22 INFO - # TBPL SUCCESS # 17:34:22 INFO - Running post-action listener: _resource_record_post_action 17:34:22 INFO - Running post-run listener: _resource_record_post_run 17:34:23 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 0; Write bytes: 510013440; Read time: 0; Write time: 710080 17:34:23 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 231653376; Read time: 0; Write time: 453856 17:34:23 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 278360064; Read time: 0; Write time: 256224 17:34:23 INFO - Running post-run listener: _upload_blobber_files 17:34:23 INFO - Blob upload gear active. 17:34:23 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:34:23 INFO - Copying logs to upload dir... 17:34:23 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.198561 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-12-15 17:34:23.241975) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-15 17:34:23.245950) ========= 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=6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009268 build_url: 'https://queue.taskcluster.net/v1/task/c9ypxuGdTyC2RSTCzEa0Ow/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-15 17:34:23.298187) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:34:23.298582) ========= 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=6d5287d839824eebc594b0c9000001d1-1450228393.834036-55007579 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-15 17:34:23.348792) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 17:34:23.349176) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-15 17:34:23.349574) ========= ========= Total master_lag: 0.23 =========