builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-032 starttime: 1450425753.26 results: success (0) buildid: 20151217233052 builduid: dad6384802e04593976e546726bef6eb revision: b40ae4501f6a9a4859de78b6bd962fa2a5188607 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.263801) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.264380) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.265104) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006448 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.304370) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.304731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.366625) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.367000) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.416370) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.416711) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.417109) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.417444) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 00:02:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2015-12-18 00:02:33 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.544372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.544734) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014761 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:33.594215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 00:02:33.594597) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev b40ae4501f6a9a4859de78b6bd962fa2a5188607 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev b40ae4501f6a9a4859de78b6bd962fa2a5188607 --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=2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 00:02:34,035 truncating revision to first 12 chars 2015-12-18 00:02:34,035 Setting DEBUG logging. 2015-12-18 00:02:34,035 attempt 1/10 2015-12-18 00:02:34,035 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/b40ae4501f6a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 00:02:35,458 unpacking tar archive at: b2g-inbound-b40ae4501f6a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.684500 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-18 00:02:35.298088) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:35.298485) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:35.309376) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:35.309683) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 00:02:35.310133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-18 00:02:35.310498) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-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', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:02:35 INFO - MultiFileLogger online at 20151218 00:02:35 in /builds/slave/test 00:02:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 00:02:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:02:35 INFO - {'append_to_log': False, 00:02:35 INFO - 'base_work_dir': '/builds/slave/test', 00:02:35 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 00:02:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:02:35 INFO - 'branch': 'B2G-Inbound-Non-PGO', 00:02:35 INFO - 'buildbot_json_path': 'buildprops.json', 00:02:35 INFO - 'config_files': ('talos/linux_config.py',), 00:02:35 INFO - 'default_actions': ('clobber', 00:02:35 INFO - 'read-buildbot-config', 00:02:35 INFO - 'download-and-extract', 00:02:35 INFO - 'populate-webroot', 00:02:35 INFO - 'create-virtualenv', 00:02:35 INFO - 'install', 00:02:35 INFO - 'run-tests'), 00:02:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:02:35 INFO - 'download_minidump_stackwalk': True, 00:02:35 INFO - 'download_symbols': 'ondemand', 00:02:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:02:35 INFO - 'tooltool.py': '/tools/tooltool.py', 00:02:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:02:35 INFO - '/tools/misc-python/virtualenv.py')}, 00:02:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:02:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:02:35 INFO - 'installer_path': 'installer.exe', 00:02:35 INFO - 'log_level': 'info', 00:02:35 INFO - 'log_name': 'talos', 00:02:35 INFO - 'log_to_console': True, 00:02:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:02:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:02:35 INFO - 'opt_config_files': (), 00:02:35 INFO - 'pip_index': False, 00:02:35 INFO - 'sps_profile': False, 00:02:35 INFO - 'sps_profile_interval': 0, 00:02:35 INFO - 'suite': 'dromaeojs', 00:02:35 INFO - 'system_bits': '64', 00:02:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:02:35 INFO - 'title': 'talos-linux64-ix-032', 00:02:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:02:35 INFO - 'use_talos_json': True, 00:02:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:02:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:02:35 INFO - 'work_dir': 'build'} 00:02:35 INFO - ##### 00:02:35 INFO - ##### Running clobber step. 00:02:35 INFO - ##### 00:02:35 INFO - Running pre-action listener: _resource_record_pre_action 00:02:35 INFO - Running main action method: clobber 00:02:35 INFO - rmtree: /builds/slave/test/build 00:02:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:02:36 INFO - Running post-action listener: _resource_record_post_action 00:02:36 INFO - ##### 00:02:36 INFO - ##### Running read-buildbot-config step. 00:02:36 INFO - ##### 00:02:36 INFO - Running pre-action listener: _resource_record_pre_action 00:02:36 INFO - Running main action method: read_buildbot_config 00:02:36 INFO - Using buildbot properties: 00:02:36 INFO - { 00:02:36 INFO - "project": "", 00:02:36 INFO - "product": "firefox", 00:02:36 INFO - "script_repo_revision": "production", 00:02:36 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 00:02:36 INFO - "repository": "", 00:02:36 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 00:02:36 INFO - "buildid": "20151217233052", 00:02:36 INFO - "pgo_build": "False", 00:02:36 INFO - "basedir": "/builds/slave/test", 00:02:36 INFO - "buildnumber": 310, 00:02:36 INFO - "slavename": "talos-linux64-ix-032", 00:02:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:02:36 INFO - "platform": "ubuntu64_hw", 00:02:36 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 00:02:36 INFO - "branch": "b2g-inbound", 00:02:36 INFO - "repo_path": "integration/b2g-inbound", 00:02:36 INFO - "revision": "b40ae4501f6a9a4859de78b6bd962fa2a5188607", 00:02:36 INFO - "stage_platform": "linux64", 00:02:36 INFO - "builduid": "dad6384802e04593976e546726bef6eb", 00:02:36 INFO - "slavebuilddir": "test" 00:02:36 INFO - } 00:02:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 00:02:36 INFO - Running post-action listener: _resource_record_post_action 00:02:36 INFO - ##### 00:02:36 INFO - ##### Running download-and-extract step. 00:02:36 INFO - ##### 00:02:36 INFO - Running pre-action listener: _resource_record_pre_action 00:02:36 INFO - Running main action method: download_and_extract 00:02:36 INFO - mkdir: /builds/slave/test/build/tests 00:02:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:02:36 INFO - https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:02:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/test_packages.json 00:02:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/test_packages.json 00:02:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:02:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:02:37 INFO - Downloaded 1302 bytes. 00:02:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:02:37 INFO - Using the following test package requirements: 00:02:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:02:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:02:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:37 INFO - u'jsshell-linux-x86_64.zip'], 00:02:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:02:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:02:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:02:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:02:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:02:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 00:02:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 00:02:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:02:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:02:37 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')]} 00:02:37 INFO - https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:02:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:02:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:02:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/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 00:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/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 00:02:42 INFO - Downloaded 21871027 bytes. 00:02:42 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 00:02:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:02:42 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 00:02:43 INFO - Return code: 0 00:02:43 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 00:02: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')]} 00:02:43 INFO - https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:02:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:02:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:02:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/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 00:02:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/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 00:02:45 INFO - Downloaded 21871027 bytes. 00:02:45 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 00:02:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 00:02:45 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 00:02:46 INFO - Return code: 0 00:02:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:02:46 INFO - https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:02:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:02:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:02:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/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 00:02:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/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 00:02:47 INFO - Downloaded 11132039 bytes. 00:02:47 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 00:02:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 00:02:47 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 00:02:47 INFO - Return code: 0 00:02:47 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')]} 00:02:47 INFO - https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:02:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:02:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:02:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/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 00:02:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/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 00:02:49 INFO - Downloaded 53018859 bytes. 00:02:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:02:49 INFO - mkdir: /builds/slave/test/properties 00:02:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:02:49 INFO - Writing to file /builds/slave/test/properties/build_url 00:02:49 INFO - Contents: 00:02:49 INFO - build_url:https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 00:02:49 INFO - Running post-action listener: _resource_record_post_action 00:02:49 INFO - Running post-action listener: set_extra_try_arguments 00:02:49 INFO - ##### 00:02:49 INFO - ##### Running populate-webroot step. 00:02:49 INFO - ##### 00:02:49 INFO - Running pre-action listener: _resource_record_pre_action 00:02:49 INFO - Running main action method: populate_webroot 00:02:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:02:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:02:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:02:49 INFO - '--tppagecycles', 00:02:49 INFO - '7'], 00:02:49 INFO - 'tests': ['tsvgm']}}, 00:02:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:02:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:02:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:02:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:02:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:02:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:02:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:02:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:49 INFO - 'talos_options': ['--e10s'], 00:02:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:02:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:49 INFO - 'tests': ['damp', 'tps']}, 00:02:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:49 INFO - 'talos_options': ['--e10s'], 00:02:49 INFO - 'tests': ['damp', 'tps']}, 00:02:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:02:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:02:49 INFO - 'other': {'tests': ['a11yr', 00:02:49 INFO - 'ts_paint', 00:02:49 INFO - 'tpaint', 00:02:49 INFO - 'sessionrestore', 00:02:49 INFO - 'sessionrestore_no_auto_restore']}, 00:02:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:02:49 INFO - 'tests': ['a11yr', 00:02:49 INFO - 'ts_paint', 00:02:49 INFO - 'tpaint', 00:02:49 INFO - 'sessionrestore', 00:02:49 INFO - 'sessionrestore_no_auto_restore']}, 00:02:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:02:49 INFO - 'tests': ['a11yr', 00:02:49 INFO - 'ts_paint', 00:02:49 INFO - 'tpaint', 00:02:49 INFO - 'sessionrestore', 00:02:49 INFO - 'sessionrestore_no_auto_restore']}, 00:02:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:02:49 INFO - 'tests': ['a11yr', 00:02:49 INFO - 'ts_paint', 00:02:49 INFO - 'tpaint', 00:02:49 INFO - 'sessionrestore', 00:02:49 INFO - 'sessionrestore_no_auto_restore']}, 00:02:49 INFO - 'other_l64': {'tests': ['a11yr', 00:02:49 INFO - 'ts_paint', 00:02:49 INFO - 'tpaint', 00:02:49 INFO - 'sessionrestore', 00:02:49 INFO - 'sessionrestore_no_auto_restore']}, 00:02:49 INFO - 'other_nol64': {'tests': ['a11yr', 00:02:49 INFO - 'ts_paint', 00:02:49 INFO - 'tpaint', 00:02:49 INFO - 'sessionrestore', 00:02:49 INFO - 'sessionrestore_no_auto_restore']}, 00:02:49 INFO - 'svgr': {'tests': ['tsvgx', 00:02:49 INFO - 'tsvgr_opacity', 00:02:49 INFO - 'tart', 00:02:49 INFO - 'tscrollx', 00:02:49 INFO - 'cart']}, 00:02:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:02:49 INFO - 'tests': ['tsvgx', 00:02:49 INFO - 'tsvgr_opacity', 00:02:49 INFO - 'tart', 00:02:49 INFO - 'tscrollx', 00:02:49 INFO - 'cart']}, 00:02:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:49 INFO - 'tests': ['tp5o']}, 00:02:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:49 INFO - 'talos_options': ['--e10s'], 00:02:49 INFO - 'tests': ['tp5o']}, 00:02:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:49 INFO - 'talos_options': ['--xperf_path', 00:02:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:02:49 INFO - 'tests': ['tp5n']}, 00:02:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:02:49 INFO - 'talos_options': ['--e10s', 00:02:49 INFO - '--xperf_path', 00:02:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:02:49 INFO - 'tests': ['tp5n']}}, 00:02:49 INFO - 'talos.zip': {'path': '', 00:02:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:02:49 INFO - Running post-action listener: _resource_record_post_action 00:02:49 INFO - ##### 00:02:49 INFO - ##### Running create-virtualenv step. 00:02:49 INFO - ##### 00:02:49 INFO - Running pre-action listener: _resource_record_pre_action 00:02:49 INFO - Running main action method: create_virtualenv 00:02:49 INFO - Creating virtualenv /builds/slave/test/build/venv 00:02:49 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 00:02:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:02:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:02:49 INFO - Using real prefix '/usr' 00:02:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:02:49 INFO - Installing distribute.............................................................................................................................................................................................done. 00:02:51 INFO - Installing pip.................done. 00:02:51 INFO - Return code: 0 00:02:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:02:51 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')]} 00:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:51 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')]} 00:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:51 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 0x7f2022267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b0b0>, '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 0x1a8bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', '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 00:02:51 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 00:02:51 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 00:02:51 INFO - Using env: {'DISPLAY': ':0', 00:02:51 INFO - 'HOME': '/home/cltbld', 00:02:51 INFO - 'LANG': 'en_US.UTF-8', 00:02:51 INFO - 'LANGUAGE': 'en_US:en', 00:02:51 INFO - 'LOGNAME': 'cltbld', 00:02:51 INFO - 'MAIL': '/var/mail/cltbld', 00:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:51 INFO - 'MOZ_NO_REMOTE': '1', 00:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:51 INFO - 'NO_EM_RESTART': '1', 00:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:51 INFO - 'PWD': '/builds/slave/test', 00:02:51 INFO - 'SHELL': '/bin/bash', 00:02:51 INFO - 'SHLVL': '1', 00:02:51 INFO - 'TERM': 'linux', 00:02:51 INFO - 'TMOUT': '86400', 00:02:51 INFO - 'USER': 'cltbld', 00:02:51 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', 00:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:51 INFO - '_': '/tools/buildbot/bin/python'} 00:02:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:51 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 00:02:51 INFO - Cleaning up... 00:02:51 INFO - Return code: 0 00:02:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:02:51 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')]} 00:02:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:51 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')]} 00:02:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:51 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 0x7f2022267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b0b0>, '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 0x1a8bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', '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 00:02:51 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 00:02:51 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 00:02:51 INFO - Using env: {'DISPLAY': ':0', 00:02:51 INFO - 'HOME': '/home/cltbld', 00:02:51 INFO - 'LANG': 'en_US.UTF-8', 00:02:51 INFO - 'LANGUAGE': 'en_US:en', 00:02:51 INFO - 'LOGNAME': 'cltbld', 00:02:51 INFO - 'MAIL': '/var/mail/cltbld', 00:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:51 INFO - 'MOZ_NO_REMOTE': '1', 00:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:51 INFO - 'NO_EM_RESTART': '1', 00:02:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:51 INFO - 'PWD': '/builds/slave/test', 00:02:51 INFO - 'SHELL': '/bin/bash', 00:02:51 INFO - 'SHLVL': '1', 00:02:51 INFO - 'TERM': 'linux', 00:02:51 INFO - 'TMOUT': '86400', 00:02:51 INFO - 'USER': 'cltbld', 00:02:51 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', 00:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:51 INFO - '_': '/tools/buildbot/bin/python'} 00:02:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:52 INFO - Downloading/unpacking psutil>=0.7.1 00:02:52 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 00:02:52 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 00:02:52 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 00:02:52 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 00:02:52 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 00:02:52 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 00:02:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:02:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:02:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:02:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:02:53 INFO - Installing collected packages: psutil 00:02:53 INFO - Running setup.py install for psutil 00:02:54 INFO - building 'psutil._psutil_linux' extension 00:02:54 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 00:02:54 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 00:02:54 INFO - building 'psutil._psutil_posix' extension 00:02:54 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 00:02:54 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 00:02:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:02:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:02:54 INFO - Successfully installed psutil 00:02:54 INFO - Cleaning up... 00:02:54 INFO - Return code: 0 00:02:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2022267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b0b0>, '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 0x1a8bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', '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 00:02:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:02:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:02:54 INFO - Using env: {'DISPLAY': ':0', 00:02:54 INFO - 'HOME': '/home/cltbld', 00:02:54 INFO - 'LANG': 'en_US.UTF-8', 00:02:54 INFO - 'LANGUAGE': 'en_US:en', 00:02:54 INFO - 'LOGNAME': 'cltbld', 00:02:54 INFO - 'MAIL': '/var/mail/cltbld', 00:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:54 INFO - 'MOZ_NO_REMOTE': '1', 00:02:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:54 INFO - 'NO_EM_RESTART': '1', 00:02:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:54 INFO - 'PWD': '/builds/slave/test', 00:02:54 INFO - 'SHELL': '/bin/bash', 00:02:54 INFO - 'SHLVL': '1', 00:02:54 INFO - 'TERM': 'linux', 00:02:54 INFO - 'TMOUT': '86400', 00:02:54 INFO - 'USER': 'cltbld', 00:02:54 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', 00:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:54 INFO - '_': '/tools/buildbot/bin/python'} 00:02:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:02:54 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 00:02:54 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 00:02:54 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 00:02:54 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 00:02:54 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 00:02:54 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 00:02:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:02:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:02:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:02:56 INFO - Installing collected packages: mozsystemmonitor 00:02:56 INFO - Running setup.py install for mozsystemmonitor 00:02:56 INFO - Successfully installed mozsystemmonitor 00:02:56 INFO - Cleaning up... 00:02:56 INFO - Return code: 0 00:02:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:56 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 0x7f2022267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b0b0>, '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 0x1a8bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', '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 00:02:56 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 00:02:56 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 00:02:56 INFO - Using env: {'DISPLAY': ':0', 00:02:56 INFO - 'HOME': '/home/cltbld', 00:02:56 INFO - 'LANG': 'en_US.UTF-8', 00:02:56 INFO - 'LANGUAGE': 'en_US:en', 00:02:56 INFO - 'LOGNAME': 'cltbld', 00:02:56 INFO - 'MAIL': '/var/mail/cltbld', 00:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:56 INFO - 'MOZ_NO_REMOTE': '1', 00:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:56 INFO - 'NO_EM_RESTART': '1', 00:02:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:56 INFO - 'PWD': '/builds/slave/test', 00:02:56 INFO - 'SHELL': '/bin/bash', 00:02:56 INFO - 'SHLVL': '1', 00:02:56 INFO - 'TERM': 'linux', 00:02:56 INFO - 'TMOUT': '86400', 00:02:56 INFO - 'USER': 'cltbld', 00:02:56 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', 00:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:56 INFO - '_': '/tools/buildbot/bin/python'} 00:02:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:56 INFO - Downloading/unpacking blobuploader==1.2.4 00:02:56 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 00:02:56 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 00:02:56 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 00:02:56 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 00:02:56 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 00:02:56 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 00:02:58 INFO - Downloading blobuploader-1.2.4.tar.gz 00:02:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:02:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:02:58 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 00:02:58 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 00:02:58 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 00:02:58 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 00:02:58 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 00:02:58 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 00:02:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:02:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:02:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:02:58 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 00:02:58 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 00:02:58 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 00:02:58 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 00:02:58 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 00:02:58 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 00:02:59 INFO - Downloading docopt-0.6.1.tar.gz 00:02:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:02:59 INFO - Installing collected packages: blobuploader, requests, docopt 00:02:59 INFO - Running setup.py install for blobuploader 00:02:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:02:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:02:59 INFO - Running setup.py install for requests 00:02:59 INFO - Running setup.py install for docopt 00:02:59 INFO - Successfully installed blobuploader requests docopt 00:02:59 INFO - Cleaning up... 00:02:59 INFO - Return code: 0 00:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:02:59 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 0x7f2022267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b0b0>, '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 0x1a8bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', '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 00:02:59 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 00:02:59 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 00:02:59 INFO - Using env: {'DISPLAY': ':0', 00:02:59 INFO - 'HOME': '/home/cltbld', 00:02:59 INFO - 'LANG': 'en_US.UTF-8', 00:02:59 INFO - 'LANGUAGE': 'en_US:en', 00:02:59 INFO - 'LOGNAME': 'cltbld', 00:02:59 INFO - 'MAIL': '/var/mail/cltbld', 00:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:02:59 INFO - 'MOZ_NO_REMOTE': '1', 00:02:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:02:59 INFO - 'NO_EM_RESTART': '1', 00:02:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:02:59 INFO - 'PWD': '/builds/slave/test', 00:02:59 INFO - 'SHELL': '/bin/bash', 00:02:59 INFO - 'SHLVL': '1', 00:02:59 INFO - 'TERM': 'linux', 00:02:59 INFO - 'TMOUT': '86400', 00:02:59 INFO - 'USER': 'cltbld', 00:02:59 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', 00:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:02:59 INFO - '_': '/tools/buildbot/bin/python'} 00:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:02:59 INFO - Running setup.py (path:/tmp/pip-KEihuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:03:00 INFO - Running setup.py (path:/tmp/pip-W7gWUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:03:00 INFO - Running setup.py (path:/tmp/pip-zItOm_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:03:00 INFO - Running setup.py (path:/tmp/pip-vvqD2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:03:00 INFO - Running setup.py (path:/tmp/pip-6HEWL9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:03:00 INFO - Running setup.py (path:/tmp/pip-lcciYH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:03:00 INFO - Running setup.py (path:/tmp/pip-2tEtwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:03:00 INFO - Running setup.py (path:/tmp/pip-8rRDqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:03:00 INFO - Running setup.py (path:/tmp/pip-1w_0vK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:03:00 INFO - Running setup.py (path:/tmp/pip-XKuOC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:03:00 INFO - Running setup.py (path:/tmp/pip-t9yzHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:03:00 INFO - Running setup.py (path:/tmp/pip-A072fG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:03:00 INFO - Running setup.py (path:/tmp/pip-IeFfmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:03:00 INFO - Running setup.py (path:/tmp/pip-VZ3BHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:00 INFO - Running setup.py (path:/tmp/pip-58RaQY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:03:01 INFO - Running setup.py (path:/tmp/pip-pbxCda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:03:01 INFO - Running setup.py (path:/tmp/pip-OCxWr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:03:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:03:01 INFO - Running setup.py install for manifestparser 00:03:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:03:01 INFO - Running setup.py install for mozcrash 00:03:01 INFO - Running setup.py install for mozdebug 00:03:01 INFO - Running setup.py install for mozdevice 00:03:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:03:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:03:01 INFO - Running setup.py install for mozfile 00:03:01 INFO - Running setup.py install for mozhttpd 00:03:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:03:01 INFO - Running setup.py install for mozinfo 00:03:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:03:01 INFO - Running setup.py install for mozInstall 00:03:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:03:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:03:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:03:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:03:01 INFO - Running setup.py install for mozleak 00:03:02 INFO - Running setup.py install for mozlog 00:03:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:03:02 INFO - Running setup.py install for moznetwork 00:03:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:03:02 INFO - Running setup.py install for mozprocess 00:03:02 INFO - Running setup.py install for mozprofile 00:03:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:03:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:03:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:03:02 INFO - Running setup.py install for mozrunner 00:03:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:03:02 INFO - Running setup.py install for mozscreenshot 00:03:02 INFO - Running setup.py install for moztest 00:03:02 INFO - Running setup.py install for mozversion 00:03:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:03:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:03:02 INFO - Cleaning up... 00:03:02 INFO - Return code: 0 00:03:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:03: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')]} 00:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03: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')]} 00:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:02 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 0x7f2022267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b0b0>, '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 0x1a8bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', '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 00:03:02 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 00:03:02 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 00:03:02 INFO - Using env: {'DISPLAY': ':0', 00:03:02 INFO - 'HOME': '/home/cltbld', 00:03:02 INFO - 'LANG': 'en_US.UTF-8', 00:03:02 INFO - 'LANGUAGE': 'en_US:en', 00:03:02 INFO - 'LOGNAME': 'cltbld', 00:03:02 INFO - 'MAIL': '/var/mail/cltbld', 00:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:02 INFO - 'MOZ_NO_REMOTE': '1', 00:03:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:02 INFO - 'NO_EM_RESTART': '1', 00:03:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:02 INFO - 'PWD': '/builds/slave/test', 00:03:02 INFO - 'SHELL': '/bin/bash', 00:03:02 INFO - 'SHLVL': '1', 00:03:02 INFO - 'TERM': 'linux', 00:03:02 INFO - 'TMOUT': '86400', 00:03:02 INFO - 'USER': 'cltbld', 00:03:02 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', 00:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:02 INFO - '_': '/tools/buildbot/bin/python'} 00:03:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:03:03 INFO - Running setup.py (path:/tmp/pip-y6BxsT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:03:03 INFO - Running setup.py (path:/tmp/pip-mWbmfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:03:03 INFO - Running setup.py (path:/tmp/pip-sdgEZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:03:03 INFO - Running setup.py (path:/tmp/pip-jp8BWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:03:03 INFO - Running setup.py (path:/tmp/pip-mDkPQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:03:03 INFO - Running setup.py (path:/tmp/pip-rl1fmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:03:03 INFO - Running setup.py (path:/tmp/pip-UjOba5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:03:03 INFO - Running setup.py (path:/tmp/pip-sxOXnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:03:03 INFO - Running setup.py (path:/tmp/pip-6PAAHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:03:03 INFO - Running setup.py (path:/tmp/pip-8J1GZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:03:03 INFO - Running setup.py (path:/tmp/pip-fUpCI5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:03:03 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)) 00:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:03:04 INFO - Running setup.py (path:/tmp/pip-47rsea-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:03:04 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)) 00:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:03:04 INFO - Running setup.py (path:/tmp/pip-GKJC7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:03:04 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)) 00:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:03:04 INFO - Running setup.py (path:/tmp/pip-y20jQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:03:04 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)) 00:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:04 INFO - Running setup.py (path:/tmp/pip-7LSsh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:03:04 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)) 00:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:03:04 INFO - Running setup.py (path:/tmp/pip-vbxJDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:03:04 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)) 00:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:03:04 INFO - Running setup.py (path:/tmp/pip-f2xVgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:03:04 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)) 00:03:04 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)) 00:03:04 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)) 00:03:04 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)) 00:03:04 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)) 00:03:04 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)) 00:03:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:06 INFO - Downloading blessings-1.5.1.tar.gz 00:03:06 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 00:03:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:03:06 INFO - Installing collected packages: blessings 00:03:06 INFO - Running setup.py install for blessings 00:03:06 INFO - Successfully installed blessings 00:03:06 INFO - Cleaning up... 00:03:06 INFO - Return code: 0 00:03:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:03:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:03:06 INFO - Reading from file tmpfile_stdout 00:03:06 INFO - Current package versions: 00:03:06 INFO - argparse == 1.2.1 00:03:06 INFO - blessings == 1.5.1 00:03:06 INFO - blobuploader == 1.2.4 00:03:06 INFO - docopt == 0.6.1 00:03:06 INFO - manifestparser == 1.1 00:03:06 INFO - mozInstall == 1.12 00:03:06 INFO - mozcrash == 0.16 00:03:06 INFO - mozdebug == 0.1 00:03:06 INFO - mozdevice == 0.47 00:03:06 INFO - mozfile == 1.2 00:03:06 INFO - mozhttpd == 0.7 00:03:06 INFO - mozinfo == 0.9 00:03:06 INFO - mozleak == 0.1 00:03:06 INFO - mozlog == 3.1 00:03:06 INFO - moznetwork == 0.27 00:03:06 INFO - mozprocess == 0.22 00:03:06 INFO - mozprofile == 0.27 00:03:06 INFO - mozrunner == 6.11 00:03:06 INFO - mozscreenshot == 0.1 00:03:06 INFO - mozsystemmonitor == 0.0 00:03:06 INFO - moztest == 0.7 00:03:06 INFO - mozversion == 1.4 00:03:06 INFO - psutil == 3.1.1 00:03:06 INFO - requests == 1.2.3 00:03:06 INFO - wsgiref == 0.1.2 00:03:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f2022267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b0b0>, '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 0x1a8bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', '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 00:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 00:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 00:03:06 INFO - Using env: {'DISPLAY': ':0', 00:03:06 INFO - 'HOME': '/home/cltbld', 00:03:06 INFO - 'LANG': 'en_US.UTF-8', 00:03:06 INFO - 'LANGUAGE': 'en_US:en', 00:03:06 INFO - 'LOGNAME': 'cltbld', 00:03:06 INFO - 'MAIL': '/var/mail/cltbld', 00:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:06 INFO - 'MOZ_NO_REMOTE': '1', 00:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:06 INFO - 'NO_EM_RESTART': '1', 00:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:06 INFO - 'PWD': '/builds/slave/test', 00:03:06 INFO - 'SHELL': '/bin/bash', 00:03:06 INFO - 'SHLVL': '1', 00:03:06 INFO - 'TERM': 'linux', 00:03:06 INFO - 'TMOUT': '86400', 00:03:06 INFO - 'USER': 'cltbld', 00:03:06 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', 00:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:06 INFO - '_': '/tools/buildbot/bin/python'} 00:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:06 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)) 00:03:06 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)) 00:03:06 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)) 00:03:06 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)) 00:03:06 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)) 00:03:06 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)) 00:03:06 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)) 00:03:06 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)) 00:03:06 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)) 00:03:06 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)) 00:03:06 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)) 00:03:06 INFO - Cleaning up... 00:03:06 INFO - Return code: 0 00:03:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2022267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b0b0>, '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 0x1a8bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', '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 00:03:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 00:03:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 00:03:06 INFO - Using env: {'DISPLAY': ':0', 00:03:06 INFO - 'HOME': '/home/cltbld', 00:03:06 INFO - 'LANG': 'en_US.UTF-8', 00:03:06 INFO - 'LANGUAGE': 'en_US:en', 00:03:06 INFO - 'LOGNAME': 'cltbld', 00:03:06 INFO - 'MAIL': '/var/mail/cltbld', 00:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:06 INFO - 'MOZ_NO_REMOTE': '1', 00:03:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:06 INFO - 'NO_EM_RESTART': '1', 00:03:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:06 INFO - 'PWD': '/builds/slave/test', 00:03:06 INFO - 'SHELL': '/bin/bash', 00:03:06 INFO - 'SHLVL': '1', 00:03:06 INFO - 'TERM': 'linux', 00:03:06 INFO - 'TMOUT': '86400', 00:03:06 INFO - 'USER': 'cltbld', 00:03:06 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', 00:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:06 INFO - '_': '/tools/buildbot/bin/python'} 00:03:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:07 INFO - Downloading/unpacking jsonschema 00:03: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 00:03: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 00:03: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 00:03: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 00:03: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 00:03: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 00:03:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:03:08 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 00:03:08 INFO - Downloading/unpacking functools32 (from jsonschema) 00:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:08 INFO - Downloading functools32-3.2.3-2.tar.gz 00:03:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:03:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:03:08 INFO - warning: no files found matching '*.txt' 00:03:08 INFO - no previously-included directories found matching 'build' 00:03:08 INFO - no previously-included directories found matching 'dist' 00:03:08 INFO - no previously-included directories found matching '.git*' 00:03:08 INFO - Installing collected packages: jsonschema, functools32 00:03:08 INFO - Running setup.py install for functools32 00:03:09 INFO - warning: no files found matching '*.txt' 00:03:09 INFO - no previously-included directories found matching 'build' 00:03:09 INFO - no previously-included directories found matching 'dist' 00:03:09 INFO - no previously-included directories found matching '.git*' 00:03:09 INFO - Successfully installed jsonschema functools32 00:03:09 INFO - Cleaning up... 00:03:09 INFO - Return code: 0 00:03:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:03:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:03:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:03:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:03:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:03:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f2022267f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x192e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x19fc240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a8b0b0>, '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 0x1a8bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c440>, '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': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', '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 00:03:09 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 00:03:09 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 00:03:09 INFO - Using env: {'DISPLAY': ':0', 00:03:09 INFO - 'HOME': '/home/cltbld', 00:03:09 INFO - 'LANG': 'en_US.UTF-8', 00:03:09 INFO - 'LANGUAGE': 'en_US:en', 00:03:09 INFO - 'LOGNAME': 'cltbld', 00:03:09 INFO - 'MAIL': '/var/mail/cltbld', 00:03:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:09 INFO - 'MOZ_NO_REMOTE': '1', 00:03:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:09 INFO - 'NO_EM_RESTART': '1', 00:03:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:09 INFO - 'PWD': '/builds/slave/test', 00:03:09 INFO - 'SHELL': '/bin/bash', 00:03:09 INFO - 'SHLVL': '1', 00:03:09 INFO - 'TERM': 'linux', 00:03:09 INFO - 'TMOUT': '86400', 00:03:09 INFO - 'USER': 'cltbld', 00:03:09 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', 00:03:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:09 INFO - '_': '/tools/buildbot/bin/python'} 00:03:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:03:09 INFO - Downloading/unpacking flake8 00:03:09 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 00:03:09 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 00:03:09 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 00:03:09 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 00:03:09 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 00:03:09 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 00:03:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:03:11 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 00:03:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:03:11 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 00:03:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:11 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 00:03:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:03:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:03:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:03:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 00:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:03:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:03:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:03:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:03:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:03:11 INFO - no previously-included directories found matching 'docs/_build' 00:03:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:03:11 INFO - Running setup.py install for pep8 00:03:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:03:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:03:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:03:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:03:11 INFO - no previously-included directories found matching 'docs/_build' 00:03:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:03:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:03:11 INFO - Cleaning up... 00:03:11 INFO - Return code: 0 00:03:11 INFO - Running post-action listener: _resource_record_post_action 00:03:11 INFO - Running post-action listener: _start_resource_monitoring 00:03:11 INFO - Starting resource monitoring. 00:03:11 INFO - ##### 00:03:11 INFO - ##### Running install step. 00:03:11 INFO - ##### 00:03:11 INFO - Running pre-action listener: _resource_record_pre_action 00:03:11 INFO - Running main action method: install 00:03:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:03:12 INFO - Reading from file tmpfile_stdout 00:03:12 INFO - Detecting whether we're running mozinstall >=1.0... 00:03:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:03:12 INFO - Reading from file tmpfile_stdout 00:03:12 INFO - Output received: 00:03:12 INFO - Usage: mozinstall [options] installer 00:03:12 INFO - Options: 00:03:12 INFO - -h, --help show this help message and exit 00:03:12 INFO - -d DEST, --destination=DEST 00:03:12 INFO - Directory to install application into. [default: 00:03:12 INFO - "/builds/slave/test"] 00:03:12 INFO - --app=APP Application being installed. [default: firefox] 00:03:12 INFO - mkdir: /builds/slave/test/build/application 00:03:12 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'] 00:03:12 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 00:03:27 INFO - Reading from file tmpfile_stdout 00:03:27 INFO - Output received: 00:03:27 INFO - /builds/slave/test/build/application/firefox/firefox 00:03:27 INFO - Running post-action listener: _resource_record_post_action 00:03:27 INFO - ##### 00:03:27 INFO - ##### Running run-tests step. 00:03:27 INFO - ##### 00:03:27 INFO - Running pre-action listener: _resource_record_pre_action 00:03:27 INFO - Running main action method: run_tests 00:03:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:03:27 INFO - Python 2.7.3 00:03:27 INFO - Return code: 0 00:03:27 INFO - grabbing minidump binary from tooltool 00:03:27 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')]} 00:03:27 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 0x1a8b0b0>, '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 0x1a8bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a8c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:03:27 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 00:03:27 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 00:03:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:03:27 INFO - Return code: 0 00:03:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:03:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:03:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:03:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:03:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:03:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:03:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:03:28 INFO - Return code: 0 00:03:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] in /builds/slave/test/build 00:03:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-032 --webServer localhost 00:03:28 INFO - Using env: {'DISPLAY': ':0', 00:03:28 INFO - 'HOME': '/home/cltbld', 00:03:28 INFO - 'LANG': 'en_US.UTF-8', 00:03:28 INFO - 'LANGUAGE': 'en_US:en', 00:03:28 INFO - 'LOGNAME': 'cltbld', 00:03:28 INFO - 'MAIL': '/var/mail/cltbld', 00:03:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:03:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:03:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:03:28 INFO - 'MOZ_NO_REMOTE': '1', 00:03:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:03:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:03:28 INFO - 'NO_EM_RESTART': '1', 00:03:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:03:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:03:28 INFO - 'PWD': '/builds/slave/test', 00:03:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:03:28 INFO - 'SHELL': '/bin/bash', 00:03:28 INFO - 'SHLVL': '1', 00:03:28 INFO - 'TERM': 'linux', 00:03:28 INFO - 'TMOUT': '86400', 00:03:28 INFO - 'USER': 'cltbld', 00:03:28 INFO - 'XDG_SESSION_COOKIE': '2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396', 00:03:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:03:28 INFO - '_': '/tools/buildbot/bin/python'} 00:03:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-032', '--webServer', 'localhost'] with output_timeout 3600 00:03:28 INFO - mozversion INFO | application_buildid: 20151217233052 00:03:28 INFO - mozversion INFO | application_changeset: b40ae4501f6a9a4859de78b6bd962fa2a5188607 00:03:28 INFO - mozversion INFO | application_display_name: Nightly 00:03:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:03:28 INFO - mozversion INFO | application_name: Firefox 00:03:28 INFO - mozversion INFO | application_remotingname: firefox 00:03:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 00:03:28 INFO - mozversion INFO | application_vendor: Mozilla 00:03:28 INFO - mozversion INFO | application_version: 46.0a1 00:03:28 INFO - mozversion INFO | platform_buildid: 20151217233052 00:03:28 INFO - mozversion INFO | platform_changeset: b40ae4501f6a9a4859de78b6bd962fa2a5188607 00:03:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 00:03:28 INFO - mozversion INFO | platform_version: 46.0a1 00:03:28 INFO - 2015-12-18 00:03:28,829 DEBUG : using testdate: 1450425808 00:03:28 INFO - 2015-12-18 00:03:28,829 DEBUG : actual date: 1450425808 00:03:28 INFO - 2015-12-18 00:03:28,841 INFO : starting webserver on 'localhost:45515' 00:03:28 INFO - 2015-12-18 00:03:28,842 INFO : Starting test suite talos-linux64-ix-032 00:03:28 INFO - 2015-12-18 00:03:28,842 INFO : Starting test dromaeo_css 00:03:28 INFO - 2015-12-18 00:03:28,842 DEBUG : operating with platform_type : linux_ 00:03:28 INFO - 2015-12-18 00:03:28,843 INFO : Initialising browser for dromaeo_css test... 00:03:28 INFO - 2015-12-18 00:03:28,858 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1kILWL/profile http://localhost:45515/getInfo.html 00:03:34 INFO - 2015-12-18 00:03:34,698 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:03:34 INFO - 2015-12-18 00:03:34,698 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:03:34 INFO - 2015-12-18 00:03:34,698 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:03:34 INFO - 2015-12-18 00:03:34,698 DEBUG : BROWSER_OUTPUT: __metrics 00:03:34 INFO - 2015-12-18 00:03:34,843 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] 00:03:34 INFO - 2015-12-18 00:03:34,899 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] 00:03:34 ERROR - 2015-12-18 00:03:34,906 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 00:03:35 INFO - 2015-12-18 00:03:35,927 INFO : Browser initialized. 00:03:35 INFO - 2015-12-18 00:03:35,928 INFO : Running cycle 1/1 for dromaeo_css test... 00:03:35 INFO - 2015-12-18 00:03:35,928 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1kILWL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:03:47 INFO - 2015-12-18 00:03:47,891 DEBUG : BROWSER_OUTPUT: RSS: Main: 149286912 00:03:47 INFO - 2015-12-18 00:03:47,892 DEBUG : BROWSER_OUTPUT: 00:04:39 INFO - 2015-12-18 00:04:39,347 DEBUG : BROWSER_OUTPUT: 1450425879344 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] 00:06:51 INFO - 2015-12-18 00:06:51,756 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45515/tests/dromaeo/cssquery-ext.html) 00:06:52 INFO - 2015-12-18 00:06:52,889 DEBUG : BROWSER_OUTPUT: RSS: Main: 250073088 00:06:52 INFO - 2015-12-18 00:06:52,889 DEBUG : BROWSER_OUTPUT: 00:09:55 INFO - 2015-12-18 00:09:55,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-ext.html (next: http://localhost:45515/tests/dromaeo/cssquery-jquery.html) 00:09:56 INFO - 2015-12-18 00:09:56,059 DEBUG : BROWSER_OUTPUT: RSS: Main: 222662656 00:09:56 INFO - 2015-12-18 00:09:56,060 DEBUG : BROWSER_OUTPUT: 00:12:58 INFO - 2015-12-18 00:12:58,077 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45515/tests/dromaeo/cssquery-mootools.html) 00:12:58 INFO - 2015-12-18 00:12:58,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 218501120 00:12:58 INFO - 2015-12-18 00:12:58,642 DEBUG : BROWSER_OUTPUT: 00:16:00 INFO - 2015-12-18 00:16:00,586 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45515/tests/dromaeo/cssquery-prototype.html) 00:16:01 INFO - 2015-12-18 00:16:01,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 204472320 00:16:01 INFO - 2015-12-18 00:16:01,172 DEBUG : BROWSER_OUTPUT: 00:19:04 INFO - 2015-12-18 00:19:04,025 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45515/tests/dromaeo/cssquery-yui.html) 00:19:04 INFO - 2015-12-18 00:19:04,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 213377024 00:19:04 INFO - 2015-12-18 00:19:04,627 DEBUG : BROWSER_OUTPUT: 00:22:07 INFO - 2015-12-18 00:22:07,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/dromaeo/cssquery-yui.html (next: http://localhost:45515/tests/dromaeo/cssquery-dojo.html) 00:22:07 INFO - 2015-12-18 00:22:07,458 DEBUG : BROWSER_OUTPUT: RSS: Main: 230158336 00:22:07 INFO - 2015-12-18 00:22:07,458 DEBUG : BROWSER_OUTPUT: 00:22:07 INFO - 2015-12-18 00:22:07,458 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:22:07 INFO - 2015-12-18 00:22:07,458 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:22:07 INFO - 2015-12-18 00:22:07,458 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:22:07 INFO - 2015-12-18 00:22:07,458 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:22:07 INFO - 2015-12-18 00:22:07,460 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2606.1530002749105;2719.796015298853;2719.877605507752;2734.453109378124;2737.11043910729;4512.187806194884;4656.4877863434995;4665.860024199271;4722.763861806904;4753.191957367248;4593.540645935404;4668.089722504113;4685.882852928678;4725.787339569719;4843.878903027426;4330.696851220416;4339.32740425233;4346.956530434694;4485.2599321111975;4487.865364039084;4422.18189634917;4482.350059241408;4493.46078470584;4500.842470513517;4541.750203738793;4168.937465937998;4232.703710740249;4272.4445822042935;4277.700560960734;4346.739195648272;4375.7155784873885;4376.452943382077;4387.583179597933;4387.670924680661;4412.801423935931;4352.673549483801;4352.7605981670995;4370;4395.252807022814;4403.009322902353;4536.206163921301;4559.270516717309;4649.674522783406;4652.930206046912;4680.859574212779;5079.060373830853;5084.77118529667;5089.923651145235;5103.362079740033;5126.5898728101665;5086.821961231376;5090.541851233407;5091.032703786269;5098.770555325019;5138.3833939927445;4514.164879497303;4613.1004454131125;4613.723176609415;4721.763911804396;4858.46556878743;5211.42674305826;5232.816851410183;5270.5256526912;5271.367435907716;5273.894522109536;5039.798408063636;5046.1169295373165;5047.671901326402;5053.7220452875445;5064.873378165502;4868.050730107666;4969.453360130383;4974.651774375831;4984.601231901439;4987.725675087905;5044;5054.039732450822;5059.8988020239385;5064.063148317573;5076.36545431821;5000;5006.123928312531;5008.098542262428;5015.523525265094;5048.268001139814;4127.772972486482;4291.570842915684;4292.441982542312;4293.8711838644895;4331.263685173528;3653.598104208535;3721.8697345592773;3730.7948062856262;3754.6245375462236;3762.435634654769;4403.779811009436;4427.800748966304;4429.911401772011;4432.468103827561;4477.126960242721;4860.95139048605;4993.251012348177;5139.049275883974;5156.020356132323;5159;4291.077418355068;4360.345948107746;4370.606645401929;4405;4423.424954755861;4530.093981203772;4554.225781617133;4560.908781824345;4561.338605902126;4601.539846015372;4669.836555720533;4815.638827087912;4827.25177597473;4831.202851529599;4865.513448655177;4921.26181072842;4959.677620954626;4991.975040124777;5031.597472202288;5053.4946505350645;4763.7141771493825;4766.380370551806;4767.690100143618;4805.711657300573;4817.0365926814075;4812.374391329105;4944.184209605375;4956.033573453142;4999.0501804657;5001.199808030698;4886.29148773433;4967.279744437109;5024.6231532634465;5025.271335656383;5037.722925239147;4856.854294371175;4925.975370123127;4928.630352723489;4937.901241975069;4977.850664480072;4758.381410416624;4924.606031517542;4931.112399768076;4938.580220681139;4942.3327850741125;4722.338872557776;4774.809007639656;4798.49615790337;4805.063012712488;4857.514248575114;4955.6531042826655;4964.230544265644;4979.278004689372;4983.053219888209;5016.498350164954;4645.954660201428;4879.292502587176;4894.975525122351;4902.607791376753;4952.950470495249 00:22:07 INFO - 2015-12-18 00:22:07,463 DEBUG : BROWSER_OUTPUT: |1;ext.html;569.9686517241553;574.8332983434805;578.2627150383258;578.9768409263629;581.9388964158763;27602.34385936845;36476;36652;36736.44895326566;36769.44845827312;40140.59859401405;40617.39073913894;40710.796446017805;40828.18343633126;40888.18223635526;6934.68793904273;7065.646717664122;7898.644560994769;8076.192380761906;8081.676732930676;10289.845652315222;10546.947265263701;10550.15598752098;10551.84172237417;10555.050045495904;10063.949680251588;10193.643222487215;10205.183585313158;10210.132138768176;10212.336198147133;7001.579905205678;7139.107611548557;7142.2857714228685;7144.857102857914;10117.291789574732;7117.75087871922;9945.353552019167;10163.847542286872;10166.796664066751;10175.84736228957;36380;36787.08032299214;36799.632003679886;36844.078898027496;36901;2835.4470878178763;2850.3016760893715;2878.668953070403;2899.1012786036395;2939.412117576493;28330.85834570814;28523.429531409463;28543.429131417462;28601.85699071512;29163.562546561818;3281.8030918144987;3481.5125882376487;3483.9129021774406;3502.579690437138;3583.5878873929573;216122;217974;219677;219979;220132;52026.21960670593;53434.198487022724;56475;56796;56846;65242.67378663171;66586;66864.66567667227;66866.33133668698;66982.33017669761;12740.617781466572;12934.223946563236;12940.029497787704;12945.482180712666;12954.222746635232;9411.43531388119;9416.95291523538;9475.28935329853;9476.194523465445;9481.668141615148;19211.451657148726;19465.51336216606;19589.608207835765;19695.704564431544;19698;7712.884306735404;7836.608169591497;7859.214078592095;7902.288794008567;7988.400869934778;876.1763941894599;877.1798368525449;907.3739120007174;920.59953920045;1067.6263307842348;26914;30084.84957575198;30868;30982.690173098432;31242.687573124433;936.6159874451442;964.6864768950119;966.8018056298442;993.4982833668951;1033.8707661542308;15499.14754688503;16079.196040197943;16167.514974550548;16228.432004879773;16310.056506183902;307245;312616;313769;314023;317200;47622;47888.28167577489;48169.518304817204;48244.27633585499;48268;1066.8559744434401;1072.469127781753;1139.0773473486502;1191.773563023023;1195.354508565365;24794.876025619757;25560;26079.478410431304;26359.868200658875;26507.33731656724;36198.8190059048;36347.27305453929;36868.81565592155;36919;37135.25729485449;230399;234653;236074;236629;237411;27377.452450951267;27576.586351204347;27796.30509237285;27834.304142396602;27837;34900.301993960486;35660.821695891354;36135.63864361323;36220.456693150154;39021.80489097536;33490.665093348754;38019.80990095032;38872.41691374575;39382;39981.40027899526;32544.674553254164;32656.03990782834;32717.18207044843;32767.672323277417;33092.83453582717;32837.34325313433;33078;33340;33388;33617.83191084127;29442.558361624164;29711.85144074266;30065.39185574195;30361.544576830922;30432.695673043872;22975.425614359774;23439.88280058589;23476;25219.621705674796;25382.49235015326 00:22:07 INFO - 2015-12-18 00:22:07,467 DEBUG : BROWSER_OUTPUT: |2;jquery.html;316.41971097037026;327.54961927349893;330.6924560159052;334.09293767421445;336.3978478523442;12201.450934707937;12537.498500059986;15051.698966020673;15236.1620110894;15566.766498502531;11585.131115166354;14730.705385892275;15101.244937753123;15527.922360388182;15528.145951972638;4887.095887260851;4889.315495830578;5008.424031236418;5009.44896061433;5016.824411145611;3772.3398405279104;3894.240623078501;4938.678985865908;4991.850244492671;5584.720763961806;5730.627509211909;5732.7133643317875;5751.194832723422;5751.309842818868;5753.5397168226655;5571.4428557144165;5646.40712725162;5648.63283886546;5650.660960342392;5719.313682358123;4871.464138944713;4912.582430493377;4913.140200464904;4914.11545921734;4938.209886418156;19221.61556768857;19307.710384344246;19745.308914188077;19963.700544491698;20021.799782002287;1818.1727314072198;1869.0748079700636;1931.304730297092;1957.451913464218;1963.3226536844766;12512.186707863959;12874.806877896839;12875.871241287654;12926.353682315847;13173.60479185626;1706.300416829094;1729.4033558422325;1742.2421246757701;1744.8080711121765;1808.3941879470394;51051.48948510542;51899.22151167736;54892;59334.40665593332;60923.695381523255;9449.90550094504;9728;9828.508574571242;9845.163161131384;9872.851907221397;12585.622431327074;12604.054695897845;12612.558560450523;12617.053720970964;12620.24278543272;6566.540342176002;6567.704453299613;6814;6857.27998560154;6967.616781077089;6179;6220.906686399708;6228.159198508234;6245.469135123474;6270.9372906270355;3973.900652483711;4032.274190645653;4163.875083747493;4191.140816132746;4196.139791342767;1622.7403615421476;1653.4874189001448;1664.4923298394106;1672.197345274251;1749.9387521436943;838.4969018588798;862.9741107766777;894.8031433084711;901.7970956534728;912.2610685344891;14490.492832750802;14531.491397801026;14992.775108373384;15072.698546029018;15089.773653395208;789.313297431227;848.7368915636173;849.7875531117221;874.8031692869054;931.417863835103;9030.593623286968;9366.438013719198;9386.108319709616;9481.24150067993;9682.90317096834;456515;469882;469999;471381;479600;73798.63100684462;74174.25825741781;75057.6247118761;75718;76007;1058.4125810175426;1058.9046985771163;1070.3256948122632;1091.252492042953;1095.1786160379716;14734.705305893607;14811.333489992761;14955.700885982002;15081.24593770329;15124.773128403303;34100.65899340975;34200.65799342074;34654;34673.50215936454;34852.825735871156;44626;44907;45286.32070518879;46210;48100;8187.058488273925;8346.874796878174;8400;8849.69026084084;8948.060453652533;15703.13632750164;16018.919905400398;16181.919090404472;16382.508524744277;16423;13412.061155719006;13530.120542164728;13701.794473082713;14063.437462501795;14202.431902723776;13385.598432047054;13490;13628.93185534066;13947.651308717363;14027.438902443788;11014.229003969645;13201.801972970605;13778.448862045807;14057.01600887928;14167.787483187967;7862.803429914069;8227.71203007892;8287.212714792086;8287.378446616407;8410.453320534145;10777.353358798497;13421.32893355348;13441.193528388329;13856.653583660489;14010.089344192595 00:22:07 INFO - 2015-12-18 00:22:07,470 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1496.4238768074288;1613.07248332209;1679.4289941419918;1700.3793615330408;1742.2769550636488;6145.877082458359;6258.468030217426;6508.57694249874;6994.615296158716;7002.789916302513;6477.5789573677675;6672.833179170523;6737.663116844163;6751.932480675204;6808.2851300613465;1964.3615824856872;1997.7502812148482;1998.530345368837;1999.0604415924565;2000.7499062617173;1749.8775085744003;1792.3637108826374;1793.6412717456496;1794.5065107095522;2016.6974953756908;1982.058522201957;2020.2020202020194;2021.231931865889;2023.6357455657976;2030.6852437872153;1881.868269221155;1883.9058047097658;1899.3542195653474;1903.4860587641328;1935.8965389727862;2083.5832833433374;2109.778473260301;2110.989445052765;2114.8413868959738;2116.7777383374832;7245.963770181115;7316.158641756213;7320.048393708784;7328.3038111379865;7328.3770879475305;4009.3585026395635;4111.814968326403;4123.711340206187;4124.938125928114;4126.66986641071;2585.2244326701916;2655.0441840937247;2674.61218123371;2691.596260560912;2696.9460610787673;808.2362167751477;808.6967387229789;823.7981694484889;832.5712258187039;850.5662112322698;9694.17599504043;9705.126538611488;9706.70879873605;9725.173360264385;9774.51127443625;3730.347189241872;3809.104860357814;3820.121372084436;3828.1769419574925;3888.0474283800086;8391.748247552583;8424.199701028392;8440.15598440151;8440.873386899202;8441.409101362846;4119.773412462283;4124.731892426983;4139.110091330378;4148.439960605279;4151.252774500558;3775.2638235543805;3777.660010599059;3777.9244415112094;3779.7921114338424;3781.6029316921326;3190.8564114614896;3256.6580509046685;3277.6394596594355;3279.1638132276594;3286.6549012353835;922.9939366090858;1045.038564520643;1048.695878195315;1060.0565496707936;1060.6923992042375;876.9649214031494;903.6385445821724;927.698497988143;1011.6863772230632;1209.4980583057932;6507.934920650828;6560.967195163994;6578.76974305897;6583.045458408504;6597.30728273534;921.3044151665583;1030.7989941961396;1048.727330893973;1055.5355643516828;1078.9480256749607;5210.843674689765;5245.737713114329;5257.132573125468;5283.286756287852;5284.180951952453;8209.671613135408;8535.402521823537;8560.0583935767;8566.82866342682;8570.571471426403;8322.8335433291;8333.083360830304;8395.62219700115;8429.367797415218;8465.449745766506;6601;6625.271220165778;6761.526693131434;6796.72813087471;6845.14435695538;6537.182852143482;6541.116949211986;6551.836204094936;6562.606243625398;6577.2436169841085;7537.283958023979;7621.733239336597;7729.381649467917;7778.961105194438;7801.921980780119;7550.509216900884;7717.729879454192;7737.961310193413;7738.690452382067;7903.802404939923;5660.801871934463;5835.591508594358;5885.852853678693;5892.263467066617;5907.113932910098;6601.768938087336;6957.4086202671315;6971.651417429007;6974.79075627732;6975.476839236976;5586.860328491658;6513.89363313664;6547.770828020996;6555.934440655532;6640.50196235294;5546;6173.1666225060835;6205.131281620667;6231.9688401557705;6489.5781774184525;6198.535109866688;6693.364130407604;6731.360520750521;6734.023566582916;6735.4274886635185;5894.322152952465;5906.704664766658;5919.644821310735;5932.881342373042;5946.167536544974;6084.513238940963;6087.269527656709;6101.145839582373;6121.84695382619;6147.0779383092895 00:22:07 INFO - 2015-12-18 00:22:07,470 DEBUG : BROWSER_OUTPUT: |4;prototype.html;278.7045731524584;282.3942643030698;283.69786177720727;286.0859553725845;286.48432820922335;5335.1997200419855;5342.91985620216;5381.946180538193;5384.219288203209;5384.703841288728;5309.495597918201;5317.734113294339;5329.387120481146;5333.173358129487;5336.786528538853;4102.630763231308;4118.546959834416;4120.5879412058775;4124.855630052949;4127.17456508698;3917.334053210947;3985.6811455083525;4008.5390180129366;4084.7957602119923;4104.97947510262;4048.9392659110135;4066.9796651016704;4068.308387574105;4072.552019277877;4076.7553946763287;3863.420486926955;4044.858429954967;4047.1096358801165;4055.3308704063793;4068.7151899367054;3489.773164744309;3495.807730574843;3570.910872183983;3580.337637537038;3580.5524309461316;5156.974215128937;5159.7678104485385;5173.042987047408;5179.2749015137915;5188.507091826271;4704.882377940545;4716.2454007359;4716.716996980193;4719.787609557578;4724.716517008956;5455.399906010336;5618.15727640853;5619.971900140473;5632.887342253132;5633;3914.354131568288;3915.158240978175;3919.627635374635;3920.705947053954;3924.646781789653;5838.328592211865;5945.286565612111;5953.910691339634;5956.225690660186;5966.552508561832;3970.305196590585;3972.066564357374;3973.562908080109;3973.7019723520852;3996.4205190247253;4067;4073.674106071507;4075.655033838826;4078.5921407858978;4080.1227736036894;4165.937510937339;4335.241332766753;4437.112577484516;4548.158590660738;4587.449506059294;5521.929276521305;5665.943340566541;5672.432756724294;5673.971630141823;5674.77300907959;1411.5976946570179;1424.4159894443228;1425.3016022149072;1425.5509514502899;1427.0010992305429;943.3443756589242;946.3564775952418;955.4935883981501;974.2790335151936;975.6829030565095;4983.377077865267;4984.950150498521;4993.17612593918;4995.575376093073;5001.124803159432;5888.823335299948;5893.793717219963;5894.764209431661;5897.52819774417;5903.616264942765;4945.653804233741;4976.726280054631;4980.352554167935;4983.654413308386;4984.028114517707;3048.8628011739524;3083.2137804859617;3132.6710695377114;3158.589383380146;3164.493681011073;5436.945630543644;5503.504684578407;5508.944910550843;5578.776848926079;5589.105743081088;6062.42406971337;6067.998780201306;6069.51443884497;6072.453479186806;6076.058210977306;5570.470805273492;5572.3870374258795;5573.247611572467;5576.665400076008;5576.9163462548095;5764.106563482667;5885.823425297248;5943.762249509971;5950.137230101697;5968.22413086296;5794.420557944172;5799.217105690678;5806.593538452268;5806.912896306474;5807.332156802022;5613.158026296088;5622.662640241599;5624.100143976944;5627.099664053731;5630.352509461464;3746.494223279822;3896.9220615588097;3924.3328634132836;3934;3939.822707978205;5891.1752354671235;5892.558058145742;5902.61632993854;5904.704764761659;5904.940950590611;5658.349289831722;5666.886662266814;5668.574856885668;5671.064274394678;5671.461211184931;5606.579506536945;5632.408597097246;5638.2670252866865;5645.915311270416;5647.1529270609735;5398.082326004667;5512.586556008235;5517.282753242052;5518.255035570147;5524.33707955048;5665.830025099253;5672.234248376416;5672.517835983987;5672.943270567242;5677.205191273142;5519.227308176939;5527.613067085265;5540.501354878081;5547.2233887256625;5557.221988921635 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: |5;yui.html;671.6977360187914;693.348252642516;731.6341829085458;740.429869000869;747.0810902589815;11262.831057534133;11548.3648399338;11550.59572914947;12319.322437265946;12886.355682215875;12179.147459677826;12224.694382640417;12227.388630568481;12230.082743794228;12243.081768867349;637.1907677249912;647.5531883000715;791.3708601661664;806.3307454812492;806.7095845495617;791.3945831438954;796.3072127249301;799.2886331165267;806.4314658166008;806.6612022950345;846.3525403066628;849.1720572441851;849.8555245608261;849.9872501912477;851.3614788908319;659.4427708586237;670.2660586657602;829.402829962426;838.7986883148031;844.1558441558442;627.9905801412982;628.1990462160736;628.71707731521;628.8144997225829;629.0093103362177;11302.208845380826;11375.146863985152;11383.487743051583;11386.71533211668;11390.544378224944;10528.894711052868;10886.40124793136;11031.669049928514;11032.779344413148;11044.061254793352;9224.446533207962;9256.72229833106;9283.210927071206;9326.253899688008;9506.47714375709;3107.9533806992913;3128.9217769555717;3129.155128115419;3176.126565194567;3194.4409728297687;38049.04877378088;38198.42702359467;38378.80810595985;38510;38551.42172867409;8926.285897128344;8946.284297256203;8973;8979.775505612412;9046.683366082156;15669.451569195024;15743.842561574467;15811.841881581267;15813.209339532978;15831.68336633284;6225.501959843202;6399.64801935898;6515.413612774873;6547.541672082908;6722.29415911332;3601.2077342984503;3679.0986208379118;3699.112213068844;3734.9066273343383;3756.436534519844;2378.167641325557;2403.0267741564694;2405.4948460823075;2407.0973384980634;2407.3981504623844;432.4119197890866;432.7144084903948;434.0689221619608;446.62483513848525;450.8940399006231;430.9935350969738;434.548070007189;472.30806867938634;596.5853731656457;598.796409220867;6990.4757143214465;7524.172341042481;7539.32146106853;7616.771496855104;7816.53100813953;454.43876812136983;455.4853016091795;463.87243508034885;517.64541289217;530.8672831792052;3346.6486018967657;3476.913077173091;3478.217401084786;3525.494483649767;3552.626974167727;46623;47251.76374118107;47342.76328618404;47619;47777.522224778004;43194.56805431968;43266.56733432625;46641.76679116583;47001;47487;38386.232275354334;38778.22443551113;38988.80505597511;39283;39302.999999999425;7001.684924178526;7337;7361.411087113125;7677.539347639159;7772.533647981139;27887.721122788513;27929;31630.841845790623;32172.678273217905;32347.676523234466;37423.625763743104;38098.80950595229;38156.427653584666;38374.052021936644;38998.80500597479;9087.227585655293;9346.906530934604;9449.43303401798;9480.431174129575;9945.254105941938;10433.197618552298;10725.678229653124;10781.568737250422;10845.783084338427;10896.945515272373;9863.260255480724;10239.590416383558;10601.840972385266;10687.51906164209;10696.62561810333;10166.593336266467;10394;10466.947665261625;10657.360558366523;10832;9913.702588922344;10220.284580079324;10233.897661023295;10573.312734672221;10595.470226488798;7783.844323113392;7859;7930.191207160109;8112;8113.0669972953865;7938.722144724907;8601.956990215009;8698.478091314288;8835.514046727492;8945.284377249674 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,930 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: __startTimestamp1450426927456__endTimestamp 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: Number of tests: 6 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: 00:22:07 INFO - 2015-12-18 00:22:07,472 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4671.79 Median:4805.06 stddev:480.22 (10.0%) stddev-sans-first:453.53 00:22:07 INFO - 2015-12-18 00:22:07,474 DEBUG : BROWSER_OUTPUT: Values: 2606.2 2719.8 2719.9 2734.5 2737.1 4512.2 4656.5 4665.9 4722.8 4753.2 4593.5 4668.1 4685.9 4725.8 4843.9 4330.7 4339.3 4347.0 4485.3 4487.9 4422.2 4482.4 4493.5 4500.8 4541.8 4168.9 4232.7 4272.4 4277.7 4346.7 4375.7 4376.5 4387.6 4387.7 4412.8 4352.7 4352.8 4370.0 4395.3 4403.0 4536.2 4559.3 4649.7 4652.9 4680.9 5079.1 5084.8 5089.9 5103.4 5126.6 5086.8 5090.5 5091.0 5098.8 5138.4 4514.2 4613.1 4613.7 4721.8 4858.5 5211.4 5232.8 5270.5 5271.4 5273.9 5039.8 5046.1 5047.7 5053.7 5064.9 4868.1 4969.5 4974.7 4984.6 4987.7 5044.0 5054.0 5059.9 5064.1 5076.4 5000.0 5006.1 5008.1 5015.5 5048.3 4127.8 4291.6 4292.4 4293.9 4331.3 3653.6 3721.9 3730.8 3754.6 3762.4 4403.8 4427.8 4429.9 4432.5 4477.1 4861.0 4993.3 5139.0 5156.0 5159.0 4291.1 4360.3 4370.6 4405.0 4423.4 4530.1 4554.2 4560.9 4561.3 4601.5 4669.8 4815.6 4827.3 4831.2 4865.5 4921.3 4959.7 4992.0 5031.6 5053.5 4763.7 4766.4 4767.7 4805.7 4817.0 4812.4 4944.2 4956.0 4999.1 5001.2 4886.3 4967.3 5024.6 5025.3 5037.7 4856.9 4926.0 4928.6 4937.9 4977.9 4758.4 4924.6 4931.1 4938.6 4942.3 4722.3 4774.8 4798.5 4805.1 4857.5 4955.7 4964.2 4979.3 4983.1 5016.5 4646.0 4879.3 4895.0 4902.6 4953.0 00:22:07 INFO - 2015-12-18 00:22:07,474 DEBUG : BROWSER_OUTPUT: 00:22:07 INFO - 2015-12-18 00:22:07,474 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42035.72 Median:18024.74 stddev:67643.38 (375.3%) stddev-sans-first:67761.49 00:22:07 INFO - 2015-12-18 00:22:07,474 DEBUG : BROWSER_OUTPUT: Values: 570.0 574.8 578.3 579.0 581.9 27602.3 36476.0 36652.0 36736.4 36769.4 40140.6 40617.4 40710.8 40828.2 40888.2 6934.7 7065.6 7898.6 8076.2 8081.7 10289.8 10546.9 10550.2 10551.8 10555.1 10063.9 10193.6 10205.2 10210.1 10212.3 7001.6 7139.1 7142.3 7144.9 10117.3 7117.8 9945.4 10163.8 10166.8 10175.8 36380.0 36787.1 36799.6 36844.1 36901.0 2835.4 2850.3 2878.7 2899.1 2939.4 28330.9 28523.4 28543.4 28601.9 29163.6 3281.8 3481.5 3483.9 3502.6 3583.6 216122.0 217974.0 219677.0 219979.0 220132.0 52026.2 53434.2 56475.0 56796.0 56846.0 65242.7 66586.0 66864.7 66866.3 66982.3 12740.6 12934.2 12940.0 12945.5 12954.2 9411.4 9417.0 9475.3 9476.2 9481.7 19211.5 19465.5 19589.6 19695.7 19698.0 7712.9 7836.6 7859.2 7902.3 7988.4 876.2 877.2 907.4 920.6 1067.6 26914.0 30084.8 30868.0 30982.7 31242.7 936.6 964.7 966.8 993.5 1033.9 15499.1 16079.2 16167.5 16228.4 16310.1 307245.0 312616.0 313769.0 314023.0 317200.0 47622.0 47888.3 48169.5 48244.3 48268.0 1066.9 1072.5 1139.1 1191.8 1195.4 24794.9 25560.0 26079.5 26359.9 26507.3 36198.8 36347.3 36868.8 36919.0 37135.3 230399.0 234653.0 236074.0 236629.0 237411.0 27377.5 27576.6 27796.3 27834.3 27837.0 34900.3 35660.8 36135.6 36220.5 39021.8 33490.7 38019.8 38872.4 39382.0 39981.4 32544.7 32656.0 32717.2 32767.7 33092.8 32837.3 33078.0 33340.0 33388.0 33617.8 29442.6 29711.9 30065.4 30361.5 30432.7 22975.4 23439.9 23476.0 25219.6 25382.5 00:22:07 INFO - 2015-12-18 00:22:07,474 DEBUG : BROWSER_OUTPUT: 00:22:07 INFO - 2015-12-18 00:22:07,474 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26144.96 Median:3833.29 stddev:76771.88 (2002.8%) stddev-sans-first:76962.75 00:22:07 INFO - 2015-12-18 00:22:07,475 DEBUG : BROWSER_OUTPUT: Values: 316.4 327.5 330.7 334.1 336.4 12201.5 12537.5 15051.7 15236.2 15566.8 11585.1 14730.7 15101.2 15527.9 15528.1 4887.1 4889.3 5008.4 5009.4 5016.8 3772.3 3894.2 4938.7 4991.9 5584.7 5730.6 5732.7 5751.2 5751.3 5753.5 5571.4 5646.4 5648.6 5650.7 5719.3 4871.5 4912.6 4913.1 4914.1 4938.2 19221.6 19307.7 19745.3 19963.7 20021.8 1818.2 1869.1 1931.3 1957.5 1963.3 12512.2 12874.8 12875.9 12926.4 13173.6 1706.3 1729.4 1742.2 1744.8 1808.4 51051.5 51899.2 54892.0 59334.4 60923.7 9449.9 9728.0 9828.5 9845.2 9872.9 12585.6 12604.1 12612.6 12617.1 12620.2 6566.5 6567.7 6814.0 6857.3 6967.6 6179.0 6220.9 6228.2 6245.5 6270.9 3973.9 4032.3 4163.9 4191.1 4196.1 1622.7 1653.5 1664.5 1672.2 1749.9 838.5 863.0 894.8 901.8 912.3 14490.5 14531.5 14992.8 15072.7 15089.8 789.3 848.7 849.8 874.8 931.4 9030.6 9366.4 9386.1 9481.2 9682.9 456515.0 469882.0 469999.0 471381.0 479600.0 73798.6 74174.3 75057.6 75718.0 76007.0 1058.4 1058.9 1070.3 1091.3 1095.2 14734.7 14811.3 14955.7 15081.2 15124.8 34100.7 34200.7 34654.0 34673.5 34852.8 44626.0 44907.0 45286.3 46210.0 48100.0 8187.1 8346.9 8400.0 8849.7 8948.1 15703.1 16018.9 16181.9 16382.5 16423.0 13412.1 13530.1 13701.8 14063.4 14202.4 13385.6 13490.0 13628.9 13947.7 14027.4 11014.2 13201.8 13778.4 14057.0 14167.8 7862.8 8227.7 8287.2 8287.4 8410.5 10777.4 13421.3 13441.2 13856.7 14010.1 00:22:07 INFO - 2015-12-18 00:22:07,475 DEBUG : BROWSER_OUTPUT: 00:22:07 INFO - 2015-12-18 00:22:07,475 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4919.84 Median:6133.86 stddev:2582.58 (42.1%) stddev-sans-first:2577.01 00:22:07 INFO - 2015-12-18 00:22:07,475 DEBUG : BROWSER_OUTPUT: Values: 1496.4 1613.1 1679.4 1700.4 1742.3 6145.9 6258.5 6508.6 6994.6 7002.8 6477.6 6672.8 6737.7 6751.9 6808.3 1964.4 1997.8 1998.5 1999.1 2000.7 1749.9 1792.4 1793.6 1794.5 2016.7 1982.1 2020.2 2021.2 2023.6 2030.7 1881.9 1883.9 1899.4 1903.5 1935.9 2083.6 2109.8 2111.0 2114.8 2116.8 7246.0 7316.2 7320.0 7328.3 7328.4 4009.4 4111.8 4123.7 4124.9 4126.7 2585.2 2655.0 2674.6 2691.6 2696.9 808.2 808.7 823.8 832.6 850.6 9694.2 9705.1 9706.7 9725.2 9774.5 3730.3 3809.1 3820.1 3828.2 3888.0 8391.7 8424.2 8440.2 8440.9 8441.4 4119.8 4124.7 4139.1 4148.4 4151.3 3775.3 3777.7 3777.9 3779.8 3781.6 3190.9 3256.7 3277.6 3279.2 3286.7 923.0 1045.0 1048.7 1060.1 1060.7 877.0 903.6 927.7 1011.7 1209.5 6507.9 6561.0 6578.8 6583.0 6597.3 921.3 1030.8 1048.7 1055.5 1078.9 5210.8 5245.7 5257.1 5283.3 5284.2 8209.7 8535.4 8560.1 8566.8 8570.6 8322.8 8333.1 8395.6 8429.4 8465.4 6601.0 6625.3 6761.5 6796.7 6845.1 6537.2 6541.1 6551.8 6562.6 6577.2 7537.3 7621.7 7729.4 7779.0 7801.9 7550.5 7717.7 7738.0 7738.7 7903.8 5660.8 5835.6 5885.9 5892.3 5907.1 6601.8 6957.4 6971.7 6974.8 6975.5 5586.9 6513.9 6547.8 6555.9 6640.5 5546.0 6173.2 6205.1 6232.0 6489.6 6198.5 6693.4 6731.4 6734.0 6735.4 5894.3 5906.7 5919.6 5932.9 5946.2 6084.5 6087.3 6101.1 6121.8 6147.1 00:22:07 INFO - 2015-12-18 00:22:07,475 DEBUG : BROWSER_OUTPUT: 00:22:07 INFO - 2015-12-18 00:22:07,476 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4661.93 Median:5339.85 stddev:1400.66 (26.2%) stddev-sans-first:1365.40 00:22:07 INFO - 2015-12-18 00:22:07,477 DEBUG : BROWSER_OUTPUT: Values: 278.7 282.4 283.7 286.1 286.5 5335.2 5342.9 5381.9 5384.2 5384.7 5309.5 5317.7 5329.4 5333.2 5336.8 4102.6 4118.5 4120.6 4124.9 4127.2 3917.3 3985.7 4008.5 4084.8 4105.0 4048.9 4067.0 4068.3 4072.6 4076.8 3863.4 4044.9 4047.1 4055.3 4068.7 3489.8 3495.8 3570.9 3580.3 3580.6 5157.0 5159.8 5173.0 5179.3 5188.5 4704.9 4716.2 4716.7 4719.8 4724.7 5455.4 5618.2 5620.0 5632.9 5633.0 3914.4 3915.2 3919.6 3920.7 3924.6 5838.3 5945.3 5953.9 5956.2 5966.6 3970.3 3972.1 3973.6 3973.7 3996.4 4067.0 4073.7 4075.7 4078.6 4080.1 4165.9 4335.2 4437.1 4548.2 4587.4 5521.9 5665.9 5672.4 5674.0 5674.8 1411.6 1424.4 1425.3 1425.6 1427.0 943.3 946.4 955.5 974.3 975.7 4983.4 4985.0 4993.2 4995.6 5001.1 5888.8 5893.8 5894.8 5897.5 5903.6 4945.7 4976.7 4980.4 4983.7 4984.0 3048.9 3083.2 3132.7 3158.6 3164.5 5436.9 5503.5 5508.9 5578.8 5589.1 6062.4 6068.0 6069.5 6072.5 6076.1 5570.5 5572.4 5573.2 5576.7 5576.9 5764.1 5885.8 5943.8 5950.1 5968.2 5794.4 5799.2 5806.6 5806.9 5807.3 5613.2 5622.7 5624.1 5627.1 5630.4 3746.5 3896.9 3924.3 3934.0 3939.8 5891.2 5892.6 5902.6 5904.7 5904.9 5658.3 5666.9 5668.6 5671.1 5671.5 5606.6 5632.4 5638.3 5645.9 5647.2 5398.1 5512.6 5517.3 5518.3 5524.3 5665.8 5672.2 5672.5 5672.9 5677.2 5519.2 5527.6 5540.5 5547.2 5557.2 00:22:07 INFO - 2015-12-18 00:22:07,477 DEBUG : BROWSER_OUTPUT: 00:22:07 INFO - 2015-12-18 00:22:07,477 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11868.17 Median:448.76 stddev:13414.69 (2989.3%) stddev-sans-first:13425.97 00:22:07 INFO - 2015-12-18 00:22:07,477 DEBUG : BROWSER_OUTPUT: Values: 671.7 693.3 731.6 740.4 747.1 11262.8 11548.4 11550.6 12319.3 12886.4 12179.1 12224.7 12227.4 12230.1 12243.1 637.2 647.6 791.4 806.3 806.7 791.4 796.3 799.3 806.4 806.7 846.4 849.2 849.9 850.0 851.4 659.4 670.3 829.4 838.8 844.2 628.0 628.2 628.7 628.8 629.0 11302.2 11375.1 11383.5 11386.7 11390.5 10528.9 10886.4 11031.7 11032.8 11044.1 9224.4 9256.7 9283.2 9326.3 9506.5 3108.0 3128.9 3129.2 3176.1 3194.4 38049.0 38198.4 38378.8 38510.0 38551.4 8926.3 8946.3 8973.0 8979.8 9046.7 15669.5 15743.8 15811.8 15813.2 15831.7 6225.5 6399.6 6515.4 6547.5 6722.3 3601.2 3679.1 3699.1 3734.9 3756.4 2378.2 2403.0 2405.5 2407.1 2407.4 432.4 432.7 434.1 446.6 450.9 431.0 434.5 472.3 596.6 598.8 6990.5 7524.2 7539.3 7616.8 7816.5 454.4 455.5 463.9 517.6 530.9 3346.6 3476.9 3478.2 3525.5 3552.6 46623.0 47251.8 47342.8 47619.0 47777.5 43194.6 43266.6 46641.8 47001.0 47487.0 38386.2 38778.2 38988.8 39283.0 39303.0 7001.7 7337.0 7361.4 7677.5 7772.5 27887.7 27929.0 31630.8 32172.7 32347.7 37423.6 38098.8 38156.4 38374.1 38998.8 9087.2 9346.9 9449.4 9480.4 9945.3 10433.2 10725.7 10781.6 10845.8 10896.9 9863.3 10239.6 10601.8 10687.5 10696.6 10166.6 10394.0 10466.9 10657.4 10832.0 9913.7 10220.3 10233.9 10573.3 10595.5 7783.8 7859.0 7930.2 8112.0 8113.1 7938.7 8602.0 8698.5 8835.5 8945.3 00:22:07 INFO - 2015-12-18 00:22:07,477 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:22:07 INFO - 2015-12-18 00:22:07,477 DEBUG : BROWSER_OUTPUT: 00:22:08 INFO - 2015-12-18 00:22:08,249 INFO : Browser exited with error code: 0 00:22:08 INFO - 2015-12-18 00:22:08,268 INFO : Completed test dromaeo_css (00:18:39) 00:22:08 INFO - 2015-12-18 00:22:08,268 INFO : Starting test kraken 00:22:08 INFO - 2015-12-18 00:22:08,268 DEBUG : operating with platform_type : linux_ 00:22:08 INFO - 2015-12-18 00:22:08,268 INFO : Initialising browser for kraken test... 00:22:08 INFO - 2015-12-18 00:22:08,274 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebj4kb/profile http://localhost:45515/getInfo.html 00:22:13 INFO - 2015-12-18 00:22:13,287 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:22:13 INFO - 2015-12-18 00:22:13,287 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:22:13 INFO - 2015-12-18 00:22:13,287 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:22:13 INFO - 2015-12-18 00:22:13,287 DEBUG : BROWSER_OUTPUT: __metrics 00:22:13 INFO - 2015-12-18 00:22:13,470 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] 00:22:13 INFO - 2015-12-18 00:22:13,547 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] 00:22:15 INFO - 2015-12-18 00:22:15,145 INFO : Browser initialized. 00:22:15 INFO - 2015-12-18 00:22:15,146 INFO : Running cycle 1/1 for kraken test... 00:22:15 INFO - 2015-12-18 00:22:15,146 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpebj4kb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:22:27 INFO - 2015-12-18 00:22:27,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 149774336 00:22:27 INFO - 2015-12-18 00:22:27,077 DEBUG : BROWSER_OUTPUT: 00:22:29 INFO - 2015-12-18 00:22:29,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45515/tests/kraken/driver.html?testName=audio-beat-detection) 00:22:30 INFO - 2015-12-18 00:22:30,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 185204736 00:22:30 INFO - 2015-12-18 00:22:30,307 DEBUG : BROWSER_OUTPUT: 00:22:33 INFO - 2015-12-18 00:22:33,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45515/tests/kraken/driver.html?testName=audio-dft) 00:22:33 INFO - 2015-12-18 00:22:33,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 174968832 00:22:33 INFO - 2015-12-18 00:22:33,631 DEBUG : BROWSER_OUTPUT: 00:22:36 INFO - 2015-12-18 00:22:36,639 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45515/tests/kraken/driver.html?testName=audio-fft) 00:22:37 INFO - 2015-12-18 00:22:37,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 159789056 00:22:37 INFO - 2015-12-18 00:22:37,202 DEBUG : BROWSER_OUTPUT: 00:22:39 INFO - 2015-12-18 00:22:39,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45515/tests/kraken/driver.html?testName=audio-oscillator) 00:22:39 INFO - 2015-12-18 00:22:39,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 162983936 00:22:39 INFO - 2015-12-18 00:22:39,796 DEBUG : BROWSER_OUTPUT: 00:22:42 INFO - 2015-12-18 00:22:42,069 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45515/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:22:42 INFO - 2015-12-18 00:22:42,635 DEBUG : BROWSER_OUTPUT: RSS: Main: 165957632 00:22:42 INFO - 2015-12-18 00:22:42,635 DEBUG : BROWSER_OUTPUT: 00:22:45 INFO - 2015-12-18 00:22:45,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45515/tests/kraken/driver.html?testName=imaging-darkroom) 00:22:46 INFO - 2015-12-18 00:22:46,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 164663296 00:22:46 INFO - 2015-12-18 00:22:46,189 DEBUG : BROWSER_OUTPUT: 00:22:49 INFO - 2015-12-18 00:22:49,592 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45515/tests/kraken/driver.html?testName=imaging-desaturate) 00:22:50 INFO - 2015-12-18 00:22:50,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 167018496 00:22:50 INFO - 2015-12-18 00:22:50,174 DEBUG : BROWSER_OUTPUT: 00:22:53 INFO - 2015-12-18 00:22:53,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45515/tests/kraken/driver.html?testName=json-parse-financial) 00:22:53 INFO - 2015-12-18 00:22:53,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 166338560 00:22:53 INFO - 2015-12-18 00:22:53,608 DEBUG : BROWSER_OUTPUT: 00:22:55 INFO - 2015-12-18 00:22:55,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45515/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:22:55 INFO - 2015-12-18 00:22:55,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 174628864 00:22:55 INFO - 2015-12-18 00:22:55,927 DEBUG : BROWSER_OUTPUT: 00:22:57 INFO - 2015-12-18 00:22:57,838 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:22:58 INFO - 2015-12-18 00:22:58,431 DEBUG : BROWSER_OUTPUT: RSS: Main: 172834816 00:22:58 INFO - 2015-12-18 00:22:58,431 DEBUG : BROWSER_OUTPUT: 00:23:00 INFO - 2015-12-18 00:23:00,495 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:23:01 INFO - 2015-12-18 00:23:01,077 DEBUG : BROWSER_OUTPUT: RSS: Main: 187715584 00:23:01 INFO - 2015-12-18 00:23:01,077 DEBUG : BROWSER_OUTPUT: 00:23:03 INFO - 2015-12-18 00:23:03,584 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:23:04 INFO - 2015-12-18 00:23:04,173 DEBUG : BROWSER_OUTPUT: RSS: Main: 190898176 00:23:04 INFO - 2015-12-18 00:23:04,174 DEBUG : BROWSER_OUTPUT: 00:23:06 INFO - 2015-12-18 00:23:06,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:23:07 INFO - 2015-12-18 00:23:07,286 DEBUG : BROWSER_OUTPUT: RSS: Main: 189292544 00:23:07 INFO - 2015-12-18 00:23:07,286 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,068 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45515/tests/kraken/driver.html?testName=ai-astar) 00:23:09 INFO - 2015-12-18 00:23:09,317 DEBUG : BROWSER_OUTPUT: RSS: Main: 247144448 00:23:09 INFO - 2015-12-18 00:23:09,318 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,319 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:23:09 INFO - 2015-12-18 00:23:09,319 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:23:09 INFO - 2015-12-18 00:23:09,319 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:23:09 INFO - 2015-12-18 00:23:09,319 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:23:09 INFO - 2015-12-18 00:23:09,319 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;113;106;111;114;112;105;114;114;102 00:23:09 INFO - 2015-12-18 00:23:09,320 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;130;161;162;130;154;159;130;188;130 00:23:09 INFO - 2015-12-18 00:23:09,320 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;160;162;164;161;162;162;161;163 00:23:09 INFO - 2015-12-18 00:23:09,320 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;84;92;72;73;74;110;90;72 00:23:09 INFO - 2015-12-18 00:23:09,321 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;131;94;94;95;141;94;94;147 00:23:09 INFO - 2015-12-18 00:23:09,321 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;110;110;110;108;109;109 00:23:09 INFO - 2015-12-18 00:23:09,322 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;147;147;146;148;147;146;146;148 00:23:09 INFO - 2015-12-18 00:23:09,322 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;94;95;97;95;95;95;95;96 00:23:09 INFO - 2015-12-18 00:23:09,322 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;72;70;70;70;71;72;80;69;69 00:23:09 INFO - 2015-12-18 00:23:09,322 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;73;69;68;69;68;68;71;69 00:23:09 INFO - 2015-12-18 00:23:09,322 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;82;82;81;81;82;82;83;82;82 00:23:09 INFO - 2015-12-18 00:23:09,323 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;122;119;131;118;121;122;118;125;122 00:23:09 INFO - 2015-12-18 00:23:09,323 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;133;143;146;148;134;145;145;144;133 00:23:09 INFO - 2015-12-18 00:23:09,323 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;71;69;70;79;68;69;69;68 00:23:09 INFO - 2015-12-18 00:23:09,323 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:23:09 INFO - 2015-12-18 00:23:09,323 DEBUG : BROWSER_OUTPUT: __start_cc_report 00:23:09 INFO - 2015-12-18 00:23:09,324 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 00:23:09 INFO - 2015-12-18 00:23:09,324 DEBUG : BROWSER_OUTPUT: __end_cc_report 00:23:09 INFO - 2015-12-18 00:23:09,324 DEBUG : BROWSER_OUTPUT: __startTimestamp1450426989318__endTimestamp 00:23:09 INFO - 2015-12-18 00:23:09,324 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,332 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:23:09 INFO - 2015-12-18 00:23:09,332 DEBUG : BROWSER_OUTPUT: Number of tests: 14 00:23:09 INFO - 2015-12-18 00:23:09,332 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,332 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.40 Median:113.00 stddev:4.40 (3.9%) stddev-sans-first:4.57 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: Values: 113.0 113.0 106.0 111.0 114.0 112.0 105.0 114.0 114.0 102.0 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.20 Median:158.50 stddev:19.63 (12.4%) stddev-sans-first:20.62 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: Values: 158.0 130.0 161.0 162.0 130.0 154.0 159.0 130.0 188.0 130.0 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 160.0 162.0 164.0 161.0 162.0 162.0 161.0 163.0 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.10 Median:73.50 stddev:12.86 (17.5%) stddev-sans-first:13.21 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 84.0 92.0 72.0 73.0 74.0 110.0 90.0 72.0 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.80 Median:94.00 stddev:22.32 (23.7%) stddev-sans-first:23.11 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 131.0 94.0 94.0 95.0 141.0 94.0 94.0 147.0 00:23:09 INFO - 2015-12-18 00:23:09,333 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.50 stddev:0.67 (0.6%) stddev-sans-first:0.67 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 110.0 110.0 110.0 108.0 109.0 109.0 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 147.0 147.0 146.0 148.0 147.0 146.0 146.0 148.0 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 94.0 95.0 97.0 95.0 95.0 95.0 95.0 96.0 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.30 Median:70.50 stddev:3.23 (4.6%) stddev-sans-first:3.40 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 70.0 70.0 70.0 71.0 72.0 80.0 69.0 69.0 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:1.66 (2.4%) stddev-sans-first:1.72 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 73.0 69.0 68.0 69.0 68.0 68.0 71.0 69.0 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,334 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.00 stddev:1.14 (1.4%) stddev-sans-first:0.60 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: Values: 85.0 82.0 82.0 81.0 81.0 82.0 82.0 83.0 82.0 82.0 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:122.00 stddev:3.88 (3.2%) stddev-sans-first:4.06 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: Values: 120.0 122.0 119.0 131.0 118.0 121.0 122.0 118.0 125.0 122.0 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.50 Median:144.50 stddev:6.17 (4.3%) stddev-sans-first:6.08 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: Values: 134.0 133.0 143.0 146.0 148.0 134.0 145.0 145.0 144.0 133.0 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:69.00 stddev:3.25 (4.7%) stddev-sans-first:3.42 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 71.0 69.0 70.0 79.0 68.0 69.0 69.0 68.0 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:23:09 INFO - 2015-12-18 00:23:09,335 DEBUG : BROWSER_OUTPUT: 00:23:10 INFO - 2015-12-18 00:23:10,625 INFO : Browser exited with error code: 0 00:23:10 INFO - 2015-12-18 00:23:10,676 INFO : Completed test kraken (00:01:02) 00:23:10 INFO - 2015-12-18 00:23:10,676 INFO : Starting test v8_7 00:23:10 INFO - 2015-12-18 00:23:10,676 DEBUG : operating with platform_type : linux_ 00:23:10 INFO - 2015-12-18 00:23:10,677 INFO : Initialising browser for v8_7 test... 00:23:10 INFO - 2015-12-18 00:23:10,683 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ7X2rC/profile http://localhost:45515/getInfo.html 00:23:15 INFO - 2015-12-18 00:23:15,858 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:23:15 INFO - 2015-12-18 00:23:15,859 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:23:15 INFO - 2015-12-18 00:23:15,859 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:23:15 INFO - 2015-12-18 00:23:15,859 DEBUG : BROWSER_OUTPUT: __metrics 00:23:16 INFO - 2015-12-18 00:23:16,056 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] 00:23:16 INFO - 2015-12-18 00:23:16,112 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] 00:23:17 INFO - 2015-12-18 00:23:17,153 INFO : Browser initialized. 00:23:17 INFO - 2015-12-18 00:23:17,154 INFO : Running cycle 1/1 for v8_7 test... 00:23:17 INFO - 2015-12-18 00:23:17,154 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ7X2rC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:23:29 INFO - 2015-12-18 00:23:29,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 150302720 00:23:29 INFO - 2015-12-18 00:23:29,141 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,503 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45515/tests/v8_7/run.html (next: http://localhost:45515/tests/v8_7/run.html) 00:23:50 INFO - 2015-12-18 00:23:50,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 450387968 00:23:50 INFO - 2015-12-18 00:23:50,753 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,755 DEBUG : BROWSER_OUTPUT: __start_tp_report 00:23:50 INFO - 2015-12-18 00:23:50,755 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 00:23:50 INFO - 2015-12-18 00:23:50,755 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 00:23:50 INFO - 2015-12-18 00:23:50,755 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 00:23:50 INFO - 2015-12-18 00:23:50,755 DEBUG : BROWSER_OUTPUT: |0;Richards;165.56291390728478 00:23:50 INFO - 2015-12-18 00:23:50,756 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;187.72292096865027 00:23:50 INFO - 2015-12-18 00:23:50,756 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.31895352073474 00:23:50 INFO - 2015-12-18 00:23:50,756 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5207.253886010362 00:23:50 INFO - 2015-12-18 00:23:50,756 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1978.2608695652175 00:23:50 INFO - 2015-12-18 00:23:50,756 DEBUG : BROWSER_OUTPUT: |5;Earley;792.3930269413629 00:23:50 INFO - 2015-12-18 00:23:50,757 DEBUG : BROWSER_OUTPUT: |6;Boyer;12120.481927710844 00:23:50 INFO - 2015-12-18 00:23:50,757 DEBUG : BROWSER_OUTPUT: |7;RegExp;27270.27027027027 00:23:50 INFO - 2015-12-18 00:23:50,757 DEBUG : BROWSER_OUTPUT: |8;Splay;608.6427267194157 00:23:50 INFO - 2015-12-18 00:23:50,757 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 00:23:50 INFO - 2015-12-18 00:23:50,758 DEBUG : BROWSER_OUTPUT: __end_tp_report 00:23:50 INFO - 2015-12-18 00:23:50,758 DEBUG : BROWSER_OUTPUT: __startTimestamp1450427030753__endTimestamp 00:23:50 INFO - 2015-12-18 00:23:50,758 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,758 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 00:23:50 INFO - 2015-12-18 00:23:50,759 DEBUG : BROWSER_OUTPUT: Number of tests: 10 00:23:50 INFO - 2015-12-18 00:23:50,759 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,759 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.56 Median:165.56 stddev:0.00 (0.0%) 00:23:50 INFO - 2015-12-18 00:23:50,761 DEBUG : BROWSER_OUTPUT: Values: 165.6 00:23:50 INFO - 2015-12-18 00:23:50,761 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,761 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:187.72 Median:187.72 stddev:0.00 (0.0%) 00:23:50 INFO - 2015-12-18 00:23:50,761 DEBUG : BROWSER_OUTPUT: Values: 187.7 00:23:50 INFO - 2015-12-18 00:23:50,761 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,762 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 00:23:50 INFO - 2015-12-18 00:23:50,762 DEBUG : BROWSER_OUTPUT: Values: 278.3 00:23:50 INFO - 2015-12-18 00:23:50,762 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,762 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5207.25 Median:5207.25 stddev:0.00 (0.0%) 00:23:50 INFO - 2015-12-18 00:23:50,762 DEBUG : BROWSER_OUTPUT: Values: 5207.3 00:23:50 INFO - 2015-12-18 00:23:50,763 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,763 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 00:23:50 INFO - 2015-12-18 00:23:50,763 DEBUG : BROWSER_OUTPUT: Values: 1978.3 00:23:50 INFO - 2015-12-18 00:23:50,763 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,763 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.39 Median:792.39 stddev:0.00 (0.0%) 00:23:50 INFO - 2015-12-18 00:23:50,764 DEBUG : BROWSER_OUTPUT: Values: 792.4 00:23:50 INFO - 2015-12-18 00:23:50,764 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,764 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12120.48 Median:12120.48 stddev:0.00 (0.0%) 00:23:50 INFO - 2015-12-18 00:23:50,764 DEBUG : BROWSER_OUTPUT: Values: 12120.5 00:23:50 INFO - 2015-12-18 00:23:50,764 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,765 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27270.27 Median:27270.27 stddev:0.00 (0.0%) 00:23:50 INFO - 2015-12-18 00:23:50,765 DEBUG : BROWSER_OUTPUT: Values: 27270.3 00:23:50 INFO - 2015-12-18 00:23:50,765 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,765 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:608.64 Median:608.64 stddev:0.00 (0.0%) 00:23:50 INFO - 2015-12-18 00:23:50,765 DEBUG : BROWSER_OUTPUT: Values: 608.6 00:23:50 INFO - 2015-12-18 00:23:50,765 DEBUG : BROWSER_OUTPUT: 00:23:50 INFO - 2015-12-18 00:23:50,765 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 00:23:50 INFO - 2015-12-18 00:23:50,765 DEBUG : BROWSER_OUTPUT: Values: 4840.6 00:23:50 INFO - 2015-12-18 00:23:50,765 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 00:23:50 INFO - 2015-12-18 00:23:50,766 DEBUG : BROWSER_OUTPUT: 00:23:51 INFO - 2015-12-18 00:23:51,633 INFO : Browser exited with error code: 0 00:23:51 INFO - 2015-12-18 00:23:51,645 INFO : Completed test v8_7 (00:00:40) 00:23:51 INFO - 2015-12-18 00:23:51,805 INFO : Completed test suite (00:20:22) 00:23:51 INFO - 2015-12-18 00:23:51,805 DEBUG : Working with test: dromaeo_css 00:23:51 INFO - 2015-12-18 00:23:51,805 DEBUG : Generating results file: dromaeo_css 00:23:51 INFO - 2015-12-18 00:23:51,806 DEBUG : Working with test: kraken 00:23:51 INFO - 2015-12-18 00:23:51,807 DEBUG : Generating results file: kraken 00:23:51 INFO - 2015-12-18 00:23:51,807 INFO : javascript benchmark 00:23:51 INFO - 2015-12-18 00:23:51,807 DEBUG : Working with test: v8_7 00:23:51 INFO - 2015-12-18 00:23:51,807 DEBUG : Generating results file: v8_7 00:23:51 INFO - 2015-12-18 00:23:51,808 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:23:51 INFO - 2015-12-18 00:23:51,871 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 00:23:51 INFO - 2015-12-18 00:23:51,871 DEBUG : process_Request line: dromaeo_css 6297.52 graph.html#tests=[[72,203,35]] 00:23:51 INFO - 2015-12-18 00:23:51,871 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:23:51 INFO - 2015-12-18 00:23:51,899 DEBUG : process_Request line: kraken 1517.80 graph.html#tests=[[232,203,35]] 00:23:51 INFO - 2015-12-18 00:23:51,899 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 00:23:51 INFO - 2015-12-18 00:23:51,928 DEBUG : process_Request line: v8_7 19756.70 graph.html#tests=[[230,203,35]] 00:23:51 INFO - 2015-12-18 00:23:51,930 INFO : javascript benchmark 00:23:51 INFO - 2015-12-18 00:23:51,933 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2606.1530002749105, 2719.796015298853, 2719.877605507752, 2734.453109378124, 2737.11043910729, 4512.187806194884, 4656.4877863434995, 4665.860024199271, 4722.763861806904, 4753.191957367248, 4593.540645935404, 4668.089722504113, 4685.882852928678, 4725.787339569719, 4843.878903027426, 4330.696851220416, 4339.32740425233, 4346.956530434694, 4485.2599321111975, 4487.865364039084, 4422.18189634917, 4482.350059241408, 4493.46078470584, 4500.842470513517, 4541.750203738793, 4168.937465937998, 4232.703710740249, 4272.4445822042935, 4277.700560960734, 4346.739195648272, 4375.7155784873885, 4376.452943382077, 4387.583179597933, 4387.670924680661, 4412.801423935931, 4352.673549483801, 4352.7605981670995, 4370.0, 4395.252807022814, 4403.009322902353, 4536.206163921301, 4559.270516717309, 4649.674522783406, 4652.930206046912, 4680.859574212779, 5079.060373830853, 5084.77118529667, 5089.923651145235, 5103.362079740033, 5126.5898728101665, 5086.821961231376, 5090.541851233407, 5091.032703786269, 5098.770555325019, 5138.3833939927445, 4514.164879497303, 4613.1004454131125, 4613.723176609415, 4721.763911804396, 4858.46556878743, 5211.42674305826, 5232.816851410183, 5270.5256526912, 5271.367435907716, 5273.894522109536, 5039.798408063636, 5046.1169295373165, 5047.671901326402, 5053.7220452875445, 5064.873378165502, 4868.050730107666, 4969.453360130383, 4974.651774375831, 4984.601231901439, 4987.725675087905, 5044.0, 5054.039732450822, 5059.8988020239385, 5064.063148317573, 5076.36545431821, 5000.0, 5006.123928312531, 5008.098542262428, 5015.523525265094, 5048.268001139814, 4127.772972486482, 4291.570842915684, 4292.441982542312, 4293.8711838644895, 4331.263685173528, 3653.598104208535, 3721.8697345592773, 3730.7948062856262, 3754.6245375462236, 3762.435634654769, 4403.779811009436, 4427.800748966304, 4429.911401772011, 4432.468103827561, 4477.126960242721, 4860.95139048605, 4993.251012348177, 5139.049275883974, 5156.020356132323, 5159.0, 4291.077418355068, 4360.345948107746, 4370.606645401929, 4405.0, 4423.424954755861, 4530.093981203772, 4554.225781617133, 4560.908781824345, 4561.338605902126, 4601.539846015372, 4669.836555720533, 4815.638827087912, 4827.25177597473, 4831.202851529599, 4865.513448655177, 4921.26181072842, 4959.677620954626, 4991.975040124777, 5031.597472202288, 5053.4946505350645, 4763.7141771493825, 4766.380370551806, 4767.690100143618, 4805.711657300573, 4817.0365926814075, 4812.374391329105, 4944.184209605375, 4956.033573453142, 4999.0501804657, 5001.199808030698, 4886.29148773433, 4967.279744437109, 5024.6231532634465, 5025.271335656383, 5037.722925239147, 4856.854294371175, 4925.975370123127, 4928.630352723489, 4937.901241975069, 4977.850664480072, 4758.381410416624, 4924.606031517542, 4931.112399768076, 4938.580220681139, 4942.3327850741125, 4722.338872557776, 4774.809007639656, 4798.49615790337, 4805.063012712488, 4857.514248575114, 4955.6531042826655, 4964.230544265644, 4979.278004689372, 4983.053219888209, 5016.498350164954, 4645.954660201428, 4879.292502587176, 4894.975525122351, 4902.607791376753, 4952.950470495249], "unit": "score", "name": "dojo.html", "value": 4642.2142455933}, {"lowerIsBetter": false, "replicates": [569.9686517241553, 574.8332983434805, 578.2627150383258, 578.9768409263629, 581.9388964158763, 27602.34385936845, 36476.0, 36652.0, 36736.44895326566, 36769.44845827312, 40140.59859401405, 40617.39073913894, 40710.796446017805, 40828.18343633126, 40888.18223635526, 6934.68793904273, 7065.646717664122, 7898.644560994769, 8076.192380761906, 8081.676732930676, 10289.845652315222, 10546.947265263701, 10550.15598752098, 10551.84172237417, 10555.050045495904, 10063.949680251588, 10193.643222487215, 10205.183585313158, 10210.132138768176, 10212.336198147133, 7001.579905205678, 7139.107611548557, 7142.2857714228685, 7144.857102857914, 10117.291789574732, 7117.75087871922, 9945.353552019167, 10163.847542286872, 10166.796664066751, 10175.84736228957, 36380.0, 36787.08032299214, 36799.632003679886, 36844.078898027496, 36901.0, 2835.4470878178763, 2850.3016760893715, 2878.668953070403, 2899.1012786036395, 2939.412117576493, 28330.85834570814, 28523.429531409463, 28543.429131417462, 28601.85699071512, 29163.562546561818, 3281.8030918144987, 3481.5125882376487, 3483.9129021774406, 3502.579690437138, 3583.5878873929573, 216122.0, 217974.0, 219677.0, 219979.0, 220132.0, 52026.21960670593, 53434.198487022724, 56475.0, 56796.0, 56846.0, 65242.67378663171, 66586.0, 66864.66567667227, 66866.33133668698, 66982.33017669761, 12740.617781466572, 12934.223946563236, 12940.029497787704, 12945.482180712666, 12954.222746635232, 9411.43531388119, 9416.95291523538, 9475.28935329853, 9476.194523465445, 9481.668141615148, 19211.451657148726, 19465.51336216606, 19589.608207835765, 19695.704564431544, 19698.0, 7712.884306735404, 7836.608169591497, 7859.214078592095, 7902.288794008567, 7988.400869934778, 876.1763941894599, 877.1798368525449, 907.3739120007174, 920.59953920045, 1067.6263307842348, 26914.0, 30084.84957575198, 30868.0, 30982.690173098432, 31242.687573124433, 936.6159874451442, 964.6864768950119, 966.8018056298442, 993.4982833668951, 1033.8707661542308, 15499.14754688503, 16079.196040197943, 16167.514974550548, 16228.432004879773, 16310.056506183902, 307245.0, 312616.0, 313769.0, 314023.0, 317200.0, 47622.0, 47888.28167577489, 48169.518304817204, 48244.27633585499, 48268.0, 1066.8559744434401, 1072.469127781753, 1139.0773473486502, 1191.773563023023, 1195.354508565365, 24794.876025619757, 25560.0, 26079.478410431304, 26359.868200658875, 26507.33731656724, 36198.8190059048, 36347.27305453929, 36868.81565592155, 36919.0, 37135.25729485449, 230399.0, 234653.0, 236074.0, 236629.0, 237411.0, 27377.452450951267, 27576.586351204347, 27796.30509237285, 27834.304142396602, 27837.0, 34900.301993960486, 35660.821695891354, 36135.63864361323, 36220.456693150154, 39021.80489097536, 33490.665093348754, 38019.80990095032, 38872.41691374575, 39382.0, 39981.40027899526, 32544.674553254164, 32656.03990782834, 32717.18207044843, 32767.672323277417, 33092.83453582717, 32837.34325313433, 33078.0, 33340.0, 33388.0, 33617.83191084127, 29442.558361624164, 29711.85144074266, 30065.39185574195, 30361.544576830922, 30432.695673043872, 22975.425614359774, 23439.88280058589, 23476.0, 25219.621705674796, 25382.49235015326], "unit": "score", "name": "ext.html", "value": 17320.7026242996}, {"lowerIsBetter": false, "replicates": [316.41971097037026, 327.54961927349893, 330.6924560159052, 334.09293767421445, 336.3978478523442, 12201.450934707937, 12537.498500059986, 15051.698966020673, 15236.1620110894, 15566.766498502531, 11585.131115166354, 14730.705385892275, 15101.244937753123, 15527.922360388182, 15528.145951972638, 4887.095887260851, 4889.315495830578, 5008.424031236418, 5009.44896061433, 5016.824411145611, 3772.3398405279104, 3894.240623078501, 4938.678985865908, 4991.850244492671, 5584.720763961806, 5730.627509211909, 5732.7133643317875, 5751.194832723422, 5751.309842818868, 5753.5397168226655, 5571.4428557144165, 5646.40712725162, 5648.63283886546, 5650.660960342392, 5719.313682358123, 4871.464138944713, 4912.582430493377, 4913.140200464904, 4914.11545921734, 4938.209886418156, 19221.61556768857, 19307.710384344246, 19745.308914188077, 19963.700544491698, 20021.799782002287, 1818.1727314072198, 1869.0748079700636, 1931.304730297092, 1957.451913464218, 1963.3226536844766, 12512.186707863959, 12874.806877896839, 12875.871241287654, 12926.353682315847, 13173.60479185626, 1706.300416829094, 1729.4033558422325, 1742.2421246757701, 1744.8080711121765, 1808.3941879470394, 51051.48948510542, 51899.22151167736, 54892.0, 59334.40665593332, 60923.695381523255, 9449.90550094504, 9728.0, 9828.508574571242, 9845.163161131384, 9872.851907221397, 12585.622431327074, 12604.054695897845, 12612.558560450523, 12617.053720970964, 12620.24278543272, 6566.540342176002, 6567.704453299613, 6814.0, 6857.27998560154, 6967.616781077089, 6179.0, 6220.906686399708, 6228.159198508234, 6245.469135123474, 6270.9372906270355, 3973.900652483711, 4032.274190645653, 4163.875083747493, 4191.140816132746, 4196.139791342767, 1622.7403615421476, 1653.4874189001448, 1664.4923298394106, 1672.197345274251, 1749.9387521436943, 838.4969018588798, 862.9741107766777, 894.8031433084711, 901.7970956534728, 912.2610685344891, 14490.492832750802, 14531.491397801026, 14992.775108373384, 15072.698546029018, 15089.773653395208, 789.313297431227, 848.7368915636173, 849.7875531117221, 874.8031692869054, 931.417863835103, 9030.593623286968, 9366.438013719198, 9386.108319709616, 9481.24150067993, 9682.90317096834, 456515.0, 469882.0, 469999.0, 471381.0, 479600.0, 73798.63100684462, 74174.25825741781, 75057.6247118761, 75718.0, 76007.0, 1058.4125810175426, 1058.9046985771163, 1070.3256948122632, 1091.252492042953, 1095.1786160379716, 14734.705305893607, 14811.333489992761, 14955.700885982002, 15081.24593770329, 15124.773128403303, 34100.65899340975, 34200.65799342074, 34654.0, 34673.50215936454, 34852.825735871156, 44626.0, 44907.0, 45286.32070518879, 46210.0, 48100.0, 8187.058488273925, 8346.874796878174, 8400.0, 8849.69026084084, 8948.060453652533, 15703.13632750164, 16018.919905400398, 16181.919090404472, 16382.508524744277, 16423.0, 13412.061155719006, 13530.120542164728, 13701.794473082713, 14063.437462501795, 14202.431902723776, 13385.598432047054, 13490.0, 13628.93185534066, 13947.651308717363, 14027.438902443788, 11014.229003969645, 13201.801972970605, 13778.448862045807, 14057.01600887928, 14167.787483187967, 7862.803429914069, 8227.71203007892, 8287.212714792086, 8287.378446616407, 8410.453320534145, 10777.353358798497, 13421.32893355348, 13441.193528388329, 13856.653583660489, 14010.089344192595], "unit": "score", "name": "jquery.html", "value": 8339.340218635854}, {"lowerIsBetter": false, "replicates": [1496.4238768074288, 1613.07248332209, 1679.4289941419918, 1700.3793615330408, 1742.2769550636488, 6145.877082458359, 6258.468030217426, 6508.57694249874, 6994.615296158716, 7002.789916302513, 6477.5789573677675, 6672.833179170523, 6737.663116844163, 6751.932480675204, 6808.2851300613465, 1964.3615824856872, 1997.7502812148482, 1998.530345368837, 1999.0604415924565, 2000.7499062617173, 1749.8775085744003, 1792.3637108826374, 1793.6412717456496, 1794.5065107095522, 2016.6974953756908, 1982.058522201957, 2020.2020202020194, 2021.231931865889, 2023.6357455657976, 2030.6852437872153, 1881.868269221155, 1883.9058047097658, 1899.3542195653474, 1903.4860587641328, 1935.8965389727862, 2083.5832833433374, 2109.778473260301, 2110.989445052765, 2114.8413868959738, 2116.7777383374832, 7245.963770181115, 7316.158641756213, 7320.048393708784, 7328.3038111379865, 7328.3770879475305, 4009.3585026395635, 4111.814968326403, 4123.711340206187, 4124.938125928114, 4126.66986641071, 2585.2244326701916, 2655.0441840937247, 2674.61218123371, 2691.596260560912, 2696.9460610787673, 808.2362167751477, 808.6967387229789, 823.7981694484889, 832.5712258187039, 850.5662112322698, 9694.17599504043, 9705.126538611488, 9706.70879873605, 9725.173360264385, 9774.51127443625, 3730.347189241872, 3809.104860357814, 3820.121372084436, 3828.1769419574925, 3888.0474283800086, 8391.748247552583, 8424.199701028392, 8440.15598440151, 8440.873386899202, 8441.409101362846, 4119.773412462283, 4124.731892426983, 4139.110091330378, 4148.439960605279, 4151.252774500558, 3775.2638235543805, 3777.660010599059, 3777.9244415112094, 3779.7921114338424, 3781.6029316921326, 3190.8564114614896, 3256.6580509046685, 3277.6394596594355, 3279.1638132276594, 3286.6549012353835, 922.9939366090858, 1045.038564520643, 1048.695878195315, 1060.0565496707936, 1060.6923992042375, 876.9649214031494, 903.6385445821724, 927.698497988143, 1011.6863772230632, 1209.4980583057932, 6507.934920650828, 6560.967195163994, 6578.76974305897, 6583.045458408504, 6597.30728273534, 921.3044151665583, 1030.7989941961396, 1048.727330893973, 1055.5355643516828, 1078.9480256749607, 5210.843674689765, 5245.737713114329, 5257.132573125468, 5283.286756287852, 5284.180951952453, 8209.671613135408, 8535.402521823537, 8560.0583935767, 8566.82866342682, 8570.571471426403, 8322.8335433291, 8333.083360830304, 8395.62219700115, 8429.367797415218, 8465.449745766506, 6601.0, 6625.271220165778, 6761.526693131434, 6796.72813087471, 6845.14435695538, 6537.182852143482, 6541.116949211986, 6551.836204094936, 6562.606243625398, 6577.2436169841085, 7537.283958023979, 7621.733239336597, 7729.381649467917, 7778.961105194438, 7801.921980780119, 7550.509216900884, 7717.729879454192, 7737.961310193413, 7738.690452382067, 7903.802404939923, 5660.801871934463, 5835.591508594358, 5885.852853678693, 5892.263467066617, 5907.113932910098, 6601.768938087336, 6957.4086202671315, 6971.651417429007, 6974.79075627732, 6975.476839236976, 5586.860328491658, 6513.89363313664, 6547.770828020996, 6555.934440655532, 6640.50196235294, 5546.0, 6173.1666225060835, 6205.131281620667, 6231.9688401557705, 6489.5781774184525, 6198.535109866688, 6693.364130407604, 6731.360520750521, 6734.023566582916, 6735.4274886635185, 5894.322152952465, 5906.704664766658, 5919.644821310735, 5932.881342373042, 5946.167536544974, 6084.513238940963, 6087.269527656709, 6101.145839582373, 6121.84695382619, 6147.0779383092895], "unit": "score", "name": "mootools.html", "value": 4019.827854245081}, {"lowerIsBetter": false, "replicates": [278.7045731524584, 282.3942643030698, 283.69786177720727, 286.0859553725845, 286.48432820922335, 5335.1997200419855, 5342.91985620216, 5381.946180538193, 5384.219288203209, 5384.703841288728, 5309.495597918201, 5317.734113294339, 5329.387120481146, 5333.173358129487, 5336.786528538853, 4102.630763231308, 4118.546959834416, 4120.5879412058775, 4124.855630052949, 4127.17456508698, 3917.334053210947, 3985.6811455083525, 4008.5390180129366, 4084.7957602119923, 4104.97947510262, 4048.9392659110135, 4066.9796651016704, 4068.308387574105, 4072.552019277877, 4076.7553946763287, 3863.420486926955, 4044.858429954967, 4047.1096358801165, 4055.3308704063793, 4068.7151899367054, 3489.773164744309, 3495.807730574843, 3570.910872183983, 3580.337637537038, 3580.5524309461316, 5156.974215128937, 5159.7678104485385, 5173.042987047408, 5179.2749015137915, 5188.507091826271, 4704.882377940545, 4716.2454007359, 4716.716996980193, 4719.787609557578, 4724.716517008956, 5455.399906010336, 5618.15727640853, 5619.971900140473, 5632.887342253132, 5633.0, 3914.354131568288, 3915.158240978175, 3919.627635374635, 3920.705947053954, 3924.646781789653, 5838.328592211865, 5945.286565612111, 5953.910691339634, 5956.225690660186, 5966.552508561832, 3970.305196590585, 3972.066564357374, 3973.562908080109, 3973.7019723520852, 3996.4205190247253, 4067.0, 4073.674106071507, 4075.655033838826, 4078.5921407858978, 4080.1227736036894, 4165.937510937339, 4335.241332766753, 4437.112577484516, 4548.158590660738, 4587.449506059294, 5521.929276521305, 5665.943340566541, 5672.432756724294, 5673.971630141823, 5674.77300907959, 1411.5976946570179, 1424.4159894443228, 1425.3016022149072, 1425.5509514502899, 1427.0010992305429, 943.3443756589242, 946.3564775952418, 955.4935883981501, 974.2790335151936, 975.6829030565095, 4983.377077865267, 4984.950150498521, 4993.17612593918, 4995.575376093073, 5001.124803159432, 5888.823335299948, 5893.793717219963, 5894.764209431661, 5897.52819774417, 5903.616264942765, 4945.653804233741, 4976.726280054631, 4980.352554167935, 4983.654413308386, 4984.028114517707, 3048.8628011739524, 3083.2137804859617, 3132.6710695377114, 3158.589383380146, 3164.493681011073, 5436.945630543644, 5503.504684578407, 5508.944910550843, 5578.776848926079, 5589.105743081088, 6062.42406971337, 6067.998780201306, 6069.51443884497, 6072.453479186806, 6076.058210977306, 5570.470805273492, 5572.3870374258795, 5573.247611572467, 5576.665400076008, 5576.9163462548095, 5764.106563482667, 5885.823425297248, 5943.762249509971, 5950.137230101697, 5968.22413086296, 5794.420557944172, 5799.217105690678, 5806.593538452268, 5806.912896306474, 5807.332156802022, 5613.158026296088, 5622.662640241599, 5624.100143976944, 5627.099664053731, 5630.352509461464, 3746.494223279822, 3896.9220615588097, 3924.3328634132836, 3934.0, 3939.822707978205, 5891.1752354671235, 5892.558058145742, 5902.61632993854, 5904.704764761659, 5904.940950590611, 5658.349289831722, 5666.886662266814, 5668.574856885668, 5671.064274394678, 5671.461211184931, 5606.579506536945, 5632.408597097246, 5638.2670252866865, 5645.915311270416, 5647.1529270609735, 5398.082326004667, 5512.586556008235, 5517.282753242052, 5518.255035570147, 5524.33707955048, 5665.830025099253, 5672.234248376416, 5672.517835983987, 5672.943270567242, 5677.205191273142, 5519.227308176939, 5527.613067085265, 5540.501354878081, 5547.2233887256625, 5557.221988921635], "unit": "score", "name": "prototype.html", "value": 4203.758381851398}, {"lowerIsBetter": false, "replicates": [671.6977360187914, 693.348252642516, 731.6341829085458, 740.429869000869, 747.0810902589815, 11262.831057534133, 11548.3648399338, 11550.59572914947, 12319.322437265946, 12886.355682215875, 12179.147459677826, 12224.694382640417, 12227.388630568481, 12230.082743794228, 12243.081768867349, 637.1907677249912, 647.5531883000715, 791.3708601661664, 806.3307454812492, 806.7095845495617, 791.3945831438954, 796.3072127249301, 799.2886331165267, 806.4314658166008, 806.6612022950345, 846.3525403066628, 849.1720572441851, 849.8555245608261, 849.9872501912477, 851.3614788908319, 659.4427708586237, 670.2660586657602, 829.402829962426, 838.7986883148031, 844.1558441558442, 627.9905801412982, 628.1990462160736, 628.71707731521, 628.8144997225829, 629.0093103362177, 11302.208845380826, 11375.146863985152, 11383.487743051583, 11386.71533211668, 11390.544378224944, 10528.894711052868, 10886.40124793136, 11031.669049928514, 11032.779344413148, 11044.061254793352, 9224.446533207962, 9256.72229833106, 9283.210927071206, 9326.253899688008, 9506.47714375709, 3107.9533806992913, 3128.9217769555717, 3129.155128115419, 3176.126565194567, 3194.4409728297687, 38049.04877378088, 38198.42702359467, 38378.80810595985, 38510.0, 38551.42172867409, 8926.285897128344, 8946.284297256203, 8973.0, 8979.775505612412, 9046.683366082156, 15669.451569195024, 15743.842561574467, 15811.841881581267, 15813.209339532978, 15831.68336633284, 6225.501959843202, 6399.64801935898, 6515.413612774873, 6547.541672082908, 6722.29415911332, 3601.2077342984503, 3679.0986208379118, 3699.112213068844, 3734.9066273343383, 3756.436534519844, 2378.167641325557, 2403.0267741564694, 2405.4948460823075, 2407.0973384980634, 2407.3981504623844, 432.4119197890866, 432.7144084903948, 434.0689221619608, 446.62483513848525, 450.8940399006231, 430.9935350969738, 434.548070007189, 472.30806867938634, 596.5853731656457, 598.796409220867, 6990.4757143214465, 7524.172341042481, 7539.32146106853, 7616.771496855104, 7816.53100813953, 454.43876812136983, 455.4853016091795, 463.87243508034885, 517.64541289217, 530.8672831792052, 3346.6486018967657, 3476.913077173091, 3478.217401084786, 3525.494483649767, 3552.626974167727, 46623.0, 47251.76374118107, 47342.76328618404, 47619.0, 47777.522224778004, 43194.56805431968, 43266.56733432625, 46641.76679116583, 47001.0, 47487.0, 38386.232275354334, 38778.22443551113, 38988.80505597511, 39283.0, 39302.999999999425, 7001.684924178526, 7337.0, 7361.411087113125, 7677.539347639159, 7772.533647981139, 27887.721122788513, 27929.0, 31630.841845790623, 32172.678273217905, 32347.676523234466, 37423.625763743104, 38098.80950595229, 38156.427653584666, 38374.052021936644, 38998.80500597479, 9087.227585655293, 9346.906530934604, 9449.43303401798, 9480.431174129575, 9945.254105941938, 10433.197618552298, 10725.678229653124, 10781.568737250422, 10845.783084338427, 10896.945515272373, 9863.260255480724, 10239.590416383558, 10601.840972385266, 10687.51906164209, 10696.62561810333, 10166.593336266467, 10394.0, 10466.947665261625, 10657.360558366523, 10832.0, 9913.702588922344, 10220.284580079324, 10233.897661023295, 10573.312734672221, 10595.470226488798, 7783.844323113392, 7859.0, 7930.191207160109, 8112.0, 8113.0669972953865, 7938.722144724907, 8601.956990215009, 8698.478091314288, 8835.514046727492, 8945.284377249674], "unit": "score", "name": "yui.html", "value": 5504.2897711961705}], "name": "dromaeo_css", "value": 6297.516857181932}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 113.0, 106.0, 111.0, 114.0, 112.0, 105.0, 114.0, 114.0, 102.0], "unit": "score", "name": "ai-astar", "value": 110.4}, {"lowerIsBetter": true, "replicates": [158.0, 130.0, 161.0, 162.0, 130.0, 154.0, 159.0, 130.0, 188.0, 130.0], "unit": "score", "name": "audio-beat-detection", "value": 150.2}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 160.0, 162.0, 164.0, 161.0, 162.0, 162.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 92.0, 72.0, 73.0, 74.0, 110.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.1}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 131.0, 94.0, 94.0, 95.0, 141.0, 94.0, 94.0, 147.0], "unit": "score", "name": "audio-oscillator", "value": 107.8}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 108.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 146.0, 148.0, 147.0, 146.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 94.0, 95.0, 97.0, 95.0, 95.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [70.0, 72.0, 70.0, 70.0, 70.0, 71.0, 72.0, 80.0, 69.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 71.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 73.0, 69.0, 68.0, 69.0, 68.0, 68.0, 71.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 82.0, 81.0, 81.0, 82.0, 82.0, 83.0, 82.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [120.0, 122.0, 119.0, 131.0, 118.0, 121.0, 122.0, 118.0, 125.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [134.0, 133.0, 143.0, 146.0, 148.0, 134.0, 145.0, 145.0, 144.0, 133.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.5}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 69.0, 70.0, 79.0, 68.0, 69.0, 69.0, 68.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.1}], "name": "kraken", "value": 1517.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.56291390728478], "unit": "score", "name": "Richards", "value": 213.2240799999999}, {"lowerIsBetter": false, "replicates": [187.72292096865027], "unit": "score", "name": "DeltaBlue", "value": 352.210586}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5207.253886010362], "unit": "score", "name": "Decrypt", "value": 51.11734626865668}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [792.3930269413629], "unit": "score", "name": "Earley", "value": 841.0763060000003}, {"lowerIsBetter": false, "replicates": [12120.481927710844], "unit": "score", "name": "Boyer", "value": 54.9865099403579}, {"lowerIsBetter": false, "replicates": [27270.27027027027], "unit": "score", "name": "RegExp", "value": 33.405792864221986}, {"lowerIsBetter": false, "replicates": [608.6427267194157], "unit": "score", "name": "Splay", "value": 133.88971299999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19756.695086878186}]} 00:23:51 INFO - RETURN: dromaeo_css: 6297.52 00:23:51 INFO - RETURN: kraken: 1517.80 00:23:51 INFO - RETURN: v8_7: 19756.70 00:23:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19756.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1517.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6297.52"}}} 00:23:51 INFO - Return code: 0 00:23:52 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:23:52 ERROR - # TBPL SUCCESS # 00:23:52 INFO - Running post-action listener: _resource_record_post_action 00:23:52 INFO - Running post-run listener: _resource_record_post_run 00:23:53 INFO - Total resource usage - Wall time: 1240s; CPU: 13.0%; Read bytes: 0; Write bytes: 565084160; Read time: 0; Write time: 1279616 00:23:53 INFO - install - Wall time: 16s; CPU: 19.0%; Read bytes: 0; Write bytes: 243339264; Read time: 0; Write time: 741912 00:23:53 INFO - run-tests - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 321744896; Read time: 0; Write time: 537704 00:23:53 INFO - Running post-run listener: _upload_blobber_files 00:23:53 INFO - Blob upload gear active. 00:23:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 00:23:53 INFO - Copying logs to upload dir... 00:23:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1277.454286 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2015-12-18 00:23:52.781005) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 00:23:52.784885) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010012 build_url: 'https://queue.taskcluster.net/v1/task/pwiJj9kNSNCA5LbWXAzhkQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 00:23:52.836643) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 00:23:52.836969) ========= 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=2dd9ebcff44b3efbe7b51203000001d7-1450424613.4594-2067751396 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004533 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 00:23:52.886446) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 00:23:52.886762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 00:23:52.887060) ========= ========= Total master_lag: 0.25 =========