builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-027 starttime: 1450370678.23 results: success (0) buildid: 20151217072904 builduid: 409a3ae361344370bc3b958c10dd3dee revision: 0711218a018d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.228910) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.229715) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.232825) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006505 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.260891) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.261212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.299159) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.299417) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.368294) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.368574) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.369009) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.369487) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 08:44: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% 226M=0s 2015-12-17 08:44:39 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179991 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.587277) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.587565) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014957 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.636705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:38.640073) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0711218a018d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 0711218a018d --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=447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 08:44:39,212 Setting DEBUG logging. 2015-12-17 08:44:39,212 attempt 1/10 2015-12-17 08:44:39,212 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0711218a018d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 08:44:39,532 unpacking tar archive at: mozilla-central-0711218a018d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626580 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:39.278220) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:39.278674) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:39.289850) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:39.290128) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 08:44:39.290757) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-17 08:44:39.291056) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:44:39 INFO - MultiFileLogger online at 20151217 08:44:39 in /builds/slave/test 08:44:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:44:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:44:39 INFO - {'append_to_log': False, 08:44:39 INFO - 'base_work_dir': '/builds/slave/test', 08:44:39 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:44:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:44:39 INFO - 'branch': 'Firefox-Non-PGO', 08:44:39 INFO - 'buildbot_json_path': 'buildprops.json', 08:44:39 INFO - 'config_files': ('talos/linux_config.py',), 08:44:39 INFO - 'default_actions': ('clobber', 08:44:39 INFO - 'read-buildbot-config', 08:44:39 INFO - 'download-and-extract', 08:44:39 INFO - 'populate-webroot', 08:44:39 INFO - 'create-virtualenv', 08:44:39 INFO - 'install', 08:44:39 INFO - 'run-tests'), 08:44:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:44:39 INFO - 'download_minidump_stackwalk': True, 08:44:39 INFO - 'download_symbols': 'ondemand', 08:44:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:44:39 INFO - 'tooltool.py': '/tools/tooltool.py', 08:44:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:44:39 INFO - '/tools/misc-python/virtualenv.py')}, 08:44:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:44:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:44:39 INFO - 'installer_path': 'installer.exe', 08:44:39 INFO - 'log_level': 'info', 08:44:39 INFO - 'log_name': 'talos', 08:44:39 INFO - 'log_to_console': True, 08:44:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:44:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:44:39 INFO - 'opt_config_files': (), 08:44:39 INFO - 'pip_index': False, 08:44:39 INFO - 'sps_profile': False, 08:44:39 INFO - 'sps_profile_interval': 0, 08:44:39 INFO - 'suite': 'dromaeojs', 08:44:39 INFO - 'system_bits': '64', 08:44:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:44:39 INFO - 'title': 'talos-linux64-ix-027', 08:44:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:44:39 INFO - 'use_talos_json': True, 08:44:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:44:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:44:39 INFO - 'work_dir': 'build'} 08:44:39 INFO - ##### 08:44:39 INFO - ##### Running clobber step. 08:44:39 INFO - ##### 08:44:39 INFO - Running pre-action listener: _resource_record_pre_action 08:44:39 INFO - Running main action method: clobber 08:44:39 INFO - rmtree: /builds/slave/test/build 08:44:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:44:40 INFO - Running post-action listener: _resource_record_post_action 08:44:40 INFO - ##### 08:44:40 INFO - ##### Running read-buildbot-config step. 08:44:40 INFO - ##### 08:44:40 INFO - Running pre-action listener: _resource_record_pre_action 08:44:40 INFO - Running main action method: read_buildbot_config 08:44:40 INFO - Using buildbot properties: 08:44:40 INFO - { 08:44:40 INFO - "project": "", 08:44:40 INFO - "product": "firefox", 08:44:40 INFO - "script_repo_revision": "production", 08:44:40 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:44:40 INFO - "repository": "", 08:44:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:44:40 INFO - "buildid": "20151217072904", 08:44:40 INFO - "pgo_build": "False", 08:44:40 INFO - "basedir": "/builds/slave/test", 08:44:40 INFO - "buildnumber": 410, 08:44:40 INFO - "slavename": "talos-linux64-ix-027", 08:44:40 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:44:40 INFO - "platform": "ubuntu64_hw", 08:44:40 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:44:40 INFO - "branch": "mozilla-central", 08:44:40 INFO - "repo_path": "mozilla-central", 08:44:40 INFO - "revision": "0711218a018d", 08:44:40 INFO - "stage_platform": "linux64", 08:44:40 INFO - "builduid": "409a3ae361344370bc3b958c10dd3dee", 08:44:40 INFO - "slavebuilddir": "test" 08:44:40 INFO - } 08:44:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:44:40 INFO - Running post-action listener: _resource_record_post_action 08:44:40 INFO - ##### 08:44:40 INFO - ##### Running download-and-extract step. 08:44:40 INFO - ##### 08:44:40 INFO - Running pre-action listener: _resource_record_pre_action 08:44:40 INFO - Running main action method: download_and_extract 08:44:40 INFO - mkdir: /builds/slave/test/build/tests 08:44: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')]} 08:44:40 INFO - https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:44:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/test_packages.json 08:44:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/test_packages.json 08:44:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:44:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:44:43 INFO - Downloaded 1302 bytes. 08:44:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:44:43 INFO - Using the following test package requirements: 08:44:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:44:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:43 INFO - u'jsshell-linux-x86_64.zip'], 08:44:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:44:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:44:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:44:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:44:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:44:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:44:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:44:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:44:43 INFO - https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:44:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:44:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:44:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:44:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:44:47 INFO - Downloaded 21870791 bytes. 08:44:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:44:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:44:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:44:48 INFO - Return code: 0 08:44:48 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:44: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')]} 08:44:48 INFO - https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:44:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:44:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:44:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:44:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:45:00 INFO - Downloaded 21870791 bytes. 08:45:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 08:45:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:45:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 08:45:01 INFO - Return code: 0 08:45:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:01 INFO - https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:45:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:45:02 INFO - Downloaded 11132039 bytes. 08:45:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 08:45:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:45:02 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 08:45:02 INFO - Return code: 0 08:45:02 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')]} 08:45:02 INFO - https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:45:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:45:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:45:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:45:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:45:04 INFO - Downloaded 53017916 bytes. 08:45:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:45:04 INFO - mkdir: /builds/slave/test/properties 08:45:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:45:04 INFO - Writing to file /builds/slave/test/properties/build_url 08:45:04 INFO - Contents: 08:45:04 INFO - build_url:https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:45:04 INFO - Running post-action listener: _resource_record_post_action 08:45:04 INFO - Running post-action listener: set_extra_try_arguments 08:45:04 INFO - ##### 08:45:04 INFO - ##### Running populate-webroot step. 08:45:04 INFO - ##### 08:45:04 INFO - Running pre-action listener: _resource_record_pre_action 08:45:04 INFO - Running main action method: populate_webroot 08:45:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:45:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:45:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:45:04 INFO - '--tppagecycles', 08:45:04 INFO - '7'], 08:45:04 INFO - 'tests': ['tsvgm']}}, 08:45:04 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:45:04 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:45:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:45:04 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:45:04 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:45:04 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:45:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'talos_options': ['--e10s'], 08:45:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:45:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'tests': ['damp', 'tps']}, 08:45:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'talos_options': ['--e10s'], 08:45:04 INFO - 'tests': ['damp', 'tps']}, 08:45:04 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:45:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:45:04 INFO - 'other': {'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore']}, 08:45:04 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:45:04 INFO - 'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore']}, 08:45:04 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:45:04 INFO - 'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore']}, 08:45:04 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:45:04 INFO - 'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore']}, 08:45:04 INFO - 'other_l64': {'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore']}, 08:45:04 INFO - 'other_nol64': {'tests': ['a11yr', 08:45:04 INFO - 'ts_paint', 08:45:04 INFO - 'tpaint', 08:45:04 INFO - 'sessionrestore', 08:45:04 INFO - 'sessionrestore_no_auto_restore']}, 08:45:04 INFO - 'svgr': {'tests': ['tsvgx', 08:45:04 INFO - 'tsvgr_opacity', 08:45:04 INFO - 'tart', 08:45:04 INFO - 'tscrollx', 08:45:04 INFO - 'cart']}, 08:45:04 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:45:04 INFO - 'tests': ['tsvgx', 08:45:04 INFO - 'tsvgr_opacity', 08:45:04 INFO - 'tart', 08:45:04 INFO - 'tscrollx', 08:45:04 INFO - 'cart']}, 08:45:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'tests': ['tp5o']}, 08:45:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'talos_options': ['--e10s'], 08:45:04 INFO - 'tests': ['tp5o']}, 08:45:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'talos_options': ['--xperf_path', 08:45:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:04 INFO - 'tests': ['tp5n']}, 08:45:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:45:04 INFO - 'talos_options': ['--e10s', 08:45:04 INFO - '--xperf_path', 08:45:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:45:04 INFO - 'tests': ['tp5n']}}, 08:45:04 INFO - 'talos.zip': {'path': '', 08:45:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:45:04 INFO - Running post-action listener: _resource_record_post_action 08:45:04 INFO - ##### 08:45:04 INFO - ##### Running create-virtualenv step. 08:45:04 INFO - ##### 08:45:04 INFO - Running pre-action listener: _resource_record_pre_action 08:45:04 INFO - Running main action method: create_virtualenv 08:45:04 INFO - Creating virtualenv /builds/slave/test/build/venv 08:45:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:45:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:45:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:45:04 INFO - Using real prefix '/usr' 08:45:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:45:05 INFO - Installing distribute.............................................................................................................................................................................................done. 08:45:07 INFO - Installing pip.................done. 08:45:07 INFO - Return code: 0 08:45:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20660b0>, '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 0x2066fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2067440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', '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 08:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:45:07 INFO - Using env: {'DISPLAY': ':0', 08:45:07 INFO - 'HOME': '/home/cltbld', 08:45:07 INFO - 'LANG': 'en_US.UTF-8', 08:45:07 INFO - 'LANGUAGE': 'en_US:en', 08:45:07 INFO - 'LOGNAME': 'cltbld', 08:45:07 INFO - 'MAIL': '/var/mail/cltbld', 08:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:07 INFO - 'MOZ_NO_REMOTE': '1', 08:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:07 INFO - 'NO_EM_RESTART': '1', 08:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:07 INFO - 'PWD': '/builds/slave/test', 08:45:07 INFO - 'SHELL': '/bin/bash', 08:45:07 INFO - 'SHLVL': '1', 08:45:07 INFO - 'TERM': 'linux', 08:45:07 INFO - 'TMOUT': '86400', 08:45:07 INFO - 'USER': 'cltbld', 08:45:07 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', 08:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:07 INFO - '_': '/tools/buildbot/bin/python'} 08:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:45:07 INFO - Cleaning up... 08:45:07 INFO - Return code: 0 08:45:07 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20660b0>, '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 0x2066fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2067440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', '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 08:45:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 08:45:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 08:45:07 INFO - Using env: {'DISPLAY': ':0', 08:45:07 INFO - 'HOME': '/home/cltbld', 08:45:07 INFO - 'LANG': 'en_US.UTF-8', 08:45:07 INFO - 'LANGUAGE': 'en_US:en', 08:45:07 INFO - 'LOGNAME': 'cltbld', 08:45:07 INFO - 'MAIL': '/var/mail/cltbld', 08:45:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:07 INFO - 'MOZ_NO_REMOTE': '1', 08:45:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:07 INFO - 'NO_EM_RESTART': '1', 08:45:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:07 INFO - 'PWD': '/builds/slave/test', 08:45:07 INFO - 'SHELL': '/bin/bash', 08:45:07 INFO - 'SHLVL': '1', 08:45:07 INFO - 'TERM': 'linux', 08:45:07 INFO - 'TMOUT': '86400', 08:45:07 INFO - 'USER': 'cltbld', 08:45:07 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', 08:45:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:07 INFO - '_': '/tools/buildbot/bin/python'} 08:45:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:07 INFO - Downloading/unpacking psutil>=0.7.1 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:09 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:45:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:45:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:09 INFO - Installing collected packages: psutil 08:45:09 INFO - Running setup.py install for psutil 08:45:09 INFO - building 'psutil._psutil_linux' extension 08:45:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:45:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:45:09 INFO - building 'psutil._psutil_posix' extension 08:45:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:45:09 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:45:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:45:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:45:10 INFO - Successfully installed psutil 08:45:10 INFO - Cleaning up... 08:45:10 INFO - Return code: 0 08:45:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20660b0>, '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 0x2066fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2067440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', '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 08:45:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 08:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 08:45:10 INFO - Using env: {'DISPLAY': ':0', 08:45:10 INFO - 'HOME': '/home/cltbld', 08:45:10 INFO - 'LANG': 'en_US.UTF-8', 08:45:10 INFO - 'LANGUAGE': 'en_US:en', 08:45:10 INFO - 'LOGNAME': 'cltbld', 08:45:10 INFO - 'MAIL': '/var/mail/cltbld', 08:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:10 INFO - 'MOZ_NO_REMOTE': '1', 08:45:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:10 INFO - 'NO_EM_RESTART': '1', 08:45:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:10 INFO - 'PWD': '/builds/slave/test', 08:45:10 INFO - 'SHELL': '/bin/bash', 08:45:10 INFO - 'SHLVL': '1', 08:45:10 INFO - 'TERM': 'linux', 08:45:10 INFO - 'TMOUT': '86400', 08:45:10 INFO - 'USER': 'cltbld', 08:45:10 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', 08:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:10 INFO - '_': '/tools/buildbot/bin/python'} 08:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:45:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:45:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:45:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:45:12 INFO - Installing collected packages: mozsystemmonitor 08:45:12 INFO - Running setup.py install for mozsystemmonitor 08:45:12 INFO - Successfully installed mozsystemmonitor 08:45:12 INFO - Cleaning up... 08:45:12 INFO - Return code: 0 08:45:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:45: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')]} 08:45:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45: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')]} 08:45:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20660b0>, '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 0x2066fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2067440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', '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 08:45:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:45:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:45:12 INFO - Using env: {'DISPLAY': ':0', 08:45:12 INFO - 'HOME': '/home/cltbld', 08:45:12 INFO - 'LANG': 'en_US.UTF-8', 08:45:12 INFO - 'LANGUAGE': 'en_US:en', 08:45:12 INFO - 'LOGNAME': 'cltbld', 08:45:12 INFO - 'MAIL': '/var/mail/cltbld', 08:45:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:12 INFO - 'MOZ_NO_REMOTE': '1', 08:45:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:12 INFO - 'NO_EM_RESTART': '1', 08:45:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:12 INFO - 'PWD': '/builds/slave/test', 08:45:12 INFO - 'SHELL': '/bin/bash', 08:45:12 INFO - 'SHLVL': '1', 08:45:12 INFO - 'TERM': 'linux', 08:45:12 INFO - 'TMOUT': '86400', 08:45:12 INFO - 'USER': 'cltbld', 08:45:12 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', 08:45:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:12 INFO - '_': '/tools/buildbot/bin/python'} 08:45:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:12 INFO - Downloading/unpacking blobuploader==1.2.4 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:14 INFO - Downloading blobuploader-1.2.4.tar.gz 08:45:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:45:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:45:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45: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 08:45:14 INFO - Downloading docopt-0.6.1.tar.gz 08:45:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:45:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:45:14 INFO - Installing collected packages: blobuploader, requests, docopt 08:45:14 INFO - Running setup.py install for blobuploader 08:45:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:45:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:45:14 INFO - Running setup.py install for requests 08:45:15 INFO - Running setup.py install for docopt 08:45:15 INFO - Successfully installed blobuploader requests docopt 08:45:15 INFO - Cleaning up... 08:45:15 INFO - Return code: 0 08:45:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20660b0>, '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 0x2066fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2067440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', '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 08:45:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:15 INFO - Using env: {'DISPLAY': ':0', 08:45:15 INFO - 'HOME': '/home/cltbld', 08:45:15 INFO - 'LANG': 'en_US.UTF-8', 08:45:15 INFO - 'LANGUAGE': 'en_US:en', 08:45:15 INFO - 'LOGNAME': 'cltbld', 08:45:15 INFO - 'MAIL': '/var/mail/cltbld', 08:45:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:15 INFO - 'MOZ_NO_REMOTE': '1', 08:45:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:15 INFO - 'NO_EM_RESTART': '1', 08:45:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:15 INFO - 'PWD': '/builds/slave/test', 08:45:15 INFO - 'SHELL': '/bin/bash', 08:45:15 INFO - 'SHLVL': '1', 08:45:15 INFO - 'TERM': 'linux', 08:45:15 INFO - 'TMOUT': '86400', 08:45:15 INFO - 'USER': 'cltbld', 08:45:15 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', 08:45:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:15 INFO - '_': '/tools/buildbot/bin/python'} 08:45:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:15 INFO - Running setup.py (path:/tmp/pip-2AiKEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:15 INFO - Running setup.py (path:/tmp/pip-ZmxSfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:15 INFO - Running setup.py (path:/tmp/pip-f0l2wA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:15 INFO - Running setup.py (path:/tmp/pip-YcwMQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:15 INFO - Running setup.py (path:/tmp/pip-kKrphS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:15 INFO - Running setup.py (path:/tmp/pip-VK77S0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:15 INFO - Running setup.py (path:/tmp/pip-_TTMIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:16 INFO - Running setup.py (path:/tmp/pip-j7cTSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:16 INFO - Running setup.py (path:/tmp/pip-L8yT9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:16 INFO - Running setup.py (path:/tmp/pip-gwr4Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:16 INFO - Running setup.py (path:/tmp/pip-wc1H5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:16 INFO - Running setup.py (path:/tmp/pip-SVyWOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:16 INFO - Running setup.py (path:/tmp/pip-BwBSaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:16 INFO - Running setup.py (path:/tmp/pip-mIEiYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:16 INFO - Running setup.py (path:/tmp/pip-5RHYTT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:16 INFO - Running setup.py (path:/tmp/pip-uLum0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:16 INFO - Running setup.py (path:/tmp/pip-gfdb2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:45:16 INFO - Running setup.py install for manifestparser 08:45:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:45:16 INFO - Running setup.py install for mozcrash 08:45:16 INFO - Running setup.py install for mozdebug 08:45:17 INFO - Running setup.py install for mozdevice 08:45:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:45:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:45:17 INFO - Running setup.py install for mozfile 08:45:17 INFO - Running setup.py install for mozhttpd 08:45:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:45:17 INFO - Running setup.py install for mozinfo 08:45:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:45:17 INFO - Running setup.py install for mozInstall 08:45:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:45:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:45:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:45:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:45:17 INFO - Running setup.py install for mozleak 08:45:17 INFO - Running setup.py install for mozlog 08:45:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:45:17 INFO - Running setup.py install for moznetwork 08:45:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:45:17 INFO - Running setup.py install for mozprocess 08:45:18 INFO - Running setup.py install for mozprofile 08:45:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:45:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:45:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:45:18 INFO - Running setup.py install for mozrunner 08:45:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:45:18 INFO - Running setup.py install for mozscreenshot 08:45:18 INFO - Running setup.py install for moztest 08:45:18 INFO - Running setup.py install for mozversion 08:45:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:45:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:45:18 INFO - Cleaning up... 08:45:18 INFO - Return code: 0 08:45:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20660b0>, '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 0x2066fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2067440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', '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 08:45:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:45:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:18 INFO - Using env: {'DISPLAY': ':0', 08:45:18 INFO - 'HOME': '/home/cltbld', 08:45:18 INFO - 'LANG': 'en_US.UTF-8', 08:45:18 INFO - 'LANGUAGE': 'en_US:en', 08:45:18 INFO - 'LOGNAME': 'cltbld', 08:45:18 INFO - 'MAIL': '/var/mail/cltbld', 08:45:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:18 INFO - 'MOZ_NO_REMOTE': '1', 08:45:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:18 INFO - 'NO_EM_RESTART': '1', 08:45:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:18 INFO - 'PWD': '/builds/slave/test', 08:45:18 INFO - 'SHELL': '/bin/bash', 08:45:18 INFO - 'SHLVL': '1', 08:45:18 INFO - 'TERM': 'linux', 08:45:18 INFO - 'TMOUT': '86400', 08:45:18 INFO - 'USER': 'cltbld', 08:45:18 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', 08:45:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:18 INFO - '_': '/tools/buildbot/bin/python'} 08:45:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:45:18 INFO - Running setup.py (path:/tmp/pip-oAGRmk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:45:18 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:45:18 INFO - Running setup.py (path:/tmp/pip-l8UDcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:45:18 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)) 08:45:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:45:18 INFO - Running setup.py (path:/tmp/pip-bfIsUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:45:19 INFO - Running setup.py (path:/tmp/pip-RsfyQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:45:19 INFO - Running setup.py (path:/tmp/pip-GCbCRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:45:19 INFO - Running setup.py (path:/tmp/pip-gbmEbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:45:19 INFO - Running setup.py (path:/tmp/pip-ukG4vQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:45:19 INFO - Running setup.py (path:/tmp/pip-XNVl8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:45:19 INFO - Running setup.py (path:/tmp/pip-PzELyj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:45:19 INFO - Running setup.py (path:/tmp/pip-JdsfDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:45:19 INFO - Running setup.py (path:/tmp/pip-8KVSPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:45:19 INFO - Running setup.py (path:/tmp/pip-zeUIJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:45:19 INFO - Running setup.py (path:/tmp/pip-WsEv1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:45:19 INFO - Running setup.py (path:/tmp/pip-haPGaZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:19 INFO - Running setup.py (path:/tmp/pip-5vl1XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:45:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:45:19 INFO - Running setup.py (path:/tmp/pip-J0tpNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:45:19 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)) 08:45:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:45:19 INFO - Running setup.py (path:/tmp/pip-T0qaVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:45:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:21 INFO - Downloading blessings-1.5.1.tar.gz 08:45:21 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 08:45:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:45:21 INFO - Installing collected packages: blessings 08:45:21 INFO - Running setup.py install for blessings 08:45:21 INFO - Successfully installed blessings 08:45:21 INFO - Cleaning up... 08:45:21 INFO - Return code: 0 08:45:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:45:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:22 INFO - Reading from file tmpfile_stdout 08:45:22 INFO - Current package versions: 08:45:22 INFO - argparse == 1.2.1 08:45:22 INFO - blessings == 1.5.1 08:45:22 INFO - blobuploader == 1.2.4 08:45:22 INFO - docopt == 0.6.1 08:45:22 INFO - manifestparser == 1.1 08:45:22 INFO - mozInstall == 1.12 08:45:22 INFO - mozcrash == 0.16 08:45:22 INFO - mozdebug == 0.1 08:45:22 INFO - mozdevice == 0.47 08:45:22 INFO - mozfile == 1.2 08:45:22 INFO - mozhttpd == 0.7 08:45:22 INFO - mozinfo == 0.9 08:45:22 INFO - mozleak == 0.1 08:45:22 INFO - mozlog == 3.1 08:45:22 INFO - moznetwork == 0.27 08:45:22 INFO - mozprocess == 0.22 08:45:22 INFO - mozprofile == 0.27 08:45:22 INFO - mozrunner == 6.11 08:45:22 INFO - mozscreenshot == 0.1 08:45:22 INFO - mozsystemmonitor == 0.0 08:45:22 INFO - moztest == 0.7 08:45:22 INFO - mozversion == 1.4 08:45:22 INFO - psutil == 3.1.1 08:45:22 INFO - requests == 1.2.3 08:45:22 INFO - wsgiref == 0.1.2 08:45:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20660b0>, '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 0x2066fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2067440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', '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 08:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:45:22 INFO - Using env: {'DISPLAY': ':0', 08:45:22 INFO - 'HOME': '/home/cltbld', 08:45:22 INFO - 'LANG': 'en_US.UTF-8', 08:45:22 INFO - 'LANGUAGE': 'en_US:en', 08:45:22 INFO - 'LOGNAME': 'cltbld', 08:45:22 INFO - 'MAIL': '/var/mail/cltbld', 08:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:22 INFO - 'MOZ_NO_REMOTE': '1', 08:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:22 INFO - 'NO_EM_RESTART': '1', 08:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:22 INFO - 'PWD': '/builds/slave/test', 08:45:22 INFO - 'SHELL': '/bin/bash', 08:45:22 INFO - 'SHLVL': '1', 08:45:22 INFO - 'TERM': 'linux', 08:45:22 INFO - 'TMOUT': '86400', 08:45:22 INFO - 'USER': 'cltbld', 08:45:22 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', 08:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:22 INFO - '_': '/tools/buildbot/bin/python'} 08:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:45:22 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:45:22 INFO - Cleaning up... 08:45:22 INFO - Return code: 0 08:45:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20660b0>, '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 0x2066fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2067440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', '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 08:45:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:45:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:45:22 INFO - Using env: {'DISPLAY': ':0', 08:45:22 INFO - 'HOME': '/home/cltbld', 08:45:22 INFO - 'LANG': 'en_US.UTF-8', 08:45:22 INFO - 'LANGUAGE': 'en_US:en', 08:45:22 INFO - 'LOGNAME': 'cltbld', 08:45:22 INFO - 'MAIL': '/var/mail/cltbld', 08:45:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:22 INFO - 'MOZ_NO_REMOTE': '1', 08:45:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:22 INFO - 'NO_EM_RESTART': '1', 08:45:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:22 INFO - 'PWD': '/builds/slave/test', 08:45:22 INFO - 'SHELL': '/bin/bash', 08:45:22 INFO - 'SHLVL': '1', 08:45:22 INFO - 'TERM': 'linux', 08:45:22 INFO - 'TMOUT': '86400', 08:45:22 INFO - 'USER': 'cltbld', 08:45:22 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', 08:45:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:22 INFO - '_': '/tools/buildbot/bin/python'} 08:45:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:22 INFO - Downloading/unpacking jsonschema 08:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:45:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 08:45:24 INFO - Downloading/unpacking functools32 (from jsonschema) 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:24 INFO - Downloading functools32-3.2.3-2.tar.gz 08:45:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:45:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:45:24 INFO - warning: no files found matching '*.txt' 08:45:24 INFO - no previously-included directories found matching 'build' 08:45:24 INFO - no previously-included directories found matching 'dist' 08:45:24 INFO - no previously-included directories found matching '.git*' 08:45:24 INFO - Installing collected packages: jsonschema, functools32 08:45:24 INFO - Running setup.py install for functools32 08:45:24 INFO - warning: no files found matching '*.txt' 08:45:24 INFO - no previously-included directories found matching 'build' 08:45:24 INFO - no previously-included directories found matching 'dist' 08:45:24 INFO - no previously-included directories found matching '.git*' 08:45:24 INFO - Successfully installed jsonschema functools32 08:45:24 INFO - Cleaning up... 08:45:24 INFO - Return code: 0 08:45:24 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:45:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:45:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:45:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa19afe2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd7240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20660b0>, '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 0x2066fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2067440>, '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': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', '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 08:45:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:45:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:45:24 INFO - Using env: {'DISPLAY': ':0', 08:45:24 INFO - 'HOME': '/home/cltbld', 08:45:24 INFO - 'LANG': 'en_US.UTF-8', 08:45:24 INFO - 'LANGUAGE': 'en_US:en', 08:45:24 INFO - 'LOGNAME': 'cltbld', 08:45:24 INFO - 'MAIL': '/var/mail/cltbld', 08:45:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:24 INFO - 'MOZ_NO_REMOTE': '1', 08:45:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:24 INFO - 'NO_EM_RESTART': '1', 08:45:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:24 INFO - 'PWD': '/builds/slave/test', 08:45:24 INFO - 'SHELL': '/bin/bash', 08:45:24 INFO - 'SHLVL': '1', 08:45:24 INFO - 'TERM': 'linux', 08:45:24 INFO - 'TMOUT': '86400', 08:45:24 INFO - 'USER': 'cltbld', 08:45:24 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', 08:45:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:24 INFO - '_': '/tools/buildbot/bin/python'} 08:45:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:45:24 INFO - Downloading/unpacking flake8 08:45:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:26 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:45:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 08:45:26 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:26 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:45:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 08:45:26 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 08:45:27 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:45:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:45:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:45:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:45:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:45:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:45:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:45:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:45:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:45:27 INFO - no previously-included directories found matching 'docs/_build' 08:45:27 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:45:27 INFO - Running setup.py install for pep8 08:45:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:45:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:45:27 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:45:27 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:45:27 INFO - no previously-included directories found matching 'docs/_build' 08:45:27 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:45:27 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:45:27 INFO - Cleaning up... 08:45:27 INFO - Return code: 0 08:45:27 INFO - Running post-action listener: _resource_record_post_action 08:45:27 INFO - Running post-action listener: _start_resource_monitoring 08:45:27 INFO - Starting resource monitoring. 08:45:27 INFO - ##### 08:45:27 INFO - ##### Running install step. 08:45:27 INFO - ##### 08:45:27 INFO - Running pre-action listener: _resource_record_pre_action 08:45:27 INFO - Running main action method: install 08:45:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:45:27 INFO - Reading from file tmpfile_stdout 08:45:27 INFO - Detecting whether we're running mozinstall >=1.0... 08:45:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:45:27 INFO - Reading from file tmpfile_stdout 08:45:27 INFO - Output received: 08:45:27 INFO - Usage: mozinstall [options] installer 08:45:27 INFO - Options: 08:45:27 INFO - -h, --help show this help message and exit 08:45:27 INFO - -d DEST, --destination=DEST 08:45:27 INFO - Directory to install application into. [default: 08:45:27 INFO - "/builds/slave/test"] 08:45:27 INFO - --app=APP Application being installed. [default: firefox] 08:45:27 INFO - mkdir: /builds/slave/test/build/application 08:45:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:45:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:45:43 INFO - Reading from file tmpfile_stdout 08:45:43 INFO - Output received: 08:45:43 INFO - /builds/slave/test/build/application/firefox/firefox 08:45:43 INFO - Running post-action listener: _resource_record_post_action 08:45:43 INFO - ##### 08:45:43 INFO - ##### Running run-tests step. 08:45:43 INFO - ##### 08:45:43 INFO - Running pre-action listener: _resource_record_pre_action 08:45:43 INFO - Running main action method: run_tests 08:45:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:45:43 INFO - Python 2.7.3 08:45:43 INFO - Return code: 0 08:45:43 INFO - grabbing minidump binary from tooltool 08:45:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:45:43 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 0x20660b0>, '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 0x2066fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2067440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:45:43 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 08:45:43 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 08:45:43 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:45:43 INFO - Return code: 0 08:45:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:45:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:45:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:45:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:45:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:45:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:45:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:45:44 INFO - Return code: 0 08:45:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] in /builds/slave/test/build 08:45:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-027 --webServer localhost 08:45:44 INFO - Using env: {'DISPLAY': ':0', 08:45:44 INFO - 'HOME': '/home/cltbld', 08:45:44 INFO - 'LANG': 'en_US.UTF-8', 08:45:44 INFO - 'LANGUAGE': 'en_US:en', 08:45:44 INFO - 'LOGNAME': 'cltbld', 08:45:44 INFO - 'MAIL': '/var/mail/cltbld', 08:45:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:45:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:45:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:45:44 INFO - 'MOZ_NO_REMOTE': '1', 08:45:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:45:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:45:44 INFO - 'NO_EM_RESTART': '1', 08:45:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:45:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:45:44 INFO - 'PWD': '/builds/slave/test', 08:45:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:45:44 INFO - 'SHELL': '/bin/bash', 08:45:44 INFO - 'SHLVL': '1', 08:45:44 INFO - 'TERM': 'linux', 08:45:44 INFO - 'TMOUT': '86400', 08:45:44 INFO - 'USER': 'cltbld', 08:45:44 INFO - 'XDG_SESSION_COOKIE': '447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112', 08:45:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:45:44 INFO - '_': '/tools/buildbot/bin/python'} 08:45:44 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-027', '--webServer', 'localhost'] with output_timeout 3600 08:45:44 INFO - mozversion INFO | application_buildid: 20151217072904 08:45:44 INFO - mozversion INFO | application_changeset: 0711218a018d912036f7d3be2ae2649e213cfb85 08:45:44 INFO - mozversion INFO | application_display_name: Nightly 08:45:44 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:45:44 INFO - mozversion INFO | application_name: Firefox 08:45:44 INFO - mozversion INFO | application_remotingname: firefox 08:45:44 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 08:45:44 INFO - mozversion INFO | application_vendor: Mozilla 08:45:44 INFO - mozversion INFO | application_version: 46.0a1 08:45:44 INFO - mozversion INFO | platform_buildid: 20151217072904 08:45:44 INFO - mozversion INFO | platform_changeset: 0711218a018d912036f7d3be2ae2649e213cfb85 08:45:44 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 08:45:44 INFO - mozversion INFO | platform_version: 46.0a1 08:45:44 INFO - 2015-12-17 08:45:44,515 DEBUG : using testdate: 1450370744 08:45:44 INFO - 2015-12-17 08:45:44,515 DEBUG : actual date: 1450370744 08:45:44 INFO - 2015-12-17 08:45:44,530 INFO : starting webserver on 'localhost:45134' 08:45:44 INFO - 2015-12-17 08:45:44,531 INFO : Starting test suite talos-linux64-ix-027 08:45:44 INFO - 2015-12-17 08:45:44,531 INFO : Starting test dromaeo_css 08:45:44 INFO - 2015-12-17 08:45:44,531 DEBUG : operating with platform_type : linux_ 08:45:44 INFO - 2015-12-17 08:45:44,532 INFO : Initialising browser for dromaeo_css test... 08:45:44 INFO - 2015-12-17 08:45:44,546 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp7BK7d/profile http://localhost:45134/getInfo.html 08:45:49 INFO - 2015-12-17 08:45:49,007 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:45:49 INFO - 2015-12-17 08:45:49,007 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:45:49 INFO - 2015-12-17 08:45:49,007 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:45:49 INFO - 2015-12-17 08:45:49,007 DEBUG : BROWSER_OUTPUT: __metrics 08:45:49 INFO - 2015-12-17 08:45:49,164 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] 08:45:49 INFO - 2015-12-17 08:45:49,240 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] 08:45:50 INFO - 2015-12-17 08:45:50,417 INFO : Browser initialized. 08:45:50 INFO - 2015-12-17 08:45:50,418 INFO : Running cycle 1/1 for dromaeo_css test... 08:45:50 INFO - 2015-12-17 08:45:50,418 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp7BK7d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:46:02 INFO - 2015-12-17 08:46:02,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 150007808 08:46:02 INFO - 2015-12-17 08:46:02,319 DEBUG : BROWSER_OUTPUT: 08:46:53 INFO - 2015-12-17 08:46:53,858 DEBUG : BROWSER_OUTPUT: 1450370813850 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] 08:49:06 INFO - 2015-12-17 08:49:06,092 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45134/tests/dromaeo/cssquery-ext.html) 08:49:07 INFO - 2015-12-17 08:49:07,157 DEBUG : BROWSER_OUTPUT: RSS: Main: 246501376 08:49:07 INFO - 2015-12-17 08:49:07,157 DEBUG : BROWSER_OUTPUT: 08:52:09 INFO - 2015-12-17 08:52:09,670 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/dromaeo/cssquery-ext.html (next: http://localhost:45134/tests/dromaeo/cssquery-jquery.html) 08:52:10 INFO - 2015-12-17 08:52:10,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 227627008 08:52:10 INFO - 2015-12-17 08:52:10,251 DEBUG : BROWSER_OUTPUT: 08:55:12 INFO - 2015-12-17 08:55:12,346 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45134/tests/dromaeo/cssquery-mootools.html) 08:55:12 INFO - 2015-12-17 08:55:12,936 DEBUG : BROWSER_OUTPUT: RSS: Main: 232493056 08:55:12 INFO - 2015-12-17 08:55:12,936 DEBUG : BROWSER_OUTPUT: 08:58:14 INFO - 2015-12-17 08:58:14,822 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45134/tests/dromaeo/cssquery-prototype.html) 08:58:15 INFO - 2015-12-17 08:58:15,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 213733376 08:58:15 INFO - 2015-12-17 08:58:15,416 DEBUG : BROWSER_OUTPUT: 09:01:18 INFO - 2015-12-17 09:01:18,221 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45134/tests/dromaeo/cssquery-yui.html) 09:01:18 INFO - 2015-12-17 09:01:18,814 DEBUG : BROWSER_OUTPUT: RSS: Main: 218279936 09:01:18 INFO - 2015-12-17 09:01:18,814 DEBUG : BROWSER_OUTPUT: 09:04:21 INFO - 2015-12-17 09:04:21,310 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/dromaeo/cssquery-yui.html (next: http://localhost:45134/tests/dromaeo/cssquery-dojo.html) 09:04:21 INFO - 2015-12-17 09:04:21,560 DEBUG : BROWSER_OUTPUT: RSS: Main: 225357824 09:04:21 INFO - 2015-12-17 09:04:21,560 DEBUG : BROWSER_OUTPUT: 09:04:21 INFO - 2015-12-17 09:04:21,560 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:04:21 INFO - 2015-12-17 09:04:21,560 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:04:21 INFO - 2015-12-17 09:04:21,560 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:04:21 INFO - 2015-12-17 09:04:21,561 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:04:21 INFO - 2015-12-17 09:04:21,561 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2630.1583493282146;2705.3236690827293;2707.4043710383735;2715.823471474354;2730.890764369425;4542.636589072875;4702;4720.362751028611;4749.667523273368;4753.001869607382;4609.539046095389;4637.327587499811;4728.574428301452;4737.810487580493;4753.144434001878;4281.529031806499;4327.610515053644;4347.065380943097;4403.691741578091;4407.18467083589;4341.327094300388;4411.779411029452;4437.423134992447;4437.556244375569;4484.148011877733;4182.435371224907;4282.614564689162;4302.655787537021;4391.4730232372;4431.313146462304;4270.359446083081;4372.628326592244;4387.14450682114;4389.122175564899;4417.602415782595;4304.332828411601;4329.783510824478;4345.674074444398;4349.064951035542;4393.143337049277;4468.039371535103;4595.655325850575;4644.6052085572765;4671.392718946549;4674.696144750615;4892.363992680965;4988.725620090893;5005.399352077774;5009.4239162496415;5024.070546948826;5033.496650334974;5064.468230835746;5066.214736715815;5077.009983053306;5121.334226550562;4468.664850136252;4576.130535198302;4694.225452800318;4697.4832768395445;4700.2009658358165;4967.130752118364;5071.340725705709;5077.238414237894;5081.441041485434;5109.131447653834;4943.9258411123865;4953.578945789648;4954.256861470736;4961.4294356148785;5005.199168133081;5080.237964305384;5109.3613298337705;5109.795608175631;5110.412302585176;5115.053715062725;4720.433547974265;4850.684705494132;4854.053459575349;4872.19608764557;5011.423686276052;4944.456109827916;4962.5533701967;4965.3048573199785;4965.751712414365;5009.599232061426;4172.853950111731;4181.163767246563;4181.707280490336;4185.079282557833;4216.620504154641;3513.7540372173703;3582.9104272393397;3646.3801153803915;3647.0335361129323;3685.8894233173046;4338.652907767371;4374.475062992461;4381.824727010948;4386.627136693353;4395.604395604411;5099.3370861787735;5116.897662046738;5118.334616499831;5122.052420302256;5159.974200128975;4118.341065429577;4232.894177645522;4237.491501019897;4240.427542281815;4338.609525142752;4421.7346959181905;4446.822127114944;4449.555044495524;4449.844255451044;4489.19194544985;4775.5463230993;4787.952120478751;4791.760411979457;4792.7124372537755;4841.104395686809;4785.880352991203;4903.26451032348;4909.631777616622;4926.3842019747535;5055.6713813602;4709.0817290628;4724.952750472451;4733.077049975222;4748.216544270295;4787.61699064067;4941.876453088557;5000.274960130688;5004.84985450437;5012.523810238022;5065;4840.346553215411;4902.509749025212;4974.427940786856;4977.502249774993;5040.521150490697;4844.588210002189;4878.219484882402;4880.827462149631;4883.121038213156;4915.754212289443;4862.95137048625;4868.975655121843;4870.26945958095;4872.342233798392;4910.852674419773;4585.839495617637;4647.186742320148;4671.486136524912;4709.48195698466;4794.113089078532;4943.579795717261;4949.430815456125;4951.430585482572;4952.479989601185;4963.255511673278;4820.68665536739;4845.442774081026;4849.160454260473;4850.53919877611;4875.7074575525585 09:04:21 INFO - 2015-12-17 09:04:21,562 DEBUG : BROWSER_OUTPUT: |1;ext.html;550.7026205848839;560.9566206855249;568.1818181818179;579.8666306749448;581.8894410062088;27095.5935660965;32530.67469325306;33055.33889322215;33155.17112072199;33230.83384583073;39033;39484.21031579374;39495.210095798066;39629.60370396295;39639;7011.404030657401;7154.67803948821;7811.179826118261;7960.203979602052;8002.919970800276;10003.149732272766;10223.897761022406;10304.536295866666;10313.948430257838;10324.483775811217;9934.9503252484;10077.193824494023;10079.798404031915;10079.949600251988;10085.596576136946;7221.927780722204;7416.258374162595;9829.803403931954;9925.900740992605;10066.899331006669;9733.951330243373;9892.060254275832;9895.851562226573;9907.207423406111;9914.355566888129;36710.816445917866;37094.44358334627;37172.32724527403;37177.81411092927;37253.81373093117;2716.660417447819;2835.9858200709073;2964.125582953034;3142.4814905540557;3353.195233144052;27940.720592794016;28137.86800315916;28143.718562814316;28198.577021344696;28794.136175914547;2763.2937983064908;2798.6361772969385;2821.887124515017;2852.957205641917;2966.347403571211;217300;217780;217838;217871;218185;49647;50883;50965.49034509608;52568.47431525636;52852.47147528552;60893;61984.69007655023;62280.68859655764;62386.37613623896;62440.68779656164;12625.873741262654;12805.487780488862;12811.487540498461;12823.61529154127;12827.935860320638;8544.231019208177;8549.529775862387;8553.059163492011;8575.528345940907;8575.614097365633;17219.569510762332;17393.65212695739;17607.823921760875;17638.735418968725;17719;6976.162860456778;7136.857262854817;7158.2483839197175;7200.279972002862;7201.747938822116;866.3372520022189;944.5135755086136;1044.8746150461993;1055.37205362809;1059.6820953713855;25718.760599349618;26163;26172.607410888853;26184.476310473685;26403.20790376292;949.6486300069018;988.7972965542046;1012.5797793915442;1042.9113525350278;1119.8936101070385;13452.461901524026;13736.725265494633;13788.103773254907;13849.584512464642;13884.58346249614;263157;266051;266587;268131;269122;44935.55064449314;45112;45122.77438612851;45168.77415612901;45208;1117.3686866920164;1172.8240763885485;1180.9173357865038;1181.509673485494;1303.791393377055;23257.534849303258;23418.531629366975;23825.880870595534;23958.88020559956;24022.51954960926;29970.550441743828;30198.54702179513;30261.546076809307;30293.242668933453;30324.84837575798;219855;224525;336944;347899;348149;26535.60196597014;26596.86701566557;26654;26688.599671004562;26701.732982669924;35335.46996794999;35578.8221058893;35817;36600.81699591485;36700;30242.114671180134;30683.386332272785;30721.38557228798;31179;31487.52768708517;30977.380452391277;31212.687873121886;31267.53098703567;31279;31341.216469588442;30972.380552389277;32876.1780955478;33365.16587085342;33487;33524.83237583894;24751.25746227616;28882.855585721936;29863;29956.550651740676;29957.251068723457;20723.4819129523;21941.67087493721;22814.885925570266;23221.535569288182;23745.931433085898 09:04:21 INFO - 2015-12-17 09:04:21,565 DEBUG : BROWSER_OUTPUT: |2;jquery.html;314.5674697291225;322.3150804540352;323.7749763914081;331.97585448890175;333.4548013997114;13061.60815175544;13601.251931143783;14621.415143394264;15419.922900385496;15577.376904923789;11803.350815705133;14657;15473;15965.760513592306;15983.280752366143;4935;4964.205727083668;5089.949100509003;5114.846554603349;5120.820771273006;3808.9809550952205;3923.8822835314986;5080.847574572768;5120.436751957282;5836.649801011953;5989.221401217836;6029.276486821587;6047.395260473962;6047.637141771485;6048.366940925947;5789.131630255453;5819.330776960662;5915.497182739451;5933.258342707161;6008;5167.173252279617;5186.611004174702;5187.247849061902;5189.922151167735;5196.6881987080515;19360.612787744307;19655.213791448325;19919.800801992085;19923.103460344173;19986.80013199864;1882.275324000256;1945.367755479475;1959.206521358852;1989;2012.939611811648;12681.682957926034;12739.87260127396;12801.93599031999;12914.354282285942;13156.605301840864;1819.1540933466001;1820.3719716697717;1844.6956252218367;1861.8696691231619;1872.1481725814858;53965;54748.45251547473;54860.17709734397;54977.72511137419;55392.446075539134;9255.213306868991;9330.160285574195;9398.718038458857;9431.481268530297;9478.440820978436;12154.453049612788;12157.209781364183;12173.756524869454;12198.32909190003;12203.328816914978;6835.316468353125;6835.897461538081;6901.171859376806;7010.509264351446;7067.081279433641;6699.598024118569;6724.226713927961;6775.288594697585;6784.694688739019;6788.355106264897;5574.275344205227;5647.37878833328;5703.600747947687;5718.199452076713;5874.882502349929;1528.5490780219639;1621.8459246371576;1623.3506597360913;1626.4795265514922;1653.3221379234456;794.7258195922398;847.9618417171242;963.9228861691188;969.7187815533416;1026.7946410717886;14208.85791142096;14232.43070277198;15405;17002.89481183744;17103.23035463407;747.4095464583028;765.9770206893802;822.2394285286086;863.5811631358786;893.5666201892077;5943.3462319144855;8726.694565690297;8745.912540874637;8757.605907734167;8948.926128864578;463951;465652;482454;482550;483373;63621.363786361544;70711.64644176849;73035.6348218266;73249;74450.62774686092;974.2498276327331;1002.5137808163036;1004.7136566078779;1005.1857995024054;1039.73486760877;13371.799423008857;13957.58127256184;14260;14404.711905762035;15377.38490460369;32128.19679508031;32180.19549511281;32321.676783231866;33631.83184084064;33978.15054623654;38362.23275534529;39942.2011559773;40585;40890.38664419977;42303.576964229964;8762;8970.865437018581;9406.43561386319;9406.576704048472;9428.340016198801;16100.67798643997;16317.265723042728;16338.101404422396;16423;16734.163291835604;13475.99451303155;13491.05562610647;13620.387082581507;14133.293335333397;14154;13452.394642240926;13455.192688438334;13661.86338136606;13696.383662735001;13720.65698357549;13635.727285454434;13686.657833553843;13742.65643358884;14047.508337208557;14173.36219870129;6865.244823069558;7614.428917831296;7622.847543049219;7757.224277572198;9103.99856015851;12973.09188356806;13080.672983175496;13427.12723672958;13520.59438216855;13524.459021639417 09:04:21 INFO - 2015-12-17 09:04:21,566 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1222.517105743232;1587.2381256996641;1682.991585042075;1696.3214714114354;1736.0712019069792;6019.428154325337;7021.68402421891;7185.425165986721;7204.675789589468;7218.458615603825;7219.0976127984;7343.155537113234;7352.375048120903;7360.705571777123;7393.889091663616;1734.6617409605133;1760.1903124562716;1761.3130878957218;2066.638338290797;2115.6720708290163;1744.485376813843;1752.4392194497702;2036.4297996560913;2044.1721102953327;2069.379186244121;2021.4036859126593;2029.03620780129;2033.5526184239443;2036.419620408184;2037.5415531505441;2017.4149496645955;2097.7063211150453;2097.8216851567636;2098.7376577927757;2100.516881117344;2059.680749483832;2071.8135367816817;2085.509905172283;2114.534802343482;2115.3548167808813;7119.430445564342;7162.749303774395;7224.096987876515;7231.783046508614;7242;4105.384192371138;4168.458100446923;4181.351890456984;4210.578942105795;4212.662986961036;2583.6899572051284;2622.5148347555573;2656.8405895646324;2660.3216179874203;2687.7984151188543;885.1812073831744;887.4054383562964;901.7204666553324;906.8367693815111;917.7980844214329;9780.755481112958;9795.265355098396;9796.216302695839;9797.06927841861;9839.852402213972;3798.582155962842;3849.1147036181833;3862.8454861805776;3916.373380259145;3917.588653191374;8404.369672274604;8431.831363372698;8454.577271136419;8458.703945362005;8469.449485783405;4243.766592837424;4246.087091275391;4248.723832950848;4251.426057482262;4256.2551553478015;3866.8066596670055;3874.380099184117;3888.241792850367;3888.8250028748776;3889.2221555688975;3493;3503.8948831535095;3514.8242587870504;3517.613062563116;3527.1182204448887;923.5243849417556;927.7448701606977;1073.6564299424265;1077.9892201078046;1101.1851230089676;888.7333799860016;905.4250550900094;907.587047893207;908.3777612335572;1188.8038473651923;6669.833254168588;6757.358050985148;6766.458683305422;6766.661666916634;6768.357006084414;1016.4714348538719;1030.1964467715045;1030.2891005206384;1035.8135535603665;1037.0873631204643;5042.4705405931845;5044.268581055726;5065.898682026339;5105.132127538253;5173.870653233699;8637.654493820302;8869.334799889904;8873;8882.06738292483;8894.86657700135;8582.837323897904;8748.300135989106;8749.47503149813;8770.38607297483;8779.604917778715;6601;6625.635590042594;6632.1709786276715;6685.598864068172;6691.799246022627;6448.387403196689;6483.578567393104;6521.706523206372;6548.770793022412;6574.4411725002;7759.883601746092;7811.5313081213035;7820.84358312842;7835.294823465915;7980.561069141021;7932.722354717557;7933.761987140395;8080.676772929252;8080.797980050545;8089.312408445348;5924.763009479572;5941.58408911372;5997.970010149921;5998.820035398945;6012.729427175875;7001.194862590663;7053.964730176316;7056.188538317954;7070.080889484334;7073.434125270069;6280.152179455715;6391.712372943136;6545.378189072221;6604.5046621502615;6720.092787473824;6299.779507717208;6312.337204593635;6352.333005034589;6528.281888992302;6610.4711623071;6316.305206427382;6356.9046464304;6384.680765961776;6405.391487808651;6450.612963222222;6072.726727297194;6095.939040609537;6108.02271636536;6110.114033465034;6122.846928826815;6151.292601350902;6172.290186628596;6187.226596675416;6192.938070619236;6197.96901015492 09:04:21 INFO - 2015-12-17 09:04:21,569 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.37408564271954;306.35970820984164;307.32542070156;309.40748466686296;314.236405534551;5145.202493613487;5198.896022079556;5253.500917412849;5278.736063196844;5389.5688344932405;5071.695698258107;5200.817971371002;5224.1902505111675;5227.79088836446;5230.633855630107;3862.401327794182;4094.0992981544014;4106.342985122388;4115.218108559379;4116.156187981456;3948.05246740783;3994.720369574131;4101.58984101589;4103.9384409233735;4119.299719047769;4048.6761059115347;4058.0666446717273;4062.2281766464275;4065.695072869532;4072.1855628874346;4066.3087275162998;4066.3900414937702;4071.124708187739;4073.816678249486;4083.8570650027405;3539.982300088509;3543.698785603227;3577.4276115821604;3577.6601222883783;3583.87456439026;4995.9500404996215;5052.873678158038;5078.4921507849285;5103.948960510422;5105.719185444799;4626.9074618507775;4628.791704373311;4631;4631.235846085426;4640.628749700016;5503;5503;5508.55931525477;5518.530924871391;5522.116461366162;3641.308151451216;3724.16206353571;3825.827837747308;3830.7510011849417;3832.8466861325514;5652.236948012048;5768.423157684198;5799.3910639382675;5800;5801.7099145043;3949.960500395017;3950.20995800841;3957.5448823385104;3957.821898014596;3959.920801583952;4004.4593979812353;4008.8797336079965;4012.1373904610064;4012.839486420569;4013.5585085640555;4474.709143905636;4597.218472859622;4599.448066232074;4608.746518941491;4608.861734147981;5522.751476183581;5530.6128570999645;5530.723463826793;5541.085720856014;5551.306086739158;1407.5003373802153;1418.0711633879826;1420.3324437514352;1421.3390773290469;1422.8150340455675;954.4368822394681;970.737900766789;976.6630512473185;982.4252812104999;989.9059589339001;4866.270059491105;4866.391701037371;4874.634402419832;4880.951190488121;4882.731449770296;5735.311762588516;5746.195532625436;5748.338941021752;5752.194692743019;5754.108113242454;4852.369192005017;4870.975645121752;4873.756312184377;4879.048585525788;4879.1461494238365;3001.4897467430587;3058.938821223563;3083.6762139975426;3096.1949893027527;3111.8132912025353;5498.1752737088955;5503.862403439866;5509.393966663663;5517.668939863621;5520.089185284383;5970;5970.552208584373;5979.282486101695;5981.730822113015;5988.550858685616;5497.972510137423;5504.311961004874;5506.834794956158;5508.421615730291;5512.39363669996;5668.348139963957;5784.248047753765;5793.623414478046;5800.767969281182;5812.3025236971835;5399.136138217867;5657;5658.094704847204;5667.789562070713;5669.971650141723;5358.598105142208;5417.918731219113;5493.917591236055;5495.148252020943;5509.173623956439;3956.169204467094;4009;4010.438538604539;4010.9197816042933;4018.3570628699267;5755.309362876482;5776.480116789509;5777.24895763548;5782.005208203163;5782.074868021096;5448.645838020516;5561.972190139185;5566.248556444828;5590.664560126405;5590.909772594305;5522.144067669517;5542.8337149885565;5564.304461942257;5575.0522411191005;5579.46995035471;5441.238226648194;5451.509364157245;5455;5461.962227176824;5489.368722596792;5479;5619.943800561942;5619.971900140473;5622.690752008679;5628.155776633538;5472.425395333433;5483.314585676791;5483.890322193454;5485.341758988947;5491.972540137273 09:04:21 INFO - 2015-12-17 09:04:21,571 DEBUG : BROWSER_OUTPUT: |5;yui.html;615.9384061593838;724.9528780629258;734.6326836581705;739.7299985505289;747.2415498269254;11186.552537898484;11474.598389056384;11499.655010349692;11509.597164099257;11511.654650360482;10993.890061099386;11006.559737610505;11008.119350451965;11013.724656883582;11020.669379918596;629.6757170057401;637.6046850952392;785.1638005524113;795.645937557787;809.2797410304804;783.902012248469;785.5836406704427;785.7485604606528;792.6591565626778;792.9365650747926;655.8950567909136;837.798928257217;845.898492180936;845.9703910363138;846.1749793950879;652.4682383857165;812.1269635142246;823.4812068396932;824.1099612418603;824.6412810427423;616.4698359410903;616.6608365399057;616.7255571270787;616.8457885528618;617.1421723803916;10754.139668826476;10893.128549716004;10938.398388088652;10947.781044379148;10950.452477376179;10406.531706073169;10908.890911090866;11228.101751859913;11429.485673144729;11440.542378304857;9370.10983956523;9464.479453630047;9477.336586438953;9638.036196380306;9668.178204852597;3174.8095114293214;3206.5350524174096;3239.2063944333554;3257.853396597135;3271.525628783837;39645.20709585792;39828.800855995534;40260.19479610421;40485.39271910924;40540;8905.821883562423;9034.147999660054;9054.123161098512;9193.678221262357;9197.494137822485;15542.84457155414;15571.143587102819;15637.218139093;15663.216839158224;15689.764653530206;6316.494680425555;6328.208973878265;6451.357084795503;6458.903116453257;6492.740290388331;3627;3640.6541378568995;3653.104989277644;3658.5243918290453;3732.3654978653694;2500.2874180858366;2507.2352932355807;2521.0924067335745;2530.962035569468;2536.4927014597156;440.94929083155205;444.1538868455533;445.7615175880888;446.1478575920042;448.28498544820957;504.412359601068;525.6530689744826;526.210683974039;535.606329347929;551.9944800551943;6595.934040659628;7183.96408017967;7269.273072692688;7323.523970941872;7512.737054203077;524.3210042994256;539.6681041159659;549.7059073395794;553.7646500237383;572.5963195946847;3320.900372988814;3351.614564325085;3383.9661603384143;3389.7288216942584;3401.6598340165783;45438;45975.31037034447;46367.30449043267;46418.5358146421;46537.767311163225;42338;42456;43315.566844331785;43498.347524787154;43807.34288985668;37022.8148859254;38170.04574885595;38959.22081558353;38993.220135597694;39207;7180.964095179491;7219.566825990458;7416.814579635552;7513.774586762406;7630.313271805564;29364;29720.10839674813;29815;30052.3989520204;30220;36123.458148128324;36784.26431471409;37510.62489375071;37649;37882.43176352412;9178.908210918073;9571.33000689945;9608.567614457506;9616.08647178517;9713.70858874235;10011.949940250252;10108.39349639024;10339.534720937727;10582.947085264525;11177.944110279397;9532.571034303612;9736.853947190657;9789.951050244703;9860.408375497493;10066.245031622511;9943.453110079015;9952.502374881082;10013.449260290754;10150.13723833453;10178.236632252463;9812.705618831447;9856.260780441638;9926.454045027593;9936.850947235653;10013.24900632441;8549.572521373782;8848.646054157762;8875.822483550164;8957.193852553302;9282.535873206178;7611.4291428142005;7998.360131189607;8054.5569993650915;8193.180681931759;8331.583420829056 09:04:21 INFO - 2015-12-17 09:04:21,571 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:04:21 INFO - 2015-12-17 09:04:21,571 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:04:21 INFO - 2015-12-17 09:04:21,571 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,901 09:04:21 INFO - 2015-12-17 09:04:21,572 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:04:21 INFO - 2015-12-17 09:04:21,572 DEBUG : BROWSER_OUTPUT: __startTimestamp1450371861559__endTimestamp 09:04:21 INFO - 2015-12-17 09:04:21,572 DEBUG : BROWSER_OUTPUT: 09:04:21 INFO - 2015-12-17 09:04:21,572 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:04:21 INFO - 2015-12-17 09:04:21,572 DEBUG : BROWSER_OUTPUT: Number of tests: 6 09:04:21 INFO - 2015-12-17 09:04:21,572 DEBUG : BROWSER_OUTPUT: 09:04:21 INFO - 2015-12-17 09:04:21,572 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4629.66 Median:4753.00 stddev:480.48 (10.1%) stddev-sans-first:455.63 09:04:21 INFO - 2015-12-17 09:04:21,573 DEBUG : BROWSER_OUTPUT: Values: 2630.2 2705.3 2707.4 2715.8 2730.9 4542.6 4702.0 4720.4 4749.7 4753.0 4609.5 4637.3 4728.6 4737.8 4753.1 4281.5 4327.6 4347.1 4403.7 4407.2 4341.3 4411.8 4437.4 4437.6 4484.1 4182.4 4282.6 4302.7 4391.5 4431.3 4270.4 4372.6 4387.1 4389.1 4417.6 4304.3 4329.8 4345.7 4349.1 4393.1 4468.0 4595.7 4644.6 4671.4 4674.7 4892.4 4988.7 5005.4 5009.4 5024.1 5033.5 5064.5 5066.2 5077.0 5121.3 4468.7 4576.1 4694.2 4697.5 4700.2 4967.1 5071.3 5077.2 5081.4 5109.1 4943.9 4953.6 4954.3 4961.4 5005.2 5080.2 5109.4 5109.8 5110.4 5115.1 4720.4 4850.7 4854.1 4872.2 5011.4 4944.5 4962.6 4965.3 4965.8 5009.6 4172.9 4181.2 4181.7 4185.1 4216.6 3513.8 3582.9 3646.4 3647.0 3685.9 4338.7 4374.5 4381.8 4386.6 4395.6 5099.3 5116.9 5118.3 5122.1 5160.0 4118.3 4232.9 4237.5 4240.4 4338.6 4421.7 4446.8 4449.6 4449.8 4489.2 4775.5 4788.0 4791.8 4792.7 4841.1 4785.9 4903.3 4909.6 4926.4 5055.7 4709.1 4725.0 4733.1 4748.2 4787.6 4941.9 5000.3 5004.8 5012.5 5065.0 4840.3 4902.5 4974.4 4977.5 5040.5 4844.6 4878.2 4880.8 4883.1 4915.8 4863.0 4869.0 4870.3 4872.3 4910.9 4585.8 4647.2 4671.5 4709.5 4794.1 4943.6 4949.4 4951.4 4952.5 4963.3 4820.7 4845.4 4849.2 4850.5 4875.7 09:04:21 INFO - 2015-12-17 09:04:21,573 DEBUG : BROWSER_OUTPUT: 09:04:21 INFO - 2015-12-17 09:04:21,573 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41103.33 Median:30277.39 stddev:69237.57 (228.7%) stddev-sans-first:69364.85 09:04:21 INFO - 2015-12-17 09:04:21,574 DEBUG : BROWSER_OUTPUT: Values: 550.7 561.0 568.2 579.9 581.9 27095.6 32530.7 33055.3 33155.2 33230.8 39033.0 39484.2 39495.2 39629.6 39639.0 7011.4 7154.7 7811.2 7960.2 8002.9 10003.1 10223.9 10304.5 10313.9 10324.5 9935.0 10077.2 10079.8 10079.9 10085.6 7221.9 7416.3 9829.8 9925.9 10066.9 9734.0 9892.1 9895.9 9907.2 9914.4 36710.8 37094.4 37172.3 37177.8 37253.8 2716.7 2836.0 2964.1 3142.5 3353.2 27940.7 28137.9 28143.7 28198.6 28794.1 2763.3 2798.6 2821.9 2853.0 2966.3 217300.0 217780.0 217838.0 217871.0 218185.0 49647.0 50883.0 50965.5 52568.5 52852.5 60893.0 61984.7 62280.7 62386.4 62440.7 12625.9 12805.5 12811.5 12823.6 12827.9 8544.2 8549.5 8553.1 8575.5 8575.6 17219.6 17393.7 17607.8 17638.7 17719.0 6976.2 7136.9 7158.2 7200.3 7201.7 866.3 944.5 1044.9 1055.4 1059.7 25718.8 26163.0 26172.6 26184.5 26403.2 949.6 988.8 1012.6 1042.9 1119.9 13452.5 13736.7 13788.1 13849.6 13884.6 263157.0 266051.0 266587.0 268131.0 269122.0 44935.6 45112.0 45122.8 45168.8 45208.0 1117.4 1172.8 1180.9 1181.5 1303.8 23257.5 23418.5 23825.9 23958.9 24022.5 29970.6 30198.5 30261.5 30293.2 30324.8 219855.0 224525.0 336944.0 347899.0 348149.0 26535.6 26596.9 26654.0 26688.6 26701.7 35335.5 35578.8 35817.0 36600.8 36700.0 30242.1 30683.4 30721.4 31179.0 31487.5 30977.4 31212.7 31267.5 31279.0 31341.2 30972.4 32876.2 33365.2 33487.0 33524.8 24751.3 28882.9 29863.0 29956.6 29957.3 20723.5 21941.7 22814.9 23221.5 23745.9 09:04:21 INFO - 2015-12-17 09:04:21,574 DEBUG : BROWSER_OUTPUT: 09:04:21 INFO - 2015-12-17 09:04:21,574 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26079.28 Median:21085.61 stddev:77629.77 (368.2%) stddev-sans-first:77823.44 09:04:21 INFO - 2015-12-17 09:04:21,574 DEBUG : BROWSER_OUTPUT: Values: 314.6 322.3 323.8 332.0 333.5 13061.6 13601.3 14621.4 15419.9 15577.4 11803.4 14657.0 15473.0 15965.8 15983.3 4935.0 4964.2 5089.9 5114.8 5120.8 3809.0 3923.9 5080.8 5120.4 5836.6 5989.2 6029.3 6047.4 6047.6 6048.4 5789.1 5819.3 5915.5 5933.3 6008.0 5167.2 5186.6 5187.2 5189.9 5196.7 19360.6 19655.2 19919.8 19923.1 19986.8 1882.3 1945.4 1959.2 1989.0 2012.9 12681.7 12739.9 12801.9 12914.4 13156.6 1819.2 1820.4 1844.7 1861.9 1872.1 53965.0 54748.5 54860.2 54977.7 55392.4 9255.2 9330.2 9398.7 9431.5 9478.4 12154.5 12157.2 12173.8 12198.3 12203.3 6835.3 6835.9 6901.2 7010.5 7067.1 6699.6 6724.2 6775.3 6784.7 6788.4 5574.3 5647.4 5703.6 5718.2 5874.9 1528.5 1621.8 1623.4 1626.5 1653.3 794.7 848.0 963.9 969.7 1026.8 14208.9 14232.4 15405.0 17002.9 17103.2 747.4 766.0 822.2 863.6 893.6 5943.3 8726.7 8745.9 8757.6 8948.9 463951.0 465652.0 482454.0 482550.0 483373.0 63621.4 70711.6 73035.6 73249.0 74450.6 974.2 1002.5 1004.7 1005.2 1039.7 13371.8 13957.6 14260.0 14404.7 15377.4 32128.2 32180.2 32321.7 33631.8 33978.2 38362.2 39942.2 40585.0 40890.4 42303.6 8762.0 8970.9 9406.4 9406.6 9428.3 16100.7 16317.3 16338.1 16423.0 16734.2 13476.0 13491.1 13620.4 14133.3 14154.0 13452.4 13455.2 13661.9 13696.4 13720.7 13635.7 13686.7 13742.7 14047.5 14173.4 6865.2 7614.4 7622.8 7757.2 9104.0 12973.1 13080.7 13427.1 13520.6 13524.5 09:04:21 INFO - 2015-12-17 09:04:21,574 DEBUG : BROWSER_OUTPUT: 09:04:21 INFO - 2015-12-17 09:04:21,575 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5016.32 Median:6289.97 stddev:2642.45 (42.0%) stddev-sans-first:2634.48 09:04:21 INFO - 2015-12-17 09:04:21,575 DEBUG : BROWSER_OUTPUT: Values: 1222.5 1587.2 1683.0 1696.3 1736.1 6019.4 7021.7 7185.4 7204.7 7218.5 7219.1 7343.2 7352.4 7360.7 7393.9 1734.7 1760.2 1761.3 2066.6 2115.7 1744.5 1752.4 2036.4 2044.2 2069.4 2021.4 2029.0 2033.6 2036.4 2037.5 2017.4 2097.7 2097.8 2098.7 2100.5 2059.7 2071.8 2085.5 2114.5 2115.4 7119.4 7162.7 7224.1 7231.8 7242.0 4105.4 4168.5 4181.4 4210.6 4212.7 2583.7 2622.5 2656.8 2660.3 2687.8 885.2 887.4 901.7 906.8 917.8 9780.8 9795.3 9796.2 9797.1 9839.9 3798.6 3849.1 3862.8 3916.4 3917.6 8404.4 8431.8 8454.6 8458.7 8469.4 4243.8 4246.1 4248.7 4251.4 4256.3 3866.8 3874.4 3888.2 3888.8 3889.2 3493.0 3503.9 3514.8 3517.6 3527.1 923.5 927.7 1073.7 1078.0 1101.2 888.7 905.4 907.6 908.4 1188.8 6669.8 6757.4 6766.5 6766.7 6768.4 1016.5 1030.2 1030.3 1035.8 1037.1 5042.5 5044.3 5065.9 5105.1 5173.9 8637.7 8869.3 8873.0 8882.1 8894.9 8582.8 8748.3 8749.5 8770.4 8779.6 6601.0 6625.6 6632.2 6685.6 6691.8 6448.4 6483.6 6521.7 6548.8 6574.4 7759.9 7811.5 7820.8 7835.3 7980.6 7932.7 7933.8 8080.7 8080.8 8089.3 5924.8 5941.6 5998.0 5998.8 6012.7 7001.2 7054.0 7056.2 7070.1 7073.4 6280.2 6391.7 6545.4 6604.5 6720.1 6299.8 6312.3 6352.3 6528.3 6610.5 6316.3 6356.9 6384.7 6405.4 6450.6 6072.7 6095.9 6108.0 6110.1 6122.8 6151.3 6172.3 6187.2 6192.9 6198.0 09:04:21 INFO - 2015-12-17 09:04:21,575 DEBUG : BROWSER_OUTPUT: 09:04:21 INFO - 2015-12-17 09:04:21,575 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4599.85 Median:5229.21 stddev:1358.18 (26.0%) stddev-sans-first:1323.13 09:04:21 INFO - 2015-12-17 09:04:21,576 DEBUG : BROWSER_OUTPUT: Values: 302.4 306.4 307.3 309.4 314.2 5145.2 5198.9 5253.5 5278.7 5389.6 5071.7 5200.8 5224.2 5227.8 5230.6 3862.4 4094.1 4106.3 4115.2 4116.2 3948.1 3994.7 4101.6 4103.9 4119.3 4048.7 4058.1 4062.2 4065.7 4072.2 4066.3 4066.4 4071.1 4073.8 4083.9 3540.0 3543.7 3577.4 3577.7 3583.9 4996.0 5052.9 5078.5 5103.9 5105.7 4626.9 4628.8 4631.0 4631.2 4640.6 5503.0 5503.0 5508.6 5518.5 5522.1 3641.3 3724.2 3825.8 3830.8 3832.8 5652.2 5768.4 5799.4 5800.0 5801.7 3950.0 3950.2 3957.5 3957.8 3959.9 4004.5 4008.9 4012.1 4012.8 4013.6 4474.7 4597.2 4599.4 4608.7 4608.9 5522.8 5530.6 5530.7 5541.1 5551.3 1407.5 1418.1 1420.3 1421.3 1422.8 954.4 970.7 976.7 982.4 989.9 4866.3 4866.4 4874.6 4881.0 4882.7 5735.3 5746.2 5748.3 5752.2 5754.1 4852.4 4871.0 4873.8 4879.0 4879.1 3001.5 3058.9 3083.7 3096.2 3111.8 5498.2 5503.9 5509.4 5517.7 5520.1 5970.0 5970.6 5979.3 5981.7 5988.6 5498.0 5504.3 5506.8 5508.4 5512.4 5668.3 5784.2 5793.6 5800.8 5812.3 5399.1 5657.0 5658.1 5667.8 5670.0 5358.6 5417.9 5493.9 5495.1 5509.2 3956.2 4009.0 4010.4 4010.9 4018.4 5755.3 5776.5 5777.2 5782.0 5782.1 5448.6 5562.0 5566.2 5590.7 5590.9 5522.1 5542.8 5564.3 5575.1 5579.5 5441.2 5451.5 5455.0 5462.0 5489.4 5479.0 5619.9 5620.0 5622.7 5628.2 5472.4 5483.3 5483.9 5485.3 5492.0 09:04:21 INFO - 2015-12-17 09:04:21,576 DEBUG : BROWSER_OUTPUT: 09:04:21 INFO - 2015-12-17 09:04:21,576 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11664.55 Median:514.37 stddev:13157.73 (2558.0%) stddev-sans-first:13168.48 09:04:21 INFO - 2015-12-17 09:04:21,578 DEBUG : BROWSER_OUTPUT: Values: 615.9 725.0 734.6 739.7 747.2 11186.6 11474.6 11499.7 11509.6 11511.7 10993.9 11006.6 11008.1 11013.7 11020.7 629.7 637.6 785.2 795.6 809.3 783.9 785.6 785.7 792.7 792.9 655.9 837.8 845.9 846.0 846.2 652.5 812.1 823.5 824.1 824.6 616.5 616.7 616.7 616.8 617.1 10754.1 10893.1 10938.4 10947.8 10950.5 10406.5 10908.9 11228.1 11429.5 11440.5 9370.1 9464.5 9477.3 9638.0 9668.2 3174.8 3206.5 3239.2 3257.9 3271.5 39645.2 39828.8 40260.2 40485.4 40540.0 8905.8 9034.1 9054.1 9193.7 9197.5 15542.8 15571.1 15637.2 15663.2 15689.8 6316.5 6328.2 6451.4 6458.9 6492.7 3627.0 3640.7 3653.1 3658.5 3732.4 2500.3 2507.2 2521.1 2531.0 2536.5 440.9 444.2 445.8 446.1 448.3 504.4 525.7 526.2 535.6 552.0 6595.9 7184.0 7269.3 7323.5 7512.7 524.3 539.7 549.7 553.8 572.6 3320.9 3351.6 3384.0 3389.7 3401.7 45438.0 45975.3 46367.3 46418.5 46537.8 42338.0 42456.0 43315.6 43498.3 43807.3 37022.8 38170.0 38959.2 38993.2 39207.0 7181.0 7219.6 7416.8 7513.8 7630.3 29364.0 29720.1 29815.0 30052.4 30220.0 36123.5 36784.3 37510.6 37649.0 37882.4 9178.9 9571.3 9608.6 9616.1 9713.7 10011.9 10108.4 10339.5 10582.9 11177.9 9532.6 9736.9 9790.0 9860.4 10066.2 9943.5 9952.5 10013.4 10150.1 10178.2 9812.7 9856.3 9926.5 9936.9 10013.2 8549.6 8848.6 8875.8 8957.2 9282.5 7611.4 7998.4 8054.6 8193.2 8331.6 09:04:21 INFO - 2015-12-17 09:04:21,578 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:04:21 INFO - 2015-12-17 09:04:21,578 DEBUG : BROWSER_OUTPUT: 09:04:22 INFO - 2015-12-17 09:04:22,269 INFO : Browser exited with error code: 0 09:04:22 INFO - 2015-12-17 09:04:22,290 INFO : Completed test dromaeo_css (00:18:37) 09:04:22 INFO - 2015-12-17 09:04:22,290 INFO : Starting test kraken 09:04:22 INFO - 2015-12-17 09:04:22,290 DEBUG : operating with platform_type : linux_ 09:04:22 INFO - 2015-12-17 09:04:22,291 INFO : Initialising browser for kraken test... 09:04:22 INFO - 2015-12-17 09:04:22,297 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprba8O1/profile http://localhost:45134/getInfo.html 09:04:26 INFO - 2015-12-17 09:04:26,572 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:04:26 INFO - 2015-12-17 09:04:26,572 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:04:26 INFO - 2015-12-17 09:04:26,572 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:04:26 INFO - 2015-12-17 09:04:26,572 DEBUG : BROWSER_OUTPUT: __metrics 09:04:26 INFO - 2015-12-17 09:04:26,714 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] 09:04:26 INFO - 2015-12-17 09:04:26,790 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] 09:04:27 INFO - 2015-12-17 09:04:27,967 INFO : Browser initialized. 09:04:27 INFO - 2015-12-17 09:04:27,968 INFO : Running cycle 1/1 for kraken test... 09:04:27 INFO - 2015-12-17 09:04:27,968 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprba8O1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:04:39 INFO - 2015-12-17 09:04:39,969 DEBUG : BROWSER_OUTPUT: RSS: Main: 150269952 09:04:39 INFO - 2015-12-17 09:04:39,970 DEBUG : BROWSER_OUTPUT: 09:04:42 INFO - 2015-12-17 09:04:42,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45134/tests/kraken/driver.html?testName=audio-beat-detection) 09:04:43 INFO - 2015-12-17 09:04:43,168 DEBUG : BROWSER_OUTPUT: RSS: Main: 187572224 09:04:43 INFO - 2015-12-17 09:04:43,168 DEBUG : BROWSER_OUTPUT: 09:04:45 INFO - 2015-12-17 09:04:45,872 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45134/tests/kraken/driver.html?testName=audio-dft) 09:04:46 INFO - 2015-12-17 09:04:46,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 177225728 09:04:46 INFO - 2015-12-17 09:04:46,452 DEBUG : BROWSER_OUTPUT: 09:04:49 INFO - 2015-12-17 09:04:49,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45134/tests/kraken/driver.html?testName=audio-fft) 09:04:50 INFO - 2015-12-17 09:04:50,003 DEBUG : BROWSER_OUTPUT: RSS: Main: 160014336 09:04:50 INFO - 2015-12-17 09:04:50,003 DEBUG : BROWSER_OUTPUT: 09:04:52 INFO - 2015-12-17 09:04:52,061 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45134/tests/kraken/driver.html?testName=audio-oscillator) 09:04:52 INFO - 2015-12-17 09:04:52,643 DEBUG : BROWSER_OUTPUT: RSS: Main: 163483648 09:04:52 INFO - 2015-12-17 09:04:52,643 DEBUG : BROWSER_OUTPUT: 09:04:54 INFO - 2015-12-17 09:04:54,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45134/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:04:55 INFO - 2015-12-17 09:04:55,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 166113280 09:04:55 INFO - 2015-12-17 09:04:55,458 DEBUG : BROWSER_OUTPUT: 09:04:58 INFO - 2015-12-17 09:04:58,436 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45134/tests/kraken/driver.html?testName=imaging-darkroom) 09:04:59 INFO - 2015-12-17 09:04:59,018 DEBUG : BROWSER_OUTPUT: RSS: Main: 164319232 09:04:59 INFO - 2015-12-17 09:04:59,018 DEBUG : BROWSER_OUTPUT: 09:05:02 INFO - 2015-12-17 09:05:02,439 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45134/tests/kraken/driver.html?testName=imaging-desaturate) 09:05:03 INFO - 2015-12-17 09:05:03,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 166526976 09:05:03 INFO - 2015-12-17 09:05:03,026 DEBUG : BROWSER_OUTPUT: 09:05:05 INFO - 2015-12-17 09:05:05,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45134/tests/kraken/driver.html?testName=json-parse-financial) 09:05:06 INFO - 2015-12-17 09:05:06,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 165068800 09:05:06 INFO - 2015-12-17 09:05:06,423 DEBUG : BROWSER_OUTPUT: 09:05:08 INFO - 2015-12-17 09:05:08,186 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45134/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:05:08 INFO - 2015-12-17 09:05:08,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 173838336 09:05:08 INFO - 2015-12-17 09:05:08,760 DEBUG : BROWSER_OUTPUT: 09:05:10 INFO - 2015-12-17 09:05:10,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45134/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:05:11 INFO - 2015-12-17 09:05:11,245 DEBUG : BROWSER_OUTPUT: RSS: Main: 172679168 09:05:11 INFO - 2015-12-17 09:05:11,245 DEBUG : BROWSER_OUTPUT: 09:05:13 INFO - 2015-12-17 09:05:13,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45134/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:05:13 INFO - 2015-12-17 09:05:13,926 DEBUG : BROWSER_OUTPUT: RSS: Main: 182202368 09:05:13 INFO - 2015-12-17 09:05:13,926 DEBUG : BROWSER_OUTPUT: 09:05:16 INFO - 2015-12-17 09:05:16,433 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45134/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:05:17 INFO - 2015-12-17 09:05:17,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 188268544 09:05:17 INFO - 2015-12-17 09:05:17,019 DEBUG : BROWSER_OUTPUT: 09:05:19 INFO - 2015-12-17 09:05:19,598 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45134/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:05:20 INFO - 2015-12-17 09:05:20,179 DEBUG : BROWSER_OUTPUT: RSS: Main: 185516032 09:05:20 INFO - 2015-12-17 09:05:20,179 DEBUG : BROWSER_OUTPUT: 09:05:21 INFO - 2015-12-17 09:05:21,908 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45134/tests/kraken/driver.html?testName=ai-astar) 09:05:22 INFO - 2015-12-17 09:05:22,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 244068352 09:05:22 INFO - 2015-12-17 09:05:22,158 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,160 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:05:22 INFO - 2015-12-17 09:05:22,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:05:22 INFO - 2015-12-17 09:05:22,160 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:05:22 INFO - 2015-12-17 09:05:22,160 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:05:22 INFO - 2015-12-17 09:05:22,160 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;108;114;116;114;103;112;112;118 09:05:22 INFO - 2015-12-17 09:05:22,160 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;129;156;164;133;162;151;130;166;129 09:05:22 INFO - 2015-12-17 09:05:22,160 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;160;160;162;159;162;162;161;160 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;86;91;73;71;72;91;100;72 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;133;93;94;94;132;94;93;129 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;110;109;109;109;109 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;146;146;146;146;146;146 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;95;95;96;95;95 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;72;70;71;70;71;80;68;68 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;67;68;69;69;68;69;69 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;84;84;82;84;82;84;84;83;84 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;128;120;120;127;119;119;117;119;127 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;149;148;148;147;134;148;146;144;136 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;68;69;70;68;71;70;70;71 09:05:22 INFO - 2015-12-17 09:05:22,161 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:05:22 INFO - 2015-12-17 09:05:22,162 DEBUG : BROWSER_OUTPUT: __start_cc_report 09:05:22 INFO - 2015-12-17 09:05:22,162 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1003 09:05:22 INFO - 2015-12-17 09:05:22,162 DEBUG : BROWSER_OUTPUT: __end_cc_report 09:05:22 INFO - 2015-12-17 09:05:22,162 DEBUG : BROWSER_OUTPUT: __startTimestamp1450371922158__endTimestamp 09:05:22 INFO - 2015-12-17 09:05:22,162 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,165 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:05:22 INFO - 2015-12-17 09:05:22,165 DEBUG : BROWSER_OUTPUT: Number of tests: 14 09:05:22 INFO - 2015-12-17 09:05:22,165 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,165 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:4.19 (3.7%) stddev-sans-first:4.43 09:05:22 INFO - 2015-12-17 09:05:22,165 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 108.0 114.0 116.0 114.0 103.0 112.0 112.0 118.0 09:05:22 INFO - 2015-12-17 09:05:22,165 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,165 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.70 Median:156.50 stddev:15.64 (10.0%) stddev-sans-first:16.22 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: Values: 157.0 129.0 156.0 164.0 133.0 162.0 151.0 130.0 166.0 129.0 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:1.06 (0.7%) stddev-sans-first:1.09 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 160.0 160.0 162.0 159.0 162.0 162.0 161.0 160.0 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:72.50 stddev:10.87 (15.0%) stddev-sans-first:11.14 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 86.0 91.0 73.0 71.0 72.0 91.0 100.0 72.0 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.00 Median:94.00 stddev:18.20 (19.4%) stddev-sans-first:18.87 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 133.0 93.0 94.0 94.0 132.0 94.0 93.0 129.0 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 09:05:22 INFO - 2015-12-17 09:05:22,166 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.30 Median:71.00 stddev:3.37 (4.7%) stddev-sans-first:3.56 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 70.0 71.0 70.0 71.0 80.0 68.0 68.0 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:0.79 (1.2%) stddev-sans-first:0.71 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 67.0 68.0 69.0 69.0 68.0 69.0 69.0 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:84.00 stddev:1.37 (1.6%) stddev-sans-first:0.88 09:05:22 INFO - 2015-12-17 09:05:22,167 DEBUG : BROWSER_OUTPUT: Values: 80.0 84.0 84.0 82.0 84.0 82.0 84.0 84.0 83.0 84.0 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.20 Median:123.00 stddev:4.24 (3.4%) stddev-sans-first:4.27 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: Values: 126.0 128.0 120.0 120.0 127.0 119.0 119.0 117.0 119.0 127.0 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.50 Median:147.50 stddev:6.04 (4.1%) stddev-sans-first:5.57 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: Values: 135.0 149.0 148.0 148.0 147.0 134.0 148.0 146.0 144.0 136.0 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.07 (1.5%) stddev-sans-first:1.13 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 68.0 69.0 70.0 68.0 71.0 70.0 70.0 71.0 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:05:22 INFO - 2015-12-17 09:05:22,168 DEBUG : BROWSER_OUTPUT: 09:05:23 INFO - 2015-12-17 09:05:23,041 INFO : Browser exited with error code: 0 09:05:23 INFO - 2015-12-17 09:05:23,097 INFO : Completed test kraken (00:01:00) 09:05:23 INFO - 2015-12-17 09:05:23,097 INFO : Starting test v8_7 09:05:23 INFO - 2015-12-17 09:05:23,097 DEBUG : operating with platform_type : linux_ 09:05:23 INFO - 2015-12-17 09:05:23,097 INFO : Initialising browser for v8_7 test... 09:05:23 INFO - 2015-12-17 09:05:23,104 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1NwGIj/profile http://localhost:45134/getInfo.html 09:05:27 INFO - 2015-12-17 09:05:27,522 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:05:27 INFO - 2015-12-17 09:05:27,522 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:05:27 INFO - 2015-12-17 09:05:27,522 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:05:27 INFO - 2015-12-17 09:05:27,522 DEBUG : BROWSER_OUTPUT: __metrics 09:05:27 INFO - 2015-12-17 09:05:27,618 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] 09:05:27 INFO - 2015-12-17 09:05:27,674 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:05:28 INFO - 2015-12-17 09:05:28,975 INFO : Browser initialized. 09:05:28 INFO - 2015-12-17 09:05:28,975 INFO : Running cycle 1/1 for v8_7 test... 09:05:28 INFO - 2015-12-17 09:05:28,975 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1NwGIj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:05:40 INFO - 2015-12-17 09:05:40,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 150208512 09:05:40 INFO - 2015-12-17 09:05:40,972 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45134/tests/v8_7/run.html (next: http://localhost:45134/tests/v8_7/run.html) 09:06:02 INFO - 2015-12-17 09:06:02,589 DEBUG : BROWSER_OUTPUT: RSS: Main: 456667136 09:06:02 INFO - 2015-12-17 09:06:02,589 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,590 DEBUG : BROWSER_OUTPUT: __start_tp_report 09:06:02 INFO - 2015-12-17 09:06:02,590 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 09:06:02 INFO - 2015-12-17 09:06:02,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 09:06:02 INFO - 2015-12-17 09:06:02,591 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 09:06:02 INFO - 2015-12-17 09:06:02,591 DEBUG : BROWSER_OUTPUT: |0;Richards;165.78249336870027 09:06:02 INFO - 2015-12-17 09:06:02,591 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.16077110237694 09:06:02 INFO - 2015-12-17 09:06:02,591 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.09572983533354 09:06:02 INFO - 2015-12-17 09:06:02,591 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5196.891191709845 09:06:02 INFO - 2015-12-17 09:06:02,591 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1956.9471624266146 09:06:02 INFO - 2015-12-17 09:06:02,592 DEBUG : BROWSER_OUTPUT: |5;Earley;796.1783439490446 09:06:02 INFO - 2015-12-17 09:06:02,592 DEBUG : BROWSER_OUTPUT: |6;Boyer;11976.190476190477 09:06:02 INFO - 2015-12-17 09:06:02,592 DEBUG : BROWSER_OUTPUT: |7;RegExp;27108.108108108107 09:06:02 INFO - 2015-12-17 09:06:02,592 DEBUG : BROWSER_OUTPUT: |8;Splay;611.2469437652812 09:06:02 INFO - 2015-12-17 09:06:02,592 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4826.923076923077 09:06:02 INFO - 2015-12-17 09:06:02,592 DEBUG : BROWSER_OUTPUT: __end_tp_report 09:06:02 INFO - 2015-12-17 09:06:02,592 DEBUG : BROWSER_OUTPUT: __startTimestamp1450371962590__endTimestamp 09:06:02 INFO - 2015-12-17 09:06:02,593 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,594 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 09:06:02 INFO - 2015-12-17 09:06:02,594 DEBUG : BROWSER_OUTPUT: Number of tests: 10 09:06:02 INFO - 2015-12-17 09:06:02,594 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,594 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.78 Median:165.78 stddev:0.00 (0.0%) 09:06:02 INFO - 2015-12-17 09:06:02,595 DEBUG : BROWSER_OUTPUT: Values: 165.8 09:06:02 INFO - 2015-12-17 09:06:02,595 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,595 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.16 Median:187.16 stddev:0.00 (0.0%) 09:06:02 INFO - 2015-12-17 09:06:02,595 DEBUG : BROWSER_OUTPUT: Values: 187.2 09:06:02 INFO - 2015-12-17 09:06:02,595 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,595 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 09:06:02 INFO - 2015-12-17 09:06:02,596 DEBUG : BROWSER_OUTPUT: Values: 279.1 09:06:02 INFO - 2015-12-17 09:06:02,596 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,596 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5196.89 Median:5196.89 stddev:0.00 (0.0%) 09:06:02 INFO - 2015-12-17 09:06:02,596 DEBUG : BROWSER_OUTPUT: Values: 5196.9 09:06:02 INFO - 2015-12-17 09:06:02,596 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,596 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1956.95 Median:1956.95 stddev:0.00 (0.0%) 09:06:02 INFO - 2015-12-17 09:06:02,597 DEBUG : BROWSER_OUTPUT: Values: 1956.9 09:06:02 INFO - 2015-12-17 09:06:02,597 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,597 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 09:06:02 INFO - 2015-12-17 09:06:02,597 DEBUG : BROWSER_OUTPUT: Values: 796.2 09:06:02 INFO - 2015-12-17 09:06:02,597 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,597 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11976.19 Median:11976.19 stddev:0.00 (0.0%) 09:06:02 INFO - 2015-12-17 09:06:02,597 DEBUG : BROWSER_OUTPUT: Values: 11976.2 09:06:02 INFO - 2015-12-17 09:06:02,598 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,598 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27108.11 Median:27108.11 stddev:0.00 (0.0%) 09:06:02 INFO - 2015-12-17 09:06:02,598 DEBUG : BROWSER_OUTPUT: Values: 27108.1 09:06:02 INFO - 2015-12-17 09:06:02,598 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,598 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.25 Median:611.25 stddev:0.00 (0.0%) 09:06:02 INFO - 2015-12-17 09:06:02,598 DEBUG : BROWSER_OUTPUT: Values: 611.2 09:06:02 INFO - 2015-12-17 09:06:02,598 DEBUG : BROWSER_OUTPUT: 09:06:02 INFO - 2015-12-17 09:06:02,599 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 09:06:02 INFO - 2015-12-17 09:06:02,599 DEBUG : BROWSER_OUTPUT: Values: 4826.9 09:06:02 INFO - 2015-12-17 09:06:02,599 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 09:06:02 INFO - 2015-12-17 09:06:02,599 DEBUG : BROWSER_OUTPUT: 09:06:03 INFO - 2015-12-17 09:06:03,469 INFO : Browser exited with error code: 0 09:06:03 INFO - 2015-12-17 09:06:03,488 INFO : Completed test v8_7 (00:00:40) 09:06:03 INFO - 2015-12-17 09:06:03,654 INFO : Completed test suite (00:20:19) 09:06:03 INFO - 2015-12-17 09:06:03,654 DEBUG : Working with test: dromaeo_css 09:06:03 INFO - 2015-12-17 09:06:03,654 DEBUG : Generating results file: dromaeo_css 09:06:03 INFO - 2015-12-17 09:06:03,655 DEBUG : Working with test: kraken 09:06:03 INFO - 2015-12-17 09:06:03,655 DEBUG : Generating results file: kraken 09:06:03 INFO - 2015-12-17 09:06:03,655 INFO : javascript benchmark 09:06:03 INFO - 2015-12-17 09:06:03,655 DEBUG : Working with test: v8_7 09:06:03 INFO - 2015-12-17 09:06:03,656 DEBUG : Generating results file: v8_7 09:06:03 INFO - 2015-12-17 09:06:03,656 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:06:03 INFO - 2015-12-17 09:06:03,716 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 09:06:03 INFO - 2015-12-17 09:06:03,716 DEBUG : process_Request line: dromaeo_css 6254.51 graph.html#tests=[[72,94,35]] 09:06:03 INFO - 2015-12-17 09:06:03,716 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:06:03 INFO - 2015-12-17 09:06:03,826 DEBUG : process_Request line: kraken 1514.50 graph.html#tests=[[232,94,35]] 09:06:03 INFO - 2015-12-17 09:06:03,826 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:06:03 INFO - 2015-12-17 09:06:03,962 DEBUG : process_Request line: v8_7 19802.45 graph.html#tests=[[230,94,35]] 09:06:03 INFO - 2015-12-17 09:06:03,963 INFO : javascript benchmark 09:06:04 INFO - 2015-12-17 09:06:03,967 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2630.1583493282146, 2705.3236690827293, 2707.4043710383735, 2715.823471474354, 2730.890764369425, 4542.636589072875, 4702.0, 4720.362751028611, 4749.667523273368, 4753.001869607382, 4609.539046095389, 4637.327587499811, 4728.574428301452, 4737.810487580493, 4753.144434001878, 4281.529031806499, 4327.610515053644, 4347.065380943097, 4403.691741578091, 4407.18467083589, 4341.327094300388, 4411.779411029452, 4437.423134992447, 4437.556244375569, 4484.148011877733, 4182.435371224907, 4282.614564689162, 4302.655787537021, 4391.4730232372, 4431.313146462304, 4270.359446083081, 4372.628326592244, 4387.14450682114, 4389.122175564899, 4417.602415782595, 4304.332828411601, 4329.783510824478, 4345.674074444398, 4349.064951035542, 4393.143337049277, 4468.039371535103, 4595.655325850575, 4644.6052085572765, 4671.392718946549, 4674.696144750615, 4892.363992680965, 4988.725620090893, 5005.399352077774, 5009.4239162496415, 5024.070546948826, 5033.496650334974, 5064.468230835746, 5066.214736715815, 5077.009983053306, 5121.334226550562, 4468.664850136252, 4576.130535198302, 4694.225452800318, 4697.4832768395445, 4700.2009658358165, 4967.130752118364, 5071.340725705709, 5077.238414237894, 5081.441041485434, 5109.131447653834, 4943.9258411123865, 4953.578945789648, 4954.256861470736, 4961.4294356148785, 5005.199168133081, 5080.237964305384, 5109.3613298337705, 5109.795608175631, 5110.412302585176, 5115.053715062725, 4720.433547974265, 4850.684705494132, 4854.053459575349, 4872.19608764557, 5011.423686276052, 4944.456109827916, 4962.5533701967, 4965.3048573199785, 4965.751712414365, 5009.599232061426, 4172.853950111731, 4181.163767246563, 4181.707280490336, 4185.079282557833, 4216.620504154641, 3513.7540372173703, 3582.9104272393397, 3646.3801153803915, 3647.0335361129323, 3685.8894233173046, 4338.652907767371, 4374.475062992461, 4381.824727010948, 4386.627136693353, 4395.604395604411, 5099.3370861787735, 5116.897662046738, 5118.334616499831, 5122.052420302256, 5159.974200128975, 4118.341065429577, 4232.894177645522, 4237.491501019897, 4240.427542281815, 4338.609525142752, 4421.7346959181905, 4446.822127114944, 4449.555044495524, 4449.844255451044, 4489.19194544985, 4775.5463230993, 4787.952120478751, 4791.760411979457, 4792.7124372537755, 4841.104395686809, 4785.880352991203, 4903.26451032348, 4909.631777616622, 4926.3842019747535, 5055.6713813602, 4709.0817290628, 4724.952750472451, 4733.077049975222, 4748.216544270295, 4787.61699064067, 4941.876453088557, 5000.274960130688, 5004.84985450437, 5012.523810238022, 5065.0, 4840.346553215411, 4902.509749025212, 4974.427940786856, 4977.502249774993, 5040.521150490697, 4844.588210002189, 4878.219484882402, 4880.827462149631, 4883.121038213156, 4915.754212289443, 4862.95137048625, 4868.975655121843, 4870.26945958095, 4872.342233798392, 4910.852674419773, 4585.839495617637, 4647.186742320148, 4671.486136524912, 4709.48195698466, 4794.113089078532, 4943.579795717261, 4949.430815456125, 4951.430585482572, 4952.479989601185, 4963.255511673278, 4820.68665536739, 4845.442774081026, 4849.160454260473, 4850.53919877611, 4875.7074575525585], "unit": "score", "name": "dojo.html", "value": 4599.8521010816}, {"lowerIsBetter": false, "replicates": [550.7026205848839, 560.9566206855249, 568.1818181818179, 579.8666306749448, 581.8894410062088, 27095.5935660965, 32530.67469325306, 33055.33889322215, 33155.17112072199, 33230.83384583073, 39033.0, 39484.21031579374, 39495.210095798066, 39629.60370396295, 39639.0, 7011.404030657401, 7154.67803948821, 7811.179826118261, 7960.203979602052, 8002.919970800276, 10003.149732272766, 10223.897761022406, 10304.536295866666, 10313.948430257838, 10324.483775811217, 9934.9503252484, 10077.193824494023, 10079.798404031915, 10079.949600251988, 10085.596576136946, 7221.927780722204, 7416.258374162595, 9829.803403931954, 9925.900740992605, 10066.899331006669, 9733.951330243373, 9892.060254275832, 9895.851562226573, 9907.207423406111, 9914.355566888129, 36710.816445917866, 37094.44358334627, 37172.32724527403, 37177.81411092927, 37253.81373093117, 2716.660417447819, 2835.9858200709073, 2964.125582953034, 3142.4814905540557, 3353.195233144052, 27940.720592794016, 28137.86800315916, 28143.718562814316, 28198.577021344696, 28794.136175914547, 2763.2937983064908, 2798.6361772969385, 2821.887124515017, 2852.957205641917, 2966.347403571211, 217300.0, 217780.0, 217838.0, 217871.0, 218185.0, 49647.0, 50883.0, 50965.49034509608, 52568.47431525636, 52852.47147528552, 60893.0, 61984.69007655023, 62280.68859655764, 62386.37613623896, 62440.68779656164, 12625.873741262654, 12805.487780488862, 12811.487540498461, 12823.61529154127, 12827.935860320638, 8544.231019208177, 8549.529775862387, 8553.059163492011, 8575.528345940907, 8575.614097365633, 17219.569510762332, 17393.65212695739, 17607.823921760875, 17638.735418968725, 17719.0, 6976.162860456778, 7136.857262854817, 7158.2483839197175, 7200.279972002862, 7201.747938822116, 866.3372520022189, 944.5135755086136, 1044.8746150461993, 1055.37205362809, 1059.6820953713855, 25718.760599349618, 26163.0, 26172.607410888853, 26184.476310473685, 26403.20790376292, 949.6486300069018, 988.7972965542046, 1012.5797793915442, 1042.9113525350278, 1119.8936101070385, 13452.461901524026, 13736.725265494633, 13788.103773254907, 13849.584512464642, 13884.58346249614, 263157.0, 266051.0, 266587.0, 268131.0, 269122.0, 44935.55064449314, 45112.0, 45122.77438612851, 45168.77415612901, 45208.0, 1117.3686866920164, 1172.8240763885485, 1180.9173357865038, 1181.509673485494, 1303.791393377055, 23257.534849303258, 23418.531629366975, 23825.880870595534, 23958.88020559956, 24022.51954960926, 29970.550441743828, 30198.54702179513, 30261.546076809307, 30293.242668933453, 30324.84837575798, 219855.0, 224525.0, 336944.0, 347899.0, 348149.0, 26535.60196597014, 26596.86701566557, 26654.0, 26688.599671004562, 26701.732982669924, 35335.46996794999, 35578.8221058893, 35817.0, 36600.81699591485, 36700.0, 30242.114671180134, 30683.386332272785, 30721.38557228798, 31179.0, 31487.52768708517, 30977.380452391277, 31212.687873121886, 31267.53098703567, 31279.0, 31341.216469588442, 30972.380552389277, 32876.1780955478, 33365.16587085342, 33487.0, 33524.83237583894, 24751.25746227616, 28882.855585721936, 29863.0, 29956.550651740676, 29957.251068723457, 20723.4819129523, 21941.67087493721, 22814.885925570266, 23221.535569288182, 23745.931433085898], "unit": "score", "name": "ext.html", "value": 16632.62734451809}, {"lowerIsBetter": false, "replicates": [314.5674697291225, 322.3150804540352, 323.7749763914081, 331.97585448890175, 333.4548013997114, 13061.60815175544, 13601.251931143783, 14621.415143394264, 15419.922900385496, 15577.376904923789, 11803.350815705133, 14657.0, 15473.0, 15965.760513592306, 15983.280752366143, 4935.0, 4964.205727083668, 5089.949100509003, 5114.846554603349, 5120.820771273006, 3808.9809550952205, 3923.8822835314986, 5080.847574572768, 5120.436751957282, 5836.649801011953, 5989.221401217836, 6029.276486821587, 6047.395260473962, 6047.637141771485, 6048.366940925947, 5789.131630255453, 5819.330776960662, 5915.497182739451, 5933.258342707161, 6008.0, 5167.173252279617, 5186.611004174702, 5187.247849061902, 5189.922151167735, 5196.6881987080515, 19360.612787744307, 19655.213791448325, 19919.800801992085, 19923.103460344173, 19986.80013199864, 1882.275324000256, 1945.367755479475, 1959.206521358852, 1989.0, 2012.939611811648, 12681.682957926034, 12739.87260127396, 12801.93599031999, 12914.354282285942, 13156.605301840864, 1819.1540933466001, 1820.3719716697717, 1844.6956252218367, 1861.8696691231619, 1872.1481725814858, 53965.0, 54748.45251547473, 54860.17709734397, 54977.72511137419, 55392.446075539134, 9255.213306868991, 9330.160285574195, 9398.718038458857, 9431.481268530297, 9478.440820978436, 12154.453049612788, 12157.209781364183, 12173.756524869454, 12198.32909190003, 12203.328816914978, 6835.316468353125, 6835.897461538081, 6901.171859376806, 7010.509264351446, 7067.081279433641, 6699.598024118569, 6724.226713927961, 6775.288594697585, 6784.694688739019, 6788.355106264897, 5574.275344205227, 5647.37878833328, 5703.600747947687, 5718.199452076713, 5874.882502349929, 1528.5490780219639, 1621.8459246371576, 1623.3506597360913, 1626.4795265514922, 1653.3221379234456, 794.7258195922398, 847.9618417171242, 963.9228861691188, 969.7187815533416, 1026.7946410717886, 14208.85791142096, 14232.43070277198, 15405.0, 17002.89481183744, 17103.23035463407, 747.4095464583028, 765.9770206893802, 822.2394285286086, 863.5811631358786, 893.5666201892077, 5943.3462319144855, 8726.694565690297, 8745.912540874637, 8757.605907734167, 8948.926128864578, 463951.0, 465652.0, 482454.0, 482550.0, 483373.0, 63621.363786361544, 70711.64644176849, 73035.6348218266, 73249.0, 74450.62774686092, 974.2498276327331, 1002.5137808163036, 1004.7136566078779, 1005.1857995024054, 1039.73486760877, 13371.799423008857, 13957.58127256184, 14260.0, 14404.711905762035, 15377.38490460369, 32128.19679508031, 32180.19549511281, 32321.676783231866, 33631.83184084064, 33978.15054623654, 38362.23275534529, 39942.2011559773, 40585.0, 40890.38664419977, 42303.576964229964, 8762.0, 8970.865437018581, 9406.43561386319, 9406.576704048472, 9428.340016198801, 16100.67798643997, 16317.265723042728, 16338.101404422396, 16423.0, 16734.163291835604, 13475.99451303155, 13491.05562610647, 13620.387082581507, 14133.293335333397, 14154.0, 13452.394642240926, 13455.192688438334, 13661.86338136606, 13696.383662735001, 13720.65698357549, 13635.727285454434, 13686.657833553843, 13742.65643358884, 14047.508337208557, 14173.36219870129, 6865.244823069558, 7614.428917831296, 7622.847543049219, 7757.224277572198, 9103.99856015851, 12973.09188356806, 13080.672983175496, 13427.12723672958, 13520.59438216855, 13524.459021639417], "unit": "score", "name": "jquery.html", "value": 8405.434644253944}, {"lowerIsBetter": false, "replicates": [1222.517105743232, 1587.2381256996641, 1682.991585042075, 1696.3214714114354, 1736.0712019069792, 6019.428154325337, 7021.68402421891, 7185.425165986721, 7204.675789589468, 7218.458615603825, 7219.0976127984, 7343.155537113234, 7352.375048120903, 7360.705571777123, 7393.889091663616, 1734.6617409605133, 1760.1903124562716, 1761.3130878957218, 2066.638338290797, 2115.6720708290163, 1744.485376813843, 1752.4392194497702, 2036.4297996560913, 2044.1721102953327, 2069.379186244121, 2021.4036859126593, 2029.03620780129, 2033.5526184239443, 2036.419620408184, 2037.5415531505441, 2017.4149496645955, 2097.7063211150453, 2097.8216851567636, 2098.7376577927757, 2100.516881117344, 2059.680749483832, 2071.8135367816817, 2085.509905172283, 2114.534802343482, 2115.3548167808813, 7119.430445564342, 7162.749303774395, 7224.096987876515, 7231.783046508614, 7242.0, 4105.384192371138, 4168.458100446923, 4181.351890456984, 4210.578942105795, 4212.662986961036, 2583.6899572051284, 2622.5148347555573, 2656.8405895646324, 2660.3216179874203, 2687.7984151188543, 885.1812073831744, 887.4054383562964, 901.7204666553324, 906.8367693815111, 917.7980844214329, 9780.755481112958, 9795.265355098396, 9796.216302695839, 9797.06927841861, 9839.852402213972, 3798.582155962842, 3849.1147036181833, 3862.8454861805776, 3916.373380259145, 3917.588653191374, 8404.369672274604, 8431.831363372698, 8454.577271136419, 8458.703945362005, 8469.449485783405, 4243.766592837424, 4246.087091275391, 4248.723832950848, 4251.426057482262, 4256.2551553478015, 3866.8066596670055, 3874.380099184117, 3888.241792850367, 3888.8250028748776, 3889.2221555688975, 3493.0, 3503.8948831535095, 3514.8242587870504, 3517.613062563116, 3527.1182204448887, 923.5243849417556, 927.7448701606977, 1073.6564299424265, 1077.9892201078046, 1101.1851230089676, 888.7333799860016, 905.4250550900094, 907.587047893207, 908.3777612335572, 1188.8038473651923, 6669.833254168588, 6757.358050985148, 6766.458683305422, 6766.661666916634, 6768.357006084414, 1016.4714348538719, 1030.1964467715045, 1030.2891005206384, 1035.8135535603665, 1037.0873631204643, 5042.4705405931845, 5044.268581055726, 5065.898682026339, 5105.132127538253, 5173.870653233699, 8637.654493820302, 8869.334799889904, 8873.0, 8882.06738292483, 8894.86657700135, 8582.837323897904, 8748.300135989106, 8749.47503149813, 8770.38607297483, 8779.604917778715, 6601.0, 6625.635590042594, 6632.1709786276715, 6685.598864068172, 6691.799246022627, 6448.387403196689, 6483.578567393104, 6521.706523206372, 6548.770793022412, 6574.4411725002, 7759.883601746092, 7811.5313081213035, 7820.84358312842, 7835.294823465915, 7980.561069141021, 7932.722354717557, 7933.761987140395, 8080.676772929252, 8080.797980050545, 8089.312408445348, 5924.763009479572, 5941.58408911372, 5997.970010149921, 5998.820035398945, 6012.729427175875, 7001.194862590663, 7053.964730176316, 7056.188538317954, 7070.080889484334, 7073.434125270069, 6280.152179455715, 6391.712372943136, 6545.378189072221, 6604.5046621502615, 6720.092787473824, 6299.779507717208, 6312.337204593635, 6352.333005034589, 6528.281888992302, 6610.4711623071, 6316.305206427382, 6356.9046464304, 6384.680765961776, 6405.391487808651, 6450.612963222222, 6072.726727297194, 6095.939040609537, 6108.02271636536, 6110.114033465034, 6122.846928826815, 6151.292601350902, 6172.290186628596, 6187.226596675416, 6192.938070619236, 6197.96901015492], "unit": "score", "name": "mootools.html", "value": 4091.041212775749}, {"lowerIsBetter": false, "replicates": [302.37408564271954, 306.35970820984164, 307.32542070156, 309.40748466686296, 314.236405534551, 5145.202493613487, 5198.896022079556, 5253.500917412849, 5278.736063196844, 5389.5688344932405, 5071.695698258107, 5200.817971371002, 5224.1902505111675, 5227.79088836446, 5230.633855630107, 3862.401327794182, 4094.0992981544014, 4106.342985122388, 4115.218108559379, 4116.156187981456, 3948.05246740783, 3994.720369574131, 4101.58984101589, 4103.9384409233735, 4119.299719047769, 4048.6761059115347, 4058.0666446717273, 4062.2281766464275, 4065.695072869532, 4072.1855628874346, 4066.3087275162998, 4066.3900414937702, 4071.124708187739, 4073.816678249486, 4083.8570650027405, 3539.982300088509, 3543.698785603227, 3577.4276115821604, 3577.6601222883783, 3583.87456439026, 4995.9500404996215, 5052.873678158038, 5078.4921507849285, 5103.948960510422, 5105.719185444799, 4626.9074618507775, 4628.791704373311, 4631.0, 4631.235846085426, 4640.628749700016, 5503.0, 5503.0, 5508.55931525477, 5518.530924871391, 5522.116461366162, 3641.308151451216, 3724.16206353571, 3825.827837747308, 3830.7510011849417, 3832.8466861325514, 5652.236948012048, 5768.423157684198, 5799.3910639382675, 5800.0, 5801.7099145043, 3949.960500395017, 3950.20995800841, 3957.5448823385104, 3957.821898014596, 3959.920801583952, 4004.4593979812353, 4008.8797336079965, 4012.1373904610064, 4012.839486420569, 4013.5585085640555, 4474.709143905636, 4597.218472859622, 4599.448066232074, 4608.746518941491, 4608.861734147981, 5522.751476183581, 5530.6128570999645, 5530.723463826793, 5541.085720856014, 5551.306086739158, 1407.5003373802153, 1418.0711633879826, 1420.3324437514352, 1421.3390773290469, 1422.8150340455675, 954.4368822394681, 970.737900766789, 976.6630512473185, 982.4252812104999, 989.9059589339001, 4866.270059491105, 4866.391701037371, 4874.634402419832, 4880.951190488121, 4882.731449770296, 5735.311762588516, 5746.195532625436, 5748.338941021752, 5752.194692743019, 5754.108113242454, 4852.369192005017, 4870.975645121752, 4873.756312184377, 4879.048585525788, 4879.1461494238365, 3001.4897467430587, 3058.938821223563, 3083.6762139975426, 3096.1949893027527, 3111.8132912025353, 5498.1752737088955, 5503.862403439866, 5509.393966663663, 5517.668939863621, 5520.089185284383, 5970.0, 5970.552208584373, 5979.282486101695, 5981.730822113015, 5988.550858685616, 5497.972510137423, 5504.311961004874, 5506.834794956158, 5508.421615730291, 5512.39363669996, 5668.348139963957, 5784.248047753765, 5793.623414478046, 5800.767969281182, 5812.3025236971835, 5399.136138217867, 5657.0, 5658.094704847204, 5667.789562070713, 5669.971650141723, 5358.598105142208, 5417.918731219113, 5493.917591236055, 5495.148252020943, 5509.173623956439, 3956.169204467094, 4009.0, 4010.438538604539, 4010.9197816042933, 4018.3570628699267, 5755.309362876482, 5776.480116789509, 5777.24895763548, 5782.005208203163, 5782.074868021096, 5448.645838020516, 5561.972190139185, 5566.248556444828, 5590.664560126405, 5590.909772594305, 5522.144067669517, 5542.8337149885565, 5564.304461942257, 5575.0522411191005, 5579.46995035471, 5441.238226648194, 5451.509364157245, 5455.0, 5461.962227176824, 5489.368722596792, 5479.0, 5619.943800561942, 5619.971900140473, 5622.690752008679, 5628.155776633538, 5472.425395333433, 5483.314585676791, 5483.890322193454, 5485.341758988947, 5491.972540137273], "unit": "score", "name": "prototype.html", "value": 4166.214965274736}, {"lowerIsBetter": false, "replicates": [615.9384061593838, 724.9528780629258, 734.6326836581705, 739.7299985505289, 747.2415498269254, 11186.552537898484, 11474.598389056384, 11499.655010349692, 11509.597164099257, 11511.654650360482, 10993.890061099386, 11006.559737610505, 11008.119350451965, 11013.724656883582, 11020.669379918596, 629.6757170057401, 637.6046850952392, 785.1638005524113, 795.645937557787, 809.2797410304804, 783.902012248469, 785.5836406704427, 785.7485604606528, 792.6591565626778, 792.9365650747926, 655.8950567909136, 837.798928257217, 845.898492180936, 845.9703910363138, 846.1749793950879, 652.4682383857165, 812.1269635142246, 823.4812068396932, 824.1099612418603, 824.6412810427423, 616.4698359410903, 616.6608365399057, 616.7255571270787, 616.8457885528618, 617.1421723803916, 10754.139668826476, 10893.128549716004, 10938.398388088652, 10947.781044379148, 10950.452477376179, 10406.531706073169, 10908.890911090866, 11228.101751859913, 11429.485673144729, 11440.542378304857, 9370.10983956523, 9464.479453630047, 9477.336586438953, 9638.036196380306, 9668.178204852597, 3174.8095114293214, 3206.5350524174096, 3239.2063944333554, 3257.853396597135, 3271.525628783837, 39645.20709585792, 39828.800855995534, 40260.19479610421, 40485.39271910924, 40540.0, 8905.821883562423, 9034.147999660054, 9054.123161098512, 9193.678221262357, 9197.494137822485, 15542.84457155414, 15571.143587102819, 15637.218139093, 15663.216839158224, 15689.764653530206, 6316.494680425555, 6328.208973878265, 6451.357084795503, 6458.903116453257, 6492.740290388331, 3627.0, 3640.6541378568995, 3653.104989277644, 3658.5243918290453, 3732.3654978653694, 2500.2874180858366, 2507.2352932355807, 2521.0924067335745, 2530.962035569468, 2536.4927014597156, 440.94929083155205, 444.1538868455533, 445.7615175880888, 446.1478575920042, 448.28498544820957, 504.412359601068, 525.6530689744826, 526.210683974039, 535.606329347929, 551.9944800551943, 6595.934040659628, 7183.96408017967, 7269.273072692688, 7323.523970941872, 7512.737054203077, 524.3210042994256, 539.6681041159659, 549.7059073395794, 553.7646500237383, 572.5963195946847, 3320.900372988814, 3351.614564325085, 3383.9661603384143, 3389.7288216942584, 3401.6598340165783, 45438.0, 45975.31037034447, 46367.30449043267, 46418.5358146421, 46537.767311163225, 42338.0, 42456.0, 43315.566844331785, 43498.347524787154, 43807.34288985668, 37022.8148859254, 38170.04574885595, 38959.22081558353, 38993.220135597694, 39207.0, 7180.964095179491, 7219.566825990458, 7416.814579635552, 7513.774586762406, 7630.313271805564, 29364.0, 29720.10839674813, 29815.0, 30052.3989520204, 30220.0, 36123.458148128324, 36784.26431471409, 37510.62489375071, 37649.0, 37882.43176352412, 9178.908210918073, 9571.33000689945, 9608.567614457506, 9616.08647178517, 9713.70858874235, 10011.949940250252, 10108.39349639024, 10339.534720937727, 10582.947085264525, 11177.944110279397, 9532.571034303612, 9736.853947190657, 9789.951050244703, 9860.408375497493, 10066.245031622511, 9943.453110079015, 9952.502374881082, 10013.449260290754, 10150.13723833453, 10178.236632252463, 9812.705618831447, 9856.260780441638, 9926.454045027593, 9936.850947235653, 10013.24900632441, 8549.572521373782, 8848.646054157762, 8875.822483550164, 8957.193852553302, 9282.535873206178, 7611.4291428142005, 7998.360131189607, 8054.5569993650915, 8193.180681931759, 8331.583420829056], "unit": "score", "name": "yui.html", "value": 5461.054768845032}], "name": "dromaeo_css", "value": 6254.516478233512}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 108.0, 114.0, 116.0, 114.0, 103.0, 112.0, 112.0, 118.0], "unit": "score", "name": "ai-astar", "value": 112.0}, {"lowerIsBetter": true, "replicates": [157.0, 129.0, 156.0, 164.0, 133.0, 162.0, 151.0, 130.0, 166.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 147.7}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 160.0, 160.0, 162.0, 159.0, 162.0, 162.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 86.0, 91.0, 73.0, 71.0, 72.0, 91.0, 100.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 133.0, 93.0, 94.0, 94.0, 132.0, 94.0, 93.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 105.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 70.0, 71.0, 70.0, 71.0, 80.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [80.0, 84.0, 84.0, 82.0, 84.0, 82.0, 84.0, 84.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.1}, {"lowerIsBetter": true, "replicates": [126.0, 128.0, 120.0, 120.0, 127.0, 119.0, 119.0, 117.0, 119.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.2}, {"lowerIsBetter": true, "replicates": [135.0, 149.0, 148.0, 148.0, 147.0, 134.0, 148.0, 146.0, 144.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.5}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 69.0, 70.0, 68.0, 71.0, 70.0, 70.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.6}], "name": "kraken", "value": 1514.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.78249336870027], "unit": "score", "name": "Richards", "value": 212.94166399999992}, {"lowerIsBetter": false, "replicates": [187.16077110237694], "unit": "score", "name": "DeltaBlue", "value": 353.2684740000001}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5196.891191709845], "unit": "score", "name": "Decrypt", "value": 51.219275174476564}, {"lowerIsBetter": false, "replicates": [1956.9471624266146], "unit": "score", "name": "RayTrace", "value": 378.13437900000014}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [11976.190476190477], "unit": "score", "name": "Boyer", "value": 55.648998011928406}, {"lowerIsBetter": false, "replicates": [27108.108108108107], "unit": "score", "name": "RegExp", "value": 33.60562811565303}, {"lowerIsBetter": false, "replicates": [611.2469437652812], "unit": "score", "name": "Splay", "value": 133.31927600000003}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19802.45365497979}]} 09:06:04 INFO - RETURN: dromaeo_css: 6254.51 09:06:04 INFO - RETURN: kraken: 1514.50 09:06:04 INFO - RETURN: v8_7: 19802.45 09:06:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19802.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1514.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6254.51"}}} 09:06:04 INFO - Return code: 0 09:06:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:06:04 INFO - # TBPL SUCCESS # 09:06:04 INFO - Running post-action listener: _resource_record_post_action 09:06:04 INFO - Running post-run listener: _resource_record_post_run 09:06:05 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 543805440; Read time: 0; Write time: 684168 09:06:05 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 227364864; Read time: 0; Write time: 371304 09:06:05 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 316440576; Read time: 0; Write time: 312864 09:06:05 INFO - Running post-run listener: _upload_blobber_files 09:06:05 INFO - Blob upload gear active. 09:06:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 09:06:05 INFO - Copying logs to upload dir... 09:06:05 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.409565 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-17 09:06:04.737579) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 09:06:04.742466) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010138 build_url: 'https://queue.taskcluster.net/v1/task/GYPWd6pbSlChOmtEtjqrEQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 09:06:04.767419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:06:04.767812) ========= 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=447a3abc0420b6a47dd38cba000001bf-1450370314.182087-711390112 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004409 ========= master_lag: 0.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 09:06:05.160305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 09:06:05.160648) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 09:06:05.161053) ========= ========= Total master_lag: 0.61 =========