builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1451530774.19 results: success (0) buildid: 20151230174340 builduid: 336f05d75bbe46b1bc50a0807ffc3e43 revision: 4c891eee4b0d83ff52f0a9a10dc052a0944c17f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.186502) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.187012) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.187348) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006321 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.214457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.215042) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.229008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.229530) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004629 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.282643) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.283374) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.284042) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.284548) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-30 18:59:34-- 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% 64.3M=0s 2015-12-30 18:59:34 (64.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.157870 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.456468) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.456857) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013987 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.507749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:34.508294) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4c891eee4b0d83ff52f0a9a10dc052a0944c17f9 --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 4c891eee4b0d83ff52f0a9a10dc052a0944c17f9 --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=0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-30 18:59:34,638 truncating revision to first 12 chars 2015-12-30 18:59:34,638 Setting DEBUG logging. 2015-12-30 18:59:34,638 attempt 1/10 2015-12-30 18:59:34,638 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4c891eee4b0d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-30 18:59:34,881 unpacking tar archive at: fx-team-4c891eee4b0d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.540031 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:35.065381) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:35.065740) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:35.075204) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:35.075588) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-30 18:59:35.076061) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-30 18:59:35.076392) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:59:35 INFO - MultiFileLogger online at 20151230 18:59:35 in /builds/slave/test 18:59:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 18:59:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:59:35 INFO - {'append_to_log': False, 18:59:35 INFO - 'base_work_dir': '/builds/slave/test', 18:59:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:59:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:59:35 INFO - 'branch': 'Fx-Team-Non-PGO', 18:59:35 INFO - 'buildbot_json_path': 'buildprops.json', 18:59:35 INFO - 'config_files': ('talos/linux_config.py',), 18:59:35 INFO - 'default_actions': ('clobber', 18:59:35 INFO - 'read-buildbot-config', 18:59:35 INFO - 'download-and-extract', 18:59:35 INFO - 'populate-webroot', 18:59:35 INFO - 'create-virtualenv', 18:59:35 INFO - 'install', 18:59:35 INFO - 'run-tests'), 18:59:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:59:35 INFO - 'download_minidump_stackwalk': True, 18:59:35 INFO - 'download_symbols': 'ondemand', 18:59:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:59:35 INFO - 'tooltool.py': '/tools/tooltool.py', 18:59:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:59:35 INFO - '/tools/misc-python/virtualenv.py')}, 18:59:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:59:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:59:35 INFO - 'installer_path': 'installer.exe', 18:59:35 INFO - 'log_level': 'info', 18:59:35 INFO - 'log_name': 'talos', 18:59:35 INFO - 'log_to_console': True, 18:59:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:59:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:59:35 INFO - 'opt_config_files': (), 18:59:35 INFO - 'pip_index': False, 18:59:35 INFO - 'sps_profile': False, 18:59:35 INFO - 'sps_profile_interval': 0, 18:59:35 INFO - 'suite': 'dromaeojs-e10s', 18:59:35 INFO - 'system_bits': '32', 18:59:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:59:35 INFO - 'title': 'talos-linux64-ix-035', 18:59:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:59:35 INFO - 'use_talos_json': True, 18:59:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:59:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:59:35 INFO - 'work_dir': 'build'} 18:59:35 INFO - ##### 18:59:35 INFO - ##### Running clobber step. 18:59:35 INFO - ##### 18:59:35 INFO - Running pre-action listener: _resource_record_pre_action 18:59:35 INFO - Running main action method: clobber 18:59:35 INFO - rmtree: /builds/slave/test/build 18:59:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:59:36 INFO - Running post-action listener: _resource_record_post_action 18:59:36 INFO - ##### 18:59:36 INFO - ##### Running read-buildbot-config step. 18:59:36 INFO - ##### 18:59:36 INFO - Running pre-action listener: _resource_record_pre_action 18:59:36 INFO - Running main action method: read_buildbot_config 18:59:36 INFO - Using buildbot properties: 18:59:36 INFO - { 18:59:36 INFO - "project": "", 18:59:36 INFO - "product": "firefox", 18:59:36 INFO - "script_repo_revision": "production", 18:59:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:59:36 INFO - "repository": "", 18:59:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:59:36 INFO - "buildid": "20151230174340", 18:59:36 INFO - "pgo_build": "False", 18:59:36 INFO - "basedir": "/builds/slave/test", 18:59:36 INFO - "buildnumber": 870, 18:59:36 INFO - "slavename": "talos-linux64-ix-035", 18:59:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:59:36 INFO - "platform": "ubuntu64_hw", 18:59:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 18:59:36 INFO - "branch": "fx-team", 18:59:36 INFO - "repo_path": "integration/fx-team", 18:59:36 INFO - "revision": "4c891eee4b0d83ff52f0a9a10dc052a0944c17f9", 18:59:36 INFO - "stage_platform": "linux64", 18:59:36 INFO - "builduid": "336f05d75bbe46b1bc50a0807ffc3e43", 18:59:36 INFO - "slavebuilddir": "test" 18:59:36 INFO - } 18:59:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 18:59:36 INFO - Running post-action listener: _resource_record_post_action 18:59:36 INFO - ##### 18:59:36 INFO - ##### Running download-and-extract step. 18:59:36 INFO - ##### 18:59:36 INFO - Running pre-action listener: _resource_record_pre_action 18:59:36 INFO - Running main action method: download_and_extract 18:59:36 INFO - mkdir: /builds/slave/test/build/tests 18:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:36 INFO - https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:59:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/test_packages.json 18:59:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/test_packages.json 18:59:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:59:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:59:37 INFO - Downloaded 1302 bytes. 18:59:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:59:37 INFO - Using the following test package requirements: 18:59:37 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:59:37 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:59:37 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:37 INFO - u'jsshell-linux-x86_64.zip'], 18:59:37 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:59:37 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:59:37 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:59:37 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:59:37 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:59:37 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 18:59:37 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 18:59:37 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:59:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:59:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:37 INFO - https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:59:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/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 18:59:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/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 18:59:39 INFO - Downloaded 21946183 bytes. 18:59:39 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 18:59:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:39 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 18:59:40 INFO - Return code: 0 18:59:40 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 18:59: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')]} 18:59:40 INFO - https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:59:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/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 18:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/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 18:59:45 INFO - Downloaded 21946183 bytes. 18:59:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:59:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 18:59:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:59:46 INFO - Return code: 0 18:59: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')]} 18:59:46 INFO - https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:59:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:59:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:59:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/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 18:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/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 18:59:47 INFO - Downloaded 11132285 bytes. 18:59: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 18:59:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 18:59: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 18:59:48 INFO - Return code: 0 18:59:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:48 INFO - https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:59:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:59:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:59:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/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 18:59:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YsFdikA3RoqureFOAzjqcg/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 18:59:50 INFO - Downloaded 53367695 bytes. 18:59:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:59:50 INFO - mkdir: /builds/slave/test/properties 18:59:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:59:50 INFO - Writing to file /builds/slave/test/properties/build_url 18:59:50 INFO - Contents: 18:59:50 INFO - build_url:https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 18:59:50 INFO - Running post-action listener: _resource_record_post_action 18:59:50 INFO - Running post-action listener: set_extra_try_arguments 18:59:50 INFO - ##### 18:59:50 INFO - ##### Running populate-webroot step. 18:59:50 INFO - ##### 18:59:50 INFO - Running pre-action listener: _resource_record_pre_action 18:59:50 INFO - Running main action method: populate_webroot 18:59:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:59:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:59:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:59:50 INFO - '--tppagecycles', 18:59:50 INFO - '7'], 18:59:50 INFO - 'tests': ['tsvgm']}}, 18:59:50 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:59:50 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:59:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:59:50 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:59:50 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:59:50 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:59:50 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:50 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:50 INFO - 'talos_options': ['--e10s'], 18:59:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:59:50 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:50 INFO - 'tests': ['damp', 'tps']}, 18:59:50 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:50 INFO - 'talos_options': ['--e10s'], 18:59:50 INFO - 'tests': ['damp', 'tps']}, 18:59:50 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:59:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:59:50 INFO - 'other': {'tests': ['a11yr', 18:59:50 INFO - 'ts_paint', 18:59:50 INFO - 'tpaint', 18:59:50 INFO - 'sessionrestore', 18:59:50 INFO - 'sessionrestore_no_auto_restore']}, 18:59:50 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:59:50 INFO - 'tests': ['a11yr', 18:59:50 INFO - 'ts_paint', 18:59:50 INFO - 'tpaint', 18:59:50 INFO - 'sessionrestore', 18:59:50 INFO - 'sessionrestore_no_auto_restore']}, 18:59:50 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:59:50 INFO - 'tests': ['a11yr', 18:59:50 INFO - 'ts_paint', 18:59:50 INFO - 'tpaint', 18:59:50 INFO - 'sessionrestore', 18:59:50 INFO - 'sessionrestore_no_auto_restore']}, 18:59:50 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:59:50 INFO - 'tests': ['a11yr', 18:59:50 INFO - 'ts_paint', 18:59:50 INFO - 'tpaint', 18:59:50 INFO - 'sessionrestore', 18:59:50 INFO - 'sessionrestore_no_auto_restore']}, 18:59:50 INFO - 'other_l64': {'tests': ['a11yr', 18:59:50 INFO - 'ts_paint', 18:59:50 INFO - 'tpaint', 18:59:50 INFO - 'sessionrestore', 18:59:50 INFO - 'sessionrestore_no_auto_restore']}, 18:59:50 INFO - 'other_nol64': {'tests': ['a11yr', 18:59:50 INFO - 'ts_paint', 18:59:50 INFO - 'tpaint', 18:59:50 INFO - 'sessionrestore', 18:59:50 INFO - 'sessionrestore_no_auto_restore']}, 18:59:50 INFO - 'svgr': {'tests': ['tsvgx', 18:59:50 INFO - 'tsvgr_opacity', 18:59:50 INFO - 'tart', 18:59:50 INFO - 'tscrollx', 18:59:50 INFO - 'cart']}, 18:59:50 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:59:50 INFO - 'tests': ['tsvgx', 18:59:50 INFO - 'tsvgr_opacity', 18:59:50 INFO - 'tart', 18:59:50 INFO - 'tscrollx', 18:59:50 INFO - 'cart']}, 18:59:50 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:50 INFO - 'tests': ['tp5o']}, 18:59:50 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:50 INFO - 'talos_options': ['--e10s'], 18:59:50 INFO - 'tests': ['tp5o']}, 18:59:50 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:50 INFO - 'talos_options': ['--xperf_path', 18:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:50 INFO - 'tests': ['tp5n']}, 18:59:50 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:59:50 INFO - 'talos_options': ['--e10s', 18:59:50 INFO - '--xperf_path', 18:59:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:59:50 INFO - 'tests': ['tp5n']}}, 18:59:50 INFO - 'talos.zip': {'path': '', 18:59:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:59:50 INFO - Running post-action listener: _resource_record_post_action 18:59:50 INFO - ##### 18:59:50 INFO - ##### Running create-virtualenv step. 18:59:50 INFO - ##### 18:59:50 INFO - Running pre-action listener: _resource_record_pre_action 18:59:50 INFO - Running main action method: create_virtualenv 18:59:50 INFO - Creating virtualenv /builds/slave/test/build/venv 18:59:50 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 18:59:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:59:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:59:50 INFO - Using real prefix '/usr' 18:59:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:59:50 INFO - Installing distribute.............................................................................................................................................................................................done. 18:59:52 INFO - Installing pip.................done. 18:59:52 INFO - Return code: 0 18:59:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe671bbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd3d0>, '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 0x1928ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', '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 18:59: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', 'pip>=1.5'] in /builds/slave/test/build 18:59: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 pip>=1.5 18:59:52 INFO - Using env: {'DISPLAY': ':0', 18:59:52 INFO - 'HOME': '/home/cltbld', 18:59:52 INFO - 'LANG': 'en_US.UTF-8', 18:59:52 INFO - 'LANGUAGE': 'en_US:en', 18:59:52 INFO - 'LOGNAME': 'cltbld', 18:59:52 INFO - 'MAIL': '/var/mail/cltbld', 18:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:52 INFO - 'MOZ_NO_REMOTE': '1', 18:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:52 INFO - 'NO_EM_RESTART': '1', 18:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:52 INFO - 'PWD': '/builds/slave/test', 18:59:52 INFO - 'SHELL': '/bin/bash', 18:59:52 INFO - 'SHLVL': '1', 18:59:52 INFO - 'TERM': 'linux', 18:59:52 INFO - 'TMOUT': '86400', 18:59:52 INFO - 'USER': 'cltbld', 18:59:52 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', 18:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:52 INFO - '_': '/tools/buildbot/bin/python'} 18:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59: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 18:59:52 INFO - Cleaning up... 18:59:52 INFO - Return code: 0 18:59:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:59: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')]} 18:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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')]} 18:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59: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 0x7fe671bbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd3d0>, '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 0x1928ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', '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 18:59: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 18:59: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 18:59:52 INFO - Using env: {'DISPLAY': ':0', 18:59:52 INFO - 'HOME': '/home/cltbld', 18:59:52 INFO - 'LANG': 'en_US.UTF-8', 18:59:52 INFO - 'LANGUAGE': 'en_US:en', 18:59:52 INFO - 'LOGNAME': 'cltbld', 18:59:52 INFO - 'MAIL': '/var/mail/cltbld', 18:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:52 INFO - 'MOZ_NO_REMOTE': '1', 18:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:52 INFO - 'NO_EM_RESTART': '1', 18:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:52 INFO - 'PWD': '/builds/slave/test', 18:59:52 INFO - 'SHELL': '/bin/bash', 18:59:52 INFO - 'SHLVL': '1', 18:59:52 INFO - 'TERM': 'linux', 18:59:52 INFO - 'TMOUT': '86400', 18:59:52 INFO - 'USER': 'cltbld', 18:59:52 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', 18:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:52 INFO - '_': '/tools/buildbot/bin/python'} 18:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:53 INFO - Downloading/unpacking psutil>=0.7.1 18:59:53 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 18:59:53 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 18:59:53 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 18:59:53 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 18:59:53 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 18:59:53 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 18:59:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:59:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:59:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:59:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:54 INFO - Installing collected packages: psutil 18:59:54 INFO - Running setup.py install for psutil 18:59:55 INFO - building 'psutil._psutil_linux' extension 18:59:55 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 18:59:55 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 18:59:55 INFO - building 'psutil._psutil_posix' extension 18:59:55 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 18:59:55 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 18:59:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:59:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:59:55 INFO - Successfully installed psutil 18:59:55 INFO - Cleaning up... 18:59:55 INFO - Return code: 0 18:59:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe671bbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd3d0>, '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 0x1928ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', '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 18:59:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 18:59:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 18:59:55 INFO - Using env: {'DISPLAY': ':0', 18:59:55 INFO - 'HOME': '/home/cltbld', 18:59:55 INFO - 'LANG': 'en_US.UTF-8', 18:59:55 INFO - 'LANGUAGE': 'en_US:en', 18:59:55 INFO - 'LOGNAME': 'cltbld', 18:59:55 INFO - 'MAIL': '/var/mail/cltbld', 18:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:55 INFO - 'MOZ_NO_REMOTE': '1', 18:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:55 INFO - 'NO_EM_RESTART': '1', 18:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:55 INFO - 'PWD': '/builds/slave/test', 18:59:55 INFO - 'SHELL': '/bin/bash', 18:59:55 INFO - 'SHLVL': '1', 18:59:55 INFO - 'TERM': 'linux', 18:59:55 INFO - 'TMOUT': '86400', 18:59:55 INFO - 'USER': 'cltbld', 18:59:55 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', 18:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:55 INFO - '_': '/tools/buildbot/bin/python'} 18:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:59:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:59:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:59:57 INFO - Installing collected packages: mozsystemmonitor 18:59:57 INFO - Running setup.py install for mozsystemmonitor 18:59:57 INFO - Successfully installed mozsystemmonitor 18:59:57 INFO - Cleaning up... 18:59:57 INFO - Return code: 0 18:59:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:59:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe671bbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd3d0>, '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 0x1928ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', '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 18:59:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:59:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:59:57 INFO - Using env: {'DISPLAY': ':0', 18:59:57 INFO - 'HOME': '/home/cltbld', 18:59:57 INFO - 'LANG': 'en_US.UTF-8', 18:59:57 INFO - 'LANGUAGE': 'en_US:en', 18:59:57 INFO - 'LOGNAME': 'cltbld', 18:59:57 INFO - 'MAIL': '/var/mail/cltbld', 18:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:59:57 INFO - 'MOZ_NO_REMOTE': '1', 18:59:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:59:57 INFO - 'NO_EM_RESTART': '1', 18:59:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:59:57 INFO - 'PWD': '/builds/slave/test', 18:59:57 INFO - 'SHELL': '/bin/bash', 18:59:57 INFO - 'SHLVL': '1', 18:59:57 INFO - 'TERM': 'linux', 18:59:57 INFO - 'TMOUT': '86400', 18:59:57 INFO - 'USER': 'cltbld', 18:59:57 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', 18:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:59:57 INFO - '_': '/tools/buildbot/bin/python'} 18:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:59:57 INFO - Downloading/unpacking blobuploader==1.2.4 18:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:59:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:59:59 INFO - Downloading blobuploader-1.2.4.tar.gz 18:59:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:59:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:59:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:59:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 18:59: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 19:00:00 INFO - Downloading docopt-0.6.1.tar.gz 19:00:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:00:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:00:00 INFO - Running setup.py install for blobuploader 19:00:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:00:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:00:00 INFO - Running setup.py install for requests 19:00:00 INFO - Running setup.py install for docopt 19:00:00 INFO - Successfully installed blobuploader requests docopt 19:00:00 INFO - Cleaning up... 19:00:00 INFO - Return code: 0 19:00:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:00 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')]} 19:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:00 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')]} 19:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:00 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 0x7fe671bbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd3d0>, '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 0x1928ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', '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 19:00:00 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 19:00:00 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 19:00:00 INFO - Using env: {'DISPLAY': ':0', 19:00:00 INFO - 'HOME': '/home/cltbld', 19:00:00 INFO - 'LANG': 'en_US.UTF-8', 19:00:00 INFO - 'LANGUAGE': 'en_US:en', 19:00:00 INFO - 'LOGNAME': 'cltbld', 19:00:00 INFO - 'MAIL': '/var/mail/cltbld', 19:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:00 INFO - 'MOZ_NO_REMOTE': '1', 19:00:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:00 INFO - 'NO_EM_RESTART': '1', 19:00:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:00 INFO - 'PWD': '/builds/slave/test', 19:00:00 INFO - 'SHELL': '/bin/bash', 19:00:00 INFO - 'SHLVL': '1', 19:00:00 INFO - 'TERM': 'linux', 19:00:00 INFO - 'TMOUT': '86400', 19:00:00 INFO - 'USER': 'cltbld', 19:00:00 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', 19:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:00 INFO - '_': '/tools/buildbot/bin/python'} 19:00:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:01 INFO - Running setup.py (path:/tmp/pip-zJOsOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:01 INFO - Running setup.py (path:/tmp/pip-Ri0Qp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:01 INFO - Running setup.py (path:/tmp/pip-gchVhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:01 INFO - Running setup.py (path:/tmp/pip-vMHf0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:01 INFO - Running setup.py (path:/tmp/pip-9FBNwd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:01 INFO - Running setup.py (path:/tmp/pip-2NX2vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:01 INFO - Running setup.py (path:/tmp/pip-5jhXSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:01 INFO - Running setup.py (path:/tmp/pip-cNqGoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:01 INFO - Running setup.py (path:/tmp/pip-ikqarI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:01 INFO - Running setup.py (path:/tmp/pip-9DtlHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:01 INFO - Running setup.py (path:/tmp/pip-UsRVmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:01 INFO - Running setup.py (path:/tmp/pip-RvhoGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:01 INFO - Running setup.py (path:/tmp/pip-lNyklr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:01 INFO - Running setup.py (path:/tmp/pip-osfrn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:02 INFO - Running setup.py (path:/tmp/pip-L4WE57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:02 INFO - Running setup.py (path:/tmp/pip-E9PLhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:02 INFO - Running setup.py (path:/tmp/pip-1vftwu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:00:02 INFO - Running setup.py install for manifestparser 19:00:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:00:02 INFO - Running setup.py install for mozcrash 19:00:02 INFO - Running setup.py install for mozdebug 19:00:02 INFO - Running setup.py install for mozdevice 19:00:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:00:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:00:02 INFO - Running setup.py install for mozfile 19:00:02 INFO - Running setup.py install for mozhttpd 19:00:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:00:02 INFO - Running setup.py install for mozinfo 19:00:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:00:02 INFO - Running setup.py install for mozInstall 19:00:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Running setup.py install for mozleak 19:00:03 INFO - Running setup.py install for mozlog 19:00:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Running setup.py install for moznetwork 19:00:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Running setup.py install for mozprocess 19:00:03 INFO - Running setup.py install for mozprofile 19:00:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Running setup.py install for mozrunner 19:00:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:00:03 INFO - Running setup.py install for mozscreenshot 19:00:03 INFO - Running setup.py install for moztest 19:00:03 INFO - Running setup.py install for mozversion 19:00:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:00:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:00:04 INFO - Cleaning up... 19:00:04 INFO - Return code: 0 19:00:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:04 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 0x7fe671bbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd3d0>, '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 0x1928ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', '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 19:00:04 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 19:00:04 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 19:00:04 INFO - Using env: {'DISPLAY': ':0', 19:00:04 INFO - 'HOME': '/home/cltbld', 19:00:04 INFO - 'LANG': 'en_US.UTF-8', 19:00:04 INFO - 'LANGUAGE': 'en_US:en', 19:00:04 INFO - 'LOGNAME': 'cltbld', 19:00:04 INFO - 'MAIL': '/var/mail/cltbld', 19:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:04 INFO - 'MOZ_NO_REMOTE': '1', 19:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:04 INFO - 'NO_EM_RESTART': '1', 19:00:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:04 INFO - 'PWD': '/builds/slave/test', 19:00:04 INFO - 'SHELL': '/bin/bash', 19:00:04 INFO - 'SHLVL': '1', 19:00:04 INFO - 'TERM': 'linux', 19:00:04 INFO - 'TMOUT': '86400', 19:00:04 INFO - 'USER': 'cltbld', 19:00:04 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', 19:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:04 INFO - '_': '/tools/buildbot/bin/python'} 19:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:00:04 INFO - Running setup.py (path:/tmp/pip-s6cA5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:00:04 INFO - Running setup.py (path:/tmp/pip-NuQyMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:00:04 INFO - Running setup.py (path:/tmp/pip-lOSVp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:00:04 INFO - Running setup.py (path:/tmp/pip-4VObbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:00:04 INFO - Running setup.py (path:/tmp/pip-A8xh2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:00:04 INFO - Running setup.py (path:/tmp/pip-FKhN7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:00:04 INFO - Running setup.py (path:/tmp/pip-wdjj_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:00:04 INFO - Running setup.py (path:/tmp/pip-j7_uwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:00:04 INFO - Running setup.py (path:/tmp/pip-5FN3Wp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:00:04 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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:00:04 INFO - Running setup.py (path:/tmp/pip-wuHMFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:00: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)) 19:00:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:00:04 INFO - Running setup.py (path:/tmp/pip-80jVsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:00:05 INFO - Running setup.py (path:/tmp/pip-X3atk5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:00:05 INFO - Running setup.py (path:/tmp/pip-p41AQQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:00:05 INFO - Running setup.py (path:/tmp/pip-i_tZa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:05 INFO - Running setup.py (path:/tmp/pip-JVLDP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:00:05 INFO - Running setup.py (path:/tmp/pip-7KMc3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:00:05 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)) 19:00:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:00:05 INFO - Running setup.py (path:/tmp/pip-OV5pqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:00:05 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)) 19:00:05 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)) 19:00:05 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)) 19:00:05 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)) 19:00:05 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)) 19:00:05 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)) 19:00:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:00:05 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 19:00:05 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 19:00:05 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 19:00:05 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 19:00:05 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 19:00:05 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 19:00:07 INFO - Downloading blessings-1.5.1.tar.gz 19:00:07 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 19:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:00:07 INFO - Installing collected packages: blessings 19:00:07 INFO - Running setup.py install for blessings 19:00:07 INFO - Successfully installed blessings 19:00:07 INFO - Cleaning up... 19:00:07 INFO - Return code: 0 19:00:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:07 INFO - Reading from file tmpfile_stdout 19:00:07 INFO - Current package versions: 19:00:07 INFO - argparse == 1.2.1 19:00:07 INFO - blessings == 1.5.1 19:00:07 INFO - blobuploader == 1.2.4 19:00:07 INFO - docopt == 0.6.1 19:00:07 INFO - manifestparser == 1.1 19:00:07 INFO - mozInstall == 1.12 19:00:07 INFO - mozcrash == 0.16 19:00:07 INFO - mozdebug == 0.1 19:00:07 INFO - mozdevice == 0.47 19:00:07 INFO - mozfile == 1.2 19:00:07 INFO - mozhttpd == 0.7 19:00:07 INFO - mozinfo == 0.9 19:00:07 INFO - mozleak == 0.1 19:00:07 INFO - mozlog == 3.1 19:00:07 INFO - moznetwork == 0.27 19:00:07 INFO - mozprocess == 0.22 19:00:07 INFO - mozprofile == 0.28 19:00:07 INFO - mozrunner == 6.11 19:00:07 INFO - mozscreenshot == 0.1 19:00:07 INFO - mozsystemmonitor == 0.0 19:00:07 INFO - moztest == 0.7 19:00:07 INFO - mozversion == 1.4 19:00:07 INFO - psutil == 3.1.1 19:00:07 INFO - requests == 1.2.3 19:00:07 INFO - wsgiref == 0.1.2 19:00:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7fe671bbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd3d0>, '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 0x1928ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', '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 19:00:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 19:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 19:00:07 INFO - Using env: {'DISPLAY': ':0', 19:00:07 INFO - 'HOME': '/home/cltbld', 19:00:07 INFO - 'LANG': 'en_US.UTF-8', 19:00:07 INFO - 'LANGUAGE': 'en_US:en', 19:00:07 INFO - 'LOGNAME': 'cltbld', 19:00:07 INFO - 'MAIL': '/var/mail/cltbld', 19:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:07 INFO - 'MOZ_NO_REMOTE': '1', 19:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:07 INFO - 'NO_EM_RESTART': '1', 19:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:07 INFO - 'PWD': '/builds/slave/test', 19:00:07 INFO - 'SHELL': '/bin/bash', 19:00:07 INFO - 'SHLVL': '1', 19:00:07 INFO - 'TERM': 'linux', 19:00:07 INFO - 'TMOUT': '86400', 19:00:07 INFO - 'USER': 'cltbld', 19:00:07 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', 19:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:07 INFO - '_': '/tools/buildbot/bin/python'} 19:00:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00: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)) 19:00: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)) 19:00: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)) 19:00: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)) 19:00: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)) 19:00: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)) 19:00: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)) 19:00: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)) 19:00: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)) 19:00: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)) 19:00: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)) 19:00:07 INFO - Cleaning up... 19:00:07 INFO - Return code: 0 19:00:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:00: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')]} 19:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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')]} 19:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00: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 0x7fe671bbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd3d0>, '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 0x1928ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', '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 19:00: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 19:00: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 19:00:07 INFO - Using env: {'DISPLAY': ':0', 19:00:07 INFO - 'HOME': '/home/cltbld', 19:00:07 INFO - 'LANG': 'en_US.UTF-8', 19:00:07 INFO - 'LANGUAGE': 'en_US:en', 19:00:07 INFO - 'LOGNAME': 'cltbld', 19:00:07 INFO - 'MAIL': '/var/mail/cltbld', 19:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:07 INFO - 'MOZ_NO_REMOTE': '1', 19:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:07 INFO - 'NO_EM_RESTART': '1', 19:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:07 INFO - 'PWD': '/builds/slave/test', 19:00:07 INFO - 'SHELL': '/bin/bash', 19:00:07 INFO - 'SHLVL': '1', 19:00:07 INFO - 'TERM': 'linux', 19:00:07 INFO - 'TMOUT': '86400', 19:00:07 INFO - 'USER': 'cltbld', 19:00:07 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', 19:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:07 INFO - '_': '/tools/buildbot/bin/python'} 19:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:08 INFO - Downloading/unpacking jsonschema 19:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:00: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 19:00:09 INFO - Downloading/unpacking functools32 (from jsonschema) 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00: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 19:00:09 INFO - Downloading functools32-3.2.3-2.tar.gz 19:00: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 19:00:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:00:10 INFO - warning: no files found matching '*.txt' 19:00:10 INFO - no previously-included directories found matching 'build' 19:00:10 INFO - no previously-included directories found matching 'dist' 19:00:10 INFO - no previously-included directories found matching '.git*' 19:00:10 INFO - Installing collected packages: jsonschema, functools32 19:00:10 INFO - Running setup.py install for functools32 19:00:10 INFO - warning: no files found matching '*.txt' 19:00:10 INFO - no previously-included directories found matching 'build' 19:00:10 INFO - no previously-included directories found matching 'dist' 19:00:10 INFO - no previously-included directories found matching '.git*' 19:00:10 INFO - Successfully installed jsonschema functools32 19:00:10 INFO - Cleaning up... 19:00:10 INFO - Return code: 0 19:00:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:00:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe671bbef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x185b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x192add0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19bd3d0>, '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 0x1928ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929360>, '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': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', '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 19:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 19:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 19:00:10 INFO - Using env: {'DISPLAY': ':0', 19:00:10 INFO - 'HOME': '/home/cltbld', 19:00:10 INFO - 'LANG': 'en_US.UTF-8', 19:00:10 INFO - 'LANGUAGE': 'en_US:en', 19:00:10 INFO - 'LOGNAME': 'cltbld', 19:00:10 INFO - 'MAIL': '/var/mail/cltbld', 19:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:10 INFO - 'MOZ_NO_REMOTE': '1', 19:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:10 INFO - 'NO_EM_RESTART': '1', 19:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:10 INFO - 'PWD': '/builds/slave/test', 19:00:10 INFO - 'SHELL': '/bin/bash', 19:00:10 INFO - 'SHLVL': '1', 19:00:10 INFO - 'TERM': 'linux', 19:00:10 INFO - 'TMOUT': '86400', 19:00:10 INFO - 'USER': 'cltbld', 19:00:10 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', 19:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:10 INFO - '_': '/tools/buildbot/bin/python'} 19:00:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:00:10 INFO - Downloading/unpacking flake8 19:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:00:12 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 19:00:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:00:12 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 19:00:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:12 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 19:00:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:00:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:00:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:00:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:00:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:00:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:00:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:00:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:00:12 INFO - no previously-included directories found matching 'docs/_build' 19:00:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:00:12 INFO - Running setup.py install for pep8 19:00:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:00:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:00:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:00:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:00:12 INFO - no previously-included directories found matching 'docs/_build' 19:00:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:00:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:00:12 INFO - Cleaning up... 19:00:13 INFO - Return code: 0 19:00:13 INFO - Running post-action listener: _resource_record_post_action 19:00:13 INFO - Running post-action listener: _start_resource_monitoring 19:00:13 INFO - Starting resource monitoring. 19:00:13 INFO - ##### 19:00:13 INFO - ##### Running install step. 19:00:13 INFO - ##### 19:00:13 INFO - Running pre-action listener: _resource_record_pre_action 19:00:13 INFO - Running main action method: install 19:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:00:13 INFO - Reading from file tmpfile_stdout 19:00:13 INFO - Detecting whether we're running mozinstall >=1.0... 19:00:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:00:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:00:13 INFO - Reading from file tmpfile_stdout 19:00:13 INFO - Output received: 19:00:13 INFO - Usage: mozinstall [options] installer 19:00:13 INFO - Options: 19:00:13 INFO - -h, --help show this help message and exit 19:00:13 INFO - -d DEST, --destination=DEST 19:00:13 INFO - Directory to install application into. [default: 19:00:13 INFO - "/builds/slave/test"] 19:00:13 INFO - --app=APP Application being installed. [default: firefox] 19:00:13 INFO - mkdir: /builds/slave/test/build/application 19:00:13 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'] 19:00:13 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 19:00:28 INFO - Reading from file tmpfile_stdout 19:00:28 INFO - Output received: 19:00:28 INFO - /builds/slave/test/build/application/firefox/firefox 19:00:28 INFO - Running post-action listener: _resource_record_post_action 19:00:28 INFO - ##### 19:00:28 INFO - ##### Running run-tests step. 19:00:28 INFO - ##### 19:00:28 INFO - Running pre-action listener: _resource_record_pre_action 19:00:28 INFO - Running main action method: run_tests 19:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:00:28 INFO - Python 2.7.3 19:00:28 INFO - Return code: 0 19:00:28 INFO - grabbing minidump binary from tooltool 19:00: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')]} 19:00: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 0x19bd3d0>, '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 0x1928ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1929360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:00: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 19:00: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 19:00:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:00:28 INFO - Return code: 0 19:00:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:00:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:00:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:00:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:00:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:00:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:00:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:00:29 INFO - Return code: 0 19:00: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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:00: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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:00:29 INFO - Using env: {'DISPLAY': ':0', 19:00:29 INFO - 'HOME': '/home/cltbld', 19:00:29 INFO - 'LANG': 'en_US.UTF-8', 19:00:29 INFO - 'LANGUAGE': 'en_US:en', 19:00:29 INFO - 'LOGNAME': 'cltbld', 19:00:29 INFO - 'MAIL': '/var/mail/cltbld', 19:00:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:00:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:00:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:00:29 INFO - 'MOZ_NO_REMOTE': '1', 19:00:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:00:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:00:29 INFO - 'NO_EM_RESTART': '1', 19:00:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:00:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:00:29 INFO - 'PWD': '/builds/slave/test', 19:00:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:00:29 INFO - 'SHELL': '/bin/bash', 19:00:29 INFO - 'SHLVL': '1', 19:00:29 INFO - 'TERM': 'linux', 19:00:29 INFO - 'TMOUT': '86400', 19:00:29 INFO - 'USER': 'cltbld', 19:00:29 INFO - 'XDG_SESSION_COOKIE': '0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561', 19:00:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:00:29 INFO - '_': '/tools/buildbot/bin/python'} 19:00: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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:00:30 INFO - mozversion application_buildid: 20151230174340 19:00:30 INFO - mozversion application_changeset: 4c891eee4b0d83ff52f0a9a10dc052a0944c17f9 19:00:30 INFO - mozversion application_display_name: Nightly 19:00:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:00:30 INFO - mozversion application_name: Firefox 19:00:30 INFO - mozversion application_remotingname: firefox 19:00:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 19:00:30 INFO - mozversion application_vendor: Mozilla 19:00:30 INFO - mozversion application_version: 46.0a1 19:00:30 INFO - mozversion platform_buildid: 20151230174340 19:00:30 INFO - mozversion platform_changeset: 4c891eee4b0d83ff52f0a9a10dc052a0944c17f9 19:00:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 19:00:30 INFO - mozversion platform_version: 46.0a1 19:00:30 INFO - using testdate: 1451530830 19:00:30 INFO - actual date: 1451530830 19:00:30 INFO - starting webserver on 'localhost:33911' 19:00:30 INFO - SUITE-START | Running 3 tests 19:00:30 INFO - TEST-START | dromaeo_css 19:00:30 INFO - operating with platform_type : linux_ 19:00:30 INFO - Initialising browser for dromaeo_css test... 19:00:30 INFO - TEST-INFO | started process 14352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHG3AUv/profile http://localhost:33911/getInfo.html) 19:00:34 INFO - PROCESS | 14352 | __metrics Screen width/height:1600/1200 19:00:34 INFO - PROCESS | 14352 | colorDepth:24 19:00:34 INFO - PROCESS | 14352 | Browser inner width/height: 1024/697 19:00:34 INFO - PROCESS | 14352 | __metrics 19:00:34 INFO - PROCESS | 14352 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:00:35 INFO - TEST-INFO | 14352: exit 0 19:00:35 INFO - Browser initialized. 19:00:35 INFO - Running cycle 1/1 for dromaeo_css test... 19:00:35 INFO - TEST-INFO | started process 14486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHG3AUv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:00:47 INFO - PROCESS | 14486 | RSS: Main: 150024192 19:00:47 INFO - PROCESS | 14486 | 19:01:37 INFO - PROCESS | 14486 | 1451530897366 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] 19:03:48 INFO - PROCESS | 14486 | Cycle 1(1): loaded http://localhost:33911/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33911/tests/dromaeo/cssquery-ext.html) 19:03:49 INFO - PROCESS | 14486 | RSS: Main: 154546176 19:03:49 INFO - PROCESS | 14486 | 19:06:51 INFO - PROCESS | 14486 | Cycle 1(1): loaded http://localhost:33911/tests/dromaeo/cssquery-ext.html (next: http://localhost:33911/tests/dromaeo/cssquery-jquery.html) 19:06:52 INFO - PROCESS | 14486 | RSS: Main: 151633920 19:06:52 INFO - PROCESS | 14486 | 19:09:54 INFO - PROCESS | 14486 | Cycle 1(1): loaded http://localhost:33911/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33911/tests/dromaeo/cssquery-mootools.html) 19:09:54 INFO - PROCESS | 14486 | RSS: Main: 152965120 19:09:54 INFO - PROCESS | 14486 | 19:12:56 INFO - PROCESS | 14486 | Cycle 1(1): loaded http://localhost:33911/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33911/tests/dromaeo/cssquery-prototype.html) 19:12:57 INFO - PROCESS | 14486 | RSS: Main: 151896064 19:12:57 INFO - PROCESS | 14486 | 19:15:59 INFO - PROCESS | 14486 | Cycle 1(1): loaded http://localhost:33911/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33911/tests/dromaeo/cssquery-yui.html) 19:16:00 INFO - PROCESS | 14486 | RSS: Main: 151592960 19:16:00 INFO - PROCESS | 14486 | 19:19:02 INFO - PROCESS | 14486 | Cycle 1(1): loaded http://localhost:33911/tests/dromaeo/cssquery-yui.html (next: http://localhost:33911/tests/dromaeo/cssquery-dojo.html) 19:19:03 INFO - PROCESS | 14486 | RSS: Main: 154734592 19:19:03 INFO - PROCESS | 14486 | 19:19:03 INFO - PROCESS | 14486 | __start_tp_report 19:19:03 INFO - PROCESS | 14486 | _x_x_mozilla_page_load 19:19:03 INFO - PROCESS | 14486 | _x_x_mozilla_page_load_details 19:19:03 INFO - PROCESS | 14486 | |i|pagename|runs| 19:19:03 INFO - PROCESS | 14486 | |0;dojo.html;2630.947381052379;2662.454196889638;2679.8928042878274;2684.7315268473153;2722.414680843619;4550.431196100488;4638.582527572517;4642.837500687477;4672.39258896343;4694.671373003886;4580.290055041465;4661.627069834413;4673.369095172151;4674.485806561275;4690.5543973322565;4110.794460276989;4355.825766969333;4364.367166760818;4398.8900277493;4457.64338852891;4210.3684447332835;4353.804078816461;4413.0732546165345;4422.7125236859665;4429.911401771963;4220.78896055196;4313;4313.331433627777;4331.956680433218;4346.022145017378;4323.848665296699;4329.631981281595;4332.631726303268;4341.761203133827;4386.407834942306;4242.787860606988;4312.353147027971;4313.245182093153;4317.11499142675;4356.194104090753;4525.298578720303;4561.498235194126;4609.516000819899;4623.537646235383;4653.511381304982;4981.402231732179;4999.975000125012;5009.12340340439;5021.874453138665;5036.471170527078;4888.193448081098;4968.677035992649;5007.148784706572;5056.519630635084;5111.488851114858;4652.999605084855;4691.8592442226445;4696.342512048316;4716.811327546929;4721.291806229059;5144.845654630367;5155.097857874857;5155.432902380735;5160.767765450564;5164.9741751291;4827.541383568555;4898.755062246873;4928.211486162197;4977.427595826526;5030.245463180479;4957.851264462072;4997.875053123628;5006.74966251686;5013.949860501349;5057.620678449131;4931.211006238985;4941.407031156285;4943.728094954812;4944.307796908436;4973.278874563168;4809.639277054235;4850.75746212688;4931.950680493221;4950.257461380822;4981.053599816023;4178.623923846869;4213.620774130343;4215.936760948588;4222.092250166229;4261.552536983634;3585.2112535242204;3678.9632103679155;3694.1872787987136;3695.334839728821;3707.0361705956648;4274.038341373166;4293.5706429356815;4357.477102747691;4365.607095361433;4407.955920440819;4959.429665588431;4999.600031997432;5008.5993120550265;5016.197408414636;5050.747462626854;4222.683298752606;4298.46269216348;4313.266744653416;4320.589543993378;4333.934990975138;4356.978215108904;4434.11317736454;4446.444194475691;4471.5081341052455;4492.73043617384;4731.455882573479;4767.046590681808;4767.6424268179335;4769.284607308931;4807.4471435785335;4889.119958407378;4997.125503037027;5015.3730783652045;5017.648764586444;5022.422421421583;4783.091212669582;4820.493848146035;4828.179209534458;4853.296272040464;4890.193118135468;5017.949820501748;5023.773930173078;5029.5221953914315;5032.320636714143;5063.594912407072;4909.975450122726;4919.262110683426;4993.201087825931;5082.390113186441;5145.202493613496;4841.830535931225;4858.805647774049;4862.635302352409;4868.41579010521;4907.460179380194;4854.878628034327;4855.1260773061185;4861.343718597944;4867.659263851497;4903.068417000758;4631.58315751584;4703.153432382204;4762.190427627381;4764.809407623795;4803.423589169322;4853.878653033702;4906.828261010847;4908.116539022867;4926.211806111149;4990.6506544541535;4758.547937945889;4771;4772.594329482033;4773.11697335994;4807.6394270429155 19:19:03 INFO - PROCESS | 14486 | |1;ext.html;508.1666067649056;517.2758138605951;521.1349160393745;530.3688610553438;539.9757010934508;31724.365512689732;32524.67475325246;32541.83729081357;32695.346093078126;32732.181695457624;35812.46281305783;36140.63859361406;36428.635713642856;36444.63555364445;36501.269974600495;7672.5780082095325;7830.099538553054;7834.138244793068;7838.176991415905;7839.725609603636;7592.50648707835;7652.813813858833;7657.770266891975;7823;7851.960740196291;7920.881186782203;7984.121746607869;8037.799055023642;8065.516069035847;8095.554744489051;7990.081140668839;8060.435769496079;8080.919190808076;8086.110527841933;8093.838123237531;7601.695932162706;7676.808079797994;7683.231676832328;7686.385089192851;7724.845503089907;35392.82303588491;35829;35856.462153067725;35902.46146307808;35904.10239744001;2279.41874821921;2508.668061470289;2557.590785474315;2774.6392968914115;2844.3884564818663;25707.61438578404;25799.613005804928;25959.480810383688;26124.477510449873;26250;3191.856366463515;3253.772235943461;3276.8689252429876;3321.8671253149846;3372.7976321420792;187732;188314;188510;188540;188667.05666471718;40451;41255.7937210312;41327.1734565307;41776.95557611023;47584;48041.75979120082;48087.51912480831;48301.5169848297;48432.27351589729;48479.75760121177;11704.590339338083;11708.356040417688;11712.238704484182;11726.648200553997;11774.116941229442;9405.05949405054;9441.527923603793;9458.763530911783;9484.762880928032;9541.045895410542;16939.830601694073;17192.22634981429;17799.73300400495;18003.369882054067;18087.547811304823;6847.554908930903;7049.224585295613;7125.96437017822;7152.213256541776;7152.249013853574;854.9230569248798;881.4745753416544;905.968291109808;908.0646933658211;996.2279233593878;25999.480010399686;26319.34201644974;26321.21036368912;26455.735442645713;26460.206193814218;824.9670013199525;852.7740148860557;863.1627321498137;933.2533972821716;968.2834702320232;12998.805017924738;13018.21890686543;13079;13079.346032698328;13979.231142287068;208559;209013;210037;211707;211840;42236.36645450321;42355.57644423578;42381.788091059345;42500.78749606232;42546;1021.269792098653;1027.2398425165472;1037.3931250218557;1038.901304376083;1185.4606154199819;24500.754992450562;25213.495730085662;27100.864495677397;27277.454450911267;27302;39291.60708392879;39301.41047884341;39447;39594.40608390934;39680.60319396769;336870;347692.92303076864;349200;349360;350461;24825.25524234276;25262.368440789127;28595.42809143764;28611.28471788222;28953.420931581673;30069.24826879258;30080.54879176858;37621.435678465394;38512.22975540529;39172;29574.260643484085;29724.405511890072;31610.36779264448;31611.683883161793;31631;32081;32403.18992025218;32421;32485.67514324921;32591.67408325981;31242.375152497276;31903.202419939687;31985.520217197227;31998.200044999063;32052.839735802103;27186.864065679543;28418;29429.705702943553;30514.847425762728;30679.233019173807;21428.250011249533;22100.447488812908;22955.081796727944;23048.539029218988;23097.19159829398 19:19:03 INFO - PROCESS | 14486 | |2;jquery.html;317.45397915585187;327.4842123655243;327.82789035756224;328.15991062879027;332.9550510681057;14906.403743850247;15287.923560382196;15341.23293835308;15759.763603545956;16304.673906521863;9050.32122590805;9233.122853328923;9993.850092248604;11126;11144.442777861095;4465.307877279019;4470.75410852403;4601;4601.585857272861;4615.076984603076;4461.643068554507;4525.049739554697;4529.909401811979;4530.093981203756;4530.411046563942;4510.842120525782;4518.502964673899;4647.117047760931;4826.831060912868;4828.855134345975;4732.621390288768;4739.028499157665;4741.359916411275;4751.073540659573;4770.0459908018365;4826.686265392738;5056.84829455117;5098.133317336024;5109.591232701375;5120.283160357553;10668.573257069707;10692.98416650417;10918.563257469692;10993.560257589686;11134.33194008354;1675.103819456585;1701.7532457793675;1758.749157782097;1846.5014446099613;1870.298638010746;8554.957225213897;8619.784505387353;8708.477491350539;11599.594014209546;12002;1607.0598699760653;1608.5576466471814;1753.9035353055576;1806.8644851636047;1817.264008076731;49019;49492.75253623745;49872.251916221285;50297.748511257574;50603.74698126523;9696.369735967139;9801.215902727907;9821.36161149523;9864.780424404451;9883.604655813688;12150.5139794409;12226.75546489083;12250.44872980718;12252.938735306445;12269.877301226874;6961.791146265519;7013.719451221996;7038.120234970629;7104.609246491389;7135.072440582795;6814.795556133324;6887.276835932255;6901.689423975933;6909.309069093151;6962.094927659473;4071.0840060986043;4161.875143745692;4163.770992595376;4182.853600123981;4205.5794420557695;1583.358739710396;1610.2914717524252;1647.4975132584436;1667.7081510735572;1675.6229848284283;713.7073799742185;751.7894989402976;754.3851760814919;789.719649524422;836.0844874862016;11851.940740296242;13679;14538.636534086732;14611.634709132144;15005.69988600222;848.5969164646867;865.9177378149066;891.2379915172564;916.2303664921498;928.9767755806159;8119.594020298961;8756.4308319959;8807.911920880837;8817.735467935972;8849.734507964771;409399;441857;484449;491172;491709;69371.3062869375;71163;71414;72236.11055557824;72747.27252727405;924.8427767279578;966.0580933589835;1050.648032908984;1061.5753698520653;1062.7290041039485;13524.391402387113;14172.291385430894;14293.57119286423;14416.567502974927;14471.204083775494;28732.712672873004;28824.423511530073;30228.546571801002;30353;32733.67266327306;34676.65323346734;35996.64003359933;36943;37471.81264093662;38269.234615308094;8041.67833286662;8183.754487365389;8282.751517454486;8557.743267701979;8590.613422396133;12229.449674764479;15211.92394038067;15308.77036844426;15412.845871541589;15706.293216805043;10448.268621196443;11041.33751974884;12442;12675.873241267469;13385.866141338462;4933.728644924564;5412.105762983082;11246.718832029264;12077.57728479499;12086.939565302117;13136.671583210114;13176.341182941007;13421.463141474233;13483.797743033667;14012.579622611338;7961.124276329483;8628.050914399537;8631.91368086311;8676.566171691517;8978.506182160045;13597.912167026416;13706.24615646149;13792.655183620489;13811.79282310746;14211.218382988622 19:19:03 INFO - PROCESS | 14486 | |3;mootools.html;1364.4610378900334;1380.5375199308228;1468.36126285066;1656.7846179996598;1661.509854592895;5775.162601422791;5852.912206316909;6365.745370185193;6473.352664733524;6493.026046093089;6384.936150638492;6489.675516224193;6514.967425162868;6530.934690653092;6559.081728558006;1996.6306233346804;2036.8065033821763;2045.253482478892;2054.0551346380685;2056.753189617248;2040.4184807329914;2056.20835978148;2060.423081537172;2094;2095.486605781578;1984.563396052866;2007.7490313710787;2020.7272018277565;2027.0878104852802;2038.7859274776158;2030.715699802029;2060.103854823142;2065.2874758208395;2067.9379618611465;2069.3481553310735;2036.3890832750117;2057.3827851644596;2096.0253482130884;2097.769245383007;2106.6208082545136;6704;6727.428168605626;6801.557898736566;6812.523123381366;6816.591004539694;3791.317562838688;3830.7893065881367;3831.885043448701;3851.287511810324;3851.9614803852164;2528.734482879308;2550.553653110717;2567.14000809729;2597.792176625884;2602.518534071184;818.55388813097;823.7322870067252;824.1305422778966;830.754927296449;840.8696652018947;8759.16787905148;8767.123287671246;8792.34057445694;8817.118288171196;8830.337724670675;3685.3182161300247;3686.576043754949;3735.869244576427;3738.4579236010627;3741.8690345837763;7680.231976802275;7696.384289256846;7704.383649308042;7722.53664780115;7779.105402878628;3902.6097390261316;3919.2161567686576;3930.8231129599235;3932.8623498177426;3949.30887094763;2968.391479746647;3035.05913166919;3522.8590856365972;3524.3832329342263;3544.9822750886597;3268.50972354144;3278.393497203025;3280.245543524955;3299.0432774495607;3312.9006129816144;962.1340793286098;967.1199208720031;969.3650658818485;975.3708857786688;976.2921881635899;894.7941973346167;902.8871391076116;961.2790407194605;993.1707024634367;1164.7030007348071;6168.691565421711;6228.377162283736;6228.750849965951;6232.439080482778;6301.936980630227;921.3504479342048;960.8270511307892;966.3235734985398;970.2141265574766;1011.2466212671607;4826.758662066883;4926.9014619707405;4939.728314942713;4941.061198372297;4950.2822090796635;7589.58257295854;7737.110232323243;7775.533467991939;7849.568273744999;7948.562829044458;7778.8833167502535;7803.882941755878;7818.179091195457;7861.52830830152;7878.054633444023;6206.286277078194;6264.718087685974;6292.968535157295;6325;6327.968360158262;5881.500072493886;6018.4884284834525;6041.365656605993;6042.879142417215;6045.153678485103;6885.299884746003;6955.374016338554;6976.19773726028;7085.14978202619;7147.3210045045635;6996.055532503047;7198.604076775828;7232.385247254042;7252.2747725227055;7290.380317673057;5677.630953987978;5822.970885145547;5858.794942177004;5884.823455296348;5892.175095486721;6319.399657032574;6329.778457753957;6379.936200637934;6394.4564712;6404.679766011774;5738.483536481736;5783.537317014713;5862.091375836752;5891.9116213255975;5902.2327097477055;5802.477776999922;5897.203877476657;5944.138099975566;5959.940400595939;5976.223090998143;5789.594728368974;5860.09168578871;5908.291005079418;6019.337872833898;6023.969880150571;5484.643498172765;5498.752556134904;5501.449855014466;5503.697296648723;5528.55771538284;5601.243832082617;5604.551635869202;5622.803201887914;5625;5647.915281270702 19:19:03 INFO - PROCESS | 14486 | |4;prototype.html;286.2700114707496;288.98710021375075;294.8024823368343;295.1720424210091;304.5568697545072;5580.497755202036;5611.7474713637885;5646.604737668365;5724.370319264888;5751.792123654027;5616.354119276284;5623.297087864017;5632.26780518532;5644.915326270109;5648.858778530539;4321.200577893084;4324.04870928396;4327.891802704926;4331.523532411448;4332.870013899572;4150.8962275943195;4267.957320426787;4274.97862510687;4290.849820256291;4295.506016808075;4210.410542524049;4218.177455396199;4238.894027649302;4239.59723826236;4243.066525364415;4233.047564298039;4236.618704316611;4239.660827133822;4240.385144154111;4250.128723611652;3639.4358874374516;3655.1044993976648;3672.210474747942;3674.595794462607;3675.5956844747325;5254.343207099113;5268.209768534713;5413.431589683066;5429.348478182604;5457.045017122027;4862;4863.319135321058;4874.341963834872;4878.414590249193;4881.804727810883;5919.526437884959;5933.22868027158;5934.1692163097205;5954.583179177459;5955.642661440327;3960.881173564798;3966.861159859391;3969.503812023497;3973.1259122992897;3980.0845805464905;6036.9396306036815;6213.099100630428;6220.253569571635;6266.467350275232;6268.341824108448;4085.428040074392;4089.7546147230664;4090.611391917763;4094.897627559335;4095.1195492969155;4166.958260434892;4168.3955826405;4169.811603692933;4173.52004519478;4174.4364510791265;4808.6153107752;4820.566149046603;4830.879228019257;4836.516348365135;4837.782299796518;5766.913496297559;5868.354481007086;5895.233619629506;5910.1725758392995;5919.6152250103605;1445.2990299704634;1472.0652385735136;1472.8748056415325;1473.1234915225423;1474.1302631447497;959.0170075672352;966.2994329111478;974.3715303629119;978.9755256118511;992.2161492421051;5154.613403994716;5157.819476318311;5159.74201289934;5162.019216348882;5167.250748641426;6153.753849845956;6165.815025549151;6174.043023331391;6182.196314479179;6183.319834818167;5147.3051138096625;5148.330717006766;5154.587632989352;5163.974180129076;5167.741612919414;3275.623303320101;3325.187772663904;3349.949750753741;3350.4974253862115;3356.3622911646708;5829.7085145743395;5837.124431335249;5841.357450680422;5843.707814609253;5844.064949608042;6098.451139397475;6246.500279977591;6257.468115210167;6408.423241908251;6450.000249961264;5843.1235314703135;5872.913511000478;5892.263467066531;5895.263092113486;5903.1145328200255;6205.937940620716;6226.937730622636;6233.376662333731;6245.656488893154;6249.906251406142;5941.613795103304;6060.727267272895;6067.635941843503;6069.362716914837;6076.635401875901;5875.471207591338;5875.94124058771;5876.706164691663;5885.793997210077;5890.293164820249;4028.133951200506;4038.818253178673;4039.2527382434346;4073.4297198391655;4077.041895154577;6057;6224;6230.844228894314;6235.688215589294;6236.376362363727;5980.43185897339;5982.4316689914385;5987.221661184019;5992.520598352208;5999;5963.731632076654;5969.9701501493955;5983.102534619842;5983.311919129356;5989.341172471112;5761.625494342854;5852;5860.062390017577;5860.677662728591;5867.090600956859;6020.4280593343565;6025.246844144482;6042.697865106815;6043.8186854394435;6044.335123136363;5796.449337312949;5809.9419005809405;5816.47651711348;5818.650880947157;5820.039693450533 19:19:03 INFO - PROCESS | 14486 | |5;yui.html;744.914334851492;745.3626303638245;762.950408223465;766.1572270502448;767.919368466311;9536.76158096048;9735.123838854503;9757.658481953133;9763.951180244107;9769.316147869651;10269.589216431352;10422.739431514197;10429.582816687342;10440;10477.476126193678;593.6823799267393;600.4415893219305;779.9727009554666;785.305005070511;795.6618437164182;779.3297763923022;782.6047845837844;785.9528428294292;791.3076058448858;791.5685951156605;832.076395201326;840.4957025784541;840.6805413942724;841.7516832534386;843.1694780641063;828.883956246126;829.1335554345693;832.8334333133367;833.5040650812757;833.9583020848994;615.8645098078416;619.8140557832633;622.4242575617536;622.8909940760394;623.9532035097386;10810.081143102845;10879.12966962649;10952.780944381067;10954.068904143158;10965.890341096567;10461.9476902615;10773.946130269376;10825.512851921683;10842.512086956105;10892.564297428093;8960.775980600472;9039.096090390974;9085.4094483859;9126.498042607654;9208.3093767967;3106.642736085334;3166.224275052604;3179.888703895376;3238.5951756030495;3244.67553244676;38499;38936.22127557433;38995.22009559821;39060.80469597634;39197.80401098005;8768.561571921378;8956.507392093497;8968.641254349883;9079.909200908038;9147.908520914705;14638;14836.70326593462;14838;14855.514448555057;14913.254337283093;5921.171036054956;6093.69531523422;6248.625082495065;6258.687065646699;6288.6855657217875;3414;3425.53755243044;3593.838277277529;3603.837827297778;3609.8917032489067;2379.58357287474;2426.939326516851;2428.5992811185956;2435.9147429840227;2517.9496410071697;486.69338316860154;493.06564061104007;498.9850304490871;502.65568085861304;503.7380562107683;398.82651046794734;416.6063070398505;428.28048877885453;434.87823409444775;462.6228531718442;7330.743423980135;7499.925000749922;7554.697812087565;7556.65995030225;7635.961820190863;472.5038709355163;509.1853035143814;545.359202936548;553.5460922043885;560.1569637695243;3294.5552350432863;3416.5046068320453;3713.814309284525;3782.394816829294;3789.905252368713;43967.340489892675;44063;44221.778891105336;44244.778776106556;44409.777951110686;42785.786071069444;42899.571004290185;43244.135117297476;43928.34107488326;44251.33622995593;39187.6081239184;40377.596224037974;40630.79684601558;40861.18277634431;41072.38391424131;7403.481756277009;7988;8250.339972802281;8260.586970651564;8267;32231.194220144684;32377.838110809294;32628;33479.49780753339;33523;38251.426228607146;41369;41679.37480937849;41768.79115604524;42094.78952605218;9182.311326650395;9225.86161207569;9287.767805804639;9336.859947100935;9501.57242924084;10935.133865429807;10947.726306842074;10971.670849874517;11026.173037022096;11045.502952367324;10240.948795255976;10284.228682848965;10321.948390258001;10326.225533084898;10351.223658225512;10294.073533382032;10319.174466042548;10347.482625868826;10362.533685983997;10384.117350025332;9829.31194816356;9877.753056173653;9891.455969921722;9919.206463483048;9934.950325248328;9075.909240907771;9256;9342.766430839283;9458.33791634579;9519.904800951901;8511.702090426805;9005.234555062892;9012.909870901207;9153.816923661623;9166.816663666823 19:19:03 INFO - PROCESS | 14486 | __end_tp_report 19:19:03 INFO - PROCESS | 14486 | __start_cc_report 19:19:03 INFO - PROCESS | 14486 | _x_x_mozilla_cycle_collect,327 19:19:03 INFO - PROCESS | 14486 | __end_cc_report 19:19:03 INFO - PROCESS | 14486 | __startTimestamp1451531943089__endTimestamp 19:19:03 INFO - PROCESS | 14486 | 19:19:03 INFO - PROCESS | 14486 | ------- Summary: start ------- 19:19:03 INFO - PROCESS | 14486 | Number of tests: 6 19:19:03 INFO - PROCESS | 14486 | 19:19:03 INFO - PROCESS | 14486 | [#0] dojo.html Cycles:165 Average:4626.03 Median:4767.64 stddev:478.33 (10.0%) stddev-sans-first:453.47 19:19:03 INFO - PROCESS | 14486 | Values: 2630.9 2662.5 2679.9 2684.7 2722.4 4550.4 4638.6 4642.8 4672.4 4694.7 4580.3 4661.6 4673.4 4674.5 4690.6 4110.8 4355.8 4364.4 4398.9 4457.6 4210.4 4353.8 4413.1 4422.7 4429.9 4220.8 4313.0 4313.3 4332.0 4346.0 4323.8 4329.6 4332.6 4341.8 4386.4 4242.8 4312.4 4313.2 4317.1 4356.2 4525.3 4561.5 4609.5 4623.5 4653.5 4981.4 5000.0 5009.1 5021.9 5036.5 4888.2 4968.7 5007.1 5056.5 5111.5 4653.0 4691.9 4696.3 4716.8 4721.3 5144.8 5155.1 5155.4 5160.8 5165.0 4827.5 4898.8 4928.2 4977.4 5030.2 4957.9 4997.9 5006.7 5013.9 5057.6 4931.2 4941.4 4943.7 4944.3 4973.3 4809.6 4850.8 4932.0 4950.3 4981.1 4178.6 4213.6 4215.9 4222.1 4261.6 3585.2 3679.0 3694.2 3695.3 3707.0 4274.0 4293.6 4357.5 4365.6 4408.0 4959.4 4999.6 5008.6 5016.2 5050.7 4222.7 4298.5 4313.3 4320.6 4333.9 4357.0 4434.1 4446.4 4471.5 4492.7 4731.5 4767.0 4767.6 4769.3 4807.4 4889.1 4997.1 5015.4 5017.6 5022.4 4783.1 4820.5 4828.2 4853.3 4890.2 5017.9 5023.8 5029.5 5032.3 5063.6 4910.0 4919.3 4993.2 5082.4 5145.2 4841.8 4858.8 4862.6 4868.4 4907.5 4854.9 4855.1 4861.3 4867.7 4903.1 4631.6 4703.2 4762.2 4764.8 4803.4 4853.9 4906.8 4908.1 4926.2 4990.7 4758.5 4771.0 4772.6 4773.1 4807.6 19:19:03 INFO - PROCESS | 14486 | 19:19:03 INFO - PROCESS | 14486 | [#1] ext.html Cycles:180 Average:39382.32 Median:170095.93 stddev:67837.12 (39.9%) stddev-sans-first:67964.62 19:19:03 INFO - PROCESS | 14486 | Values: 508.2 517.3 521.1 530.4 540.0 31724.4 32524.7 32541.8 32695.3 32732.2 35812.5 36140.6 36428.6 36444.6 36501.3 7672.6 7830.1 7834.1 7838.2 7839.7 7592.5 7652.8 7657.8 7823.0 7852.0 7920.9 7984.1 8037.8 8065.5 8095.6 7990.1 8060.4 8080.9 8086.1 8093.8 7601.7 7676.8 7683.2 7686.4 7724.8 35392.8 35829.0 35856.5 35902.5 35904.1 2279.4 2508.7 2557.6 2774.6 2844.4 25707.6 25799.6 25959.5 26124.5 26250.0 3191.9 3253.8 3276.9 3321.9 3372.8 187732.0 188314.0 188510.0 188540.0 188667.1 40451.0 41255.8 41327.2 41777.0 47584.0 48041.8 48087.5 48301.5 48432.3 48479.8 11704.6 11708.4 11712.2 11726.6 11774.1 9405.1 9441.5 9458.8 9484.8 9541.0 16939.8 17192.2 17799.7 18003.4 18087.5 6847.6 7049.2 7126.0 7152.2 7152.2 854.9 881.5 906.0 908.1 996.2 25999.5 26319.3 26321.2 26455.7 26460.2 825.0 852.8 863.2 933.3 968.3 12998.8 13018.2 13079.0 13079.3 13979.2 208559.0 209013.0 210037.0 211707.0 211840.0 42236.4 42355.6 42381.8 42500.8 42546.0 1021.3 1027.2 1037.4 1038.9 1185.5 24500.8 25213.5 27100.9 27277.5 27302.0 39291.6 39301.4 39447.0 39594.4 39680.6 336870.0 347692.9 349200.0 349360.0 350461.0 24825.3 25262.4 28595.4 28611.3 28953.4 30069.2 30080.5 37621.4 38512.2 39172.0 29574.3 29724.4 31610.4 31611.7 31631.0 32081.0 32403.2 32421.0 32485.7 32591.7 31242.4 31903.2 31985.5 31998.2 32052.8 27186.9 28418.0 29429.7 30514.8 30679.2 21428.3 22100.4 22955.1 23048.5 23097.2 19:19:03 INFO - PROCESS | 14486 | 19:19:03 INFO - PROCESS | 14486 | [#2] jquery.html Cycles:180 Average:24635.89 Median:223031.29 stddev:75966.34 (34.1%) stddev-sans-first:76157.50 19:19:03 INFO - PROCESS | 14486 | Values: 317.5 327.5 327.8 328.2 333.0 14906.4 15287.9 15341.2 15759.8 16304.7 9050.3 9233.1 9993.9 11126.0 11144.4 4465.3 4470.8 4601.0 4601.6 4615.1 4461.6 4525.0 4529.9 4530.1 4530.4 4510.8 4518.5 4647.1 4826.8 4828.9 4732.6 4739.0 4741.4 4751.1 4770.0 4826.7 5056.8 5098.1 5109.6 5120.3 10668.6 10693.0 10918.6 10993.6 11134.3 1675.1 1701.8 1758.7 1846.5 1870.3 8555.0 8619.8 8708.5 11599.6 12002.0 1607.1 1608.6 1753.9 1806.9 1817.3 49019.0 49492.8 49872.3 50297.7 50603.7 9696.4 9801.2 9821.4 9864.8 9883.6 12150.5 12226.8 12250.4 12252.9 12269.9 6961.8 7013.7 7038.1 7104.6 7135.1 6814.8 6887.3 6901.7 6909.3 6962.1 4071.1 4161.9 4163.8 4182.9 4205.6 1583.4 1610.3 1647.5 1667.7 1675.6 713.7 751.8 754.4 789.7 836.1 11851.9 13679.0 14538.6 14611.6 15005.7 848.6 865.9 891.2 916.2 929.0 8119.6 8756.4 8807.9 8817.7 8849.7 409399.0 441857.0 484449.0 491172.0 491709.0 69371.3 71163.0 71414.0 72236.1 72747.3 924.8 966.1 1050.6 1061.6 1062.7 13524.4 14172.3 14293.6 14416.6 14471.2 28732.7 28824.4 30228.5 30353.0 32733.7 34676.7 35996.6 36943.0 37471.8 38269.2 8041.7 8183.8 8282.8 8557.7 8590.6 12229.4 15211.9 15308.8 15412.8 15706.3 10448.3 11041.3 12442.0 12675.9 13385.9 4933.7 5412.1 11246.7 12077.6 12086.9 13136.7 13176.3 13421.5 13483.8 14012.6 7961.1 8628.1 8631.9 8676.6 8978.5 13597.9 13706.2 13792.7 13811.8 14211.2 19:19:03 INFO - PROCESS | 14486 | 19:19:03 INFO - PROCESS | 14486 | [#3] mootools.html Cycles:180 Average:4621.53 Median:5892.04 stddev:2337.23 (39.7%) stddev-sans-first:2330.96 19:19:03 INFO - PROCESS | 14486 | Values: 1364.5 1380.5 1468.4 1656.8 1661.5 5775.2 5852.9 6365.7 6473.4 6493.0 6384.9 6489.7 6515.0 6530.9 6559.1 1996.6 2036.8 2045.3 2054.1 2056.8 2040.4 2056.2 2060.4 2094.0 2095.5 1984.6 2007.7 2020.7 2027.1 2038.8 2030.7 2060.1 2065.3 2067.9 2069.3 2036.4 2057.4 2096.0 2097.8 2106.6 6704.0 6727.4 6801.6 6812.5 6816.6 3791.3 3830.8 3831.9 3851.3 3852.0 2528.7 2550.6 2567.1 2597.8 2602.5 818.6 823.7 824.1 830.8 840.9 8759.2 8767.1 8792.3 8817.1 8830.3 3685.3 3686.6 3735.9 3738.5 3741.9 7680.2 7696.4 7704.4 7722.5 7779.1 3902.6 3919.2 3930.8 3932.9 3949.3 2968.4 3035.1 3522.9 3524.4 3545.0 3268.5 3278.4 3280.2 3299.0 3312.9 962.1 967.1 969.4 975.4 976.3 894.8 902.9 961.3 993.2 1164.7 6168.7 6228.4 6228.8 6232.4 6301.9 921.4 960.8 966.3 970.2 1011.2 4826.8 4926.9 4939.7 4941.1 4950.3 7589.6 7737.1 7775.5 7849.6 7948.6 7778.9 7803.9 7818.2 7861.5 7878.1 6206.3 6264.7 6293.0 6325.0 6328.0 5881.5 6018.5 6041.4 6042.9 6045.2 6885.3 6955.4 6976.2 7085.1 7147.3 6996.1 7198.6 7232.4 7252.3 7290.4 5677.6 5823.0 5858.8 5884.8 5892.2 6319.4 6329.8 6379.9 6394.5 6404.7 5738.5 5783.5 5862.1 5891.9 5902.2 5802.5 5897.2 5944.1 5959.9 5976.2 5789.6 5860.1 5908.3 6019.3 6024.0 5484.6 5498.8 5501.4 5503.7 5528.6 5601.2 5604.6 5622.8 5625.0 5647.9 19:19:03 INFO - PROCESS | 14486 | 19:19:03 INFO - PROCESS | 14486 | [#4] prototype.html Cycles:180 Average:4887.44 Median:5645.76 stddev:1480.94 (26.2%) stddev-sans-first:1444.27 19:19:03 INFO - PROCESS | 14486 | Values: 286.3 289.0 294.8 295.2 304.6 5580.5 5611.7 5646.6 5724.4 5751.8 5616.4 5623.3 5632.3 5644.9 5648.9 4321.2 4324.0 4327.9 4331.5 4332.9 4150.9 4268.0 4275.0 4290.8 4295.5 4210.4 4218.2 4238.9 4239.6 4243.1 4233.0 4236.6 4239.7 4240.4 4250.1 3639.4 3655.1 3672.2 3674.6 3675.6 5254.3 5268.2 5413.4 5429.3 5457.0 4862.0 4863.3 4874.3 4878.4 4881.8 5919.5 5933.2 5934.2 5954.6 5955.6 3960.9 3966.9 3969.5 3973.1 3980.1 6036.9 6213.1 6220.3 6266.5 6268.3 4085.4 4089.8 4090.6 4094.9 4095.1 4167.0 4168.4 4169.8 4173.5 4174.4 4808.6 4820.6 4830.9 4836.5 4837.8 5766.9 5868.4 5895.2 5910.2 5919.6 1445.3 1472.1 1472.9 1473.1 1474.1 959.0 966.3 974.4 979.0 992.2 5154.6 5157.8 5159.7 5162.0 5167.3 6153.8 6165.8 6174.0 6182.2 6183.3 5147.3 5148.3 5154.6 5164.0 5167.7 3275.6 3325.2 3349.9 3350.5 3356.4 5829.7 5837.1 5841.4 5843.7 5844.1 6098.5 6246.5 6257.5 6408.4 6450.0 5843.1 5872.9 5892.3 5895.3 5903.1 6205.9 6226.9 6233.4 6245.7 6249.9 5941.6 6060.7 6067.6 6069.4 6076.6 5875.5 5875.9 5876.7 5885.8 5890.3 4028.1 4038.8 4039.3 4073.4 4077.0 6057.0 6224.0 6230.8 6235.7 6236.4 5980.4 5982.4 5987.2 5992.5 5999.0 5963.7 5970.0 5983.1 5983.3 5989.3 5761.6 5852.0 5860.1 5860.7 5867.1 6020.4 6025.2 6042.7 6043.8 6044.3 5796.4 5809.9 5816.5 5818.7 5820.0 19:19:03 INFO - PROCESS | 14486 | 19:19:03 INFO - PROCESS | 14486 | [#5] yui.html Cycles:180 Average:11808.88 Median:479.60 stddev:13417.01 (2797.6%) stddev-sans-first:13428.92 19:19:03 INFO - PROCESS | 14486 | Values: 744.9 745.4 763.0 766.2 767.9 9536.8 9735.1 9757.7 9764.0 9769.3 10269.6 10422.7 10429.6 10440.0 10477.5 593.7 600.4 780.0 785.3 795.7 779.3 782.6 786.0 791.3 791.6 832.1 840.5 840.7 841.8 843.2 828.9 829.1 832.8 833.5 834.0 615.9 619.8 622.4 622.9 624.0 10810.1 10879.1 10952.8 10954.1 10965.9 10461.9 10773.9 10825.5 10842.5 10892.6 8960.8 9039.1 9085.4 9126.5 9208.3 3106.6 3166.2 3179.9 3238.6 3244.7 38499.0 38936.2 38995.2 39060.8 39197.8 8768.6 8956.5 8968.6 9079.9 9147.9 14638.0 14836.7 14838.0 14855.5 14913.3 5921.2 6093.7 6248.6 6258.7 6288.7 3414.0 3425.5 3593.8 3603.8 3609.9 2379.6 2426.9 2428.6 2435.9 2517.9 486.7 493.1 499.0 502.7 503.7 398.8 416.6 428.3 434.9 462.6 7330.7 7499.9 7554.7 7556.7 7636.0 472.5 509.2 545.4 553.5 560.2 3294.6 3416.5 3713.8 3782.4 3789.9 43967.3 44063.0 44221.8 44244.8 44409.8 42785.8 42899.6 43244.1 43928.3 44251.3 39187.6 40377.6 40630.8 40861.2 41072.4 7403.5 7988.0 8250.3 8260.6 8267.0 32231.2 32377.8 32628.0 33479.5 33523.0 38251.4 41369.0 41679.4 41768.8 42094.8 9182.3 9225.9 9287.8 9336.9 9501.6 10935.1 10947.7 10971.7 11026.2 11045.5 10240.9 10284.2 10321.9 10326.2 10351.2 10294.1 10319.2 10347.5 10362.5 10384.1 9829.3 9877.8 9891.5 9919.2 9935.0 9075.9 9256.0 9342.8 9458.3 9519.9 8511.7 9005.2 9012.9 9153.8 9166.8 19:19:03 INFO - PROCESS | 14486 | -------- Summary: end -------- 19:19:03 INFO - PROCESS | 14486 | 19:19:03 INFO - TEST-INFO | 14486: exit 0 19:19:03 INFO - TEST-OK | dromaeo_css | took 1113827ms 19:19:03 INFO - TEST-START | kraken 19:19:03 INFO - operating with platform_type : linux_ 19:19:03 INFO - Initialising browser for kraken test... 19:19:03 INFO - TEST-INFO | started process 14725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps8zu1z/profile http://localhost:33911/getInfo.html) 19:19:08 INFO - PROCESS | 14725 | __metrics Screen width/height:1600/1200 19:19:08 INFO - PROCESS | 14725 | colorDepth:24 19:19:08 INFO - PROCESS | 14725 | Browser inner width/height: 1024/697 19:19:08 INFO - PROCESS | 14725 | __metrics 19:19:08 INFO - PROCESS | 14725 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:19:09 INFO - TEST-INFO | 14725: exit 0 19:19:09 INFO - Browser initialized. 19:19:09 INFO - Running cycle 1/1 for kraken test... 19:19:09 INFO - TEST-INFO | started process 14845 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmps8zu1z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:19:21 INFO - PROCESS | 14845 | RSS: Main: 149745664 19:19:21 INFO - PROCESS | 14845 | 19:19:24 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33911/tests/kraken/driver.html?testName=audio-beat-detection) 19:19:24 INFO - PROCESS | 14845 | RSS: Main: 150900736 19:19:24 INFO - PROCESS | 14845 | 19:19:27 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33911/tests/kraken/driver.html?testName=audio-dft) 19:19:28 INFO - PROCESS | 14845 | RSS: Main: 151146496 19:19:28 INFO - PROCESS | 14845 | 19:19:30 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33911/tests/kraken/driver.html?testName=audio-fft) 19:19:31 INFO - PROCESS | 14845 | RSS: Main: 146468864 19:19:31 INFO - PROCESS | 14845 | 19:19:33 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33911/tests/kraken/driver.html?testName=audio-oscillator) 19:19:34 INFO - PROCESS | 14845 | RSS: Main: 145793024 19:19:34 INFO - PROCESS | 14845 | 19:19:36 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33911/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:19:37 INFO - PROCESS | 14845 | RSS: Main: 146636800 19:19:37 INFO - PROCESS | 14845 | 19:19:40 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33911/tests/kraken/driver.html?testName=imaging-darkroom) 19:19:40 INFO - PROCESS | 14845 | RSS: Main: 146886656 19:19:40 INFO - PROCESS | 14845 | 19:19:44 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33911/tests/kraken/driver.html?testName=imaging-desaturate) 19:19:44 INFO - PROCESS | 14845 | RSS: Main: 145829888 19:19:44 INFO - PROCESS | 14845 | 19:19:47 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33911/tests/kraken/driver.html?testName=json-parse-financial) 19:19:48 INFO - PROCESS | 14845 | RSS: Main: 146649088 19:19:48 INFO - PROCESS | 14845 | 19:19:50 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33911/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:19:50 INFO - PROCESS | 14845 | RSS: Main: 147922944 19:19:50 INFO - PROCESS | 14845 | 19:19:52 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33911/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:19:53 INFO - PROCESS | 14845 | RSS: Main: 148295680 19:19:53 INFO - PROCESS | 14845 | 19:19:55 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33911/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:19:56 INFO - PROCESS | 14845 | RSS: Main: 147828736 19:19:56 INFO - PROCESS | 14845 | 19:19:58 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:19:59 INFO - PROCESS | 14845 | RSS: Main: 148328448 19:19:59 INFO - PROCESS | 14845 | 19:20:01 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:20:02 INFO - PROCESS | 14845 | RSS: Main: 147439616 19:20:02 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | Cycle 1(1): loaded http://localhost:33911/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33911/tests/kraken/driver.html?testName=ai-astar) 19:20:04 INFO - PROCESS | 14845 | RSS: Main: 148152320 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | __start_tp_report 19:20:04 INFO - PROCESS | 14845 | _x_x_mozilla_page_load 19:20:04 INFO - PROCESS | 14845 | _x_x_mozilla_page_load_details 19:20:04 INFO - PROCESS | 14845 | |i|pagename|runs| 19:20:04 INFO - PROCESS | 14845 | |0;ai-astar;113;110;113;113;114;125;113;116;112;116 19:20:04 INFO - PROCESS | 14845 | |1;audio-beat-detection;162;134;153;176;137;155;161;134;165;134 19:20:04 INFO - PROCESS | 14845 | |2;audio-dft;162;160;164;163;163;164;173;161;164;162 19:20:04 INFO - PROCESS | 14845 | |3;audio-fft;71;73;72;73;126;72;72;83;72;94 19:20:04 INFO - PROCESS | 14845 | |4;audio-oscillator;98;99;140;98;99;98;139;97;97;133 19:20:04 INFO - PROCESS | 14845 | |5;imaging-gaussian-blur;109;110;110;109;109;109;110;110;110;110 19:20:04 INFO - PROCESS | 14845 | |6;imaging-darkroom;148;149;147;148;147;149;148;148;147;150 19:20:04 INFO - PROCESS | 14845 | |7;imaging-desaturate;96;95;97;97;96;96;96;100;96;97 19:20:04 INFO - PROCESS | 14845 | |8;json-parse-financial;74;74;74;74;75;74;73;73;71;71 19:20:04 INFO - PROCESS | 14845 | |9;json-stringify-tinderbox;67;69;68;68;72;69;69;69;67;68 19:20:04 INFO - PROCESS | 14845 | |10;stanford-crypto-aes;85;95;87;86;93;85;87;86;86;85 19:20:04 INFO - PROCESS | 14845 | |11;stanford-crypto-ccm;129;132;122;127;120;128;125;126;127;122 19:20:04 INFO - PROCESS | 14845 | |12;stanford-crypto-pbkdf2;136;158;165;154;151;142;148;150;160;141 19:20:04 INFO - PROCESS | 14845 | |13;stanford-crypto-sha256-iterative;70;71;71;72;72;71;71;72;71;72 19:20:04 INFO - PROCESS | 14845 | __end_tp_report 19:20:04 INFO - PROCESS | 14845 | __start_cc_report 19:20:04 INFO - PROCESS | 14845 | _x_x_mozilla_cycle_collect,797 19:20:04 INFO - PROCESS | 14845 | __end_cc_report 19:20:04 INFO - PROCESS | 14845 | __startTimestamp1451532004518__endTimestamp 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | ------- Summary: start ------- 19:20:04 INFO - PROCESS | 14845 | Number of tests: 14 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#0] ai-astar Cycles:10 Average:114.50 Median:113.50 stddev:4.09 (3.6%) stddev-sans-first:4.30 19:20:04 INFO - PROCESS | 14845 | Values: 113.0 110.0 113.0 113.0 114.0 125.0 113.0 116.0 112.0 116.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:158.00 stddev:15.37 (9.7%) stddev-sans-first:15.78 19:20:04 INFO - PROCESS | 14845 | Values: 162.0 134.0 153.0 176.0 137.0 155.0 161.0 134.0 165.0 134.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:3.57 (2.2%) stddev-sans-first:3.73 19:20:04 INFO - PROCESS | 14845 | Values: 162.0 160.0 164.0 163.0 163.0 164.0 173.0 161.0 164.0 162.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#3] audio-fft Cycles:10 Average:80.80 Median:72.50 stddev:17.48 (24.1%) stddev-sans-first:18.18 19:20:04 INFO - PROCESS | 14845 | Values: 71.0 73.0 72.0 73.0 126.0 72.0 72.0 83.0 72.0 94.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:98.00 stddev:19.10 (19.5%) stddev-sans-first:19.77 19:20:04 INFO - PROCESS | 14845 | Values: 98.0 99.0 140.0 98.0 99.0 98.0 139.0 97.0 97.0 133.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 19:20:04 INFO - PROCESS | 14845 | Values: 109.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 110.0 110.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 19:20:04 INFO - PROCESS | 14845 | Values: 148.0 149.0 147.0 148.0 147.0 149.0 148.0 148.0 147.0 150.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.41 19:20:04 INFO - PROCESS | 14845 | Values: 96.0 95.0 97.0 97.0 96.0 96.0 96.0 100.0 96.0 97.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#8] json-parse-financial Cycles:10 Average:73.30 Median:74.00 stddev:1.34 (1.8%) stddev-sans-first:1.39 19:20:04 INFO - PROCESS | 14845 | Values: 74.0 74.0 74.0 74.0 75.0 74.0 73.0 73.0 71.0 71.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:1.43 (2.1%) stddev-sans-first:1.39 19:20:04 INFO - PROCESS | 14845 | Values: 67.0 69.0 68.0 68.0 72.0 69.0 69.0 69.0 67.0 68.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#10] stanford-crypto-aes Cycles:10 Average:87.50 Median:86.50 stddev:3.54 (4.1%) stddev-sans-first:3.63 19:20:04 INFO - PROCESS | 14845 | Values: 85.0 95.0 87.0 86.0 93.0 85.0 87.0 86.0 86.0 85.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:127.00 stddev:3.65 (2.9%) stddev-sans-first:3.68 19:20:04 INFO - PROCESS | 14845 | Values: 129.0 132.0 122.0 127.0 120.0 128.0 125.0 126.0 127.0 122.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.50 Median:152.50 stddev:9.12 (6.0%) stddev-sans-first:8.02 19:20:04 INFO - PROCESS | 14845 | Values: 136.0 158.0 165.0 154.0 151.0 142.0 148.0 150.0 160.0 141.0 19:20:04 INFO - PROCESS | 14845 | 19:20:04 INFO - PROCESS | 14845 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.50 stddev:0.67 (0.9%) stddev-sans-first:0.53 19:20:04 INFO - PROCESS | 14845 | Values: 70.0 71.0 71.0 72.0 72.0 71.0 71.0 72.0 71.0 72.0 19:20:04 INFO - PROCESS | 14845 | -------- Summary: end -------- 19:20:04 INFO - PROCESS | 14845 | 19:20:05 INFO - TEST-INFO | 14845: exit 0 19:20:05 INFO - TEST-OK | kraken | took 61686ms 19:20:05 INFO - TEST-START | v8_7 19:20:05 INFO - operating with platform_type : linux_ 19:20:05 INFO - Initialising browser for v8_7 test... 19:20:05 INFO - TEST-INFO | started process 15131 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCD5acS/profile http://localhost:33911/getInfo.html) 19:20:09 INFO - PROCESS | 15131 | __metrics Screen width/height:1600/1200 19:20:09 INFO - PROCESS | 15131 | colorDepth:24 19:20:09 INFO - PROCESS | 15131 | Browser inner width/height: 1024/697 19:20:09 INFO - PROCESS | 15131 | __metrics 19:20:10 INFO - PROCESS | 15131 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 19:20:11 INFO - TEST-INFO | 15131: exit 0 19:20:11 INFO - Browser initialized. 19:20:11 INFO - Running cycle 1/1 for v8_7 test... 19:20:11 INFO - TEST-INFO | started process 15251 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCD5acS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:20:23 INFO - PROCESS | 15251 | RSS: Main: 150253568 19:20:23 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | Cycle 1(1): loaded http://localhost:33911/tests/v8_7/run.html (next: http://localhost:33911/tests/v8_7/run.html) 19:20:44 INFO - PROCESS | 15251 | RSS: Main: 144953344 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | __start_tp_report 19:20:44 INFO - PROCESS | 15251 | _x_x_mozilla_page_load 19:20:44 INFO - PROCESS | 15251 | _x_x_mozilla_page_load_details 19:20:44 INFO - PROCESS | 15251 | |i|pagename|runs| 19:20:44 INFO - PROCESS | 15251 | |0;Richards;166.14055490945339 19:20:44 INFO - PROCESS | 15251 | |1;DeltaBlue;187.125748502994 19:20:44 INFO - PROCESS | 15251 | |2;Encrypt;278.55153203342616 19:20:44 INFO - PROCESS | 15251 | |3;Decrypt;5263.1578947368425 19:20:44 INFO - PROCESS | 15251 | |4;RayTrace;1079.913606911447 19:20:44 INFO - PROCESS | 15251 | |5;Earley;720.662347012239 19:20:44 INFO - PROCESS | 15251 | |6;Boyer;12432.098765432098 19:20:44 INFO - PROCESS | 15251 | |7;RegExp;25641.02564102564 19:20:44 INFO - PROCESS | 15251 | |8;Splay;605.5488540410132 19:20:44 INFO - PROCESS | 15251 | |9;NavierStokes;4835.748792270531 19:20:44 INFO - PROCESS | 15251 | __end_tp_report 19:20:44 INFO - PROCESS | 15251 | __startTimestamp1451532044757__endTimestamp 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | ------- Summary: start ------- 19:20:44 INFO - PROCESS | 15251 | Number of tests: 10 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | [#0] Richards Cycles:1 Average:166.14 Median:166.14 stddev:0.00 (0.0%) 19:20:44 INFO - PROCESS | 15251 | Values: 166.1 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | [#1] DeltaBlue Cycles:1 Average:187.13 Median:187.13 stddev:0.00 (0.0%) 19:20:44 INFO - PROCESS | 15251 | Values: 187.1 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | [#2] Encrypt Cycles:1 Average:278.55 Median:278.55 stddev:0.00 (0.0%) 19:20:44 INFO - PROCESS | 15251 | Values: 278.6 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 19:20:44 INFO - PROCESS | 15251 | Values: 5263.2 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | [#4] RayTrace Cycles:1 Average:1079.91 Median:1079.91 stddev:0.00 (0.0%) 19:20:44 INFO - PROCESS | 15251 | Values: 1079.9 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | [#5] Earley Cycles:1 Average:720.66 Median:720.66 stddev:0.00 (0.0%) 19:20:44 INFO - PROCESS | 15251 | Values: 720.7 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | [#6] Boyer Cycles:1 Average:12432.10 Median:12432.10 stddev:0.00 (0.0%) 19:20:44 INFO - PROCESS | 15251 | Values: 12432.1 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | [#7] RegExp Cycles:1 Average:25641.03 Median:25641.03 stddev:0.00 (0.0%) 19:20:44 INFO - PROCESS | 15251 | Values: 25641.0 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | [#8] Splay Cycles:1 Average:605.55 Median:605.55 stddev:0.00 (0.0%) 19:20:44 INFO - PROCESS | 15251 | Values: 605.5 19:20:44 INFO - PROCESS | 15251 | 19:20:44 INFO - PROCESS | 15251 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 19:20:44 INFO - PROCESS | 15251 | Values: 4835.7 19:20:44 INFO - PROCESS | 15251 | -------- Summary: end -------- 19:20:44 INFO - PROCESS | 15251 | 19:20:45 INFO - TEST-INFO | 15251: exit 0 19:20:45 INFO - TEST-OK | v8_7 | took 40142ms 19:20:45 INFO - SUITE-END | took 1215s 19:20:45 INFO - Completed test suite (00:20:15) 19:20:45 INFO - Working with test: dromaeo_css 19:20:45 INFO - Generating results file: dromaeo_css 19:20:45 INFO - Working with test: kraken 19:20:45 INFO - Generating results file: kraken 19:20:45 INFO - javascript benchmark 19:20:45 INFO - Working with test: v8_7 19:20:45 INFO - Generating results file: v8_7 19:20:45 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:20:45 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 19:20:45 INFO - process_Request line: dromaeo_css 6101.46 graph.html#tests=[[72,132,43]] 19:20:45 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:20:45 INFO - process_Request line: kraken 1551.10 graph.html#tests=[[232,132,43]] 19:20:45 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:20:45 INFO - process_Request line: v8_7 21256.83 graph.html#tests=[[230,132,43]] 19:20:45 INFO - RETURN: dromaeo_css: 6101.46 19:20:45 INFO - RETURN: kraken: 1551.10 19:20:45 INFO - RETURN: v8_7: 21256.83 19:20:45 INFO - javascript benchmark 19:20:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2630.947381052379, 2662.454196889638, 2679.8928042878274, 2684.7315268473153, 2722.414680843619, 4550.431196100488, 4638.582527572517, 4642.837500687477, 4672.39258896343, 4694.671373003886, 4580.290055041465, 4661.627069834413, 4673.369095172151, 4674.485806561275, 4690.5543973322565, 4110.794460276989, 4355.825766969333, 4364.367166760818, 4398.8900277493, 4457.64338852891, 4210.3684447332835, 4353.804078816461, 4413.0732546165345, 4422.7125236859665, 4429.911401771963, 4220.78896055196, 4313.0, 4313.331433627777, 4331.956680433218, 4346.022145017378, 4323.848665296699, 4329.631981281595, 4332.631726303268, 4341.761203133827, 4386.407834942306, 4242.787860606988, 4312.353147027971, 4313.245182093153, 4317.11499142675, 4356.194104090753, 4525.298578720303, 4561.498235194126, 4609.516000819899, 4623.537646235383, 4653.511381304982, 4981.402231732179, 4999.975000125012, 5009.12340340439, 5021.874453138665, 5036.471170527078, 4888.193448081098, 4968.677035992649, 5007.148784706572, 5056.519630635084, 5111.488851114858, 4652.999605084855, 4691.8592442226445, 4696.342512048316, 4716.811327546929, 4721.291806229059, 5144.845654630367, 5155.097857874857, 5155.432902380735, 5160.767765450564, 5164.9741751291, 4827.541383568555, 4898.755062246873, 4928.211486162197, 4977.427595826526, 5030.245463180479, 4957.851264462072, 4997.875053123628, 5006.74966251686, 5013.949860501349, 5057.620678449131, 4931.211006238985, 4941.407031156285, 4943.728094954812, 4944.307796908436, 4973.278874563168, 4809.639277054235, 4850.75746212688, 4931.950680493221, 4950.257461380822, 4981.053599816023, 4178.623923846869, 4213.620774130343, 4215.936760948588, 4222.092250166229, 4261.552536983634, 3585.2112535242204, 3678.9632103679155, 3694.1872787987136, 3695.334839728821, 3707.0361705956648, 4274.038341373166, 4293.5706429356815, 4357.477102747691, 4365.607095361433, 4407.955920440819, 4959.429665588431, 4999.600031997432, 5008.5993120550265, 5016.197408414636, 5050.747462626854, 4222.683298752606, 4298.46269216348, 4313.266744653416, 4320.589543993378, 4333.934990975138, 4356.978215108904, 4434.11317736454, 4446.444194475691, 4471.5081341052455, 4492.73043617384, 4731.455882573479, 4767.046590681808, 4767.6424268179335, 4769.284607308931, 4807.4471435785335, 4889.119958407378, 4997.125503037027, 5015.3730783652045, 5017.648764586444, 5022.422421421583, 4783.091212669582, 4820.493848146035, 4828.179209534458, 4853.296272040464, 4890.193118135468, 5017.949820501748, 5023.773930173078, 5029.5221953914315, 5032.320636714143, 5063.594912407072, 4909.975450122726, 4919.262110683426, 4993.201087825931, 5082.390113186441, 5145.202493613496, 4841.830535931225, 4858.805647774049, 4862.635302352409, 4868.41579010521, 4907.460179380194, 4854.878628034327, 4855.1260773061185, 4861.343718597944, 4867.659263851497, 4903.068417000758, 4631.58315751584, 4703.153432382204, 4762.190427627381, 4764.809407623795, 4803.423589169322, 4853.878653033702, 4906.828261010847, 4908.116539022867, 4926.211806111149, 4990.6506544541535, 4758.547937945889, 4771.0, 4772.594329482033, 4773.11697335994, 4807.6394270429155], "unit": "score", "name": "dojo.html", "value": 4596.317214107919}, {"lowerIsBetter": false, "replicates": [508.1666067649056, 517.2758138605951, 521.1349160393745, 530.3688610553438, 539.9757010934508, 31724.365512689732, 32524.67475325246, 32541.83729081357, 32695.346093078126, 32732.181695457624, 35812.46281305783, 36140.63859361406, 36428.635713642856, 36444.63555364445, 36501.269974600495, 7672.5780082095325, 7830.099538553054, 7834.138244793068, 7838.176991415905, 7839.725609603636, 7592.50648707835, 7652.813813858833, 7657.770266891975, 7823.0, 7851.960740196291, 7920.881186782203, 7984.121746607869, 8037.799055023642, 8065.516069035847, 8095.554744489051, 7990.081140668839, 8060.435769496079, 8080.919190808076, 8086.110527841933, 8093.838123237531, 7601.695932162706, 7676.808079797994, 7683.231676832328, 7686.385089192851, 7724.845503089907, 35392.82303588491, 35829.0, 35856.462153067725, 35902.46146307808, 35904.10239744001, 2279.41874821921, 2508.668061470289, 2557.590785474315, 2774.6392968914115, 2844.3884564818663, 25707.61438578404, 25799.613005804928, 25959.480810383688, 26124.477510449873, 26250.0, 3191.856366463515, 3253.772235943461, 3276.8689252429876, 3321.8671253149846, 3372.7976321420792, 187732.0, 188314.0, 188510.0, 188540.0, 188667.05666471718, 40451.0, 41255.7937210312, 41327.1734565307, 41776.95557611023, 47584.0, 48041.75979120082, 48087.51912480831, 48301.5169848297, 48432.27351589729, 48479.75760121177, 11704.590339338083, 11708.356040417688, 11712.238704484182, 11726.648200553997, 11774.116941229442, 9405.05949405054, 9441.527923603793, 9458.763530911783, 9484.762880928032, 9541.045895410542, 16939.830601694073, 17192.22634981429, 17799.73300400495, 18003.369882054067, 18087.547811304823, 6847.554908930903, 7049.224585295613, 7125.96437017822, 7152.213256541776, 7152.249013853574, 854.9230569248798, 881.4745753416544, 905.968291109808, 908.0646933658211, 996.2279233593878, 25999.480010399686, 26319.34201644974, 26321.21036368912, 26455.735442645713, 26460.206193814218, 824.9670013199525, 852.7740148860557, 863.1627321498137, 933.2533972821716, 968.2834702320232, 12998.805017924738, 13018.21890686543, 13079.0, 13079.346032698328, 13979.231142287068, 208559.0, 209013.0, 210037.0, 211707.0, 211840.0, 42236.36645450321, 42355.57644423578, 42381.788091059345, 42500.78749606232, 42546.0, 1021.269792098653, 1027.2398425165472, 1037.3931250218557, 1038.901304376083, 1185.4606154199819, 24500.754992450562, 25213.495730085662, 27100.864495677397, 27277.454450911267, 27302.0, 39291.60708392879, 39301.41047884341, 39447.0, 39594.40608390934, 39680.60319396769, 336870.0, 347692.92303076864, 349200.0, 349360.0, 350461.0, 24825.25524234276, 25262.368440789127, 28595.42809143764, 28611.28471788222, 28953.420931581673, 30069.24826879258, 30080.54879176858, 37621.435678465394, 38512.22975540529, 39172.0, 29574.260643484085, 29724.405511890072, 31610.36779264448, 31611.683883161793, 31631.0, 32081.0, 32403.18992025218, 32421.0, 32485.67514324921, 32591.67408325981, 31242.375152497276, 31903.202419939687, 31985.520217197227, 31998.200044999063, 32052.839735802103, 27186.864065679543, 28418.0, 29429.705702943553, 30514.847425762728, 30679.233019173807, 21428.250011249533, 22100.447488812908, 22955.081796727944, 23048.539029218988, 23097.19159829398], "unit": "score", "name": "ext.html", "value": 15823.509874816664}, {"lowerIsBetter": false, "replicates": [317.45397915585187, 327.4842123655243, 327.82789035756224, 328.15991062879027, 332.9550510681057, 14906.403743850247, 15287.923560382196, 15341.23293835308, 15759.763603545956, 16304.673906521863, 9050.32122590805, 9233.122853328923, 9993.850092248604, 11126.0, 11144.442777861095, 4465.307877279019, 4470.75410852403, 4601.0, 4601.585857272861, 4615.076984603076, 4461.643068554507, 4525.049739554697, 4529.909401811979, 4530.093981203756, 4530.411046563942, 4510.842120525782, 4518.502964673899, 4647.117047760931, 4826.831060912868, 4828.855134345975, 4732.621390288768, 4739.028499157665, 4741.359916411275, 4751.073540659573, 4770.0459908018365, 4826.686265392738, 5056.84829455117, 5098.133317336024, 5109.591232701375, 5120.283160357553, 10668.573257069707, 10692.98416650417, 10918.563257469692, 10993.560257589686, 11134.33194008354, 1675.103819456585, 1701.7532457793675, 1758.749157782097, 1846.5014446099613, 1870.298638010746, 8554.957225213897, 8619.784505387353, 8708.477491350539, 11599.594014209546, 12002.0, 1607.0598699760653, 1608.5576466471814, 1753.9035353055576, 1806.8644851636047, 1817.264008076731, 49019.0, 49492.75253623745, 49872.251916221285, 50297.748511257574, 50603.74698126523, 9696.369735967139, 9801.215902727907, 9821.36161149523, 9864.780424404451, 9883.604655813688, 12150.5139794409, 12226.75546489083, 12250.44872980718, 12252.938735306445, 12269.877301226874, 6961.791146265519, 7013.719451221996, 7038.120234970629, 7104.609246491389, 7135.072440582795, 6814.795556133324, 6887.276835932255, 6901.689423975933, 6909.309069093151, 6962.094927659473, 4071.0840060986043, 4161.875143745692, 4163.770992595376, 4182.853600123981, 4205.5794420557695, 1583.358739710396, 1610.2914717524252, 1647.4975132584436, 1667.7081510735572, 1675.6229848284283, 713.7073799742185, 751.7894989402976, 754.3851760814919, 789.719649524422, 836.0844874862016, 11851.940740296242, 13679.0, 14538.636534086732, 14611.634709132144, 15005.69988600222, 848.5969164646867, 865.9177378149066, 891.2379915172564, 916.2303664921498, 928.9767755806159, 8119.594020298961, 8756.4308319959, 8807.911920880837, 8817.735467935972, 8849.734507964771, 409399.0, 441857.0, 484449.0, 491172.0, 491709.0, 69371.3062869375, 71163.0, 71414.0, 72236.11055557824, 72747.27252727405, 924.8427767279578, 966.0580933589835, 1050.648032908984, 1061.5753698520653, 1062.7290041039485, 13524.391402387113, 14172.291385430894, 14293.57119286423, 14416.567502974927, 14471.204083775494, 28732.712672873004, 28824.423511530073, 30228.546571801002, 30353.0, 32733.67266327306, 34676.65323346734, 35996.64003359933, 36943.0, 37471.81264093662, 38269.234615308094, 8041.67833286662, 8183.754487365389, 8282.751517454486, 8557.743267701979, 8590.613422396133, 12229.449674764479, 15211.92394038067, 15308.77036844426, 15412.845871541589, 15706.293216805043, 10448.268621196443, 11041.33751974884, 12442.0, 12675.873241267469, 13385.866141338462, 4933.728644924564, 5412.105762983082, 11246.718832029264, 12077.57728479499, 12086.939565302117, 13136.671583210114, 13176.341182941007, 13421.463141474233, 13483.797743033667, 14012.579622611338, 7961.124276329483, 8628.050914399537, 8631.91368086311, 8676.566171691517, 8978.506182160045, 13597.912167026416, 13706.24615646149, 13792.655183620489, 13811.79282310746, 14211.218382988622], "unit": "score", "name": "jquery.html", "value": 7672.474377292673}, {"lowerIsBetter": false, "replicates": [1364.4610378900334, 1380.5375199308228, 1468.36126285066, 1656.7846179996598, 1661.509854592895, 5775.162601422791, 5852.912206316909, 6365.745370185193, 6473.352664733524, 6493.026046093089, 6384.936150638492, 6489.675516224193, 6514.967425162868, 6530.934690653092, 6559.081728558006, 1996.6306233346804, 2036.8065033821763, 2045.253482478892, 2054.0551346380685, 2056.753189617248, 2040.4184807329914, 2056.20835978148, 2060.423081537172, 2094.0, 2095.486605781578, 1984.563396052866, 2007.7490313710787, 2020.7272018277565, 2027.0878104852802, 2038.7859274776158, 2030.715699802029, 2060.103854823142, 2065.2874758208395, 2067.9379618611465, 2069.3481553310735, 2036.3890832750117, 2057.3827851644596, 2096.0253482130884, 2097.769245383007, 2106.6208082545136, 6704.0, 6727.428168605626, 6801.557898736566, 6812.523123381366, 6816.591004539694, 3791.317562838688, 3830.7893065881367, 3831.885043448701, 3851.287511810324, 3851.9614803852164, 2528.734482879308, 2550.553653110717, 2567.14000809729, 2597.792176625884, 2602.518534071184, 818.55388813097, 823.7322870067252, 824.1305422778966, 830.754927296449, 840.8696652018947, 8759.16787905148, 8767.123287671246, 8792.34057445694, 8817.118288171196, 8830.337724670675, 3685.3182161300247, 3686.576043754949, 3735.869244576427, 3738.4579236010627, 3741.8690345837763, 7680.231976802275, 7696.384289256846, 7704.383649308042, 7722.53664780115, 7779.105402878628, 3902.6097390261316, 3919.2161567686576, 3930.8231129599235, 3932.8623498177426, 3949.30887094763, 2968.391479746647, 3035.05913166919, 3522.8590856365972, 3524.3832329342263, 3544.9822750886597, 3268.50972354144, 3278.393497203025, 3280.245543524955, 3299.0432774495607, 3312.9006129816144, 962.1340793286098, 967.1199208720031, 969.3650658818485, 975.3708857786688, 976.2921881635899, 894.7941973346167, 902.8871391076116, 961.2790407194605, 993.1707024634367, 1164.7030007348071, 6168.691565421711, 6228.377162283736, 6228.750849965951, 6232.439080482778, 6301.936980630227, 921.3504479342048, 960.8270511307892, 966.3235734985398, 970.2141265574766, 1011.2466212671607, 4826.758662066883, 4926.9014619707405, 4939.728314942713, 4941.061198372297, 4950.2822090796635, 7589.58257295854, 7737.110232323243, 7775.533467991939, 7849.568273744999, 7948.562829044458, 7778.8833167502535, 7803.882941755878, 7818.179091195457, 7861.52830830152, 7878.054633444023, 6206.286277078194, 6264.718087685974, 6292.968535157295, 6325.0, 6327.968360158262, 5881.500072493886, 6018.4884284834525, 6041.365656605993, 6042.879142417215, 6045.153678485103, 6885.299884746003, 6955.374016338554, 6976.19773726028, 7085.14978202619, 7147.3210045045635, 6996.055532503047, 7198.604076775828, 7232.385247254042, 7252.2747725227055, 7290.380317673057, 5677.630953987978, 5822.970885145547, 5858.794942177004, 5884.823455296348, 5892.175095486721, 6319.399657032574, 6329.778457753957, 6379.936200637934, 6394.4564712, 6404.679766011774, 5738.483536481736, 5783.537317014713, 5862.091375836752, 5891.9116213255975, 5902.2327097477055, 5802.477776999922, 5897.203877476657, 5944.138099975566, 5959.940400595939, 5976.223090998143, 5789.594728368974, 5860.09168578871, 5908.291005079418, 6019.337872833898, 6023.969880150571, 5484.643498172765, 5498.752556134904, 5501.449855014466, 5503.697296648723, 5528.55771538284, 5601.243832082617, 5604.551635869202, 5622.803201887914, 5625.0, 5647.915281270702], "unit": "score", "name": "mootools.html", "value": 3832.450148415322}, {"lowerIsBetter": false, "replicates": [286.2700114707496, 288.98710021375075, 294.8024823368343, 295.1720424210091, 304.5568697545072, 5580.497755202036, 5611.7474713637885, 5646.604737668365, 5724.370319264888, 5751.792123654027, 5616.354119276284, 5623.297087864017, 5632.26780518532, 5644.915326270109, 5648.858778530539, 4321.200577893084, 4324.04870928396, 4327.891802704926, 4331.523532411448, 4332.870013899572, 4150.8962275943195, 4267.957320426787, 4274.97862510687, 4290.849820256291, 4295.506016808075, 4210.410542524049, 4218.177455396199, 4238.894027649302, 4239.59723826236, 4243.066525364415, 4233.047564298039, 4236.618704316611, 4239.660827133822, 4240.385144154111, 4250.128723611652, 3639.4358874374516, 3655.1044993976648, 3672.210474747942, 3674.595794462607, 3675.5956844747325, 5254.343207099113, 5268.209768534713, 5413.431589683066, 5429.348478182604, 5457.045017122027, 4862.0, 4863.319135321058, 4874.341963834872, 4878.414590249193, 4881.804727810883, 5919.526437884959, 5933.22868027158, 5934.1692163097205, 5954.583179177459, 5955.642661440327, 3960.881173564798, 3966.861159859391, 3969.503812023497, 3973.1259122992897, 3980.0845805464905, 6036.9396306036815, 6213.099100630428, 6220.253569571635, 6266.467350275232, 6268.341824108448, 4085.428040074392, 4089.7546147230664, 4090.611391917763, 4094.897627559335, 4095.1195492969155, 4166.958260434892, 4168.3955826405, 4169.811603692933, 4173.52004519478, 4174.4364510791265, 4808.6153107752, 4820.566149046603, 4830.879228019257, 4836.516348365135, 4837.782299796518, 5766.913496297559, 5868.354481007086, 5895.233619629506, 5910.1725758392995, 5919.6152250103605, 1445.2990299704634, 1472.0652385735136, 1472.8748056415325, 1473.1234915225423, 1474.1302631447497, 959.0170075672352, 966.2994329111478, 974.3715303629119, 978.9755256118511, 992.2161492421051, 5154.613403994716, 5157.819476318311, 5159.74201289934, 5162.019216348882, 5167.250748641426, 6153.753849845956, 6165.815025549151, 6174.043023331391, 6182.196314479179, 6183.319834818167, 5147.3051138096625, 5148.330717006766, 5154.587632989352, 5163.974180129076, 5167.741612919414, 3275.623303320101, 3325.187772663904, 3349.949750753741, 3350.4974253862115, 3356.3622911646708, 5829.7085145743395, 5837.124431335249, 5841.357450680422, 5843.707814609253, 5844.064949608042, 6098.451139397475, 6246.500279977591, 6257.468115210167, 6408.423241908251, 6450.000249961264, 5843.1235314703135, 5872.913511000478, 5892.263467066531, 5895.263092113486, 5903.1145328200255, 6205.937940620716, 6226.937730622636, 6233.376662333731, 6245.656488893154, 6249.906251406142, 5941.613795103304, 6060.727267272895, 6067.635941843503, 6069.362716914837, 6076.635401875901, 5875.471207591338, 5875.94124058771, 5876.706164691663, 5885.793997210077, 5890.293164820249, 4028.133951200506, 4038.818253178673, 4039.2527382434346, 4073.4297198391655, 4077.041895154577, 6057.0, 6224.0, 6230.844228894314, 6235.688215589294, 6236.376362363727, 5980.43185897339, 5982.4316689914385, 5987.221661184019, 5992.520598352208, 5999.0, 5963.731632076654, 5969.9701501493955, 5983.102534619842, 5983.311919129356, 5989.341172471112, 5761.625494342854, 5852.0, 5860.062390017577, 5860.677662728591, 5867.090600956859, 6020.4280593343565, 6025.246844144482, 6042.697865106815, 6043.8186854394435, 6044.335123136363, 5796.449337312949, 5809.9419005809405, 5816.47651711348, 5818.650880947157, 5820.039693450533], "unit": "score", "name": "prototype.html", "value": 4399.219486780395}, {"lowerIsBetter": false, "replicates": [744.914334851492, 745.3626303638245, 762.950408223465, 766.1572270502448, 767.919368466311, 9536.76158096048, 9735.123838854503, 9757.658481953133, 9763.951180244107, 9769.316147869651, 10269.589216431352, 10422.739431514197, 10429.582816687342, 10440.0, 10477.476126193678, 593.6823799267393, 600.4415893219305, 779.9727009554666, 785.305005070511, 795.6618437164182, 779.3297763923022, 782.6047845837844, 785.9528428294292, 791.3076058448858, 791.5685951156605, 832.076395201326, 840.4957025784541, 840.6805413942724, 841.7516832534386, 843.1694780641063, 828.883956246126, 829.1335554345693, 832.8334333133367, 833.5040650812757, 833.9583020848994, 615.8645098078416, 619.8140557832633, 622.4242575617536, 622.8909940760394, 623.9532035097386, 10810.081143102845, 10879.12966962649, 10952.780944381067, 10954.068904143158, 10965.890341096567, 10461.9476902615, 10773.946130269376, 10825.512851921683, 10842.512086956105, 10892.564297428093, 8960.775980600472, 9039.096090390974, 9085.4094483859, 9126.498042607654, 9208.3093767967, 3106.642736085334, 3166.224275052604, 3179.888703895376, 3238.5951756030495, 3244.67553244676, 38499.0, 38936.22127557433, 38995.22009559821, 39060.80469597634, 39197.80401098005, 8768.561571921378, 8956.507392093497, 8968.641254349883, 9079.909200908038, 9147.908520914705, 14638.0, 14836.70326593462, 14838.0, 14855.514448555057, 14913.254337283093, 5921.171036054956, 6093.69531523422, 6248.625082495065, 6258.687065646699, 6288.6855657217875, 3414.0, 3425.53755243044, 3593.838277277529, 3603.837827297778, 3609.8917032489067, 2379.58357287474, 2426.939326516851, 2428.5992811185956, 2435.9147429840227, 2517.9496410071697, 486.69338316860154, 493.06564061104007, 498.9850304490871, 502.65568085861304, 503.7380562107683, 398.82651046794734, 416.6063070398505, 428.28048877885453, 434.87823409444775, 462.6228531718442, 7330.743423980135, 7499.925000749922, 7554.697812087565, 7556.65995030225, 7635.961820190863, 472.5038709355163, 509.1853035143814, 545.359202936548, 553.5460922043885, 560.1569637695243, 3294.5552350432863, 3416.5046068320453, 3713.814309284525, 3782.394816829294, 3789.905252368713, 43967.340489892675, 44063.0, 44221.778891105336, 44244.778776106556, 44409.777951110686, 42785.786071069444, 42899.571004290185, 43244.135117297476, 43928.34107488326, 44251.33622995593, 39187.6081239184, 40377.596224037974, 40630.79684601558, 40861.18277634431, 41072.38391424131, 7403.481756277009, 7988.0, 8250.339972802281, 8260.586970651564, 8267.0, 32231.194220144684, 32377.838110809294, 32628.0, 33479.49780753339, 33523.0, 38251.426228607146, 41369.0, 41679.37480937849, 41768.79115604524, 42094.78952605218, 9182.311326650395, 9225.86161207569, 9287.767805804639, 9336.859947100935, 9501.57242924084, 10935.133865429807, 10947.726306842074, 10971.670849874517, 11026.173037022096, 11045.502952367324, 10240.948795255976, 10284.228682848965, 10321.948390258001, 10326.225533084898, 10351.223658225512, 10294.073533382032, 10319.174466042548, 10347.482625868826, 10362.533685983997, 10384.117350025332, 9829.31194816356, 9877.753056173653, 9891.455969921722, 9919.206463483048, 9934.950325248328, 9075.909240907771, 9256.0, 9342.766430839283, 9458.33791634579, 9519.904800951901, 8511.702090426805, 9005.234555062892, 9012.909870901207, 9153.816923661623, 9166.816663666823], "unit": "score", "name": "yui.html", "value": 5483.500204094468}], "name": "dromaeo_css", "value": 6101.456146239321}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 113.0, 113.0, 114.0, 125.0, 113.0, 116.0, 112.0, 116.0], "unit": "score", "name": "ai-astar", "value": 114.5}, {"lowerIsBetter": true, "replicates": [162.0, 134.0, 153.0, 176.0, 137.0, 155.0, 161.0, 134.0, 165.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 151.1}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 164.0, 163.0, 163.0, 164.0, 173.0, 161.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 72.0, 73.0, 126.0, 72.0, 72.0, 83.0, 72.0, 94.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 140.0, 98.0, 99.0, 98.0, 139.0, 97.0, 97.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 147.0, 148.0, 147.0, 149.0, 148.0, 148.0, 147.0, 150.0], "unit": "score", "name": "imaging-darkroom", "value": 148.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 97.0, 97.0, 96.0, 96.0, 96.0, 100.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 74.0, 74.0, 75.0, 74.0, 73.0, 73.0, 71.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 73.3}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 68.0, 72.0, 69.0, 69.0, 69.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [85.0, 95.0, 87.0, 86.0, 93.0, 85.0, 87.0, 86.0, 86.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.5}, {"lowerIsBetter": true, "replicates": [129.0, 132.0, 122.0, 127.0, 120.0, 128.0, 125.0, 126.0, 127.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [136.0, 158.0, 165.0, 154.0, 151.0, 142.0, 148.0, 150.0, 160.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 150.5}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 71.0, 72.0, 72.0, 71.0, 71.0, 72.0, 71.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.3}], "name": "kraken", "value": 1551.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.14055490945339], "unit": "score", "name": "Richards", "value": 212.48273800000004}, {"lowerIsBetter": false, "replicates": [187.125748502994], "unit": "score", "name": "DeltaBlue", "value": 353.33459199999993}, {"lowerIsBetter": false, "replicates": [278.55153203342616], "unit": "score", "name": "Encrypt", "value": 955.5897900000004}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1079.913606911447], "unit": "score", "name": "RayTrace", "value": 685.2298140000004}, {"lowerIsBetter": false, "replicates": [720.662347012239], "unit": "score", "name": "Earley", "value": 924.7923146853145}, {"lowerIsBetter": false, "replicates": [12432.098765432098], "unit": "score", "name": "Boyer", "value": 53.608245283018846}, {"lowerIsBetter": false, "replicates": [25641.02564102564], "unit": "score", "name": "RegExp", "value": 35.52841499999999}, {"lowerIsBetter": false, "replicates": [605.5488540410132], "unit": "score", "name": "Splay", "value": 134.57378286852588}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21256.826188522606}]} 19:20:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21256.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1551.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6101.46"}}} 19:20:45 INFO - Return code: 0 19:20:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 19:20:46 INFO - # TBPL SUCCESS # 19:20:46 INFO - Running post-action listener: _resource_record_post_action 19:20:46 INFO - Running post-run listener: _resource_record_post_run 19:20:47 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 8192; Write bytes: 560766976; Read time: 196; Write time: 521540 19:20:47 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 244891648; Read time: 184; Write time: 283944 19:20:47 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 315875328; Read time: 12; Write time: 237596 19:20:47 INFO - Running post-run listener: _upload_blobber_files 19:20:47 INFO - Blob upload gear active. 19:20:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:20:47 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 19:20:47 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'] 19:20:47 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 19:20:47 INFO - (blobuploader) - INFO - Open directory for files ... 19:20:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:20:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:20:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:48 INFO - (blobuploader) - INFO - Done attempting. 19:20:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:20:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:20:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:20:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:20:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:20:49 INFO - (blobuploader) - INFO - Done attempting. 19:20:49 INFO - (blobuploader) - INFO - Iteration through files over. 19:20:49 INFO - Return code: 0 19:20:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:20:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:20:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a641347cb27386c2ffe1b4ca0da9354a2131ffd695bc4d61d924fad1ed992d1572fb31bbb92e09076f2caa3b74e071dc93682e215fe9d8ada83e9d0543e4dba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e5d1a16f70b0af8e5d4711b5202516c76d4e6ec7afd44a4e2024c0e336dcc794ca833e5ceb9fc7e5b985c1b1a2e9fba9347e9dbd849c219df1d58bcbebd7447"} 19:20:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:20:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:20:49 INFO - Contents: 19:20:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a641347cb27386c2ffe1b4ca0da9354a2131ffd695bc4d61d924fad1ed992d1572fb31bbb92e09076f2caa3b74e071dc93682e215fe9d8ada83e9d0543e4dba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e5d1a16f70b0af8e5d4711b5202516c76d4e6ec7afd44a4e2024c0e336dcc794ca833e5ceb9fc7e5b985c1b1a2e9fba9347e9dbd849c219df1d58bcbebd7447"} 19:20:49 INFO - Copying logs to upload dir... 19:20:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.513025 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-12-30 19:20:49.604092) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 19:20:49.607576) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a641347cb27386c2ffe1b4ca0da9354a2131ffd695bc4d61d924fad1ed992d1572fb31bbb92e09076f2caa3b74e071dc93682e215fe9d8ada83e9d0543e4dba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e5d1a16f70b0af8e5d4711b5202516c76d4e6ec7afd44a4e2024c0e336dcc794ca833e5ceb9fc7e5b985c1b1a2e9fba9347e9dbd849c219df1d58bcbebd7447"} build_url:https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011368 build_url: 'https://queue.taskcluster.net/v1/task/YsFdikA3RoqureFOAzjqcg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3a641347cb27386c2ffe1b4ca0da9354a2131ffd695bc4d61d924fad1ed992d1572fb31bbb92e09076f2caa3b74e071dc93682e215fe9d8ada83e9d0543e4dba", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e5d1a16f70b0af8e5d4711b5202516c76d4e6ec7afd44a4e2024c0e336dcc794ca833e5ceb9fc7e5b985c1b1a2e9fba9347e9dbd849c219df1d58bcbebd7447"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-30 19:20:49.632747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 19:20:49.633130) ========= 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=0d7d1540fd7fba0c6b8b7f12000001dc-1451530554.125214-400230561 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004515 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-30 19:20:49.715581) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 19:20:49.716009) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-30 19:20:49.716376) ========= ========= Total master_lag: 0.24 =========