builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1449859609.93 results: success (0) buildid: 20151211101232 builduid: ad92a65bda9f4ea1b0f129d096cef3fe revision: 30d3b887b4ec0e3536320b4dabd24627f73dfcd5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:49.929319) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:49.930123) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:49.930475) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006386 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:49.956701) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:49.957078) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:49.978051) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:49.978412) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004595 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:50.049496) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:50.049815) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:50.050255) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:50.050700) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 10:46:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2015-12-11 10:46:50 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153745 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:50.217459) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:50.217863) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015173 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:50.268660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-11 10:46:50.269082) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 30d3b887b4ec0e3536320b4dabd24627f73dfcd5 --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 30d3b887b4ec0e3536320b4dabd24627f73dfcd5 --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=9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 10:46:50,788 truncating revision to first 12 chars 2015-12-11 10:46:50,788 Setting DEBUG logging. 2015-12-11 10:46:50,788 attempt 1/10 2015-12-11 10:46:50,788 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/30d3b887b4ec?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 10:46:52,128 unpacking tar archive at: fx-team-30d3b887b4ec/testing/mozharness/ program finished with exit code 0 elapsedTime=1.648409 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-11 10:46:51.945170) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:51.945478) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:51.955367) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:51.955663) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 10:46:51.956075) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-11 10:46:51.956365) ========= /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=9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:46:52 INFO - MultiFileLogger online at 20151211 10:46:52 in /builds/slave/test 10:46:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:46:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:46:52 INFO - {'append_to_log': False, 10:46:52 INFO - 'base_work_dir': '/builds/slave/test', 10:46:52 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:46:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:46:52 INFO - 'branch': 'Fx-Team-Non-PGO', 10:46:52 INFO - 'buildbot_json_path': 'buildprops.json', 10:46:52 INFO - 'config_files': ('talos/linux_config.py',), 10:46:52 INFO - 'default_actions': ('clobber', 10:46:52 INFO - 'read-buildbot-config', 10:46:52 INFO - 'download-and-extract', 10:46:52 INFO - 'populate-webroot', 10:46:52 INFO - 'create-virtualenv', 10:46:52 INFO - 'install', 10:46:52 INFO - 'run-tests'), 10:46:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:46:52 INFO - 'download_minidump_stackwalk': True, 10:46:52 INFO - 'download_symbols': 'ondemand', 10:46:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:46:52 INFO - 'tooltool.py': '/tools/tooltool.py', 10:46:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:46:52 INFO - '/tools/misc-python/virtualenv.py')}, 10:46:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:46:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:46:52 INFO - 'installer_path': 'installer.exe', 10:46:52 INFO - 'log_level': 'info', 10:46:52 INFO - 'log_name': 'talos', 10:46:52 INFO - 'log_to_console': True, 10:46:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:46:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:46:52 INFO - 'opt_config_files': (), 10:46:52 INFO - 'pip_index': False, 10:46:52 INFO - 'sps_profile': False, 10:46:52 INFO - 'sps_profile_interval': 0, 10:46:52 INFO - 'suite': 'dromaeojs', 10:46:52 INFO - 'system_bits': '64', 10:46:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:46:52 INFO - 'title': 'talos-linux64-ix-036', 10:46:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:46:52 INFO - 'use_talos_json': True, 10:46:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:46:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:46:52 INFO - 'work_dir': 'build'} 10:46:52 INFO - ##### 10:46:52 INFO - ##### Running clobber step. 10:46:52 INFO - ##### 10:46:52 INFO - Running pre-action listener: _resource_record_pre_action 10:46:52 INFO - Running main action method: clobber 10:46:52 INFO - rmtree: /builds/slave/test/build 10:46:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:46:53 INFO - Running post-action listener: _resource_record_post_action 10:46:53 INFO - ##### 10:46:53 INFO - ##### Running read-buildbot-config step. 10:46:53 INFO - ##### 10:46:53 INFO - Running pre-action listener: _resource_record_pre_action 10:46:53 INFO - Running main action method: read_buildbot_config 10:46:53 INFO - Using buildbot properties: 10:46:53 INFO - { 10:46:53 INFO - "properties": { 10:46:53 INFO - "buildnumber": 2204, 10:46:53 INFO - "product": "firefox", 10:46:53 INFO - "script_repo_revision": "production", 10:46:53 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 10:46:53 INFO - "repository": "", 10:46:53 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 10:46:53 INFO - "buildid": "20151211101232", 10:46:53 INFO - "slavename": "talos-linux64-ix-036", 10:46:53 INFO - "pgo_build": "False", 10:46:53 INFO - "basedir": "/builds/slave/test", 10:46:53 INFO - "project": "", 10:46:53 INFO - "platform": "ubuntu64_hw", 10:46:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 10:46:53 INFO - "slavebuilddir": "test", 10:46:53 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:46:53 INFO - "branch": "fx-team", 10:46:53 INFO - "repo_path": "integration/fx-team", 10:46:53 INFO - "stage_platform": "linux64", 10:46:53 INFO - "builduid": "ad92a65bda9f4ea1b0f129d096cef3fe", 10:46:53 INFO - "revision": "30d3b887b4ec0e3536320b4dabd24627f73dfcd5" 10:46:53 INFO - }, 10:46:53 INFO - "sourcestamp": { 10:46:53 INFO - "repository": "", 10:46:53 INFO - "hasPatch": false, 10:46:53 INFO - "project": "", 10:46:53 INFO - "branch": "fx-team-linux64-talos", 10:46:53 INFO - "changes": [ 10:46:53 INFO - { 10:46:53 INFO - "category": null, 10:46:53 INFO - "files": [ 10:46:53 INFO - { 10:46:53 INFO - "url": null, 10:46:53 INFO - "name": "https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 10:46:53 INFO - } 10:46:53 INFO - ], 10:46:53 INFO - "repository": "", 10:46:53 INFO - "rev": "30d3b887b4ec0e3536320b4dabd24627f73dfcd5", 10:46:53 INFO - "who": "alessio.placitelli@gmail.com", 10:46:53 INFO - "when": 1449859583, 10:46:53 INFO - "number": 7353855, 10:46:53 INFO - "comments": "Bug 1230213 - test_TelemetryLog yields from a non generator function. r=dexter", 10:46:53 INFO - "project": "", 10:46:53 INFO - "at": "Fri 11 Dec 2015 10:46:23", 10:46:53 INFO - "branch": "fx-team-linux64-talos", 10:46:53 INFO - "revlink": "", 10:46:53 INFO - "properties": [ 10:46:53 INFO - [ 10:46:53 INFO - "buildid", 10:46:53 INFO - "20151211101232", 10:46:53 INFO - "Change" 10:46:53 INFO - ], 10:46:53 INFO - [ 10:46:53 INFO - "builduid", 10:46:53 INFO - "ad92a65bda9f4ea1b0f129d096cef3fe", 10:46:53 INFO - "Change" 10:46:53 INFO - ], 10:46:53 INFO - [ 10:46:53 INFO - "pgo_build", 10:46:53 INFO - "False", 10:46:53 INFO - "Change" 10:46:53 INFO - ] 10:46:53 INFO - ], 10:46:53 INFO - "revision": "30d3b887b4ec0e3536320b4dabd24627f73dfcd5" 10:46:53 INFO - } 10:46:53 INFO - ], 10:46:53 INFO - "revision": "30d3b887b4ec0e3536320b4dabd24627f73dfcd5" 10:46:53 INFO - } 10:46:53 INFO - } 10:46:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 10:46:53 INFO - Running post-action listener: _resource_record_post_action 10:46:53 INFO - ##### 10:46:53 INFO - ##### Running download-and-extract step. 10:46:53 INFO - ##### 10:46:53 INFO - Running pre-action listener: _resource_record_pre_action 10:46:53 INFO - Running main action method: download_and_extract 10:46:53 INFO - mkdir: /builds/slave/test/build/tests 10:46:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:53 INFO - https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:46:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/test_packages.json 10:46:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/test_packages.json 10:46:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:46:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:46:54 INFO - Downloaded 1302 bytes. 10:46:54 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:46:54 INFO - Using the following test package requirements: 10:46:54 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:54 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:46:54 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'jsshell-linux-x86_64.zip'], 10:46:54 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:46:54 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:54 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:46:54 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:46:54 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:46:54 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 10:46:54 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 10:46:54 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:46:54 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:54 INFO - https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:46:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:46:55 INFO - Downloaded 21874385 bytes. 10:46:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:46:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:46:56 INFO - Return code: 0 10:46:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 10:46:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:56 INFO - https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:46:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 10:46:57 INFO - Downloaded 21874385 bytes. 10:46:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 10:46:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 10:46:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 10:46:58 INFO - Return code: 0 10:46:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:58 INFO - https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:46:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:46:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:46:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:46:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 10:46:59 INFO - Downloaded 11132038 bytes. 10:46:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 10:46:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 10:46:59 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 10:46:59 INFO - Return code: 0 10:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:46:59 INFO - https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:46:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:46:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:46:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 10:47:01 INFO - Downloaded 57728507 bytes. 10:47:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:01 INFO - mkdir: /builds/slave/test/properties 10:47:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:47:01 INFO - Writing to file /builds/slave/test/properties/build_url 10:47:01 INFO - Contents: 10:47:01 INFO - build_url:https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 10:47:01 INFO - Running post-action listener: _resource_record_post_action 10:47:01 INFO - Running post-action listener: set_extra_try_arguments 10:47:01 INFO - ##### 10:47:01 INFO - ##### Running populate-webroot step. 10:47:01 INFO - ##### 10:47:01 INFO - Running pre-action listener: _resource_record_pre_action 10:47:01 INFO - Running main action method: populate_webroot 10:47:01 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:47:01 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:47:01 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:47:01 INFO - '--tppagecycles', 10:47:01 INFO - '7'], 10:47:01 INFO - 'tests': ['tsvgm']}}, 10:47:01 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:47:01 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:47:01 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:47:01 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:47:01 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:47:01 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 10:47:01 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:47:01 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:01 INFO - 'talos_options': ['--e10s'], 10:47:01 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:47:01 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:01 INFO - 'tests': ['damp', 'tps']}, 10:47:01 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:01 INFO - 'talos_options': ['--e10s'], 10:47:01 INFO - 'tests': ['damp', 'tps']}, 10:47:01 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:47:01 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:47:01 INFO - 'other': {'tests': ['a11yr', 10:47:01 INFO - 'ts_paint', 10:47:01 INFO - 'tpaint', 10:47:01 INFO - 'sessionrestore', 10:47:01 INFO - 'sessionrestore_no_auto_restore']}, 10:47:01 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:47:01 INFO - 'tests': ['a11yr', 10:47:01 INFO - 'ts_paint', 10:47:01 INFO - 'tpaint', 10:47:01 INFO - 'sessionrestore', 10:47:01 INFO - 'sessionrestore_no_auto_restore']}, 10:47:01 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:47:01 INFO - 'tests': ['a11yr', 10:47:01 INFO - 'ts_paint', 10:47:01 INFO - 'tpaint', 10:47:01 INFO - 'sessionrestore', 10:47:01 INFO - 'sessionrestore_no_auto_restore']}, 10:47:01 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:47:01 INFO - 'tests': ['a11yr', 10:47:01 INFO - 'ts_paint', 10:47:01 INFO - 'tpaint', 10:47:01 INFO - 'sessionrestore', 10:47:01 INFO - 'sessionrestore_no_auto_restore']}, 10:47:01 INFO - 'other_l64': {'tests': ['a11yr', 10:47:01 INFO - 'ts_paint', 10:47:01 INFO - 'tpaint', 10:47:01 INFO - 'sessionrestore', 10:47:01 INFO - 'sessionrestore_no_auto_restore']}, 10:47:01 INFO - 'other_nol64': {'tests': ['a11yr', 10:47:01 INFO - 'ts_paint', 10:47:01 INFO - 'tpaint', 10:47:01 INFO - 'sessionrestore', 10:47:01 INFO - 'sessionrestore_no_auto_restore']}, 10:47:01 INFO - 'svgr': {'tests': ['tsvgx', 10:47:01 INFO - 'tsvgr_opacity', 10:47:01 INFO - 'tart', 10:47:01 INFO - 'tscrollx', 10:47:01 INFO - 'cart']}, 10:47:01 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:47:01 INFO - 'tests': ['tsvgx', 10:47:01 INFO - 'tsvgr_opacity', 10:47:01 INFO - 'tart', 10:47:01 INFO - 'tscrollx', 10:47:01 INFO - 'cart']}, 10:47:01 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:01 INFO - 'tests': ['tp5o']}, 10:47:01 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:01 INFO - 'talos_options': ['--e10s'], 10:47:01 INFO - 'tests': ['tp5o']}, 10:47:01 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:01 INFO - 'talos_options': ['--xperf_path', 10:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:47:01 INFO - 'tests': ['tp5n']}, 10:47:01 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:47:01 INFO - 'talos_options': ['--e10s', 10:47:01 INFO - '--xperf_path', 10:47:01 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:47:01 INFO - 'tests': ['tp5n']}}, 10:47:01 INFO - 'talos.zip': {'path': '', 10:47:01 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:47:01 INFO - Running post-action listener: _resource_record_post_action 10:47:01 INFO - ##### 10:47:01 INFO - ##### Running create-virtualenv step. 10:47:01 INFO - ##### 10:47:01 INFO - Running pre-action listener: _resource_record_pre_action 10:47:01 INFO - Running main action method: create_virtualenv 10:47:01 INFO - Creating virtualenv /builds/slave/test/build/venv 10:47:01 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:47:01 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:47:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:47:01 INFO - Using real prefix '/usr' 10:47:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:47:01 INFO - Installing distribute.............................................................................................................................................................................................done. 10:47:03 INFO - Installing pip.................done. 10:47:03 INFO - Return code: 0 10:47:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:47: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')]} 10:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59d7593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f50b0>, '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 0x16f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f6440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:47:03 INFO - Using env: {'DISPLAY': ':0', 10:47:03 INFO - 'HOME': '/home/cltbld', 10:47:03 INFO - 'LANG': 'en_US.UTF-8', 10:47:03 INFO - 'LANGUAGE': 'en_US:en', 10:47:03 INFO - 'LOGNAME': 'cltbld', 10:47:03 INFO - 'MAIL': '/var/mail/cltbld', 10:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:03 INFO - 'MOZ_NO_REMOTE': '1', 10:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:03 INFO - 'NO_EM_RESTART': '1', 10:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:03 INFO - 'PWD': '/builds/slave/test', 10:47:03 INFO - 'SHELL': '/bin/bash', 10:47:03 INFO - 'SHLVL': '1', 10:47:03 INFO - 'TERM': 'linux', 10:47:03 INFO - 'TMOUT': '86400', 10:47:03 INFO - 'USER': 'cltbld', 10:47:03 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 10:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:03 INFO - '_': '/tools/buildbot/bin/python'} 10:47:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:03 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:47:03 INFO - Cleaning up... 10:47:03 INFO - Return code: 0 10:47:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:47: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')]} 10:47:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47: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')]} 10:47:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59d7593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f50b0>, '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 0x16f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f6440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:47:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:47:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:47:03 INFO - Using env: {'DISPLAY': ':0', 10:47:03 INFO - 'HOME': '/home/cltbld', 10:47:03 INFO - 'LANG': 'en_US.UTF-8', 10:47:03 INFO - 'LANGUAGE': 'en_US:en', 10:47:03 INFO - 'LOGNAME': 'cltbld', 10:47:03 INFO - 'MAIL': '/var/mail/cltbld', 10:47:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:03 INFO - 'MOZ_NO_REMOTE': '1', 10:47:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:03 INFO - 'NO_EM_RESTART': '1', 10:47:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:03 INFO - 'PWD': '/builds/slave/test', 10:47:03 INFO - 'SHELL': '/bin/bash', 10:47:03 INFO - 'SHLVL': '1', 10:47:03 INFO - 'TERM': 'linux', 10:47:03 INFO - 'TMOUT': '86400', 10:47:03 INFO - 'USER': 'cltbld', 10:47:03 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 10:47:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:03 INFO - '_': '/tools/buildbot/bin/python'} 10:47:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:04 INFO - Downloading/unpacking psutil>=0.7.1 10:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 10:47:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 10:47:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:47:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:05 INFO - Installing collected packages: psutil 10:47:05 INFO - Running setup.py install for psutil 10:47:05 INFO - building 'psutil._psutil_linux' extension 10:47:05 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:47:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 10:47:06 INFO - building 'psutil._psutil_posix' extension 10:47:06 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 10:47:06 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 10:47:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:47:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:47:06 INFO - Successfully installed psutil 10:47:06 INFO - Cleaning up... 10:47:06 INFO - Return code: 0 10:47:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:06 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 0x7f59d7593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f50b0>, '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 0x16f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f6440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:47:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:47:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:47:06 INFO - Using env: {'DISPLAY': ':0', 10:47:06 INFO - 'HOME': '/home/cltbld', 10:47:06 INFO - 'LANG': 'en_US.UTF-8', 10:47:06 INFO - 'LANGUAGE': 'en_US:en', 10:47:06 INFO - 'LOGNAME': 'cltbld', 10:47:06 INFO - 'MAIL': '/var/mail/cltbld', 10:47:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:06 INFO - 'MOZ_NO_REMOTE': '1', 10:47:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:06 INFO - 'NO_EM_RESTART': '1', 10:47:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:06 INFO - 'PWD': '/builds/slave/test', 10:47:06 INFO - 'SHELL': '/bin/bash', 10:47:06 INFO - 'SHLVL': '1', 10:47:06 INFO - 'TERM': 'linux', 10:47:06 INFO - 'TMOUT': '86400', 10:47:06 INFO - 'USER': 'cltbld', 10:47:06 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 10:47:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:06 INFO - '_': '/tools/buildbot/bin/python'} 10:47:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:47:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 10:47:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:47:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:47:08 INFO - Installing collected packages: mozsystemmonitor 10:47:08 INFO - Running setup.py install for mozsystemmonitor 10:47:08 INFO - Successfully installed mozsystemmonitor 10:47:08 INFO - Cleaning up... 10:47:08 INFO - Return code: 0 10:47:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:08 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 0x7f59d7593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f50b0>, '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 0x16f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f6440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:47:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:47:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:47:08 INFO - Using env: {'DISPLAY': ':0', 10:47:08 INFO - 'HOME': '/home/cltbld', 10:47:08 INFO - 'LANG': 'en_US.UTF-8', 10:47:08 INFO - 'LANGUAGE': 'en_US:en', 10:47:08 INFO - 'LOGNAME': 'cltbld', 10:47:08 INFO - 'MAIL': '/var/mail/cltbld', 10:47:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:08 INFO - 'MOZ_NO_REMOTE': '1', 10:47:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:08 INFO - 'NO_EM_RESTART': '1', 10:47:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:08 INFO - 'PWD': '/builds/slave/test', 10:47:08 INFO - 'SHELL': '/bin/bash', 10:47:08 INFO - 'SHLVL': '1', 10:47:08 INFO - 'TERM': 'linux', 10:47:08 INFO - 'TMOUT': '86400', 10:47:08 INFO - 'USER': 'cltbld', 10:47:08 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 10:47:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:08 INFO - '_': '/tools/buildbot/bin/python'} 10:47:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:08 INFO - Downloading/unpacking blobuploader==1.2.4 10:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:10 INFO - Downloading blobuploader-1.2.4.tar.gz 10:47:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 10:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:47:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 10:47:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:47:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:11 INFO - Downloading docopt-0.6.1.tar.gz 10:47:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 10:47:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:47:11 INFO - Installing collected packages: blobuploader, requests, docopt 10:47:11 INFO - Running setup.py install for blobuploader 10:47:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:47:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:47:11 INFO - Running setup.py install for requests 10:47:11 INFO - Running setup.py install for docopt 10:47:11 INFO - Successfully installed blobuploader requests docopt 10:47:11 INFO - Cleaning up... 10:47:11 INFO - Return code: 0 10:47:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59d7593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f50b0>, '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 0x16f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f6440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:47:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:47:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:47:11 INFO - Using env: {'DISPLAY': ':0', 10:47:11 INFO - 'HOME': '/home/cltbld', 10:47:11 INFO - 'LANG': 'en_US.UTF-8', 10:47:11 INFO - 'LANGUAGE': 'en_US:en', 10:47:11 INFO - 'LOGNAME': 'cltbld', 10:47:11 INFO - 'MAIL': '/var/mail/cltbld', 10:47:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:11 INFO - 'MOZ_NO_REMOTE': '1', 10:47:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:11 INFO - 'NO_EM_RESTART': '1', 10:47:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:11 INFO - 'PWD': '/builds/slave/test', 10:47:11 INFO - 'SHELL': '/bin/bash', 10:47:11 INFO - 'SHLVL': '1', 10:47:11 INFO - 'TERM': 'linux', 10:47:11 INFO - 'TMOUT': '86400', 10:47:11 INFO - 'USER': 'cltbld', 10:47:11 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 10:47:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:11 INFO - '_': '/tools/buildbot/bin/python'} 10:47:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:11 INFO - Running setup.py (path:/tmp/pip-oizk7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:12 INFO - Running setup.py (path:/tmp/pip-lNeFm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:12 INFO - Running setup.py (path:/tmp/pip-YXU0B2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:12 INFO - Running setup.py (path:/tmp/pip-h9KQKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:12 INFO - Running setup.py (path:/tmp/pip-UXObZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:12 INFO - Running setup.py (path:/tmp/pip-J0bYTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:12 INFO - Running setup.py (path:/tmp/pip-g37Hp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:12 INFO - Running setup.py (path:/tmp/pip-_mzrbV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:12 INFO - Running setup.py (path:/tmp/pip-eWorNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:12 INFO - Running setup.py (path:/tmp/pip-RgkKPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:12 INFO - Running setup.py (path:/tmp/pip-L5BW8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:12 INFO - Running setup.py (path:/tmp/pip-v_XXSA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:12 INFO - Running setup.py (path:/tmp/pip-0Pib8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:12 INFO - Running setup.py (path:/tmp/pip-ItnThm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:12 INFO - Running setup.py (path:/tmp/pip-tFy2Se-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:13 INFO - Running setup.py (path:/tmp/pip-ccujxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:13 INFO - Running setup.py (path:/tmp/pip-ryaPST-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:47:13 INFO - Running setup.py install for manifestparser 10:47:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:47:13 INFO - Running setup.py install for mozcrash 10:47:13 INFO - Running setup.py install for mozdebug 10:47:13 INFO - Running setup.py install for mozdevice 10:47:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:47:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:47:13 INFO - Running setup.py install for mozfile 10:47:13 INFO - Running setup.py install for mozhttpd 10:47:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:47:13 INFO - Running setup.py install for mozinfo 10:47:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:47:13 INFO - Running setup.py install for mozInstall 10:47:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:47:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:47:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:47:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:47:13 INFO - Running setup.py install for mozleak 10:47:14 INFO - Running setup.py install for mozlog 10:47:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:47:14 INFO - Running setup.py install for moznetwork 10:47:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:47:14 INFO - Running setup.py install for mozprocess 10:47:14 INFO - Running setup.py install for mozprofile 10:47:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:47:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:47:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:47:14 INFO - Running setup.py install for mozrunner 10:47:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:47:14 INFO - Running setup.py install for mozscreenshot 10:47:14 INFO - Running setup.py install for moztest 10:47:14 INFO - Running setup.py install for mozversion 10:47:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:47:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:47:14 INFO - Cleaning up... 10:47:14 INFO - Return code: 0 10:47:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59d7593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f50b0>, '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 0x16f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f6440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:47:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:47:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:47:14 INFO - Using env: {'DISPLAY': ':0', 10:47:14 INFO - 'HOME': '/home/cltbld', 10:47:14 INFO - 'LANG': 'en_US.UTF-8', 10:47:14 INFO - 'LANGUAGE': 'en_US:en', 10:47:14 INFO - 'LOGNAME': 'cltbld', 10:47:14 INFO - 'MAIL': '/var/mail/cltbld', 10:47:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:14 INFO - 'MOZ_NO_REMOTE': '1', 10:47:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:14 INFO - 'NO_EM_RESTART': '1', 10:47:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:14 INFO - 'PWD': '/builds/slave/test', 10:47:14 INFO - 'SHELL': '/bin/bash', 10:47:14 INFO - 'SHLVL': '1', 10:47:14 INFO - 'TERM': 'linux', 10:47:14 INFO - 'TMOUT': '86400', 10:47:14 INFO - 'USER': 'cltbld', 10:47:14 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 10:47:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:14 INFO - '_': '/tools/buildbot/bin/python'} 10:47:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:47:15 INFO - Running setup.py (path:/tmp/pip-QEZxuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:47:15 INFO - Running setup.py (path:/tmp/pip-gwfYHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:47:15 INFO - Running setup.py (path:/tmp/pip-XdwAH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:47:15 INFO - Running setup.py (path:/tmp/pip-qT9Rh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:47:15 INFO - Running setup.py (path:/tmp/pip-pVgDmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:47:15 INFO - Running setup.py (path:/tmp/pip-Szq74c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:47:15 INFO - Running setup.py (path:/tmp/pip-sR2BrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:47:15 INFO - Running setup.py (path:/tmp/pip-r1mGth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:47:15 INFO - Running setup.py (path:/tmp/pip-3khGYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:47:15 INFO - Running setup.py (path:/tmp/pip-CIiFd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:47:15 INFO - Running setup.py (path:/tmp/pip-pczith-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:47:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:47:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:47:15 INFO - Running setup.py (path:/tmp/pip-hbwORX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:47:16 INFO - Running setup.py (path:/tmp/pip-W3Wsbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 10:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:47:16 INFO - Running setup.py (path:/tmp/pip-DdzIcf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:16 INFO - Running setup.py (path:/tmp/pip-ldMYre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 10:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:47:16 INFO - Running setup.py (path:/tmp/pip-QBuvVV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 10:47:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:47:16 INFO - Running setup.py (path:/tmp/pip-B5PDkz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:47:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:47:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:18 INFO - Downloading blessings-1.5.1.tar.gz 10:47:18 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 10:47:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:47:18 INFO - Installing collected packages: blessings 10:47:18 INFO - Running setup.py install for blessings 10:47:18 INFO - Successfully installed blessings 10:47:18 INFO - Cleaning up... 10:47:18 INFO - Return code: 0 10:47:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:47:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:18 INFO - Reading from file tmpfile_stdout 10:47:18 INFO - Current package versions: 10:47:18 INFO - argparse == 1.2.1 10:47:18 INFO - blessings == 1.5.1 10:47:18 INFO - blobuploader == 1.2.4 10:47:18 INFO - docopt == 0.6.1 10:47:18 INFO - manifestparser == 1.1 10:47:18 INFO - mozInstall == 1.12 10:47:18 INFO - mozcrash == 0.16 10:47:18 INFO - mozdebug == 0.1 10:47:18 INFO - mozdevice == 0.47 10:47:18 INFO - mozfile == 1.2 10:47:18 INFO - mozhttpd == 0.7 10:47:18 INFO - mozinfo == 0.9 10:47:18 INFO - mozleak == 0.1 10:47:18 INFO - mozlog == 3.1 10:47:18 INFO - moznetwork == 0.27 10:47:18 INFO - mozprocess == 0.22 10:47:18 INFO - mozprofile == 0.27 10:47:18 INFO - mozrunner == 6.11 10:47:18 INFO - mozscreenshot == 0.1 10:47:18 INFO - mozsystemmonitor == 0.0 10:47:18 INFO - moztest == 0.7 10:47:18 INFO - mozversion == 1.4 10:47:18 INFO - psutil == 3.1.1 10:47:18 INFO - requests == 1.2.3 10:47:18 INFO - wsgiref == 0.1.2 10:47:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f59d7593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f50b0>, '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 0x16f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f6440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:47:18 INFO - Using env: {'DISPLAY': ':0', 10:47:18 INFO - 'HOME': '/home/cltbld', 10:47:18 INFO - 'LANG': 'en_US.UTF-8', 10:47:18 INFO - 'LANGUAGE': 'en_US:en', 10:47:18 INFO - 'LOGNAME': 'cltbld', 10:47:18 INFO - 'MAIL': '/var/mail/cltbld', 10:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:18 INFO - 'MOZ_NO_REMOTE': '1', 10:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:18 INFO - 'NO_EM_RESTART': '1', 10:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:18 INFO - 'PWD': '/builds/slave/test', 10:47:18 INFO - 'SHELL': '/bin/bash', 10:47:18 INFO - 'SHLVL': '1', 10:47:18 INFO - 'TERM': 'linux', 10:47:18 INFO - 'TMOUT': '86400', 10:47:18 INFO - 'USER': 'cltbld', 10:47:18 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 10:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:18 INFO - '_': '/tools/buildbot/bin/python'} 10:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:47:18 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:47:18 INFO - Cleaning up... 10:47:18 INFO - Return code: 0 10:47:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59d7593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f50b0>, '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 0x16f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f6440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:47:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:47:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:47:18 INFO - Using env: {'DISPLAY': ':0', 10:47:18 INFO - 'HOME': '/home/cltbld', 10:47:18 INFO - 'LANG': 'en_US.UTF-8', 10:47:18 INFO - 'LANGUAGE': 'en_US:en', 10:47:18 INFO - 'LOGNAME': 'cltbld', 10:47:18 INFO - 'MAIL': '/var/mail/cltbld', 10:47:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:18 INFO - 'MOZ_NO_REMOTE': '1', 10:47:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:18 INFO - 'NO_EM_RESTART': '1', 10:47:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:18 INFO - 'PWD': '/builds/slave/test', 10:47:18 INFO - 'SHELL': '/bin/bash', 10:47:18 INFO - 'SHLVL': '1', 10:47:18 INFO - 'TERM': 'linux', 10:47:18 INFO - 'TMOUT': '86400', 10:47:18 INFO - 'USER': 'cltbld', 10:47:18 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 10:47:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:18 INFO - '_': '/tools/buildbot/bin/python'} 10:47:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:18 INFO - Downloading/unpacking jsonschema 10:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:47:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 10:47:20 INFO - Downloading/unpacking functools32 (from jsonschema) 10:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:21 INFO - Downloading functools32-3.2.3-2.tar.gz 10:47:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 10:47:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:47:21 INFO - warning: no files found matching '*.txt' 10:47:21 INFO - no previously-included directories found matching 'build' 10:47:21 INFO - no previously-included directories found matching 'dist' 10:47:21 INFO - no previously-included directories found matching '.git*' 10:47:21 INFO - Installing collected packages: jsonschema, functools32 10:47:21 INFO - Running setup.py install for functools32 10:47:21 INFO - warning: no files found matching '*.txt' 10:47:21 INFO - no previously-included directories found matching 'build' 10:47:21 INFO - no previously-included directories found matching 'dist' 10:47:21 INFO - no previously-included directories found matching '.git*' 10:47:21 INFO - Successfully installed jsonschema functools32 10:47:21 INFO - Cleaning up... 10:47:21 INFO - Return code: 0 10:47:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:47:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:47:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:47:21 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 0x7f59d7593f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1666240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16f50b0>, '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 0x16f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f6440>, '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': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 10:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 10:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 10:47:21 INFO - Using env: {'DISPLAY': ':0', 10:47:21 INFO - 'HOME': '/home/cltbld', 10:47:21 INFO - 'LANG': 'en_US.UTF-8', 10:47:21 INFO - 'LANGUAGE': 'en_US:en', 10:47:21 INFO - 'LOGNAME': 'cltbld', 10:47:21 INFO - 'MAIL': '/var/mail/cltbld', 10:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:21 INFO - 'MOZ_NO_REMOTE': '1', 10:47:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:21 INFO - 'NO_EM_RESTART': '1', 10:47:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:21 INFO - 'PWD': '/builds/slave/test', 10:47:21 INFO - 'SHELL': '/bin/bash', 10:47:21 INFO - 'SHLVL': '1', 10:47:21 INFO - 'TERM': 'linux', 10:47:21 INFO - 'TMOUT': '86400', 10:47:21 INFO - 'USER': 'cltbld', 10:47:21 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 10:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:21 INFO - '_': '/tools/buildbot/bin/python'} 10:47:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:47:21 INFO - Downloading/unpacking flake8 10:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:47:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 10:47:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:47:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 10:47:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 10:47:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:47:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:47:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:47:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 10:47:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:47:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:47:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:47:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:47:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:47:23 INFO - no previously-included directories found matching 'docs/_build' 10:47:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:47:23 INFO - Running setup.py install for pep8 10:47:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:47:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:47:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:47:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:47:23 INFO - no previously-included directories found matching 'docs/_build' 10:47:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:47:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:47:24 INFO - Cleaning up... 10:47:24 INFO - Return code: 0 10:47:24 INFO - Running post-action listener: _resource_record_post_action 10:47:24 INFO - Running post-action listener: _start_resource_monitoring 10:47:24 INFO - Starting resource monitoring. 10:47:24 INFO - ##### 10:47:24 INFO - ##### Running install step. 10:47:24 INFO - ##### 10:47:24 INFO - Running pre-action listener: _resource_record_pre_action 10:47:24 INFO - Running main action method: install 10:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:47:24 INFO - Reading from file tmpfile_stdout 10:47:24 INFO - Detecting whether we're running mozinstall >=1.0... 10:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:47:24 INFO - Reading from file tmpfile_stdout 10:47:24 INFO - Output received: 10:47:24 INFO - Usage: mozinstall [options] installer 10:47:24 INFO - Options: 10:47:24 INFO - -h, --help show this help message and exit 10:47:24 INFO - -d DEST, --destination=DEST 10:47:24 INFO - Directory to install application into. [default: 10:47:24 INFO - "/builds/slave/test"] 10:47:24 INFO - --app=APP Application being installed. [default: firefox] 10:47:24 INFO - mkdir: /builds/slave/test/build/application 10:47:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:47:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:47:39 INFO - Reading from file tmpfile_stdout 10:47:39 INFO - Output received: 10:47:39 INFO - /builds/slave/test/build/application/firefox/firefox 10:47:39 INFO - Running post-action listener: _resource_record_post_action 10:47:39 INFO - ##### 10:47:39 INFO - ##### Running run-tests step. 10:47:39 INFO - ##### 10:47:39 INFO - Running pre-action listener: _resource_record_pre_action 10:47:39 INFO - Running main action method: run_tests 10:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:47:39 INFO - Python 2.7.3 10:47:39 INFO - Return code: 0 10:47:39 INFO - grabbing minidump binary from tooltool 10:47:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:47:39 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 0x16f50b0>, '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 0x16f5fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16f6440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:47:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:47:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:47:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:47:39 INFO - Return code: 0 10:47:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:47:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:47:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:47:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:47:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:47:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:47:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:47:40 INFO - Return code: 0 10:47:40 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/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] in /builds/slave/test/build 10:47:40 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/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost 10:47:40 INFO - Using env: {'DISPLAY': ':0', 10:47:40 INFO - 'HOME': '/home/cltbld', 10:47:40 INFO - 'LANG': 'en_US.UTF-8', 10:47:40 INFO - 'LANGUAGE': 'en_US:en', 10:47:40 INFO - 'LOGNAME': 'cltbld', 10:47:40 INFO - 'MAIL': '/var/mail/cltbld', 10:47:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:47:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:47:40 INFO - 'MOZ_NO_REMOTE': '1', 10:47:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:47:40 INFO - 'NO_EM_RESTART': '1', 10:47:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:47:40 INFO - 'PWD': '/builds/slave/test', 10:47:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:47:40 INFO - 'SHELL': '/bin/bash', 10:47:40 INFO - 'SHLVL': '1', 10:47:40 INFO - 'TERM': 'linux', 10:47:40 INFO - 'TMOUT': '86400', 10:47:40 INFO - 'USER': 'cltbld', 10:47:40 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963', 10:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:47:40 INFO - '_': '/tools/buildbot/bin/python'} 10:47:40 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/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost'] with output_timeout 3600 10:47:40 INFO - mozversion INFO | application_buildid: 20151211101232 10:47:40 INFO - mozversion INFO | application_changeset: 30d3b887b4ec0e3536320b4dabd24627f73dfcd5 10:47:40 INFO - mozversion INFO | application_display_name: Nightly 10:47:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:47:40 INFO - mozversion INFO | application_name: Firefox 10:47:40 INFO - mozversion INFO | application_remotingname: firefox 10:47:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 10:47:40 INFO - mozversion INFO | application_vendor: Mozilla 10:47:40 INFO - mozversion INFO | application_version: 45.0a1 10:47:40 INFO - mozversion INFO | platform_buildid: 20151211101232 10:47:40 INFO - mozversion INFO | platform_changeset: 30d3b887b4ec0e3536320b4dabd24627f73dfcd5 10:47:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 10:47:40 INFO - mozversion INFO | platform_version: 45.0a1 10:47:40 INFO - 2015-12-11 10:47:40,675 DEBUG : using testdate: 1449859660 10:47:40 INFO - 2015-12-11 10:47:40,675 DEBUG : actual date: 1449859660 10:47:40 INFO - 2015-12-11 10:47:40,687 INFO : starting webserver on 'localhost:41783' 10:47:40 INFO - 2015-12-11 10:47:40,688 INFO : Starting test suite talos-linux64-ix-036 10:47:40 INFO - 2015-12-11 10:47:40,688 INFO : Starting test dromaeo_css 10:47:40 INFO - 2015-12-11 10:47:40,689 DEBUG : operating with platform_type : linux_ 10:47:40 INFO - 2015-12-11 10:47:40,689 INFO : Initialising browser for dromaeo_css test... 10:47:40 INFO - 2015-12-11 10:47:40,706 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpahPmms/profile http://localhost:41783/getInfo.html 10:47:45 INFO - 2015-12-11 10:47:45,328 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:47:45 INFO - 2015-12-11 10:47:45,328 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:47:45 INFO - 2015-12-11 10:47:45,328 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:47:45 INFO - 2015-12-11 10:47:45,328 DEBUG : BROWSER_OUTPUT: __metrics 10:47:45 INFO - 2015-12-11 10:47:45,429 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 10:47:45 INFO - 2015-12-11 10:47:45,518 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:47:46 INFO - 2015-12-11 10:47:46,875 INFO : Browser initialized. 10:47:46 INFO - 2015-12-11 10:47:46,876 INFO : Running cycle 1/1 for dromaeo_css test... 10:47:46 INFO - 2015-12-11 10:47:46,876 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpahPmms/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:47:58 INFO - 2015-12-11 10:47:58,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 142557184 10:47:58 INFO - 2015-12-11 10:47:58,841 DEBUG : BROWSER_OUTPUT: 10:48:50 INFO - 2015-12-11 10:48:50,138 DEBUG : BROWSER_OUTPUT: 1449859730133 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] 10:51:02 INFO - 2015-12-11 10:51:02,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41783/tests/dromaeo/cssquery-ext.html) 10:51:03 INFO - 2015-12-11 10:51:03,404 DEBUG : BROWSER_OUTPUT: RSS: Main: 255217664 10:51:03 INFO - 2015-12-11 10:51:03,404 DEBUG : BROWSER_OUTPUT: 10:54:06 INFO - 2015-12-11 10:54:06,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/dromaeo/cssquery-ext.html (next: http://localhost:41783/tests/dromaeo/cssquery-jquery.html) 10:54:06 INFO - 2015-12-11 10:54:06,587 DEBUG : BROWSER_OUTPUT: RSS: Main: 219254784 10:54:06 INFO - 2015-12-11 10:54:06,587 DEBUG : BROWSER_OUTPUT: 10:57:08 INFO - 2015-12-11 10:57:08,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41783/tests/dromaeo/cssquery-mootools.html) 10:57:09 INFO - 2015-12-11 10:57:09,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 218386432 10:57:09 INFO - 2015-12-11 10:57:09,299 DEBUG : BROWSER_OUTPUT: 11:00:11 INFO - 2015-12-11 11:00:11,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41783/tests/dromaeo/cssquery-prototype.html) 11:00:11 INFO - 2015-12-11 11:00:11,790 DEBUG : BROWSER_OUTPUT: RSS: Main: 206135296 11:00:11 INFO - 2015-12-11 11:00:11,790 DEBUG : BROWSER_OUTPUT: 11:03:14 INFO - 2015-12-11 11:03:14,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41783/tests/dromaeo/cssquery-yui.html) 11:03:15 INFO - 2015-12-11 11:03:15,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 208056320 11:03:15 INFO - 2015-12-11 11:03:15,122 DEBUG : BROWSER_OUTPUT: 11:06:17 INFO - 2015-12-11 11:06:17,873 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/dromaeo/cssquery-yui.html (next: http://localhost:41783/tests/dromaeo/cssquery-dojo.html) 11:06:18 INFO - 2015-12-11 11:06:18,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 246251520 11:06:18 INFO - 2015-12-11 11:06:18,117 DEBUG : BROWSER_OUTPUT: 11:06:18 INFO - 2015-12-11 11:06:18,117 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:06:18 INFO - 2015-12-11 11:06:18,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:06:18 INFO - 2015-12-11 11:06:18,117 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:06:18 INFO - 2015-12-11 11:06:18,117 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:06:18 INFO - 2015-12-11 11:06:18,121 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2655.34943938735;2726.9045583404586;2733.8906443742253;2736.575830746235;2751.38093928866;4473.82104715811;4598.5401459854;4679.461861885884;4721.716696998178;4729.337892695025;4594.72431654101;4659.324397962293;4776.925191831836;4783;4784.44978827435;4306.310990241562;4339.913201735963;4384.802683879233;4409.9118017639785;4451.065276291983;4202.411662367271;4352.347147927804;4387.9561204387865;4447.822087116511;4458.754768487732;4242.851500197478;4302.677299202573;4318.978405107954;4326.178026175048;4338.067315527177;4344.652427805768;4344.804483798237;4355.216061108999;4359.934600980988;4389.604935555815;4114.814833332477;4212.578742125794;4292.656587472995;4325.783710814447;4374.190774706658;4480.574345437179;4521.683482156251;4573.085382923396;4589.2198326284615;4623.445186577598;5024.447310795809;5082.263071854597;5086.593072554187;5095.923561146548;5146.279520867081;4888.73111978841;5014.323066386028;5101.566366858821;5108.055009823194;5113.488651134894;4488.730676159408;4574.5425457453985;4578.656600754956;4585.862424127282;4600.263957766741;5232.738363081907;5277.551408130275;5287.07476191665;5288.206768984606;5315;5044.646874718808;5059.848204553869;5061.7975280989085;5064.721440320818;5109.054824857413;4857.077155340545;4968.354113965162;4974.353334066548;4997.625178111656;5109.514596113363;4983.426905905795;5003.74981250936;5004.84985450437;5005.549500544896;5053.418856831511;4980.726060066731;4983.551480366785;4987.80048798044;4991.825286115041;5036.169032109734;4057.4522439470293;4117;4173.791310434527;4272.9359059614135;4276;3681.3557627415094;3718.7768733876055;3719.0330514065995;3760.2855457462992;3760.9059773505883;4336.826526938887;4349.325854492558;4351;4365.934510982338;4384;4792.832250871203;4921;4935.654504184673;5012.974935125301;5121.1550094234035;4305.763183024964;4357.477102747691;4378.5183629800695;4382.956170438319;4422.314541246112;4512.548745125527;4523.683342166082;4527.524609915978;4527.9547204527535;4576.244919588297;4613.700109492872;4722.433308003062;4755.048990201904;4764.380630518011;4829.975850120797;5120.871978200575;5126.231065340229;5137.972405518986;5141.331626888481;5148.562372198405;4845.030993801324;4854.368932038812;4854.854354369375;4859.781309840995;4893.168161412639;4785.976070119627;4833.830815921426;4901.264810278487;4910.263460480956;5103.18349064148;5096.719680417613;5104.336436263262;5106.46382129871;5106.5404113628465;5109.489051094861;4948.257761335828;4950.257461380822;4951.653384263067;4955.752212389438;4995.050940321327;4686.671932964659;4748.548887855648;4794;4852.0295940811275;4939.209726443752;4872.6832755870755;4877.317175595491;4884.9985752921275;4886.975565122151;4892.779824907817;4996.475370086088;5000.799968001239;5003.249512573143;5028.64799464034;5042.268871013609;4723.197056500335;4755.453122890912;4868.586170175575;4886.877828054327;4887.144749668722 11:06:18 INFO - 2015-12-11 11:06:18,121 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.0970751651116;570.492261886921;574.0556784090172;578.4562511239435;602.8673691787806;26700.465990680175;35389.64610353896;35987.28025439493;36024.459633105456;36056.45915311272;40286.19427611446;40771;40806.18387632246;40930.38604420936;40931.386029209585;7090.220075791659;7224.891626625605;7848.68605255789;8068.031836179637;8075.394345424087;7206.963965180167;9998.800023999516;10200.540975656077;10224.642137525188;10232.846507302396;9758.072983066597;9910.752231194207;9920.950395248014;9924.603015879393;9930.553125109387;7116.9288307116785;7290.81772955675;9958.90041099587;10079.546420411025;10087.243456740736;10105.292629515938;10371.844422333672;10397.532111055021;10398.740031499197;10400.271980961335;37682.81158594217;38142.80928595339;38149.61850381488;38235;38235.808820955994;2916.387558612673;2946.4254470378287;3050.603421555206;3213.855376508063;3551.5383000210068;28223.177682231817;28326.15021549357;28502;28715;28817.135485935454;3188.601424821897;3271.1495011296997;3277.147941535194;3363.9495407568907;3384.0524653097173;203641;205023;205167;205623;205941;46494.767526162155;54244.18633720497;54642.180367294524;54645.453545464035;54660.2606726288;39554.60445395509;63176.68411658004;66290.33709662939;66331.66834165798;66360.6681966587;13007.219566826021;13201.801972970414;13227;13238.470461181638;13243.867561324456;9693.563789629483;9704.369216000938;9755.804883902425;9759.414435133915;9765.023497650178;18686.813131868777;18829.435116946515;18868.339608113925;18945.526361841064;18951.62096758057;7011.6143612100805;7337.486375953632;7340.743073992385;7352.96323518379;7373.631318434057;835.6907944060737;872.284726524244;901.5447199164511;939.1266122506134;1052.5211028981794;25806;26300.21099367022;26741.331466713487;26765.464690706078;26768.59847102295;932.9813403732023;946.1673727120091;976.2873102635116;984.1192133040888;1067.6796960911695;13141.279989618639;13426.194428334331;13639.454421823017;13642.795358069638;13676.658083547793;249211;250455;252213;253395;253683;46114.769426152656;46448.07103857904;46473.30290045652;46505.53494465012;46528.30207546889;1222.9510819567117;1236.1779416687802;1237.220551052849;1251.3367915005063;1253.154120968361;22199.556008880056;24951.87524062368;25321.87339063293;25821.483570328863;27214.183574492796;40300;40769.59230407658;41001.79499102486;41028.17943641051;41082.79458602688;195709;195992;197138;197175;197778;24859.254222373358;25547.23358299254;26355.341116472242;26365.736342636326;26756.866215668797;33700.32599348048;34096.31807363888;34242.65757342494;34517;38135.237295253384;29419;29617.407651847272;29788.55317170201;30200.54699179558;30378.696213037587;29778.70221297846;29936.85031574828;29939.251518712208;29979;29992.4001519964;32116.03651890447;33209.50185747264;33671.663283366855;33759.83120084384;33782.15544611306;25522.23433297004;29329.266768330963;29482.557761633165;30173.396532069673;30570.84714576502;21589.13643454244;21787.891060544596;23714.762852371947;23717.762822372246;24198.274051778473 11:06:18 INFO - 2015-12-11 11:06:18,125 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.52757320817835;333.98831040913575;336.0355778914514;337.08145304046474;340.39239956677335;12215.755684886297;12440.25358478492;15159.545213643594;15404.428648443585;16595.58511037223;12180;14681.632959175999;15440.69118617627;16111.0333379997;16157.192140392963;4856.7571621418965;4933.309336692866;4950.801967921278;4972.975135124319;5073.061483625523;3398.4052790761516;3507.2108775525558;4938.703677779345;6233.7818176363835;6430.7106180222;6333.429991300782;6340.334264902188;6361.536846525302;6418.101465794793;6423.229212494507;6417;6463.289038205794;6463.773767918124;6465.3534646535445;6467.870642587145;6027.608205466675;6104.053871649901;6194.659293738842;6243.75024999004;6249.312575616678;18803.341883034165;18877.90561047186;19568.412947611596;20247.190112395485;20629.690554641544;1988.2245924089616;1998.6902030185345;2027.1891243502569;2046.98976505118;2055.1368425261426;12830.294333811637;12956.80564791529;13031.804522932163;13081.215127092404;13502.932485337511;1742.1724680776656;1839.4297767691924;1852.4164888060218;1854.3695143651223;1866.925322987079;49774.7511262445;49851.25223121656;51889;60867.39132608662;61575.07637385443;14591.708165836624;15157.877897094415;15189;15234.619134521725;15254.08475491474;22175.223867164572;22226.222082227043;22426.55146897053;22448.887755561118;22458.775412245996;7940.325072368913;8000.279974802295;8046;8131.430799844073;8149.551774652451;6837.38463538274;6893.379595836399;6912.654367281616;6913.3777959983845;6941.479389045841;6661.134052573135;7561.2060733622175;7575.128860181149;7581.166071732105;7598.240175982358;2494.3639371960035;2962.259435141215;2967.6438827340426;3012.6987301269696;3023.319753055589;759.9962000189963;764.75910088322;831.5717405536154;871.9128087191357;964.6141543382703;12641.620751377473;14558.563243102724;14963.70072598542;15091.698166036618;15544.76682849758;794.2018271637083;813.6826637611337;838.6142374507795;851.1956201389627;880.3397451911067;8664.913350866536;8787.384883058252;8826.205641492297;8870.334724895658;9019.864702029476;427063;434230;439259;454459;456031;63769.68115159395;66173.33826661768;67548;67871.3212867865;68012.31987680159;1045.2213101239624;1052.3633201912885;1110.0841805510486;1121.0527104596765;1122.5117074072805;13715.740602066955;13747.450101995808;13975.161490310615;14127.717445651235;14248.64378390507;32523.186920326236;32903.506447402826;32923.50614740733;33607.15982100369;33744.15639609029;43734.78132609444;43914.78042609766;44550.10899781921;45971.77014114908;47101.764491177324;8297.460665056751;8648.56757162152;8742.825143496968;8743.950725912931;8748.906386701663;9997;10913.686714742587;12473.625791226277;12601.11792174539;15117.319720612819;12907.290099044643;12972.156809807333;13114.672133196746;13226.603201903958;13348.199108053548;8344.582770861554;8521.573921304034;13028.674283142997;13464.798028029392;13742.793858091936;8843;8898.288136949159;9293.581788819383;9357.06429357059;9366.250699943852;12335.938320308342;12775.48898044105;12788.296643684687;13611.727765444833;13633.727325453237;13714.38285277145;13868.167909925436;14404.207768572829;14437.278136092944;14472.421103156177 11:06:18 INFO - 2015-12-11 11:06:18,126 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1202.711349276173;1655.9503214903552;1720.1571230097247;1740.3299729604103;1749.3439960014994;6000.729967151483;6738.663066846662;6891.24196338403;6900.6204658743745;6909.550879192849;7027.262137475568;7061.646917654122;7134.75028374007;7144.499885008038;7150.678219480123;2074.159965214083;2105.231590469483;2107.473131717071;2107.862988905724;2111.4721319670084;2070.7722150563427;2082.83337333013;2099.6010757956014;2147.6456384696507;2150.666646669769;2100.0759665747023;2101.264557404904;2106.7787882272296;2128.138104067855;2130.7336582927132;2106.8630539014994;2121.299971009571;2123.108294516307;2128.946776330589;2136.861104028241;2060.3406909788873;2078.490769761403;2086.6765651324067;2088.634488964425;2090.7386576677914;7009.719611215545;7086.468514861406;7100.964495177543;7101.431885449152;7114.964425177893;4116.176764647083;4208.242516347056;4224.302990006645;4225.9577404226175;4232.915341693149;2645.3122188231005;2657.840529568213;2726.82275652082;2735.466584016118;2754.903578374767;846.2764336492334;1581.4896773581202;1582.9604259893595;1593.1556275174175;1640.2208950748418;9432.103950124796;9544.95227523865;9551;9558.665446709332;9562.330636855422;3774.698024158061;3791.5829258781514;3866.3813789794062;3869.0520822398694;3870.8064596770614;7916.564588947663;7921.32668723165;7921.683132674629;7922.762317130495;7932;4138.358554424069;4160.334346504545;4162.146759914211;4190.455240818674;4195.846142310828;3253.430649636304;3329.3008468221947;3740.551133863954;3805.1438426353848;3836.271108489378;3095.582096417;3146.5594816725675;3151.401233765577;3162.7311678507126;3176.2059485128716;902.4359775140537;906.1527471813876;908.2053203446984;926.7080869526078;928.4707716601607;989.2333441582831;1007.7682133109425;1009.8333774927202;1065.307550092446;1197.6167626359656;6632.071509988606;6655.633940133339;6674.365935236145;6690.866182676319;6693.933060669331;434.2379124636243;1096.736783172049;1108.2020944919645;1129.4239937631867;1160.4545863444168;5016.849494515171;5037.042961837239;5152.252923326097;5153.5361817436615;5160.8967820643375;8273.958630206811;8314.584270786436;8399.244068033906;8414.032386275534;8423.915760842436;8165.673373065011;8372.246497815226;8402.159784021671;8438.113998030241;8466.238038576557;6643.56816806906;6654.567453115532;6719.932800671931;6734.158230221223;6743.696533656095;6199.1011303361665;6271.278802937721;6398.680065996775;6424.068510066108;6436.034594810816;7359.521631093961;7516.699332026657;7554.848903022019;7579.204183560867;7662.463627546018;7642.350400216044;7824.569648669378;7835.49069310493;7836.647350869111;7865.685372585032;5023.748812559431;5142.382914050338;6029.939700602938;6084.482818960438;6096.207493025879;6594.142761440982;6656.600603963584;6745.3591908768585;6756.594604323756;6768.796936091925;6238.282597501346;6242.406971337716;6279.1209230708655;6332.651704156316;6342;6158.137860699416;6160.630362178284;6184.319724830175;6238.625682459067;6269.153664255267;6280.528960328085;6365.490760739222;6432.646204458612;6434.388733070351;6463.612183269019;5934.673592952429;5948.732307046107;5972.790952316648;5999.550033747573;6015.488683461955;5969.671668058125;5972.343042265435;6020.51835853122;6026.186464827368;6038.84902877414 11:06:18 INFO - 2015-12-11 11:06:18,126 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.4081958541673;309.8683059699629;310.7762411064036;311.14280158164263;313.9874405023799;5328.440513746054;5403.432639572842;5428.430014848438;5450.427705090968;5550.306211723535;5336.706481143536;5397;5404.378496472907;5412.404635490093;5413.756380962856;3932.508436445444;4027.0737730322044;4184.435101261336;4190.7485550866895;4192.24539582875;4054.736442131267;4146.963259185204;4169.228692691861;4173.061061261223;4177.644900183473;4114.670826333886;4119.938200926988;4126.236646220459;4130.132672138854;4134.069834287291;3906.6679332256936;3981.163955569334;4054.6148115929236;4118.794060296988;4147.294959856831;3657.482144909859;3668.0829792551863;3685.3919103347916;3687.870924517629;3688.3729765939856;5099.413567439755;5113.156329205676;5123.2315152727015;5125.410577783566;5127.7948882044675;4824.831130910401;4841.7337046462435;4842.564169224752;4846.176150054499;4855.441624213226;5577.107662773937;5663.943360566424;5664.178694089375;5683.857903552403;5708.115242137475;4025.5974402559805;4032.8386864525382;4033.334499807528;4035.8385664573384;4036.0717035082093;5888.676122813244;5991.580589358747;5999.280086389574;5999.430054144849;6001.729922153513;4176.227397931392;4182;4182.163567286555;4187.14163596462;4190.350495673176;4085.9591404086173;4214.030772922184;4229.2598795210715;4247.023184667543;4253.532111467736;4825.348577942003;4827.710337379768;4829.227323628203;4833.250846118857;4834.081524510332;5700.743466544015;5700.8859822803315;5707.0583353747;5707.514861236758;5713.971430142823;1480.8074950256614;1494.0811400988314;1506.5555661080007;1506.7890495330662;1506.8568485993812;1023.5649848814224;1024.7335692719946;1030.7062487191115;1032.2413026425722;1062.9468526573794;4962.280469331927;4967.950320496821;4973.452920178777;4980.302757613937;4980.352554167935;5877.38287479817;5892.234009578728;5907.261592300963;5911.40885911414;5914.319853216849;4965.230389289666;4967.90064198714;4973;4981.227909674007;4983.202687569971;2929.516629756109;3017.5775391445213;3127.499600063979;3153.30627262002;3188.8724451022163;5541.445855414427;5602.691851948182;5607.243022192033;5627.634203776742;5631.267935168402;6131.233595800525;6140.078988151813;6149.200603921461;6153.600015999035;6153.784617538365;5607.7476513556985;5611.887762244733;5614.859628509238;5615.494605485526;5620.634658747168;5822.650640961556;5908.527317814479;5911.408859114054;5934.495567876779;5945.256842894638;5781;5786.392428794916;5789.710514474175;5795.594308398372;5798.652080875161;5594.468525490072;5594.964931487688;5600.523955463831;5604.047311956896;5604.8318550443555;4110.91778164441;4187.790610469525;4198.202341555095;4201.684873634551;4206.17979494008;5926.970365148319;5928.762849486145;5931.525477961839;5939.316978547522;5945.346011938596;5711.429356926712;5719.056355701429;5719.142128680731;5731.283589551306;5734.942650573441;5716.256886604715;5719.542436604978;5726.770929162787;5728.942710572841;5730.025895597842;5425.457454254701;5607.635503692247;5611.74747136388;5616.297962754656;5622.044252477171;5770.192173095686;5775.884482310415;5776.7111644418455;5777.8555536111935;5784.190213370048;5395.136778115482;5456.399796022513;5536.252605898152;5612.663240205601;5624.325080990144 11:06:18 INFO - 2015-12-11 11:06:18,127 DEBUG : BROWSER_OUTPUT: |5;yui.html;761.8171638806687;770.2066871122742;771.9807004824883;777.0558771093121;788.992110078899;10916.563337466501;11215.943920280397;13318.13432126911;13556.98322625802;13584.728305433886;12962.80555791664;13026.478940842355;13130.671733206675;13132.146410483336;13164.210147391163;634.8793729191462;640.1645852162949;810.9716159934418;818.6357071103362;822.2928281677753;816.873384625384;819.0335404223015;824.756696774453;824.9628766705513;825.686239229092;861.2593169873903;867.9783005424852;868.8088620503511;869.0917990699734;870.2168048756107;656.7865443730783;667.7262322447822;846.2848892685671;857.7941294089436;859.8925134358205;634.7873462390105;635.4281146967766;635.5170070746266;635.5265327331122;635.586868535451;11518.36648984314;11774.764504709943;11813.1140164488;11814.586489472827;11835.408229588485;10838.078763305128;11015.614453494169;11114.61098861544;11319.094472442184;11682.883171168265;9013;9632.807343853154;9737.318387712863;9748.610055597768;9960.452175130366;3125.624925008991;3135.749140068789;3152.7162555369896;3171.63526194486;3230.2731885325616;40503.79748101241;40614.79692601548;40844.774656760346;40890.795546022375;40939.7953010236;9141.222996045277;9553.42679439222;9564.61741530331;9639.084286992724;9648.421094734338;16251.674966500605;16714.6657066858;16757.748633770505;16812.663746724997;16815.41146059882;6251.28110267316;6362.331955144736;6401.007843784221;6480.384363485461;6487.740490380332;3575.481555174485;3679.742418030712;3689.7232707546505;3773.867914622975;3798.4682144499793;2675.9331016724736;2696.8381897086238;2697.082991782764;2701.162639581736;2701.7433343832304;495.61342153120626;496.493576551915;498.94761050089943;502.979880804771;503.4889587069128;447.6530688716271;456.6369736059774;485.61393692014934;534.156033467121;539.075485542289;7305.780826575105;7598.924010759822;7701.499402538817;7883.054033516015;8033.959830200812;471.5143402295641;522.6968358352146;523.5392854288202;533.4292307231225;590.1825971030069;3538.203904121552;3627.764195327295;3676.7426280160666;3682.834272457746;3826.9043273918373;50881.74559127181;50962.23556646653;51308;51345.229821552704;51470;44031.779841100586;44113.11773764571;44488.55511444844;44703.77648111804;44720.10559788851;41031.384529232084;41348.1730365397;41373;41452.37821432621;41717;7323.560586364835;7424.740134095281;7774;7933.809928510539;8120.83758324842;30858.074257772303;31573.268325823392;31923.36153276968;31924.36151277008;32591.18522036968;40226.17851304122;41742;42290.36564451474;42998.35502467528;43562.12875742531;9924.503774811375;9966.800663986825;10004.24968127408;10073.949630251802;10326.586936522455;10820.350778953289;10836.945815270874;10841.837372439262;11145.331280123219;11389.544418223179;9619.18236949867;9709.70870873875;9816.85274720894;9971.202303815533;10180.796384072426;10474.162067034467;10738.677839664822;10795.866434024629;11072.723181920517;11078.279911805706;8209.71266005687;9816.950915245663;10436.165106791286;11093.889061109285;11106.500207490844;8857;8918.73243802687;9328.347015709107;9421.62313507452;9434.811303774024;8382.695208318639;8817.727347640184;8818.955905220433;8963.462192268486;9119.635214591342 11:06:18 INFO - 2015-12-11 11:06:18,127 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:06:18 INFO - 2015-12-11 11:06:18,127 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:06:18 INFO - 2015-12-11 11:06:18,127 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,908 11:06:18 INFO - 2015-12-11 11:06:18,128 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:06:18 INFO - 2015-12-11 11:06:18,128 DEBUG : BROWSER_OUTPUT: __startTimestamp1449860778116__endTimestamp 11:06:18 INFO - 2015-12-11 11:06:18,128 DEBUG : BROWSER_OUTPUT: 11:06:18 INFO - 2015-12-11 11:06:18,129 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:06:18 INFO - 2015-12-11 11:06:18,129 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:06:18 INFO - 2015-12-11 11:06:18,129 DEBUG : BROWSER_OUTPUT: 11:06:18 INFO - 2015-12-11 11:06:18,129 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4657.72 Median:4784.45 stddev:490.01 (10.2%) stddev-sans-first:465.65 11:06:18 INFO - 2015-12-11 11:06:18,129 DEBUG : BROWSER_OUTPUT: Values: 2655.3 2726.9 2733.9 2736.6 2751.4 4473.8 4598.5 4679.5 4721.7 4729.3 4594.7 4659.3 4776.9 4783.0 4784.4 4306.3 4339.9 4384.8 4409.9 4451.1 4202.4 4352.3 4388.0 4447.8 4458.8 4242.9 4302.7 4319.0 4326.2 4338.1 4344.7 4344.8 4355.2 4359.9 4389.6 4114.8 4212.6 4292.7 4325.8 4374.2 4480.6 4521.7 4573.1 4589.2 4623.4 5024.4 5082.3 5086.6 5095.9 5146.3 4888.7 5014.3 5101.6 5108.1 5113.5 4488.7 4574.5 4578.7 4585.9 4600.3 5232.7 5277.6 5287.1 5288.2 5315.0 5044.6 5059.8 5061.8 5064.7 5109.1 4857.1 4968.4 4974.4 4997.6 5109.5 4983.4 5003.7 5004.8 5005.5 5053.4 4980.7 4983.6 4987.8 4991.8 5036.2 4057.5 4117.0 4173.8 4272.9 4276.0 3681.4 3718.8 3719.0 3760.3 3760.9 4336.8 4349.3 4351.0 4365.9 4384.0 4792.8 4921.0 4935.7 5013.0 5121.2 4305.8 4357.5 4378.5 4383.0 4422.3 4512.5 4523.7 4527.5 4528.0 4576.2 4613.7 4722.4 4755.0 4764.4 4830.0 5120.9 5126.2 5138.0 5141.3 5148.6 4845.0 4854.4 4854.9 4859.8 4893.2 4786.0 4833.8 4901.3 4910.3 5103.2 5096.7 5104.3 5106.5 5106.5 5109.5 4948.3 4950.3 4951.7 4955.8 4995.1 4686.7 4748.5 4794.0 4852.0 4939.2 4872.7 4877.3 4885.0 4887.0 4892.8 4996.5 5000.8 5003.2 5028.6 5042.3 4723.2 4755.5 4868.6 4886.9 4887.1 11:06:18 INFO - 2015-12-11 11:06:18,129 DEBUG : BROWSER_OUTPUT: 11:06:18 INFO - 2015-12-11 11:06:18,129 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38118.01 Median:16879.72 stddev:56966.29 (337.5%) stddev-sans-first:57056.31 11:06:18 INFO - 2015-12-11 11:06:18,130 DEBUG : BROWSER_OUTPUT: Values: 566.1 570.5 574.1 578.5 602.9 26700.5 35389.6 35987.3 36024.5 36056.5 40286.2 40771.0 40806.2 40930.4 40931.4 7090.2 7224.9 7848.7 8068.0 8075.4 7207.0 9998.8 10200.5 10224.6 10232.8 9758.1 9910.8 9921.0 9924.6 9930.6 7116.9 7290.8 9958.9 10079.5 10087.2 10105.3 10371.8 10397.5 10398.7 10400.3 37682.8 38142.8 38149.6 38235.0 38235.8 2916.4 2946.4 3050.6 3213.9 3551.5 28223.2 28326.2 28502.0 28715.0 28817.1 3188.6 3271.1 3277.1 3363.9 3384.1 203641.0 205023.0 205167.0 205623.0 205941.0 46494.8 54244.2 54642.2 54645.5 54660.3 39554.6 63176.7 66290.3 66331.7 66360.7 13007.2 13201.8 13227.0 13238.5 13243.9 9693.6 9704.4 9755.8 9759.4 9765.0 18686.8 18829.4 18868.3 18945.5 18951.6 7011.6 7337.5 7340.7 7353.0 7373.6 835.7 872.3 901.5 939.1 1052.5 25806.0 26300.2 26741.3 26765.5 26768.6 933.0 946.2 976.3 984.1 1067.7 13141.3 13426.2 13639.5 13642.8 13676.7 249211.0 250455.0 252213.0 253395.0 253683.0 46114.8 46448.1 46473.3 46505.5 46528.3 1223.0 1236.2 1237.2 1251.3 1253.2 22199.6 24951.9 25321.9 25821.5 27214.2 40300.0 40769.6 41001.8 41028.2 41082.8 195709.0 195992.0 197138.0 197175.0 197778.0 24859.3 25547.2 26355.3 26365.7 26756.9 33700.3 34096.3 34242.7 34517.0 38135.2 29419.0 29617.4 29788.6 30200.5 30378.7 29778.7 29936.9 29939.3 29979.0 29992.4 32116.0 33209.5 33671.7 33759.8 33782.2 25522.2 29329.3 29482.6 30173.4 30570.8 21589.1 21787.9 23714.8 23717.8 24198.3 11:06:18 INFO - 2015-12-11 11:06:18,130 DEBUG : BROWSER_OUTPUT: 11:06:18 INFO - 2015-12-11 11:06:18,130 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25595.62 Median:18571.28 stddev:72128.67 (388.4%) stddev-sans-first:72306.07 11:06:18 INFO - 2015-12-11 11:06:18,130 DEBUG : BROWSER_OUTPUT: Values: 331.5 334.0 336.0 337.1 340.4 12215.8 12440.3 15159.5 15404.4 16595.6 12180.0 14681.6 15440.7 16111.0 16157.2 4856.8 4933.3 4950.8 4973.0 5073.1 3398.4 3507.2 4938.7 6233.8 6430.7 6333.4 6340.3 6361.5 6418.1 6423.2 6417.0 6463.3 6463.8 6465.4 6467.9 6027.6 6104.1 6194.7 6243.8 6249.3 18803.3 18877.9 19568.4 20247.2 20629.7 1988.2 1998.7 2027.2 2047.0 2055.1 12830.3 12956.8 13031.8 13081.2 13502.9 1742.2 1839.4 1852.4 1854.4 1866.9 49774.8 49851.3 51889.0 60867.4 61575.1 14591.7 15157.9 15189.0 15234.6 15254.1 22175.2 22226.2 22426.6 22448.9 22458.8 7940.3 8000.3 8046.0 8131.4 8149.6 6837.4 6893.4 6912.7 6913.4 6941.5 6661.1 7561.2 7575.1 7581.2 7598.2 2494.4 2962.3 2967.6 3012.7 3023.3 760.0 764.8 831.6 871.9 964.6 12641.6 14558.6 14963.7 15091.7 15544.8 794.2 813.7 838.6 851.2 880.3 8664.9 8787.4 8826.2 8870.3 9019.9 427063.0 434230.0 439259.0 454459.0 456031.0 63769.7 66173.3 67548.0 67871.3 68012.3 1045.2 1052.4 1110.1 1121.1 1122.5 13715.7 13747.5 13975.2 14127.7 14248.6 32523.2 32903.5 32923.5 33607.2 33744.2 43734.8 43914.8 44550.1 45971.8 47101.8 8297.5 8648.6 8742.8 8744.0 8748.9 9997.0 10913.7 12473.6 12601.1 15117.3 12907.3 12972.2 13114.7 13226.6 13348.2 8344.6 8521.6 13028.7 13464.8 13742.8 8843.0 8898.3 9293.6 9357.1 9366.3 12335.9 12775.5 12788.3 13611.7 13633.7 13714.4 13868.2 14404.2 14437.3 14472.4 11:06:18 INFO - 2015-12-11 11:06:18,130 DEBUG : BROWSER_OUTPUT: 11:06:18 INFO - 2015-12-11 11:06:18,131 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4907.06 Median:6034.39 stddev:2499.13 (41.4%) stddev-sans-first:2490.63 11:06:18 INFO - 2015-12-11 11:06:18,131 DEBUG : BROWSER_OUTPUT: Values: 1202.7 1656.0 1720.2 1740.3 1749.3 6000.7 6738.7 6891.2 6900.6 6909.6 7027.3 7061.6 7134.8 7144.5 7150.7 2074.2 2105.2 2107.5 2107.9 2111.5 2070.8 2082.8 2099.6 2147.6 2150.7 2100.1 2101.3 2106.8 2128.1 2130.7 2106.9 2121.3 2123.1 2128.9 2136.9 2060.3 2078.5 2086.7 2088.6 2090.7 7009.7 7086.5 7101.0 7101.4 7115.0 4116.2 4208.2 4224.3 4226.0 4232.9 2645.3 2657.8 2726.8 2735.5 2754.9 846.3 1581.5 1583.0 1593.2 1640.2 9432.1 9545.0 9551.0 9558.7 9562.3 3774.7 3791.6 3866.4 3869.1 3870.8 7916.6 7921.3 7921.7 7922.8 7932.0 4138.4 4160.3 4162.1 4190.5 4195.8 3253.4 3329.3 3740.6 3805.1 3836.3 3095.6 3146.6 3151.4 3162.7 3176.2 902.4 906.2 908.2 926.7 928.5 989.2 1007.8 1009.8 1065.3 1197.6 6632.1 6655.6 6674.4 6690.9 6693.9 434.2 1096.7 1108.2 1129.4 1160.5 5016.8 5037.0 5152.3 5153.5 5160.9 8274.0 8314.6 8399.2 8414.0 8423.9 8165.7 8372.2 8402.2 8438.1 8466.2 6643.6 6654.6 6719.9 6734.2 6743.7 6199.1 6271.3 6398.7 6424.1 6436.0 7359.5 7516.7 7554.8 7579.2 7662.5 7642.4 7824.6 7835.5 7836.6 7865.7 5023.7 5142.4 6029.9 6084.5 6096.2 6594.1 6656.6 6745.4 6756.6 6768.8 6238.3 6242.4 6279.1 6332.7 6342.0 6158.1 6160.6 6184.3 6238.6 6269.2 6280.5 6365.5 6432.6 6434.4 6463.6 5934.7 5948.7 5972.8 5999.6 6015.5 5969.7 5972.3 6020.5 6026.2 6038.8 11:06:18 INFO - 2015-12-11 11:06:18,132 DEBUG : BROWSER_OUTPUT: 11:06:18 INFO - 2015-12-11 11:06:18,132 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4731.79 Median:5332.57 stddev:1389.23 (26.1%) stddev-sans-first:1352.73 11:06:18 INFO - 2015-12-11 11:06:18,132 DEBUG : BROWSER_OUTPUT: Values: 300.4 309.9 310.8 311.1 314.0 5328.4 5403.4 5428.4 5450.4 5550.3 5336.7 5397.0 5404.4 5412.4 5413.8 3932.5 4027.1 4184.4 4190.7 4192.2 4054.7 4147.0 4169.2 4173.1 4177.6 4114.7 4119.9 4126.2 4130.1 4134.1 3906.7 3981.2 4054.6 4118.8 4147.3 3657.5 3668.1 3685.4 3687.9 3688.4 5099.4 5113.2 5123.2 5125.4 5127.8 4824.8 4841.7 4842.6 4846.2 4855.4 5577.1 5663.9 5664.2 5683.9 5708.1 4025.6 4032.8 4033.3 4035.8 4036.1 5888.7 5991.6 5999.3 5999.4 6001.7 4176.2 4182.0 4182.2 4187.1 4190.4 4086.0 4214.0 4229.3 4247.0 4253.5 4825.3 4827.7 4829.2 4833.3 4834.1 5700.7 5700.9 5707.1 5707.5 5714.0 1480.8 1494.1 1506.6 1506.8 1506.9 1023.6 1024.7 1030.7 1032.2 1062.9 4962.3 4968.0 4973.5 4980.3 4980.4 5877.4 5892.2 5907.3 5911.4 5914.3 4965.2 4967.9 4973.0 4981.2 4983.2 2929.5 3017.6 3127.5 3153.3 3188.9 5541.4 5602.7 5607.2 5627.6 5631.3 6131.2 6140.1 6149.2 6153.6 6153.8 5607.7 5611.9 5614.9 5615.5 5620.6 5822.7 5908.5 5911.4 5934.5 5945.3 5781.0 5786.4 5789.7 5795.6 5798.7 5594.5 5595.0 5600.5 5604.0 5604.8 4110.9 4187.8 4198.2 4201.7 4206.2 5927.0 5928.8 5931.5 5939.3 5945.3 5711.4 5719.1 5719.1 5731.3 5734.9 5716.3 5719.5 5726.8 5728.9 5730.0 5425.5 5607.6 5611.7 5616.3 5622.0 5770.2 5775.9 5776.7 5777.9 5784.2 5395.1 5456.4 5536.3 5612.7 5624.3 11:06:18 INFO - 2015-12-11 11:06:18,132 DEBUG : BROWSER_OUTPUT: 11:06:18 INFO - 2015-12-11 11:06:18,132 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12420.13 Median:490.61 stddev:14150.94 (2884.3%) stddev-sans-first:14163.55 11:06:18 INFO - 2015-12-11 11:06:18,132 DEBUG : BROWSER_OUTPUT: Values: 761.8 770.2 772.0 777.1 789.0 10916.6 11215.9 13318.1 13557.0 13584.7 12962.8 13026.5 13130.7 13132.1 13164.2 634.9 640.2 811.0 818.6 822.3 816.9 819.0 824.8 825.0 825.7 861.3 868.0 868.8 869.1 870.2 656.8 667.7 846.3 857.8 859.9 634.8 635.4 635.5 635.5 635.6 11518.4 11774.8 11813.1 11814.6 11835.4 10838.1 11015.6 11114.6 11319.1 11682.9 9013.0 9632.8 9737.3 9748.6 9960.5 3125.6 3135.7 3152.7 3171.6 3230.3 40503.8 40614.8 40844.8 40890.8 40939.8 9141.2 9553.4 9564.6 9639.1 9648.4 16251.7 16714.7 16757.7 16812.7 16815.4 6251.3 6362.3 6401.0 6480.4 6487.7 3575.5 3679.7 3689.7 3773.9 3798.5 2675.9 2696.8 2697.1 2701.2 2701.7 495.6 496.5 498.9 503.0 503.5 447.7 456.6 485.6 534.2 539.1 7305.8 7598.9 7701.5 7883.1 8034.0 471.5 522.7 523.5 533.4 590.2 3538.2 3627.8 3676.7 3682.8 3826.9 50881.7 50962.2 51308.0 51345.2 51470.0 44031.8 44113.1 44488.6 44703.8 44720.1 41031.4 41348.2 41373.0 41452.4 41717.0 7323.6 7424.7 7774.0 7933.8 8120.8 30858.1 31573.3 31923.4 31924.4 32591.2 40226.2 41742.0 42290.4 42998.4 43562.1 9924.5 9966.8 10004.2 10073.9 10326.6 10820.4 10836.9 10841.8 11145.3 11389.5 9619.2 9709.7 9816.9 9971.2 10180.8 10474.2 10738.7 10795.9 11072.7 11078.3 8209.7 9817.0 10436.2 11093.9 11106.5 8857.0 8918.7 9328.3 9421.6 9434.8 8382.7 8817.7 8819.0 8963.5 9119.6 11:06:18 INFO - 2015-12-11 11:06:18,133 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:06:18 INFO - 2015-12-11 11:06:18,133 DEBUG : BROWSER_OUTPUT: 11:06:18 INFO - 2015-12-11 11:06:18,921 INFO : Browser exited with error code: 0 11:06:18 INFO - 2015-12-11 11:06:18,938 INFO : Completed test dromaeo_css (00:18:38) 11:06:18 INFO - 2015-12-11 11:06:18,938 INFO : Starting test kraken 11:06:18 INFO - 2015-12-11 11:06:18,938 DEBUG : operating with platform_type : linux_ 11:06:18 INFO - 2015-12-11 11:06:18,938 INFO : Initialising browser for kraken test... 11:06:18 INFO - 2015-12-11 11:06:18,944 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKKioQv/profile http://localhost:41783/getInfo.html 11:06:23 INFO - 2015-12-11 11:06:23,221 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:06:23 INFO - 2015-12-11 11:06:23,221 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:06:23 INFO - 2015-12-11 11:06:23,221 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:06:23 INFO - 2015-12-11 11:06:23,221 DEBUG : BROWSER_OUTPUT: __metrics 11:06:23 INFO - 2015-12-11 11:06:23,342 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:06:23 INFO - 2015-12-11 11:06:23,404 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:06:24 INFO - 2015-12-11 11:06:24,614 INFO : Browser initialized. 11:06:24 INFO - 2015-12-11 11:06:24,615 INFO : Running cycle 1/1 for kraken test... 11:06:24 INFO - 2015-12-11 11:06:24,615 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKKioQv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:06:36 INFO - 2015-12-11 11:06:36,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 142577664 11:06:36 INFO - 2015-12-11 11:06:36,621 DEBUG : BROWSER_OUTPUT: 11:06:39 INFO - 2015-12-11 11:06:39,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41783/tests/kraken/driver.html?testName=audio-beat-detection) 11:06:39 INFO - 2015-12-11 11:06:39,815 DEBUG : BROWSER_OUTPUT: RSS: Main: 178929664 11:06:39 INFO - 2015-12-11 11:06:39,815 DEBUG : BROWSER_OUTPUT: 11:06:42 INFO - 2015-12-11 11:06:42,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41783/tests/kraken/driver.html?testName=audio-dft) 11:06:43 INFO - 2015-12-11 11:06:43,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 167505920 11:06:43 INFO - 2015-12-11 11:06:43,142 DEBUG : BROWSER_OUTPUT: 11:06:46 INFO - 2015-12-11 11:06:46,162 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41783/tests/kraken/driver.html?testName=audio-fft) 11:06:46 INFO - 2015-12-11 11:06:46,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 153042944 11:06:46 INFO - 2015-12-11 11:06:46,728 DEBUG : BROWSER_OUTPUT: 11:06:48 INFO - 2015-12-11 11:06:48,752 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41783/tests/kraken/driver.html?testName=audio-oscillator) 11:06:49 INFO - 2015-12-11 11:06:49,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 156024832 11:06:49 INFO - 2015-12-11 11:06:49,325 DEBUG : BROWSER_OUTPUT: 11:06:51 INFO - 2015-12-11 11:06:51,585 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41783/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:06:52 INFO - 2015-12-11 11:06:52,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 156491776 11:06:52 INFO - 2015-12-11 11:06:52,166 DEBUG : BROWSER_OUTPUT: 11:06:55 INFO - 2015-12-11 11:06:55,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41783/tests/kraken/driver.html?testName=imaging-darkroom) 11:06:55 INFO - 2015-12-11 11:06:55,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 158412800 11:06:55 INFO - 2015-12-11 11:06:55,731 DEBUG : BROWSER_OUTPUT: 11:06:59 INFO - 2015-12-11 11:06:59,119 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41783/tests/kraken/driver.html?testName=imaging-desaturate) 11:06:59 INFO - 2015-12-11 11:06:59,700 DEBUG : BROWSER_OUTPUT: RSS: Main: 158212096 11:06:59 INFO - 2015-12-11 11:06:59,700 DEBUG : BROWSER_OUTPUT: 11:07:02 INFO - 2015-12-11 11:07:02,561 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41783/tests/kraken/driver.html?testName=json-parse-financial) 11:07:03 INFO - 2015-12-11 11:07:03,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 158994432 11:07:03 INFO - 2015-12-11 11:07:03,134 DEBUG : BROWSER_OUTPUT: 11:07:04 INFO - 2015-12-11 11:07:04,916 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41783/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:07:05 INFO - 2015-12-11 11:07:05,482 DEBUG : BROWSER_OUTPUT: RSS: Main: 165429248 11:07:05 INFO - 2015-12-11 11:07:05,482 DEBUG : BROWSER_OUTPUT: 11:07:07 INFO - 2015-12-11 11:07:07,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41783/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:07:07 INFO - 2015-12-11 11:07:07,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 166543360 11:07:07 INFO - 2015-12-11 11:07:07,946 DEBUG : BROWSER_OUTPUT: 11:07:10 INFO - 2015-12-11 11:07:10,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41783/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:07:10 INFO - 2015-12-11 11:07:10,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 177864704 11:07:10 INFO - 2015-12-11 11:07:10,631 DEBUG : BROWSER_OUTPUT: 11:07:13 INFO - 2015-12-11 11:07:13,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:07:13 INFO - 2015-12-11 11:07:13,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 181915648 11:07:13 INFO - 2015-12-11 11:07:13,764 DEBUG : BROWSER_OUTPUT: 11:07:16 INFO - 2015-12-11 11:07:16,327 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:07:16 INFO - 2015-12-11 11:07:16,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 180269056 11:07:16 INFO - 2015-12-11 11:07:16,908 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41783/tests/kraken/driver.html?testName=ai-astar) 11:07:18 INFO - 2015-12-11 11:07:18,935 DEBUG : BROWSER_OUTPUT: RSS: Main: 238059520 11:07:18 INFO - 2015-12-11 11:07:18,936 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,939 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:07:18 INFO - 2015-12-11 11:07:18,939 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:07:18 INFO - 2015-12-11 11:07:18,940 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:07:18 INFO - 2015-12-11 11:07:18,940 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:07:18 INFO - 2015-12-11 11:07:18,940 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;114;107;112;113;113;102;112;111;111 11:07:18 INFO - 2015-12-11 11:07:18,940 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;130;159;177;132;154;153;130;165;128 11:07:18 INFO - 2015-12-11 11:07:18,941 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;161;160;161;160;160;161;161;162 11:07:18 INFO - 2015-12-11 11:07:18,941 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;88;91;71;72;72;117;90;72 11:07:18 INFO - 2015-12-11 11:07:18,941 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;134;94;95;95;129;96;96;137 11:07:18 INFO - 2015-12-11 11:07:18,941 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;109;110;109;109;109;109;110 11:07:18 INFO - 2015-12-11 11:07:18,941 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;148;147;147;146;147;146;146 11:07:18 INFO - 2015-12-11 11:07:18,941 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;95;96;96;95;95;96 11:07:18 INFO - 2015-12-11 11:07:18,941 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;72;72;71;72;72;72;79;69;69 11:07:18 INFO - 2015-12-11 11:07:18,942 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;68;68;69;68 11:07:18 INFO - 2015-12-11 11:07:18,942 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;85;86;82;83;83;82;82;82;81 11:07:18 INFO - 2015-12-11 11:07:18,942 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;117;128;136;126;120;127;126;119;126 11:07:18 INFO - 2015-12-11 11:07:18,942 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;145;146;146;145;135;147;144;144;134 11:07:18 INFO - 2015-12-11 11:07:18,942 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;71;69;70;69;69;68;69;69 11:07:18 INFO - 2015-12-11 11:07:18,942 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:07:18 INFO - 2015-12-11 11:07:18,942 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:07:18 INFO - 2015-12-11 11:07:18,942 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,988 11:07:18 INFO - 2015-12-11 11:07:18,943 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:07:18 INFO - 2015-12-11 11:07:18,943 DEBUG : BROWSER_OUTPUT: __startTimestamp1449860838938__endTimestamp 11:07:18 INFO - 2015-12-11 11:07:18,943 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,946 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:07:18 INFO - 2015-12-11 11:07:18,946 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:07:18 INFO - 2015-12-11 11:07:18,946 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,946 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.57 (3.2%) stddev-sans-first:3.78 11:07:18 INFO - 2015-12-11 11:07:18,946 DEBUG : BROWSER_OUTPUT: Values: 110.0 114.0 107.0 112.0 113.0 113.0 102.0 112.0 111.0 111.0 11:07:18 INFO - 2015-12-11 11:07:18,947 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,947 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.90 Median:153.50 stddev:17.08 (11.1%) stddev-sans-first:18.08 11:07:18 INFO - 2015-12-11 11:07:18,947 DEBUG : BROWSER_OUTPUT: Values: 151.0 130.0 159.0 177.0 132.0 154.0 153.0 130.0 165.0 128.0 11:07:18 INFO - 2015-12-11 11:07:18,947 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,947 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 11:07:18 INFO - 2015-12-11 11:07:18,947 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 161.0 160.0 161.0 160.0 160.0 161.0 161.0 162.0 11:07:18 INFO - 2015-12-11 11:07:18,947 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,947 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.70 Median:72.00 stddev:15.00 (20.8%) stddev-sans-first:15.50 11:07:18 INFO - 2015-12-11 11:07:18,947 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 88.0 91.0 71.0 72.0 72.0 117.0 90.0 72.0 11:07:18 INFO - 2015-12-11 11:07:18,948 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,948 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.70 Median:95.00 stddev:18.49 (19.5%) stddev-sans-first:19.12 11:07:18 INFO - 2015-12-11 11:07:18,948 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 134.0 94.0 95.0 95.0 129.0 96.0 96.0 137.0 11:07:18 INFO - 2015-12-11 11:07:18,948 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,948 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 11:07:18 INFO - 2015-12-11 11:07:18,948 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 11:07:18 INFO - 2015-12-11 11:07:18,948 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,948 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 11:07:18 INFO - 2015-12-11 11:07:18,948 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 148.0 147.0 147.0 146.0 147.0 146.0 146.0 11:07:18 INFO - 2015-12-11 11:07:18,948 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,949 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 11:07:18 INFO - 2015-12-11 11:07:18,949 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 11:07:18 INFO - 2015-12-11 11:07:18,949 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,949 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.90 Median:72.00 stddev:2.77 (3.8%) stddev-sans-first:2.92 11:07:18 INFO - 2015-12-11 11:07:18,949 DEBUG : BROWSER_OUTPUT: Values: 71.0 72.0 72.0 71.0 72.0 72.0 72.0 79.0 69.0 69.0 11:07:18 INFO - 2015-12-11 11:07:18,949 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,949 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:07:18 INFO - 2015-12-11 11:07:18,949 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 68.0 68.0 69.0 68.0 11:07:18 INFO - 2015-12-11 11:07:18,949 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,950 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:1.64 (2.0%) stddev-sans-first:1.62 11:07:18 INFO - 2015-12-11 11:07:18,950 DEBUG : BROWSER_OUTPUT: Values: 81.0 85.0 86.0 82.0 83.0 83.0 82.0 82.0 82.0 81.0 11:07:18 INFO - 2015-12-11 11:07:18,950 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,950 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.00 stddev:5.96 (4.7%) stddev-sans-first:5.72 11:07:18 INFO - 2015-12-11 11:07:18,950 DEBUG : BROWSER_OUTPUT: Values: 117.0 117.0 128.0 136.0 126.0 120.0 127.0 126.0 119.0 126.0 11:07:18 INFO - 2015-12-11 11:07:18,950 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,950 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.10 Median:145.00 stddev:5.22 (3.6%) stddev-sans-first:4.86 11:07:18 INFO - 2015-12-11 11:07:18,950 DEBUG : BROWSER_OUTPUT: Values: 135.0 145.0 146.0 146.0 145.0 135.0 147.0 144.0 144.0 134.0 11:07:18 INFO - 2015-12-11 11:07:18,950 DEBUG : BROWSER_OUTPUT: 11:07:18 INFO - 2015-12-11 11:07:18,951 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:0.92 (1.3%) stddev-sans-first:0.87 11:07:18 INFO - 2015-12-11 11:07:18,951 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 71.0 69.0 70.0 69.0 69.0 68.0 69.0 69.0 11:07:18 INFO - 2015-12-11 11:07:18,951 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:07:18 INFO - 2015-12-11 11:07:18,951 DEBUG : BROWSER_OUTPUT: 11:07:19 INFO - 2015-12-11 11:07:19,841 INFO : Browser exited with error code: 0 11:07:19 INFO - 2015-12-11 11:07:19,891 INFO : Completed test kraken (00:01:00) 11:07:19 INFO - 2015-12-11 11:07:19,892 INFO : Starting test v8_7 11:07:19 INFO - 2015-12-11 11:07:19,892 DEBUG : operating with platform_type : linux_ 11:07:19 INFO - 2015-12-11 11:07:19,892 INFO : Initialising browser for v8_7 test... 11:07:19 INFO - 2015-12-11 11:07:19,898 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Sp_ez/profile http://localhost:41783/getInfo.html 11:07:24 INFO - 2015-12-11 11:07:24,802 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:07:24 INFO - 2015-12-11 11:07:24,802 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:07:24 INFO - 2015-12-11 11:07:24,802 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:07:24 INFO - 2015-12-11 11:07:24,802 DEBUG : BROWSER_OUTPUT: __metrics 11:07:24 INFO - 2015-12-11 11:07:24,959 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:07:25 INFO - 2015-12-11 11:07:25,021 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:07:25 INFO - 2015-12-11 11:07:25,869 INFO : Browser initialized. 11:07:25 INFO - 2015-12-11 11:07:25,869 INFO : Running cycle 1/1 for v8_7 test... 11:07:25 INFO - 2015-12-11 11:07:25,870 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4Sp_ez/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:07:37 INFO - 2015-12-11 11:07:37,922 DEBUG : BROWSER_OUTPUT: RSS: Main: 143114240 11:07:37 INFO - 2015-12-11 11:07:37,922 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41783/tests/v8_7/run.html (next: http://localhost:41783/tests/v8_7/run.html) 11:07:59 INFO - 2015-12-11 11:07:59,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 441151488 11:07:59 INFO - 2015-12-11 11:07:59,532 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,532 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:07:59 INFO - 2015-12-11 11:07:59,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:07:59 INFO - 2015-12-11 11:07:59,532 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:07:59 INFO - 2015-12-11 11:07:59,532 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:07:59 INFO - 2015-12-11 11:07:59,532 DEBUG : BROWSER_OUTPUT: |0;Richards;168.03898504453034 11:07:59 INFO - 2015-12-11 11:07:59,532 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.8045336306206 11:07:59 INFO - 2015-12-11 11:07:59,533 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.2516056967328 11:07:59 INFO - 2015-12-11 11:07:59,533 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5181.347150259067 11:07:59 INFO - 2015-12-11 11:07:59,533 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 11:07:59 INFO - 2015-12-11 11:07:59,533 DEBUG : BROWSER_OUTPUT: |5;Earley;780.64012490242 11:07:59 INFO - 2015-12-11 11:07:59,533 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 11:07:59 INFO - 2015-12-11 11:07:59,533 DEBUG : BROWSER_OUTPUT: |7;RegExp;26421.052631578947 11:07:59 INFO - 2015-12-11 11:07:59,533 DEBUG : BROWSER_OUTPUT: |8;Splay;615.3846153846154 11:07:59 INFO - 2015-12-11 11:07:59,533 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 11:07:59 INFO - 2015-12-11 11:07:59,533 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:07:59 INFO - 2015-12-11 11:07:59,534 DEBUG : BROWSER_OUTPUT: __startTimestamp1449860879531__endTimestamp 11:07:59 INFO - 2015-12-11 11:07:59,534 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,534 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:07:59 INFO - 2015-12-11 11:07:59,534 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:07:59 INFO - 2015-12-11 11:07:59,534 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,534 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.04 Median:168.04 stddev:0.00 (0.0%) 11:07:59 INFO - 2015-12-11 11:07:59,535 DEBUG : BROWSER_OUTPUT: Values: 168.0 11:07:59 INFO - 2015-12-11 11:07:59,535 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,535 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.80 Median:185.80 stddev:0.00 (0.0%) 11:07:59 INFO - 2015-12-11 11:07:59,535 DEBUG : BROWSER_OUTPUT: Values: 185.8 11:07:59 INFO - 2015-12-11 11:07:59,535 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.25 Median:279.25 stddev:0.00 (0.0%) 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: Values: 279.3 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5181.35 Median:5181.35 stddev:0.00 (0.0%) 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: Values: 5181.3 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: Values: 1972.4 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:780.64 Median:780.64 stddev:0.00 (0.0%) 11:07:59 INFO - 2015-12-11 11:07:59,537 DEBUG : BROWSER_OUTPUT: Values: 780.6 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: Values: 12219.5 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26421.05 Median:26421.05 stddev:0.00 (0.0%) 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: Values: 26421.1 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.38 Median:615.38 stddev:0.00 (0.0%) 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: Values: 615.4 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: Values: 4826.9 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:07:59 INFO - 2015-12-11 11:07:59,538 DEBUG : BROWSER_OUTPUT: 11:08:00 INFO - 2015-12-11 11:08:00,457 INFO : Browser exited with error code: 0 11:08:00 INFO - 2015-12-11 11:08:00,474 INFO : Completed test v8_7 (00:00:40) 11:08:00 INFO - 2015-12-11 11:08:00,591 INFO : Completed test suite (00:20:19) 11:08:00 INFO - 2015-12-11 11:08:00,591 DEBUG : Working with test: dromaeo_css 11:08:00 INFO - 2015-12-11 11:08:00,591 DEBUG : Generating results file: dromaeo_css 11:08:00 INFO - 2015-12-11 11:08:00,592 DEBUG : Working with test: kraken 11:08:00 INFO - 2015-12-11 11:08:00,592 DEBUG : Generating results file: kraken 11:08:00 INFO - 2015-12-11 11:08:00,593 INFO : javascript benchmark 11:08:00 INFO - 2015-12-11 11:08:00,593 DEBUG : Working with test: v8_7 11:08:00 INFO - 2015-12-11 11:08:00,593 DEBUG : Generating results file: v8_7 11:08:00 INFO - 2015-12-11 11:08:00,593 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:08:00 INFO - 2015-12-11 11:08:00,654 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:08:00 INFO - 2015-12-11 11:08:00,654 DEBUG : process_Request line: dromaeo_css 6407.47 graph.html#tests=[[72,132,35]] 11:08:00 INFO - 2015-12-11 11:08:00,654 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:08:00 INFO - 2015-12-11 11:08:00,692 DEBUG : process_Request line: kraken 1517.60 graph.html#tests=[[232,132,35]] 11:08:00 INFO - 2015-12-11 11:08:00,692 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:08:00 INFO - 2015-12-11 11:08:00,741 DEBUG : process_Request line: v8_7 19815.42 graph.html#tests=[[230,132,35]] 11:08:00 INFO - 2015-12-11 11:08:00,742 INFO : javascript benchmark 11:08:00 INFO - 2015-12-11 11:08:00,745 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2655.34943938735, 2726.9045583404586, 2733.8906443742253, 2736.575830746235, 2751.38093928866, 4473.82104715811, 4598.5401459854, 4679.461861885884, 4721.716696998178, 4729.337892695025, 4594.72431654101, 4659.324397962293, 4776.925191831836, 4783.0, 4784.44978827435, 4306.310990241562, 4339.913201735963, 4384.802683879233, 4409.9118017639785, 4451.065276291983, 4202.411662367271, 4352.347147927804, 4387.9561204387865, 4447.822087116511, 4458.754768487732, 4242.851500197478, 4302.677299202573, 4318.978405107954, 4326.178026175048, 4338.067315527177, 4344.652427805768, 4344.804483798237, 4355.216061108999, 4359.934600980988, 4389.604935555815, 4114.814833332477, 4212.578742125794, 4292.656587472995, 4325.783710814447, 4374.190774706658, 4480.574345437179, 4521.683482156251, 4573.085382923396, 4589.2198326284615, 4623.445186577598, 5024.447310795809, 5082.263071854597, 5086.593072554187, 5095.923561146548, 5146.279520867081, 4888.73111978841, 5014.323066386028, 5101.566366858821, 5108.055009823194, 5113.488651134894, 4488.730676159408, 4574.5425457453985, 4578.656600754956, 4585.862424127282, 4600.263957766741, 5232.738363081907, 5277.551408130275, 5287.07476191665, 5288.206768984606, 5315.0, 5044.646874718808, 5059.848204553869, 5061.7975280989085, 5064.721440320818, 5109.054824857413, 4857.077155340545, 4968.354113965162, 4974.353334066548, 4997.625178111656, 5109.514596113363, 4983.426905905795, 5003.74981250936, 5004.84985450437, 5005.549500544896, 5053.418856831511, 4980.726060066731, 4983.551480366785, 4987.80048798044, 4991.825286115041, 5036.169032109734, 4057.4522439470293, 4117.0, 4173.791310434527, 4272.9359059614135, 4276.0, 3681.3557627415094, 3718.7768733876055, 3719.0330514065995, 3760.2855457462992, 3760.9059773505883, 4336.826526938887, 4349.325854492558, 4351.0, 4365.934510982338, 4384.0, 4792.832250871203, 4921.0, 4935.654504184673, 5012.974935125301, 5121.1550094234035, 4305.763183024964, 4357.477102747691, 4378.5183629800695, 4382.956170438319, 4422.314541246112, 4512.548745125527, 4523.683342166082, 4527.524609915978, 4527.9547204527535, 4576.244919588297, 4613.700109492872, 4722.433308003062, 4755.048990201904, 4764.380630518011, 4829.975850120797, 5120.871978200575, 5126.231065340229, 5137.972405518986, 5141.331626888481, 5148.562372198405, 4845.030993801324, 4854.368932038812, 4854.854354369375, 4859.781309840995, 4893.168161412639, 4785.976070119627, 4833.830815921426, 4901.264810278487, 4910.263460480956, 5103.18349064148, 5096.719680417613, 5104.336436263262, 5106.46382129871, 5106.5404113628465, 5109.489051094861, 4948.257761335828, 4950.257461380822, 4951.653384263067, 4955.752212389438, 4995.050940321327, 4686.671932964659, 4748.548887855648, 4794.0, 4852.0295940811275, 4939.209726443752, 4872.6832755870755, 4877.317175595491, 4884.9985752921275, 4886.975565122151, 4892.779824907817, 4996.475370086088, 5000.799968001239, 5003.249512573143, 5028.64799464034, 5042.268871013609, 4723.197056500335, 4755.453122890912, 4868.586170175575, 4886.877828054327, 4887.144749668722], "unit": "ms", "name": "dojo.html", "value": 4627.375381454666}, {"lowerIsBetter": false, "replicates": [566.0970751651116, 570.492261886921, 574.0556784090172, 578.4562511239435, 602.8673691787806, 26700.465990680175, 35389.64610353896, 35987.28025439493, 36024.459633105456, 36056.45915311272, 40286.19427611446, 40771.0, 40806.18387632246, 40930.38604420936, 40931.386029209585, 7090.220075791659, 7224.891626625605, 7848.68605255789, 8068.031836179637, 8075.394345424087, 7206.963965180167, 9998.800023999516, 10200.540975656077, 10224.642137525188, 10232.846507302396, 9758.072983066597, 9910.752231194207, 9920.950395248014, 9924.603015879393, 9930.553125109387, 7116.9288307116785, 7290.81772955675, 9958.90041099587, 10079.546420411025, 10087.243456740736, 10105.292629515938, 10371.844422333672, 10397.532111055021, 10398.740031499197, 10400.271980961335, 37682.81158594217, 38142.80928595339, 38149.61850381488, 38235.0, 38235.808820955994, 2916.387558612673, 2946.4254470378287, 3050.603421555206, 3213.855376508063, 3551.5383000210068, 28223.177682231817, 28326.15021549357, 28502.0, 28715.0, 28817.135485935454, 3188.601424821897, 3271.1495011296997, 3277.147941535194, 3363.9495407568907, 3384.0524653097173, 203641.0, 205023.0, 205167.0, 205623.0, 205941.0, 46494.767526162155, 54244.18633720497, 54642.180367294524, 54645.453545464035, 54660.2606726288, 39554.60445395509, 63176.68411658004, 66290.33709662939, 66331.66834165798, 66360.6681966587, 13007.219566826021, 13201.801972970414, 13227.0, 13238.470461181638, 13243.867561324456, 9693.563789629483, 9704.369216000938, 9755.804883902425, 9759.414435133915, 9765.023497650178, 18686.813131868777, 18829.435116946515, 18868.339608113925, 18945.526361841064, 18951.62096758057, 7011.6143612100805, 7337.486375953632, 7340.743073992385, 7352.96323518379, 7373.631318434057, 835.6907944060737, 872.284726524244, 901.5447199164511, 939.1266122506134, 1052.5211028981794, 25806.0, 26300.21099367022, 26741.331466713487, 26765.464690706078, 26768.59847102295, 932.9813403732023, 946.1673727120091, 976.2873102635116, 984.1192133040888, 1067.6796960911695, 13141.279989618639, 13426.194428334331, 13639.454421823017, 13642.795358069638, 13676.658083547793, 249211.0, 250455.0, 252213.0, 253395.0, 253683.0, 46114.769426152656, 46448.07103857904, 46473.30290045652, 46505.53494465012, 46528.30207546889, 1222.9510819567117, 1236.1779416687802, 1237.220551052849, 1251.3367915005063, 1253.154120968361, 22199.556008880056, 24951.87524062368, 25321.87339063293, 25821.483570328863, 27214.183574492796, 40300.0, 40769.59230407658, 41001.79499102486, 41028.17943641051, 41082.79458602688, 195709.0, 195992.0, 197138.0, 197175.0, 197778.0, 24859.254222373358, 25547.23358299254, 26355.341116472242, 26365.736342636326, 26756.866215668797, 33700.32599348048, 34096.31807363888, 34242.65757342494, 34517.0, 38135.237295253384, 29419.0, 29617.407651847272, 29788.55317170201, 30200.54699179558, 30378.696213037587, 29778.70221297846, 29936.85031574828, 29939.251518712208, 29979.0, 29992.4001519964, 32116.03651890447, 33209.50185747264, 33671.663283366855, 33759.83120084384, 33782.15544611306, 25522.23433297004, 29329.266768330963, 29482.557761633165, 30173.396532069673, 30570.84714576502, 21589.13643454244, 21787.891060544596, 23714.762852371947, 23717.762822372246, 24198.274051778473], "unit": "ms", "name": "ext.html", "value": 16761.00415803476}, {"lowerIsBetter": false, "replicates": [331.52757320817835, 333.98831040913575, 336.0355778914514, 337.08145304046474, 340.39239956677335, 12215.755684886297, 12440.25358478492, 15159.545213643594, 15404.428648443585, 16595.58511037223, 12180.0, 14681.632959175999, 15440.69118617627, 16111.0333379997, 16157.192140392963, 4856.7571621418965, 4933.309336692866, 4950.801967921278, 4972.975135124319, 5073.061483625523, 3398.4052790761516, 3507.2108775525558, 4938.703677779345, 6233.7818176363835, 6430.7106180222, 6333.429991300782, 6340.334264902188, 6361.536846525302, 6418.101465794793, 6423.229212494507, 6417.0, 6463.289038205794, 6463.773767918124, 6465.3534646535445, 6467.870642587145, 6027.608205466675, 6104.053871649901, 6194.659293738842, 6243.75024999004, 6249.312575616678, 18803.341883034165, 18877.90561047186, 19568.412947611596, 20247.190112395485, 20629.690554641544, 1988.2245924089616, 1998.6902030185345, 2027.1891243502569, 2046.98976505118, 2055.1368425261426, 12830.294333811637, 12956.80564791529, 13031.804522932163, 13081.215127092404, 13502.932485337511, 1742.1724680776656, 1839.4297767691924, 1852.4164888060218, 1854.3695143651223, 1866.925322987079, 49774.7511262445, 49851.25223121656, 51889.0, 60867.39132608662, 61575.07637385443, 14591.708165836624, 15157.877897094415, 15189.0, 15234.619134521725, 15254.08475491474, 22175.223867164572, 22226.222082227043, 22426.55146897053, 22448.887755561118, 22458.775412245996, 7940.325072368913, 8000.279974802295, 8046.0, 8131.430799844073, 8149.551774652451, 6837.38463538274, 6893.379595836399, 6912.654367281616, 6913.3777959983845, 6941.479389045841, 6661.134052573135, 7561.2060733622175, 7575.128860181149, 7581.166071732105, 7598.240175982358, 2494.3639371960035, 2962.259435141215, 2967.6438827340426, 3012.6987301269696, 3023.319753055589, 759.9962000189963, 764.75910088322, 831.5717405536154, 871.9128087191357, 964.6141543382703, 12641.620751377473, 14558.563243102724, 14963.70072598542, 15091.698166036618, 15544.76682849758, 794.2018271637083, 813.6826637611337, 838.6142374507795, 851.1956201389627, 880.3397451911067, 8664.913350866536, 8787.384883058252, 8826.205641492297, 8870.334724895658, 9019.864702029476, 427063.0, 434230.0, 439259.0, 454459.0, 456031.0, 63769.68115159395, 66173.33826661768, 67548.0, 67871.3212867865, 68012.31987680159, 1045.2213101239624, 1052.3633201912885, 1110.0841805510486, 1121.0527104596765, 1122.5117074072805, 13715.740602066955, 13747.450101995808, 13975.161490310615, 14127.717445651235, 14248.64378390507, 32523.186920326236, 32903.506447402826, 32923.50614740733, 33607.15982100369, 33744.15639609029, 43734.78132609444, 43914.78042609766, 44550.10899781921, 45971.77014114908, 47101.764491177324, 8297.460665056751, 8648.56757162152, 8742.825143496968, 8743.950725912931, 8748.906386701663, 9997.0, 10913.686714742587, 12473.625791226277, 12601.11792174539, 15117.319720612819, 12907.290099044643, 12972.156809807333, 13114.672133196746, 13226.603201903958, 13348.199108053548, 8344.582770861554, 8521.573921304034, 13028.674283142997, 13464.798028029392, 13742.793858091936, 8843.0, 8898.288136949159, 9293.581788819383, 9357.06429357059, 9366.250699943852, 12335.938320308342, 12775.48898044105, 12788.296643684687, 13611.727765444833, 13633.727325453237, 13714.38285277145, 13868.167909925436, 14404.207768572829, 14437.278136092944, 14472.421103156177], "unit": "ms", "name": "jquery.html", "value": 8899.485153200645}, {"lowerIsBetter": false, "replicates": [1202.711349276173, 1655.9503214903552, 1720.1571230097247, 1740.3299729604103, 1749.3439960014994, 6000.729967151483, 6738.663066846662, 6891.24196338403, 6900.6204658743745, 6909.550879192849, 7027.262137475568, 7061.646917654122, 7134.75028374007, 7144.499885008038, 7150.678219480123, 2074.159965214083, 2105.231590469483, 2107.473131717071, 2107.862988905724, 2111.4721319670084, 2070.7722150563427, 2082.83337333013, 2099.6010757956014, 2147.6456384696507, 2150.666646669769, 2100.0759665747023, 2101.264557404904, 2106.7787882272296, 2128.138104067855, 2130.7336582927132, 2106.8630539014994, 2121.299971009571, 2123.108294516307, 2128.946776330589, 2136.861104028241, 2060.3406909788873, 2078.490769761403, 2086.6765651324067, 2088.634488964425, 2090.7386576677914, 7009.719611215545, 7086.468514861406, 7100.964495177543, 7101.431885449152, 7114.964425177893, 4116.176764647083, 4208.242516347056, 4224.302990006645, 4225.9577404226175, 4232.915341693149, 2645.3122188231005, 2657.840529568213, 2726.82275652082, 2735.466584016118, 2754.903578374767, 846.2764336492334, 1581.4896773581202, 1582.9604259893595, 1593.1556275174175, 1640.2208950748418, 9432.103950124796, 9544.95227523865, 9551.0, 9558.665446709332, 9562.330636855422, 3774.698024158061, 3791.5829258781514, 3866.3813789794062, 3869.0520822398694, 3870.8064596770614, 7916.564588947663, 7921.32668723165, 7921.683132674629, 7922.762317130495, 7932.0, 4138.358554424069, 4160.334346504545, 4162.146759914211, 4190.455240818674, 4195.846142310828, 3253.430649636304, 3329.3008468221947, 3740.551133863954, 3805.1438426353848, 3836.271108489378, 3095.582096417, 3146.5594816725675, 3151.401233765577, 3162.7311678507126, 3176.2059485128716, 902.4359775140537, 906.1527471813876, 908.2053203446984, 926.7080869526078, 928.4707716601607, 989.2333441582831, 1007.7682133109425, 1009.8333774927202, 1065.307550092446, 1197.6167626359656, 6632.071509988606, 6655.633940133339, 6674.365935236145, 6690.866182676319, 6693.933060669331, 434.2379124636243, 1096.736783172049, 1108.2020944919645, 1129.4239937631867, 1160.4545863444168, 5016.849494515171, 5037.042961837239, 5152.252923326097, 5153.5361817436615, 5160.8967820643375, 8273.958630206811, 8314.584270786436, 8399.244068033906, 8414.032386275534, 8423.915760842436, 8165.673373065011, 8372.246497815226, 8402.159784021671, 8438.113998030241, 8466.238038576557, 6643.56816806906, 6654.567453115532, 6719.932800671931, 6734.158230221223, 6743.696533656095, 6199.1011303361665, 6271.278802937721, 6398.680065996775, 6424.068510066108, 6436.034594810816, 7359.521631093961, 7516.699332026657, 7554.848903022019, 7579.204183560867, 7662.463627546018, 7642.350400216044, 7824.569648669378, 7835.49069310493, 7836.647350869111, 7865.685372585032, 5023.748812559431, 5142.382914050338, 6029.939700602938, 6084.482818960438, 6096.207493025879, 6594.142761440982, 6656.600603963584, 6745.3591908768585, 6756.594604323756, 6768.796936091925, 6238.282597501346, 6242.406971337716, 6279.1209230708655, 6332.651704156316, 6342.0, 6158.137860699416, 6160.630362178284, 6184.319724830175, 6238.625682459067, 6269.153664255267, 6280.528960328085, 6365.490760739222, 6432.646204458612, 6434.388733070351, 6463.612183269019, 5934.673592952429, 5948.732307046107, 5972.790952316648, 5999.550033747573, 6015.488683461955, 5969.671668058125, 5972.343042265435, 6020.51835853122, 6026.186464827368, 6038.84902877414], "unit": "ms", "name": "mootools.html", "value": 4081.4028106090045}, {"lowerIsBetter": false, "replicates": [300.4081958541673, 309.8683059699629, 310.7762411064036, 311.14280158164263, 313.9874405023799, 5328.440513746054, 5403.432639572842, 5428.430014848438, 5450.427705090968, 5550.306211723535, 5336.706481143536, 5397.0, 5404.378496472907, 5412.404635490093, 5413.756380962856, 3932.508436445444, 4027.0737730322044, 4184.435101261336, 4190.7485550866895, 4192.24539582875, 4054.736442131267, 4146.963259185204, 4169.228692691861, 4173.061061261223, 4177.644900183473, 4114.670826333886, 4119.938200926988, 4126.236646220459, 4130.132672138854, 4134.069834287291, 3906.6679332256936, 3981.163955569334, 4054.6148115929236, 4118.794060296988, 4147.294959856831, 3657.482144909859, 3668.0829792551863, 3685.3919103347916, 3687.870924517629, 3688.3729765939856, 5099.413567439755, 5113.156329205676, 5123.2315152727015, 5125.410577783566, 5127.7948882044675, 4824.831130910401, 4841.7337046462435, 4842.564169224752, 4846.176150054499, 4855.441624213226, 5577.107662773937, 5663.943360566424, 5664.178694089375, 5683.857903552403, 5708.115242137475, 4025.5974402559805, 4032.8386864525382, 4033.334499807528, 4035.8385664573384, 4036.0717035082093, 5888.676122813244, 5991.580589358747, 5999.280086389574, 5999.430054144849, 6001.729922153513, 4176.227397931392, 4182.0, 4182.163567286555, 4187.14163596462, 4190.350495673176, 4085.9591404086173, 4214.030772922184, 4229.2598795210715, 4247.023184667543, 4253.532111467736, 4825.348577942003, 4827.710337379768, 4829.227323628203, 4833.250846118857, 4834.081524510332, 5700.743466544015, 5700.8859822803315, 5707.0583353747, 5707.514861236758, 5713.971430142823, 1480.8074950256614, 1494.0811400988314, 1506.5555661080007, 1506.7890495330662, 1506.8568485993812, 1023.5649848814224, 1024.7335692719946, 1030.7062487191115, 1032.2413026425722, 1062.9468526573794, 4962.280469331927, 4967.950320496821, 4973.452920178777, 4980.302757613937, 4980.352554167935, 5877.38287479817, 5892.234009578728, 5907.261592300963, 5911.40885911414, 5914.319853216849, 4965.230389289666, 4967.90064198714, 4973.0, 4981.227909674007, 4983.202687569971, 2929.516629756109, 3017.5775391445213, 3127.499600063979, 3153.30627262002, 3188.8724451022163, 5541.445855414427, 5602.691851948182, 5607.243022192033, 5627.634203776742, 5631.267935168402, 6131.233595800525, 6140.078988151813, 6149.200603921461, 6153.600015999035, 6153.784617538365, 5607.7476513556985, 5611.887762244733, 5614.859628509238, 5615.494605485526, 5620.634658747168, 5822.650640961556, 5908.527317814479, 5911.408859114054, 5934.495567876779, 5945.256842894638, 5781.0, 5786.392428794916, 5789.710514474175, 5795.594308398372, 5798.652080875161, 5594.468525490072, 5594.964931487688, 5600.523955463831, 5604.047311956896, 5604.8318550443555, 4110.91778164441, 4187.790610469525, 4198.202341555095, 4201.684873634551, 4206.17979494008, 5926.970365148319, 5928.762849486145, 5931.525477961839, 5939.316978547522, 5945.346011938596, 5711.429356926712, 5719.056355701429, 5719.142128680731, 5731.283589551306, 5734.942650573441, 5716.256886604715, 5719.542436604978, 5726.770929162787, 5728.942710572841, 5730.025895597842, 5425.457454254701, 5607.635503692247, 5611.74747136388, 5616.297962754656, 5622.044252477171, 5770.192173095686, 5775.884482310415, 5776.7111644418455, 5777.8555536111935, 5784.190213370048, 5395.136778115482, 5456.399796022513, 5536.252605898152, 5612.663240205601, 5624.325080990144], "unit": "ms", "name": "prototype.html", "value": 4288.769476741049}, {"lowerIsBetter": false, "replicates": [761.8171638806687, 770.2066871122742, 771.9807004824883, 777.0558771093121, 788.992110078899, 10916.563337466501, 11215.943920280397, 13318.13432126911, 13556.98322625802, 13584.728305433886, 12962.80555791664, 13026.478940842355, 13130.671733206675, 13132.146410483336, 13164.210147391163, 634.8793729191462, 640.1645852162949, 810.9716159934418, 818.6357071103362, 822.2928281677753, 816.873384625384, 819.0335404223015, 824.756696774453, 824.9628766705513, 825.686239229092, 861.2593169873903, 867.9783005424852, 868.8088620503511, 869.0917990699734, 870.2168048756107, 656.7865443730783, 667.7262322447822, 846.2848892685671, 857.7941294089436, 859.8925134358205, 634.7873462390105, 635.4281146967766, 635.5170070746266, 635.5265327331122, 635.586868535451, 11518.36648984314, 11774.764504709943, 11813.1140164488, 11814.586489472827, 11835.408229588485, 10838.078763305128, 11015.614453494169, 11114.61098861544, 11319.094472442184, 11682.883171168265, 9013.0, 9632.807343853154, 9737.318387712863, 9748.610055597768, 9960.452175130366, 3125.624925008991, 3135.749140068789, 3152.7162555369896, 3171.63526194486, 3230.2731885325616, 40503.79748101241, 40614.79692601548, 40844.774656760346, 40890.795546022375, 40939.7953010236, 9141.222996045277, 9553.42679439222, 9564.61741530331, 9639.084286992724, 9648.421094734338, 16251.674966500605, 16714.6657066858, 16757.748633770505, 16812.663746724997, 16815.41146059882, 6251.28110267316, 6362.331955144736, 6401.007843784221, 6480.384363485461, 6487.740490380332, 3575.481555174485, 3679.742418030712, 3689.7232707546505, 3773.867914622975, 3798.4682144499793, 2675.9331016724736, 2696.8381897086238, 2697.082991782764, 2701.162639581736, 2701.7433343832304, 495.61342153120626, 496.493576551915, 498.94761050089943, 502.979880804771, 503.4889587069128, 447.6530688716271, 456.6369736059774, 485.61393692014934, 534.156033467121, 539.075485542289, 7305.780826575105, 7598.924010759822, 7701.499402538817, 7883.054033516015, 8033.959830200812, 471.5143402295641, 522.6968358352146, 523.5392854288202, 533.4292307231225, 590.1825971030069, 3538.203904121552, 3627.764195327295, 3676.7426280160666, 3682.834272457746, 3826.9043273918373, 50881.74559127181, 50962.23556646653, 51308.0, 51345.229821552704, 51470.0, 44031.779841100586, 44113.11773764571, 44488.55511444844, 44703.77648111804, 44720.10559788851, 41031.384529232084, 41348.1730365397, 41373.0, 41452.37821432621, 41717.0, 7323.560586364835, 7424.740134095281, 7774.0, 7933.809928510539, 8120.83758324842, 30858.074257772303, 31573.268325823392, 31923.36153276968, 31924.36151277008, 32591.18522036968, 40226.17851304122, 41742.0, 42290.36564451474, 42998.35502467528, 43562.12875742531, 9924.503774811375, 9966.800663986825, 10004.24968127408, 10073.949630251802, 10326.586936522455, 10820.350778953289, 10836.945815270874, 10841.837372439262, 11145.331280123219, 11389.544418223179, 9619.18236949867, 9709.70870873875, 9816.85274720894, 9971.202303815533, 10180.796384072426, 10474.162067034467, 10738.677839664822, 10795.866434024629, 11072.723181920517, 11078.279911805706, 8209.71266005687, 9816.950915245663, 10436.165106791286, 11093.889061109285, 11106.500207490844, 8857.0, 8918.73243802687, 9328.347015709107, 9421.62313507452, 9434.811303774024, 8382.695208318639, 8817.727347640184, 8818.955905220433, 8963.462192268486, 9119.635214591342], "unit": "ms", "name": "yui.html", "value": 5727.039375493092}], "name": "dromaeo_css", "value": 6407.4647597602625}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 107.0, 112.0, 113.0, 113.0, 102.0, 112.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [151.0, 130.0, 159.0, 177.0, 132.0, 154.0, 153.0, 130.0, 165.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.9}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 161.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 160.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 88.0, 91.0, 71.0, 72.0, 72.0, 117.0, 90.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 134.0, 94.0, 95.0, 95.0, 129.0, 96.0, 96.0, 137.0], "unit": "ms", "name": "audio-oscillator", "value": 106.7}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 148.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 71.0, 72.0, 72.0, 72.0, 79.0, 69.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 71.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [81.0, 85.0, 86.0, 82.0, 83.0, 83.0, 82.0, 82.0, 82.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 128.0, 136.0, 126.0, 120.0, 127.0, 126.0, 119.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [135.0, 145.0, 146.0, 146.0, 145.0, 135.0, 147.0, 144.0, 144.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 142.1}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 71.0, 69.0, 70.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1517.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.03898504453034], "unit": "score", "name": "Richards", "value": 210.08220199999997}, {"lowerIsBetter": false, "replicates": [185.8045336306206], "unit": "score", "name": "DeltaBlue", "value": 355.8470759999999}, {"lowerIsBetter": false, "replicates": [279.2516056967328], "unit": "score", "name": "Encrypt", "value": 953.1941609999996}, {"lowerIsBetter": false, "replicates": [5181.347150259067], "unit": "score", "name": "Decrypt", "value": 51.372933}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [780.64012490242], "unit": "score", "name": "Earley", "value": 853.7391030000001}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [26421.052631578947], "unit": "score", "name": "RegExp", "value": 34.47951195219122}, {"lowerIsBetter": false, "replicates": [615.3846153846154], "unit": "score", "name": "Splay", "value": 132.42287499999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19815.420482019697}]} 11:08:00 INFO - RETURN: dromaeo_css: 6407.47 11:08:00 INFO - RETURN: kraken: 1517.60 11:08:00 INFO - RETURN: v8_7: 19815.42 11:08:00 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19815.42"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1517.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6407.47"}}} 11:08:00 INFO - Return code: 0 11:08:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:08:00 INFO - # TBPL SUCCESS # 11:08:00 INFO - Running post-action listener: _resource_record_post_action 11:08:00 INFO - Running post-run listener: _resource_record_post_run 11:08:01 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 4096; Write bytes: 516759552; Read time: 20; Write time: 666196 11:08:01 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 243232768; Read time: 0; Write time: 416084 11:08:01 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 4096; Write bytes: 273526784; Read time: 20; Write time: 250112 11:08:01 INFO - Running post-run listener: _upload_blobber_files 11:08:01 INFO - Blob upload gear active. 11:08:01 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:08:01 INFO - Copying logs to upload dir... 11:08:01 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.578277 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-11 11:08:01.558178) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 11:08:01.561734) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010083 build_url: 'https://queue.taskcluster.net/v1/task/UPPfzHs6Qeez3fOiym1Wwg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 11:08:01.613635) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:08:01.614018) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1449857388.6770-819076963 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004811 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 11:08:01.664185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 11:08:01.664503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 11:08:01.664793) ========= ========= Total master_lag: 0.27 =========