builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1451939137.43 results: success (0) buildid: 20151231043737 builduid: 243a7c95570f4b3ea77743c0c991ab42 revision: 5a1d2aedd97fdb742ee1352b2567c293ba096fb8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.431573) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.432270) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.432799) ========= 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=7de08804244eb36560b44971000001c3-1451939136.804952-1602148427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006198 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.458735) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.459275) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.474480) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.475064) ========= 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=7de08804244eb36560b44971000001c3-1451939136.804952-1602148427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004582 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.526713) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.527269) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.527873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.528364) ========= 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=7de08804244eb36560b44971000001c3-1451939136.804952-1602148427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 12:25:37-- 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% 223M=0s 2016-01-04 12:25:37 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.120302 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.662167) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.665621) ========= 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=7de08804244eb36560b44971000001c3-1451939136.804952-1602148427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021037 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.716224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:37.716583) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5a1d2aedd97fdb742ee1352b2567c293ba096fb8 --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 5a1d2aedd97fdb742ee1352b2567c293ba096fb8 --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=7de08804244eb36560b44971000001c3-1451939136.804952-1602148427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 12:25:37,871 truncating revision to first 12 chars 2016-01-04 12:25:37,872 Setting DEBUG logging. 2016-01-04 12:25:37,872 attempt 1/10 2016-01-04 12:25:37,872 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5a1d2aedd97f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 12:25:38,149 unpacking tar archive at: fx-team-5a1d2aedd97f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.553878 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:38.283270) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:38.283714) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:38.538447) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:38.538841) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 12:25:38.539409) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-04 12:25:38.539710) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --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', '--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=7de08804244eb36560b44971000001c3-1451939136.804952-1602148427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:25:38 INFO - MultiFileLogger online at 20160104 12:25:38 in /builds/slave/test 12:25:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:25:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:25:38 INFO - {'append_to_log': False, 12:25:38 INFO - 'base_work_dir': '/builds/slave/test', 12:25:38 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:25:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:25:38 INFO - 'branch': 'Fx-Team-Non-PGO', 12:25:38 INFO - 'buildbot_json_path': 'buildprops.json', 12:25:38 INFO - 'config_files': ('talos/linux_config.py',), 12:25:38 INFO - 'default_actions': ('clobber', 12:25:38 INFO - 'read-buildbot-config', 12:25:38 INFO - 'download-and-extract', 12:25:38 INFO - 'populate-webroot', 12:25:38 INFO - 'create-virtualenv', 12:25:38 INFO - 'install', 12:25:38 INFO - 'run-tests'), 12:25:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:25:38 INFO - 'download_minidump_stackwalk': True, 12:25:38 INFO - 'download_symbols': 'ondemand', 12:25:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:25:38 INFO - 'tooltool.py': '/tools/tooltool.py', 12:25:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:25:38 INFO - '/tools/misc-python/virtualenv.py')}, 12:25:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:25:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:25:38 INFO - 'installer_path': 'installer.exe', 12:25:38 INFO - 'log_level': 'info', 12:25:38 INFO - 'log_name': 'talos', 12:25:38 INFO - 'log_to_console': True, 12:25:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:25:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:25:38 INFO - 'opt_config_files': (), 12:25:38 INFO - 'pip_index': False, 12:25:38 INFO - 'sps_profile': False, 12:25:38 INFO - 'sps_profile_interval': 0, 12:25:38 INFO - 'suite': 'dromaeojs', 12:25:38 INFO - 'system_bits': '32', 12:25:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:25:38 INFO - 'title': 'talos-linux64-ix-003', 12:25:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:25:38 INFO - 'use_talos_json': True, 12:25:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:25:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:25:38 INFO - 'work_dir': 'build'} 12:25:38 INFO - ##### 12:25:38 INFO - ##### Running clobber step. 12:25:38 INFO - ##### 12:25:38 INFO - Running pre-action listener: _resource_record_pre_action 12:25:38 INFO - Running main action method: clobber 12:25:38 INFO - rmtree: /builds/slave/test/build 12:25:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:25:39 INFO - Running post-action listener: _resource_record_post_action 12:25:39 INFO - ##### 12:25:39 INFO - ##### Running read-buildbot-config step. 12:25:39 INFO - ##### 12:25:39 INFO - Running pre-action listener: _resource_record_pre_action 12:25:39 INFO - Running main action method: read_buildbot_config 12:25:39 INFO - Using buildbot properties: 12:25:39 INFO - { 12:25:39 INFO - "project": "", 12:25:39 INFO - "product": "firefox", 12:25:39 INFO - "script_repo_revision": "production", 12:25:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:25:39 INFO - "repository": "", 12:25:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:25:39 INFO - "buildid": "20151231043737", 12:25:39 INFO - "pgo_build": "False", 12:25:39 INFO - "basedir": "/builds/slave/test", 12:25:39 INFO - "buildnumber": 1085, 12:25:39 INFO - "slavename": "talos-linux64-ix-003", 12:25:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:25:39 INFO - "platform": "ubuntu64_hw", 12:25:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:25:39 INFO - "branch": "fx-team", 12:25:39 INFO - "repo_path": "integration/fx-team", 12:25:39 INFO - "revision": "5a1d2aedd97fdb742ee1352b2567c293ba096fb8", 12:25:39 INFO - "stage_platform": "linux64", 12:25:39 INFO - "builduid": "243a7c95570f4b3ea77743c0c991ab42", 12:25:39 INFO - "slavebuilddir": "test" 12:25:39 INFO - } 12:25:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:25:39 INFO - Running post-action listener: _resource_record_post_action 12:25:39 INFO - ##### 12:25:39 INFO - ##### Running download-and-extract step. 12:25:39 INFO - ##### 12:25:39 INFO - Running pre-action listener: _resource_record_pre_action 12:25:39 INFO - Running main action method: download_and_extract 12:25:39 INFO - mkdir: /builds/slave/test/build/tests 12:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:39 INFO - https://queue.taskcluster.net/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:25:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/test_packages.json 12:25:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/test_packages.json 12:25:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:25:40 INFO - Downloaded 1302 bytes. 12:25:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:25:40 INFO - Using the following test package requirements: 12:25:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:25:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:25:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:25:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:25:40 INFO - u'jsshell-linux-x86_64.zip'], 12:25:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:25:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:25:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:25:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:25:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:25:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:25:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:25:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:25:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:25:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:25:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:25:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:25:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:40 INFO - https://queue.taskcluster.net/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:25:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:25:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:25:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/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 12:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/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 12:25:41 INFO - Downloaded 21946183 bytes. 12:25:41 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 12:25:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:25:41 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 12:25:42 INFO - Return code: 0 12:25:42 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 12:25:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:42 INFO - https://queue.taskcluster.net/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:25:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:25:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:25:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/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 12:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/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 12:25:44 INFO - Downloaded 21946183 bytes. 12:25:44 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 12:25:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:25:44 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 12:25:46 INFO - Return code: 0 12:25: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')]} 12:25:46 INFO - https://queue.taskcluster.net/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:25:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:25:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:25:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/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 12:25:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/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 12:25:47 INFO - Downloaded 11132285 bytes. 12:25:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 12:25:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:25:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:25:47 INFO - Return code: 0 12:25:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:47 INFO - https://queue.taskcluster.net/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:25:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:25:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:25:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/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 12:25:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ADFQF5VhTPiHlOXkifomow/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 12:25:49 INFO - Downloaded 53361114 bytes. 12:25:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:25:49 INFO - mkdir: /builds/slave/test/properties 12:25:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:25:49 INFO - Writing to file /builds/slave/test/properties/build_url 12:25:49 INFO - Contents: 12:25:49 INFO - build_url:https://queue.taskcluster.net/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:25:49 INFO - Running post-action listener: _resource_record_post_action 12:25:49 INFO - Running post-action listener: set_extra_try_arguments 12:25:49 INFO - ##### 12:25:49 INFO - ##### Running populate-webroot step. 12:25:49 INFO - ##### 12:25:49 INFO - Running pre-action listener: _resource_record_pre_action 12:25:49 INFO - Running main action method: populate_webroot 12:25:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:25:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:25:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:25:49 INFO - '--tppagecycles', 12:25:49 INFO - '7'], 12:25:49 INFO - 'tests': ['tsvgm']}}, 12:25:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:25:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:25:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:25:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:25:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:25:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:25:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:25:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:49 INFO - 'talos_options': ['--e10s'], 12:25:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:25:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:49 INFO - 'tests': ['damp', 'tps']}, 12:25:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:49 INFO - 'talos_options': ['--e10s'], 12:25:49 INFO - 'tests': ['damp', 'tps']}, 12:25:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:25:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:25:49 INFO - 'other': {'tests': ['a11yr', 12:25:49 INFO - 'ts_paint', 12:25:49 INFO - 'tpaint', 12:25:49 INFO - 'sessionrestore', 12:25:49 INFO - 'sessionrestore_no_auto_restore']}, 12:25:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:25:49 INFO - 'tests': ['a11yr', 12:25:49 INFO - 'ts_paint', 12:25:49 INFO - 'tpaint', 12:25:49 INFO - 'sessionrestore', 12:25:49 INFO - 'sessionrestore_no_auto_restore']}, 12:25:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:25:49 INFO - 'tests': ['a11yr', 12:25:49 INFO - 'ts_paint', 12:25:49 INFO - 'tpaint', 12:25:49 INFO - 'sessionrestore', 12:25:49 INFO - 'sessionrestore_no_auto_restore']}, 12:25:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:25:49 INFO - 'tests': ['a11yr', 12:25:49 INFO - 'ts_paint', 12:25:49 INFO - 'tpaint', 12:25:49 INFO - 'sessionrestore', 12:25:49 INFO - 'sessionrestore_no_auto_restore']}, 12:25:49 INFO - 'other_l64': {'tests': ['a11yr', 12:25:49 INFO - 'ts_paint', 12:25:49 INFO - 'tpaint', 12:25:49 INFO - 'sessionrestore', 12:25:49 INFO - 'sessionrestore_no_auto_restore']}, 12:25:49 INFO - 'other_nol64': {'tests': ['a11yr', 12:25:49 INFO - 'ts_paint', 12:25:49 INFO - 'tpaint', 12:25:49 INFO - 'sessionrestore', 12:25:49 INFO - 'sessionrestore_no_auto_restore']}, 12:25:49 INFO - 'svgr': {'tests': ['tsvgx', 12:25:49 INFO - 'tsvgr_opacity', 12:25:49 INFO - 'tart', 12:25:49 INFO - 'tscrollx', 12:25:49 INFO - 'cart']}, 12:25:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:25:49 INFO - 'tests': ['tsvgx', 12:25:49 INFO - 'tsvgr_opacity', 12:25:49 INFO - 'tart', 12:25:49 INFO - 'tscrollx', 12:25:49 INFO - 'cart']}, 12:25:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:49 INFO - 'tests': ['tp5o']}, 12:25:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:49 INFO - 'talos_options': ['--e10s'], 12:25:49 INFO - 'tests': ['tp5o']}, 12:25:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:49 INFO - 'talos_options': ['--xperf_path', 12:25:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:25:49 INFO - 'tests': ['tp5n']}, 12:25:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:25:49 INFO - 'talos_options': ['--e10s', 12:25:49 INFO - '--xperf_path', 12:25:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:25:49 INFO - 'tests': ['tp5n']}}, 12:25:49 INFO - 'talos.zip': {'path': '', 12:25:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:25:49 INFO - Running post-action listener: _resource_record_post_action 12:25:49 INFO - ##### 12:25:49 INFO - ##### Running create-virtualenv step. 12:25:49 INFO - ##### 12:25:49 INFO - Running pre-action listener: _resource_record_pre_action 12:25:49 INFO - Running main action method: create_virtualenv 12:25:49 INFO - Creating virtualenv /builds/slave/test/build/venv 12:25:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:25:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:25:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:25:49 INFO - Using real prefix '/usr' 12:25:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:25:49 INFO - Installing distribute.............................................................................................................................................................................................done. 12:25:51 INFO - Installing pip.................done. 12:25:51 INFO - Return code: 0 12:25:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f388b6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20673d0>, '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 0x1fd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd3360>, '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': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', '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 12:25:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:25:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:25:51 INFO - Using env: {'DISPLAY': ':0', 12:25:51 INFO - 'HOME': '/home/cltbld', 12:25:51 INFO - 'LANG': 'en_US.UTF-8', 12:25:51 INFO - 'LANGUAGE': 'en_US:en', 12:25:51 INFO - 'LOGNAME': 'cltbld', 12:25:51 INFO - 'MAIL': '/var/mail/cltbld', 12:25:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:51 INFO - 'MOZ_NO_REMOTE': '1', 12:25:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:51 INFO - 'NO_EM_RESTART': '1', 12:25:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:51 INFO - 'PWD': '/builds/slave/test', 12:25:51 INFO - 'SHELL': '/bin/bash', 12:25:51 INFO - 'SHLVL': '1', 12:25:51 INFO - 'TERM': 'linux', 12:25:51 INFO - 'TMOUT': '86400', 12:25:51 INFO - 'USER': 'cltbld', 12:25:51 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', 12:25:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:51 INFO - '_': '/tools/buildbot/bin/python'} 12:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:52 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 12:25:52 INFO - Cleaning up... 12:25:52 INFO - Return code: 0 12:25:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:52 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 0x7f388b6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20673d0>, '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 0x1fd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd3360>, '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': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', '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 12:25:52 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 12:25:52 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 12:25:52 INFO - Using env: {'DISPLAY': ':0', 12:25:52 INFO - 'HOME': '/home/cltbld', 12:25:52 INFO - 'LANG': 'en_US.UTF-8', 12:25:52 INFO - 'LANGUAGE': 'en_US:en', 12:25:52 INFO - 'LOGNAME': 'cltbld', 12:25:52 INFO - 'MAIL': '/var/mail/cltbld', 12:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:52 INFO - 'MOZ_NO_REMOTE': '1', 12:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:52 INFO - 'NO_EM_RESTART': '1', 12:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:52 INFO - 'PWD': '/builds/slave/test', 12:25:52 INFO - 'SHELL': '/bin/bash', 12:25:52 INFO - 'SHLVL': '1', 12:25:52 INFO - 'TERM': 'linux', 12:25:52 INFO - 'TMOUT': '86400', 12:25:52 INFO - 'USER': 'cltbld', 12:25:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', 12:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:52 INFO - '_': '/tools/buildbot/bin/python'} 12:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:52 INFO - Downloading/unpacking psutil>=0.7.1 12:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:25:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:25:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:25:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:25:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:25:54 INFO - Installing collected packages: psutil 12:25:54 INFO - Running setup.py install for psutil 12:25:54 INFO - building 'psutil._psutil_linux' extension 12:25:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:25:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:25:54 INFO - building 'psutil._psutil_posix' extension 12:25:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:25:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:25:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:25:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:25:54 INFO - Successfully installed psutil 12:25:54 INFO - Cleaning up... 12:25:54 INFO - Return code: 0 12:25:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f388b6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20673d0>, '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 0x1fd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd3360>, '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': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', '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 12:25:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:25:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:25:54 INFO - Using env: {'DISPLAY': ':0', 12:25:54 INFO - 'HOME': '/home/cltbld', 12:25:54 INFO - 'LANG': 'en_US.UTF-8', 12:25:54 INFO - 'LANGUAGE': 'en_US:en', 12:25:54 INFO - 'LOGNAME': 'cltbld', 12:25:54 INFO - 'MAIL': '/var/mail/cltbld', 12:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:54 INFO - 'MOZ_NO_REMOTE': '1', 12:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:54 INFO - 'NO_EM_RESTART': '1', 12:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:54 INFO - 'PWD': '/builds/slave/test', 12:25:54 INFO - 'SHELL': '/bin/bash', 12:25:54 INFO - 'SHLVL': '1', 12:25:54 INFO - 'TERM': 'linux', 12:25:54 INFO - 'TMOUT': '86400', 12:25:54 INFO - 'USER': 'cltbld', 12:25:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', 12:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:54 INFO - '_': '/tools/buildbot/bin/python'} 12:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:25:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:25:56 INFO - Installing collected packages: mozsystemmonitor 12:25:56 INFO - Running setup.py install for mozsystemmonitor 12:25:56 INFO - Successfully installed mozsystemmonitor 12:25:56 INFO - Cleaning up... 12:25:56 INFO - Return code: 0 12:25:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f388b6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20673d0>, '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 0x1fd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd3360>, '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': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', '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 12:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:25:56 INFO - Using env: {'DISPLAY': ':0', 12:25:56 INFO - 'HOME': '/home/cltbld', 12:25:56 INFO - 'LANG': 'en_US.UTF-8', 12:25:56 INFO - 'LANGUAGE': 'en_US:en', 12:25:56 INFO - 'LOGNAME': 'cltbld', 12:25:56 INFO - 'MAIL': '/var/mail/cltbld', 12:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:56 INFO - 'MOZ_NO_REMOTE': '1', 12:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:56 INFO - 'NO_EM_RESTART': '1', 12:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:56 INFO - 'PWD': '/builds/slave/test', 12:25:56 INFO - 'SHELL': '/bin/bash', 12:25:56 INFO - 'SHLVL': '1', 12:25:56 INFO - 'TERM': 'linux', 12:25:56 INFO - 'TMOUT': '86400', 12:25:56 INFO - 'USER': 'cltbld', 12:25:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', 12:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:56 INFO - '_': '/tools/buildbot/bin/python'} 12:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:25:56 INFO - Downloading/unpacking blobuploader==1.2.4 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25:58 INFO - Downloading blobuploader-1.2.4.tar.gz 12:25:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:25:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:25:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:25:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25: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 12:25:59 INFO - Downloading docopt-0.6.1.tar.gz 12:25:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:25:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:25:59 INFO - Installing collected packages: blobuploader, requests, docopt 12:25:59 INFO - Running setup.py install for blobuploader 12:25:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:25:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:25:59 INFO - Running setup.py install for requests 12:25:59 INFO - Running setup.py install for docopt 12:25:59 INFO - Successfully installed blobuploader requests docopt 12:25:59 INFO - Cleaning up... 12:25:59 INFO - Return code: 0 12:25:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:25: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')]} 12:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25: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')]} 12:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:25:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f388b6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20673d0>, '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 0x1fd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd3360>, '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': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', '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 12:25:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:25:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:25:59 INFO - Using env: {'DISPLAY': ':0', 12:25:59 INFO - 'HOME': '/home/cltbld', 12:25:59 INFO - 'LANG': 'en_US.UTF-8', 12:25:59 INFO - 'LANGUAGE': 'en_US:en', 12:25:59 INFO - 'LOGNAME': 'cltbld', 12:25:59 INFO - 'MAIL': '/var/mail/cltbld', 12:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:25:59 INFO - 'MOZ_NO_REMOTE': '1', 12:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:25:59 INFO - 'NO_EM_RESTART': '1', 12:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:25:59 INFO - 'PWD': '/builds/slave/test', 12:25:59 INFO - 'SHELL': '/bin/bash', 12:25:59 INFO - 'SHLVL': '1', 12:25:59 INFO - 'TERM': 'linux', 12:25:59 INFO - 'TMOUT': '86400', 12:25:59 INFO - 'USER': 'cltbld', 12:25:59 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', 12:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:25:59 INFO - '_': '/tools/buildbot/bin/python'} 12:26:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:26:00 INFO - Running setup.py (path:/tmp/pip-gNiVd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:26:00 INFO - Running setup.py (path:/tmp/pip-z_2roQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:26:00 INFO - Running setup.py (path:/tmp/pip-dFReir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:26:00 INFO - Running setup.py (path:/tmp/pip-XUTSUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:26:00 INFO - Running setup.py (path:/tmp/pip-R0wQ9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:26:00 INFO - Running setup.py (path:/tmp/pip-pqmTvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:26:00 INFO - Running setup.py (path:/tmp/pip-uwNEX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:26:00 INFO - Running setup.py (path:/tmp/pip-Puv2GF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:26:00 INFO - Running setup.py (path:/tmp/pip-AvfrOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:26:00 INFO - Running setup.py (path:/tmp/pip-MFeP9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:26:00 INFO - Running setup.py (path:/tmp/pip-l9oFvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:26:00 INFO - Running setup.py (path:/tmp/pip-0KIqXK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:26:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:26:00 INFO - Running setup.py (path:/tmp/pip-CMWM91-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:26:01 INFO - Running setup.py (path:/tmp/pip-_AR2Of-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:01 INFO - Running setup.py (path:/tmp/pip-CmIrpR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:26:01 INFO - Running setup.py (path:/tmp/pip-ggYieA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:26:01 INFO - Running setup.py (path:/tmp/pip-D6gBrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:26:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:26:01 INFO - Running setup.py install for manifestparser 12:26:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Running setup.py install for mozcrash 12:26:01 INFO - Running setup.py install for mozdebug 12:26:01 INFO - Running setup.py install for mozdevice 12:26:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Running setup.py install for mozfile 12:26:01 INFO - Running setup.py install for mozhttpd 12:26:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:26:01 INFO - Running setup.py install for mozinfo 12:26:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Running setup.py install for mozInstall 12:26:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Running setup.py install for mozleak 12:26:02 INFO - Running setup.py install for mozlog 12:26:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Running setup.py install for moznetwork 12:26:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Running setup.py install for mozprocess 12:26:02 INFO - Running setup.py install for mozprofile 12:26:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Running setup.py install for mozrunner 12:26:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:26:02 INFO - Running setup.py install for mozscreenshot 12:26:02 INFO - Running setup.py install for moztest 12:26:03 INFO - Running setup.py install for mozversion 12:26:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:26:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:26:03 INFO - Cleaning up... 12:26:03 INFO - Return code: 0 12:26:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f388b6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20673d0>, '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 0x1fd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd3360>, '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': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', '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 12:26:03 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 12:26:03 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 12:26:03 INFO - Using env: {'DISPLAY': ':0', 12:26:03 INFO - 'HOME': '/home/cltbld', 12:26:03 INFO - 'LANG': 'en_US.UTF-8', 12:26:03 INFO - 'LANGUAGE': 'en_US:en', 12:26:03 INFO - 'LOGNAME': 'cltbld', 12:26:03 INFO - 'MAIL': '/var/mail/cltbld', 12:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:03 INFO - 'MOZ_NO_REMOTE': '1', 12:26:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:03 INFO - 'NO_EM_RESTART': '1', 12:26:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:03 INFO - 'PWD': '/builds/slave/test', 12:26:03 INFO - 'SHELL': '/bin/bash', 12:26:03 INFO - 'SHLVL': '1', 12:26:03 INFO - 'TERM': 'linux', 12:26:03 INFO - 'TMOUT': '86400', 12:26:03 INFO - 'USER': 'cltbld', 12:26:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', 12:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:03 INFO - '_': '/tools/buildbot/bin/python'} 12:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:26:03 INFO - Running setup.py (path:/tmp/pip-7k2ALI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:26:03 INFO - Running setup.py (path:/tmp/pip-ZyP9OR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:26:03 INFO - Running setup.py (path:/tmp/pip-uY7Fnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:26:03 INFO - Running setup.py (path:/tmp/pip-2H852N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:26:03 INFO - Running setup.py (path:/tmp/pip-eyrbtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:26:03 INFO - Running setup.py (path:/tmp/pip-zSXenx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:26:03 INFO - Running setup.py (path:/tmp/pip-OYdSMF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:26:03 INFO - Running setup.py (path:/tmp/pip-HepO9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:26:03 INFO - Running setup.py (path:/tmp/pip-o1ocrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:26:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:26:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:26:03 INFO - Running setup.py (path:/tmp/pip-L5nTr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:26:04 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)) 12:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:26:04 INFO - Running setup.py (path:/tmp/pip-cQgvW4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:26:04 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)) 12:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:26:04 INFO - Running setup.py (path:/tmp/pip-e2amC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:26:04 INFO - Running setup.py (path:/tmp/pip-nrbjiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:26:04 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)) 12:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:26:04 INFO - Running setup.py (path:/tmp/pip-neJRE0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:04 INFO - Running setup.py (path:/tmp/pip-ofuPhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:26:04 INFO - Running setup.py (path:/tmp/pip-fnTIWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:26:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:26:04 INFO - Running setup.py (path:/tmp/pip-d9v02H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:26:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:06 INFO - Downloading blessings-1.5.1.tar.gz 12:26:06 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:26:06 INFO - Installing collected packages: blessings 12:26:06 INFO - Running setup.py install for blessings 12:26:06 INFO - Successfully installed blessings 12:26:06 INFO - Cleaning up... 12:26:06 INFO - Return code: 0 12:26:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:26:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:26:06 INFO - Reading from file tmpfile_stdout 12:26:06 INFO - Current package versions: 12:26:06 INFO - argparse == 1.2.1 12:26:06 INFO - blessings == 1.5.1 12:26:06 INFO - blobuploader == 1.2.4 12:26:06 INFO - docopt == 0.6.1 12:26:06 INFO - manifestparser == 1.1 12:26:06 INFO - mozInstall == 1.12 12:26:06 INFO - mozcrash == 0.16 12:26:06 INFO - mozdebug == 0.1 12:26:06 INFO - mozdevice == 0.47 12:26:06 INFO - mozfile == 1.2 12:26:06 INFO - mozhttpd == 0.7 12:26:06 INFO - mozinfo == 0.9 12:26:06 INFO - mozleak == 0.1 12:26:06 INFO - mozlog == 3.1 12:26:06 INFO - moznetwork == 0.27 12:26:06 INFO - mozprocess == 0.22 12:26:06 INFO - mozprofile == 0.28 12:26:06 INFO - mozrunner == 6.11 12:26:06 INFO - mozscreenshot == 0.1 12:26:06 INFO - mozsystemmonitor == 0.0 12:26:06 INFO - moztest == 0.7 12:26:06 INFO - mozversion == 1.4 12:26:06 INFO - psutil == 3.1.1 12:26:06 INFO - requests == 1.2.3 12:26:06 INFO - wsgiref == 0.1.2 12:26:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f388b6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20673d0>, '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 0x1fd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd3360>, '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': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', '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 12:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:26:06 INFO - Using env: {'DISPLAY': ':0', 12:26:06 INFO - 'HOME': '/home/cltbld', 12:26:06 INFO - 'LANG': 'en_US.UTF-8', 12:26:06 INFO - 'LANGUAGE': 'en_US:en', 12:26:06 INFO - 'LOGNAME': 'cltbld', 12:26:06 INFO - 'MAIL': '/var/mail/cltbld', 12:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:06 INFO - 'MOZ_NO_REMOTE': '1', 12:26:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:06 INFO - 'NO_EM_RESTART': '1', 12:26:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:06 INFO - 'PWD': '/builds/slave/test', 12:26:06 INFO - 'SHELL': '/bin/bash', 12:26:06 INFO - 'SHLVL': '1', 12:26:06 INFO - 'TERM': 'linux', 12:26:06 INFO - 'TMOUT': '86400', 12:26:06 INFO - 'USER': 'cltbld', 12:26:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', 12:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:06 INFO - '_': '/tools/buildbot/bin/python'} 12:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:07 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)) 12:26:07 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)) 12:26:07 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)) 12:26:07 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)) 12:26:07 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)) 12:26:07 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)) 12:26:07 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)) 12:26:07 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)) 12:26:07 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)) 12:26:07 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)) 12:26:07 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)) 12:26:07 INFO - Cleaning up... 12:26:07 INFO - Return code: 0 12:26:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:26: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')]} 12:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26: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')]} 12:26:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f388b6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20673d0>, '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 0x1fd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd3360>, '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': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', '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 12:26:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:26:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:26:07 INFO - Using env: {'DISPLAY': ':0', 12:26:07 INFO - 'HOME': '/home/cltbld', 12:26:07 INFO - 'LANG': 'en_US.UTF-8', 12:26:07 INFO - 'LANGUAGE': 'en_US:en', 12:26:07 INFO - 'LOGNAME': 'cltbld', 12:26:07 INFO - 'MAIL': '/var/mail/cltbld', 12:26:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:07 INFO - 'MOZ_NO_REMOTE': '1', 12:26:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:07 INFO - 'NO_EM_RESTART': '1', 12:26:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:07 INFO - 'PWD': '/builds/slave/test', 12:26:07 INFO - 'SHELL': '/bin/bash', 12:26:07 INFO - 'SHLVL': '1', 12:26:07 INFO - 'TERM': 'linux', 12:26:07 INFO - 'TMOUT': '86400', 12:26:07 INFO - 'USER': 'cltbld', 12:26:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', 12:26:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:07 INFO - '_': '/tools/buildbot/bin/python'} 12:26:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:07 INFO - Downloading/unpacking jsonschema 12:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:26:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:26:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:26:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:26:09 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 12:26:09 INFO - Downloading/unpacking functools32 (from jsonschema) 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26:09 INFO - Downloading functools32-3.2.3-2.tar.gz 12:26:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:26:09 INFO - warning: no files found matching '*.txt' 12:26:09 INFO - no previously-included directories found matching 'build' 12:26:09 INFO - no previously-included directories found matching 'dist' 12:26:09 INFO - no previously-included directories found matching '.git*' 12:26:09 INFO - Installing collected packages: jsonschema, functools32 12:26:09 INFO - Running setup.py install for functools32 12:26:09 INFO - warning: no files found matching '*.txt' 12:26:09 INFO - no previously-included directories found matching 'build' 12:26:09 INFO - no previously-included directories found matching 'dist' 12:26:09 INFO - no previously-included directories found matching '.git*' 12:26:09 INFO - Successfully installed jsonschema functools32 12:26:09 INFO - Cleaning up... 12:26:09 INFO - Return code: 0 12:26:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:26:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:26:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:26:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:26:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f388b6f2f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd4dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20673d0>, '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 0x1fd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd3360>, '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': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', '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 12:26:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 12:26:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 12:26:09 INFO - Using env: {'DISPLAY': ':0', 12:26:09 INFO - 'HOME': '/home/cltbld', 12:26:09 INFO - 'LANG': 'en_US.UTF-8', 12:26:09 INFO - 'LANGUAGE': 'en_US:en', 12:26:09 INFO - 'LOGNAME': 'cltbld', 12:26:09 INFO - 'MAIL': '/var/mail/cltbld', 12:26:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:09 INFO - 'MOZ_NO_REMOTE': '1', 12:26:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:09 INFO - 'NO_EM_RESTART': '1', 12:26:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:09 INFO - 'PWD': '/builds/slave/test', 12:26:09 INFO - 'SHELL': '/bin/bash', 12:26:09 INFO - 'SHLVL': '1', 12:26:09 INFO - 'TERM': 'linux', 12:26:09 INFO - 'TMOUT': '86400', 12:26:09 INFO - 'USER': 'cltbld', 12:26:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', 12:26:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:09 INFO - '_': '/tools/buildbot/bin/python'} 12:26:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:26:09 INFO - Downloading/unpacking flake8 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:26:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 12:26:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:26:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 12:26:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 12:26:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26: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 12:26:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:26:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:26:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:26:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:26:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:26:12 INFO - no previously-included directories found matching 'docs/_build' 12:26:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:26:12 INFO - Running setup.py install for pep8 12:26:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:26:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:26:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:26:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:26:12 INFO - no previously-included directories found matching 'docs/_build' 12:26:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:26:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:26:12 INFO - Cleaning up... 12:26:12 INFO - Return code: 0 12:26:12 INFO - Running post-action listener: _resource_record_post_action 12:26:12 INFO - Running post-action listener: _start_resource_monitoring 12:26:12 INFO - Starting resource monitoring. 12:26:12 INFO - ##### 12:26:12 INFO - ##### Running install step. 12:26:12 INFO - ##### 12:26:12 INFO - Running pre-action listener: _resource_record_pre_action 12:26:12 INFO - Running main action method: install 12:26:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:26:12 INFO - Reading from file tmpfile_stdout 12:26:12 INFO - Detecting whether we're running mozinstall >=1.0... 12:26:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:26:12 INFO - Reading from file tmpfile_stdout 12:26:12 INFO - Output received: 12:26:12 INFO - Usage: mozinstall [options] installer 12:26:12 INFO - Options: 12:26:12 INFO - -h, --help show this help message and exit 12:26:12 INFO - -d DEST, --destination=DEST 12:26:12 INFO - Directory to install application into. [default: 12:26:12 INFO - "/builds/slave/test"] 12:26:12 INFO - --app=APP Application being installed. [default: firefox] 12:26:12 INFO - mkdir: /builds/slave/test/build/application 12:26:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:26:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:26:28 INFO - Reading from file tmpfile_stdout 12:26:28 INFO - Output received: 12:26:28 INFO - /builds/slave/test/build/application/firefox/firefox 12:26:28 INFO - Running post-action listener: _resource_record_post_action 12:26:28 INFO - ##### 12:26:28 INFO - ##### Running run-tests step. 12:26:28 INFO - ##### 12:26:28 INFO - Running pre-action listener: _resource_record_pre_action 12:26:28 INFO - Running main action method: run_tests 12:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:26:28 INFO - Python 2.7.3 12:26:28 INFO - Return code: 0 12:26:28 INFO - grabbing minidump binary from tooltool 12:26:28 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')]} 12:26:28 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 0x20673d0>, '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 0x1fd2ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1fd3360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:26:28 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 12:26:28 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 12:26:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:26:28 INFO - Return code: 0 12:26:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:26:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:26:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:26:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:26:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:26:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:26:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:26:29 INFO - Return code: 0 12:26:29 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/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 12:26:29 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/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 12:26:29 INFO - Using env: {'DISPLAY': ':0', 12:26:29 INFO - 'HOME': '/home/cltbld', 12:26:29 INFO - 'LANG': 'en_US.UTF-8', 12:26:29 INFO - 'LANGUAGE': 'en_US:en', 12:26:29 INFO - 'LOGNAME': 'cltbld', 12:26:29 INFO - 'MAIL': '/var/mail/cltbld', 12:26:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:26:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:26:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:26:29 INFO - 'MOZ_NO_REMOTE': '1', 12:26:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:26:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:26:29 INFO - 'NO_EM_RESTART': '1', 12:26:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:26:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:26:29 INFO - 'PWD': '/builds/slave/test', 12:26:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:26:29 INFO - 'SHELL': '/bin/bash', 12:26:29 INFO - 'SHLVL': '1', 12:26:29 INFO - 'TERM': 'linux', 12:26:29 INFO - 'TMOUT': '86400', 12:26:29 INFO - 'USER': 'cltbld', 12:26:29 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1451939136.804952-1602148427', 12:26:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:26:29 INFO - '_': '/tools/buildbot/bin/python'} 12:26:29 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/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 12:26:29 INFO - mozversion application_buildid: 20151231043737 12:26:29 INFO - mozversion application_changeset: 5a1d2aedd97fdb742ee1352b2567c293ba096fb8 12:26:29 INFO - mozversion application_display_name: Nightly 12:26:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:26:29 INFO - mozversion application_name: Firefox 12:26:29 INFO - mozversion application_remotingname: firefox 12:26:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:26:29 INFO - mozversion application_vendor: Mozilla 12:26:29 INFO - mozversion application_version: 46.0a1 12:26:29 INFO - mozversion platform_buildid: 20151231043737 12:26:29 INFO - mozversion platform_changeset: 5a1d2aedd97fdb742ee1352b2567c293ba096fb8 12:26:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:26:29 INFO - mozversion platform_version: 46.0a1 12:26:29 INFO - using testdate: 1451939189 12:26:29 INFO - actual date: 1451939189 12:26:29 INFO - starting webserver on 'localhost:38035' 12:26:29 INFO - SUITE-START | Running 3 tests 12:26:29 INFO - TEST-START | dromaeo_css 12:26:29 INFO - operating with platform_type : linux_ 12:26:29 INFO - Initialising browser for dromaeo_css test... 12:26:29 INFO - TEST-INFO | started process 25048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDN7v1m/profile http://localhost:38035/getInfo.html) 12:26:33 INFO - PROCESS | 25048 | __metrics Screen width/height:1600/1200 12:26:33 INFO - PROCESS | 25048 | colorDepth:24 12:26:33 INFO - PROCESS | 25048 | Browser inner width/height: 1024/697 12:26:33 INFO - PROCESS | 25048 | __metrics 12:26:33 INFO - PROCESS | 25048 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:26:34 INFO - PROCESS | 25048 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:26:35 INFO - TEST-INFO | 25048: exit 0 12:26:35 INFO - Browser initialized. 12:26:35 INFO - Running cycle 1/1 for dromaeo_css test... 12:26:35 INFO - TEST-INFO | started process 25141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDN7v1m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:26:47 INFO - PROCESS | 25141 | RSS: Main: 149377024 12:26:47 INFO - PROCESS | 25141 | 12:27:38 INFO - PROCESS | 25141 | 1451939258506 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] 12:29:50 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:38035/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38035/tests/dromaeo/cssquery-ext.html) 12:29:51 INFO - PROCESS | 25141 | RSS: Main: 244531200 12:29:51 INFO - PROCESS | 25141 | 12:32:53 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:38035/tests/dromaeo/cssquery-ext.html (next: http://localhost:38035/tests/dromaeo/cssquery-jquery.html) 12:32:54 INFO - PROCESS | 25141 | RSS: Main: 233820160 12:32:54 INFO - PROCESS | 25141 | 12:35:56 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:38035/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38035/tests/dromaeo/cssquery-mootools.html) 12:35:56 INFO - PROCESS | 25141 | RSS: Main: 217231360 12:35:56 INFO - PROCESS | 25141 | 12:38:58 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:38035/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38035/tests/dromaeo/cssquery-prototype.html) 12:38:59 INFO - PROCESS | 25141 | RSS: Main: 209076224 12:38:59 INFO - PROCESS | 25141 | 12:42:02 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:38035/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38035/tests/dromaeo/cssquery-yui.html) 12:42:02 INFO - PROCESS | 25141 | RSS: Main: 192012288 12:42:02 INFO - PROCESS | 25141 | 12:45:05 INFO - PROCESS | 25141 | Cycle 1(1): loaded http://localhost:38035/tests/dromaeo/cssquery-yui.html (next: http://localhost:38035/tests/dromaeo/cssquery-dojo.html) 12:45:05 INFO - PROCESS | 25141 | RSS: Main: 258543616 12:45:05 INFO - PROCESS | 25141 | 12:45:05 INFO - PROCESS | 25141 | __start_tp_report 12:45:05 INFO - PROCESS | 25141 | _x_x_mozilla_page_load 12:45:05 INFO - PROCESS | 25141 | _x_x_mozilla_page_load_details 12:45:05 INFO - PROCESS | 25141 | |i|pagename|runs| 12:45:05 INFO - PROCESS | 25141 | |0;dojo.html;2598.6491823603815;2709.796765242606;2713.5522638764605;2721.9047333343337;2737.411456536845;4436.179306828239;4546.749928753918;4639.420072490939;4663.090697314025;4684.789184486698;4536.7051141675765;4566.885827854297;4603.470600880892;4615.076984603084;4655.255159174532;4132.462779838616;4184.97468120311;4223.746575205482;4273.786310684469;4279.61483466488;4105.651019663333;4243.490781106271;4269.87190384289;4297.03316753731;4344.087741574273;4156.085661154556;4209.894752631178;4265.573442655741;4276.593723596254;4304.569543045702;4291.935620965688;4294.892627684301;4298.699091063627;4298.914021719579;4331.242032644274;4128.710990230685;4208.579142085798;4240.851570195059;4298.140371925628;4324.740515569076;4498.077894031716;4550.408446901914;4585.151746926829;4605.953940460619;4606.769661516911;4840.443349014873;4880.41435027799;4887.315775791357;4893.486183950705;4939.3578834751615;4900.068986892515;4901.687073744674;4912.214045752662;4912.263160525914;4912.901741965176;4420.911581768379;4520.412346394947;4522.163399771053;4590.196715574761;4713.387259656222;5059.924101138486;5064.4935506449065;5071.3153724247495;5072.112380333427;5077.771500282496;4870.634702397334;4873.853784386474;4874.2201247800185;4874.366332376769;4916.532929371704;4770.522947705202;4864.1001414737675;4882.609391248691;4883.560479556786;4885.682430641997;4859.95140048602;4876.780544875489;4884.096442158212;4889.65772395936;4931.975340123348;4859.781309840995;4865.148598995162;4866.853994380174;4866.902661946812;4905.264210368473;3985.4021896715726;4036.6770658347264;4076.103257283393;4114.136031433432;4156.168766246763;3565.7682250653625;3625.782453052825;3641.289948460078;3652.214773823641;3666.633336666312;4216.641585465209;4222.577742225752;4224.894377640584;4264.744115353026;4267.935980960288;4714.38712967312;4847.394075740533;4852.005338905516;4930.33440485537;4936.555709986047;4154.729942553724;4159.355299928516;4238.364245363158;4252.787360631956;4270.957290427056;4400.801963911632;4432.623227025739;4442.289233722653;4444.266695995189;4484.8430304939175;4543;4779.761011949458;4779.904401911942;4783.473817879961;4813.133635945494;4787.61699064081;4799.424069111589;4863.173260545645;4942.703437793743;4989.575886049726;4715.292706094114;4732.5030871759345;4735.431748190239;4738.976305118453;4778.331033655221;4690.249560070372;4878.121938051185;4878.56092951636;4880.92678609814;4933.038057578738;4823.300621409946;4843.564079232886;4846.224604063474;4848;4849.199882019428;4816.686915350491;4820.204666230033;4822.156122678447;4827.300041493893;4865.683730557503;4772.212584923449;4798.2082956311815;4816.253480710496;4819.060283244734;4863.635227357891;4548.749818759868;4604.194266003503;4655.371524844239;4655.580997710223;4722.1972264714395;4826.58973987201;4831.275308703723;4837.2260438329695;4844.539768721966;4853.0779151961015;4673.789679464364;4675.509071547439;4681.180793361216;4687.601553867959;4727.196376615915 12:45:05 INFO - PROCESS | 25141 | |1;ext.html;494.74026136278474;499.71765952236984;510.40282869043216;529.7642549065665;537.4786457136577;25231;25747.356316092108;33139.17152071199;33780.662193378055;33795.324093518175;37369.25261494768;37678.24643507128;37803.62196378035;37907.81046094772;37994.15043871714;6798.354156355138;7773.61131943402;7939.444238903279;7949.364050875945;7951;5569.081101618249;5725.713714314267;5732.79935202268;5839.941600583982;9867.654632087879;9743.171830394389;9832.164266037395;9833.950830245838;9834.967328430483;9838.065383788564;9838.458884761336;9914.305998580103;9936.652217172365;9941.502924853728;9956.15372693322;6924.134483189601;7135.571865688075;9849.359791613522;10096.091351778301;10132.189424846069;28491.430171396663;28676.426471470662;28795.28011799722;28808.711912881023;28813.42373152546;2744.794140439475;2799.328161241308;3017.532282496217;3187.952180717291;3524.3303772283184;26937.86531067332;28100.437991240266;28238;28316.433671326457;28609.570856436963;3234.1267857678295;3342.7660063795543;3359.4792807114936;3402.557667503209;3451.2752322012407;233410;236595;237770;238087;238945;47898.28152577714;48992;57145.42854571484;57433.13850292249;57681.71159144177;58771;60038.39961600416;60272.69863650654;60332.39667603355;60392.69803650954;13882.791758123636;14182.432702691776;14193.148411095368;14201.289935503184;14205.28973551339;9723.951380243054;9742.707718768448;9760.853587196198;9825.263105266991;9832.115109640166;18417.447476575457;18607.16267767954;18654.53363665892;19453;19496.51258718515;6049.911016017159;6248.781292654735;6310.318114801191;6385.584936979081;6385.904211436832;865.2385900407601;867.3761870342265;895.8790563273875;908.1100521488846;1050.9842352364722;25896.22311330663;25924.351891202492;25991.350216244744;26098.608520872203;26216.344591384986;935.6818681648273;940.8165407745424;956.5886668732372;1006.5571148694551;1035.295998720862;12824.935875320563;12875.291858947661;14900.254987250593;15693.686126277411;16668.333266669197;330202;335533;335847;335917;336207;48478.757606211744;48958;49073;49116.50883491191;49228;1206.8913797758244;1237.5235534319172;1266.5883587833807;1271.389732928181;1272.9561759357423;23630.88184559135;27452;27581.586276206275;28451.146465606063;28550;42717.35923961205;43674.56325436705;43676.781616091714;43746.562534375524;43748.56251437445;256255;257793;258634;259181;259211;23777.762222377554;24523.632145517473;24530.264092077265;28172.85913570501;28621;33121.50317745284;33201.83399082989;33368.833155834065;34197.658023420445;34211.828940855135;29261.85369073141;30789.23026924255;31342.373152536366;31708.84145579257;31798.841005794824;31229.843850780602;31325.68674313319;31375.84312078425;34473.138171545914;36115;32412;32430;32927;33066.5040024395;33299.167520812174;24673.25980220596;25898.611520826827;26032.219033429028;26136.73863261343;26415.603765943142;21322.466938326044;24472.510549789262;25192.496150076528;26679.466410672067;26933.595996060467 12:45:05 INFO - PROCESS | 25141 | |2;jquery.html;324.60074108846106;329.47284345047916;329.6489238960507;330.3294312545532;330.4712460063897;11522.135839812006;11944.701382465442;14511.346989385476;14942.25288735563;15006.174660393674;12327.938360308208;12335.444904979275;12597;12640.304783236918;12714.618561443149;4925.310456536088;4937.456879743226;5087.338645976037;5090.389153301609;5090.974545127269;3733.701303895682;3849.7873169951517;4935.161022626145;5591.888162236753;5803.448672376138;5663.292088488939;5721.199032135504;5730.083186690131;5740.937926483593;5746.511546518551;5565.2486914266665;5700.800471983482;5745.368009518949;5762.308522977228;5763.308402991626;5017.397912250517;5023.171176755831;5028.245763135523;5029.321041659366;5030.6730062546185;18675.626487470174;18915;19211.903940480348;19256.80743192564;19374.128164232643;1407.345584303304;1897.7532920720357;1898.2691663709434;1948.9902550487298;2299.7585253548305;8126.756197314031;8364.832703345959;8592.785180370542;8604.225619694194;9932.304738668296;1716.8197339279445;1742.8518575921062;1746.1705689797373;1791.7133258678548;1797.757302764123;56151;58551.70724146395;58961.115583266284;59015.11477327844;59029.40970590325;8673.176048275403;9157.221636160868;9434.150926416656;9501.097395747393;9601.37591056579;12059.336736479403;12137.878621213851;12153.5138594457;12179.330136842558;12188.512459501699;6992.160940687048;7091.2554181810165;7113.679884405111;7151.856962860714;7174.92825071753;6785.558938668971;6865.450763938873;6866.244713081557;6874.690638921261;6885.552439091543;4009.7393669411395;4024.175044116008;4044.0992733415246;4046.8785936421955;4071.0229544909007;1572.4575021617525;1595.9840401595836;1618.5629879932353;1620.4004518328295;1655.6688662267595;816.4285000499674;886.902440731519;957.3394357893171;966.5988614724951;973.7224890906058;15323.080615163126;15538.145402002772;15744.291506882219;15920;15965.600859978593;740.8555331710372;781.4725060584083;832.9916700832914;840.436907272117;861.8319427711662;8098.838023239502;8368.20502052304;8376.686271181354;8417.70538031166;8512.914870851337;461998;466991;467714;468096;475554;71445.50471143678;72082.2791772086;72350.63824680948;72656;75386.62306688541;1015.0357160697367;1015.5531566111035;1018.4398580780689;1029.6653587584065;1030.9175265978704;12630.747385052431;12818.294993775431;12956.870431295943;12976.351182441029;13076.673083172616;28838.855805720836;29106.12681619555;29240;29286.267843303234;29577.408451831274;42137.57862421459;42562.57437425586;42690.57309426866;43082.138357232056;44181.11637767291;8197.754067377988;8412.116727743498;8565.143485651384;8638.308935285288;8651.437656552303;8428.410011299395;10168.847467288144;10260.640877569249;16246.431374901822;16431.507054788377;13647.522336718168;13819;13922.164670119826;14084.366203521071;14420.567382978528;12985.545505907248;13021.153625014344;13271.800922986356;13467.730645387233;13475.460981560627;14230;14252.501162459264;14340.856591434369;14342.928285358506;14470.855291447371;8738.563071846254;8773.605187766694;8775.07861674515;8783.912160878564;8960.775980600538;13004.739905201654;13262.137961032502;13274.93362533181;13603.047786654839;13885.514007009706 12:45:05 INFO - PROCESS | 25141 | |3;mootools.html;1121.4056550028477;1361.1220762608116;1367.432515506065;1467.7284702330069;1698.2612563534863;5655.858603534909;5823.097419899912;6415.422611964928;6493.1558897343275;6500.80497585072;6493;6564.5076619253505;6586.209654841414;6589;6590.308017658149;2048.4264405966314;2082.802133797287;2084.6247675418417;2085.103405535619;2085.8122768950793;2037.7350944377283;2071.2232912657755;2074.917003319865;2084.9895750521227;2095.538981424092;2035.470777597828;2052.2509284111266;2058.7941205879442;2064.4013236161495;2071.906764195615;2045.5295282085056;2083.6353638113346;2084.280923081542;2084.4372019554785;2086.3219453677616;2082.791720827905;2100.8949552522313;2125.776793436698;2140.860844045132;2141.6145093883097;6700.497462690318;6760.628165450898;6763.830904227384;6765.797026089225;6767.187937447488;3984.7409918355215;4027.2750904837117;4027.617376349242;4028.0936789222483;4057.046594050396;2557.3223095879607;2578.097665816949;2617.070939816376;2670.826396284235;2678.4375281190974;784.2432053068759;791.2562191539934;791.8812178173263;826.4669288309067;1720.3118752498976;8763.079876612992;8830.86753698695;8853.911460885372;8928.419652722552;8935.240504557121;3574.12433953683;3596.1549035976523;3640.6541378568995;3643.034595832107;3734.7198960078103;7180.353768160786;7197.820054498575;7203.099612548432;7205.351518363268;7208.603526805971;4006.759594424344;4011.498562679665;4047.433359329696;4052.452918855976;4064.4919385076864;2993.3564283679116;3069.8618562164756;3610.927781444409;3717.1636381813873;3729.738918275749;2888.5522743974716;2939.5002849515636;2942.6027486289076;2967.5251959686348;2982.478066338382;798.5448294472095;802.0495712580494;802.6749166587541;802.9839403211903;803.5219044668413;878.2403221213605;901.0403919825364;1100.6092837042895;1111.4442778610694;1124.3534967393618;6188.4739797117745;6302.621842689453;6315.5894866833505;6339.239291284983;6342.39747224013;400.21557746816563;408.0919953104319;1041.463646222196;1044.1959691037857;1109.9778004439866;5042.949570504321;5095.082885080721;5109.182530795055;5109.948900511022;5118;7866.623340915431;7878;7980.042394912648;8060.113387527367;8064.959675201587;7710.306072453506;7910.288074073361;7922.286994170552;7931.762047138595;7932.881006784903;6386.712597933011;6444.8388790280615;6461.353864613501;6510.251321098134;6527.738890444424;6111.419415155553;6233.252009758677;6236.189295391751;6249.687515624291;6262.937370626418;7169.139703235645;7220.458465614995;7222.494425390382;7332.78001659951;7352.4485663576515;7421.443391745533;7533.359664428366;7534.397248220239;7545.622718864144;7670.69317227327;5227.947720522746;5331.866703332447;6115.969420152871;6220.284667263141;6232.906506402317;6239.344868788712;6296.968515157395;6342.365763423805;6345.682715864281;6348.936510634834;5964.642121472725;6020.217371741645;6156.384361563808;6177.96911015442;6367.299597044229;5963.254593175853;6003.219581454558;6029.698515074141;6036.879262414815;6049.697515124314;5946.28644562638;5999.820005399845;6010.1585777991995;6049.304330002106;6057.939420605914;5789.9710501447225;5790.218320526675;5815.447532484407;5820.650760954356;5833.416658334302;5828.883422331445;5875.030619947832;5894.734736936934;5911.556633252438;5933.940660593339 12:45:05 INFO - PROCESS | 25141 | |4;prototype.html;294.9837758923259;298.0670501330834;302.37559439756916;302.4495418338623;302.9924251893701;5310.415854256038;5422.186671999202;5433.1578605316145;5531.032069387861;5537.335519737627;5349.679019258838;5419.376771671259;5426.8371948841595;5432.2123292122615;5437.782488700447;3914.17802261524;4111.075008123164;4111.095558977036;4118.505779306487;4118.670506359484;4001.25976694311;4015.7751885675;4092.3043082675867;4094.7338423002557;4102.446169767088;4022.798860057;4084.9387259191135;4091.0590564170257;4098.057446787241;4099.50805903292;3866.284737323604;3963.088489647397;3985.2826491231567;4096.549379568245;4104.13813099248;3525.5593050868642;3533.2050288685095;3540.822958852047;3551.076720052779;3552.467129930505;5153.458886816868;5166.199239117943;5168.379794424655;5168.638195326329;5170.146925757245;4712.458067322267;4723.834665786715;4726.314684370747;4728.1252968201;4729.935764453005;5552.611317207797;5616.269884914935;5654.886902261973;5672.829815105553;5680.3467601225975;3873.2253549290253;3875.5543112542136;3878.1855810279876;3883.864064757748;3891.3579259422163;5893.14549390336;5995.340512543617;5995.850103747398;5998.700064996777;6000.099985002241;3981.5620281768984;3991.241664083873;3991.940120898189;3992.181602771425;3994.9001274967777;3889.8055097245024;4047.777372244555;4048.27131116396;4052.068024354415;4053.473048503735;4657.720536767804;4690.6012988895645;4692.929606055912;4695.835645752451;4703.811847526061;5653.773849046074;5656.5757568181725;5657.688827114548;5665.688387138664;5666.744996475169;1406.9577912662637;1425.8360288566948;1428.52144531581;1428.721399327142;1430.6065831896312;940.4874343482818;943.919766819828;950.3632566180676;968.1867231525553;969.0745338202;4980.352554167935;4986.5289739526925;4990.600751939836;4997.775100120503;4998.150314446553;5919.052951527735;5927.288725352985;5928.318243401977;5929.110633405024;5936.614120082268;4985.601151907838;4990.351254336985;4990.50094990498;4993.251012348177;4994.200927851526;3127.577777000076;3142.1987393214586;3195.3769015041844;3195.4248235317864;3205.294835136266;5604.103343465026;5610.579206559524;5612.214289999403;5619.297587801525;5622;6028.367021462771;6058.878822423615;6059.697015149313;6065.96967015171;6071.180390647294;5588.161775733673;5590.105583106765;5598.272224610856;5602.635828671123;5619.522340601013;5741.282339707536;5861.9413805861395;5909.5863289569315;5967.433093856077;5980;5809.448102430262;5811.622244554091;5813.76744930198;5820;5824.708764561839;5666.405027472056;5666.943330566806;5667.801626943202;5669.7165141741925;5675.290588676416;3860.9227815444096;3927.469791578215;3950.486436763202;3963.6432721055244;3972.3445631470486;5963.761449541969;5968.343482216866;5973.342932277533;5977.462028417463;5978.461938425563;5715.599908006399;5733.283339582552;5738.340090889435;5739.8565035874435;5740.483356497935;5586;5697.515711164598;5732.914006289826;5745.712714364348;5748.137779333133;5624.100143976944;5628.690422026828;5630.85922851932;5635.774569017193;5640.464155905182;5531.529819965348;5660.066089095253;5738.885222295614;5774.133879918046;5779.913301300399;5462.508374246337;5562.276904002454;5585.050541408052;5595.720213989365;5598.188262701967 12:45:05 INFO - PROCESS | 25141 | |5;yui.html;587.9176915231867;609.1299709890636;640.4748106552626;649.9675016249192;691.2672567078894;9204.493752843598;9311.348205625609;9336.906630933689;9345.672901448443;9348.065193480657;9996.2502812289;10060.144887684555;10786.460676966159;10799.622013229538;10800.78398432031;774.3379410603937;792.2077922077922;793.0800271684847;793.115676021238;793.8253584211493;781.6287263549825;782.7495201535511;790.1900551934256;790.3913986230599;792.1523969352795;828.9419740618159;835.2900034970257;835.5321020228691;836.2515548584014;837.9497230166179;819.9098099209082;820.0405525535108;820.0569345252948;820.2330820682681;820.4953953318726;615.3231445410013;616.3097330989276;616.5067945643467;616.5252755378378;617;9953.90046099537;9984.80030399388;10040.69877903664;10045.598176072948;10049.497525123714;8520.70177543783;9033.63865445388;9034.819303613956;9379.812403751956;9420.293477989178;8610.784730381727;8856.158664926821;8864.468131912106;8882.86675699865;8884.955575222148;3194.121616555466;3231.644519102897;3245.334706385185;3247;3271.1167984644253;34077.148071298165;34233;36154.45768313477;36749.44875826865;38861.611383886084;8316.667333306721;8532.744017679479;8723.842331373355;9004.054574269738;9037.412568183046;15661;15672.373105075669;15675.686486270439;15685.05889646625;15728.213589320489;5919.319278283053;6030.155778191057;6113.174721412553;6144.8771024580155;6165.691715414301;3555.253396786652;3566.661167189113;3599.3521166190335;3676.9448458273146;3715;2500.937476563064;2531.240627811649;2535.1253817432957;2536.7463253674855;2537.1120107962065;446.44417699963753;446.61591031712703;447.4965663628418;448.64108713029447;452.32377595494944;406.4857954687323;461.83143152749676;480.1405484183273;507.86033840693364;524.3052954834859;6944.4444444444325;7197.856042879218;7216.458765592602;7518.473706840578;7528.623568821647;503.4009528660882;537.6800803521899;576.8932747441737;586.4370204603543;592.6177615438105;3329.234276116507;3372.3423932332958;3419.196488825124;3514.61339252682;3699.0382500549513;49918.50081499211;50140.49859501431;50571;50652.240216396785;51003.48996510061;42238.366424503656;42270.57729422666;42492.57507424886;42563.14873702508;42588.36117458241;33879.66120338765;39162.80418597889;39432.01419964466;39454.01364965899;39766.40350394746;7081.8669012959745;7255.673494692646;7422.814429639302;7451.776446706607;7467.92532074694;26791.062312818958;26845.194644160707;26866.865665671547;27039.324016899736;27234.863825681536;32057.51913721343;32307;34435.65564344324;34565.30869382648;34937.30125397529;9369;9618.951905240709;9917.074463033277;10186.337888037255;10238.641647542301;10497.737556561147;10611.8938810614;10861.076808471369;11095;11135.610253641084;9876.23639345909;9993.400395976265;10100.292979491365;10149.746256343651;10551.472426378803;10069.496525173858;10167.18662506983;10248;10403.94798026005;10712.785744285227;10016.449095299828;10018.098371146632;10270.537825798006;10300.742481438025;10335.379877207391;8040.959795200986;8257.545834979133;8280.01355418681;8357.874631880404;8531.104234055583;8164.183581642026;8326.333893288644;8358.623861926106;8600.39797214189;9150.496722680316 12:45:05 INFO - PROCESS | 25141 | __end_tp_report 12:45:05 INFO - PROCESS | 25141 | __start_cc_report 12:45:05 INFO - PROCESS | 25141 | _x_x_mozilla_cycle_collect,825 12:45:05 INFO - PROCESS | 25141 | __end_cc_report 12:45:05 INFO - PROCESS | 25141 | __startTimestamp1451940305515__endTimestamp 12:45:05 INFO - PROCESS | 25141 | 12:45:05 INFO - PROCESS | 25141 | ------- Summary: start ------- 12:45:05 INFO - PROCESS | 25141 | Number of tests: 6 12:45:05 INFO - PROCESS | 25141 | 12:45:05 INFO - PROCESS | 25141 | [#0] dojo.html Cycles:165 Average:4543.83 Median:4687.60 stddev:459.11 (9.8%) stddev-sans-first:434.42 12:45:05 INFO - PROCESS | 25141 | Values: 2598.6 2709.8 2713.6 2721.9 2737.4 4436.2 4546.7 4639.4 4663.1 4684.8 4536.7 4566.9 4603.5 4615.1 4655.3 4132.5 4185.0 4223.7 4273.8 4279.6 4105.7 4243.5 4269.9 4297.0 4344.1 4156.1 4209.9 4265.6 4276.6 4304.6 4291.9 4294.9 4298.7 4298.9 4331.2 4128.7 4208.6 4240.9 4298.1 4324.7 4498.1 4550.4 4585.2 4606.0 4606.8 4840.4 4880.4 4887.3 4893.5 4939.4 4900.1 4901.7 4912.2 4912.3 4912.9 4420.9 4520.4 4522.2 4590.2 4713.4 5059.9 5064.5 5071.3 5072.1 5077.8 4870.6 4873.9 4874.2 4874.4 4916.5 4770.5 4864.1 4882.6 4883.6 4885.7 4860.0 4876.8 4884.1 4889.7 4932.0 4859.8 4865.1 4866.9 4866.9 4905.3 3985.4 4036.7 4076.1 4114.1 4156.2 3565.8 3625.8 3641.3 3652.2 3666.6 4216.6 4222.6 4224.9 4264.7 4267.9 4714.4 4847.4 4852.0 4930.3 4936.6 4154.7 4159.4 4238.4 4252.8 4271.0 4400.8 4432.6 4442.3 4444.3 4484.8 4543.0 4779.8 4779.9 4783.5 4813.1 4787.6 4799.4 4863.2 4942.7 4989.6 4715.3 4732.5 4735.4 4739.0 4778.3 4690.2 4878.1 4878.6 4880.9 4933.0 4823.3 4843.6 4846.2 4848.0 4849.2 4816.7 4820.2 4822.2 4827.3 4865.7 4772.2 4798.2 4816.3 4819.1 4863.6 4548.7 4604.2 4655.4 4655.6 4722.2 4826.6 4831.3 4837.2 4844.5 4853.1 4673.8 4675.5 4681.2 4687.6 4727.2 12:45:05 INFO - PROCESS | 25141 | 12:45:05 INFO - PROCESS | 25141 | [#1] ext.html Cycles:180 Average:42715.88 Median:33130.34 stddev:73410.77 (221.6%) stddev-sans-first:73548.26 12:45:05 INFO - PROCESS | 25141 | Values: 494.7 499.7 510.4 529.8 537.5 25231.0 25747.4 33139.2 33780.7 33795.3 37369.3 37678.2 37803.6 37907.8 37994.2 6798.4 7773.6 7939.4 7949.4 7951.0 5569.1 5725.7 5732.8 5839.9 9867.7 9743.2 9832.2 9834.0 9835.0 9838.1 9838.5 9914.3 9936.7 9941.5 9956.2 6924.1 7135.6 9849.4 10096.1 10132.2 28491.4 28676.4 28795.3 28808.7 28813.4 2744.8 2799.3 3017.5 3188.0 3524.3 26937.9 28100.4 28238.0 28316.4 28609.6 3234.1 3342.8 3359.5 3402.6 3451.3 233410.0 236595.0 237770.0 238087.0 238945.0 47898.3 48992.0 57145.4 57433.1 57681.7 58771.0 60038.4 60272.7 60332.4 60392.7 13882.8 14182.4 14193.1 14201.3 14205.3 9724.0 9742.7 9760.9 9825.3 9832.1 18417.4 18607.2 18654.5 19453.0 19496.5 6049.9 6248.8 6310.3 6385.6 6385.9 865.2 867.4 895.9 908.1 1051.0 25896.2 25924.4 25991.4 26098.6 26216.3 935.7 940.8 956.6 1006.6 1035.3 12824.9 12875.3 14900.3 15693.7 16668.3 330202.0 335533.0 335847.0 335917.0 336207.0 48478.8 48958.0 49073.0 49116.5 49228.0 1206.9 1237.5 1266.6 1271.4 1273.0 23630.9 27452.0 27581.6 28451.1 28550.0 42717.4 43674.6 43676.8 43746.6 43748.6 256255.0 257793.0 258634.0 259181.0 259211.0 23777.8 24523.6 24530.3 28172.9 28621.0 33121.5 33201.8 33368.8 34197.7 34211.8 29261.9 30789.2 31342.4 31708.8 31798.8 31229.8 31325.7 31375.8 34473.1 36115.0 32412.0 32430.0 32927.0 33066.5 33299.2 24673.3 25898.6 26032.2 26136.7 26415.6 21322.5 24472.5 25192.5 26679.5 26933.6 12:45:05 INFO - PROCESS | 25141 | 12:45:05 INFO - PROCESS | 25141 | [#2] jquery.html Cycles:180 Average:25577.45 Median:23104.30 stddev:76551.58 (331.3%) stddev-sans-first:76742.84 12:45:05 INFO - PROCESS | 25141 | Values: 324.6 329.5 329.6 330.3 330.5 11522.1 11944.7 14511.3 14942.3 15006.2 12327.9 12335.4 12597.0 12640.3 12714.6 4925.3 4937.5 5087.3 5090.4 5091.0 3733.7 3849.8 4935.2 5591.9 5803.4 5663.3 5721.2 5730.1 5740.9 5746.5 5565.2 5700.8 5745.4 5762.3 5763.3 5017.4 5023.2 5028.2 5029.3 5030.7 18675.6 18915.0 19211.9 19256.8 19374.1 1407.3 1897.8 1898.3 1949.0 2299.8 8126.8 8364.8 8592.8 8604.2 9932.3 1716.8 1742.9 1746.2 1791.7 1797.8 56151.0 58551.7 58961.1 59015.1 59029.4 8673.2 9157.2 9434.2 9501.1 9601.4 12059.3 12137.9 12153.5 12179.3 12188.5 6992.2 7091.3 7113.7 7151.9 7174.9 6785.6 6865.5 6866.2 6874.7 6885.6 4009.7 4024.2 4044.1 4046.9 4071.0 1572.5 1596.0 1618.6 1620.4 1655.7 816.4 886.9 957.3 966.6 973.7 15323.1 15538.1 15744.3 15920.0 15965.6 740.9 781.5 833.0 840.4 861.8 8098.8 8368.2 8376.7 8417.7 8512.9 461998.0 466991.0 467714.0 468096.0 475554.0 71445.5 72082.3 72350.6 72656.0 75386.6 1015.0 1015.6 1018.4 1029.7 1030.9 12630.7 12818.3 12956.9 12976.4 13076.7 28838.9 29106.1 29240.0 29286.3 29577.4 42137.6 42562.6 42690.6 43082.1 44181.1 8197.8 8412.1 8565.1 8638.3 8651.4 8428.4 10168.8 10260.6 16246.4 16431.5 13647.5 13819.0 13922.2 14084.4 14420.6 12985.5 13021.2 13271.8 13467.7 13475.5 14230.0 14252.5 14340.9 14342.9 14470.9 8738.6 8773.6 8775.1 8783.9 8960.8 13004.7 13262.1 13274.9 13603.0 13885.5 12:45:05 INFO - PROCESS | 25141 | 12:45:05 INFO - PROCESS | 25141 | [#3] mootools.html Cycles:180 Average:4677.57 Median:5982.23 stddev:2386.04 (39.9%) stddev-sans-first:2377.75 12:45:05 INFO - PROCESS | 25141 | Values: 1121.4 1361.1 1367.4 1467.7 1698.3 5655.9 5823.1 6415.4 6493.2 6500.8 6493.0 6564.5 6586.2 6589.0 6590.3 2048.4 2082.8 2084.6 2085.1 2085.8 2037.7 2071.2 2074.9 2085.0 2095.5 2035.5 2052.3 2058.8 2064.4 2071.9 2045.5 2083.6 2084.3 2084.4 2086.3 2082.8 2100.9 2125.8 2140.9 2141.6 6700.5 6760.6 6763.8 6765.8 6767.2 3984.7 4027.3 4027.6 4028.1 4057.0 2557.3 2578.1 2617.1 2670.8 2678.4 784.2 791.3 791.9 826.5 1720.3 8763.1 8830.9 8853.9 8928.4 8935.2 3574.1 3596.2 3640.7 3643.0 3734.7 7180.4 7197.8 7203.1 7205.4 7208.6 4006.8 4011.5 4047.4 4052.5 4064.5 2993.4 3069.9 3610.9 3717.2 3729.7 2888.6 2939.5 2942.6 2967.5 2982.5 798.5 802.0 802.7 803.0 803.5 878.2 901.0 1100.6 1111.4 1124.4 6188.5 6302.6 6315.6 6339.2 6342.4 400.2 408.1 1041.5 1044.2 1110.0 5042.9 5095.1 5109.2 5109.9 5118.0 7866.6 7878.0 7980.0 8060.1 8065.0 7710.3 7910.3 7922.3 7931.8 7932.9 6386.7 6444.8 6461.4 6510.3 6527.7 6111.4 6233.3 6236.2 6249.7 6262.9 7169.1 7220.5 7222.5 7332.8 7352.4 7421.4 7533.4 7534.4 7545.6 7670.7 5227.9 5331.9 6116.0 6220.3 6232.9 6239.3 6297.0 6342.4 6345.7 6348.9 5964.6 6020.2 6156.4 6178.0 6367.3 5963.3 6003.2 6029.7 6036.9 6049.7 5946.3 5999.8 6010.2 6049.3 6057.9 5790.0 5790.2 5815.4 5820.7 5833.4 5828.9 5875.0 5894.7 5911.6 5933.9 12:45:05 INFO - PROCESS | 25141 | 12:45:05 INFO - PROCESS | 25141 | [#4] prototype.html Cycles:180 Average:4694.42 Median:5432.69 stddev:1413.43 (26.0%) stddev-sans-first:1378.28 12:45:05 INFO - PROCESS | 25141 | Values: 295.0 298.1 302.4 302.4 303.0 5310.4 5422.2 5433.2 5531.0 5537.3 5349.7 5419.4 5426.8 5432.2 5437.8 3914.2 4111.1 4111.1 4118.5 4118.7 4001.3 4015.8 4092.3 4094.7 4102.4 4022.8 4084.9 4091.1 4098.1 4099.5 3866.3 3963.1 3985.3 4096.5 4104.1 3525.6 3533.2 3540.8 3551.1 3552.5 5153.5 5166.2 5168.4 5168.6 5170.1 4712.5 4723.8 4726.3 4728.1 4729.9 5552.6 5616.3 5654.9 5672.8 5680.3 3873.2 3875.6 3878.2 3883.9 3891.4 5893.1 5995.3 5995.9 5998.7 6000.1 3981.6 3991.2 3991.9 3992.2 3994.9 3889.8 4047.8 4048.3 4052.1 4053.5 4657.7 4690.6 4692.9 4695.8 4703.8 5653.8 5656.6 5657.7 5665.7 5666.7 1407.0 1425.8 1428.5 1428.7 1430.6 940.5 943.9 950.4 968.2 969.1 4980.4 4986.5 4990.6 4997.8 4998.2 5919.1 5927.3 5928.3 5929.1 5936.6 4985.6 4990.4 4990.5 4993.3 4994.2 3127.6 3142.2 3195.4 3195.4 3205.3 5604.1 5610.6 5612.2 5619.3 5622.0 6028.4 6058.9 6059.7 6066.0 6071.2 5588.2 5590.1 5598.3 5602.6 5619.5 5741.3 5861.9 5909.6 5967.4 5980.0 5809.4 5811.6 5813.8 5820.0 5824.7 5666.4 5666.9 5667.8 5669.7 5675.3 3860.9 3927.5 3950.5 3963.6 3972.3 5963.8 5968.3 5973.3 5977.5 5978.5 5715.6 5733.3 5738.3 5739.9 5740.5 5586.0 5697.5 5732.9 5745.7 5748.1 5624.1 5628.7 5630.9 5635.8 5640.5 5531.5 5660.1 5738.9 5774.1 5779.9 5462.5 5562.3 5585.1 5595.7 5598.2 12:45:05 INFO - PROCESS | 25141 | 12:45:05 INFO - PROCESS | 25141 | [#5] yui.html Cycles:180 Average:11323.71 Median:25755.68 stddev:12952.22 (50.3%) stddev-sans-first:12963.47 12:45:05 INFO - PROCESS | 25141 | Values: 587.9 609.1 640.5 650.0 691.3 9204.5 9311.3 9336.9 9345.7 9348.1 9996.3 10060.1 10786.5 10799.6 10800.8 774.3 792.2 793.1 793.1 793.8 781.6 782.7 790.2 790.4 792.2 828.9 835.3 835.5 836.3 837.9 819.9 820.0 820.1 820.2 820.5 615.3 616.3 616.5 616.5 617.0 9953.9 9984.8 10040.7 10045.6 10049.5 8520.7 9033.6 9034.8 9379.8 9420.3 8610.8 8856.2 8864.5 8882.9 8885.0 3194.1 3231.6 3245.3 3247.0 3271.1 34077.1 34233.0 36154.5 36749.4 38861.6 8316.7 8532.7 8723.8 9004.1 9037.4 15661.0 15672.4 15675.7 15685.1 15728.2 5919.3 6030.2 6113.2 6144.9 6165.7 3555.3 3566.7 3599.4 3676.9 3715.0 2500.9 2531.2 2535.1 2536.7 2537.1 446.4 446.6 447.5 448.6 452.3 406.5 461.8 480.1 507.9 524.3 6944.4 7197.9 7216.5 7518.5 7528.6 503.4 537.7 576.9 586.4 592.6 3329.2 3372.3 3419.2 3514.6 3699.0 49918.5 50140.5 50571.0 50652.2 51003.5 42238.4 42270.6 42492.6 42563.1 42588.4 33879.7 39162.8 39432.0 39454.0 39766.4 7081.9 7255.7 7422.8 7451.8 7467.9 26791.1 26845.2 26866.9 27039.3 27234.9 32057.5 32307.0 34435.7 34565.3 34937.3 9369.0 9619.0 9917.1 10186.3 10238.6 10497.7 10611.9 10861.1 11095.0 11135.6 9876.2 9993.4 10100.3 10149.7 10551.5 10069.5 10167.2 10248.0 10403.9 10712.8 10016.4 10018.1 10270.5 10300.7 10335.4 8041.0 8257.5 8280.0 8357.9 8531.1 8164.2 8326.3 8358.6 8600.4 9150.5 12:45:05 INFO - PROCESS | 25141 | -------- Summary: end -------- 12:45:05 INFO - PROCESS | 25141 | 12:45:06 INFO - TEST-INFO | 25141: exit 0 12:45:06 INFO - TEST-OK | dromaeo_css | took 1116998ms 12:45:06 INFO - TEST-START | kraken 12:45:06 INFO - operating with platform_type : linux_ 12:45:06 INFO - Initialising browser for kraken test... 12:45:06 INFO - TEST-INFO | started process 25332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFGBLE4/profile http://localhost:38035/getInfo.html) 12:45:10 INFO - PROCESS | 25332 | __metrics Screen width/height:1600/1200 12:45:10 INFO - PROCESS | 25332 | colorDepth:24 12:45:10 INFO - PROCESS | 25332 | Browser inner width/height: 1024/697 12:45:10 INFO - PROCESS | 25332 | __metrics 12:45:10 INFO - PROCESS | 25332 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:45:11 INFO - PROCESS | 25332 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:45:11 INFO - PROCESS | 25332 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 12:45:12 INFO - TEST-INFO | 25332: exit 0 12:45:12 INFO - Browser initialized. 12:45:12 INFO - Running cycle 1/1 for kraken test... 12:45:12 INFO - TEST-INFO | started process 25414 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFGBLE4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:45:24 INFO - PROCESS | 25414 | RSS: Main: 146485248 12:45:24 INFO - PROCESS | 25414 | 12:45:26 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38035/tests/kraken/driver.html?testName=audio-beat-detection) 12:45:27 INFO - PROCESS | 25414 | RSS: Main: 181919744 12:45:27 INFO - PROCESS | 25414 | 12:45:30 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38035/tests/kraken/driver.html?testName=audio-dft) 12:45:30 INFO - PROCESS | 25414 | RSS: Main: 173105152 12:45:30 INFO - PROCESS | 25414 | 12:45:33 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38035/tests/kraken/driver.html?testName=audio-fft) 12:45:34 INFO - PROCESS | 25414 | RSS: Main: 157413376 12:45:34 INFO - PROCESS | 25414 | 12:45:36 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38035/tests/kraken/driver.html?testName=audio-oscillator) 12:45:36 INFO - PROCESS | 25414 | RSS: Main: 160329728 12:45:36 INFO - PROCESS | 25414 | 12:45:39 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38035/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:45:39 INFO - PROCESS | 25414 | RSS: Main: 162234368 12:45:39 INFO - PROCESS | 25414 | 12:45:42 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38035/tests/kraken/driver.html?testName=imaging-darkroom) 12:45:43 INFO - PROCESS | 25414 | RSS: Main: 162381824 12:45:43 INFO - PROCESS | 25414 | 12:45:46 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38035/tests/kraken/driver.html?testName=imaging-desaturate) 12:45:47 INFO - PROCESS | 25414 | RSS: Main: 163041280 12:45:47 INFO - PROCESS | 25414 | 12:45:50 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38035/tests/kraken/driver.html?testName=json-parse-financial) 12:45:50 INFO - PROCESS | 25414 | RSS: Main: 163622912 12:45:50 INFO - PROCESS | 25414 | 12:45:52 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38035/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:45:52 INFO - PROCESS | 25414 | RSS: Main: 177143808 12:45:52 INFO - PROCESS | 25414 | 12:45:54 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38035/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:45:55 INFO - PROCESS | 25414 | RSS: Main: 175149056 12:45:55 INFO - PROCESS | 25414 | 12:45:57 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38035/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:45:58 INFO - PROCESS | 25414 | RSS: Main: 186380288 12:45:58 INFO - PROCESS | 25414 | 12:46:00 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:46:01 INFO - PROCESS | 25414 | RSS: Main: 189620224 12:46:01 INFO - PROCESS | 25414 | 12:46:04 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:46:04 INFO - PROCESS | 25414 | RSS: Main: 188583936 12:46:04 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | Cycle 1(1): loaded http://localhost:38035/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38035/tests/kraken/driver.html?testName=ai-astar) 12:46:06 INFO - PROCESS | 25414 | RSS: Main: 247042048 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | __start_tp_report 12:46:06 INFO - PROCESS | 25414 | _x_x_mozilla_page_load 12:46:06 INFO - PROCESS | 25414 | _x_x_mozilla_page_load_details 12:46:06 INFO - PROCESS | 25414 | |i|pagename|runs| 12:46:06 INFO - PROCESS | 25414 | |0;ai-astar;110;113;107;113;112;113;102;112;113;102 12:46:06 INFO - PROCESS | 25414 | |1;audio-beat-detection;153;134;157;173;147;161;156;132;173;139 12:46:06 INFO - PROCESS | 25414 | |2;audio-dft;161;159;161;162;161;161;162;160;161;163 12:46:06 INFO - PROCESS | 25414 | |3;audio-fft;72;74;110;92;73;72;72;107;90;72 12:46:06 INFO - PROCESS | 25414 | |4;audio-oscillator;99;99;139;98;98;99;145;100;99;140 12:46:06 INFO - PROCESS | 25414 | |5;imaging-gaussian-blur;109;109;109;110;109;110;108;110;109;109 12:46:06 INFO - PROCESS | 25414 | |6;imaging-darkroom;146;147;147;147;148;146;148;146;148;147 12:46:06 INFO - PROCESS | 25414 | |7;imaging-desaturate;96;95;95;95;95;95;95;95;96;95 12:46:06 INFO - PROCESS | 25414 | |8;json-parse-financial;71;72;72;72;71;72;72;71;85;71 12:46:06 INFO - PROCESS | 25414 | |9;json-stringify-tinderbox;68;68;69;68;69;69;69;69;69;69 12:46:06 INFO - PROCESS | 25414 | |10;stanford-crypto-aes;95;86;86;88;86;86;86;85;85;86 12:46:06 INFO - PROCESS | 25414 | |11;stanford-crypto-ccm;128;131;121;125;128;121;130;132;128;124 12:46:06 INFO - PROCESS | 25414 | |12;stanford-crypto-pbkdf2;139;152;157;157;145;137;152;151;150;140 12:46:06 INFO - PROCESS | 25414 | |13;stanford-crypto-sha256-iterative;72;70;73;71;71;71;73;71;69;70 12:46:06 INFO - PROCESS | 25414 | __end_tp_report 12:46:06 INFO - PROCESS | 25414 | __start_cc_report 12:46:06 INFO - PROCESS | 25414 | _x_x_mozilla_cycle_collect,991 12:46:06 INFO - PROCESS | 25414 | __end_cc_report 12:46:06 INFO - PROCESS | 25414 | __startTimestamp1451940366624__endTimestamp 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | ------- Summary: start ------- 12:46:06 INFO - PROCESS | 25414 | Number of tests: 14 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#0] ai-astar Cycles:10 Average:109.70 Median:112.50 stddev:4.47 (4.0%) stddev-sans-first:4.74 12:46:06 INFO - PROCESS | 25414 | Values: 110.0 113.0 107.0 113.0 112.0 113.0 102.0 112.0 113.0 102.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#1] audio-beat-detection Cycles:10 Average:152.50 Median:156.50 stddev:14.61 (9.3%) stddev-sans-first:15.49 12:46:06 INFO - PROCESS | 25414 | Values: 153.0 134.0 157.0 173.0 147.0 161.0 156.0 132.0 173.0 139.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:1.10 (0.7%) stddev-sans-first:1.17 12:46:06 INFO - PROCESS | 25414 | Values: 161.0 159.0 161.0 162.0 161.0 161.0 162.0 160.0 161.0 163.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#3] audio-fft Cycles:10 Average:83.40 Median:72.50 stddev:15.27 (21.1%) stddev-sans-first:15.63 12:46:06 INFO - PROCESS | 25414 | Values: 72.0 74.0 110.0 92.0 73.0 72.0 72.0 107.0 90.0 72.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#4] audio-oscillator Cycles:10 Average:111.60 Median:98.50 stddev:20.58 (20.9%) stddev-sans-first:21.32 12:46:06 INFO - PROCESS | 25414 | Values: 99.0 99.0 139.0 98.0 98.0 99.0 145.0 100.0 99.0 140.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 12:46:06 INFO - PROCESS | 25414 | Values: 109.0 109.0 109.0 110.0 109.0 110.0 108.0 110.0 109.0 109.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 12:46:06 INFO - PROCESS | 25414 | Values: 146.0 147.0 147.0 147.0 148.0 146.0 148.0 146.0 148.0 147.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 12:46:06 INFO - PROCESS | 25414 | Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#8] json-parse-financial Cycles:10 Average:72.90 Median:72.00 stddev:4.28 (5.9%) stddev-sans-first:4.48 12:46:06 INFO - PROCESS | 25414 | Values: 71.0 72.0 72.0 72.0 71.0 72.0 72.0 71.0 85.0 71.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 12:46:06 INFO - PROCESS | 25414 | Values: 68.0 68.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 69.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:2.96 (3.4%) stddev-sans-first:0.87 12:46:06 INFO - PROCESS | 25414 | Values: 95.0 86.0 86.0 88.0 86.0 86.0 86.0 85.0 85.0 86.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#11] stanford-crypto-ccm Cycles:10 Average:126.80 Median:128.00 stddev:3.91 (3.1%) stddev-sans-first:4.12 12:46:06 INFO - PROCESS | 25414 | Values: 128.0 131.0 121.0 125.0 128.0 121.0 130.0 132.0 128.0 124.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:151.50 stddev:7.32 (4.8%) stddev-sans-first:7.00 12:46:06 INFO - PROCESS | 25414 | Values: 139.0 152.0 157.0 157.0 145.0 137.0 152.0 151.0 150.0 140.0 12:46:06 INFO - PROCESS | 25414 | 12:46:06 INFO - PROCESS | 25414 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:71.00 stddev:1.29 (1.8%) stddev-sans-first:1.32 12:46:06 INFO - PROCESS | 25414 | Values: 72.0 70.0 73.0 71.0 71.0 71.0 73.0 71.0 69.0 70.0 12:46:06 INFO - PROCESS | 25414 | -------- Summary: end -------- 12:46:06 INFO - PROCESS | 25414 | 12:46:07 INFO - TEST-INFO | 25414: exit 0 12:46:07 INFO - TEST-OK | kraken | took 61303ms 12:46:07 INFO - TEST-START | v8_7 12:46:07 INFO - operating with platform_type : linux_ 12:46:07 INFO - Initialising browser for v8_7 test... 12:46:07 INFO - TEST-INFO | started process 25662 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk46gE6/profile http://localhost:38035/getInfo.html) 12:46:11 INFO - PROCESS | 25662 | __metrics Screen width/height:1600/1200 12:46:11 INFO - PROCESS | 25662 | colorDepth:24 12:46:11 INFO - PROCESS | 25662 | Browser inner width/height: 1024/697 12:46:11 INFO - PROCESS | 25662 | __metrics 12:46:11 INFO - PROCESS | 25662 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:46:11 INFO - PROCESS | 25662 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:46:13 INFO - TEST-INFO | 25662: exit 0 12:46:13 INFO - Browser initialized. 12:46:13 INFO - Running cycle 1/1 for v8_7 test... 12:46:13 INFO - TEST-INFO | started process 25744 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpk46gE6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:46:25 INFO - PROCESS | 25744 | RSS: Main: 149643264 12:46:25 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | Cycle 1(1): loaded http://localhost:38035/tests/v8_7/run.html (next: http://localhost:38035/tests/v8_7/run.html) 12:46:46 INFO - PROCESS | 25744 | RSS: Main: 449642496 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | __start_tp_report 12:46:46 INFO - PROCESS | 25744 | _x_x_mozilla_page_load 12:46:46 INFO - PROCESS | 25744 | _x_x_mozilla_page_load_details 12:46:46 INFO - PROCESS | 25744 | |i|pagename|runs| 12:46:46 INFO - PROCESS | 25744 | |0;Richards;166.6944490748458 12:46:46 INFO - PROCESS | 25744 | |1;DeltaBlue;188.39487565938205 12:46:46 INFO - PROCESS | 25744 | |2;Encrypt;278.31895352073474 12:46:46 INFO - PROCESS | 25744 | |3;Decrypt;5159.79381443299 12:46:46 INFO - PROCESS | 25744 | |4;RayTrace;1972.3865877712033 12:46:46 INFO - PROCESS | 25744 | |5;Earley;800.8 12:46:46 INFO - PROCESS | 25744 | |6;Boyer;12525 12:46:46 INFO - PROCESS | 25744 | |7;RegExp;26894.736842105263 12:46:46 INFO - PROCESS | 25744 | |8;Splay;617.6652254478073 12:46:46 INFO - PROCESS | 25744 | |9;NavierStokes;4868.9320388349515 12:46:46 INFO - PROCESS | 25744 | __end_tp_report 12:46:46 INFO - PROCESS | 25744 | __startTimestamp1451940406817__endTimestamp 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | ------- Summary: start ------- 12:46:46 INFO - PROCESS | 25744 | Number of tests: 10 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | [#0] Richards Cycles:1 Average:166.69 Median:166.69 stddev:0.00 (0.0%) 12:46:46 INFO - PROCESS | 25744 | Values: 166.7 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | [#1] DeltaBlue Cycles:1 Average:188.39 Median:188.39 stddev:0.00 (0.0%) 12:46:46 INFO - PROCESS | 25744 | Values: 188.4 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | [#2] Encrypt Cycles:1 Average:278.32 Median:278.32 stddev:0.00 (0.0%) 12:46:46 INFO - PROCESS | 25744 | Values: 278.3 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 12:46:46 INFO - PROCESS | 25744 | Values: 5159.8 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 12:46:46 INFO - PROCESS | 25744 | Values: 1972.4 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | [#5] Earley Cycles:1 Average:800.80 Median:800.80 stddev:0.00 (0.0%) 12:46:46 INFO - PROCESS | 25744 | Values: 800.8 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | [#6] Boyer Cycles:1 Average:12525.00 Median:12525.00 stddev:0.00 (0.0%) 12:46:46 INFO - PROCESS | 25744 | Values: 12525.0 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | [#7] RegExp Cycles:1 Average:26894.74 Median:26894.74 stddev:0.00 (0.0%) 12:46:46 INFO - PROCESS | 25744 | Values: 26894.7 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | [#8] Splay Cycles:1 Average:617.67 Median:617.67 stddev:0.00 (0.0%) 12:46:46 INFO - PROCESS | 25744 | Values: 617.7 12:46:46 INFO - PROCESS | 25744 | 12:46:46 INFO - PROCESS | 25744 | [#9] NavierStokes Cycles:1 Average:4868.93 Median:4868.93 stddev:0.00 (0.0%) 12:46:46 INFO - PROCESS | 25744 | Values: 4868.9 12:46:46 INFO - PROCESS | 25744 | -------- Summary: end -------- 12:46:46 INFO - PROCESS | 25744 | 12:46:47 INFO - TEST-INFO | 25744: exit 0 12:46:47 INFO - TEST-OK | v8_7 | took 40175ms 12:46:47 INFO - SUITE-END | took 1218s 12:46:47 INFO - Completed test suite (00:20:18) 12:46:47 INFO - Working with test: dromaeo_css 12:46:47 INFO - Generating results file: dromaeo_css 12:46:47 INFO - Working with test: kraken 12:46:47 INFO - Generating results file: kraken 12:46:47 INFO - javascript benchmark 12:46:47 INFO - Working with test: v8_7 12:46:47 INFO - Generating results file: v8_7 12:46:47 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:46:47 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:46:47 INFO - process_Request line: dromaeo_css 6130.84 graph.html#tests=[[72,132,35]] 12:46:47 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:46:47 INFO - process_Request line: kraken 1544.10 graph.html#tests=[[232,132,35]] 12:46:47 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:46:47 INFO - process_Request line: v8_7 19661.35 graph.html#tests=[[230,132,35]] 12:46:47 INFO - RETURN: dromaeo_css: 6130.84 12:46:47 INFO - RETURN: kraken: 1544.10 12:46:47 INFO - RETURN: v8_7: 19661.35 12:46:47 INFO - javascript benchmark 12:46:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2598.6491823603815, 2709.796765242606, 2713.5522638764605, 2721.9047333343337, 2737.411456536845, 4436.179306828239, 4546.749928753918, 4639.420072490939, 4663.090697314025, 4684.789184486698, 4536.7051141675765, 4566.885827854297, 4603.470600880892, 4615.076984603084, 4655.255159174532, 4132.462779838616, 4184.97468120311, 4223.746575205482, 4273.786310684469, 4279.61483466488, 4105.651019663333, 4243.490781106271, 4269.87190384289, 4297.03316753731, 4344.087741574273, 4156.085661154556, 4209.894752631178, 4265.573442655741, 4276.593723596254, 4304.569543045702, 4291.935620965688, 4294.892627684301, 4298.699091063627, 4298.914021719579, 4331.242032644274, 4128.710990230685, 4208.579142085798, 4240.851570195059, 4298.140371925628, 4324.740515569076, 4498.077894031716, 4550.408446901914, 4585.151746926829, 4605.953940460619, 4606.769661516911, 4840.443349014873, 4880.41435027799, 4887.315775791357, 4893.486183950705, 4939.3578834751615, 4900.068986892515, 4901.687073744674, 4912.214045752662, 4912.263160525914, 4912.901741965176, 4420.911581768379, 4520.412346394947, 4522.163399771053, 4590.196715574761, 4713.387259656222, 5059.924101138486, 5064.4935506449065, 5071.3153724247495, 5072.112380333427, 5077.771500282496, 4870.634702397334, 4873.853784386474, 4874.2201247800185, 4874.366332376769, 4916.532929371704, 4770.522947705202, 4864.1001414737675, 4882.609391248691, 4883.560479556786, 4885.682430641997, 4859.95140048602, 4876.780544875489, 4884.096442158212, 4889.65772395936, 4931.975340123348, 4859.781309840995, 4865.148598995162, 4866.853994380174, 4866.902661946812, 4905.264210368473, 3985.4021896715726, 4036.6770658347264, 4076.103257283393, 4114.136031433432, 4156.168766246763, 3565.7682250653625, 3625.782453052825, 3641.289948460078, 3652.214773823641, 3666.633336666312, 4216.641585465209, 4222.577742225752, 4224.894377640584, 4264.744115353026, 4267.935980960288, 4714.38712967312, 4847.394075740533, 4852.005338905516, 4930.33440485537, 4936.555709986047, 4154.729942553724, 4159.355299928516, 4238.364245363158, 4252.787360631956, 4270.957290427056, 4400.801963911632, 4432.623227025739, 4442.289233722653, 4444.266695995189, 4484.8430304939175, 4543.0, 4779.761011949458, 4779.904401911942, 4783.473817879961, 4813.133635945494, 4787.61699064081, 4799.424069111589, 4863.173260545645, 4942.703437793743, 4989.575886049726, 4715.292706094114, 4732.5030871759345, 4735.431748190239, 4738.976305118453, 4778.331033655221, 4690.249560070372, 4878.121938051185, 4878.56092951636, 4880.92678609814, 4933.038057578738, 4823.300621409946, 4843.564079232886, 4846.224604063474, 4848.0, 4849.199882019428, 4816.686915350491, 4820.204666230033, 4822.156122678447, 4827.300041493893, 4865.683730557503, 4772.212584923449, 4798.2082956311815, 4816.253480710496, 4819.060283244734, 4863.635227357891, 4548.749818759868, 4604.194266003503, 4655.371524844239, 4655.580997710223, 4722.1972264714395, 4826.58973987201, 4831.275308703723, 4837.2260438329695, 4844.539768721966, 4853.0779151961015, 4673.789679464364, 4675.509071547439, 4681.180793361216, 4687.601553867959, 4727.196376615915], "unit": "score", "name": "dojo.html", "value": 4516.35023600431}, {"lowerIsBetter": false, "replicates": [494.74026136278474, 499.71765952236984, 510.40282869043216, 529.7642549065665, 537.4786457136577, 25231.0, 25747.356316092108, 33139.17152071199, 33780.662193378055, 33795.324093518175, 37369.25261494768, 37678.24643507128, 37803.62196378035, 37907.81046094772, 37994.15043871714, 6798.354156355138, 7773.61131943402, 7939.444238903279, 7949.364050875945, 7951.0, 5569.081101618249, 5725.713714314267, 5732.79935202268, 5839.941600583982, 9867.654632087879, 9743.171830394389, 9832.164266037395, 9833.950830245838, 9834.967328430483, 9838.065383788564, 9838.458884761336, 9914.305998580103, 9936.652217172365, 9941.502924853728, 9956.15372693322, 6924.134483189601, 7135.571865688075, 9849.359791613522, 10096.091351778301, 10132.189424846069, 28491.430171396663, 28676.426471470662, 28795.28011799722, 28808.711912881023, 28813.42373152546, 2744.794140439475, 2799.328161241308, 3017.532282496217, 3187.952180717291, 3524.3303772283184, 26937.86531067332, 28100.437991240266, 28238.0, 28316.433671326457, 28609.570856436963, 3234.1267857678295, 3342.7660063795543, 3359.4792807114936, 3402.557667503209, 3451.2752322012407, 233410.0, 236595.0, 237770.0, 238087.0, 238945.0, 47898.28152577714, 48992.0, 57145.42854571484, 57433.13850292249, 57681.71159144177, 58771.0, 60038.39961600416, 60272.69863650654, 60332.39667603355, 60392.69803650954, 13882.791758123636, 14182.432702691776, 14193.148411095368, 14201.289935503184, 14205.28973551339, 9723.951380243054, 9742.707718768448, 9760.853587196198, 9825.263105266991, 9832.115109640166, 18417.447476575457, 18607.16267767954, 18654.53363665892, 19453.0, 19496.51258718515, 6049.911016017159, 6248.781292654735, 6310.318114801191, 6385.584936979081, 6385.904211436832, 865.2385900407601, 867.3761870342265, 895.8790563273875, 908.1100521488846, 1050.9842352364722, 25896.22311330663, 25924.351891202492, 25991.350216244744, 26098.608520872203, 26216.344591384986, 935.6818681648273, 940.8165407745424, 956.5886668732372, 1006.5571148694551, 1035.295998720862, 12824.935875320563, 12875.291858947661, 14900.254987250593, 15693.686126277411, 16668.333266669197, 330202.0, 335533.0, 335847.0, 335917.0, 336207.0, 48478.757606211744, 48958.0, 49073.0, 49116.50883491191, 49228.0, 1206.8913797758244, 1237.5235534319172, 1266.5883587833807, 1271.389732928181, 1272.9561759357423, 23630.88184559135, 27452.0, 27581.586276206275, 28451.146465606063, 28550.0, 42717.35923961205, 43674.56325436705, 43676.781616091714, 43746.562534375524, 43748.56251437445, 256255.0, 257793.0, 258634.0, 259181.0, 259211.0, 23777.762222377554, 24523.632145517473, 24530.264092077265, 28172.85913570501, 28621.0, 33121.50317745284, 33201.83399082989, 33368.833155834065, 34197.658023420445, 34211.828940855135, 29261.85369073141, 30789.23026924255, 31342.373152536366, 31708.84145579257, 31798.841005794824, 31229.843850780602, 31325.68674313319, 31375.84312078425, 34473.138171545914, 36115.0, 32412.0, 32430.0, 32927.0, 33066.5040024395, 33299.167520812174, 24673.25980220596, 25898.611520826827, 26032.219033429028, 26136.73863261343, 26415.603765943142, 21322.466938326044, 24472.510549789262, 25192.496150076528, 26679.466410672067, 26933.595996060467], "unit": "score", "name": "ext.html", "value": 16707.270216454745}, {"lowerIsBetter": false, "replicates": [324.60074108846106, 329.47284345047916, 329.6489238960507, 330.3294312545532, 330.4712460063897, 11522.135839812006, 11944.701382465442, 14511.346989385476, 14942.25288735563, 15006.174660393674, 12327.938360308208, 12335.444904979275, 12597.0, 12640.304783236918, 12714.618561443149, 4925.310456536088, 4937.456879743226, 5087.338645976037, 5090.389153301609, 5090.974545127269, 3733.701303895682, 3849.7873169951517, 4935.161022626145, 5591.888162236753, 5803.448672376138, 5663.292088488939, 5721.199032135504, 5730.083186690131, 5740.937926483593, 5746.511546518551, 5565.2486914266665, 5700.800471983482, 5745.368009518949, 5762.308522977228, 5763.308402991626, 5017.397912250517, 5023.171176755831, 5028.245763135523, 5029.321041659366, 5030.6730062546185, 18675.626487470174, 18915.0, 19211.903940480348, 19256.80743192564, 19374.128164232643, 1407.345584303304, 1897.7532920720357, 1898.2691663709434, 1948.9902550487298, 2299.7585253548305, 8126.756197314031, 8364.832703345959, 8592.785180370542, 8604.225619694194, 9932.304738668296, 1716.8197339279445, 1742.8518575921062, 1746.1705689797373, 1791.7133258678548, 1797.757302764123, 56151.0, 58551.70724146395, 58961.115583266284, 59015.11477327844, 59029.40970590325, 8673.176048275403, 9157.221636160868, 9434.150926416656, 9501.097395747393, 9601.37591056579, 12059.336736479403, 12137.878621213851, 12153.5138594457, 12179.330136842558, 12188.512459501699, 6992.160940687048, 7091.2554181810165, 7113.679884405111, 7151.856962860714, 7174.92825071753, 6785.558938668971, 6865.450763938873, 6866.244713081557, 6874.690638921261, 6885.552439091543, 4009.7393669411395, 4024.175044116008, 4044.0992733415246, 4046.8785936421955, 4071.0229544909007, 1572.4575021617525, 1595.9840401595836, 1618.5629879932353, 1620.4004518328295, 1655.6688662267595, 816.4285000499674, 886.902440731519, 957.3394357893171, 966.5988614724951, 973.7224890906058, 15323.080615163126, 15538.145402002772, 15744.291506882219, 15920.0, 15965.600859978593, 740.8555331710372, 781.4725060584083, 832.9916700832914, 840.436907272117, 861.8319427711662, 8098.838023239502, 8368.20502052304, 8376.686271181354, 8417.70538031166, 8512.914870851337, 461998.0, 466991.0, 467714.0, 468096.0, 475554.0, 71445.50471143678, 72082.2791772086, 72350.63824680948, 72656.0, 75386.62306688541, 1015.0357160697367, 1015.5531566111035, 1018.4398580780689, 1029.6653587584065, 1030.9175265978704, 12630.747385052431, 12818.294993775431, 12956.870431295943, 12976.351182441029, 13076.673083172616, 28838.855805720836, 29106.12681619555, 29240.0, 29286.267843303234, 29577.408451831274, 42137.57862421459, 42562.57437425586, 42690.57309426866, 43082.138357232056, 44181.11637767291, 8197.754067377988, 8412.116727743498, 8565.143485651384, 8638.308935285288, 8651.437656552303, 8428.410011299395, 10168.847467288144, 10260.640877569249, 16246.431374901822, 16431.507054788377, 13647.522336718168, 13819.0, 13922.164670119826, 14084.366203521071, 14420.567382978528, 12985.545505907248, 13021.153625014344, 13271.800922986356, 13467.730645387233, 13475.460981560627, 14230.0, 14252.501162459264, 14340.856591434369, 14342.928285358506, 14470.855291447371, 8738.563071846254, 8773.605187766694, 8775.07861674515, 8783.912160878564, 8960.775980600538, 13004.739905201654, 13262.137961032502, 13274.93362533181, 13603.047786654839, 13885.514007009706], "unit": "score", "name": "jquery.html", "value": 8079.219890972431}, {"lowerIsBetter": false, "replicates": [1121.4056550028477, 1361.1220762608116, 1367.432515506065, 1467.7284702330069, 1698.2612563534863, 5655.858603534909, 5823.097419899912, 6415.422611964928, 6493.1558897343275, 6500.80497585072, 6493.0, 6564.5076619253505, 6586.209654841414, 6589.0, 6590.308017658149, 2048.4264405966314, 2082.802133797287, 2084.6247675418417, 2085.103405535619, 2085.8122768950793, 2037.7350944377283, 2071.2232912657755, 2074.917003319865, 2084.9895750521227, 2095.538981424092, 2035.470777597828, 2052.2509284111266, 2058.7941205879442, 2064.4013236161495, 2071.906764195615, 2045.5295282085056, 2083.6353638113346, 2084.280923081542, 2084.4372019554785, 2086.3219453677616, 2082.791720827905, 2100.8949552522313, 2125.776793436698, 2140.860844045132, 2141.6145093883097, 6700.497462690318, 6760.628165450898, 6763.830904227384, 6765.797026089225, 6767.187937447488, 3984.7409918355215, 4027.2750904837117, 4027.617376349242, 4028.0936789222483, 4057.046594050396, 2557.3223095879607, 2578.097665816949, 2617.070939816376, 2670.826396284235, 2678.4375281190974, 784.2432053068759, 791.2562191539934, 791.8812178173263, 826.4669288309067, 1720.3118752498976, 8763.079876612992, 8830.86753698695, 8853.911460885372, 8928.419652722552, 8935.240504557121, 3574.12433953683, 3596.1549035976523, 3640.6541378568995, 3643.034595832107, 3734.7198960078103, 7180.353768160786, 7197.820054498575, 7203.099612548432, 7205.351518363268, 7208.603526805971, 4006.759594424344, 4011.498562679665, 4047.433359329696, 4052.452918855976, 4064.4919385076864, 2993.3564283679116, 3069.8618562164756, 3610.927781444409, 3717.1636381813873, 3729.738918275749, 2888.5522743974716, 2939.5002849515636, 2942.6027486289076, 2967.5251959686348, 2982.478066338382, 798.5448294472095, 802.0495712580494, 802.6749166587541, 802.9839403211903, 803.5219044668413, 878.2403221213605, 901.0403919825364, 1100.6092837042895, 1111.4442778610694, 1124.3534967393618, 6188.4739797117745, 6302.621842689453, 6315.5894866833505, 6339.239291284983, 6342.39747224013, 400.21557746816563, 408.0919953104319, 1041.463646222196, 1044.1959691037857, 1109.9778004439866, 5042.949570504321, 5095.082885080721, 5109.182530795055, 5109.948900511022, 5118.0, 7866.623340915431, 7878.0, 7980.042394912648, 8060.113387527367, 8064.959675201587, 7710.306072453506, 7910.288074073361, 7922.286994170552, 7931.762047138595, 7932.881006784903, 6386.712597933011, 6444.8388790280615, 6461.353864613501, 6510.251321098134, 6527.738890444424, 6111.419415155553, 6233.252009758677, 6236.189295391751, 6249.687515624291, 6262.937370626418, 7169.139703235645, 7220.458465614995, 7222.494425390382, 7332.78001659951, 7352.4485663576515, 7421.443391745533, 7533.359664428366, 7534.397248220239, 7545.622718864144, 7670.69317227327, 5227.947720522746, 5331.866703332447, 6115.969420152871, 6220.284667263141, 6232.906506402317, 6239.344868788712, 6296.968515157395, 6342.365763423805, 6345.682715864281, 6348.936510634834, 5964.642121472725, 6020.217371741645, 6156.384361563808, 6177.96911015442, 6367.299597044229, 5963.254593175853, 6003.219581454558, 6029.698515074141, 6036.879262414815, 6049.697515124314, 5946.28644562638, 5999.820005399845, 6010.1585777991995, 6049.304330002106, 6057.939420605914, 5789.9710501447225, 5790.218320526675, 5815.447532484407, 5820.650760954356, 5833.416658334302, 5828.883422331445, 5875.030619947832, 5894.734736936934, 5911.556633252438, 5933.940660593339], "unit": "score", "name": "mootools.html", "value": 3850.4225782836343}, {"lowerIsBetter": false, "replicates": [294.9837758923259, 298.0670501330834, 302.37559439756916, 302.4495418338623, 302.9924251893701, 5310.415854256038, 5422.186671999202, 5433.1578605316145, 5531.032069387861, 5537.335519737627, 5349.679019258838, 5419.376771671259, 5426.8371948841595, 5432.2123292122615, 5437.782488700447, 3914.17802261524, 4111.075008123164, 4111.095558977036, 4118.505779306487, 4118.670506359484, 4001.25976694311, 4015.7751885675, 4092.3043082675867, 4094.7338423002557, 4102.446169767088, 4022.798860057, 4084.9387259191135, 4091.0590564170257, 4098.057446787241, 4099.50805903292, 3866.284737323604, 3963.088489647397, 3985.2826491231567, 4096.549379568245, 4104.13813099248, 3525.5593050868642, 3533.2050288685095, 3540.822958852047, 3551.076720052779, 3552.467129930505, 5153.458886816868, 5166.199239117943, 5168.379794424655, 5168.638195326329, 5170.146925757245, 4712.458067322267, 4723.834665786715, 4726.314684370747, 4728.1252968201, 4729.935764453005, 5552.611317207797, 5616.269884914935, 5654.886902261973, 5672.829815105553, 5680.3467601225975, 3873.2253549290253, 3875.5543112542136, 3878.1855810279876, 3883.864064757748, 3891.3579259422163, 5893.14549390336, 5995.340512543617, 5995.850103747398, 5998.700064996777, 6000.099985002241, 3981.5620281768984, 3991.241664083873, 3991.940120898189, 3992.181602771425, 3994.9001274967777, 3889.8055097245024, 4047.777372244555, 4048.27131116396, 4052.068024354415, 4053.473048503735, 4657.720536767804, 4690.6012988895645, 4692.929606055912, 4695.835645752451, 4703.811847526061, 5653.773849046074, 5656.5757568181725, 5657.688827114548, 5665.688387138664, 5666.744996475169, 1406.9577912662637, 1425.8360288566948, 1428.52144531581, 1428.721399327142, 1430.6065831896312, 940.4874343482818, 943.919766819828, 950.3632566180676, 968.1867231525553, 969.0745338202, 4980.352554167935, 4986.5289739526925, 4990.600751939836, 4997.775100120503, 4998.150314446553, 5919.052951527735, 5927.288725352985, 5928.318243401977, 5929.110633405024, 5936.614120082268, 4985.601151907838, 4990.351254336985, 4990.50094990498, 4993.251012348177, 4994.200927851526, 3127.577777000076, 3142.1987393214586, 3195.3769015041844, 3195.4248235317864, 3205.294835136266, 5604.103343465026, 5610.579206559524, 5612.214289999403, 5619.297587801525, 5622.0, 6028.367021462771, 6058.878822423615, 6059.697015149313, 6065.96967015171, 6071.180390647294, 5588.161775733673, 5590.105583106765, 5598.272224610856, 5602.635828671123, 5619.522340601013, 5741.282339707536, 5861.9413805861395, 5909.5863289569315, 5967.433093856077, 5980.0, 5809.448102430262, 5811.622244554091, 5813.76744930198, 5820.0, 5824.708764561839, 5666.405027472056, 5666.943330566806, 5667.801626943202, 5669.7165141741925, 5675.290588676416, 3860.9227815444096, 3927.469791578215, 3950.486436763202, 3963.6432721055244, 3972.3445631470486, 5963.761449541969, 5968.343482216866, 5973.342932277533, 5977.462028417463, 5978.461938425563, 5715.599908006399, 5733.283339582552, 5738.340090889435, 5739.8565035874435, 5740.483356497935, 5586.0, 5697.515711164598, 5732.914006289826, 5745.712714364348, 5748.137779333133, 5624.100143976944, 5628.690422026828, 5630.85922851932, 5635.774569017193, 5640.464155905182, 5531.529819965348, 5660.066089095253, 5738.885222295614, 5774.133879918046, 5779.913301300399, 5462.508374246337, 5562.276904002454, 5585.050541408052, 5595.720213989365, 5598.188262701967], "unit": "score", "name": "prototype.html", "value": 4236.118554009218}, {"lowerIsBetter": false, "replicates": [587.9176915231867, 609.1299709890636, 640.4748106552626, 649.9675016249192, 691.2672567078894, 9204.493752843598, 9311.348205625609, 9336.906630933689, 9345.672901448443, 9348.065193480657, 9996.2502812289, 10060.144887684555, 10786.460676966159, 10799.622013229538, 10800.78398432031, 774.3379410603937, 792.2077922077922, 793.0800271684847, 793.115676021238, 793.8253584211493, 781.6287263549825, 782.7495201535511, 790.1900551934256, 790.3913986230599, 792.1523969352795, 828.9419740618159, 835.2900034970257, 835.5321020228691, 836.2515548584014, 837.9497230166179, 819.9098099209082, 820.0405525535108, 820.0569345252948, 820.2330820682681, 820.4953953318726, 615.3231445410013, 616.3097330989276, 616.5067945643467, 616.5252755378378, 617.0, 9953.90046099537, 9984.80030399388, 10040.69877903664, 10045.598176072948, 10049.497525123714, 8520.70177543783, 9033.63865445388, 9034.819303613956, 9379.812403751956, 9420.293477989178, 8610.784730381727, 8856.158664926821, 8864.468131912106, 8882.86675699865, 8884.955575222148, 3194.121616555466, 3231.644519102897, 3245.334706385185, 3247.0, 3271.1167984644253, 34077.148071298165, 34233.0, 36154.45768313477, 36749.44875826865, 38861.611383886084, 8316.667333306721, 8532.744017679479, 8723.842331373355, 9004.054574269738, 9037.412568183046, 15661.0, 15672.373105075669, 15675.686486270439, 15685.05889646625, 15728.213589320489, 5919.319278283053, 6030.155778191057, 6113.174721412553, 6144.8771024580155, 6165.691715414301, 3555.253396786652, 3566.661167189113, 3599.3521166190335, 3676.9448458273146, 3715.0, 2500.937476563064, 2531.240627811649, 2535.1253817432957, 2536.7463253674855, 2537.1120107962065, 446.44417699963753, 446.61591031712703, 447.4965663628418, 448.64108713029447, 452.32377595494944, 406.4857954687323, 461.83143152749676, 480.1405484183273, 507.86033840693364, 524.3052954834859, 6944.4444444444325, 7197.856042879218, 7216.458765592602, 7518.473706840578, 7528.623568821647, 503.4009528660882, 537.6800803521899, 576.8932747441737, 586.4370204603543, 592.6177615438105, 3329.234276116507, 3372.3423932332958, 3419.196488825124, 3514.61339252682, 3699.0382500549513, 49918.50081499211, 50140.49859501431, 50571.0, 50652.240216396785, 51003.48996510061, 42238.366424503656, 42270.57729422666, 42492.57507424886, 42563.14873702508, 42588.36117458241, 33879.66120338765, 39162.80418597889, 39432.01419964466, 39454.01364965899, 39766.40350394746, 7081.8669012959745, 7255.673494692646, 7422.814429639302, 7451.776446706607, 7467.92532074694, 26791.062312818958, 26845.194644160707, 26866.865665671547, 27039.324016899736, 27234.863825681536, 32057.51913721343, 32307.0, 34435.65564344324, 34565.30869382648, 34937.30125397529, 9369.0, 9618.951905240709, 9917.074463033277, 10186.337888037255, 10238.641647542301, 10497.737556561147, 10611.8938810614, 10861.076808471369, 11095.0, 11135.610253641084, 9876.23639345909, 9993.400395976265, 10100.292979491365, 10149.746256343651, 10551.472426378803, 10069.496525173858, 10167.18662506983, 10248.0, 10403.94798026005, 10712.785744285227, 10016.449095299828, 10018.098371146632, 10270.537825798006, 10300.742481438025, 10335.379877207391, 8040.959795200986, 8257.545834979133, 8280.01355418681, 8357.874631880404, 8531.104234055583, 8164.183581642026, 8326.333893288644, 8358.623861926106, 8600.39797214189, 9150.496722680316], "unit": "score", "name": "yui.html", "value": 5339.9245664865675}], "name": "dromaeo_css", "value": 6130.844189158276}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 113.0, 107.0, 113.0, 112.0, 113.0, 102.0, 112.0, 113.0, 102.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [153.0, 134.0, 157.0, 173.0, 147.0, 161.0, 156.0, 132.0, 173.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 152.5}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 161.0, 162.0, 161.0, 161.0, 162.0, 160.0, 161.0, 163.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 110.0, 92.0, 73.0, 72.0, 72.0, 107.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 83.4}, {"lowerIsBetter": true, "replicates": [99.0, 99.0, 139.0, 98.0, 98.0, 99.0, 145.0, 100.0, 99.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 111.6}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 110.0, 109.0, 110.0, 108.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 148.0, 146.0, 148.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [71.0, 72.0, 72.0, 72.0, 71.0, 72.0, 72.0, 71.0, 85.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [95.0, 86.0, 86.0, 88.0, 86.0, 86.0, 86.0, 85.0, 85.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [128.0, 131.0, 121.0, 125.0, 128.0, 121.0, 130.0, 132.0, 128.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.8}, {"lowerIsBetter": true, "replicates": [139.0, 152.0, 157.0, 157.0, 145.0, 137.0, 152.0, 151.0, 150.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [72.0, 70.0, 73.0, 71.0, 71.0, 71.0, 73.0, 71.0, 69.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.1}], "name": "kraken", "value": 1544.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.6944490748458], "unit": "score", "name": "Richards", "value": 211.77669800000004}, {"lowerIsBetter": false, "replicates": [188.39487565938205], "unit": "score", "name": "DeltaBlue", "value": 350.95434399999994}, {"lowerIsBetter": false, "replicates": [278.31895352073474], "unit": "score", "name": "Encrypt", "value": 956.3883330000003}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [800.8], "unit": "score", "name": "Earley", "value": 832.2465034965037}, {"lowerIsBetter": false, "replicates": [12525.0], "unit": "score", "name": "Boyer", "value": 53.21061876247504}, {"lowerIsBetter": false, "replicates": [26894.736842105263], "unit": "score", "name": "RegExp", "value": 33.87224070450098}, {"lowerIsBetter": false, "replicates": [617.6652254478073], "unit": "score", "name": "Splay", "value": 131.93392900000003}, {"lowerIsBetter": false, "replicates": [4868.9320388349515], "unit": "score", "name": "NavierStokes", "value": 304.7896311066801}], "name": "v8_7", "value": 19661.353390115724}]} 12:46:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19661.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1544.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6130.84"}}} 12:46:48 INFO - Return code: 0 12:46:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:46:48 INFO - # TBPL SUCCESS # 12:46:48 INFO - Running post-action listener: _resource_record_post_action 12:46:48 INFO - Running post-run listener: _resource_record_post_run 12:46:49 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 559710208; Read time: 0; Write time: 468568 12:46:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245174272; Read time: 0; Write time: 255944 12:46:49 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 314535936; Read time: 0; Write time: 212624 12:46:49 INFO - Running post-run listener: _upload_blobber_files 12:46:49 INFO - Blob upload gear active. 12:46:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:46:49 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 12:46:49 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'] 12:46:49 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 12:46:49 INFO - (blobuploader) - INFO - Open directory for files ... 12:46:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:46:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:46:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:50 INFO - (blobuploader) - INFO - Done attempting. 12:46:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:46:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:46:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:46:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:46:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:46:51 INFO - (blobuploader) - INFO - Done attempting. 12:46:51 INFO - (blobuploader) - INFO - Iteration through files over. 12:46:51 INFO - Return code: 0 12:46:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:46:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:46:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a33313f9f4337dc0a17146d6f85e41217911625c370b1a2dc9b35d712409f82c20435e7cbb01f3725522c95179f8aeae1c869e51a501028b10faf5fc684640a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de2ef51ee47331e6c0834efbab8b8fd3bfed9b97c8bf415c7276ed34586509be36a176bac2b16a378b1baef62ce6abe6e353ff9c74c87d2ceb210ad7e3c0be6e"} 12:46:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:46:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:46:51 INFO - Contents: 12:46:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a33313f9f4337dc0a17146d6f85e41217911625c370b1a2dc9b35d712409f82c20435e7cbb01f3725522c95179f8aeae1c869e51a501028b10faf5fc684640a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de2ef51ee47331e6c0834efbab8b8fd3bfed9b97c8bf415c7276ed34586509be36a176bac2b16a378b1baef62ce6abe6e353ff9c74c87d2ceb210ad7e3c0be6e"} 12:46:51 INFO - Copying logs to upload dir... 12:46:51 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1272.530035 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 12 secs) (at 2016-01-04 12:46:51.092286) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 12:46:51.095810) ========= 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=7de08804244eb36560b44971000001c3-1451939136.804952-1602148427 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/a33313f9f4337dc0a17146d6f85e41217911625c370b1a2dc9b35d712409f82c20435e7cbb01f3725522c95179f8aeae1c869e51a501028b10faf5fc684640a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de2ef51ee47331e6c0834efbab8b8fd3bfed9b97c8bf415c7276ed34586509be36a176bac2b16a378b1baef62ce6abe6e353ff9c74c87d2ceb210ad7e3c0be6e"} build_url:https://queue.taskcluster.net/v1/task/ADFQF5VhTPiHlOXkifomow/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011289 build_url: 'https://queue.taskcluster.net/v1/task/ADFQF5VhTPiHlOXkifomow/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/a33313f9f4337dc0a17146d6f85e41217911625c370b1a2dc9b35d712409f82c20435e7cbb01f3725522c95179f8aeae1c869e51a501028b10faf5fc684640a2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/de2ef51ee47331e6c0834efbab8b8fd3bfed9b97c8bf415c7276ed34586509be36a176bac2b16a378b1baef62ce6abe6e353ff9c74c87d2ceb210ad7e3c0be6e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 12:46:51.121127) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 12:46:51.121500) ========= 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=7de08804244eb36560b44971000001c3-1451939136.804952-1602148427 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 12:46:51.207543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 12:46:51.207923) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 12:46:51.208375) ========= ========= Total master_lag: 0.24 =========