builder: cedar_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-017 starttime: 1449186818.11 results: success (0) buildid: 20151203144642 builduid: 9567c679381b4069b8fd094e22fab1f9 revision: 3150c768471cf5800888c009a0f3ed8d752e7038 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.113584) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.114793) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.115293) ========= 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=6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006319 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.143420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.143771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.166299) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.166635) ========= 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=6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004636 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.216503) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.216905) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.217375) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.217735) ========= 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=6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-03 15:53:38-- 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% 228M=0s 2015-12-03 15:53:38 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.191110 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.421871) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.422191) ========= 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=6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020271 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.471947) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:38.472327) ========= bash -c 'python archiver_client.py mozharness --repo projects/cedar --rev 3150c768471cf5800888c009a0f3ed8d752e7038 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/cedar --rev 3150c768471cf5800888c009a0f3ed8d752e7038 --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=6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-03 15:53:38,708 truncating revision to first 12 chars 2015-12-03 15:53:38,708 Setting DEBUG logging. 2015-12-03 15:53:38,708 attempt 1/10 2015-12-03 15:53:38,708 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/cedar/3150c768471c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-03 15:53:38,957 unpacking tar archive at: cedar-3150c768471c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.523683 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:39.009856) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:39.010262) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:39.018246) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:39.018633) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/default ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-03 15:53:39.019092) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-03 15:53:39.019383) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 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', 'Cedar', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Cedar'] 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=6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:53:39 INFO - MultiFileLogger online at 20151203 15:53:39 in /builds/slave/test 15:53:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Cedar --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Cedar 15:53:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:53:39 INFO - {'append_to_log': False, 15:53:39 INFO - 'base_work_dir': '/builds/slave/test', 15:53:39 INFO - 'blob_upload_branch': 'Cedar', 15:53:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:53:39 INFO - 'branch': 'Cedar', 15:53:39 INFO - 'buildbot_json_path': 'buildprops.json', 15:53:39 INFO - 'config_files': ('talos/linux_config.py',), 15:53:39 INFO - 'default_actions': ('clobber', 15:53:39 INFO - 'read-buildbot-config', 15:53:39 INFO - 'download-and-extract', 15:53:39 INFO - 'populate-webroot', 15:53:39 INFO - 'create-virtualenv', 15:53:39 INFO - 'install', 15:53:39 INFO - 'run-tests'), 15:53:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:53:39 INFO - 'download_minidump_stackwalk': True, 15:53:39 INFO - 'download_symbols': 'ondemand', 15:53:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:53:39 INFO - 'tooltool.py': '/tools/tooltool.py', 15:53:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:53:39 INFO - '/tools/misc-python/virtualenv.py')}, 15:53:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:53:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:53:39 INFO - 'installer_path': 'installer.exe', 15:53:39 INFO - 'log_level': 'info', 15:53:39 INFO - 'log_name': 'talos', 15:53:39 INFO - 'log_to_console': True, 15:53:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:53:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:53:39 INFO - 'opt_config_files': (), 15:53:39 INFO - 'pip_index': False, 15:53:39 INFO - 'sps_profile': False, 15:53:39 INFO - 'sps_profile_interval': 0, 15:53:39 INFO - 'suite': 'dromaeojs', 15:53:39 INFO - 'system_bits': '64', 15:53:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:53:39 INFO - 'title': 'talos-linux64-ix-017', 15:53:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:53:39 INFO - 'use_talos_json': True, 15:53:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:53:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:53:39 INFO - 'work_dir': 'build'} 15:53:39 INFO - ##### 15:53:39 INFO - ##### Running clobber step. 15:53:39 INFO - ##### 15:53:39 INFO - Running pre-action listener: _resource_record_pre_action 15:53:39 INFO - Running main action method: clobber 15:53:39 INFO - rmtree: /builds/slave/test/build 15:53:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:53:40 INFO - Running post-action listener: _resource_record_post_action 15:53:40 INFO - ##### 15:53:40 INFO - ##### Running read-buildbot-config step. 15:53:40 INFO - ##### 15:53:40 INFO - Running pre-action listener: _resource_record_pre_action 15:53:40 INFO - Running main action method: read_buildbot_config 15:53:40 INFO - Using buildbot properties: 15:53:40 INFO - { 15:53:40 INFO - "properties": { 15:53:40 INFO - "buildnumber": 5, 15:53:40 INFO - "product": "firefox", 15:53:40 INFO - "script_repo_revision": "default", 15:53:40 INFO - "builddir": "cedar_ubuntu64_hw_test-dromaeojs", 15:53:40 INFO - "repository": "", 15:53:40 INFO - "buildername": "Ubuntu HW 12.04 x64 cedar talos dromaeojs", 15:53:40 INFO - "buildid": "20151203144642", 15:53:40 INFO - "slavename": "talos-linux64-ix-017", 15:53:40 INFO - "pgo_build": "False", 15:53:40 INFO - "basedir": "/builds/slave/test", 15:53:40 INFO - "project": "", 15:53:40 INFO - "platform": "ubuntu64_hw", 15:53:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:53:40 INFO - "slavebuilddir": "test", 15:53:40 INFO - "scheduler": "tests-cedar-linux64-talos", 15:53:40 INFO - "branch": "cedar", 15:53:40 INFO - "repo_path": "projects/cedar", 15:53:40 INFO - "stage_platform": "linux64", 15:53:40 INFO - "builduid": "9567c679381b4069b8fd094e22fab1f9", 15:53:40 INFO - "revision": "3150c768471cf5800888c009a0f3ed8d752e7038" 15:53:40 INFO - }, 15:53:40 INFO - "sourcestamp": { 15:53:40 INFO - "repository": "", 15:53:40 INFO - "hasPatch": false, 15:53:40 INFO - "project": "", 15:53:40 INFO - "branch": "cedar-linux64-talos", 15:53:40 INFO - "changes": [ 15:53:40 INFO - { 15:53:40 INFO - "category": null, 15:53:40 INFO - "files": [ 15:53:40 INFO - { 15:53:40 INFO - "url": null, 15:53:40 INFO - "name": "https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:53:40 INFO - } 15:53:40 INFO - ], 15:53:40 INFO - "repository": "", 15:53:40 INFO - "rev": "3150c768471cf5800888c009a0f3ed8d752e7038", 15:53:40 INFO - "who": "nalexander@mozilla.com", 15:53:40 INFO - "when": 1449186793, 15:53:40 INFO - "number": 6741468, 15:53:40 INFO - "comments": "Bug 1214362 - Enable DOM push API in Fennec Nightly. r?mfinkle", 15:53:40 INFO - "project": "", 15:53:40 INFO - "at": "Thu 03 Dec 2015 15:53:13", 15:53:40 INFO - "branch": "cedar-linux64-talos", 15:53:40 INFO - "revlink": "", 15:53:40 INFO - "properties": [ 15:53:40 INFO - [ 15:53:40 INFO - "buildid", 15:53:40 INFO - "20151203144642", 15:53:40 INFO - "Change" 15:53:40 INFO - ], 15:53:40 INFO - [ 15:53:40 INFO - "builduid", 15:53:40 INFO - "9567c679381b4069b8fd094e22fab1f9", 15:53:40 INFO - "Change" 15:53:40 INFO - ], 15:53:40 INFO - [ 15:53:40 INFO - "pgo_build", 15:53:40 INFO - "False", 15:53:40 INFO - "Change" 15:53:40 INFO - ] 15:53:40 INFO - ], 15:53:40 INFO - "revision": "3150c768471cf5800888c009a0f3ed8d752e7038" 15:53:40 INFO - } 15:53:40 INFO - ], 15:53:40 INFO - "revision": "3150c768471cf5800888c009a0f3ed8d752e7038" 15:53:40 INFO - } 15:53:40 INFO - } 15:53:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:53:40 INFO - Running post-action listener: _resource_record_post_action 15:53:40 INFO - ##### 15:53:40 INFO - ##### Running download-and-extract step. 15:53:40 INFO - ##### 15:53:40 INFO - Running pre-action listener: _resource_record_pre_action 15:53:40 INFO - Running main action method: download_and_extract 15:53:40 INFO - mkdir: /builds/slave/test/build/tests 15:53:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:40 INFO - https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:53:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/test_packages.json 15:53:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/test_packages.json 15:53:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:53:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:53:42 INFO - Downloaded 1302 bytes. 15:53:42 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:53:42 INFO - Using the following test package requirements: 15:53:42 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:53:42 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:53:42 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:42 INFO - u'jsshell-linux-x86_64.zip'], 15:53:42 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:53:42 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:53:42 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:53:42 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:53:42 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:53:42 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:53:42 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:53:42 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:53:42 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:42 INFO - https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:53:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:53:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/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 15:53:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/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 15:53:44 INFO - Downloaded 21793389 bytes. 15:53:44 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 15:53:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:53:44 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 15:53:45 INFO - Return code: 0 15:53:45 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 15:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:45 INFO - https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:53:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:53:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:53:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/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 15:53:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/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 15:53:47 INFO - Downloaded 21793389 bytes. 15:53:47 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 15:53:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:53:47 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 15:53:48 INFO - Return code: 0 15:53:48 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')]} 15:53:48 INFO - https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:53:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:53:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:53:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/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 15:53:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/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 15:53:49 INFO - Downloaded 11132001 bytes. 15:53:49 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 15:53:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:53:49 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 15:53:50 INFO - Return code: 0 15:53:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:50 INFO - https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:53:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:53:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:53:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/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 15:53:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/gzglTxweSgqQIwIW5GDLSw/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 15:53:52 INFO - Downloaded 57678737 bytes. 15:53:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:53:52 INFO - mkdir: /builds/slave/test/properties 15:53:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:52 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:52 INFO - Contents: 15:53:52 INFO - build_url:https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:53:52 INFO - Running post-action listener: _resource_record_post_action 15:53:52 INFO - Running post-action listener: set_extra_try_arguments 15:53:52 INFO - ##### 15:53:52 INFO - ##### Running populate-webroot step. 15:53:52 INFO - ##### 15:53:52 INFO - Running pre-action listener: _resource_record_pre_action 15:53:52 INFO - Running main action method: populate_webroot 15:53:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:53:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:53:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:53:52 INFO - '../fennec_ids.txt'], 15:53:52 INFO - 'tests': ['tcheck2']}, 15:53:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:53:52 INFO - '--tppagecycles', 15:53:52 INFO - '7'], 15:53:52 INFO - 'tests': ['tsvgm']}}, 15:53:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:53:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:53:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:53:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:53:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:53:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:52 INFO - 'talos_options': ['--e10s'], 15:53:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:52 INFO - 'tests': ['damp', 'tps']}, 15:53:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:52 INFO - 'talos_options': ['--e10s'], 15:53:52 INFO - 'tests': ['damp', 'tps']}, 15:53:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:53:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:52 INFO - 'other': {'tests': ['a11yr', 15:53:52 INFO - 'ts_paint', 15:53:52 INFO - 'tpaint', 15:53:52 INFO - 'sessionrestore', 15:53:52 INFO - 'sessionrestore_no_auto_restore']}, 15:53:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:53:52 INFO - 'tests': ['a11yr', 15:53:52 INFO - 'ts_paint', 15:53:52 INFO - 'tpaint', 15:53:52 INFO - 'sessionrestore', 15:53:52 INFO - 'sessionrestore_no_auto_restore']}, 15:53:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:53:52 INFO - 'tests': ['a11yr', 15:53:52 INFO - 'ts_paint', 15:53:52 INFO - 'tpaint', 15:53:52 INFO - 'sessionrestore', 15:53:52 INFO - 'sessionrestore_no_auto_restore']}, 15:53:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:53:52 INFO - 'tests': ['a11yr', 15:53:52 INFO - 'ts_paint', 15:53:52 INFO - 'tpaint', 15:53:52 INFO - 'sessionrestore', 15:53:52 INFO - 'sessionrestore_no_auto_restore']}, 15:53:52 INFO - 'other_l64': {'tests': ['a11yr', 15:53:52 INFO - 'ts_paint', 15:53:52 INFO - 'tpaint', 15:53:52 INFO - 'sessionrestore', 15:53:52 INFO - 'sessionrestore_no_auto_restore']}, 15:53:52 INFO - 'other_nol64': {'tests': ['a11yr', 15:53:52 INFO - 'ts_paint', 15:53:52 INFO - 'tpaint', 15:53:52 INFO - 'sessionrestore', 15:53:52 INFO - 'sessionrestore_no_auto_restore']}, 15:53:52 INFO - 'svgr': {'tests': ['tsvgx', 15:53:52 INFO - 'tsvgr_opacity', 15:53:52 INFO - 'tart', 15:53:52 INFO - 'tscrollx', 15:53:52 INFO - 'cart']}, 15:53:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:53:52 INFO - 'tests': ['tsvgx', 15:53:52 INFO - 'tsvgr_opacity', 15:53:52 INFO - 'tart', 15:53:52 INFO - 'tscrollx', 15:53:52 INFO - 'cart']}, 15:53:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:52 INFO - 'tests': ['tp5o']}, 15:53:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:52 INFO - 'talos_options': ['--e10s'], 15:53:52 INFO - 'tests': ['tp5o']}, 15:53:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:52 INFO - 'talos_options': ['--xperf_path', 15:53:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:52 INFO - 'tests': ['tp5n']}, 15:53:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:52 INFO - 'talos_options': ['--e10s', 15:53:52 INFO - '--xperf_path', 15:53:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:52 INFO - 'tests': ['tp5n']}}, 15:53:52 INFO - 'talos.zip': {'path': '', 15:53:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:53:52 INFO - Running post-action listener: _resource_record_post_action 15:53:52 INFO - ##### 15:53:52 INFO - ##### Running create-virtualenv step. 15:53:52 INFO - ##### 15:53:52 INFO - Running pre-action listener: _resource_record_pre_action 15:53:52 INFO - Running main action method: create_virtualenv 15:53:52 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:52 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 15:53:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:53:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:52 INFO - Using real prefix '/usr' 15:53:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:52 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:54 INFO - Installing pip.................done. 15:53:54 INFO - Return code: 0 15:53:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:54 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 0x7fdf8debaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc0b0>, '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 0x1ebcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd440>, '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': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', '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 15:53:54 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 15:53:54 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 15:53:54 INFO - Using env: {'DISPLAY': ':0', 15:53:54 INFO - 'HOME': '/home/cltbld', 15:53:54 INFO - 'LANG': 'en_US.UTF-8', 15:53:54 INFO - 'LANGUAGE': 'en_US:en', 15:53:54 INFO - 'LOGNAME': 'cltbld', 15:53:54 INFO - 'MAIL': '/var/mail/cltbld', 15:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:54 INFO - 'MOZ_NO_REMOTE': '1', 15:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:54 INFO - 'NO_EM_RESTART': '1', 15:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:54 INFO - 'PWD': '/builds/slave/test', 15:53:54 INFO - 'SHELL': '/bin/bash', 15:53:54 INFO - 'SHLVL': '1', 15:53:54 INFO - 'TERM': 'linux', 15:53:54 INFO - 'TMOUT': '86400', 15:53:54 INFO - 'USER': 'cltbld', 15:53:54 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', 15:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:54 INFO - '_': '/tools/buildbot/bin/python'} 15:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:55 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 15:53:55 INFO - Cleaning up... 15:53:55 INFO - Return code: 0 15:53:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:53:55 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')]} 15:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:55 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')]} 15:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:55 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 0x7fdf8debaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc0b0>, '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 0x1ebcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd440>, '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': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', '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 15:53:55 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 15:53:55 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 15:53:55 INFO - Using env: {'DISPLAY': ':0', 15:53:55 INFO - 'HOME': '/home/cltbld', 15:53:55 INFO - 'LANG': 'en_US.UTF-8', 15:53:55 INFO - 'LANGUAGE': 'en_US:en', 15:53:55 INFO - 'LOGNAME': 'cltbld', 15:53:55 INFO - 'MAIL': '/var/mail/cltbld', 15:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:55 INFO - 'MOZ_NO_REMOTE': '1', 15:53:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:55 INFO - 'NO_EM_RESTART': '1', 15:53:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:55 INFO - 'PWD': '/builds/slave/test', 15:53:55 INFO - 'SHELL': '/bin/bash', 15:53:55 INFO - 'SHLVL': '1', 15:53:55 INFO - 'TERM': 'linux', 15:53:55 INFO - 'TMOUT': '86400', 15:53:55 INFO - 'USER': 'cltbld', 15:53:55 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', 15:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:55 INFO - '_': '/tools/buildbot/bin/python'} 15:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:55 INFO - Downloading/unpacking psutil>=0.7.1 15:53:55 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 15:53:55 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 15:53:55 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 15:53:55 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 15:53:55 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 15:53:55 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 15:53:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:53:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:53:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:57 INFO - Installing collected packages: psutil 15:53:57 INFO - Running setup.py install for psutil 15:53:57 INFO - building 'psutil._psutil_linux' extension 15:53:57 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 15:53:57 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 15:53:57 INFO - building 'psutil._psutil_posix' extension 15:53:57 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 15:53:57 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 15:53:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:57 INFO - Successfully installed psutil 15:53:57 INFO - Cleaning up... 15:53:57 INFO - Return code: 0 15:53:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:57 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 0x7fdf8debaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc0b0>, '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 0x1ebcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd440>, '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': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', '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 15:53:57 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 15:53:57 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 15:53:57 INFO - Using env: {'DISPLAY': ':0', 15:53:57 INFO - 'HOME': '/home/cltbld', 15:53:57 INFO - 'LANG': 'en_US.UTF-8', 15:53:57 INFO - 'LANGUAGE': 'en_US:en', 15:53:57 INFO - 'LOGNAME': 'cltbld', 15:53:57 INFO - 'MAIL': '/var/mail/cltbld', 15:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:57 INFO - 'MOZ_NO_REMOTE': '1', 15:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:57 INFO - 'NO_EM_RESTART': '1', 15:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:57 INFO - 'PWD': '/builds/slave/test', 15:53:57 INFO - 'SHELL': '/bin/bash', 15:53:57 INFO - 'SHLVL': '1', 15:53:57 INFO - 'TERM': 'linux', 15:53:57 INFO - 'TMOUT': '86400', 15:53:57 INFO - 'USER': 'cltbld', 15:53:57 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', 15:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:57 INFO - '_': '/tools/buildbot/bin/python'} 15:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:53:57 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 15:53:57 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 15:53:57 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 15:53:57 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 15:53:57 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 15:53:57 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 15:53:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:53:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:53:59 INFO - Installing collected packages: mozsystemmonitor 15:53:59 INFO - Running setup.py install for mozsystemmonitor 15:53:59 INFO - Successfully installed mozsystemmonitor 15:53:59 INFO - Cleaning up... 15:53:59 INFO - Return code: 0 15:53:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:59 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 0x7fdf8debaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc0b0>, '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 0x1ebcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd440>, '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': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', '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 15:53:59 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 15:53:59 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 15:53:59 INFO - Using env: {'DISPLAY': ':0', 15:53:59 INFO - 'HOME': '/home/cltbld', 15:53:59 INFO - 'LANG': 'en_US.UTF-8', 15:53:59 INFO - 'LANGUAGE': 'en_US:en', 15:53:59 INFO - 'LOGNAME': 'cltbld', 15:53:59 INFO - 'MAIL': '/var/mail/cltbld', 15:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:59 INFO - 'MOZ_NO_REMOTE': '1', 15:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:53:59 INFO - 'NO_EM_RESTART': '1', 15:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:59 INFO - 'PWD': '/builds/slave/test', 15:53:59 INFO - 'SHELL': '/bin/bash', 15:53:59 INFO - 'SHLVL': '1', 15:53:59 INFO - 'TERM': 'linux', 15:53:59 INFO - 'TMOUT': '86400', 15:53:59 INFO - 'USER': 'cltbld', 15:53:59 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', 15:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:59 INFO - '_': '/tools/buildbot/bin/python'} 15:54:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:00 INFO - Downloading/unpacking blobuploader==1.2.4 15:54:00 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 15:54:00 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 15:54:00 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 15:54:00 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 15:54:00 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 15:54:00 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 15:54:01 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54:01 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 15:54:01 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 15:54:01 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 15:54:01 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 15:54:01 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 15:54:01 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 15:54:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:54:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54:02 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 15:54:02 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 15:54:02 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 15:54:02 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 15:54:02 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 15:54:02 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 15:54:02 INFO - Downloading docopt-0.6.1.tar.gz 15:54:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:02 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:02 INFO - Running setup.py install for blobuploader 15:54:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:54:02 INFO - Running setup.py install for requests 15:54:02 INFO - Running setup.py install for docopt 15:54:03 INFO - Successfully installed blobuploader requests docopt 15:54:03 INFO - Cleaning up... 15:54:03 INFO - Return code: 0 15:54:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:03 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 0x7fdf8debaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc0b0>, '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 0x1ebcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd440>, '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': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', '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 15:54:03 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 15:54:03 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 15:54:03 INFO - Using env: {'DISPLAY': ':0', 15:54:03 INFO - 'HOME': '/home/cltbld', 15:54:03 INFO - 'LANG': 'en_US.UTF-8', 15:54:03 INFO - 'LANGUAGE': 'en_US:en', 15:54:03 INFO - 'LOGNAME': 'cltbld', 15:54:03 INFO - 'MAIL': '/var/mail/cltbld', 15:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:03 INFO - 'MOZ_NO_REMOTE': '1', 15:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:03 INFO - 'NO_EM_RESTART': '1', 15:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:03 INFO - 'PWD': '/builds/slave/test', 15:54:03 INFO - 'SHELL': '/bin/bash', 15:54:03 INFO - 'SHLVL': '1', 15:54:03 INFO - 'TERM': 'linux', 15:54:03 INFO - 'TMOUT': '86400', 15:54:03 INFO - 'USER': 'cltbld', 15:54:03 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', 15:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:03 INFO - '_': '/tools/buildbot/bin/python'} 15:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:03 INFO - Running setup.py (path:/tmp/pip-1FOGn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:03 INFO - Running setup.py (path:/tmp/pip-VBa_q6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:03 INFO - Running setup.py (path:/tmp/pip-YaFkBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:03 INFO - Running setup.py (path:/tmp/pip-cmmjif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:03 INFO - Running setup.py (path:/tmp/pip-sQ8mVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:03 INFO - Running setup.py (path:/tmp/pip-us1O9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:03 INFO - Running setup.py (path:/tmp/pip-BYRYJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:03 INFO - Running setup.py (path:/tmp/pip-TESDy0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:03 INFO - Running setup.py (path:/tmp/pip-IvEjoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:03 INFO - Running setup.py (path:/tmp/pip-2S4XRj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:04 INFO - Running setup.py (path:/tmp/pip-AKb4X9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:04 INFO - Running setup.py (path:/tmp/pip-6VZpg5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:04 INFO - Running setup.py (path:/tmp/pip-VAnrUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:04 INFO - Running setup.py (path:/tmp/pip-McdUs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:04 INFO - Running setup.py (path:/tmp/pip-yPtt1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:04 INFO - Running setup.py (path:/tmp/pip-9Np6fV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:04 INFO - Running setup.py (path:/tmp/pip-Cfiown-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:04 INFO - Running setup.py install for manifestparser 15:54:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Running setup.py install for mozcrash 15:54:04 INFO - Running setup.py install for mozdebug 15:54:04 INFO - Running setup.py install for mozdevice 15:54:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:54:04 INFO - Running setup.py install for mozfile 15:54:05 INFO - Running setup.py install for mozhttpd 15:54:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Running setup.py install for mozinfo 15:54:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Running setup.py install for mozInstall 15:54:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Running setup.py install for mozleak 15:54:05 INFO - Running setup.py install for mozlog 15:54:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Running setup.py install for moznetwork 15:54:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Running setup.py install for mozprocess 15:54:05 INFO - Running setup.py install for mozprofile 15:54:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Running setup.py install for mozrunner 15:54:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:54:05 INFO - Running setup.py install for mozscreenshot 15:54:06 INFO - Running setup.py install for moztest 15:54:06 INFO - Running setup.py install for mozversion 15:54:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:54:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:06 INFO - Cleaning up... 15:54:06 INFO - Return code: 0 15:54:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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', '-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 0x7fdf8debaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc0b0>, '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 0x1ebcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd440>, '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': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', '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 15:54:06 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 15:54:06 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 15:54:06 INFO - Using env: {'DISPLAY': ':0', 15:54:06 INFO - 'HOME': '/home/cltbld', 15:54:06 INFO - 'LANG': 'en_US.UTF-8', 15:54:06 INFO - 'LANGUAGE': 'en_US:en', 15:54:06 INFO - 'LOGNAME': 'cltbld', 15:54:06 INFO - 'MAIL': '/var/mail/cltbld', 15:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:06 INFO - 'MOZ_NO_REMOTE': '1', 15:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:06 INFO - 'NO_EM_RESTART': '1', 15:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:06 INFO - 'PWD': '/builds/slave/test', 15:54:06 INFO - 'SHELL': '/bin/bash', 15:54:06 INFO - 'SHLVL': '1', 15:54:06 INFO - 'TERM': 'linux', 15:54:06 INFO - 'TMOUT': '86400', 15:54:06 INFO - 'USER': 'cltbld', 15:54:06 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', 15:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:06 INFO - '_': '/tools/buildbot/bin/python'} 15:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:06 INFO - Running setup.py (path:/tmp/pip-w13Kiq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:06 INFO - Running setup.py (path:/tmp/pip-WDKsuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:06 INFO - Running setup.py (path:/tmp/pip-Qi75bC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:06 INFO - Running setup.py (path:/tmp/pip-7Qbel8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:06 INFO - Running setup.py (path:/tmp/pip-xkInMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:06 INFO - Running setup.py (path:/tmp/pip-2Cj0av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:06 INFO - Running setup.py (path:/tmp/pip-_DJrie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:06 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)) 15:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:06 INFO - Running setup.py (path:/tmp/pip-0Lhg40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:07 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)) 15:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:07 INFO - Running setup.py (path:/tmp/pip-WaFksF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:07 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)) 15:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:07 INFO - Running setup.py (path:/tmp/pip-jrWOAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:07 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)) 15:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:07 INFO - Running setup.py (path:/tmp/pip-DFOjWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:07 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)) 15:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:07 INFO - Running setup.py (path:/tmp/pip-JAeIrn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:07 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)) 15:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:07 INFO - Running setup.py (path:/tmp/pip-42NL38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:07 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)) 15:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:07 INFO - Running setup.py (path:/tmp/pip-uqU2EB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:07 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)) 15:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:07 INFO - Running setup.py (path:/tmp/pip-haFqJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:07 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)) 15:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:07 INFO - Running setup.py (path:/tmp/pip-kZQqzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:07 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)) 15:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:07 INFO - Running setup.py (path:/tmp/pip-LWY3Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:07 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)) 15:54:07 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)) 15:54:07 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)) 15:54:07 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)) 15:54:07 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)) 15:54:07 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)) 15:54:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:09 INFO - Downloading blessings-1.5.1.tar.gz 15:54:09 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 15:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:54:09 INFO - Installing collected packages: blessings 15:54:09 INFO - Running setup.py install for blessings 15:54:09 INFO - Successfully installed blessings 15:54:09 INFO - Cleaning up... 15:54:09 INFO - Return code: 0 15:54:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:09 INFO - Reading from file tmpfile_stdout 15:54:09 INFO - Current package versions: 15:54:09 INFO - argparse == 1.2.1 15:54:09 INFO - blessings == 1.5.1 15:54:09 INFO - blobuploader == 1.2.4 15:54:09 INFO - docopt == 0.6.1 15:54:09 INFO - manifestparser == 1.1 15:54:09 INFO - mozInstall == 1.12 15:54:09 INFO - mozcrash == 0.16 15:54:09 INFO - mozdebug == 0.1 15:54:09 INFO - mozdevice == 0.47 15:54:09 INFO - mozfile == 1.2 15:54:09 INFO - mozhttpd == 0.7 15:54:09 INFO - mozinfo == 0.9 15:54:09 INFO - mozleak == 0.1 15:54:09 INFO - mozlog == 3.1 15:54:09 INFO - moznetwork == 0.27 15:54:09 INFO - mozprocess == 0.22 15:54:09 INFO - mozprofile == 0.27 15:54:09 INFO - mozrunner == 6.11 15:54:09 INFO - mozscreenshot == 0.1 15:54:09 INFO - mozsystemmonitor == 0.0 15:54:09 INFO - moztest == 0.7 15:54:09 INFO - mozversion == 1.4 15:54:09 INFO - psutil == 3.1.1 15:54:09 INFO - requests == 1.2.3 15:54:09 INFO - wsgiref == 0.1.2 15:54:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:09 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')]} 15:54:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:09 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')]} 15:54:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:09 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 0x7fdf8debaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc0b0>, '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 0x1ebcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd440>, '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': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', '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 15:54:09 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 15:54:09 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 15:54:09 INFO - Using env: {'DISPLAY': ':0', 15:54:09 INFO - 'HOME': '/home/cltbld', 15:54:09 INFO - 'LANG': 'en_US.UTF-8', 15:54:09 INFO - 'LANGUAGE': 'en_US:en', 15:54:09 INFO - 'LOGNAME': 'cltbld', 15:54:09 INFO - 'MAIL': '/var/mail/cltbld', 15:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:09 INFO - 'MOZ_NO_REMOTE': '1', 15:54:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:09 INFO - 'NO_EM_RESTART': '1', 15:54:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:09 INFO - 'PWD': '/builds/slave/test', 15:54:09 INFO - 'SHELL': '/bin/bash', 15:54:09 INFO - 'SHLVL': '1', 15:54:09 INFO - 'TERM': 'linux', 15:54:09 INFO - 'TMOUT': '86400', 15:54:09 INFO - 'USER': 'cltbld', 15:54:09 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', 15:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:09 INFO - '_': '/tools/buildbot/bin/python'} 15:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:10 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)) 15:54:10 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)) 15:54:10 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)) 15:54:10 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)) 15:54:10 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)) 15:54:10 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)) 15:54:10 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)) 15:54:10 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)) 15:54:10 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)) 15:54:10 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)) 15:54:10 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)) 15:54:10 INFO - Cleaning up... 15:54:10 INFO - Return code: 0 15:54:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf8debaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc0b0>, '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 0x1ebcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd440>, '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': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', '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 15:54:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:54:10 INFO - Using env: {'DISPLAY': ':0', 15:54:10 INFO - 'HOME': '/home/cltbld', 15:54:10 INFO - 'LANG': 'en_US.UTF-8', 15:54:10 INFO - 'LANGUAGE': 'en_US:en', 15:54:10 INFO - 'LOGNAME': 'cltbld', 15:54:10 INFO - 'MAIL': '/var/mail/cltbld', 15:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:10 INFO - 'MOZ_NO_REMOTE': '1', 15:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:10 INFO - 'NO_EM_RESTART': '1', 15:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:10 INFO - 'PWD': '/builds/slave/test', 15:54:10 INFO - 'SHELL': '/bin/bash', 15:54:10 INFO - 'SHLVL': '1', 15:54:10 INFO - 'TERM': 'linux', 15:54:10 INFO - 'TMOUT': '86400', 15:54:10 INFO - 'USER': 'cltbld', 15:54:10 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', 15:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:10 INFO - '_': '/tools/buildbot/bin/python'} 15:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:10 INFO - Downloading/unpacking jsonschema 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:54:11 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 15:54:12 INFO - Downloading/unpacking functools32 (from jsonschema) 15:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:12 INFO - Downloading functools32-3.2.3-2.tar.gz 15:54:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:54:12 INFO - warning: no files found matching '*.txt' 15:54:12 INFO - no previously-included directories found matching 'build' 15:54:12 INFO - no previously-included directories found matching 'dist' 15:54:12 INFO - no previously-included directories found matching '.git*' 15:54:12 INFO - Installing collected packages: jsonschema, functools32 15:54:12 INFO - Running setup.py install for functools32 15:54:12 INFO - warning: no files found matching '*.txt' 15:54:12 INFO - no previously-included directories found matching 'build' 15:54:12 INFO - no previously-included directories found matching 'dist' 15:54:12 INFO - no previously-included directories found matching '.git*' 15:54:12 INFO - Successfully installed jsonschema functools32 15:54:12 INFO - Cleaning up... 15:54:12 INFO - Return code: 0 15:54:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 15:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:54:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdf8debaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d5f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e2d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ebc0b0>, '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 0x1ebcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd440>, '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': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', '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 15:54:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 15:54:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:54:12 INFO - Using env: {'DISPLAY': ':0', 15:54:12 INFO - 'HOME': '/home/cltbld', 15:54:12 INFO - 'LANG': 'en_US.UTF-8', 15:54:12 INFO - 'LANGUAGE': 'en_US:en', 15:54:12 INFO - 'LOGNAME': 'cltbld', 15:54:12 INFO - 'MAIL': '/var/mail/cltbld', 15:54:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:12 INFO - 'MOZ_NO_REMOTE': '1', 15:54:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:12 INFO - 'NO_EM_RESTART': '1', 15:54:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:12 INFO - 'PWD': '/builds/slave/test', 15:54:12 INFO - 'SHELL': '/bin/bash', 15:54:12 INFO - 'SHLVL': '1', 15:54:12 INFO - 'TERM': 'linux', 15:54:12 INFO - 'TMOUT': '86400', 15:54:12 INFO - 'USER': 'cltbld', 15:54:12 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', 15:54:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:12 INFO - '_': '/tools/buildbot/bin/python'} 15:54:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:12 INFO - Downloading/unpacking flake8 15:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:54:14 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 15:54:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:54:14 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 15:54:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:14 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 15:54:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:54:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 15:54:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:54:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:54:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:54:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:54:15 INFO - no previously-included directories found matching 'docs/_build' 15:54:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:54:15 INFO - Running setup.py install for pep8 15:54:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:54:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:54:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:54:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:54:15 INFO - no previously-included directories found matching 'docs/_build' 15:54:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 15:54:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:54:15 INFO - Cleaning up... 15:54:15 INFO - Return code: 0 15:54:15 INFO - Running post-action listener: _resource_record_post_action 15:54:15 INFO - Running post-action listener: _start_resource_monitoring 15:54:15 INFO - Starting resource monitoring. 15:54:15 INFO - ##### 15:54:15 INFO - ##### Running install step. 15:54:15 INFO - ##### 15:54:15 INFO - Running pre-action listener: _resource_record_pre_action 15:54:15 INFO - Running main action method: install 15:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:54:15 INFO - Reading from file tmpfile_stdout 15:54:15 INFO - Detecting whether we're running mozinstall >=1.0... 15:54:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:54:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:54:15 INFO - Reading from file tmpfile_stdout 15:54:15 INFO - Output received: 15:54:15 INFO - Usage: mozinstall [options] installer 15:54:15 INFO - Options: 15:54:15 INFO - -h, --help show this help message and exit 15:54:15 INFO - -d DEST, --destination=DEST 15:54:15 INFO - Directory to install application into. [default: 15:54:15 INFO - "/builds/slave/test"] 15:54:15 INFO - --app=APP Application being installed. [default: firefox] 15:54:15 INFO - mkdir: /builds/slave/test/build/application 15:54:15 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'] 15:54:15 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 15:54:30 INFO - Reading from file tmpfile_stdout 15:54:30 INFO - Output received: 15:54:30 INFO - /builds/slave/test/build/application/firefox/firefox 15:54:30 INFO - Running post-action listener: _resource_record_post_action 15:54:30 INFO - ##### 15:54:30 INFO - ##### Running run-tests step. 15:54:30 INFO - ##### 15:54:30 INFO - Running pre-action listener: _resource_record_pre_action 15:54:30 INFO - Running main action method: run_tests 15:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:30 INFO - Python 2.7.3 15:54:30 INFO - Return code: 0 15:54:30 INFO - grabbing minidump binary from tooltool 15:54:30 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')]} 15:54:30 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 0x1ebc0b0>, '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 0x1ebcfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ebd440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54:30 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 15:54:30 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 15:54:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:30 INFO - Return code: 0 15:54:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:54:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:54:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 15:54:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 15:54:31 INFO - Return code: 0 15:54:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] in /builds/slave/test/build 15:54:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Cedar --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-017 --webServer localhost 15:54:31 INFO - Using env: {'DISPLAY': ':0', 15:54:31 INFO - 'HOME': '/home/cltbld', 15:54:31 INFO - 'LANG': 'en_US.UTF-8', 15:54:31 INFO - 'LANGUAGE': 'en_US:en', 15:54:31 INFO - 'LOGNAME': 'cltbld', 15:54:31 INFO - 'MAIL': '/var/mail/cltbld', 15:54:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:31 INFO - 'MOZ_NO_REMOTE': '1', 15:54:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:31 INFO - 'NO_EM_RESTART': '1', 15:54:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:31 INFO - 'PWD': '/builds/slave/test', 15:54:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:31 INFO - 'SHELL': '/bin/bash', 15:54:31 INFO - 'SHLVL': '1', 15:54:31 INFO - 'TERM': 'linux', 15:54:31 INFO - 'TMOUT': '86400', 15:54:31 INFO - 'USER': 'cltbld', 15:54:31 INFO - 'XDG_SESSION_COOKIE': '6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146', 15:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:31 INFO - '_': '/tools/buildbot/bin/python'} 15:54:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Cedar', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-017', '--webServer', 'localhost'] with output_timeout 3600 15:54:31 INFO - mozversion INFO | application_buildid: 20151203144642 15:54:31 INFO - mozversion INFO | application_changeset: 3150c768471cf5800888c009a0f3ed8d752e7038 15:54:31 INFO - mozversion INFO | application_display_name: Nightly 15:54:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:31 INFO - mozversion INFO | application_name: Firefox 15:54:31 INFO - mozversion INFO | application_remotingname: firefox 15:54:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/projects/cedar 15:54:31 INFO - mozversion INFO | application_vendor: Mozilla 15:54:31 INFO - mozversion INFO | application_version: 45.0a1 15:54:31 INFO - mozversion INFO | platform_buildid: 20151203144642 15:54:31 INFO - mozversion INFO | platform_changeset: 3150c768471cf5800888c009a0f3ed8d752e7038 15:54:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/projects/cedar 15:54:31 INFO - mozversion INFO | platform_version: 45.0a1 15:54:31 INFO - 2015-12-03 15:54:31,283 DEBUG : using testdate: 1449186871 15:54:31 INFO - 2015-12-03 15:54:31,283 DEBUG : actual date: 1449186871 15:54:31 INFO - 2015-12-03 15:54:31,291 INFO : starting webserver on 'localhost:41015' 15:54:31 INFO - 2015-12-03 15:54:31,292 INFO : Starting test suite talos-linux64-ix-017 15:54:31 INFO - 2015-12-03 15:54:31,292 INFO : Starting test dromaeo_css 15:54:31 INFO - 2015-12-03 15:54:31,292 DEBUG : operating with platform_type : linux_ 15:54:31 INFO - 2015-12-03 15:54:31,293 INFO : Initialising browser for dromaeo_css test... 15:54:31 INFO - 2015-12-03 15:54:31,307 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgCVaxz/profile http://localhost:41015/getInfo.html 15:54:34 INFO - 2015-12-03 15:54:34,923 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:54:34 INFO - 2015-12-03 15:54:34,924 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:54:34 INFO - 2015-12-03 15:54:34,924 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:54:34 INFO - 2015-12-03 15:54:34,924 DEBUG : BROWSER_OUTPUT: __metrics 15:54:35 INFO - 2015-12-03 15:54:35,026 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] 15:54:35 INFO - 2015-12-03 15:54:35,027 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] 15:54:36 INFO - 2015-12-03 15:54:36,077 INFO : Browser initialized. 15:54:36 INFO - 2015-12-03 15:54:36,078 INFO : Running cycle 1/1 for dromaeo_css test... 15:54:36 INFO - 2015-12-03 15:54:36,078 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgCVaxz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:54:48 INFO - 2015-12-03 15:54:48,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 143667200 15:54:48 INFO - 2015-12-03 15:54:48,178 DEBUG : BROWSER_OUTPUT: 15:55:39 INFO - 2015-12-03 15:55:39,519 DEBUG : BROWSER_OUTPUT: 1449186939515 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] 15:57:51 INFO - 2015-12-03 15:57:51,389 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41015/tests/dromaeo/cssquery-ext.html) 15:57:52 INFO - 2015-12-03 15:57:52,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 254717952 15:57:52 INFO - 2015-12-03 15:57:52,494 DEBUG : BROWSER_OUTPUT: 16:00:55 INFO - 2015-12-03 16:00:55,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-ext.html (next: http://localhost:41015/tests/dromaeo/cssquery-jquery.html) 16:00:55 INFO - 2015-12-03 16:00:55,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 223592448 16:00:55 INFO - 2015-12-03 16:00:55,628 DEBUG : BROWSER_OUTPUT: 16:03:57 INFO - 2015-12-03 16:03:57,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41015/tests/dromaeo/cssquery-mootools.html) 16:03:58 INFO - 2015-12-03 16:03:58,255 DEBUG : BROWSER_OUTPUT: RSS: Main: 227213312 16:03:58 INFO - 2015-12-03 16:03:58,256 DEBUG : BROWSER_OUTPUT: 16:07:00 INFO - 2015-12-03 16:07:00,191 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41015/tests/dromaeo/cssquery-prototype.html) 16:07:00 INFO - 2015-12-03 16:07:00,752 DEBUG : BROWSER_OUTPUT: RSS: Main: 205410304 16:07:00 INFO - 2015-12-03 16:07:00,752 DEBUG : BROWSER_OUTPUT: 16:10:03 INFO - 2015-12-03 16:10:03,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41015/tests/dromaeo/cssquery-yui.html) 16:10:04 INFO - 2015-12-03 16:10:04,200 DEBUG : BROWSER_OUTPUT: RSS: Main: 207749120 16:10:04 INFO - 2015-12-03 16:10:04,200 DEBUG : BROWSER_OUTPUT: 16:13:06 INFO - 2015-12-03 16:13:06,861 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/dromaeo/cssquery-yui.html (next: http://localhost:41015/tests/dromaeo/cssquery-dojo.html) 16:13:07 INFO - 2015-12-03 16:13:07,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 261459968 16:13:07 INFO - 2015-12-03 16:13:07,107 DEBUG : BROWSER_OUTPUT: 16:13:07 INFO - 2015-12-03 16:13:07,111 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:13:07 INFO - 2015-12-03 16:13:07,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:13:07 INFO - 2015-12-03 16:13:07,111 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:13:07 INFO - 2015-12-03 16:13:07,111 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:13:07 INFO - 2015-12-03 16:13:07,111 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2590.92227233183;2700.779683449515;2709.620653108565;2713.633659455973;2716.5925111233314;4378.365137055125;4511.819527218916;4596.862094137177;4653.511381304961;4672.5327467253255;4579.610733087691;4633.675642705012;4667.929981050287;4676.462206846214;4687.859364219071;4265.296226122686;4281.978590107045;4332.97833510832;4348.869533913988;4359.673024523157;4126.793660316972;4274.679399045069;4297.097609502009;4352.434183556134;4392.494863090737;4200.810963506619;4220.430241917333;4286.078493123993;4288;4308.030693094061;4241.088166044285;4252.829886804555;4271.807768650418;4289.6997210195295;4340.197063543254;4115.403266526337;4208.621224089816;4225.68307376948;4244.533101358848;4266.616004559604;4494.16857881293;4540.72755634663;4573.062522182978;4589.885252868671;4617.445906491243;4943.06081844452;5002.874928126826;5003.749812509396;5010;5066.088104141253;4828.61371090312;4989.675671081368;5020.0963826511215;5022.221555658843;5030.320906677588;4577.5880170784785;4609.976950115261;4669.836555720533;4691.225947718656;4730;5100.770465329069;5132.153194722829;5133.101707201225;5138.3833939927445;5186.429492755794;4707.082118986833;4841.612670986313;4910;4951.876203094951;4992.326035985168;4839.467658557556;4917.58200552957;4928.186849169919;4946.554810067111;4966.056449274626;4965.155923493015;4970.179920313108;4971.701697898137;4976.129177393942;4983.700977941335;4940.283658869444;4943.826966056171;4946.851594452172;4947.505249475023;4977.626677999165;3920.1571662092215;3989.960100399017;4031.3952907064177;4056.9797151014645;4186.05813691923;3649.6168896711633;3653.5615726113037;3656.104254457675;3663.285659296465;3683.723720720903;4295.978520107379;4300.698951073395;4303.763293018851;4334.761588112684;4336.631386332134;4781.784819683123;4813.302071199656;4910.852674419773;4912.778924948315;4972.577330926912;4326;4330.935035974463;4333.090051089243;4343.109662519176;4362.214801335726;4442.511323754385;4445.822167113344;4452.710573812692;4497.370368148462;4497.797599107983;4589.380433641482;4700.529947005272;4717.622590192845;4721.2918062289555;4829.323894654751;4938.407391113089;4970.254461830755;4971.080350135237;4971.850844474671;5004.899902002013;4731.006488637425;4732.053589282088;4736.100140973204;4774.331593576832;4783.617310615212;4751.809927602857;4829.348038014964;4886.902261954812;4897.681650692836;4928.581070608895;4965.826196083264;4977.701337919736;4978.4523702393435;4983.651144419856;4994.275830004702;4824.252240902666;4826.758662066953;4830.2513110467935;4834.734089625104;4863.7324947128245;4679.766011699333;4710.317004034464;4762.119007983534;4819.638527110411;4875.780589873393;4762.261849413347;4763.499832517536;4772.141014617263;4784.40194975628;4837.153498137882;4898.33872427232;4898.436679781728;4901.387326584177;4907.484714104968;4934.5805606523845;4614.238650622609;4709.270063140219;4741;4747.525247475225;4831.371921650163 16:13:07 INFO - 2015-12-03 16:13:07,115 DEBUG : BROWSER_OUTPUT: |1;ext.html;568.866316415642;573.7532860869826;582.3245035758521;585.0084107437895;587.43899575905;28114;28650.140495785134;38056.809715951415;38274.234515309676;38318;39916;40120;40437.19125617486;40518.59481405185;40546.189076218456;7001.124859392576;7914.6042697865305;8045.356371490267;8067.233612806774;8079.9192008080045;7114.715411383539;10151.340162889426;10529.6314628988;10536.209784266171;10537.78924421515;10216.48917554123;10307.793844123113;10312.793744125112;10315.896841031568;10327.741806454862;7102.218755936843;7332.120145582511;10014;10153.187744980383;10223.693289201336;9977.850332245021;10106.393616382968;10111.646092386805;10111.949440252825;10114.747131321703;36599.63400365989;37258.44112338317;37274;37279.62720372788;37286.62713372859;2915.6355455568055;3252.414565378231;3301.504774283853;3505.94741078884;3542.0613537412605;27959.440811183867;28100.437991240062;28159.296017599518;28541.143765687062;29146.271343216376;3458.429359155736;3540.504329393887;3540.8406621702084;3552.5381700379044;3660.1764602964386;209674;209960;211657;212146;212284;51515;52725.209121863205;54040.72979635155;54486.727566361915;62384.376156238766;58352.708236459395;58394.708026460445;58641.41358586359;58657.4134258652;58752.41247587469;13597.456101756017;13793.655158621115;13896.305184740722;13898.235597042058;13910.58268251954;10668.199885008655;10714.035736783728;10727.195460340507;10741.301815381976;10755.623553175757;19358.4192474226;19616.803831961497;19760.308389206308;19791.901040494704;19805.900970495342;7245.275472452818;7521.548707077593;7531.359834414026;7585.848283034308;7592.316691497792;791.133708589094;815.2418251026602;816.8856360109589;839.1776059461762;854.7307598106577;26212.21363359102;26336.8683156583;26818.865905670347;26822.329441763723;26975.595366069523;936.8828896387952;941.7975135345933;966.6906589891308;997.1623835977668;1019.4342140112309;13785.655358616115;13854.792178117335;13982.230977296347;13994.860051399559;14006.929965350311;301411;307166;308050;308170;308694;48303.75848120737;48651;48656;48802.75598621984;48824.75587622039;1208.6434501821984;1213.4478812140455;1227.2820400065882;1228.2139430764319;1228.4963165102265;21814.89092554527;30867.38265234638;31251.84374078115;31374.529382059744;31760.523592146597;43944.34083488814;44667.32999005083;44737.10525789531;44756.77621611871;44786.104277914914;244276;246198;246329;247107;247152;24495.63256551189;28522.144335669964;28860.134195974155;28908.855455722587;29233.41533169282;35877.461838071926;36632;36807.63192368149;36963.26073478461;37837;31711.84144079357;31751.52372714365;31840.36319273648;32373.67626323801;32831.507527387585;32082;32547.674523255413;32627.34745305128;32661.34677306488;32808.179795505304;32840.67159328376;33176;33248;33295.167620809676;36311.09222269464;29059.854700726362;29557.85221073881;31118.37763244768;31349.216269593442;31378.372432550765;23976.88011559931;24051.759482404952;24264;24531.877340613184;24550.877245613658 16:13:07 INFO - 2015-12-03 16:13:07,115 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.89846596787976;336.83495087407175;336.9554381417605;340.49436586668776;341.19137643784234;12223.633291001262;12613.306268155271;14923.776143357845;15056.849431505681;15686.450974215904;12878.356082195876;13274.203547787116;14289.71420571588;14569.344379502922;14931.925340373311;4476.261416866229;4875.049365373762;5022.773975171108;5024.899502009957;5761.510271626917;3603.0992251937014;3735.682466990309;5558.110702287635;5694.430556944314;5749.05140651794;5676.801311954083;5682.51698605619;5684.857878553028;5725.227094342273;5732.627379220337;5636.859078523029;5758.712064396785;5760.683162426044;5762.625429347079;5763.769449222026;5053.090443720129;5058.671186372911;5061.063703214917;5068.771905264272;5072.51811077947;18956.43130706081;18963;19303.710444343345;19539.316123935736;19572;1827.3695575026595;1853.8516918646476;1873.7751469823572;1918.1080797429122;2026.9695954560693;12595.74808503834;12600.621981340575;12696.365181740875;12810.29543375114;13131.212127272298;1769.752234687145;1781.5635169383584;1787.6156626325403;1800.4148651688254;1837.2467288411822;50968;52726.47273527254;53183.734081329734;53627.92744145134;54044.91910161814;9256.398334108262;9370.85943710845;9474.810503789886;9480.194183494481;9552.90447095534;11942.641720748392;11984.820227696591;12011.939940300243;12018.098642601839;12028.819567706492;7059.752908648173;7087.92912070883;7181.281871812777;7183.856322873513;7217.494775365674;6709.261981182066;6746.8650626988165;6759.256481787;6780.084688566981;6806.965965170241;5676.460736230051;5716.857078573069;5736.1682556029145;5738.512226460714;5810.680412577264;1565.6946895355297;1603.0622086079775;1608.7184742669986;1614.1929035482258;1618.587260248629;723.6020188896191;771.9614019299013;834.6828205282076;864.0668078475231;950.0452045694034;15027.849721502864;15519.37922483088;15696.293666784793;16082;16171.919140404223;764.6635480388722;837.2046555772041;853.5134973065293;917.5962576466334;949.0556895888635;8290.057970010012;9025.548722563846;9074.500902450296;9218.81562368749;9270.30472714549;453297;459219;459472;466076;490488;69240.6537967317;70544;71652;72927.63536182285;73748.63125684338;986.2750878104588;1011.585250047477;1012.9746756331003;1019.3425240719695;1045.4720366215165;13565.38955746974;14029;14143.929280353532;14388.568342949728;14562.635934101732;30283.091507254816;32049.359012820078;32451;32925;33656.66343336633;39429;40168.59831401648;42070.78964605158;42218.78890605527;42762.57237427586;8971.147740964598;9029.729108126767;9040.050794666466;9179.31155163352;9201.217896478875;13727.656808579866;16050;16816.915915420344;16879.831201688317;16933.661326773643;13610.455581776618;13878;13958.720825583634;13984.790228146789;14441.277936103363;13498.122622029538;13641.727165456437;13654.249016304198;13973.790393143907;14008.649783755487;11106.944465277622;14168.583141685749;14262;14368.066075705046;14709.852901471277;7916.129225785274;8244.958775206325;9001.729948101567;9323.440593564408;9326.114019168168;13711.177329360271;13827;14078.859211408164;14292;14295.499657511937 16:13:07 INFO - 2015-12-03 16:13:07,115 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1213.344793811342;1401.173307748429;1424.3376829774159;1619.2146808797731;1701.9829801701978;6293.181886354773;6503.674816259186;7218.494705370619;7377.114746230446;7385.852282954338;6993.090898183242;7043.04918835957;7086.078809754737;7103.964480177592;7137.393321567673;2083.4583008417844;2106.7682554918947;2123.437289118385;2125.3730149605904;2125.904334304952;2093.3824521766114;2115.3653903828867;2125.5961367340233;2126.0114046968156;2128.4146859613575;2115.7038014677955;2135.562209746998;2157.244964262511;2160.79472450117;2161.6001039807684;2150.419386765572;2167.6640120781303;2173.7065496157975;2175.5540114276537;2183.192218879009;2118.4386137673528;2179.0085511092416;2179.106566307822;2179.2808373236794;2180.3132013415884;6234.812955611339;7311.744088956861;7417.814554636123;7421.703131874719;7427.220141885133;3735.1595890924323;3811.1805961718087;4202.243596152692;4288.078063216423;4289.764062976535;2748.876300566479;2773.8751756171023;2790.497710412125;2796.8881244750187;2874.870630821597;889.9866502002475;890.1279434460112;898.3621628643671;912.7124955638952;916.1525588830306;10137.89862101377;10267.743306417324;10281.742956426075;10290.845637315446;10298.330608510423;4119.279126152971;4165.958340416557;4180.393842892763;4220.873373798791;4232.090100628379;8857.070007649232;8885.378023538291;8887;8888.11118888119;8894.644214231488;4364.803583838735;4367.868963931087;4370.169667763178;4372.322290045048;4372.781360932005;3899.6880249579967;3902.6292502212245;3908.843646254175;3915.040815000343;3915.6280153385383;3348.045806945058;3366.192113892648;3369.309291595217;3392.8473218705217;3396.3037577296595;1084.5065495199665;1085.853409789684;1087.4399684162663;1096.17786660005;1097.6761855252719;1044.7127040064042;1052.9420881851572;1069.0485467933545;1070.1813112968584;1089.983650245247;6917.7232910684015;6947.82630434233;6972.58164510131;6990.231074581792;7018.649067546602;450.6102221578311;453.745902294716;463.55730277584826;463.57582811726894;463.7055469776716;4983.975080124649;5459.672419654833;5468.453154684579;5495.6427832191575;5547.77808887648;8081.757547273473;8803.911960880438;8931.062238464998;9146.725598232064;9147.588358523883;8768.298536117223;8884.333674974274;8922.286217102615;8941.865872011926;8943.686970956116;6889.173299204128;6972.442204623618;7034;7034.472414568928;7035.366816986496;6700.162479690039;6709.865802683821;6767.154105736783;6770.255271920183;6784.185897692111;7867.763967080997;7971.521708697497;8025.759227223192;8057.194280571896;8104.473209241381;8083.959580202061;8219.671213151407;8228;8311.542865142475;8327.6668933242;6272.498200143887;6311.495080393465;6314.400131987454;6324.810255692337;6340.904886426615;7009.439244860501;7056.1179852518435;7068;7069.752558660422;7087.468439866928;6680.5991640501725;6716.630585317855;6750.0212469192675;6860.897086543606;6899.517033807585;6548;6558.80323590293;6602.042703807825;6668.43318317929;6699.263081061177;6734.730610775514;6771.559848610022;6823.590584564942;6885.311468853075;6885.414739747178;6211.81364559064;6251.281102673069;6255.906161407492;6260.467860231749;6271.3415091414745;6258.43674069336;6300.905486417799;6303.9684801575695;6323.747050118128;6324.557280990287 16:13:07 INFO - 2015-12-03 16:13:07,116 DEBUG : BROWSER_OUTPUT: |4;prototype.html;296.5462841851966;306.93861227754456;307.8676169247224;310.96112985876766;311.56692197845;5236.3192784937955;5274.235235890794;5274.841754747355;5285.788568457262;5291.2327712481665;5152.948470515294;5165.5092766187245;5217.530422261995;5218.1650935850275;5220.8694782630455;4115.938260926081;4116.259073366793;4116.567760385161;4120.361343991686;4121.608447197526;3917.196974620196;4029.81865816039;4121.237571049351;4124.216398884218;4125.608067233608;3801.220749746309;3816.0459885028745;3979.482667253253;3993.480847489837;3996.8001599920035;3970.4441378207075;4020.557738648746;4050.675945924319;4061.3095773718537;4078.2455245779624;3597.442396428558;3625.492431059654;3626.274745050974;3637.781733095996;3640.1445660269815;4794.089123066607;4938.777755001033;4942.1104201244125;5014.398272207359;5033.144365457881;4684.156851766681;4690.906181876378;4693.155232058228;4695.741734204652;4699.318598803155;5520.751566179531;5536.335639723259;5536.390996990328;5541.251930989305;5550;3685.68671662909;3806.0675134591925;3857.247836671822;3910.1397692507603;3919.7452165609143;5762.88474230513;5768.567357448208;5785.681787501728;5792.565557583198;5806.042003069489;4038.818253178614;4041.2927737645796;4042.2319759245647;4046.77742724153;4047.251258517184;4094.570070142592;4099.733517321364;4100.487439070116;4102.2000709861295;4103.466549348565;4564.908701825945;4644.628429725613;4655;4669.719816811003;4683.063387322481;5541.307336582927;5541.362743284574;5541.501264886179;5546.140348246028;5547.528460080857;1434.8852091832628;1443.9566812995627;1447.4572035486692;1449.9855001450062;1450.6155868694805;988.930774845754;991.8065977134389;1001.906501966093;1009.7273736091214;1023.1201166996526;4891.779869905863;4897.755112244445;4904.852854414374;4905.166121759238;4917.434495033045;5664.971675141598;5725.255716756795;5745.626534275342;5748.396418376094;5749.511291540182;4890.388701412324;4896.951030489649;4902.313676085351;4903.289023091703;4907.190313598217;3015.819050856912;3061.98469007658;3087.274490494732;3090.8454577271045;3103.8603262853226;5519.254900588369;5527.115661494222;5533.723313834373;5534.972325138348;5545.916811247835;5960.821175364746;5962.4633782959745;5971.671558064349;5972.910406343908;5977.9402205977385;5517.44825517445;5528.474794894559;5538.47384498472;5539;5539.113741801292;5645.350784659817;5792.420757924174;5802.767889284381;5802.970985145216;5807.82576522705;5461.9180712290145;5576.804811831566;5673.149027645886;5678.403767604342;5683.77264909399;5379.112446446293;5464.480874316933;5503.11950087984;5504.284443022381;5504.311961004874;3947.230290093519;3986.661133803543;3992.001999500125;3993.4608827807874;3995.580464051233;5743.167240750151;5760.395158508296;5764.164196191445;5782.277215348082;5782.681952492653;5411.702356370437;5553.194786755817;5557.972210138923;5560.388357280777;5565.888682226252;5552.7223638818705;5561.499465048165;5568.55451563882;5569.415211402745;5573.080441727069;5438.83683489496;5441.483059109379;5442.319710036246;5443.292371991616;5446.291982042309;5481.314835645544;5594.244776955059;5596.076647353141;5599.552035837205;5601.103823388238;5451.781928722807;5458.754356054066;5464.535514481155;5468.960897429476;5472.671639701631 16:13:07 INFO - 2015-12-03 16:13:07,117 DEBUG : BROWSER_OUTPUT: |5;yui.html;760.5170716594964;778.6573907480712;781.8944442500263;792.892959450474;795.16904834448;11858.584949526758;12640.557580484685;12661.49354025839;12676.68308292291;12711.555095571657;12160.452779624917;12285.815712764315;12291.262524248552;12303.38483075847;12311.261324320547;610.5664977865721;619.3465893482374;765.2347652347653;767.9424043196755;785.3638552772244;779.9727009554666;781.6404453951161;781.7771934998526;787.5983248543226;789.2817536042203;635.4217661927647;816.481534225765;823.6087858267335;823.7611092783086;824.4229039672224;638.0110828216269;800.219785708935;810.3476701255487;811.3022800391658;812.5043723328765;603.3815339277232;603.7766026570154;604.1964187630441;604.2054698072021;604.5737754882797;11495.885041149566;11850.88149118515;11857.051435885109;11858.169928105037;11902.285862848257;11346.262492937933;11983.94008029963;12192.634220973385;12260.570880019157;12502.74994500105;9560;9835.360701554448;9841.852372214422;10204.132648724868;10236.641717539926;3273.714468220998;3292.6048874135017;3324.1855745342546;3382.746294027958;3439.7420193485336;42737.57262427367;42920.356194657106;43230.56769432328;43260.3510947336;43308.78345608252;9296.39573427725;9302.581383837743;9471.147596716328;9476.668316608886;9520.381175223589;16241.106739129462;16293.348266069224;16309.429169978994;16342.509724708278;16352.591185220464;6158.815235542941;6171.56799024073;6217.098520714471;6362.395572420613;6371.872562548723;3640.7087433005295;3659.2315613721416;3688.0595448160548;3713.665770080706;3767.3595488766973;2653.761161495436;2685.7448542388443;2695.3396417877743;2709.701932787392;2710.8780104895327;488.3480553461098;490.9435414927329;491.66566734620085;511.0851575679566;511.8771494841211;437.86645073252964;441.4481897627965;447.46080972428143;460.82028009076487;488.565176992477;7306.986661377456;7449.776506704808;7529.134149572869;7886.842263154819;7934.914418623162;570.6461993564017;577.1832856507995;584.0509172594534;597.1013624495107;619.7830759234232;3328.617209020945;3333.4333163361803;3391.270876761508;3392.9709913930624;3473.4963430302464;49123.508764911894;50180.749096255015;50209.49790502121;50212;50320.49679503231;42708.78645606752;42830;42883.57116428858;44946.32580511295;45247.32129018068;39355.40966885499;40061.198776024314;40315.798421008294;40323;40928.18143637111;7478.7382441616455;7952.284294413531;7968.681252749825;8009.719659811879;8043.276105150565;29884.252893677833;30764.384712305182;30819;30884.53673194859;31027.224319392197;36508.45237321389;38654.420183696704;39355.409668855566;39470.60529394669;39836.601633983286;10068.496575171066;10070.194384449373;10169.542370593193;10255.846162307422;10332.276740628084;11463.197576169589;11676.94161529187;11835.28988260707;11841.5855445059;12089.892563053269;9984.750381240237;10131.290809643255;10923.344599323747;10947.945260273966;11291.774164516828;10757.408342541235;11170.720731981766;11218.326900386002;11620.244684095507;11639.243449175776;7702.922970770221;8255.463394879314;8602.05377408497;9975.50122493887;10116.140128089195;8404.705835295736;8564.443311184754;8996.910030899608;9054.366194366332;9071.138241867013;7230;7820.882686759817;7880.17258187882;8199.95900020496;9163.816723665355 16:13:07 INFO - 2015-12-03 16:13:07,117 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,898 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: __startTimestamp1449187987108__endTimestamp 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4585.39 Median:4721.29 stddev:474.92 (10.1%) stddev-sans-first:449.86 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: Values: 2590.9 2700.8 2709.6 2713.6 2716.6 4378.4 4511.8 4596.9 4653.5 4672.5 4579.6 4633.7 4667.9 4676.5 4687.9 4265.3 4282.0 4333.0 4348.9 4359.7 4126.8 4274.7 4297.1 4352.4 4392.5 4200.8 4220.4 4286.1 4288.0 4308.0 4241.1 4252.8 4271.8 4289.7 4340.2 4115.4 4208.6 4225.7 4244.5 4266.6 4494.2 4540.7 4573.1 4589.9 4617.4 4943.1 5002.9 5003.7 5010.0 5066.1 4828.6 4989.7 5020.1 5022.2 5030.3 4577.6 4610.0 4669.8 4691.2 4730.0 5100.8 5132.2 5133.1 5138.4 5186.4 4707.1 4841.6 4910.0 4951.9 4992.3 4839.5 4917.6 4928.2 4946.6 4966.1 4965.2 4970.2 4971.7 4976.1 4983.7 4940.3 4943.8 4946.9 4947.5 4977.6 3920.2 3990.0 4031.4 4057.0 4186.1 3649.6 3653.6 3656.1 3663.3 3683.7 4296.0 4300.7 4303.8 4334.8 4336.6 4781.8 4813.3 4910.9 4912.8 4972.6 4326.0 4330.9 4333.1 4343.1 4362.2 4442.5 4445.8 4452.7 4497.4 4497.8 4589.4 4700.5 4717.6 4721.3 4829.3 4938.4 4970.3 4971.1 4971.9 5004.9 4731.0 4732.1 4736.1 4774.3 4783.6 4751.8 4829.3 4886.9 4897.7 4928.6 4965.8 4977.7 4978.5 4983.7 4994.3 4824.3 4826.8 4830.3 4834.7 4863.7 4679.8 4710.3 4762.1 4819.6 4875.8 4762.3 4763.5 4772.1 4784.4 4837.2 4898.3 4898.4 4901.4 4907.5 4934.6 4614.2 4709.3 4741.0 4747.5 4831.4 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: 16:13:07 INFO - 2015-12-03 16:13:07,118 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41890.69 Median:31756.02 stddev:67236.01 (211.7%) stddev-sans-first:67353.04 16:13:07 INFO - 2015-12-03 16:13:07,119 DEBUG : BROWSER_OUTPUT: Values: 568.9 573.8 582.3 585.0 587.4 28114.0 28650.1 38056.8 38274.2 38318.0 39916.0 40120.0 40437.2 40518.6 40546.2 7001.1 7914.6 8045.4 8067.2 8079.9 7114.7 10151.3 10529.6 10536.2 10537.8 10216.5 10307.8 10312.8 10315.9 10327.7 7102.2 7332.1 10014.0 10153.2 10223.7 9977.9 10106.4 10111.6 10111.9 10114.7 36599.6 37258.4 37274.0 37279.6 37286.6 2915.6 3252.4 3301.5 3505.9 3542.1 27959.4 28100.4 28159.3 28541.1 29146.3 3458.4 3540.5 3540.8 3552.5 3660.2 209674.0 209960.0 211657.0 212146.0 212284.0 51515.0 52725.2 54040.7 54486.7 62384.4 58352.7 58394.7 58641.4 58657.4 58752.4 13597.5 13793.7 13896.3 13898.2 13910.6 10668.2 10714.0 10727.2 10741.3 10755.6 19358.4 19616.8 19760.3 19791.9 19805.9 7245.3 7521.5 7531.4 7585.8 7592.3 791.1 815.2 816.9 839.2 854.7 26212.2 26336.9 26818.9 26822.3 26975.6 936.9 941.8 966.7 997.2 1019.4 13785.7 13854.8 13982.2 13994.9 14006.9 301411.0 307166.0 308050.0 308170.0 308694.0 48303.8 48651.0 48656.0 48802.8 48824.8 1208.6 1213.4 1227.3 1228.2 1228.5 21814.9 30867.4 31251.8 31374.5 31760.5 43944.3 44667.3 44737.1 44756.8 44786.1 244276.0 246198.0 246329.0 247107.0 247152.0 24495.6 28522.1 28860.1 28908.9 29233.4 35877.5 36632.0 36807.6 36963.3 37837.0 31711.8 31751.5 31840.4 32373.7 32831.5 32082.0 32547.7 32627.3 32661.3 32808.2 32840.7 33176.0 33248.0 33295.2 36311.1 29059.9 29557.9 31118.4 31349.2 31378.4 23976.9 24051.8 24264.0 24531.9 24550.9 16:13:07 INFO - 2015-12-03 16:13:07,119 DEBUG : BROWSER_OUTPUT: 16:13:07 INFO - 2015-12-03 16:13:07,119 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25778.19 Median:21582.34 stddev:76037.56 (352.3%) stddev-sans-first:76226.86 16:13:07 INFO - 2015-12-03 16:13:07,120 DEBUG : BROWSER_OUTPUT: Values: 332.9 336.8 337.0 340.5 341.2 12223.6 12613.3 14923.8 15056.8 15686.5 12878.4 13274.2 14289.7 14569.3 14931.9 4476.3 4875.0 5022.8 5024.9 5761.5 3603.1 3735.7 5558.1 5694.4 5749.1 5676.8 5682.5 5684.9 5725.2 5732.6 5636.9 5758.7 5760.7 5762.6 5763.8 5053.1 5058.7 5061.1 5068.8 5072.5 18956.4 18963.0 19303.7 19539.3 19572.0 1827.4 1853.9 1873.8 1918.1 2027.0 12595.7 12600.6 12696.4 12810.3 13131.2 1769.8 1781.6 1787.6 1800.4 1837.2 50968.0 52726.5 53183.7 53627.9 54044.9 9256.4 9370.9 9474.8 9480.2 9552.9 11942.6 11984.8 12011.9 12018.1 12028.8 7059.8 7087.9 7181.3 7183.9 7217.5 6709.3 6746.9 6759.3 6780.1 6807.0 5676.5 5716.9 5736.2 5738.5 5810.7 1565.7 1603.1 1608.7 1614.2 1618.6 723.6 772.0 834.7 864.1 950.0 15027.8 15519.4 15696.3 16082.0 16171.9 764.7 837.2 853.5 917.6 949.1 8290.1 9025.5 9074.5 9218.8 9270.3 453297.0 459219.0 459472.0 466076.0 490488.0 69240.7 70544.0 71652.0 72927.6 73748.6 986.3 1011.6 1013.0 1019.3 1045.5 13565.4 14029.0 14143.9 14388.6 14562.6 30283.1 32049.4 32451.0 32925.0 33656.7 39429.0 40168.6 42070.8 42218.8 42762.6 8971.1 9029.7 9040.1 9179.3 9201.2 13727.7 16050.0 16816.9 16879.8 16933.7 13610.5 13878.0 13958.7 13984.8 14441.3 13498.1 13641.7 13654.2 13973.8 14008.6 11106.9 14168.6 14262.0 14368.1 14709.9 7916.1 8245.0 9001.7 9323.4 9326.1 13711.2 13827.0 14078.9 14292.0 14295.5 16:13:07 INFO - 2015-12-03 16:13:07,120 DEBUG : BROWSER_OUTPUT: 16:13:07 INFO - 2015-12-03 16:13:07,120 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5136.78 Median:6265.90 stddev:2727.26 (43.5%) stddev-sans-first:2718.97 16:13:07 INFO - 2015-12-03 16:13:07,120 DEBUG : BROWSER_OUTPUT: Values: 1213.3 1401.2 1424.3 1619.2 1702.0 6293.2 6503.7 7218.5 7377.1 7385.9 6993.1 7043.0 7086.1 7104.0 7137.4 2083.5 2106.8 2123.4 2125.4 2125.9 2093.4 2115.4 2125.6 2126.0 2128.4 2115.7 2135.6 2157.2 2160.8 2161.6 2150.4 2167.7 2173.7 2175.6 2183.2 2118.4 2179.0 2179.1 2179.3 2180.3 6234.8 7311.7 7417.8 7421.7 7427.2 3735.2 3811.2 4202.2 4288.1 4289.8 2748.9 2773.9 2790.5 2796.9 2874.9 890.0 890.1 898.4 912.7 916.2 10137.9 10267.7 10281.7 10290.8 10298.3 4119.3 4166.0 4180.4 4220.9 4232.1 8857.1 8885.4 8887.0 8888.1 8894.6 4364.8 4367.9 4370.2 4372.3 4372.8 3899.7 3902.6 3908.8 3915.0 3915.6 3348.0 3366.2 3369.3 3392.8 3396.3 1084.5 1085.9 1087.4 1096.2 1097.7 1044.7 1052.9 1069.0 1070.2 1090.0 6917.7 6947.8 6972.6 6990.2 7018.6 450.6 453.7 463.6 463.6 463.7 4984.0 5459.7 5468.5 5495.6 5547.8 8081.8 8803.9 8931.1 9146.7 9147.6 8768.3 8884.3 8922.3 8941.9 8943.7 6889.2 6972.4 7034.0 7034.5 7035.4 6700.2 6709.9 6767.2 6770.3 6784.2 7867.8 7971.5 8025.8 8057.2 8104.5 8084.0 8219.7 8228.0 8311.5 8327.7 6272.5 6311.5 6314.4 6324.8 6340.9 7009.4 7056.1 7068.0 7069.8 7087.5 6680.6 6716.6 6750.0 6860.9 6899.5 6548.0 6558.8 6602.0 6668.4 6699.3 6734.7 6771.6 6823.6 6885.3 6885.4 6211.8 6251.3 6255.9 6260.5 6271.3 6258.4 6300.9 6304.0 6323.7 6324.6 16:13:07 INFO - 2015-12-03 16:13:07,120 DEBUG : BROWSER_OUTPUT: 16:13:07 INFO - 2015-12-03 16:13:07,120 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4608.99 Median:5217.85 stddev:1351.34 (25.9%) stddev-sans-first:1315.80 16:13:07 INFO - 2015-12-03 16:13:07,122 DEBUG : BROWSER_OUTPUT: Values: 296.5 306.9 307.9 311.0 311.6 5236.3 5274.2 5274.8 5285.8 5291.2 5152.9 5165.5 5217.5 5218.2 5220.9 4115.9 4116.3 4116.6 4120.4 4121.6 3917.2 4029.8 4121.2 4124.2 4125.6 3801.2 3816.0 3979.5 3993.5 3996.8 3970.4 4020.6 4050.7 4061.3 4078.2 3597.4 3625.5 3626.3 3637.8 3640.1 4794.1 4938.8 4942.1 5014.4 5033.1 4684.2 4690.9 4693.2 4695.7 4699.3 5520.8 5536.3 5536.4 5541.3 5550.0 3685.7 3806.1 3857.2 3910.1 3919.7 5762.9 5768.6 5785.7 5792.6 5806.0 4038.8 4041.3 4042.2 4046.8 4047.3 4094.6 4099.7 4100.5 4102.2 4103.5 4564.9 4644.6 4655.0 4669.7 4683.1 5541.3 5541.4 5541.5 5546.1 5547.5 1434.9 1444.0 1447.5 1450.0 1450.6 988.9 991.8 1001.9 1009.7 1023.1 4891.8 4897.8 4904.9 4905.2 4917.4 5665.0 5725.3 5745.6 5748.4 5749.5 4890.4 4897.0 4902.3 4903.3 4907.2 3015.8 3062.0 3087.3 3090.8 3103.9 5519.3 5527.1 5533.7 5535.0 5545.9 5960.8 5962.5 5971.7 5972.9 5977.9 5517.4 5528.5 5538.5 5539.0 5539.1 5645.4 5792.4 5802.8 5803.0 5807.8 5461.9 5576.8 5673.1 5678.4 5683.8 5379.1 5464.5 5503.1 5504.3 5504.3 3947.2 3986.7 3992.0 3993.5 3995.6 5743.2 5760.4 5764.2 5782.3 5782.7 5411.7 5553.2 5558.0 5560.4 5565.9 5552.7 5561.5 5568.6 5569.4 5573.1 5438.8 5441.5 5442.3 5443.3 5446.3 5481.3 5594.2 5596.1 5599.6 5601.1 5451.8 5458.8 5464.5 5469.0 5472.7 16:13:07 INFO - 2015-12-03 16:13:07,122 DEBUG : BROWSER_OUTPUT: 16:13:07 INFO - 2015-12-03 16:13:07,122 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12258.79 Median:439.66 stddev:13865.16 (3153.6%) stddev-sans-first:13877.17 16:13:07 INFO - 2015-12-03 16:13:07,123 DEBUG : BROWSER_OUTPUT: Values: 760.5 778.7 781.9 792.9 795.2 11858.6 12640.6 12661.5 12676.7 12711.6 12160.5 12285.8 12291.3 12303.4 12311.3 610.6 619.3 765.2 767.9 785.4 780.0 781.6 781.8 787.6 789.3 635.4 816.5 823.6 823.8 824.4 638.0 800.2 810.3 811.3 812.5 603.4 603.8 604.2 604.2 604.6 11495.9 11850.9 11857.1 11858.2 11902.3 11346.3 11983.9 12192.6 12260.6 12502.7 9560.0 9835.4 9841.9 10204.1 10236.6 3273.7 3292.6 3324.2 3382.7 3439.7 42737.6 42920.4 43230.6 43260.4 43308.8 9296.4 9302.6 9471.1 9476.7 9520.4 16241.1 16293.3 16309.4 16342.5 16352.6 6158.8 6171.6 6217.1 6362.4 6371.9 3640.7 3659.2 3688.1 3713.7 3767.4 2653.8 2685.7 2695.3 2709.7 2710.9 488.3 490.9 491.7 511.1 511.9 437.9 441.4 447.5 460.8 488.6 7307.0 7449.8 7529.1 7886.8 7934.9 570.6 577.2 584.1 597.1 619.8 3328.6 3333.4 3391.3 3393.0 3473.5 49123.5 50180.7 50209.5 50212.0 50320.5 42708.8 42830.0 42883.6 44946.3 45247.3 39355.4 40061.2 40315.8 40323.0 40928.2 7478.7 7952.3 7968.7 8009.7 8043.3 29884.3 30764.4 30819.0 30884.5 31027.2 36508.5 38654.4 39355.4 39470.6 39836.6 10068.5 10070.2 10169.5 10255.8 10332.3 11463.2 11676.9 11835.3 11841.6 12089.9 9984.8 10131.3 10923.3 10947.9 11291.8 10757.4 11170.7 11218.3 11620.2 11639.2 7702.9 8255.5 8602.1 9975.5 10116.1 8404.7 8564.4 8996.9 9054.4 9071.1 7230.0 7820.9 7880.2 8200.0 9163.8 16:13:07 INFO - 2015-12-03 16:13:07,123 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:13:07 INFO - 2015-12-03 16:13:07,123 DEBUG : BROWSER_OUTPUT: 16:13:07 INFO - 2015-12-03 16:13:07,877 INFO : Browser exited with error code: 0 16:13:07 INFO - 2015-12-03 16:13:07,901 INFO : Completed test dromaeo_css (00:18:36) 16:13:07 INFO - 2015-12-03 16:13:07,901 INFO : Starting test kraken 16:13:07 INFO - 2015-12-03 16:13:07,901 DEBUG : operating with platform_type : linux_ 16:13:07 INFO - 2015-12-03 16:13:07,901 INFO : Initialising browser for kraken test... 16:13:07 INFO - 2015-12-03 16:13:07,907 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpODflTH/profile http://localhost:41015/getInfo.html 16:13:11 INFO - 2015-12-03 16:13:11,459 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:13:11 INFO - 2015-12-03 16:13:11,459 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:13:11 INFO - 2015-12-03 16:13:11,459 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:13:11 INFO - 2015-12-03 16:13:11,459 DEBUG : BROWSER_OUTPUT: __metrics 16:13:11 INFO - 2015-12-03 16:13:11,596 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] 16:13:11 INFO - 2015-12-03 16:13:11,596 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] 16:13:12 INFO - 2015-12-03 16:13:12,728 INFO : Browser initialized. 16:13:12 INFO - 2015-12-03 16:13:12,728 INFO : Running cycle 1/1 for kraken test... 16:13:12 INFO - 2015-12-03 16:13:12,728 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpODflTH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:13:24 INFO - 2015-12-03 16:13:24,662 DEBUG : BROWSER_OUTPUT: RSS: Main: 144478208 16:13:24 INFO - 2015-12-03 16:13:24,662 DEBUG : BROWSER_OUTPUT: 16:13:27 INFO - 2015-12-03 16:13:27,272 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41015/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:27 INFO - 2015-12-03 16:13:27,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 181465088 16:13:27 INFO - 2015-12-03 16:13:27,853 DEBUG : BROWSER_OUTPUT: 16:13:30 INFO - 2015-12-03 16:13:30,556 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41015/tests/kraken/driver.html?testName=audio-dft) 16:13:31 INFO - 2015-12-03 16:13:31,129 DEBUG : BROWSER_OUTPUT: RSS: Main: 172044288 16:13:31 INFO - 2015-12-03 16:13:31,129 DEBUG : BROWSER_OUTPUT: 16:13:34 INFO - 2015-12-03 16:13:34,149 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41015/tests/kraken/driver.html?testName=audio-fft) 16:13:34 INFO - 2015-12-03 16:13:34,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 153915392 16:13:34 INFO - 2015-12-03 16:13:34,710 DEBUG : BROWSER_OUTPUT: 16:13:36 INFO - 2015-12-03 16:13:36,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41015/tests/kraken/driver.html?testName=audio-oscillator) 16:13:37 INFO - 2015-12-03 16:13:37,325 DEBUG : BROWSER_OUTPUT: RSS: Main: 156360704 16:13:37 INFO - 2015-12-03 16:13:37,325 DEBUG : BROWSER_OUTPUT: 16:13:39 INFO - 2015-12-03 16:13:39,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41015/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:40 INFO - 2015-12-03 16:13:40,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 157544448 16:13:40 INFO - 2015-12-03 16:13:40,133 DEBUG : BROWSER_OUTPUT: 16:13:43 INFO - 2015-12-03 16:13:43,114 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41015/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:43 INFO - 2015-12-03 16:13:43,687 DEBUG : BROWSER_OUTPUT: RSS: Main: 157216768 16:13:43 INFO - 2015-12-03 16:13:43,687 DEBUG : BROWSER_OUTPUT: 16:13:47 INFO - 2015-12-03 16:13:47,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41015/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:47 INFO - 2015-12-03 16:13:47,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 159404032 16:13:47 INFO - 2015-12-03 16:13:47,648 DEBUG : BROWSER_OUTPUT: 16:13:50 INFO - 2015-12-03 16:13:50,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41015/tests/kraken/driver.html?testName=json-parse-financial) 16:13:51 INFO - 2015-12-03 16:13:51,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 157200384 16:13:51 INFO - 2015-12-03 16:13:51,108 DEBUG : BROWSER_OUTPUT: 16:13:52 INFO - 2015-12-03 16:13:52,900 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41015/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:53 INFO - 2015-12-03 16:13:53,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 168493056 16:13:53 INFO - 2015-12-03 16:13:53,461 DEBUG : BROWSER_OUTPUT: 16:13:55 INFO - 2015-12-03 16:13:55,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:55 INFO - 2015-12-03 16:13:55,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 168296448 16:13:55 INFO - 2015-12-03 16:13:55,946 DEBUG : BROWSER_OUTPUT: 16:13:58 INFO - 2015-12-03 16:13:58,083 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:58 INFO - 2015-12-03 16:13:58,669 DEBUG : BROWSER_OUTPUT: RSS: Main: 177930240 16:13:58 INFO - 2015-12-03 16:13:58,669 DEBUG : BROWSER_OUTPUT: 16:14:01 INFO - 2015-12-03 16:14:01,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:01 INFO - 2015-12-03 16:14:01,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 184152064 16:14:01 INFO - 2015-12-03 16:14:01,797 DEBUG : BROWSER_OUTPUT: 16:14:04 INFO - 2015-12-03 16:14:04,384 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:04 INFO - 2015-12-03 16:14:04,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 184152064 16:14:04 INFO - 2015-12-03 16:14:04,966 DEBUG : BROWSER_OUTPUT: 16:14:06 INFO - 2015-12-03 16:14:06,740 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41015/tests/kraken/driver.html?testName=ai-astar) 16:14:06 INFO - 2015-12-03 16:14:06,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 240160768 16:14:06 INFO - 2015-12-03 16:14:06,990 DEBUG : BROWSER_OUTPUT: 16:14:06 INFO - 2015-12-03 16:14:06,993 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:14:06 INFO - 2015-12-03 16:14:06,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:14:06 INFO - 2015-12-03 16:14:06,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:14:06 INFO - 2015-12-03 16:14:06,994 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:14:06 INFO - 2015-12-03 16:14:06,994 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;107;112;113;112;99;111;111;108 16:14:06 INFO - 2015-12-03 16:14:06,994 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;130;149;169;130;153;163;131;175;129 16:14:06 INFO - 2015-12-03 16:14:06,994 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;160;162;159;161;161;161;161 16:14:06 INFO - 2015-12-03 16:14:06,994 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;87;99;73;73;71;85;87;72 16:14:06 INFO - 2015-12-03 16:14:06,994 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;130;94;94;94;126;93;94;128 16:14:06 INFO - 2015-12-03 16:14:06,994 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;110;109;109;109;110;109 16:14:06 INFO - 2015-12-03 16:14:06,995 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;147;147;146;147;147;146;146 16:14:06 INFO - 2015-12-03 16:14:06,995 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;96;95;95;96;95;96;95 16:14:06 INFO - 2015-12-03 16:14:06,995 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;70;70;70;70;70;72;73;71;69 16:14:06 INFO - 2015-12-03 16:14:06,995 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;68;68;68;70;68;69 16:14:06 INFO - 2015-12-03 16:14:06,995 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;86;85;84;84;84;85;84;93 16:14:06 INFO - 2015-12-03 16:14:06,995 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;128;131;126;119;125;127;121;120;120 16:14:06 INFO - 2015-12-03 16:14:06,995 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;154;142;145;147;147;137;149;158;137;134 16:14:06 INFO - 2015-12-03 16:14:06,996 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;67;69;68;70;67;68;68;68 16:14:06 INFO - 2015-12-03 16:14:06,996 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:14:07 INFO - 2015-12-03 16:14:06,996 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:14:07 INFO - 2015-12-03 16:14:06,996 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,993 16:14:07 INFO - 2015-12-03 16:14:06,996 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:14:07 INFO - 2015-12-03 16:14:06,996 DEBUG : BROWSER_OUTPUT: __startTimestamp1449188046992__endTimestamp 16:14:07 INFO - 2015-12-03 16:14:06,996 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,004 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:14:07 INFO - 2015-12-03 16:14:07,004 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:14:07 INFO - 2015-12-03 16:14:07,004 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,004 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.50 Median:112.00 stddev:4.14 (3.7%) stddev-sans-first:4.39 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 107.0 112.0 113.0 112.0 99.0 111.0 111.0 108.0 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.60 Median:155.00 stddev:17.63 (11.4%) stddev-sans-first:18.43 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: Values: 157.0 130.0 149.0 169.0 130.0 153.0 163.0 131.0 175.0 129.0 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 160.0 162.0 159.0 161.0 161.0 161.0 161.0 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:79.00 stddev:9.62 (12.2%) stddev-sans-first:9.85 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 87.0 99.0 73.0 73.0 71.0 85.0 87.0 72.0 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:94.00 stddev:16.52 (17.6%) stddev-sans-first:17.12 16:14:07 INFO - 2015-12-03 16:14:07,005 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 130.0 94.0 94.0 94.0 126.0 93.0 94.0 128.0 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 109.0 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 147.0 147.0 146.0 147.0 147.0 146.0 146.0 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.80 Median:70.50 stddev:1.40 (2.0%) stddev-sans-first:1.24 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: Values: 73.0 70.0 70.0 70.0 70.0 70.0 72.0 73.0 71.0 69.0 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 68.0 68.0 68.0 70.0 68.0 69.0 16:14:07 INFO - 2015-12-03 16:14:07,006 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,007 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.40 Median:85.00 stddev:2.84 (3.3%) stddev-sans-first:2.87 16:14:07 INFO - 2015-12-03 16:14:07,007 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 86.0 85.0 84.0 84.0 84.0 85.0 84.0 93.0 16:14:07 INFO - 2015-12-03 16:14:07,007 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,007 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.50 Median:126.50 stddev:4.20 (3.3%) stddev-sans-first:4.26 16:14:07 INFO - 2015-12-03 16:14:07,007 DEBUG : BROWSER_OUTPUT: Values: 128.0 128.0 131.0 126.0 119.0 125.0 127.0 121.0 120.0 120.0 16:14:07 INFO - 2015-12-03 16:14:07,007 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,007 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.00 Median:147.00 stddev:7.69 (5.2%) stddev-sans-first:7.43 16:14:07 INFO - 2015-12-03 16:14:07,007 DEBUG : BROWSER_OUTPUT: Values: 154.0 142.0 145.0 147.0 147.0 137.0 149.0 158.0 137.0 134.0 16:14:07 INFO - 2015-12-03 16:14:07,007 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,007 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.00 stddev:1.26 (1.9%) stddev-sans-first:0.93 16:14:07 INFO - 2015-12-03 16:14:07,008 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 67.0 69.0 68.0 70.0 67.0 68.0 68.0 68.0 16:14:07 INFO - 2015-12-03 16:14:07,008 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:14:07 INFO - 2015-12-03 16:14:07,008 DEBUG : BROWSER_OUTPUT: 16:14:07 INFO - 2015-12-03 16:14:07,857 INFO : Browser exited with error code: 0 16:14:07 INFO - 2015-12-03 16:14:07,909 INFO : Completed test kraken (00:01:00) 16:14:07 INFO - 2015-12-03 16:14:07,909 INFO : Starting test v8_7 16:14:07 INFO - 2015-12-03 16:14:07,909 DEBUG : operating with platform_type : linux_ 16:14:07 INFO - 2015-12-03 16:14:07,909 INFO : Initialising browser for v8_7 test... 16:14:07 INFO - 2015-12-03 16:14:07,915 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp47tEdY/profile http://localhost:41015/getInfo.html 16:14:11 INFO - 2015-12-03 16:14:11,470 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:14:11 INFO - 2015-12-03 16:14:11,470 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:14:11 INFO - 2015-12-03 16:14:11,470 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:14:11 INFO - 2015-12-03 16:14:11,470 DEBUG : BROWSER_OUTPUT: __metrics 16:14:11 INFO - 2015-12-03 16:14:11,587 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] 16:14:11 INFO - 2015-12-03 16:14:11,587 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] 16:14:12 INFO - 2015-12-03 16:14:12,585 INFO : Browser initialized. 16:14:12 INFO - 2015-12-03 16:14:12,586 INFO : Running cycle 1/1 for v8_7 test... 16:14:12 INFO - 2015-12-03 16:14:12,586 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp47tEdY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:14:24 INFO - 2015-12-03 16:14:24,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 143540224 16:14:24 INFO - 2015-12-03 16:14:24,535 DEBUG : BROWSER_OUTPUT: 16:14:45 INFO - 2015-12-03 16:14:45,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41015/tests/v8_7/run.html (next: http://localhost:41015/tests/v8_7/run.html) 16:14:46 INFO - 2015-12-03 16:14:46,184 DEBUG : BROWSER_OUTPUT: RSS: Main: 445337600 16:14:46 INFO - 2015-12-03 16:14:46,184 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,184 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:14:46 INFO - 2015-12-03 16:14:46,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:14:46 INFO - 2015-12-03 16:14:46,186 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:14:46 INFO - 2015-12-03 16:14:46,186 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:14:46 INFO - 2015-12-03 16:14:46,186 DEBUG : BROWSER_OUTPUT: |0;Richards;168.09547823163558 16:14:46 INFO - 2015-12-03 16:14:46,186 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;193.91118867558657 16:14:46 INFO - 2015-12-03 16:14:46,187 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.74115665356544 16:14:46 INFO - 2015-12-03 16:14:46,187 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5235.602094240838 16:14:46 INFO - 2015-12-03 16:14:46,187 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2047.034764826176 16:14:46 INFO - 2015-12-03 16:14:46,187 DEBUG : BROWSER_OUTPUT: |5;Earley;790.0552486187845 16:14:46 INFO - 2015-12-03 16:14:46,188 DEBUG : BROWSER_OUTPUT: |6;Boyer;12132.530120481928 16:14:46 INFO - 2015-12-03 16:14:46,188 DEBUG : BROWSER_OUTPUT: |7;RegExp;26763.157894736843 16:14:46 INFO - 2015-12-03 16:14:46,188 DEBUG : BROWSER_OUTPUT: |8;Splay;603.1081888822474 16:14:46 INFO - 2015-12-03 16:14:46,188 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 16:14:46 INFO - 2015-12-03 16:14:46,188 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:14:46 INFO - 2015-12-03 16:14:46,189 DEBUG : BROWSER_OUTPUT: __startTimestamp1449188086184__endTimestamp 16:14:46 INFO - 2015-12-03 16:14:46,189 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,189 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:14:46 INFO - 2015-12-03 16:14:46,189 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:14:46 INFO - 2015-12-03 16:14:46,190 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,190 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.10 Median:168.10 stddev:0.00 (0.0%) 16:14:46 INFO - 2015-12-03 16:14:46,190 DEBUG : BROWSER_OUTPUT: Values: 168.1 16:14:46 INFO - 2015-12-03 16:14:46,190 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,191 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:193.91 Median:193.91 stddev:0.00 (0.0%) 16:14:46 INFO - 2015-12-03 16:14:46,191 DEBUG : BROWSER_OUTPUT: Values: 193.9 16:14:46 INFO - 2015-12-03 16:14:46,191 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,191 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.74 Median:280.74 stddev:0.00 (0.0%) 16:14:46 INFO - 2015-12-03 16:14:46,192 DEBUG : BROWSER_OUTPUT: Values: 280.7 16:14:46 INFO - 2015-12-03 16:14:46,192 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,192 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5235.60 Median:5235.60 stddev:0.00 (0.0%) 16:14:46 INFO - 2015-12-03 16:14:46,192 DEBUG : BROWSER_OUTPUT: Values: 5235.6 16:14:46 INFO - 2015-12-03 16:14:46,193 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,193 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2047.03 Median:2047.03 stddev:0.00 (0.0%) 16:14:46 INFO - 2015-12-03 16:14:46,193 DEBUG : BROWSER_OUTPUT: Values: 2047.0 16:14:46 INFO - 2015-12-03 16:14:46,193 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,194 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:790.06 Median:790.06 stddev:0.00 (0.0%) 16:14:46 INFO - 2015-12-03 16:14:46,194 DEBUG : BROWSER_OUTPUT: Values: 790.1 16:14:46 INFO - 2015-12-03 16:14:46,194 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,194 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12132.53 Median:12132.53 stddev:0.00 (0.0%) 16:14:46 INFO - 2015-12-03 16:14:46,195 DEBUG : BROWSER_OUTPUT: Values: 12132.5 16:14:46 INFO - 2015-12-03 16:14:46,195 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,195 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26763.16 Median:26763.16 stddev:0.00 (0.0%) 16:14:46 INFO - 2015-12-03 16:14:46,195 DEBUG : BROWSER_OUTPUT: Values: 26763.2 16:14:46 INFO - 2015-12-03 16:14:46,196 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,196 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:603.11 Median:603.11 stddev:0.00 (0.0%) 16:14:46 INFO - 2015-12-03 16:14:46,196 DEBUG : BROWSER_OUTPUT: Values: 603.1 16:14:46 INFO - 2015-12-03 16:14:46,196 DEBUG : BROWSER_OUTPUT: 16:14:46 INFO - 2015-12-03 16:14:46,197 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 16:14:46 INFO - 2015-12-03 16:14:46,197 DEBUG : BROWSER_OUTPUT: Values: 4840.6 16:14:46 INFO - 2015-12-03 16:14:46,197 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:14:46 INFO - 2015-12-03 16:14:46,197 DEBUG : BROWSER_OUTPUT: 16:14:47 INFO - 2015-12-03 16:14:47,077 INFO : Browser exited with error code: 0 16:14:47 INFO - 2015-12-03 16:14:47,089 INFO : Completed test v8_7 (00:00:39) 16:14:47 INFO - 2015-12-03 16:14:47,207 INFO : Completed test suite (00:20:15) 16:14:47 INFO - 2015-12-03 16:14:47,208 DEBUG : Working with test: dromaeo_css 16:14:47 INFO - 2015-12-03 16:14:47,208 DEBUG : Generating results file: dromaeo_css 16:14:47 INFO - 2015-12-03 16:14:47,209 DEBUG : Working with test: kraken 16:14:47 INFO - 2015-12-03 16:14:47,209 DEBUG : Generating results file: kraken 16:14:47 INFO - 2015-12-03 16:14:47,209 INFO : javascript benchmark 16:14:47 INFO - 2015-12-03 16:14:47,209 DEBUG : Working with test: v8_7 16:14:47 INFO - 2015-12-03 16:14:47,210 DEBUG : Generating results file: v8_7 16:14:47 INFO - 2015-12-03 16:14:47,210 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:14:47 INFO - 2015-12-03 16:14:47,274 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,26,35]] 16:14:47 INFO - 2015-12-03 16:14:47,274 DEBUG : process_Request line: dromaeo_css 6341.55 graph.html#tests=[[72,26,35]] 16:14:47 INFO - 2015-12-03 16:14:47,275 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:14:47 INFO - 2015-12-03 16:14:47,305 DEBUG : process_Request line: kraken 1515.70 graph.html#tests=[[232,26,35]] 16:14:47 INFO - 2015-12-03 16:14:47,305 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:14:47 INFO - 2015-12-03 16:14:47,338 DEBUG : process_Request line: v8_7 19625.60 graph.html#tests=[[230,26,35]] 16:14:47 INFO - 2015-12-03 16:14:47,339 INFO : javascript benchmark 16:14:47 INFO - 2015-12-03 16:14:47,343 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2590.92227233183, 2700.779683449515, 2709.620653108565, 2713.633659455973, 2716.5925111233314, 4378.365137055125, 4511.819527218916, 4596.862094137177, 4653.511381304961, 4672.5327467253255, 4579.610733087691, 4633.675642705012, 4667.929981050287, 4676.462206846214, 4687.859364219071, 4265.296226122686, 4281.978590107045, 4332.97833510832, 4348.869533913988, 4359.673024523157, 4126.793660316972, 4274.679399045069, 4297.097609502009, 4352.434183556134, 4392.494863090737, 4200.810963506619, 4220.430241917333, 4286.078493123993, 4288.0, 4308.030693094061, 4241.088166044285, 4252.829886804555, 4271.807768650418, 4289.6997210195295, 4340.197063543254, 4115.403266526337, 4208.621224089816, 4225.68307376948, 4244.533101358848, 4266.616004559604, 4494.16857881293, 4540.72755634663, 4573.062522182978, 4589.885252868671, 4617.445906491243, 4943.06081844452, 5002.874928126826, 5003.749812509396, 5010.0, 5066.088104141253, 4828.61371090312, 4989.675671081368, 5020.0963826511215, 5022.221555658843, 5030.320906677588, 4577.5880170784785, 4609.976950115261, 4669.836555720533, 4691.225947718656, 4730.0, 5100.770465329069, 5132.153194722829, 5133.101707201225, 5138.3833939927445, 5186.429492755794, 4707.082118986833, 4841.612670986313, 4910.0, 4951.876203094951, 4992.326035985168, 4839.467658557556, 4917.58200552957, 4928.186849169919, 4946.554810067111, 4966.056449274626, 4965.155923493015, 4970.179920313108, 4971.701697898137, 4976.129177393942, 4983.700977941335, 4940.283658869444, 4943.826966056171, 4946.851594452172, 4947.505249475023, 4977.626677999165, 3920.1571662092215, 3989.960100399017, 4031.3952907064177, 4056.9797151014645, 4186.05813691923, 3649.6168896711633, 3653.5615726113037, 3656.104254457675, 3663.285659296465, 3683.723720720903, 4295.978520107379, 4300.698951073395, 4303.763293018851, 4334.761588112684, 4336.631386332134, 4781.784819683123, 4813.302071199656, 4910.852674419773, 4912.778924948315, 4972.577330926912, 4326.0, 4330.935035974463, 4333.090051089243, 4343.109662519176, 4362.214801335726, 4442.511323754385, 4445.822167113344, 4452.710573812692, 4497.370368148462, 4497.797599107983, 4589.380433641482, 4700.529947005272, 4717.622590192845, 4721.2918062289555, 4829.323894654751, 4938.407391113089, 4970.254461830755, 4971.080350135237, 4971.850844474671, 5004.899902002013, 4731.006488637425, 4732.053589282088, 4736.100140973204, 4774.331593576832, 4783.617310615212, 4751.809927602857, 4829.348038014964, 4886.902261954812, 4897.681650692836, 4928.581070608895, 4965.826196083264, 4977.701337919736, 4978.4523702393435, 4983.651144419856, 4994.275830004702, 4824.252240902666, 4826.758662066953, 4830.2513110467935, 4834.734089625104, 4863.7324947128245, 4679.766011699333, 4710.317004034464, 4762.119007983534, 4819.638527110411, 4875.780589873393, 4762.261849413347, 4763.499832517536, 4772.141014617263, 4784.40194975628, 4837.153498137882, 4898.33872427232, 4898.436679781728, 4901.387326584177, 4907.484714104968, 4934.5805606523845, 4614.238650622609, 4709.270063140219, 4741.0, 4747.525247475225, 4831.371921650163], "unit": "ms", "name": "dojo.html", "value": 4556.202892986457}, {"lowerIsBetter": false, "replicates": [568.866316415642, 573.7532860869826, 582.3245035758521, 585.0084107437895, 587.43899575905, 28114.0, 28650.140495785134, 38056.809715951415, 38274.234515309676, 38318.0, 39916.0, 40120.0, 40437.19125617486, 40518.59481405185, 40546.189076218456, 7001.124859392576, 7914.6042697865305, 8045.356371490267, 8067.233612806774, 8079.9192008080045, 7114.715411383539, 10151.340162889426, 10529.6314628988, 10536.209784266171, 10537.78924421515, 10216.48917554123, 10307.793844123113, 10312.793744125112, 10315.896841031568, 10327.741806454862, 7102.218755936843, 7332.120145582511, 10014.0, 10153.187744980383, 10223.693289201336, 9977.850332245021, 10106.393616382968, 10111.646092386805, 10111.949440252825, 10114.747131321703, 36599.63400365989, 37258.44112338317, 37274.0, 37279.62720372788, 37286.62713372859, 2915.6355455568055, 3252.414565378231, 3301.504774283853, 3505.94741078884, 3542.0613537412605, 27959.440811183867, 28100.437991240062, 28159.296017599518, 28541.143765687062, 29146.271343216376, 3458.429359155736, 3540.504329393887, 3540.8406621702084, 3552.5381700379044, 3660.1764602964386, 209674.0, 209960.0, 211657.0, 212146.0, 212284.0, 51515.0, 52725.209121863205, 54040.72979635155, 54486.727566361915, 62384.376156238766, 58352.708236459395, 58394.708026460445, 58641.41358586359, 58657.4134258652, 58752.41247587469, 13597.456101756017, 13793.655158621115, 13896.305184740722, 13898.235597042058, 13910.58268251954, 10668.199885008655, 10714.035736783728, 10727.195460340507, 10741.301815381976, 10755.623553175757, 19358.4192474226, 19616.803831961497, 19760.308389206308, 19791.901040494704, 19805.900970495342, 7245.275472452818, 7521.548707077593, 7531.359834414026, 7585.848283034308, 7592.316691497792, 791.133708589094, 815.2418251026602, 816.8856360109589, 839.1776059461762, 854.7307598106577, 26212.21363359102, 26336.8683156583, 26818.865905670347, 26822.329441763723, 26975.595366069523, 936.8828896387952, 941.7975135345933, 966.6906589891308, 997.1623835977668, 1019.4342140112309, 13785.655358616115, 13854.792178117335, 13982.230977296347, 13994.860051399559, 14006.929965350311, 301411.0, 307166.0, 308050.0, 308170.0, 308694.0, 48303.75848120737, 48651.0, 48656.0, 48802.75598621984, 48824.75587622039, 1208.6434501821984, 1213.4478812140455, 1227.2820400065882, 1228.2139430764319, 1228.4963165102265, 21814.89092554527, 30867.38265234638, 31251.84374078115, 31374.529382059744, 31760.523592146597, 43944.34083488814, 44667.32999005083, 44737.10525789531, 44756.77621611871, 44786.104277914914, 244276.0, 246198.0, 246329.0, 247107.0, 247152.0, 24495.63256551189, 28522.144335669964, 28860.134195974155, 28908.855455722587, 29233.41533169282, 35877.461838071926, 36632.0, 36807.63192368149, 36963.26073478461, 37837.0, 31711.84144079357, 31751.52372714365, 31840.36319273648, 32373.67626323801, 32831.507527387585, 32082.0, 32547.674523255413, 32627.34745305128, 32661.34677306488, 32808.179795505304, 32840.67159328376, 33176.0, 33248.0, 33295.167620809676, 36311.09222269464, 29059.854700726362, 29557.85221073881, 31118.37763244768, 31349.216269593442, 31378.372432550765, 23976.88011559931, 24051.759482404952, 24264.0, 24531.877340613184, 24550.877245613658], "unit": "ms", "name": "ext.html", "value": 17438.721383000364}, {"lowerIsBetter": false, "replicates": [332.89846596787976, 336.83495087407175, 336.9554381417605, 340.49436586668776, 341.19137643784234, 12223.633291001262, 12613.306268155271, 14923.776143357845, 15056.849431505681, 15686.450974215904, 12878.356082195876, 13274.203547787116, 14289.71420571588, 14569.344379502922, 14931.925340373311, 4476.261416866229, 4875.049365373762, 5022.773975171108, 5024.899502009957, 5761.510271626917, 3603.0992251937014, 3735.682466990309, 5558.110702287635, 5694.430556944314, 5749.05140651794, 5676.801311954083, 5682.51698605619, 5684.857878553028, 5725.227094342273, 5732.627379220337, 5636.859078523029, 5758.712064396785, 5760.683162426044, 5762.625429347079, 5763.769449222026, 5053.090443720129, 5058.671186372911, 5061.063703214917, 5068.771905264272, 5072.51811077947, 18956.43130706081, 18963.0, 19303.710444343345, 19539.316123935736, 19572.0, 1827.3695575026595, 1853.8516918646476, 1873.7751469823572, 1918.1080797429122, 2026.9695954560693, 12595.74808503834, 12600.621981340575, 12696.365181740875, 12810.29543375114, 13131.212127272298, 1769.752234687145, 1781.5635169383584, 1787.6156626325403, 1800.4148651688254, 1837.2467288411822, 50968.0, 52726.47273527254, 53183.734081329734, 53627.92744145134, 54044.91910161814, 9256.398334108262, 9370.85943710845, 9474.810503789886, 9480.194183494481, 9552.90447095534, 11942.641720748392, 11984.820227696591, 12011.939940300243, 12018.098642601839, 12028.819567706492, 7059.752908648173, 7087.92912070883, 7181.281871812777, 7183.856322873513, 7217.494775365674, 6709.261981182066, 6746.8650626988165, 6759.256481787, 6780.084688566981, 6806.965965170241, 5676.460736230051, 5716.857078573069, 5736.1682556029145, 5738.512226460714, 5810.680412577264, 1565.6946895355297, 1603.0622086079775, 1608.7184742669986, 1614.1929035482258, 1618.587260248629, 723.6020188896191, 771.9614019299013, 834.6828205282076, 864.0668078475231, 950.0452045694034, 15027.849721502864, 15519.37922483088, 15696.293666784793, 16082.0, 16171.919140404223, 764.6635480388722, 837.2046555772041, 853.5134973065293, 917.5962576466334, 949.0556895888635, 8290.057970010012, 9025.548722563846, 9074.500902450296, 9218.81562368749, 9270.30472714549, 453297.0, 459219.0, 459472.0, 466076.0, 490488.0, 69240.6537967317, 70544.0, 71652.0, 72927.63536182285, 73748.63125684338, 986.2750878104588, 1011.585250047477, 1012.9746756331003, 1019.3425240719695, 1045.4720366215165, 13565.38955746974, 14029.0, 14143.929280353532, 14388.568342949728, 14562.635934101732, 30283.091507254816, 32049.359012820078, 32451.0, 32925.0, 33656.66343336633, 39429.0, 40168.59831401648, 42070.78964605158, 42218.78890605527, 42762.57237427586, 8971.147740964598, 9029.729108126767, 9040.050794666466, 9179.31155163352, 9201.217896478875, 13727.656808579866, 16050.0, 16816.915915420344, 16879.831201688317, 16933.661326773643, 13610.455581776618, 13878.0, 13958.720825583634, 13984.790228146789, 14441.277936103363, 13498.122622029538, 13641.727165456437, 13654.249016304198, 13973.790393143907, 14008.649783755487, 11106.944465277622, 14168.583141685749, 14262.0, 14368.066075705046, 14709.852901471277, 7916.129225785274, 8244.958775206325, 9001.729948101567, 9323.440593564408, 9326.114019168168, 13711.177329360271, 13827.0, 14078.859211408164, 14292.0, 14295.499657511937], "unit": "ms", "name": "jquery.html", "value": 8396.614486022976}, {"lowerIsBetter": false, "replicates": [1213.344793811342, 1401.173307748429, 1424.3376829774159, 1619.2146808797731, 1701.9829801701978, 6293.181886354773, 6503.674816259186, 7218.494705370619, 7377.114746230446, 7385.852282954338, 6993.090898183242, 7043.04918835957, 7086.078809754737, 7103.964480177592, 7137.393321567673, 2083.4583008417844, 2106.7682554918947, 2123.437289118385, 2125.3730149605904, 2125.904334304952, 2093.3824521766114, 2115.3653903828867, 2125.5961367340233, 2126.0114046968156, 2128.4146859613575, 2115.7038014677955, 2135.562209746998, 2157.244964262511, 2160.79472450117, 2161.6001039807684, 2150.419386765572, 2167.6640120781303, 2173.7065496157975, 2175.5540114276537, 2183.192218879009, 2118.4386137673528, 2179.0085511092416, 2179.106566307822, 2179.2808373236794, 2180.3132013415884, 6234.812955611339, 7311.744088956861, 7417.814554636123, 7421.703131874719, 7427.220141885133, 3735.1595890924323, 3811.1805961718087, 4202.243596152692, 4288.078063216423, 4289.764062976535, 2748.876300566479, 2773.8751756171023, 2790.497710412125, 2796.8881244750187, 2874.870630821597, 889.9866502002475, 890.1279434460112, 898.3621628643671, 912.7124955638952, 916.1525588830306, 10137.89862101377, 10267.743306417324, 10281.742956426075, 10290.845637315446, 10298.330608510423, 4119.279126152971, 4165.958340416557, 4180.393842892763, 4220.873373798791, 4232.090100628379, 8857.070007649232, 8885.378023538291, 8887.0, 8888.11118888119, 8894.644214231488, 4364.803583838735, 4367.868963931087, 4370.169667763178, 4372.322290045048, 4372.781360932005, 3899.6880249579967, 3902.6292502212245, 3908.843646254175, 3915.040815000343, 3915.6280153385383, 3348.045806945058, 3366.192113892648, 3369.309291595217, 3392.8473218705217, 3396.3037577296595, 1084.5065495199665, 1085.853409789684, 1087.4399684162663, 1096.17786660005, 1097.6761855252719, 1044.7127040064042, 1052.9420881851572, 1069.0485467933545, 1070.1813112968584, 1089.983650245247, 6917.7232910684015, 6947.82630434233, 6972.58164510131, 6990.231074581792, 7018.649067546602, 450.6102221578311, 453.745902294716, 463.55730277584826, 463.57582811726894, 463.7055469776716, 4983.975080124649, 5459.672419654833, 5468.453154684579, 5495.6427832191575, 5547.77808887648, 8081.757547273473, 8803.911960880438, 8931.062238464998, 9146.725598232064, 9147.588358523883, 8768.298536117223, 8884.333674974274, 8922.286217102615, 8941.865872011926, 8943.686970956116, 6889.173299204128, 6972.442204623618, 7034.0, 7034.472414568928, 7035.366816986496, 6700.162479690039, 6709.865802683821, 6767.154105736783, 6770.255271920183, 6784.185897692111, 7867.763967080997, 7971.521708697497, 8025.759227223192, 8057.194280571896, 8104.473209241381, 8083.959580202061, 8219.671213151407, 8228.0, 8311.542865142475, 8327.6668933242, 6272.498200143887, 6311.495080393465, 6314.400131987454, 6324.810255692337, 6340.904886426615, 7009.439244860501, 7056.1179852518435, 7068.0, 7069.752558660422, 7087.468439866928, 6680.5991640501725, 6716.630585317855, 6750.0212469192675, 6860.897086543606, 6899.517033807585, 6548.0, 6558.80323590293, 6602.042703807825, 6668.43318317929, 6699.263081061177, 6734.730610775514, 6771.559848610022, 6823.590584564942, 6885.311468853075, 6885.414739747178, 6211.81364559064, 6251.281102673069, 6255.906161407492, 6260.467860231749, 6271.3415091414745, 6258.43674069336, 6300.905486417799, 6303.9684801575695, 6323.747050118128, 6324.557280990287], "unit": "ms", "name": "mootools.html", "value": 4121.741067654802}, {"lowerIsBetter": false, "replicates": [296.5462841851966, 306.93861227754456, 307.8676169247224, 310.96112985876766, 311.56692197845, 5236.3192784937955, 5274.235235890794, 5274.841754747355, 5285.788568457262, 5291.2327712481665, 5152.948470515294, 5165.5092766187245, 5217.530422261995, 5218.1650935850275, 5220.8694782630455, 4115.938260926081, 4116.259073366793, 4116.567760385161, 4120.361343991686, 4121.608447197526, 3917.196974620196, 4029.81865816039, 4121.237571049351, 4124.216398884218, 4125.608067233608, 3801.220749746309, 3816.0459885028745, 3979.482667253253, 3993.480847489837, 3996.8001599920035, 3970.4441378207075, 4020.557738648746, 4050.675945924319, 4061.3095773718537, 4078.2455245779624, 3597.442396428558, 3625.492431059654, 3626.274745050974, 3637.781733095996, 3640.1445660269815, 4794.089123066607, 4938.777755001033, 4942.1104201244125, 5014.398272207359, 5033.144365457881, 4684.156851766681, 4690.906181876378, 4693.155232058228, 4695.741734204652, 4699.318598803155, 5520.751566179531, 5536.335639723259, 5536.390996990328, 5541.251930989305, 5550.0, 3685.68671662909, 3806.0675134591925, 3857.247836671822, 3910.1397692507603, 3919.7452165609143, 5762.88474230513, 5768.567357448208, 5785.681787501728, 5792.565557583198, 5806.042003069489, 4038.818253178614, 4041.2927737645796, 4042.2319759245647, 4046.77742724153, 4047.251258517184, 4094.570070142592, 4099.733517321364, 4100.487439070116, 4102.2000709861295, 4103.466549348565, 4564.908701825945, 4644.628429725613, 4655.0, 4669.719816811003, 4683.063387322481, 5541.307336582927, 5541.362743284574, 5541.501264886179, 5546.140348246028, 5547.528460080857, 1434.8852091832628, 1443.9566812995627, 1447.4572035486692, 1449.9855001450062, 1450.6155868694805, 988.930774845754, 991.8065977134389, 1001.906501966093, 1009.7273736091214, 1023.1201166996526, 4891.779869905863, 4897.755112244445, 4904.852854414374, 4905.166121759238, 4917.434495033045, 5664.971675141598, 5725.255716756795, 5745.626534275342, 5748.396418376094, 5749.511291540182, 4890.388701412324, 4896.951030489649, 4902.313676085351, 4903.289023091703, 4907.190313598217, 3015.819050856912, 3061.98469007658, 3087.274490494732, 3090.8454577271045, 3103.8603262853226, 5519.254900588369, 5527.115661494222, 5533.723313834373, 5534.972325138348, 5545.916811247835, 5960.821175364746, 5962.4633782959745, 5971.671558064349, 5972.910406343908, 5977.9402205977385, 5517.44825517445, 5528.474794894559, 5538.47384498472, 5539.0, 5539.113741801292, 5645.350784659817, 5792.420757924174, 5802.767889284381, 5802.970985145216, 5807.82576522705, 5461.9180712290145, 5576.804811831566, 5673.149027645886, 5678.403767604342, 5683.77264909399, 5379.112446446293, 5464.480874316933, 5503.11950087984, 5504.284443022381, 5504.311961004874, 3947.230290093519, 3986.661133803543, 3992.001999500125, 3993.4608827807874, 3995.580464051233, 5743.167240750151, 5760.395158508296, 5764.164196191445, 5782.277215348082, 5782.681952492653, 5411.702356370437, 5553.194786755817, 5557.972210138923, 5560.388357280777, 5565.888682226252, 5552.7223638818705, 5561.499465048165, 5568.55451563882, 5569.415211402745, 5573.080441727069, 5438.83683489496, 5441.483059109379, 5442.319710036246, 5443.292371991616, 5446.291982042309, 5481.314835645544, 5594.244776955059, 5596.076647353141, 5599.552035837205, 5601.103823388238, 5451.781928722807, 5458.754356054066, 5464.535514481155, 5468.960897429476, 5472.671639701631], "unit": "ms", "name": "prototype.html", "value": 4179.155954630767}, {"lowerIsBetter": false, "replicates": [760.5170716594964, 778.6573907480712, 781.8944442500263, 792.892959450474, 795.16904834448, 11858.584949526758, 12640.557580484685, 12661.49354025839, 12676.68308292291, 12711.555095571657, 12160.452779624917, 12285.815712764315, 12291.262524248552, 12303.38483075847, 12311.261324320547, 610.5664977865721, 619.3465893482374, 765.2347652347653, 767.9424043196755, 785.3638552772244, 779.9727009554666, 781.6404453951161, 781.7771934998526, 787.5983248543226, 789.2817536042203, 635.4217661927647, 816.481534225765, 823.6087858267335, 823.7611092783086, 824.4229039672224, 638.0110828216269, 800.219785708935, 810.3476701255487, 811.3022800391658, 812.5043723328765, 603.3815339277232, 603.7766026570154, 604.1964187630441, 604.2054698072021, 604.5737754882797, 11495.885041149566, 11850.88149118515, 11857.051435885109, 11858.169928105037, 11902.285862848257, 11346.262492937933, 11983.94008029963, 12192.634220973385, 12260.570880019157, 12502.74994500105, 9560.0, 9835.360701554448, 9841.852372214422, 10204.132648724868, 10236.641717539926, 3273.714468220998, 3292.6048874135017, 3324.1855745342546, 3382.746294027958, 3439.7420193485336, 42737.57262427367, 42920.356194657106, 43230.56769432328, 43260.3510947336, 43308.78345608252, 9296.39573427725, 9302.581383837743, 9471.147596716328, 9476.668316608886, 9520.381175223589, 16241.106739129462, 16293.348266069224, 16309.429169978994, 16342.509724708278, 16352.591185220464, 6158.815235542941, 6171.56799024073, 6217.098520714471, 6362.395572420613, 6371.872562548723, 3640.7087433005295, 3659.2315613721416, 3688.0595448160548, 3713.665770080706, 3767.3595488766973, 2653.761161495436, 2685.7448542388443, 2695.3396417877743, 2709.701932787392, 2710.8780104895327, 488.3480553461098, 490.9435414927329, 491.66566734620085, 511.0851575679566, 511.8771494841211, 437.86645073252964, 441.4481897627965, 447.46080972428143, 460.82028009076487, 488.565176992477, 7306.986661377456, 7449.776506704808, 7529.134149572869, 7886.842263154819, 7934.914418623162, 570.6461993564017, 577.1832856507995, 584.0509172594534, 597.1013624495107, 619.7830759234232, 3328.617209020945, 3333.4333163361803, 3391.270876761508, 3392.9709913930624, 3473.4963430302464, 49123.508764911894, 50180.749096255015, 50209.49790502121, 50212.0, 50320.49679503231, 42708.78645606752, 42830.0, 42883.57116428858, 44946.32580511295, 45247.32129018068, 39355.40966885499, 40061.198776024314, 40315.798421008294, 40323.0, 40928.18143637111, 7478.7382441616455, 7952.284294413531, 7968.681252749825, 8009.719659811879, 8043.276105150565, 29884.252893677833, 30764.384712305182, 30819.0, 30884.53673194859, 31027.224319392197, 36508.45237321389, 38654.420183696704, 39355.409668855566, 39470.60529394669, 39836.601633983286, 10068.496575171066, 10070.194384449373, 10169.542370593193, 10255.846162307422, 10332.276740628084, 11463.197576169589, 11676.94161529187, 11835.28988260707, 11841.5855445059, 12089.892563053269, 9984.750381240237, 10131.290809643255, 10923.344599323747, 10947.945260273966, 11291.774164516828, 10757.408342541235, 11170.720731981766, 11218.326900386002, 11620.244684095507, 11639.243449175776, 7702.922970770221, 8255.463394879314, 8602.05377408497, 9975.50122493887, 10116.140128089195, 8404.705835295736, 8564.443311184754, 8996.910030899608, 9054.366194366332, 9071.138241867013, 7230.0, 7820.882686759817, 7880.17258187882, 8199.95900020496, 9163.816723665355], "unit": "ms", "name": "yui.html", "value": 5658.953445938144}], "name": "dromaeo_css", "value": 6341.554493455224}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 107.0, 112.0, 113.0, 112.0, 99.0, 111.0, 111.0, 108.0], "unit": "ms", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [157.0, 130.0, 149.0, 169.0, 130.0, 153.0, 163.0, 131.0, 175.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.6}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 162.0, 159.0, 161.0, 161.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 87.0, 99.0, 73.0, 73.0, 71.0, 85.0, 87.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 130.0, 94.0, 94.0, 94.0, 126.0, 93.0, 94.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 104.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [73.0, 70.0, 70.0, 70.0, 70.0, 70.0, 72.0, 73.0, 71.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.8}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 70.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 86.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 93.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.4}, {"lowerIsBetter": true, "replicates": [128.0, 128.0, 131.0, 126.0, 119.0, 125.0, 127.0, 121.0, 120.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.5}, {"lowerIsBetter": true, "replicates": [154.0, 142.0, 145.0, 147.0, 147.0, 137.0, 149.0, 158.0, 137.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.0}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 67.0, 69.0, 68.0, 70.0, 67.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.4}], "name": "kraken", "value": 1515.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.09547823163558], "unit": "score", "name": "Richards", "value": 210.01159799999994}, {"lowerIsBetter": false, "replicates": [193.91118867558657], "unit": "score", "name": "DeltaBlue", "value": 340.97052599999995}, {"lowerIsBetter": false, "replicates": [280.74115665356544], "unit": "score", "name": "Encrypt", "value": 948.136722}, {"lowerIsBetter": false, "replicates": [5235.602094240838], "unit": "score", "name": "Decrypt", "value": 50.84057100000005}, {"lowerIsBetter": false, "replicates": [2047.034764826176], "unit": "score", "name": "RayTrace", "value": 361.49312787212784}, {"lowerIsBetter": false, "replicates": [790.0552486187845], "unit": "score", "name": "Earley", "value": 843.565055944056}, {"lowerIsBetter": false, "replicates": [12132.530120481928], "unit": "score", "name": "Boyer", "value": 54.93190566037737}, {"lowerIsBetter": false, "replicates": [26763.157894736843], "unit": "score", "name": "RegExp", "value": 34.0387708947886}, {"lowerIsBetter": false, "replicates": [603.1081888822474], "unit": "score", "name": "Splay", "value": 135.11837760158576}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19625.601296868525}]} 16:14:47 INFO - RETURN: dromaeo_css: 6341.55 16:14:47 INFO - RETURN: kraken: 1515.70 16:14:47 INFO - RETURN: v8_7: 19625.60 16:14:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,26,35]]", "result": "19625.60"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,26,35]]", "result": "1515.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,26,35]]", "result": "6341.55"}}} 16:14:47 INFO - Return code: 0 16:14:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:14:47 INFO - # TBPL SUCCESS # 16:14:47 INFO - Running post-action listener: _resource_record_post_action 16:14:47 INFO - Running post-run listener: _resource_record_post_run 16:14:48 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 524529664; Read time: 16; Write time: 436140 16:14:48 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 245723136; Read time: 0; Write time: 286100 16:14:48 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 277942272; Read time: 16; Write time: 149992 16:14:48 INFO - Running post-run listener: _upload_blobber_files 16:14:48 INFO - Blob upload gear active. 16:14:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:14:48 INFO - Copying logs to upload dir... 16:14:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.396426 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-12-03 16:14:48.435344) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-03 16:14:48.438622) ========= 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=6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010112 build_url: 'https://queue.taskcluster.net/v1/task/gzglTxweSgqQIwIW5GDLSw/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-03 16:14:48.493693) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:14:48.494144) ========= 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=6587686cb2da90a5f91b3170000001be-1449186646.257358-653155146 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-03 16:14:48.544173) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 16:14:48.544610) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-03 16:14:48.544976) ========= ========= Total master_lag: 0.23 =========