builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1450704273.32 results: success (0) buildid: 20151221045029 builduid: 1449aa4bd3844f20a522801294a8201c revision: 446a82134ef2a325e58f7fe749a1989c88335796 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.324318) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.324924) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.325465) ========= 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=820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006422 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.353376) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.353728) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.371290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.371598) ========= 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=820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004664 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.425274) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.425616) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.426067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.426390) ========= 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=820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-21 05:24: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.4M=0s 2015-12-21 05:24:33 (84.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167780 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.613644) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.614022) ========= 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=820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022140 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.665633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:33.666006) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 446a82134ef2a325e58f7fe749a1989c88335796 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 446a82134ef2a325e58f7fe749a1989c88335796 --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=820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-21 05:24:33,834 truncating revision to first 12 chars 2015-12-21 05:24:33,834 Setting DEBUG logging. 2015-12-21 05:24:33,834 attempt 1/10 2015-12-21 05:24:33,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/446a82134ef2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-21 05:24:34,135 unpacking tar archive at: fx-team-446a82134ef2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.602957 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:34.282673) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:34.283018) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:34.291618) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:34.291904) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-21 05:24:34.292333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-21 05:24:34.292679) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:24:34 INFO - MultiFileLogger online at 20151221 05:24:34 in /builds/slave/test 05:24:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:24:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:24:34 INFO - {'append_to_log': False, 05:24:34 INFO - 'base_work_dir': '/builds/slave/test', 05:24:34 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:24:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:24:34 INFO - 'branch': 'Fx-Team-Non-PGO', 05:24:34 INFO - 'buildbot_json_path': 'buildprops.json', 05:24:34 INFO - 'config_files': ('talos/linux_config.py',), 05:24:34 INFO - 'default_actions': ('clobber', 05:24:34 INFO - 'read-buildbot-config', 05:24:34 INFO - 'download-and-extract', 05:24:34 INFO - 'populate-webroot', 05:24:34 INFO - 'create-virtualenv', 05:24:34 INFO - 'install', 05:24:34 INFO - 'run-tests'), 05:24:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:24:34 INFO - 'download_minidump_stackwalk': True, 05:24:34 INFO - 'download_symbols': 'ondemand', 05:24:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:24:34 INFO - 'tooltool.py': '/tools/tooltool.py', 05:24:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:24:34 INFO - '/tools/misc-python/virtualenv.py')}, 05:24:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:24:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:24:34 INFO - 'installer_path': 'installer.exe', 05:24:34 INFO - 'log_level': 'info', 05:24:34 INFO - 'log_name': 'talos', 05:24:34 INFO - 'log_to_console': True, 05:24:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:24:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:24:34 INFO - 'opt_config_files': (), 05:24:34 INFO - 'pip_index': False, 05:24:34 INFO - 'sps_profile': False, 05:24:34 INFO - 'sps_profile_interval': 0, 05:24:34 INFO - 'suite': 'dromaeojs', 05:24:34 INFO - 'system_bits': '64', 05:24:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:24:34 INFO - 'title': 'talos-linux64-ix-055', 05:24:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:24:34 INFO - 'use_talos_json': True, 05:24:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:24:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:24:34 INFO - 'work_dir': 'build'} 05:24:34 INFO - ##### 05:24:34 INFO - ##### Running clobber step. 05:24:34 INFO - ##### 05:24:34 INFO - Running pre-action listener: _resource_record_pre_action 05:24:34 INFO - Running main action method: clobber 05:24:34 INFO - rmtree: /builds/slave/test/build 05:24:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:24:35 INFO - Running post-action listener: _resource_record_post_action 05:24:35 INFO - ##### 05:24:35 INFO - ##### Running read-buildbot-config step. 05:24:35 INFO - ##### 05:24:35 INFO - Running pre-action listener: _resource_record_pre_action 05:24:35 INFO - Running main action method: read_buildbot_config 05:24:35 INFO - Using buildbot properties: 05:24:35 INFO - { 05:24:35 INFO - "project": "", 05:24:35 INFO - "product": "firefox", 05:24:35 INFO - "script_repo_revision": "production", 05:24:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:24:35 INFO - "repository": "", 05:24:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:24:35 INFO - "buildid": "20151221045029", 05:24:35 INFO - "pgo_build": "False", 05:24:35 INFO - "basedir": "/builds/slave/test", 05:24:35 INFO - "buildnumber": 1037, 05:24:35 INFO - "slavename": "talos-linux64-ix-055", 05:24:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:24:35 INFO - "platform": "ubuntu64_hw", 05:24:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:24:35 INFO - "branch": "fx-team", 05:24:35 INFO - "repo_path": "integration/fx-team", 05:24:35 INFO - "revision": "446a82134ef2a325e58f7fe749a1989c88335796", 05:24:35 INFO - "stage_platform": "linux64", 05:24:35 INFO - "builduid": "1449aa4bd3844f20a522801294a8201c", 05:24:35 INFO - "slavebuilddir": "test" 05:24:35 INFO - } 05:24:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:24:35 INFO - Running post-action listener: _resource_record_post_action 05:24:35 INFO - ##### 05:24:35 INFO - ##### Running download-and-extract step. 05:24:35 INFO - ##### 05:24:35 INFO - Running pre-action listener: _resource_record_pre_action 05:24:35 INFO - Running main action method: download_and_extract 05:24:35 INFO - mkdir: /builds/slave/test/build/tests 05:24:35 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')]} 05:24:35 INFO - https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:24:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/test_packages.json 05:24:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/test_packages.json 05:24:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:24:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:24:44 INFO - Downloaded 1302 bytes. 05:24:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:24:44 INFO - Using the following test package requirements: 05:24:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:24:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:24:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:44 INFO - u'jsshell-linux-x86_64.zip'], 05:24:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:24:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:24:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:24:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:24:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:24:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:24:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:24:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:24:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:24:44 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')]} 05:24:44 INFO - https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/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 05:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/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 05:24:45 INFO - Downloaded 21926753 bytes. 05:24: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 05:24:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:24: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 05:24:46 INFO - Return code: 0 05:24:46 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 05:24: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')]} 05:24:46 INFO - https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:24:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:24:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:24:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/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 05:24:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/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 05:24:50 INFO - Downloaded 21926753 bytes. 05:24:50 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 05:24:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:24:50 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 05:24:51 INFO - Return code: 0 05:24: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')]} 05:24:51 INFO - https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:24:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:24:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:24:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/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 05:24:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/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 05:24:52 INFO - Downloaded 11132277 bytes. 05:24:52 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 05:24:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:24:52 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 05:24:52 INFO - Return code: 0 05:24:52 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')]} 05:24:52 INFO - https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:24:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:24:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:24:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/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 05:24:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/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 05:24:53 INFO - Downloaded 53385317 bytes. 05:24:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:24:53 INFO - mkdir: /builds/slave/test/properties 05:24:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:24:53 INFO - Writing to file /builds/slave/test/properties/build_url 05:24:53 INFO - Contents: 05:24:53 INFO - build_url:https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:24:53 INFO - Running post-action listener: _resource_record_post_action 05:24:53 INFO - Running post-action listener: set_extra_try_arguments 05:24:53 INFO - ##### 05:24:53 INFO - ##### Running populate-webroot step. 05:24:53 INFO - ##### 05:24:53 INFO - Running pre-action listener: _resource_record_pre_action 05:24:53 INFO - Running main action method: populate_webroot 05:24:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:24:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:24:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:24:53 INFO - '--tppagecycles', 05:24:53 INFO - '7'], 05:24:53 INFO - 'tests': ['tsvgm']}}, 05:24:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:24:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:24:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:24:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:24:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:24:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:24:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:53 INFO - 'talos_options': ['--e10s'], 05:24:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:24:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:53 INFO - 'tests': ['damp', 'tps']}, 05:24:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:53 INFO - 'talos_options': ['--e10s'], 05:24:53 INFO - 'tests': ['damp', 'tps']}, 05:24:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:24:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:24:53 INFO - 'other': {'tests': ['a11yr', 05:24:53 INFO - 'ts_paint', 05:24:53 INFO - 'tpaint', 05:24:53 INFO - 'sessionrestore', 05:24:53 INFO - 'sessionrestore_no_auto_restore']}, 05:24:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:24:53 INFO - 'tests': ['a11yr', 05:24:53 INFO - 'ts_paint', 05:24:53 INFO - 'tpaint', 05:24:53 INFO - 'sessionrestore', 05:24:53 INFO - 'sessionrestore_no_auto_restore']}, 05:24:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:24:53 INFO - 'tests': ['a11yr', 05:24:53 INFO - 'ts_paint', 05:24:53 INFO - 'tpaint', 05:24:53 INFO - 'sessionrestore', 05:24:53 INFO - 'sessionrestore_no_auto_restore']}, 05:24:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:24:53 INFO - 'tests': ['a11yr', 05:24:53 INFO - 'ts_paint', 05:24:53 INFO - 'tpaint', 05:24:53 INFO - 'sessionrestore', 05:24:53 INFO - 'sessionrestore_no_auto_restore']}, 05:24:53 INFO - 'other_l64': {'tests': ['a11yr', 05:24:53 INFO - 'ts_paint', 05:24:53 INFO - 'tpaint', 05:24:53 INFO - 'sessionrestore', 05:24:53 INFO - 'sessionrestore_no_auto_restore']}, 05:24:53 INFO - 'other_nol64': {'tests': ['a11yr', 05:24:53 INFO - 'ts_paint', 05:24:53 INFO - 'tpaint', 05:24:53 INFO - 'sessionrestore', 05:24:53 INFO - 'sessionrestore_no_auto_restore']}, 05:24:53 INFO - 'svgr': {'tests': ['tsvgx', 05:24:53 INFO - 'tsvgr_opacity', 05:24:53 INFO - 'tart', 05:24:53 INFO - 'tscrollx', 05:24:53 INFO - 'cart']}, 05:24:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:24:53 INFO - 'tests': ['tsvgx', 05:24:53 INFO - 'tsvgr_opacity', 05:24:53 INFO - 'tart', 05:24:53 INFO - 'tscrollx', 05:24:53 INFO - 'cart']}, 05:24:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:53 INFO - 'tests': ['tp5o']}, 05:24:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:53 INFO - 'talos_options': ['--e10s'], 05:24:53 INFO - 'tests': ['tp5o']}, 05:24:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:53 INFO - 'talos_options': ['--xperf_path', 05:24:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:53 INFO - 'tests': ['tp5n']}, 05:24:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:24:53 INFO - 'talos_options': ['--e10s', 05:24:53 INFO - '--xperf_path', 05:24:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:24:53 INFO - 'tests': ['tp5n']}}, 05:24:53 INFO - 'talos.zip': {'path': '', 05:24:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:24:53 INFO - Running post-action listener: _resource_record_post_action 05:24:53 INFO - ##### 05:24:53 INFO - ##### Running create-virtualenv step. 05:24:53 INFO - ##### 05:24:53 INFO - Running pre-action listener: _resource_record_pre_action 05:24:53 INFO - Running main action method: create_virtualenv 05:24:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:24:53 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 05:24:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:24:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:24:53 INFO - Using real prefix '/usr' 05:24:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:24:54 INFO - Installing distribute.............................................................................................................................................................................................done. 05:24:56 INFO - Installing pip.................done. 05:24:56 INFO - Return code: 0 05:24:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa9e1c04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, '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 0x15f2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3360>, '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': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', '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 05:24: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', 'pip>=1.5'] in /builds/slave/test/build 05:24: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 pip>=1.5 05:24:56 INFO - Using env: {'DISPLAY': ':0', 05:24:56 INFO - 'HOME': '/home/cltbld', 05:24:56 INFO - 'LANG': 'en_US.UTF-8', 05:24:56 INFO - 'LANGUAGE': 'en_US:en', 05:24:56 INFO - 'LOGNAME': 'cltbld', 05:24:56 INFO - 'MAIL': '/var/mail/cltbld', 05:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:56 INFO - 'MOZ_NO_REMOTE': '1', 05:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:56 INFO - 'NO_EM_RESTART': '1', 05:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:56 INFO - 'PWD': '/builds/slave/test', 05:24:56 INFO - 'SHELL': '/bin/bash', 05:24:56 INFO - 'SHLVL': '1', 05:24:56 INFO - 'TERM': 'linux', 05:24:56 INFO - 'TMOUT': '86400', 05:24:56 INFO - 'USER': 'cltbld', 05:24:56 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', 05:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:56 INFO - '_': '/tools/buildbot/bin/python'} 05:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:56 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 05:24:56 INFO - Cleaning up... 05:24:56 INFO - Return code: 0 05:24:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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', '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 0x7fa9e1c04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, '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 0x15f2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3360>, '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': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', '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 05:24: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', 'psutil>=0.7.1'] in /builds/slave/test/build 05:24: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 psutil>=0.7.1 05:24:56 INFO - Using env: {'DISPLAY': ':0', 05:24:56 INFO - 'HOME': '/home/cltbld', 05:24:56 INFO - 'LANG': 'en_US.UTF-8', 05:24:56 INFO - 'LANGUAGE': 'en_US:en', 05:24:56 INFO - 'LOGNAME': 'cltbld', 05:24:56 INFO - 'MAIL': '/var/mail/cltbld', 05:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:56 INFO - 'MOZ_NO_REMOTE': '1', 05:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:56 INFO - 'NO_EM_RESTART': '1', 05:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:56 INFO - 'PWD': '/builds/slave/test', 05:24:56 INFO - 'SHELL': '/bin/bash', 05:24:56 INFO - 'SHLVL': '1', 05:24:56 INFO - 'TERM': 'linux', 05:24:56 INFO - 'TMOUT': '86400', 05:24:56 INFO - 'USER': 'cltbld', 05:24:56 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', 05:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:56 INFO - '_': '/tools/buildbot/bin/python'} 05:24:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:56 INFO - Downloading/unpacking psutil>=0.7.1 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24: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 05:24:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:24:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:24:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:24:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:58 INFO - Installing collected packages: psutil 05:24:58 INFO - Running setup.py install for psutil 05:24:58 INFO - building 'psutil._psutil_linux' extension 05:24:58 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 05:24:58 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 05:24:58 INFO - building 'psutil._psutil_posix' extension 05:24:58 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 05:24:59 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 05:24:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:24:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:24:59 INFO - Successfully installed psutil 05:24:59 INFO - Cleaning up... 05:24:59 INFO - Return code: 0 05:24:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa9e1c04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, '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 0x15f2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3360>, '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': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', '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 05:24:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:24:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:24:59 INFO - Using env: {'DISPLAY': ':0', 05:24:59 INFO - 'HOME': '/home/cltbld', 05:24:59 INFO - 'LANG': 'en_US.UTF-8', 05:24:59 INFO - 'LANGUAGE': 'en_US:en', 05:24:59 INFO - 'LOGNAME': 'cltbld', 05:24:59 INFO - 'MAIL': '/var/mail/cltbld', 05:24:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:59 INFO - 'MOZ_NO_REMOTE': '1', 05:24:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:59 INFO - 'NO_EM_RESTART': '1', 05:24:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:59 INFO - 'PWD': '/builds/slave/test', 05:24:59 INFO - 'SHELL': '/bin/bash', 05:24:59 INFO - 'SHLVL': '1', 05:24:59 INFO - 'TERM': 'linux', 05:24:59 INFO - 'TMOUT': '86400', 05:24:59 INFO - 'USER': 'cltbld', 05:24:59 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', 05:24:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:59 INFO - '_': '/tools/buildbot/bin/python'} 05:24:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:24:59 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 05:24:59 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 05:24:59 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 05:24:59 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 05:24:59 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 05:24:59 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 05:25:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:25:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:25:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:25:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:25:01 INFO - Installing collected packages: mozsystemmonitor 05:25:01 INFO - Running setup.py install for mozsystemmonitor 05:25:01 INFO - Successfully installed mozsystemmonitor 05:25:01 INFO - Cleaning up... 05:25:01 INFO - Return code: 0 05:25:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:01 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 0x7fa9e1c04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, '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 0x15f2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3360>, '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': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', '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 05:25:01 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 05:25:01 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 05:25:01 INFO - Using env: {'DISPLAY': ':0', 05:25:01 INFO - 'HOME': '/home/cltbld', 05:25:01 INFO - 'LANG': 'en_US.UTF-8', 05:25:01 INFO - 'LANGUAGE': 'en_US:en', 05:25:01 INFO - 'LOGNAME': 'cltbld', 05:25:01 INFO - 'MAIL': '/var/mail/cltbld', 05:25:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:01 INFO - 'MOZ_NO_REMOTE': '1', 05:25:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:01 INFO - 'NO_EM_RESTART': '1', 05:25:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:01 INFO - 'PWD': '/builds/slave/test', 05:25:01 INFO - 'SHELL': '/bin/bash', 05:25:01 INFO - 'SHLVL': '1', 05:25:01 INFO - 'TERM': 'linux', 05:25:01 INFO - 'TMOUT': '86400', 05:25:01 INFO - 'USER': 'cltbld', 05:25:01 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', 05:25:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:01 INFO - '_': '/tools/buildbot/bin/python'} 05:25:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:01 INFO - Downloading/unpacking blobuploader==1.2.4 05:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:03 INFO - Downloading blobuploader-1.2.4.tar.gz 05:25:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:25:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:25:03 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 05:25:03 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 05:25:03 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 05:25:03 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 05:25:03 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 05:25:03 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 05:25:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:25:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:25:03 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 05:25:03 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 05:25:03 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 05:25:03 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 05:25:03 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 05:25:03 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 05:25:03 INFO - Downloading docopt-0.6.1.tar.gz 05:25:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:25:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:25:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:25:03 INFO - Running setup.py install for blobuploader 05:25:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:25:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:25:04 INFO - Running setup.py install for requests 05:25:04 INFO - Running setup.py install for docopt 05:25:04 INFO - Successfully installed blobuploader requests docopt 05:25:04 INFO - Cleaning up... 05:25:04 INFO - Return code: 0 05:25:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:04 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')]} 05:25:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:04 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')]} 05:25:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:04 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 0x7fa9e1c04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, '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 0x15f2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3360>, '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': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', '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 05:25:04 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 05:25:04 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 05:25:04 INFO - Using env: {'DISPLAY': ':0', 05:25:04 INFO - 'HOME': '/home/cltbld', 05:25:04 INFO - 'LANG': 'en_US.UTF-8', 05:25:04 INFO - 'LANGUAGE': 'en_US:en', 05:25:04 INFO - 'LOGNAME': 'cltbld', 05:25:04 INFO - 'MAIL': '/var/mail/cltbld', 05:25:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:04 INFO - 'MOZ_NO_REMOTE': '1', 05:25:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:04 INFO - 'NO_EM_RESTART': '1', 05:25:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:04 INFO - 'PWD': '/builds/slave/test', 05:25:04 INFO - 'SHELL': '/bin/bash', 05:25:04 INFO - 'SHLVL': '1', 05:25:04 INFO - 'TERM': 'linux', 05:25:04 INFO - 'TMOUT': '86400', 05:25:04 INFO - 'USER': 'cltbld', 05:25:04 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', 05:25:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:04 INFO - '_': '/tools/buildbot/bin/python'} 05:25:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:04 INFO - Running setup.py (path:/tmp/pip-xMAW41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:04 INFO - Running setup.py (path:/tmp/pip-mhjMXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:04 INFO - Running setup.py (path:/tmp/pip-XxuPVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:04 INFO - Running setup.py (path:/tmp/pip-lK6obC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:05 INFO - Running setup.py (path:/tmp/pip-g9omhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:05 INFO - Running setup.py (path:/tmp/pip-Y6m27f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:05 INFO - Running setup.py (path:/tmp/pip-9WQbr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:05 INFO - Running setup.py (path:/tmp/pip-eybPCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:05 INFO - Running setup.py (path:/tmp/pip-1BW2cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:05 INFO - Running setup.py (path:/tmp/pip-XHWlNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:05 INFO - Running setup.py (path:/tmp/pip-fPtFP7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:05 INFO - Running setup.py (path:/tmp/pip-LR9b8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:05 INFO - Running setup.py (path:/tmp/pip-9AYRH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:05 INFO - Running setup.py (path:/tmp/pip-rFB3ch-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:05 INFO - Running setup.py (path:/tmp/pip-TxW2g1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:05 INFO - Running setup.py (path:/tmp/pip-DyTm5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:05 INFO - Running setup.py (path:/tmp/pip-44tUoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:25:05 INFO - Running setup.py install for manifestparser 05:25:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:25:06 INFO - Running setup.py install for mozcrash 05:25:06 INFO - Running setup.py install for mozdebug 05:25:06 INFO - Running setup.py install for mozdevice 05:25:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:25:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:25:06 INFO - Running setup.py install for mozfile 05:25:06 INFO - Running setup.py install for mozhttpd 05:25:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:25:06 INFO - Running setup.py install for mozinfo 05:25:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:25:06 INFO - Running setup.py install for mozInstall 05:25:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:25:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:25:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:25:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:25:06 INFO - Running setup.py install for mozleak 05:25:06 INFO - Running setup.py install for mozlog 05:25:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:25:06 INFO - Running setup.py install for moznetwork 05:25:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:25:07 INFO - Running setup.py install for mozprocess 05:25:07 INFO - Running setup.py install for mozprofile 05:25:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:25:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:25:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:25:07 INFO - Running setup.py install for mozrunner 05:25:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:25:07 INFO - Running setup.py install for mozscreenshot 05:25:07 INFO - Running setup.py install for moztest 05:25:07 INFO - Running setup.py install for mozversion 05:25:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:25:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:25:07 INFO - Cleaning up... 05:25:07 INFO - Return code: 0 05:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fa9e1c04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, '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 0x15f2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3360>, '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': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', '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 05:25:07 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 05:25:07 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 05:25:07 INFO - Using env: {'DISPLAY': ':0', 05:25:07 INFO - 'HOME': '/home/cltbld', 05:25:07 INFO - 'LANG': 'en_US.UTF-8', 05:25:07 INFO - 'LANGUAGE': 'en_US:en', 05:25:07 INFO - 'LOGNAME': 'cltbld', 05:25:07 INFO - 'MAIL': '/var/mail/cltbld', 05:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:07 INFO - 'MOZ_NO_REMOTE': '1', 05:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:07 INFO - 'NO_EM_RESTART': '1', 05:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:07 INFO - 'PWD': '/builds/slave/test', 05:25:07 INFO - 'SHELL': '/bin/bash', 05:25:07 INFO - 'SHLVL': '1', 05:25:07 INFO - 'TERM': 'linux', 05:25:07 INFO - 'TMOUT': '86400', 05:25:07 INFO - 'USER': 'cltbld', 05:25:07 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', 05:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:07 INFO - '_': '/tools/buildbot/bin/python'} 05:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:25:07 INFO - Running setup.py (path:/tmp/pip-ei8HcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:25:08 INFO - Running setup.py (path:/tmp/pip-FJu2g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:25:08 INFO - Running setup.py (path:/tmp/pip-q3_QnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:25:08 INFO - Running setup.py (path:/tmp/pip-xIUIPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:25:08 INFO - Running setup.py (path:/tmp/pip-0TrOw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:25:08 INFO - Running setup.py (path:/tmp/pip-1PpJeU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:25:08 INFO - Running setup.py (path:/tmp/pip-TIcNZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:25:08 INFO - Running setup.py (path:/tmp/pip-7NOkwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:25:08 INFO - Running setup.py (path:/tmp/pip-MH45CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:25:08 INFO - Running setup.py (path:/tmp/pip-rssKA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:25:08 INFO - Running setup.py (path:/tmp/pip-OovYZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:25:08 INFO - Running setup.py (path:/tmp/pip-uuJ6VA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:25:08 INFO - Running setup.py (path:/tmp/pip-9sdbE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:25:08 INFO - Running setup.py (path:/tmp/pip-HwnTmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:25:08 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)) 05:25:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:08 INFO - Running setup.py (path:/tmp/pip-u4N1vx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:25:09 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)) 05:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:25:09 INFO - Running setup.py (path:/tmp/pip-hMFiH1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:25:09 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)) 05:25:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:25:09 INFO - Running setup.py (path:/tmp/pip-mWgZVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:25:09 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)) 05:25:09 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)) 05:25:09 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)) 05:25:09 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)) 05:25:09 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)) 05:25:09 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)) 05:25:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:10 INFO - Downloading blessings-1.5.1.tar.gz 05:25:10 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 05:25:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:25:10 INFO - Installing collected packages: blessings 05:25:10 INFO - Running setup.py install for blessings 05:25:10 INFO - Successfully installed blessings 05:25:10 INFO - Cleaning up... 05:25:11 INFO - Return code: 0 05:25:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:25:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:11 INFO - Reading from file tmpfile_stdout 05:25:11 INFO - Current package versions: 05:25:11 INFO - argparse == 1.2.1 05:25:11 INFO - blessings == 1.5.1 05:25:11 INFO - blobuploader == 1.2.4 05:25:11 INFO - docopt == 0.6.1 05:25:11 INFO - manifestparser == 1.1 05:25:11 INFO - mozInstall == 1.12 05:25:11 INFO - mozcrash == 0.16 05:25:11 INFO - mozdebug == 0.1 05:25:11 INFO - mozdevice == 0.47 05:25:11 INFO - mozfile == 1.2 05:25:11 INFO - mozhttpd == 0.7 05:25:11 INFO - mozinfo == 0.9 05:25:11 INFO - mozleak == 0.1 05:25:11 INFO - mozlog == 3.1 05:25:11 INFO - moznetwork == 0.27 05:25:11 INFO - mozprocess == 0.22 05:25:11 INFO - mozprofile == 0.28 05:25:11 INFO - mozrunner == 6.11 05:25:11 INFO - mozscreenshot == 0.1 05:25:11 INFO - mozsystemmonitor == 0.0 05:25:11 INFO - moztest == 0.7 05:25:11 INFO - mozversion == 1.4 05:25:11 INFO - psutil == 3.1.1 05:25:11 INFO - requests == 1.2.3 05:25:11 INFO - wsgiref == 0.1.2 05:25:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:11 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 0x7fa9e1c04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, '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 0x15f2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3360>, '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': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', '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 05:25:11 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 05:25:11 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 05:25:11 INFO - Using env: {'DISPLAY': ':0', 05:25:11 INFO - 'HOME': '/home/cltbld', 05:25:11 INFO - 'LANG': 'en_US.UTF-8', 05:25:11 INFO - 'LANGUAGE': 'en_US:en', 05:25:11 INFO - 'LOGNAME': 'cltbld', 05:25:11 INFO - 'MAIL': '/var/mail/cltbld', 05:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:11 INFO - 'MOZ_NO_REMOTE': '1', 05:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:11 INFO - 'NO_EM_RESTART': '1', 05:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:11 INFO - 'PWD': '/builds/slave/test', 05:25:11 INFO - 'SHELL': '/bin/bash', 05:25:11 INFO - 'SHLVL': '1', 05:25:11 INFO - 'TERM': 'linux', 05:25:11 INFO - 'TMOUT': '86400', 05:25:11 INFO - 'USER': 'cltbld', 05:25:11 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', 05:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:11 INFO - '_': '/tools/buildbot/bin/python'} 05:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:25:11 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 2)) 05:25:11 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 3)) 05:25:11 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 4)) 05:25:11 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 5)) 05:25:11 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 6)) 05:25:11 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 7)) 05:25:11 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 8)) 05:25:11 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 9)) 05:25:11 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:25:11 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 4)) 05:25:11 INFO - Cleaning up... 05:25:11 INFO - Return code: 0 05:25:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:25:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:11 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 0x7fa9e1c04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, '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 0x15f2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3360>, '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': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', '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 05:25:11 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 05:25:11 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 05:25:11 INFO - Using env: {'DISPLAY': ':0', 05:25:11 INFO - 'HOME': '/home/cltbld', 05:25:11 INFO - 'LANG': 'en_US.UTF-8', 05:25:11 INFO - 'LANGUAGE': 'en_US:en', 05:25:11 INFO - 'LOGNAME': 'cltbld', 05:25:11 INFO - 'MAIL': '/var/mail/cltbld', 05:25:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:11 INFO - 'MOZ_NO_REMOTE': '1', 05:25:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:11 INFO - 'NO_EM_RESTART': '1', 05:25:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:11 INFO - 'PWD': '/builds/slave/test', 05:25:11 INFO - 'SHELL': '/bin/bash', 05:25:11 INFO - 'SHLVL': '1', 05:25:11 INFO - 'TERM': 'linux', 05:25:11 INFO - 'TMOUT': '86400', 05:25:11 INFO - 'USER': 'cltbld', 05:25:11 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', 05:25:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:11 INFO - '_': '/tools/buildbot/bin/python'} 05:25:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:11 INFO - Downloading/unpacking jsonschema 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25: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 05:25:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:25:13 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 05:25:13 INFO - Downloading/unpacking functools32 (from jsonschema) 05:25:13 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 05:25:13 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 05:25:13 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 05:25:13 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 05:25:13 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 05:25:13 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 05:25:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:25:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:25:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:25:13 INFO - warning: no files found matching '*.txt' 05:25:13 INFO - no previously-included directories found matching 'build' 05:25:13 INFO - no previously-included directories found matching 'dist' 05:25:13 INFO - no previously-included directories found matching '.git*' 05:25:13 INFO - Installing collected packages: jsonschema, functools32 05:25:13 INFO - Running setup.py install for functools32 05:25:13 INFO - warning: no files found matching '*.txt' 05:25:13 INFO - no previously-included directories found matching 'build' 05:25:13 INFO - no previously-included directories found matching 'dist' 05:25:13 INFO - no previously-included directories found matching '.git*' 05:25:13 INFO - Successfully installed jsonschema functools32 05:25:13 INFO - Cleaning up... 05:25:13 INFO - Return code: 0 05:25:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:25:13 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')]} 05:25:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:13 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')]} 05:25:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:13 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 0x7fa9e1c04f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15258a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15f4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16873d0>, '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 0x15f2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3360>, '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': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', '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 05:25:13 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 05:25:13 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 05:25:13 INFO - Using env: {'DISPLAY': ':0', 05:25:13 INFO - 'HOME': '/home/cltbld', 05:25:13 INFO - 'LANG': 'en_US.UTF-8', 05:25:13 INFO - 'LANGUAGE': 'en_US:en', 05:25:13 INFO - 'LOGNAME': 'cltbld', 05:25:13 INFO - 'MAIL': '/var/mail/cltbld', 05:25:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:13 INFO - 'MOZ_NO_REMOTE': '1', 05:25:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:13 INFO - 'NO_EM_RESTART': '1', 05:25:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:13 INFO - 'PWD': '/builds/slave/test', 05:25:13 INFO - 'SHELL': '/bin/bash', 05:25:13 INFO - 'SHLVL': '1', 05:25:13 INFO - 'TERM': 'linux', 05:25:13 INFO - 'TMOUT': '86400', 05:25:13 INFO - 'USER': 'cltbld', 05:25:13 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', 05:25:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:13 INFO - '_': '/tools/buildbot/bin/python'} 05:25:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:14 INFO - Downloading/unpacking flake8 05:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:25:15 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 05:25:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:25:15 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 05:25:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:15 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 05:25:16 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 05:25:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:25:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:25:16 INFO - no previously-included directories found matching 'docs/_build' 05:25:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:25:16 INFO - Running setup.py install for pep8 05:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:25:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:25:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:25:16 INFO - no previously-included directories found matching 'docs/_build' 05:25:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:25:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:25:16 INFO - Cleaning up... 05:25:16 INFO - Return code: 0 05:25:16 INFO - Running post-action listener: _resource_record_post_action 05:25:16 INFO - Running post-action listener: _start_resource_monitoring 05:25:16 INFO - Starting resource monitoring. 05:25:16 INFO - ##### 05:25:16 INFO - ##### Running install step. 05:25:16 INFO - ##### 05:25:16 INFO - Running pre-action listener: _resource_record_pre_action 05:25:16 INFO - Running main action method: install 05:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:25:16 INFO - Reading from file tmpfile_stdout 05:25:16 INFO - Detecting whether we're running mozinstall >=1.0... 05:25:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:25:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:25:16 INFO - Reading from file tmpfile_stdout 05:25:16 INFO - Output received: 05:25:16 INFO - Usage: mozinstall [options] installer 05:25:16 INFO - Options: 05:25:16 INFO - -h, --help show this help message and exit 05:25:16 INFO - -d DEST, --destination=DEST 05:25:16 INFO - Directory to install application into. [default: 05:25:16 INFO - "/builds/slave/test"] 05:25:16 INFO - --app=APP Application being installed. [default: firefox] 05:25:16 INFO - mkdir: /builds/slave/test/build/application 05:25:16 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'] 05:25:16 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 05:25:32 INFO - Reading from file tmpfile_stdout 05:25:32 INFO - Output received: 05:25:32 INFO - /builds/slave/test/build/application/firefox/firefox 05:25:32 INFO - Running post-action listener: _resource_record_post_action 05:25:32 INFO - ##### 05:25:32 INFO - ##### Running run-tests step. 05:25:32 INFO - ##### 05:25:32 INFO - Running pre-action listener: _resource_record_pre_action 05:25:32 INFO - Running main action method: run_tests 05:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:25:32 INFO - Python 2.7.3 05:25:32 INFO - Return code: 0 05:25:32 INFO - grabbing minidump binary from tooltool 05:25:32 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')]} 05:25:32 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 0x16873d0>, '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 0x15f2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f3360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:25:32 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 05:25:32 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 05:25:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:25:32 INFO - Return code: 0 05:25:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:25:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:25:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:25:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:25:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:25:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:25:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:25:33 INFO - Return code: 0 05:25:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:25:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:25:33 INFO - Using env: {'DISPLAY': ':0', 05:25:33 INFO - 'HOME': '/home/cltbld', 05:25:33 INFO - 'LANG': 'en_US.UTF-8', 05:25:33 INFO - 'LANGUAGE': 'en_US:en', 05:25:33 INFO - 'LOGNAME': 'cltbld', 05:25:33 INFO - 'MAIL': '/var/mail/cltbld', 05:25:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:25:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:25:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:33 INFO - 'MOZ_NO_REMOTE': '1', 05:25:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:25:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:25:33 INFO - 'NO_EM_RESTART': '1', 05:25:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:25:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:33 INFO - 'PWD': '/builds/slave/test', 05:25:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:25:33 INFO - 'SHELL': '/bin/bash', 05:25:33 INFO - 'SHLVL': '1', 05:25:33 INFO - 'TERM': 'linux', 05:25:33 INFO - 'TMOUT': '86400', 05:25:33 INFO - 'USER': 'cltbld', 05:25:33 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324', 05:25:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:33 INFO - '_': '/tools/buildbot/bin/python'} 05:25:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:25:33 INFO - mozversion application_buildid: 20151221045029 05:25:33 INFO - mozversion application_changeset: 446a82134ef2a325e58f7fe749a1989c88335796 05:25:33 INFO - mozversion application_display_name: Nightly 05:25:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:25:33 INFO - mozversion application_name: Firefox 05:25:33 INFO - mozversion application_remotingname: firefox 05:25:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:25:33 INFO - mozversion application_vendor: Mozilla 05:25:33 INFO - mozversion application_version: 46.0a1 05:25:33 INFO - mozversion platform_buildid: 20151221045029 05:25:33 INFO - mozversion platform_changeset: 446a82134ef2a325e58f7fe749a1989c88335796 05:25:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:25:33 INFO - mozversion platform_version: 46.0a1 05:25:33 INFO - using testdate: 1450704333 05:25:33 INFO - actual date: 1450704333 05:25:33 INFO - starting webserver on 'localhost:36453' 05:25:33 INFO - SUITE-START | Running 3 tests 05:25:33 INFO - TEST-START | dromaeo_css 05:25:33 INFO - operating with platform_type : linux_ 05:25:33 INFO - Initialising browser for dromaeo_css test... 05:25:33 INFO - TEST-INFO | started process 3611 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptzEZE9/profile http://localhost:36453/getInfo.html) 05:25:38 INFO - PROCESS | 3611 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:25:38 INFO - PROCESS | 3611 | __metrics Screen width/height:1600/1200 05:25:38 INFO - PROCESS | 3611 | colorDepth:24 05:25:38 INFO - PROCESS | 3611 | Browser inner width/height: 1024/697 05:25:38 INFO - PROCESS | 3611 | __metrics 05:25:38 INFO - PROCESS | 3611 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:25:38 INFO - PROCESS | 3611 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:25:39 INFO - TEST-INFO | 3611: exit 0 05:25:39 INFO - Browser initialized. 05:25:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:25:39 INFO - TEST-INFO | started process 3703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptzEZE9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:25:51 INFO - PROCESS | 3703 | RSS: Main: 150102016 05:25:51 INFO - PROCESS | 3703 | 05:26:42 INFO - PROCESS | 3703 | 1450704402804 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] 05:28:54 INFO - PROCESS | 3703 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36453/tests/dromaeo/cssquery-ext.html) 05:28:55 INFO - PROCESS | 3703 | RSS: Main: 253136896 05:28:55 INFO - PROCESS | 3703 | 05:31:58 INFO - PROCESS | 3703 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-ext.html (next: http://localhost:36453/tests/dromaeo/cssquery-jquery.html) 05:31:58 INFO - PROCESS | 3703 | RSS: Main: 225906688 05:31:58 INFO - PROCESS | 3703 | 05:35:01 INFO - PROCESS | 3703 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36453/tests/dromaeo/cssquery-mootools.html) 05:35:01 INFO - PROCESS | 3703 | RSS: Main: 224489472 05:35:01 INFO - PROCESS | 3703 | 05:38:03 INFO - PROCESS | 3703 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36453/tests/dromaeo/cssquery-prototype.html) 05:38:04 INFO - PROCESS | 3703 | RSS: Main: 210694144 05:38:04 INFO - PROCESS | 3703 | 05:41:06 INFO - PROCESS | 3703 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36453/tests/dromaeo/cssquery-yui.html) 05:41:07 INFO - PROCESS | 3703 | RSS: Main: 214941696 05:41:07 INFO - PROCESS | 3703 | 05:44:09 INFO - PROCESS | 3703 | Cycle 1(1): loaded http://localhost:36453/tests/dromaeo/cssquery-yui.html (next: http://localhost:36453/tests/dromaeo/cssquery-dojo.html) 05:44:10 INFO - PROCESS | 3703 | RSS: Main: 278491136 05:44:10 INFO - PROCESS | 3703 | 05:44:10 INFO - PROCESS | 3703 | __start_tp_report 05:44:10 INFO - PROCESS | 3703 | _x_x_mozilla_page_load 05:44:10 INFO - PROCESS | 3703 | _x_x_mozilla_page_load_details 05:44:10 INFO - PROCESS | 3703 | |i|pagename|runs| 05:44:10 INFO - PROCESS | 3703 | |0;dojo.html;2622.554165791815;2705.3642394037383;2705.404810941592;2711.0511321037625;2729.0175536806746;4499.865004049884;4641.953580464195;4643.930341044883;4711.528847115291;4757.119932812432;4608.21660317746;4692.038132182903;4693.0613877224605;4702.85891423257;4828.396450443694;4318.9784051079705;4332.631726303268;4345.456817897762;4359.912801743979;4381.868543943671;4170.833166673345;4401.163778882018;4407.272799987998;4463.464384273875;4467.061916997418;4157.272477316487;4235.8093885775215;4244.80898359573;4269.338252570826;4271.530131685512;4247.617714405718;4319.179355922396;4324.13517296542;4355.1725172217175;4358.629516491102;4128.587141285878;4274.935875961832;4279.930017495626;4338.2191205582985;4350.521442641307;4573.519780423041;4581.748003859786;4583.404157459542;4703.647226457995;4724.834630787906;5027.4469808321055;5051.292819005343;5053.84838454847;5055.747212639353;5106.693598384071;4834.9516504834855;5063.645544811865;5071.366079240095;5075;5084.262781896641;4533.750643714594;4555.794989225526;4623.075384923029;4737.786799594027;4748.3114948332295;5168.121419358718;5184.170532714747;5191.299174611379;5195.818146364934;5243.475652434802;4967.503249675004;4984.077945580079;4986.252062190628;4987.451380348159;5037.4458809530925;4834.806607735652;4857.927131093036;4938.407391113089;4941.1847045237855;4978.925316120261;4988.6757360771435;4991.750412479361;4992.301077849104;4993.17612593918;5010.774515146827;4966.056449274626;4976.751162441936;4980.228064649985;4984.800607975713;5019.874503137451;3939.6454319110844;4075;4079.4492743479846;4186.204621122038;4230.894227644272;3607.2785442911;3674.706023518112;3685.686716629063;3699.8150092495266;3722.050877026341;4332.155229730235;4341.175176716414;4353.760543170093;4360.956390436118;4401.581849724335;4773.069251495925;4882.340883980688;4978.925316120261;5022.321986531844;5075.56857667095;4242.44848169736;4269.679774016961;4326.4808223012815;4344.695871289043;4364.148990946798;4458.06380660065;4463.732176069446;4478.328250762346;4499.1451624191295;4504.864854054384;4580.335851301476;4689.929651055305;4788.473267940523;4816.735079570657;4836.661433699607;4907.803687852589;4961.801527938842;5026.145555255543;5041.924371134362;5083.669561478492;4786.994731106507;4789.44921334051;4790.4251489821445;4792.808287668594;4834.0331933612715;4695.929561056519;4797.9040419192115;4918.2376731606655;4924.6703390085195;4972.602191824718;4891.5353041461;4910.238912968495;4959.0329885671945;4989.775460104376;5007.073691366963;4883.096627123851;4945.8021679132435;4950.282209079735;4959.553640172402;5004.374453193351;4722;4806.95193048079;4930.408350997904;4952;4983.526564976321;4710.4347478302825;4763.285507173951;4818.4217893852965;4843.07981483517;4855.320255164209;4949.257611358325;4949.480304567968;4957.330760347307;4961.231009193581;4963.057019166346;4848.587870031087;4852.2479015752615;4852.369192005017;4854.101991131652;4896.314515967839 05:44:10 INFO - PROCESS | 3703 | |1;ext.html;524.6825670469366;525.3721802446076;525.4482793067278;544.2217628790828;549.4478049560191;27129.59305610415;27536.03623873165;27697;27715.584266235997;36063.81968090156;40056.79971600138;40888.38667419991;40915;40939;40941.38587921176;7736.303732664059;7892.56590887501;7906.893034975108;7915.683372665087;7918.208179182093;7277.163126240497;7470.178280389153;7477.214892436297;7479.401647868158;7727.111382191064;7221.133463984329;10170.288079834414;10438.425886576235;10447.634332798354;10458.372497650127;9934.602615895355;10028;10045.497725113788;10052.497375131214;10052.798944021151;7289.380402665727;7437.070366204224;9809.21526277896;9964.25268104895;10091.344062635904;36384;36896;36918.26163476742;36922.81538592317;36930;2736.6715994080637;2760.268528839839;2765.3336111565905;2812.7890408219464;3626.34725749365;27545.173644790688;27554.17337479879;27606.59850468423;27739.445211095866;28214.294642634097;3410.369081719865;3437.089171369589;3471.8090505022215;3502.3004720578624;3508.561429821272;215335;215638;215647;216625.99999999843;216789;53651;54504;54551.45448545543;54572.18141727877;54631.453685462635;56407.71796140993;56669.71665141648;56832.71583642055;56851.43148568461;56918;14234.14595124296;14696.485623003357;14756.778648320284;14789.852101479062;14838.777418338734;11413;11514.19400641947;11527.193096483166;11534.077273818075;11539.19225654213;18011.369602063864;18183;18189.45431637053;18461.907690461463;18483.90758046228;7407.777766667009;7598.126215485179;7638.618069096634;7670.654820533089;7683.615819209129;820.1142765812908;860.9784755381165;880.9383343165916;935.3452583191793;951.785848184153;25580;26266.212013639622;26335.473290534464;26342.73657263441;26554.734452655226;876.4434584039182;953.0850383631653;1008.5360734062414;1063.229158859836;1068.7061058209056;12509.74980500403;13029.674258143432;13115.606531804062;13537.729245415037;13543.796843047363;359329;364051;364171;364454;365245;37005.44491832625;37738.81130594384;42490.57509424928;43109.78445107817;43554.564454355685;1189.607429548247;1189.9226550274377;1194.8685644579089;1196.952121915131;1197.4132674989194;21797.891010544845;22650.660240096084;23013.53972920566;23778.16776412817;24125.638115428636;35717;36088.27823443569;36101;36126;36133.27733445369;159004;160283;160302.19848901147;160574.1971290136;160739;25674;25843.224703258933;25975.61036584415;25988.09041683532;25988.220353389428;37737.62262377341;37780.62219377771;38420.42369364518;38479.61520384761;38520.2295954085;27501.587476187473;28175.43649127047;29331.706682933753;31353.216169595944;32669.673303267613;28769.280767980967;29139.271518212216;29222.707772922;29320.413591728473;29364.412711746074;29233.70766292395;29884.402311953203;30161.849190753906;30194;30249.243768905955;26072;29119.7088029117;29913.102606921828;30856;32414.675853242108;22076.2273320433;22516.32451026472;22523.211687590854;22528.32415027552;22590.774092258867 05:44:10 INFO - PROCESS | 3703 | |2;jquery.html;302.19013045039287;306.0756515323721;306.4514519010971;313.33729162820634;315.6685480245742;12453.875461245385;12878.227306361625;14734;15168.393264269429;15227.771583426244;14969.401223951028;15280.797780610337;16421.096839673814;16626.085565293903;16643;4933.1860243059855;5021.447640759514;5171.974140129313;5172.974135129319;5178.093833579127;3524.22467057247;3615.2950174715943;3617.2765446910594;5064.797408103672;5071.2139618359215;5069.74651267437;5094.7197904115255;5100.642954993152;5108.20822772469;5174.353205849269;5086.872828179288;5133.1786914093755;5366.114591092465;5369.785208591652;5374.6237763356585;5061.848144555669;5155.510226528474;5159.5614372778355;5166.5866730661455;5167.069927413064;18530.351437699617;18936.337228197084;19484.902575487173;19504.902475487674;19517.316893908646;1689.923953422099;1719.5271300392367;1815.4916623345484;1833;1948.3473036532637;8646.265067469272;8808.383413161082;8810.030896601369;8835.690750823755;8982.28141748665;1682.4616122840696;1702.9318827247018;1747.1264367816093;1766.4877185616285;1799.973000404995;48120.759396203146;48262.27606585904;48449.75775121137;49495;49768.75115624435;9165;9299.581518831668;9376.437413755197;9391.859122113174;9647.973925475728;12291.07816913735;12296.139270250997;12304.138710290194;12305.44625491855;12327.568535101229;7087.291270872975;7191.964040179766;7202.53183543068;7230.710771569184;7247.13034435871;6964.408025317804;7005.824854378579;7035.366816986393;7120.6439678015895;7145.964270178616;4038.2932986727205;4057;4064.248114098901;4068.6541643960595;4069.9389509157386;1586;1617.3934774459578;1622.448367555037;1633.656932044284;1655.180685560655;387.3975967370709;387.9670228030649;403.4311620614919;770.4799260499253;896.5024411451576;9390;9874;9939.453330066772;10018.949905250573;10072.546735396925;340.1021303758081;355.25928439204546;385.35068409729695;390.6425620557158;394.3493236160301;5230.686158830406;5261.237120617489;5276.630635855453;5285.55072818807;5340.893182136336;463894;470588;470663;474879;480599;69681;73550.63224683842;74490.627546863;74566.66183374474;75287;421.00852492380005;425.80838622619945;426.3562021347787;427.79893450077793;428.07322147550826;8853.335999800169;8961.910380896108;9047.095290470901;9110.453372797654;9134.22359099484;30147;30148.397032059675;30891.227719307197;31038;31343.529847052767;42439.57560424356;43037.78481107575;43625.12749744924;43863.12273754443;44366.556334436245;8495.95752021236;8830.955845220733;8866.911330886609;8867.512286824287;8870.645174193218;10356.689299321033;10409.375437473776;15331.77002344988;16220;16317.84780171877;13236.470541178245;13451.049597808458;13732.244726540137;13853.861461385257;14067.226302553458;13181.143225690299;13723.245221512912;13800.37898294559;13969.790453143009;14114.929425352808;10688.305260158066;14502.202378868842;14668.633284167554;14775.261236937895;14915.403383864525;7619.4285428594185;7661.808454788675;8155.306798921921;8539.847120638635;8737.344699147463;12923.935380323039;12957.093003489665;13426.932865335611;13491.662708432368;13572.457101715821 05:44:10 INFO - PROCESS | 3703 | |3;mootools.html;1266.1643315411818;1634.4687976407668;1683.9747403788945;1706.462464323738;1721.5265801904468;6233.314335423105;6917.377436030756;7129.893051604224;7136.072310599615;7151.4993950423495;7115.18175409828;7158.606276654795;7199.352058314751;7223.277672232774;7226.819329516765;2106.368089573126;2146.7531233908066;2156.924507642225;2157.7087093242367;2159.082389984258;2120.597086553558;2162.9242976495825;2166.588348213842;2176.1948079210715;2178.400939741568;2082.9687554686693;2103.547737236494;2139;2141.3040761752413;2142.7857214278524;2093.706881036656;2113.619548481273;2122.108714339981;2123.4797474618663;2123.479747461874;2062.9277975270793;2135.765065842756;2144.024468866662;2146.055735476401;2150.2474134053114;7156.606386648732;7237.312455316736;7264.164621068592;7270.27297270274;7279.126504819403;4236.4704411948505;4289.077848262607;4292.5063617683745;4293.076988447468;4306.870793876189;2742.766864816493;2743.6158937748733;2798.0906205483298;2808.747212750862;2813.4795062913427;820.6061090676449;873.3362644390246;894.3873446689039;896.5651658945407;906.5557876640464;9769.413835169913;9816.460094694788;9822;9830.508474576314;9830.606775729033;3979.5025621797276;4040.2727509048655;4057.7159598827798;4058.6144316289906;4079.224947260011;8385.454945428528;8392.748217553482;8401.70594029206;8409.789755256168;8414.284785793276;4272.530021697611;4295.29127693927;4298.495526565677;4307.07397909451;4309.353596960481;3373.4939759036342;3453.7582369234415;3804.1630841214887;3938.7636741795586;3941.3299739044432;3435.2957643682985;3456.9827150864085;3463.89608311746;3497.3529896969144;3504.456809194579;1091.9945400272948;1092.6995076353908;1101.658485869367;1109.3011402816173;1115.6931843743037;807.075898096676;817.6484111831969;824.0688022534498;824.1593574553922;963.5134257200069;6461.321561236003;6463.838404039937;6477.287498375175;6487.2539657939;6491.7078731457195;425.41293015638223;437.8183054032541;440.24278241424696;443.0363958390488;446.4910002597042;5229.581633469314;5289.682619042793;5292.100342941632;5298.284731561267;5298.81454149103;7959.44283900133;8137.430379873352;8154.633041513146;8449.070602233749;8665.43674661145;8275.793105172299;8281.751547453587;8293.21214484623;8295.253427191461;8303.875441868377;6657.567258128206;6788.694508747119;6813.693383797741;6863.245043045261;6882.03651488792;6651.434628056476;6691.1636045494315;6710.429613482908;6714.462842972453;6715.059891615276;7638.197989211053;7823.452358334862;7997.560134192675;8011.959940200261;8015.158408367038;8001.079875814356;8174.100848906496;8182.83634327322;8283.337333013224;8288.461250018729;5551.861203469945;5612.102063669793;5753.223314852441;6433;6516.413522782972;6494.058361537645;6553.04980777775;6565.507586931095;6588.4399826013405;6598.802035938929;6194.659293738708;6312.400321969406;6364.172657554674;6511;6537.280899101;6203.4416902479;6296.5277604178955;6300.59046161998;6368.968155159195;6452.35476452351;6400.615963042046;6428.967855160694;6447.484841062253;6469.159009328757;6478.222613286436;5671.48956593892;5833.883322333614;5856.150858125463;5858.619189752652;5864.618799778001;5901.734421951109;5986.281646202309;5992.9811931972545;5996.2504686914135;6002.789902353396 05:44:10 INFO - PROCESS | 3703 | |4;prototype.html;286.067420210115;288.04513039274804;294.8127938758889;294.8673097106302;297.7632781938359;5306.151015837457;5327.7727615123285;5428.728563571821;5434.804343044534;5508.421615730351;5100.846974590768;5225.686458812474;5249.86875328117;5387;5394.73026348682;4112.97943510282;4143.834246630131;4151.481064866892;4151.688623353246;4161.396597493362;3913.6477717005464;3984.342583473723;4027.8388864445387;4161.9375709364385;4166.937495937564;4071.97964010181;4083.816228269735;4115.135821477494;4125.257453658341;4126.690498212631;4090.529589097262;4111.198316328318;4113.053997580573;4119.382092686091;4122.814473348676;3595.496630471736;3598.334308152974;3605.0266428064538;3607.657272559129;3610.0613840401684;5066.164082926312;5148.407933087706;5166.560842328407;5178.456262092502;5186.403563590197;4748.19280722278;4752.952470475286;4755.833545825914;4765.046990601859;4766.237402015696;5642.266505354278;5644.209810626516;5651.15232715096;5658.0381335173115;5661.065924122515;3921.5882332355263;3932.646061854447;3932.7247092703524;3935.74417662851;3940.211957608461;5824.777993288713;5909.23179986599;5951.970240148815;5953.3748956359395;5963.105534169866;4048.4534587830854;4052.65552428041;4055.858044968471;4059.6143366380147;4062.9390559141048;4103.4870641169855;4106.301928672133;4112.362583799516;4112.424260603518;4121.258173528794;4741.1465936131135;4741.644376671763;4748.287756836502;4749.430068391815;4754.881127971828;5545.833624991256;5656.943430565724;5660.066089095336;5663.1505274208375;5666.4900158985065;1420.943162273518;1458.1251249250577;1459.4818839312104;1459.6059064052859;1460.3866376122055;960.4765402855461;992.4739887859301;994.8408254679216;1000.6847842929454;1009.8737657792776;4986.4514903360605;4993;4993.151164302078;4995.625328100407;4999.325091112726;5877.647341159544;5882.617629854046;5885.176075349455;5885.499732522783;5894.381089985575;4810.855674329776;4904.779284932187;4959.776810043557;5030.245463180552;5032.622553308516;3156.068959656907;3176.4758814795764;3184.598776538362;3188.8883889064236;3191.728703060266;5617.775288988395;5622.184783206412;5629.521490673257;5630.859228519238;5630.971845140748;5877.971355012855;6024.97575412181;6076.392360763888;6085.66528840918;6086.05666121743;5615.943840561542;5634.915476267941;5636.633618814764;5639.295088114068;5643.5203007743985;5918.260217472816;5924.940750592439;5928.67392293428;5932.466078052996;5932.644041357532;5669.234653321749;5805.245318108618;5812.18629391894;5814.215080964016;5814.505767009851;5596.580256480862;5620.943790562205;5625.662460252398;5626.465485778845;5630.774769009194;3934.7639141651593;3956.1098752780395;3962.326404511298;3964.9207015860097;3966.8413263470293;5894.233749612695;5902.881942361215;5904.232449781501;5909.940900591111;5917.260342457193;5575.972120139536;5620.550355971431;5674.375818660027;5685.857853553694;5706.885862282814;5700.629459085146;5703.458171473703;5704.9429505706075;5711.971440142773;5713.971430142823;5545.694986775766;5574.16387541872;5574.303212098488;5579.581531385244;5579.60942734021;5552.305961754781;5732.283464566929;5740;5741.5119714824705;5742.655440673573;5535.916961245504;5577.721113944368;5592.4966752990795;5598.972005139948;5608.214849921096 05:44:10 INFO - PROCESS | 3703 | |5;yui.html;659.123365923322;717.3364637710117;738.5347231244314;744.1219361153838;796.0328201235498;10627.096696780773;10933.125349971993;10934.890651093496;10944.56221751131;10956.28784129031;11253.437328133601;11264.549418023289;11392.658220253385;11395.886041139585;11400.486978085984;802.065593583476;818.0265484073963;818.3085292927467;818.4966245758845;818.5497976113144;798.7124635131348;806.7216810200472;807.0557447786075;807.1766797866202;807.8020884883211;847.0301504777027;859.6002858670716;859.9269062129727;859.9785005374853;860.0668274921718;852.2372476633409;852.5992783391796;853.9871901921476;854.0605334132435;854.3336197765752;626.5707990026846;626.8902941985134;627.560707504744;627.6955676496896;627.8367624417639;10380.065794078493;10502.159827213882;10523.73690657732;10537.73655658607;10548.736281592945;9124.178823905813;9292.767680807967;9393.718188454357;9570.47362395068;9711.90288097117;8353.122922093215;8358.874616880752;8466.915330846736;8529.445586036887;8624.568771561397;3124.5938028056435;3141.0733833519166;3176.174194709369;3177.682231776827;3220.838958052088;33522;34653.82673086669;34692.479612805575;35458;37329;9163.908360916439;9301.860472092923;9312.44125352481;9321.300902432346;9381.43711377306;16692.499225023024;16700.415485458194;16742;16751;16755.91622041882;6634.170728658918;6657.40083392497;6663.560573768027;6722.529422940347;6762.120924279812;3627.6009638940222;3639.454081887685;3700.0379901225874;3750.6249375062275;3792.544894612664;2608.67391576053;2636.275024368276;2640.6567146270863;2642.656454660882;2645.1535508637435;471.7641179410295;472.7399930038534;472.75889296459053;472.86759707282016;475.07834800486944;424.89377655586105;426.45413870246136;432.4356714487624;435.84091806491034;442.2393483208876;6884;7047.119110111236;7266.491345605757;7267.63661816907;7344.375728063068;473.01140616111803;484.88847565060235;507.44941738214453;540.2895192821427;595.1132812109925;3469.65303469651;3582.62382449839;3595.119195796994;3656.8720094796554;3824.388097904322;42577;43055.13889722188;43266.13467730691;43303.78348108239;43537.34693979593;41193.88430327719;43532.78233608875;43902.780486098;43996;44120.779396103455;36677.98271095115;38332.80833595814;39940.2011959765;43675.12649746987;43725;6901.75843845463;7162.498625096193;7522.968798424504;7665.846683066419;7722.343600793771;31219.219519511284;31662;31724.682753173096;32415.67584324221;32502;36180.27639447249;37433.81283093567;39032.219355612164;39591;39857.40213896852;8904.955475222583;9122.771930701785;9169.220616247694;9252.814943701223;9491.050894910453;9908.405495670282;10119.291649584458;10157.644482443375;10531.210159237935;10635.20235982289;8882.866756998521;8947.373683842068;9096.727098187064;9558;9781.315307928377;9558.856617150888;9741.172000380047;9979;10203.540840662337;10289.2797504174;9626;9776.217902567636;9873.703788886345;9883.851742224017;10403.063724264852;8500.829983400421;8520.573971301534;8681.208287331416;8800.823983520166;9224.769380765534;8133.430659853753;8535.274501667427;8562.100979397073;8607.096254893146;8779.325878530526 05:44:10 INFO - PROCESS | 3703 | __end_tp_report 05:44:10 INFO - PROCESS | 3703 | __start_cc_report 05:44:10 INFO - PROCESS | 3703 | _x_x_mozilla_cycle_collect,948 05:44:10 INFO - PROCESS | 3703 | __end_cc_report 05:44:10 INFO - PROCESS | 3703 | __startTimestamp1450705450145__endTimestamp 05:44:10 INFO - PROCESS | 3703 | 05:44:10 INFO - PROCESS | 3703 | ------- Summary: start ------- 05:44:10 INFO - PROCESS | 3703 | Number of tests: 6 05:44:10 INFO - PROCESS | 3703 | 05:44:10 INFO - PROCESS | 3703 | [#0] dojo.html Cycles:165 Average:4628.05 Median:4788.47 stddev:484.66 (10.1%) stddev-sans-first:459.90 05:44:10 INFO - PROCESS | 3703 | Values: 2622.6 2705.4 2705.4 2711.1 2729.0 4499.9 4642.0 4643.9 4711.5 4757.1 4608.2 4692.0 4693.1 4702.9 4828.4 4319.0 4332.6 4345.5 4359.9 4381.9 4170.8 4401.2 4407.3 4463.5 4467.1 4157.3 4235.8 4244.8 4269.3 4271.5 4247.6 4319.2 4324.1 4355.2 4358.6 4128.6 4274.9 4279.9 4338.2 4350.5 4573.5 4581.7 4583.4 4703.6 4724.8 5027.4 5051.3 5053.8 5055.7 5106.7 4835.0 5063.6 5071.4 5075.0 5084.3 4533.8 4555.8 4623.1 4737.8 4748.3 5168.1 5184.2 5191.3 5195.8 5243.5 4967.5 4984.1 4986.3 4987.5 5037.4 4834.8 4857.9 4938.4 4941.2 4978.9 4988.7 4991.8 4992.3 4993.2 5010.8 4966.1 4976.8 4980.2 4984.8 5019.9 3939.6 4075.0 4079.4 4186.2 4230.9 3607.3 3674.7 3685.7 3699.8 3722.1 4332.2 4341.2 4353.8 4361.0 4401.6 4773.1 4882.3 4978.9 5022.3 5075.6 4242.4 4269.7 4326.5 4344.7 4364.1 4458.1 4463.7 4478.3 4499.1 4504.9 4580.3 4689.9 4788.5 4816.7 4836.7 4907.8 4961.8 5026.1 5041.9 5083.7 4787.0 4789.4 4790.4 4792.8 4834.0 4695.9 4797.9 4918.2 4924.7 4972.6 4891.5 4910.2 4959.0 4989.8 5007.1 4883.1 4945.8 4950.3 4959.6 5004.4 4722.0 4807.0 4930.4 4952.0 4983.5 4710.4 4763.3 4818.4 4843.1 4855.3 4949.3 4949.5 4957.3 4961.2 4963.1 4848.6 4852.2 4852.4 4854.1 4896.3 05:44:10 INFO - PROCESS | 3703 | 05:44:10 INFO - PROCESS | 3703 | [#1] ext.html Cycles:180 Average:39881.71 Median:29624.41 stddev:68842.16 (232.4%) stddev-sans-first:68971.86 05:44:10 INFO - PROCESS | 3703 | Values: 524.7 525.4 525.4 544.2 549.4 27129.6 27536.0 27697.0 27715.6 36063.8 40056.8 40888.4 40915.0 40939.0 40941.4 7736.3 7892.6 7906.9 7915.7 7918.2 7277.2 7470.2 7477.2 7479.4 7727.1 7221.1 10170.3 10438.4 10447.6 10458.4 9934.6 10028.0 10045.5 10052.5 10052.8 7289.4 7437.1 9809.2 9964.3 10091.3 36384.0 36896.0 36918.3 36922.8 36930.0 2736.7 2760.3 2765.3 2812.8 3626.3 27545.2 27554.2 27606.6 27739.4 28214.3 3410.4 3437.1 3471.8 3502.3 3508.6 215335.0 215638.0 215647.0 216626.0 216789.0 53651.0 54504.0 54551.5 54572.2 54631.5 56407.7 56669.7 56832.7 56851.4 56918.0 14234.1 14696.5 14756.8 14789.9 14838.8 11413.0 11514.2 11527.2 11534.1 11539.2 18011.4 18183.0 18189.5 18461.9 18483.9 7407.8 7598.1 7638.6 7670.7 7683.6 820.1 861.0 880.9 935.3 951.8 25580.0 26266.2 26335.5 26342.7 26554.7 876.4 953.1 1008.5 1063.2 1068.7 12509.7 13029.7 13115.6 13537.7 13543.8 359329.0 364051.0 364171.0 364454.0 365245.0 37005.4 37738.8 42490.6 43109.8 43554.6 1189.6 1189.9 1194.9 1197.0 1197.4 21797.9 22650.7 23013.5 23778.2 24125.6 35717.0 36088.3 36101.0 36126.0 36133.3 159004.0 160283.0 160302.2 160574.2 160739.0 25674.0 25843.2 25975.6 25988.1 25988.2 37737.6 37780.6 38420.4 38479.6 38520.2 27501.6 28175.4 29331.7 31353.2 32669.7 28769.3 29139.3 29222.7 29320.4 29364.4 29233.7 29884.4 30161.8 30194.0 30249.2 26072.0 29119.7 29913.1 30856.0 32414.7 22076.2 22516.3 22523.2 22528.3 22590.8 05:44:10 INFO - PROCESS | 3703 | 05:44:10 INFO - PROCESS | 3703 | [#2] jquery.html Cycles:180 Average:25216.02 Median:426.08 stddev:77198.82 (18118.3%) stddev-sans-first:77392.71 05:44:10 INFO - PROCESS | 3703 | Values: 302.2 306.1 306.5 313.3 315.7 12453.9 12878.2 14734.0 15168.4 15227.8 14969.4 15280.8 16421.1 16626.1 16643.0 4933.2 5021.4 5172.0 5173.0 5178.1 3524.2 3615.3 3617.3 5064.8 5071.2 5069.7 5094.7 5100.6 5108.2 5174.4 5086.9 5133.2 5366.1 5369.8 5374.6 5061.8 5155.5 5159.6 5166.6 5167.1 18530.4 18936.3 19484.9 19504.9 19517.3 1689.9 1719.5 1815.5 1833.0 1948.3 8646.3 8808.4 8810.0 8835.7 8982.3 1682.5 1702.9 1747.1 1766.5 1800.0 48120.8 48262.3 48449.8 49495.0 49768.8 9165.0 9299.6 9376.4 9391.9 9648.0 12291.1 12296.1 12304.1 12305.4 12327.6 7087.3 7192.0 7202.5 7230.7 7247.1 6964.4 7005.8 7035.4 7120.6 7146.0 4038.3 4057.0 4064.2 4068.7 4069.9 1586.0 1617.4 1622.4 1633.7 1655.2 387.4 388.0 403.4 770.5 896.5 9390.0 9874.0 9939.5 10018.9 10072.5 340.1 355.3 385.4 390.6 394.3 5230.7 5261.2 5276.6 5285.6 5340.9 463894.0 470588.0 470663.0 474879.0 480599.0 69681.0 73550.6 74490.6 74566.7 75287.0 421.0 425.8 426.4 427.8 428.1 8853.3 8961.9 9047.1 9110.5 9134.2 30147.0 30148.4 30891.2 31038.0 31343.5 42439.6 43037.8 43625.1 43863.1 44366.6 8496.0 8831.0 8866.9 8867.5 8870.6 10356.7 10409.4 15331.8 16220.0 16317.8 13236.5 13451.0 13732.2 13853.9 14067.2 13181.1 13723.2 13800.4 13969.8 14114.9 10688.3 14502.2 14668.6 14775.3 14915.4 7619.4 7661.8 8155.3 8539.8 8737.3 12923.9 12957.1 13426.9 13491.7 13572.5 05:44:10 INFO - PROCESS | 3703 | 05:44:10 INFO - PROCESS | 3703 | [#3] mootools.html Cycles:180 Average:4973.74 Median:6264.92 stddev:2597.98 (41.5%) stddev-sans-first:2590.32 05:44:10 INFO - PROCESS | 3703 | Values: 1266.2 1634.5 1684.0 1706.5 1721.5 6233.3 6917.4 7129.9 7136.1 7151.5 7115.2 7158.6 7199.4 7223.3 7226.8 2106.4 2146.8 2156.9 2157.7 2159.1 2120.6 2162.9 2166.6 2176.2 2178.4 2083.0 2103.5 2139.0 2141.3 2142.8 2093.7 2113.6 2122.1 2123.5 2123.5 2062.9 2135.8 2144.0 2146.1 2150.2 7156.6 7237.3 7264.2 7270.3 7279.1 4236.5 4289.1 4292.5 4293.1 4306.9 2742.8 2743.6 2798.1 2808.7 2813.5 820.6 873.3 894.4 896.6 906.6 9769.4 9816.5 9822.0 9830.5 9830.6 3979.5 4040.3 4057.7 4058.6 4079.2 8385.5 8392.7 8401.7 8409.8 8414.3 4272.5 4295.3 4298.5 4307.1 4309.4 3373.5 3453.8 3804.2 3938.8 3941.3 3435.3 3457.0 3463.9 3497.4 3504.5 1092.0 1092.7 1101.7 1109.3 1115.7 807.1 817.6 824.1 824.2 963.5 6461.3 6463.8 6477.3 6487.3 6491.7 425.4 437.8 440.2 443.0 446.5 5229.6 5289.7 5292.1 5298.3 5298.8 7959.4 8137.4 8154.6 8449.1 8665.4 8275.8 8281.8 8293.2 8295.3 8303.9 6657.6 6788.7 6813.7 6863.2 6882.0 6651.4 6691.2 6710.4 6714.5 6715.1 7638.2 7823.5 7997.6 8012.0 8015.2 8001.1 8174.1 8182.8 8283.3 8288.5 5551.9 5612.1 5753.2 6433.0 6516.4 6494.1 6553.0 6565.5 6588.4 6598.8 6194.7 6312.4 6364.2 6511.0 6537.3 6203.4 6296.5 6300.6 6369.0 6452.4 6400.6 6429.0 6447.5 6469.2 6478.2 5671.5 5833.9 5856.2 5858.6 5864.6 5901.7 5986.3 5993.0 5996.3 6002.8 05:44:10 INFO - PROCESS | 3703 | 05:44:10 INFO - PROCESS | 3703 | [#4] prototype.html Cycles:180 Average:4696.98 Median:5316.96 stddev:1392.67 (26.2%) stddev-sans-first:1356.66 05:44:10 INFO - PROCESS | 3703 | Values: 286.1 288.0 294.8 294.9 297.8 5306.2 5327.8 5428.7 5434.8 5508.4 5100.8 5225.7 5249.9 5387.0 5394.7 4113.0 4143.8 4151.5 4151.7 4161.4 3913.6 3984.3 4027.8 4161.9 4166.9 4072.0 4083.8 4115.1 4125.3 4126.7 4090.5 4111.2 4113.1 4119.4 4122.8 3595.5 3598.3 3605.0 3607.7 3610.1 5066.2 5148.4 5166.6 5178.5 5186.4 4748.2 4753.0 4755.8 4765.0 4766.2 5642.3 5644.2 5651.2 5658.0 5661.1 3921.6 3932.6 3932.7 3935.7 3940.2 5824.8 5909.2 5952.0 5953.4 5963.1 4048.5 4052.7 4055.9 4059.6 4062.9 4103.5 4106.3 4112.4 4112.4 4121.3 4741.1 4741.6 4748.3 4749.4 4754.9 5545.8 5656.9 5660.1 5663.2 5666.5 1420.9 1458.1 1459.5 1459.6 1460.4 960.5 992.5 994.8 1000.7 1009.9 4986.5 4993.0 4993.2 4995.6 4999.3 5877.6 5882.6 5885.2 5885.5 5894.4 4810.9 4904.8 4959.8 5030.2 5032.6 3156.1 3176.5 3184.6 3188.9 3191.7 5617.8 5622.2 5629.5 5630.9 5631.0 5878.0 6025.0 6076.4 6085.7 6086.1 5615.9 5634.9 5636.6 5639.3 5643.5 5918.3 5924.9 5928.7 5932.5 5932.6 5669.2 5805.2 5812.2 5814.2 5814.5 5596.6 5620.9 5625.7 5626.5 5630.8 3934.8 3956.1 3962.3 3964.9 3966.8 5894.2 5902.9 5904.2 5909.9 5917.3 5576.0 5620.6 5674.4 5685.9 5706.9 5700.6 5703.5 5704.9 5712.0 5714.0 5545.7 5574.2 5574.3 5579.6 5579.6 5552.3 5732.3 5740.0 5741.5 5742.7 5535.9 5577.7 5592.5 5599.0 5608.2 05:44:10 INFO - PROCESS | 3703 | 05:44:10 INFO - PROCESS | 3703 | [#5] yui.html Cycles:180 Average:11538.60 Median:567.70 stddev:12980.94 (2286.6%) stddev-sans-first:12991.64 05:44:10 INFO - PROCESS | 3703 | Values: 659.1 717.3 738.5 744.1 796.0 10627.1 10933.1 10934.9 10944.6 10956.3 11253.4 11264.5 11392.7 11395.9 11400.5 802.1 818.0 818.3 818.5 818.5 798.7 806.7 807.1 807.2 807.8 847.0 859.6 859.9 860.0 860.1 852.2 852.6 854.0 854.1 854.3 626.6 626.9 627.6 627.7 627.8 10380.1 10502.2 10523.7 10537.7 10548.7 9124.2 9292.8 9393.7 9570.5 9711.9 8353.1 8358.9 8466.9 8529.4 8624.6 3124.6 3141.1 3176.2 3177.7 3220.8 33522.0 34653.8 34692.5 35458.0 37329.0 9163.9 9301.9 9312.4 9321.3 9381.4 16692.5 16700.4 16742.0 16751.0 16755.9 6634.2 6657.4 6663.6 6722.5 6762.1 3627.6 3639.5 3700.0 3750.6 3792.5 2608.7 2636.3 2640.7 2642.7 2645.2 471.8 472.7 472.8 472.9 475.1 424.9 426.5 432.4 435.8 442.2 6884.0 7047.1 7266.5 7267.6 7344.4 473.0 484.9 507.4 540.3 595.1 3469.7 3582.6 3595.1 3656.9 3824.4 42577.0 43055.1 43266.1 43303.8 43537.3 41193.9 43532.8 43902.8 43996.0 44120.8 36678.0 38332.8 39940.2 43675.1 43725.0 6901.8 7162.5 7523.0 7665.8 7722.3 31219.2 31662.0 31724.7 32415.7 32502.0 36180.3 37433.8 39032.2 39591.0 39857.4 8905.0 9122.8 9169.2 9252.8 9491.1 9908.4 10119.3 10157.6 10531.2 10635.2 8882.9 8947.4 9096.7 9558.0 9781.3 9558.9 9741.2 9979.0 10203.5 10289.3 9626.0 9776.2 9873.7 9883.9 10403.1 8500.8 8520.6 8681.2 8800.8 9224.8 8133.4 8535.3 8562.1 8607.1 8779.3 05:44:10 INFO - PROCESS | 3703 | -------- Summary: end -------- 05:44:10 INFO - PROCESS | 3703 | 05:44:10 INFO - TEST-INFO | 3703: exit 0 05:44:10 INFO - TEST-OK | dromaeo_css | took 1117211ms 05:44:10 INFO - TEST-START | kraken 05:44:10 INFO - operating with platform_type : linux_ 05:44:10 INFO - Initialising browser for kraken test... 05:44:10 INFO - TEST-INFO | started process 3893 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCOhRTH/profile http://localhost:36453/getInfo.html) 05:44:14 INFO - PROCESS | 3893 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:44:14 INFO - PROCESS | 3893 | __metrics Screen width/height:1600/1200 05:44:14 INFO - PROCESS | 3893 | colorDepth:24 05:44:14 INFO - PROCESS | 3893 | Browser inner width/height: 1024/697 05:44:14 INFO - PROCESS | 3893 | __metrics 05:44:15 INFO - PROCESS | 3893 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:44:15 INFO - PROCESS | 3893 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:44:16 INFO - TEST-INFO | 3893: exit 0 05:44:16 INFO - Browser initialized. 05:44:16 INFO - Running cycle 1/1 for kraken test... 05:44:16 INFO - TEST-INFO | started process 3972 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCOhRTH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:44:28 INFO - PROCESS | 3972 | RSS: Main: 150048768 05:44:28 INFO - PROCESS | 3972 | 05:44:30 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36453/tests/kraken/driver.html?testName=audio-beat-detection) 05:44:31 INFO - PROCESS | 3972 | RSS: Main: 185487360 05:44:31 INFO - PROCESS | 3972 | 05:44:34 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36453/tests/kraken/driver.html?testName=audio-dft) 05:44:34 INFO - PROCESS | 3972 | RSS: Main: 174415872 05:44:34 INFO - PROCESS | 3972 | 05:44:37 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36453/tests/kraken/driver.html?testName=audio-fft) 05:44:38 INFO - PROCESS | 3972 | RSS: Main: 161820672 05:44:38 INFO - PROCESS | 3972 | 05:44:40 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36453/tests/kraken/driver.html?testName=audio-oscillator) 05:44:40 INFO - PROCESS | 3972 | RSS: Main: 164241408 05:44:40 INFO - PROCESS | 3972 | 05:44:43 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36453/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:44:43 INFO - PROCESS | 3972 | RSS: Main: 165662720 05:44:43 INFO - PROCESS | 3972 | 05:44:46 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36453/tests/kraken/driver.html?testName=imaging-darkroom) 05:44:47 INFO - PROCESS | 3972 | RSS: Main: 164503552 05:44:47 INFO - PROCESS | 3972 | 05:44:50 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36453/tests/kraken/driver.html?testName=imaging-desaturate) 05:44:51 INFO - PROCESS | 3972 | RSS: Main: 166981632 05:44:51 INFO - PROCESS | 3972 | 05:44:54 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36453/tests/kraken/driver.html?testName=json-parse-financial) 05:44:54 INFO - PROCESS | 3972 | RSS: Main: 166625280 05:44:54 INFO - PROCESS | 3972 | 05:44:56 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36453/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:44:56 INFO - PROCESS | 3972 | RSS: Main: 174235648 05:44:56 INFO - PROCESS | 3972 | 05:44:58 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:44:59 INFO - PROCESS | 3972 | RSS: Main: 173604864 05:44:59 INFO - PROCESS | 3972 | 05:45:01 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:45:02 INFO - PROCESS | 3972 | RSS: Main: 182833152 05:45:02 INFO - PROCESS | 3972 | 05:45:04 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:45:05 INFO - PROCESS | 3972 | RSS: Main: 189648896 05:45:05 INFO - PROCESS | 3972 | 05:45:07 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:45:08 INFO - PROCESS | 3972 | RSS: Main: 186413056 05:45:08 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | Cycle 1(1): loaded http://localhost:36453/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36453/tests/kraken/driver.html?testName=ai-astar) 05:45:10 INFO - PROCESS | 3972 | RSS: Main: 243933184 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | __start_tp_report 05:45:10 INFO - PROCESS | 3972 | _x_x_mozilla_page_load 05:45:10 INFO - PROCESS | 3972 | _x_x_mozilla_page_load_details 05:45:10 INFO - PROCESS | 3972 | |i|pagename|runs| 05:45:10 INFO - PROCESS | 3972 | |0;ai-astar;111;113;111;112;113;113;102;111;110;103 05:45:10 INFO - PROCESS | 3972 | |1;audio-beat-detection;162;134;155;162;129;167;152;136;170;128 05:45:10 INFO - PROCESS | 3972 | |2;audio-dft;161;159;160;159;163;160;161;161;161;160 05:45:10 INFO - PROCESS | 3972 | |3;audio-fft;74;72;91;91;71;74;74;119;88;72 05:45:10 INFO - PROCESS | 3972 | |4;audio-oscillator;95;95;128;95;95;95;130;94;95;130 05:45:10 INFO - PROCESS | 3972 | |5;imaging-gaussian-blur;109;110;109;110;110;109;109;109;110;109 05:45:10 INFO - PROCESS | 3972 | |6;imaging-darkroom;146;146;146;147;146;146;146;146;146;145 05:45:10 INFO - PROCESS | 3972 | |7;imaging-desaturate;95;95;95;95;95;95;96;96;95;95 05:45:10 INFO - PROCESS | 3972 | |8;json-parse-financial;70;73;70;70;72;70;70;82;67;68 05:45:10 INFO - PROCESS | 3972 | |9;json-stringify-tinderbox;67;69;68;67;68;68;68;68;67;68 05:45:10 INFO - PROCESS | 3972 | |10;stanford-crypto-aes;82;83;91;82;84;83;83;83;84;83 05:45:10 INFO - PROCESS | 3972 | |11;stanford-crypto-ccm;120;120;123;116;122;129;117;129;135;131 05:45:10 INFO - PROCESS | 3972 | |12;stanford-crypto-pbkdf2;135;135;147;152;150;132;149;148;146;138 05:45:10 INFO - PROCESS | 3972 | |13;stanford-crypto-sha256-iterative;72;68;68;68;69;68;68;69;69;70 05:45:10 INFO - PROCESS | 3972 | __end_tp_report 05:45:10 INFO - PROCESS | 3972 | __start_cc_report 05:45:10 INFO - PROCESS | 3972 | _x_x_mozilla_cycle_collect,968 05:45:10 INFO - PROCESS | 3972 | __end_cc_report 05:45:10 INFO - PROCESS | 3972 | __startTimestamp1450705510364__endTimestamp 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | ------- Summary: start ------- 05:45:10 INFO - PROCESS | 3972 | Number of tests: 14 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#0] ai-astar Cycles:10 Average:109.90 Median:111.50 stddev:4.04 (3.6%) stddev-sans-first:4.27 05:45:10 INFO - PROCESS | 3972 | Values: 111.0 113.0 111.0 112.0 113.0 113.0 102.0 111.0 110.0 103.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#1] audio-beat-detection Cycles:10 Average:149.50 Median:158.50 stddev:16.26 (10.3%) stddev-sans-first:16.61 05:45:10 INFO - PROCESS | 3972 | Values: 162.0 134.0 155.0 162.0 129.0 167.0 152.0 136.0 170.0 128.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:1.24 05:45:10 INFO - PROCESS | 3972 | Values: 161.0 159.0 160.0 159.0 163.0 160.0 161.0 161.0 161.0 160.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#3] audio-fft Cycles:10 Average:82.60 Median:74.00 stddev:15.19 (20.5%) stddev-sans-first:15.79 05:45:10 INFO - PROCESS | 3972 | Values: 74.0 72.0 91.0 91.0 71.0 74.0 74.0 119.0 88.0 72.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:95.00 stddev:16.67 (17.5%) stddev-sans-first:17.26 05:45:10 INFO - PROCESS | 3972 | Values: 95.0 95.0 128.0 95.0 95.0 95.0 130.0 94.0 95.0 130.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 05:45:10 INFO - PROCESS | 3972 | Values: 109.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 109.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 05:45:10 INFO - PROCESS | 3972 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 145.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:45:10 INFO - PROCESS | 3972 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:70.00 stddev:4.16 (5.9%) stddev-sans-first:4.39 05:45:10 INFO - PROCESS | 3972 | Values: 70.0 73.0 70.0 70.0 72.0 70.0 70.0 82.0 67.0 68.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 05:45:10 INFO - PROCESS | 3972 | Values: 67.0 69.0 68.0 67.0 68.0 68.0 68.0 68.0 67.0 68.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:83.00 stddev:2.62 (3.2%) stddev-sans-first:2.69 05:45:10 INFO - PROCESS | 3972 | Values: 82.0 83.0 91.0 82.0 84.0 83.0 83.0 83.0 84.0 83.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:126.00 stddev:6.41 (5.1%) stddev-sans-first:6.61 05:45:10 INFO - PROCESS | 3972 | Values: 120.0 120.0 123.0 116.0 122.0 129.0 117.0 129.0 135.0 131.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:147.50 stddev:7.38 (5.0%) stddev-sans-first:7.20 05:45:10 INFO - PROCESS | 3972 | Values: 135.0 135.0 147.0 152.0 150.0 132.0 149.0 148.0 146.0 138.0 05:45:10 INFO - PROCESS | 3972 | 05:45:10 INFO - PROCESS | 3972 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.29 (1.9%) stddev-sans-first:0.73 05:45:10 INFO - PROCESS | 3972 | Values: 72.0 68.0 68.0 68.0 69.0 68.0 68.0 69.0 69.0 70.0 05:45:10 INFO - PROCESS | 3972 | -------- Summary: end -------- 05:45:10 INFO - PROCESS | 3972 | 05:45:11 INFO - TEST-INFO | 3972: exit 0 05:45:11 INFO - TEST-OK | kraken | took 60353ms 05:45:11 INFO - TEST-START | v8_7 05:45:11 INFO - operating with platform_type : linux_ 05:45:11 INFO - Initialising browser for v8_7 test... 05:45:11 INFO - TEST-INFO | started process 4221 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVumEJL/profile http://localhost:36453/getInfo.html) 05:45:15 INFO - PROCESS | 4221 | JavaScript error: resource://app/modules/BrowserUITelemetry.jsm, line 538: ReferenceError: assignment to undeclared variable item 05:45:15 INFO - PROCESS | 4221 | __metrics Screen width/height:1600/1200 05:45:15 INFO - PROCESS | 4221 | colorDepth:24 05:45:15 INFO - PROCESS | 4221 | Browser inner width/height: 1024/697 05:45:15 INFO - PROCESS | 4221 | __metrics 05:45:15 INFO - PROCESS | 4221 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:45:15 INFO - PROCESS | 4221 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:45:16 INFO - TEST-INFO | 4221: exit 0 05:45:16 INFO - Browser initialized. 05:45:16 INFO - Running cycle 1/1 for v8_7 test... 05:45:16 INFO - TEST-INFO | started process 4303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVumEJL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:28 INFO - PROCESS | 4303 | RSS: Main: 149958656 05:45:28 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | Cycle 1(1): loaded http://localhost:36453/tests/v8_7/run.html (next: http://localhost:36453/tests/v8_7/run.html) 05:45:50 INFO - PROCESS | 4303 | RSS: Main: 448221184 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | __start_tp_report 05:45:50 INFO - PROCESS | 4303 | _x_x_mozilla_page_load 05:45:50 INFO - PROCESS | 4303 | _x_x_mozilla_page_load_details 05:45:50 INFO - PROCESS | 4303 | |i|pagename|runs| 05:45:50 INFO - PROCESS | 4303 | |0;Richards;164.88046166529267 05:45:50 INFO - PROCESS | 4303 | |1;DeltaBlue;185.8045336306206 05:45:50 INFO - PROCESS | 4303 | |2;Encrypt;278.31895352073474 05:45:50 INFO - PROCESS | 4303 | |3;Decrypt;5191.709844559586 05:45:50 INFO - PROCESS | 4303 | |4;RayTrace;1968.5039370078741 05:45:50 INFO - PROCESS | 4303 | |5;Earley;791.1392405063291 05:45:50 INFO - PROCESS | 4303 | |6;Boyer;12207.317073170732 05:45:50 INFO - PROCESS | 4303 | |7;RegExp;27054.054054054053 05:45:50 INFO - PROCESS | 4303 | |8;Splay;597.8647686832741 05:45:50 INFO - PROCESS | 4303 | |9;NavierStokes;4840.579710144928 05:45:50 INFO - PROCESS | 4303 | __end_tp_report 05:45:50 INFO - PROCESS | 4303 | __startTimestamp1450705550362__endTimestamp 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | ------- Summary: start ------- 05:45:50 INFO - PROCESS | 4303 | Number of tests: 10 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | [#0] Richards Cycles:1 Average:164.88 Median:164.88 stddev:0.00 (0.0%) 05:45:50 INFO - PROCESS | 4303 | Values: 164.9 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | [#1] DeltaBlue Cycles:1 Average:185.80 Median:185.80 stddev:0.00 (0.0%) 05:45:50 INFO - PROCESS | 4303 | Values: 185.8 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 05:45:50 INFO - PROCESS | 4303 | Values: 278.3 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 05:45:50 INFO - PROCESS | 4303 | Values: 5191.7 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | [#4] RayTrace Cycles:1 Average:1968.50 Median:1968.50 stddev:0.00 (0.0%) 05:45:50 INFO - PROCESS | 4303 | Values: 1968.5 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | [#5] Earley Cycles:1 Average:791.14 Median:791.14 stddev:0.00 (0.0%) 05:45:50 INFO - PROCESS | 4303 | Values: 791.1 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 05:45:50 INFO - PROCESS | 4303 | Values: 12207.3 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | [#7] RegExp Cycles:1 Average:27054.05 Median:27054.05 stddev:0.00 (0.0%) 05:45:50 INFO - PROCESS | 4303 | Values: 27054.1 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | [#8] Splay Cycles:1 Average:597.86 Median:597.86 stddev:0.00 (0.0%) 05:45:50 INFO - PROCESS | 4303 | Values: 597.9 05:45:50 INFO - PROCESS | 4303 | 05:45:50 INFO - PROCESS | 4303 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 05:45:50 INFO - PROCESS | 4303 | Values: 4840.6 05:45:50 INFO - PROCESS | 4303 | -------- Summary: end -------- 05:45:50 INFO - PROCESS | 4303 | 05:45:51 INFO - TEST-INFO | 4303: exit 0 05:45:51 INFO - TEST-OK | v8_7 | took 40002ms 05:45:51 INFO - SUITE-END | took 1217s 05:45:51 INFO - Completed test suite (00:20:17) 05:45:51 INFO - Working with test: dromaeo_css 05:45:51 INFO - Generating results file: dromaeo_css 05:45:51 INFO - Working with test: kraken 05:45:51 INFO - Generating results file: kraken 05:45:51 INFO - javascript benchmark 05:45:51 INFO - Working with test: v8_7 05:45:51 INFO - Generating results file: v8_7 05:45:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:45:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:45:51 INFO - process_Request line: dromaeo_css 6098.72 graph.html#tests=[[72,132,35]] 05:45:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:45:51 INFO - process_Request line: kraken 1517.40 graph.html#tests=[[232,132,35]] 05:45:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:45:51 INFO - process_Request line: v8_7 19840.77 graph.html#tests=[[230,132,35]] 05:45:51 INFO - RETURN: dromaeo_css: 6098.72 05:45:51 INFO - RETURN: kraken: 1517.40 05:45:51 INFO - RETURN: v8_7: 19840.77 05:45:51 INFO - javascript benchmark 05:45:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.554165791815, 2705.3642394037383, 2705.404810941592, 2711.0511321037625, 2729.0175536806746, 4499.865004049884, 4641.953580464195, 4643.930341044883, 4711.528847115291, 4757.119932812432, 4608.21660317746, 4692.038132182903, 4693.0613877224605, 4702.85891423257, 4828.396450443694, 4318.9784051079705, 4332.631726303268, 4345.456817897762, 4359.912801743979, 4381.868543943671, 4170.833166673345, 4401.163778882018, 4407.272799987998, 4463.464384273875, 4467.061916997418, 4157.272477316487, 4235.8093885775215, 4244.80898359573, 4269.338252570826, 4271.530131685512, 4247.617714405718, 4319.179355922396, 4324.13517296542, 4355.1725172217175, 4358.629516491102, 4128.587141285878, 4274.935875961832, 4279.930017495626, 4338.2191205582985, 4350.521442641307, 4573.519780423041, 4581.748003859786, 4583.404157459542, 4703.647226457995, 4724.834630787906, 5027.4469808321055, 5051.292819005343, 5053.84838454847, 5055.747212639353, 5106.693598384071, 4834.9516504834855, 5063.645544811865, 5071.366079240095, 5075.0, 5084.262781896641, 4533.750643714594, 4555.794989225526, 4623.075384923029, 4737.786799594027, 4748.3114948332295, 5168.121419358718, 5184.170532714747, 5191.299174611379, 5195.818146364934, 5243.475652434802, 4967.503249675004, 4984.077945580079, 4986.252062190628, 4987.451380348159, 5037.4458809530925, 4834.806607735652, 4857.927131093036, 4938.407391113089, 4941.1847045237855, 4978.925316120261, 4988.6757360771435, 4991.750412479361, 4992.301077849104, 4993.17612593918, 5010.774515146827, 4966.056449274626, 4976.751162441936, 4980.228064649985, 4984.800607975713, 5019.874503137451, 3939.6454319110844, 4075.0, 4079.4492743479846, 4186.204621122038, 4230.894227644272, 3607.2785442911, 3674.706023518112, 3685.686716629063, 3699.8150092495266, 3722.050877026341, 4332.155229730235, 4341.175176716414, 4353.760543170093, 4360.956390436118, 4401.581849724335, 4773.069251495925, 4882.340883980688, 4978.925316120261, 5022.321986531844, 5075.56857667095, 4242.44848169736, 4269.679774016961, 4326.4808223012815, 4344.695871289043, 4364.148990946798, 4458.06380660065, 4463.732176069446, 4478.328250762346, 4499.1451624191295, 4504.864854054384, 4580.335851301476, 4689.929651055305, 4788.473267940523, 4816.735079570657, 4836.661433699607, 4907.803687852589, 4961.801527938842, 5026.145555255543, 5041.924371134362, 5083.669561478492, 4786.994731106507, 4789.44921334051, 4790.4251489821445, 4792.808287668594, 4834.0331933612715, 4695.929561056519, 4797.9040419192115, 4918.2376731606655, 4924.6703390085195, 4972.602191824718, 4891.5353041461, 4910.238912968495, 4959.0329885671945, 4989.775460104376, 5007.073691366963, 4883.096627123851, 4945.8021679132435, 4950.282209079735, 4959.553640172402, 5004.374453193351, 4722.0, 4806.95193048079, 4930.408350997904, 4952.0, 4983.526564976321, 4710.4347478302825, 4763.285507173951, 4818.4217893852965, 4843.07981483517, 4855.320255164209, 4949.257611358325, 4949.480304567968, 4957.330760347307, 4961.231009193581, 4963.057019166346, 4848.587870031087, 4852.2479015752615, 4852.369192005017, 4854.101991131652, 4896.314515967839], "unit": "score", "name": "dojo.html", "value": 4597.990308082303}, {"lowerIsBetter": false, "replicates": [524.6825670469366, 525.3721802446076, 525.4482793067278, 544.2217628790828, 549.4478049560191, 27129.59305610415, 27536.03623873165, 27697.0, 27715.584266235997, 36063.81968090156, 40056.79971600138, 40888.38667419991, 40915.0, 40939.0, 40941.38587921176, 7736.303732664059, 7892.56590887501, 7906.893034975108, 7915.683372665087, 7918.208179182093, 7277.163126240497, 7470.178280389153, 7477.214892436297, 7479.401647868158, 7727.111382191064, 7221.133463984329, 10170.288079834414, 10438.425886576235, 10447.634332798354, 10458.372497650127, 9934.602615895355, 10028.0, 10045.497725113788, 10052.497375131214, 10052.798944021151, 7289.380402665727, 7437.070366204224, 9809.21526277896, 9964.25268104895, 10091.344062635904, 36384.0, 36896.0, 36918.26163476742, 36922.81538592317, 36930.0, 2736.6715994080637, 2760.268528839839, 2765.3336111565905, 2812.7890408219464, 3626.34725749365, 27545.173644790688, 27554.17337479879, 27606.59850468423, 27739.445211095866, 28214.294642634097, 3410.369081719865, 3437.089171369589, 3471.8090505022215, 3502.3004720578624, 3508.561429821272, 215335.0, 215638.0, 215647.0, 216625.99999999843, 216789.0, 53651.0, 54504.0, 54551.45448545543, 54572.18141727877, 54631.453685462635, 56407.71796140993, 56669.71665141648, 56832.71583642055, 56851.43148568461, 56918.0, 14234.14595124296, 14696.485623003357, 14756.778648320284, 14789.852101479062, 14838.777418338734, 11413.0, 11514.19400641947, 11527.193096483166, 11534.077273818075, 11539.19225654213, 18011.369602063864, 18183.0, 18189.45431637053, 18461.907690461463, 18483.90758046228, 7407.777766667009, 7598.126215485179, 7638.618069096634, 7670.654820533089, 7683.615819209129, 820.1142765812908, 860.9784755381165, 880.9383343165916, 935.3452583191793, 951.785848184153, 25580.0, 26266.212013639622, 26335.473290534464, 26342.73657263441, 26554.734452655226, 876.4434584039182, 953.0850383631653, 1008.5360734062414, 1063.229158859836, 1068.7061058209056, 12509.74980500403, 13029.674258143432, 13115.606531804062, 13537.729245415037, 13543.796843047363, 359329.0, 364051.0, 364171.0, 364454.0, 365245.0, 37005.44491832625, 37738.81130594384, 42490.57509424928, 43109.78445107817, 43554.564454355685, 1189.607429548247, 1189.9226550274377, 1194.8685644579089, 1196.952121915131, 1197.4132674989194, 21797.891010544845, 22650.660240096084, 23013.53972920566, 23778.16776412817, 24125.638115428636, 35717.0, 36088.27823443569, 36101.0, 36126.0, 36133.27733445369, 159004.0, 160283.0, 160302.19848901147, 160574.1971290136, 160739.0, 25674.0, 25843.224703258933, 25975.61036584415, 25988.09041683532, 25988.220353389428, 37737.62262377341, 37780.62219377771, 38420.42369364518, 38479.61520384761, 38520.2295954085, 27501.587476187473, 28175.43649127047, 29331.706682933753, 31353.216169595944, 32669.673303267613, 28769.280767980967, 29139.271518212216, 29222.707772922, 29320.413591728473, 29364.412711746074, 29233.70766292395, 29884.402311953203, 30161.849190753906, 30194.0, 30249.243768905955, 26072.0, 29119.7088029117, 29913.102606921828, 30856.0, 32414.675853242108, 22076.2273320433, 22516.32451026472, 22523.211687590854, 22528.32415027552, 22590.774092258867], "unit": "score", "name": "ext.html", "value": 16486.88475168792}, {"lowerIsBetter": false, "replicates": [302.19013045039287, 306.0756515323721, 306.4514519010971, 313.33729162820634, 315.6685480245742, 12453.875461245385, 12878.227306361625, 14734.0, 15168.393264269429, 15227.771583426244, 14969.401223951028, 15280.797780610337, 16421.096839673814, 16626.085565293903, 16643.0, 4933.1860243059855, 5021.447640759514, 5171.974140129313, 5172.974135129319, 5178.093833579127, 3524.22467057247, 3615.2950174715943, 3617.2765446910594, 5064.797408103672, 5071.2139618359215, 5069.74651267437, 5094.7197904115255, 5100.642954993152, 5108.20822772469, 5174.353205849269, 5086.872828179288, 5133.1786914093755, 5366.114591092465, 5369.785208591652, 5374.6237763356585, 5061.848144555669, 5155.510226528474, 5159.5614372778355, 5166.5866730661455, 5167.069927413064, 18530.351437699617, 18936.337228197084, 19484.902575487173, 19504.902475487674, 19517.316893908646, 1689.923953422099, 1719.5271300392367, 1815.4916623345484, 1833.0, 1948.3473036532637, 8646.265067469272, 8808.383413161082, 8810.030896601369, 8835.690750823755, 8982.28141748665, 1682.4616122840696, 1702.9318827247018, 1747.1264367816093, 1766.4877185616285, 1799.973000404995, 48120.759396203146, 48262.27606585904, 48449.75775121137, 49495.0, 49768.75115624435, 9165.0, 9299.581518831668, 9376.437413755197, 9391.859122113174, 9647.973925475728, 12291.07816913735, 12296.139270250997, 12304.138710290194, 12305.44625491855, 12327.568535101229, 7087.291270872975, 7191.964040179766, 7202.53183543068, 7230.710771569184, 7247.13034435871, 6964.408025317804, 7005.824854378579, 7035.366816986393, 7120.6439678015895, 7145.964270178616, 4038.2932986727205, 4057.0, 4064.248114098901, 4068.6541643960595, 4069.9389509157386, 1586.0, 1617.3934774459578, 1622.448367555037, 1633.656932044284, 1655.180685560655, 387.3975967370709, 387.9670228030649, 403.4311620614919, 770.4799260499253, 896.5024411451576, 9390.0, 9874.0, 9939.453330066772, 10018.949905250573, 10072.546735396925, 340.1021303758081, 355.25928439204546, 385.35068409729695, 390.6425620557158, 394.3493236160301, 5230.686158830406, 5261.237120617489, 5276.630635855453, 5285.55072818807, 5340.893182136336, 463894.0, 470588.0, 470663.0, 474879.0, 480599.0, 69681.0, 73550.63224683842, 74490.627546863, 74566.66183374474, 75287.0, 421.00852492380005, 425.80838622619945, 426.3562021347787, 427.79893450077793, 428.07322147550826, 8853.335999800169, 8961.910380896108, 9047.095290470901, 9110.453372797654, 9134.22359099484, 30147.0, 30148.397032059675, 30891.227719307197, 31038.0, 31343.529847052767, 42439.57560424356, 43037.78481107575, 43625.12749744924, 43863.12273754443, 44366.556334436245, 8495.95752021236, 8830.955845220733, 8866.911330886609, 8867.512286824287, 8870.645174193218, 10356.689299321033, 10409.375437473776, 15331.77002344988, 16220.0, 16317.84780171877, 13236.470541178245, 13451.049597808458, 13732.244726540137, 13853.861461385257, 14067.226302553458, 13181.143225690299, 13723.245221512912, 13800.37898294559, 13969.790453143009, 14114.929425352808, 10688.305260158066, 14502.202378868842, 14668.633284167554, 14775.261236937895, 14915.403383864525, 7619.4285428594185, 7661.808454788675, 8155.306798921921, 8539.847120638635, 8737.344699147463, 12923.935380323039, 12957.093003489665, 13426.932865335611, 13491.662708432368, 13572.457101715821], "unit": "score", "name": "jquery.html", "value": 7329.15847513231}, {"lowerIsBetter": false, "replicates": [1266.1643315411818, 1634.4687976407668, 1683.9747403788945, 1706.462464323738, 1721.5265801904468, 6233.314335423105, 6917.377436030756, 7129.893051604224, 7136.072310599615, 7151.4993950423495, 7115.18175409828, 7158.606276654795, 7199.352058314751, 7223.277672232774, 7226.819329516765, 2106.368089573126, 2146.7531233908066, 2156.924507642225, 2157.7087093242367, 2159.082389984258, 2120.597086553558, 2162.9242976495825, 2166.588348213842, 2176.1948079210715, 2178.400939741568, 2082.9687554686693, 2103.547737236494, 2139.0, 2141.3040761752413, 2142.7857214278524, 2093.706881036656, 2113.619548481273, 2122.108714339981, 2123.4797474618663, 2123.479747461874, 2062.9277975270793, 2135.765065842756, 2144.024468866662, 2146.055735476401, 2150.2474134053114, 7156.606386648732, 7237.312455316736, 7264.164621068592, 7270.27297270274, 7279.126504819403, 4236.4704411948505, 4289.077848262607, 4292.5063617683745, 4293.076988447468, 4306.870793876189, 2742.766864816493, 2743.6158937748733, 2798.0906205483298, 2808.747212750862, 2813.4795062913427, 820.6061090676449, 873.3362644390246, 894.3873446689039, 896.5651658945407, 906.5557876640464, 9769.413835169913, 9816.460094694788, 9822.0, 9830.508474576314, 9830.606775729033, 3979.5025621797276, 4040.2727509048655, 4057.7159598827798, 4058.6144316289906, 4079.224947260011, 8385.454945428528, 8392.748217553482, 8401.70594029206, 8409.789755256168, 8414.284785793276, 4272.530021697611, 4295.29127693927, 4298.495526565677, 4307.07397909451, 4309.353596960481, 3373.4939759036342, 3453.7582369234415, 3804.1630841214887, 3938.7636741795586, 3941.3299739044432, 3435.2957643682985, 3456.9827150864085, 3463.89608311746, 3497.3529896969144, 3504.456809194579, 1091.9945400272948, 1092.6995076353908, 1101.658485869367, 1109.3011402816173, 1115.6931843743037, 807.075898096676, 817.6484111831969, 824.0688022534498, 824.1593574553922, 963.5134257200069, 6461.321561236003, 6463.838404039937, 6477.287498375175, 6487.2539657939, 6491.7078731457195, 425.41293015638223, 437.8183054032541, 440.24278241424696, 443.0363958390488, 446.4910002597042, 5229.581633469314, 5289.682619042793, 5292.100342941632, 5298.284731561267, 5298.81454149103, 7959.44283900133, 8137.430379873352, 8154.633041513146, 8449.070602233749, 8665.43674661145, 8275.793105172299, 8281.751547453587, 8293.21214484623, 8295.253427191461, 8303.875441868377, 6657.567258128206, 6788.694508747119, 6813.693383797741, 6863.245043045261, 6882.03651488792, 6651.434628056476, 6691.1636045494315, 6710.429613482908, 6714.462842972453, 6715.059891615276, 7638.197989211053, 7823.452358334862, 7997.560134192675, 8011.959940200261, 8015.158408367038, 8001.079875814356, 8174.100848906496, 8182.83634327322, 8283.337333013224, 8288.461250018729, 5551.861203469945, 5612.102063669793, 5753.223314852441, 6433.0, 6516.413522782972, 6494.058361537645, 6553.04980777775, 6565.507586931095, 6588.4399826013405, 6598.802035938929, 6194.659293738708, 6312.400321969406, 6364.172657554674, 6511.0, 6537.280899101, 6203.4416902479, 6296.5277604178955, 6300.59046161998, 6368.968155159195, 6452.35476452351, 6400.615963042046, 6428.967855160694, 6447.484841062253, 6469.159009328757, 6478.222613286436, 5671.48956593892, 5833.883322333614, 5856.150858125463, 5858.619189752652, 5864.618799778001, 5901.734421951109, 5986.281646202309, 5992.9811931972545, 5996.2504686914135, 6002.789902353396], "unit": "score", "name": "mootools.html", "value": 4005.2280304887504}, {"lowerIsBetter": false, "replicates": [286.067420210115, 288.04513039274804, 294.8127938758889, 294.8673097106302, 297.7632781938359, 5306.151015837457, 5327.7727615123285, 5428.728563571821, 5434.804343044534, 5508.421615730351, 5100.846974590768, 5225.686458812474, 5249.86875328117, 5387.0, 5394.73026348682, 4112.97943510282, 4143.834246630131, 4151.481064866892, 4151.688623353246, 4161.396597493362, 3913.6477717005464, 3984.342583473723, 4027.8388864445387, 4161.9375709364385, 4166.937495937564, 4071.97964010181, 4083.816228269735, 4115.135821477494, 4125.257453658341, 4126.690498212631, 4090.529589097262, 4111.198316328318, 4113.053997580573, 4119.382092686091, 4122.814473348676, 3595.496630471736, 3598.334308152974, 3605.0266428064538, 3607.657272559129, 3610.0613840401684, 5066.164082926312, 5148.407933087706, 5166.560842328407, 5178.456262092502, 5186.403563590197, 4748.19280722278, 4752.952470475286, 4755.833545825914, 4765.046990601859, 4766.237402015696, 5642.266505354278, 5644.209810626516, 5651.15232715096, 5658.0381335173115, 5661.065924122515, 3921.5882332355263, 3932.646061854447, 3932.7247092703524, 3935.74417662851, 3940.211957608461, 5824.777993288713, 5909.23179986599, 5951.970240148815, 5953.3748956359395, 5963.105534169866, 4048.4534587830854, 4052.65552428041, 4055.858044968471, 4059.6143366380147, 4062.9390559141048, 4103.4870641169855, 4106.301928672133, 4112.362583799516, 4112.424260603518, 4121.258173528794, 4741.1465936131135, 4741.644376671763, 4748.287756836502, 4749.430068391815, 4754.881127971828, 5545.833624991256, 5656.943430565724, 5660.066089095336, 5663.1505274208375, 5666.4900158985065, 1420.943162273518, 1458.1251249250577, 1459.4818839312104, 1459.6059064052859, 1460.3866376122055, 960.4765402855461, 992.4739887859301, 994.8408254679216, 1000.6847842929454, 1009.8737657792776, 4986.4514903360605, 4993.0, 4993.151164302078, 4995.625328100407, 4999.325091112726, 5877.647341159544, 5882.617629854046, 5885.176075349455, 5885.499732522783, 5894.381089985575, 4810.855674329776, 4904.779284932187, 4959.776810043557, 5030.245463180552, 5032.622553308516, 3156.068959656907, 3176.4758814795764, 3184.598776538362, 3188.8883889064236, 3191.728703060266, 5617.775288988395, 5622.184783206412, 5629.521490673257, 5630.859228519238, 5630.971845140748, 5877.971355012855, 6024.97575412181, 6076.392360763888, 6085.66528840918, 6086.05666121743, 5615.943840561542, 5634.915476267941, 5636.633618814764, 5639.295088114068, 5643.5203007743985, 5918.260217472816, 5924.940750592439, 5928.67392293428, 5932.466078052996, 5932.644041357532, 5669.234653321749, 5805.245318108618, 5812.18629391894, 5814.215080964016, 5814.505767009851, 5596.580256480862, 5620.943790562205, 5625.662460252398, 5626.465485778845, 5630.774769009194, 3934.7639141651593, 3956.1098752780395, 3962.326404511298, 3964.9207015860097, 3966.8413263470293, 5894.233749612695, 5902.881942361215, 5904.232449781501, 5909.940900591111, 5917.260342457193, 5575.972120139536, 5620.550355971431, 5674.375818660027, 5685.857853553694, 5706.885862282814, 5700.629459085146, 5703.458171473703, 5704.9429505706075, 5711.971440142773, 5713.971430142823, 5545.694986775766, 5574.16387541872, 5574.303212098488, 5579.581531385244, 5579.60942734021, 5552.305961754781, 5732.283464566929, 5740.0, 5741.5119714824705, 5742.655440673573, 5535.916961245504, 5577.721113944368, 5592.4966752990795, 5598.972005139948, 5608.214849921096], "unit": "score", "name": "prototype.html", "value": 4245.1206622973905}, {"lowerIsBetter": false, "replicates": [659.123365923322, 717.3364637710117, 738.5347231244314, 744.1219361153838, 796.0328201235498, 10627.096696780773, 10933.125349971993, 10934.890651093496, 10944.56221751131, 10956.28784129031, 11253.437328133601, 11264.549418023289, 11392.658220253385, 11395.886041139585, 11400.486978085984, 802.065593583476, 818.0265484073963, 818.3085292927467, 818.4966245758845, 818.5497976113144, 798.7124635131348, 806.7216810200472, 807.0557447786075, 807.1766797866202, 807.8020884883211, 847.0301504777027, 859.6002858670716, 859.9269062129727, 859.9785005374853, 860.0668274921718, 852.2372476633409, 852.5992783391796, 853.9871901921476, 854.0605334132435, 854.3336197765752, 626.5707990026846, 626.8902941985134, 627.560707504744, 627.6955676496896, 627.8367624417639, 10380.065794078493, 10502.159827213882, 10523.73690657732, 10537.73655658607, 10548.736281592945, 9124.178823905813, 9292.767680807967, 9393.718188454357, 9570.47362395068, 9711.90288097117, 8353.122922093215, 8358.874616880752, 8466.915330846736, 8529.445586036887, 8624.568771561397, 3124.5938028056435, 3141.0733833519166, 3176.174194709369, 3177.682231776827, 3220.838958052088, 33522.0, 34653.82673086669, 34692.479612805575, 35458.0, 37329.0, 9163.908360916439, 9301.860472092923, 9312.44125352481, 9321.300902432346, 9381.43711377306, 16692.499225023024, 16700.415485458194, 16742.0, 16751.0, 16755.91622041882, 6634.170728658918, 6657.40083392497, 6663.560573768027, 6722.529422940347, 6762.120924279812, 3627.6009638940222, 3639.454081887685, 3700.0379901225874, 3750.6249375062275, 3792.544894612664, 2608.67391576053, 2636.275024368276, 2640.6567146270863, 2642.656454660882, 2645.1535508637435, 471.7641179410295, 472.7399930038534, 472.75889296459053, 472.86759707282016, 475.07834800486944, 424.89377655586105, 426.45413870246136, 432.4356714487624, 435.84091806491034, 442.2393483208876, 6884.0, 7047.119110111236, 7266.491345605757, 7267.63661816907, 7344.375728063068, 473.01140616111803, 484.88847565060235, 507.44941738214453, 540.2895192821427, 595.1132812109925, 3469.65303469651, 3582.62382449839, 3595.119195796994, 3656.8720094796554, 3824.388097904322, 42577.0, 43055.13889722188, 43266.13467730691, 43303.78348108239, 43537.34693979593, 41193.88430327719, 43532.78233608875, 43902.780486098, 43996.0, 44120.779396103455, 36677.98271095115, 38332.80833595814, 39940.2011959765, 43675.12649746987, 43725.0, 6901.75843845463, 7162.498625096193, 7522.968798424504, 7665.846683066419, 7722.343600793771, 31219.219519511284, 31662.0, 31724.682753173096, 32415.67584324221, 32502.0, 36180.27639447249, 37433.81283093567, 39032.219355612164, 39591.0, 39857.40213896852, 8904.955475222583, 9122.771930701785, 9169.220616247694, 9252.814943701223, 9491.050894910453, 9908.405495670282, 10119.291649584458, 10157.644482443375, 10531.210159237935, 10635.20235982289, 8882.866756998521, 8947.373683842068, 9096.727098187064, 9558.0, 9781.315307928377, 9558.856617150888, 9741.172000380047, 9979.0, 10203.540840662337, 10289.2797504174, 9626.0, 9776.217902567636, 9873.703788886345, 9883.851742224017, 10403.063724264852, 8500.829983400421, 8520.573971301534, 8681.208287331416, 8800.823983520166, 9224.769380765534, 8133.430659853753, 8535.274501667427, 8562.100979397073, 8607.096254893146, 8779.325878530526], "unit": "score", "name": "yui.html", "value": 5446.387238011916}], "name": "dromaeo_css", "value": 6098.714496205465}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 111.0, 112.0, 113.0, 113.0, 102.0, 111.0, 110.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.9}, {"lowerIsBetter": true, "replicates": [162.0, 134.0, 155.0, 162.0, 129.0, 167.0, 152.0, 136.0, 170.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.5}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 160.0, 159.0, 163.0, 160.0, 161.0, 161.0, 161.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.5}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 91.0, 91.0, 71.0, 74.0, 74.0, 119.0, 88.0, 72.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 128.0, 95.0, 95.0, 95.0, 130.0, 94.0, 95.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 105.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [70.0, 73.0, 70.0, 70.0, 72.0, 70.0, 70.0, 82.0, 67.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 91.0, 82.0, 84.0, 83.0, 83.0, 83.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [120.0, 120.0, 123.0, 116.0, 122.0, 129.0, 117.0, 129.0, 135.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [135.0, 135.0, 147.0, 152.0, 150.0, 132.0, 149.0, 148.0, 146.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [72.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1517.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.88046166529267], "unit": "score", "name": "Richards", "value": 214.10663000000005}, {"lowerIsBetter": false, "replicates": [185.8045336306206], "unit": "score", "name": "DeltaBlue", "value": 355.8470759999999}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1968.5039370078741], "unit": "score", "name": "RayTrace", "value": 375.9144119999999}, {"lowerIsBetter": false, "replicates": [791.1392405063291], "unit": "score", "name": "Earley", "value": 842.4092320000002}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [27054.054054054053], "unit": "score", "name": "RegExp", "value": 33.67277222777225}, {"lowerIsBetter": false, "replicates": [597.8647686832741], "unit": "score", "name": "Splay", "value": 136.30339880952374}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19840.77452482569}]} 05:45:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19840.77"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1517.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6098.72"}}} 05:45:51 INFO - Return code: 0 05:45:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:45:51 INFO - # TBPL SUCCESS # 05:45:51 INFO - Running post-action listener: _resource_record_post_action 05:45:51 INFO - Running post-run listener: _resource_record_post_run 05:45:52 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 550170624; Read time: 0; Write time: 413176 05:45:52 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 228093952; Read time: 0; Write time: 256648 05:45:52 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 322076672; Read time: 0; Write time: 156528 05:45:52 INFO - Running post-run listener: _upload_blobber_files 05:45:52 INFO - Blob upload gear active. 05:45:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:45:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:45:53 INFO - (blobuploader) - INFO - Open directory for files ... 05:45:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:45:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:45:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:54 INFO - (blobuploader) - INFO - Done attempting. 05:45:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:45:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:45:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:45:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:45:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:45:55 INFO - (blobuploader) - INFO - Done attempting. 05:45:55 INFO - (blobuploader) - INFO - Iteration through files over. 05:45:55 INFO - Return code: 0 05:45:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:45:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:45:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc7126d4041c6b19d0216c97758bcb3ae9bd2b577c8f954ce6952a4c3bca56964127556e08b64f3b2ddb69d102b0b329d76062f364257f164896e06b2aa9f3db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c90ecfb9d30a79278fdc1e14a4fe086f1533816257be7c47de16bcb54e3d2d05c68a36c460dcb5ce55606800d676677c8a2de4475c7241d2f20431d2fa82b33"} 05:45:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:45:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:45:55 INFO - Contents: 05:45:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc7126d4041c6b19d0216c97758bcb3ae9bd2b577c8f954ce6952a4c3bca56964127556e08b64f3b2ddb69d102b0b329d76062f364257f164896e06b2aa9f3db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c90ecfb9d30a79278fdc1e14a4fe086f1533816257be7c47de16bcb54e3d2d05c68a36c460dcb5ce55606800d676677c8a2de4475c7241d2f20431d2fa82b33"} 05:45:55 INFO - Copying logs to upload dir... 05:45:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1280.703561 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 20 secs) (at 2015-12-21 05:45:55.011570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 05:45:55.014811) ========= 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=820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc7126d4041c6b19d0216c97758bcb3ae9bd2b577c8f954ce6952a4c3bca56964127556e08b64f3b2ddb69d102b0b329d76062f364257f164896e06b2aa9f3db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c90ecfb9d30a79278fdc1e14a4fe086f1533816257be7c47de16bcb54e3d2d05c68a36c460dcb5ce55606800d676677c8a2de4475c7241d2f20431d2fa82b33"} build_url:https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011411 build_url: 'https://queue.taskcluster.net/v1/task/lG6vyCIQTZ-B_eSHzKSssQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fc7126d4041c6b19d0216c97758bcb3ae9bd2b577c8f954ce6952a4c3bca56964127556e08b64f3b2ddb69d102b0b329d76062f364257f164896e06b2aa9f3db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4c90ecfb9d30a79278fdc1e14a4fe086f1533816257be7c47de16bcb54e3d2d05c68a36c460dcb5ce55606800d676677c8a2de4475c7241d2f20431d2fa82b33"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-21 05:45:55.040183) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:45:55.040873) ========= 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=820bb6602ddf640013a48df2000001a9-1450703840.752787-445921324 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-21 05:45:55.125597) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:45:55.125946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-21 05:45:55.126262) ========= ========= Total master_lag: 0.24 =========