builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-024 starttime: 1452172884.77 results: success (0) buildid: 20160107044007 builduid: e3b1c8b3395f4d3b899944615691f996 revision: 9c82d5b244d7c6a453a0cb2909cd9444de472bed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.769755) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.770136) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.770503) ========= 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=4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006315 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.809894) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.810179) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.842581) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.842848) ========= 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=4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004655 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.892288) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.892545) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.892891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:24.893204) ========= 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=4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-07 05:21:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2016-01-07 05:21:25 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178641 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:25.084000) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:25.084333) ========= 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=4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014385 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:25.135657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:25.136047) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9c82d5b244d7c6a453a0cb2909cd9444de472bed --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 9c82d5b244d7c6a453a0cb2909cd9444de472bed --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=4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-07 05:21:25,218 truncating revision to first 12 chars 2016-01-07 05:21:25,218 Setting DEBUG logging. 2016-01-07 05:21:25,218 attempt 1/10 2016-01-07 05:21:25,219 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9c82d5b244d7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-07 05:21:25,459 unpacking tar archive at: fx-team-9c82d5b244d7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.522498 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:25.672316) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:25.672643) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:25.681727) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:25.682058) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-07 05:21:25.682482) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-07 05:21:25.682805) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:21:25 INFO - MultiFileLogger online at 20160107 05:21:25 in /builds/slave/test 05:21:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 05:21:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:21:25 INFO - {'append_to_log': False, 05:21:25 INFO - 'base_work_dir': '/builds/slave/test', 05:21:25 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 05:21:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:21:25 INFO - 'branch': 'Fx-Team-Non-PGO', 05:21:25 INFO - 'buildbot_json_path': 'buildprops.json', 05:21:25 INFO - 'config_files': ('talos/linux_config.py',), 05:21:25 INFO - 'default_actions': ('clobber', 05:21:25 INFO - 'read-buildbot-config', 05:21:25 INFO - 'download-and-extract', 05:21:25 INFO - 'populate-webroot', 05:21:25 INFO - 'create-virtualenv', 05:21:25 INFO - 'install', 05:21:25 INFO - 'run-tests'), 05:21:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:21:25 INFO - 'download_minidump_stackwalk': True, 05:21:25 INFO - 'download_symbols': 'ondemand', 05:21:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:21:25 INFO - 'tooltool.py': '/tools/tooltool.py', 05:21:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:21:25 INFO - '/tools/misc-python/virtualenv.py')}, 05:21:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:21:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:21:25 INFO - 'installer_path': 'installer.exe', 05:21:25 INFO - 'log_level': 'info', 05:21:25 INFO - 'log_name': 'talos', 05:21:25 INFO - 'log_to_console': True, 05:21:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:21:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:21:25 INFO - 'opt_config_files': (), 05:21:25 INFO - 'pip_index': False, 05:21:25 INFO - 'sps_profile': False, 05:21:25 INFO - 'sps_profile_interval': 0, 05:21:25 INFO - 'suite': 'dromaeojs', 05:21:25 INFO - 'system_bits': '32', 05:21:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:21:25 INFO - 'title': 'talos-linux64-ix-024', 05:21:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:21:25 INFO - 'use_talos_json': True, 05:21:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:21:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:21:25 INFO - 'work_dir': 'build'} 05:21:25 INFO - ##### 05:21:25 INFO - ##### Running clobber step. 05:21:25 INFO - ##### 05:21:25 INFO - Running pre-action listener: _resource_record_pre_action 05:21:25 INFO - Running main action method: clobber 05:21:25 INFO - rmtree: /builds/slave/test/build 05:21:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:21:26 INFO - Running post-action listener: _resource_record_post_action 05:21:26 INFO - ##### 05:21:26 INFO - ##### Running read-buildbot-config step. 05:21:26 INFO - ##### 05:21:26 INFO - Running pre-action listener: _resource_record_pre_action 05:21:26 INFO - Running main action method: read_buildbot_config 05:21:26 INFO - Using buildbot properties: 05:21:26 INFO - { 05:21:26 INFO - "project": "", 05:21:26 INFO - "product": "firefox", 05:21:26 INFO - "script_repo_revision": "production", 05:21:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:21:26 INFO - "repository": "", 05:21:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 05:21:26 INFO - "buildid": "20160107044007", 05:21:26 INFO - "pgo_build": "False", 05:21:26 INFO - "basedir": "/builds/slave/test", 05:21:26 INFO - "buildnumber": 2316, 05:21:26 INFO - "slavename": "talos-linux64-ix-024", 05:21:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:21:26 INFO - "platform": "ubuntu64_hw", 05:21:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 05:21:26 INFO - "branch": "fx-team", 05:21:26 INFO - "repo_path": "integration/fx-team", 05:21:26 INFO - "revision": "9c82d5b244d7c6a453a0cb2909cd9444de472bed", 05:21:26 INFO - "stage_platform": "linux64", 05:21:26 INFO - "builduid": "e3b1c8b3395f4d3b899944615691f996", 05:21:26 INFO - "slavebuilddir": "test" 05:21:26 INFO - } 05:21:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:21:26 INFO - Running post-action listener: _resource_record_post_action 05:21:26 INFO - ##### 05:21:26 INFO - ##### Running download-and-extract step. 05:21:26 INFO - ##### 05:21:26 INFO - Running pre-action listener: _resource_record_pre_action 05:21:26 INFO - Running main action method: download_and_extract 05:21:26 INFO - mkdir: /builds/slave/test/build/tests 05:21:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:26 INFO - https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:21:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/test_packages.json 05:21:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/test_packages.json 05:21:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:21:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:21:31 INFO - Downloaded 1302 bytes. 05:21:31 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:21:31 INFO - Using the following test package requirements: 05:21:31 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:31 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:21:31 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:31 INFO - u'jsshell-linux-x86_64.zip'], 05:21:31 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:21:31 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:31 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:21:31 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:21:31 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:21:31 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:21:31 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:21:31 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:21:31 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:21:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:31 INFO - https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:21:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:21:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:21:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:36 INFO - Downloaded 22788107 bytes. 05:21:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:21:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:21:36 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:21:37 INFO - Return code: 0 05:21:37 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:21: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')]} 05:21:37 INFO - https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:21:38 INFO - Downloaded 22788107 bytes. 05:21:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:21:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:21:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:21:39 INFO - Return code: 0 05:21:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:39 INFO - https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:21:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:21:40 INFO - Downloaded 11132285 bytes. 05:21:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 05:21:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:21:40 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 05:21:41 INFO - Return code: 0 05:21:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:41 INFO - https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:21:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:21:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:21:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:21:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:21:42 INFO - Downloaded 54021391 bytes. 05:21:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:21:42 INFO - mkdir: /builds/slave/test/properties 05:21:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:21:42 INFO - Writing to file /builds/slave/test/properties/build_url 05:21:42 INFO - Contents: 05:21:42 INFO - build_url:https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:21:42 INFO - Running post-action listener: _resource_record_post_action 05:21:42 INFO - Running post-action listener: set_extra_try_arguments 05:21:42 INFO - ##### 05:21:42 INFO - ##### Running populate-webroot step. 05:21:42 INFO - ##### 05:21:42 INFO - Running pre-action listener: _resource_record_pre_action 05:21:42 INFO - Running main action method: populate_webroot 05:21:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:21:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:21:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:21:42 INFO - '--tppagecycles', 05:21:42 INFO - '7'], 05:21:42 INFO - 'tests': ['tsvgm']}}, 05:21:42 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:21:42 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:21:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:21:42 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:21:42 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:21:42 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:21:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:42 INFO - 'talos_options': ['--e10s'], 05:21:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:21:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:42 INFO - 'tests': ['damp', 'tps']}, 05:21:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:42 INFO - 'talos_options': ['--e10s'], 05:21:42 INFO - 'tests': ['damp', 'tps']}, 05:21:42 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:21:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:21:42 INFO - 'other': {'tests': ['a11yr', 05:21:42 INFO - 'ts_paint', 05:21:42 INFO - 'tpaint', 05:21:42 INFO - 'sessionrestore', 05:21:42 INFO - 'sessionrestore_no_auto_restore']}, 05:21:42 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:21:42 INFO - 'tests': ['a11yr', 05:21:42 INFO - 'ts_paint', 05:21:42 INFO - 'tpaint', 05:21:42 INFO - 'sessionrestore', 05:21:42 INFO - 'sessionrestore_no_auto_restore']}, 05:21:42 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:21:42 INFO - 'tests': ['a11yr', 05:21:42 INFO - 'ts_paint', 05:21:42 INFO - 'tpaint', 05:21:42 INFO - 'sessionrestore', 05:21:42 INFO - 'sessionrestore_no_auto_restore']}, 05:21:42 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:21:42 INFO - 'tests': ['a11yr', 05:21:42 INFO - 'ts_paint', 05:21:42 INFO - 'tpaint', 05:21:42 INFO - 'sessionrestore', 05:21:42 INFO - 'sessionrestore_no_auto_restore']}, 05:21:42 INFO - 'other_l64': {'tests': ['a11yr', 05:21:42 INFO - 'ts_paint', 05:21:42 INFO - 'tpaint', 05:21:42 INFO - 'sessionrestore', 05:21:42 INFO - 'sessionrestore_no_auto_restore']}, 05:21:42 INFO - 'other_nol64': {'tests': ['a11yr', 05:21:42 INFO - 'ts_paint', 05:21:42 INFO - 'tpaint', 05:21:42 INFO - 'sessionrestore', 05:21:42 INFO - 'sessionrestore_no_auto_restore']}, 05:21:42 INFO - 'svgr': {'tests': ['tsvgx', 05:21:42 INFO - 'tsvgr_opacity', 05:21:42 INFO - 'tart', 05:21:42 INFO - 'tscrollx', 05:21:42 INFO - 'cart']}, 05:21:42 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:21:42 INFO - 'tests': ['tsvgx', 05:21:42 INFO - 'tsvgr_opacity', 05:21:42 INFO - 'tart', 05:21:42 INFO - 'tscrollx', 05:21:42 INFO - 'cart']}, 05:21:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:42 INFO - 'tests': ['tp5o']}, 05:21:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:42 INFO - 'talos_options': ['--e10s'], 05:21:42 INFO - 'tests': ['tp5o']}, 05:21:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:42 INFO - 'talos_options': ['--xperf_path', 05:21:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:42 INFO - 'tests': ['tp5n']}, 05:21:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:21:42 INFO - 'talos_options': ['--e10s', 05:21:42 INFO - '--xperf_path', 05:21:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:21:42 INFO - 'tests': ['tp5n']}}, 05:21:42 INFO - 'talos.zip': {'path': '', 05:21:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:21:42 INFO - Running post-action listener: _resource_record_post_action 05:21:42 INFO - ##### 05:21:42 INFO - ##### Running create-virtualenv step. 05:21:42 INFO - ##### 05:21:42 INFO - Running pre-action listener: _resource_record_pre_action 05:21:42 INFO - Running main action method: create_virtualenv 05:21:42 INFO - Creating virtualenv /builds/slave/test/build/venv 05:21:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:21:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:21:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:21:42 INFO - Using real prefix '/usr' 05:21:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:21:43 INFO - Installing distribute.............................................................................................................................................................................................done. 05:21:45 INFO - Installing pip.................done. 05:21:45 INFO - Return code: 0 05:21:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 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 0x7fc45b6b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f3d0>, '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 0x14caed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:21:45 INFO - Using env: {'DISPLAY': ':0', 05:21:45 INFO - 'HOME': '/home/cltbld', 05:21:45 INFO - 'LANG': 'en_US.UTF-8', 05:21:45 INFO - 'LANGUAGE': 'en_US:en', 05:21:45 INFO - 'LOGNAME': 'cltbld', 05:21:45 INFO - 'MAIL': '/var/mail/cltbld', 05:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:45 INFO - 'MOZ_NO_REMOTE': '1', 05:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:45 INFO - 'NO_EM_RESTART': '1', 05:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:45 INFO - 'PWD': '/builds/slave/test', 05:21:45 INFO - 'SHELL': '/bin/bash', 05:21:45 INFO - 'SHLVL': '1', 05:21:45 INFO - 'TERM': 'linux', 05:21:45 INFO - 'TMOUT': '86400', 05:21:45 INFO - 'USER': 'cltbld', 05:21:45 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 05:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:45 INFO - '_': '/tools/buildbot/bin/python'} 05:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:21:45 INFO - Cleaning up... 05:21:45 INFO - Return code: 0 05:21:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:45 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 0x7fc45b6b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f3d0>, '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 0x14caed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:21:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:21:45 INFO - Using env: {'DISPLAY': ':0', 05:21:45 INFO - 'HOME': '/home/cltbld', 05:21:45 INFO - 'LANG': 'en_US.UTF-8', 05:21:45 INFO - 'LANGUAGE': 'en_US:en', 05:21:45 INFO - 'LOGNAME': 'cltbld', 05:21:45 INFO - 'MAIL': '/var/mail/cltbld', 05:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:45 INFO - 'MOZ_NO_REMOTE': '1', 05:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:45 INFO - 'NO_EM_RESTART': '1', 05:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:45 INFO - 'PWD': '/builds/slave/test', 05:21:45 INFO - 'SHELL': '/bin/bash', 05:21:45 INFO - 'SHLVL': '1', 05:21:45 INFO - 'TERM': 'linux', 05:21:45 INFO - 'TMOUT': '86400', 05:21:45 INFO - 'USER': 'cltbld', 05:21:45 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 05:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:45 INFO - '_': '/tools/buildbot/bin/python'} 05:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:45 INFO - Downloading/unpacking psutil>=0.7.1 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:47 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:21:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:47 INFO - Installing collected packages: psutil 05:21:47 INFO - Running setup.py install for psutil 05:21:47 INFO - building 'psutil._psutil_linux' extension 05:21:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:21:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:21:47 INFO - building 'psutil._psutil_posix' extension 05:21:47 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:21:47 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:21:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:21:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:21:47 INFO - Successfully installed psutil 05:21:47 INFO - Cleaning up... 05:21:47 INFO - Return code: 0 05:21:47 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:47 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 0x7fc45b6b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f3d0>, '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 0x14caed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:21:47 INFO - Using env: {'DISPLAY': ':0', 05:21:47 INFO - 'HOME': '/home/cltbld', 05:21:47 INFO - 'LANG': 'en_US.UTF-8', 05:21:47 INFO - 'LANGUAGE': 'en_US:en', 05:21:47 INFO - 'LOGNAME': 'cltbld', 05:21:47 INFO - 'MAIL': '/var/mail/cltbld', 05:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:47 INFO - 'MOZ_NO_REMOTE': '1', 05:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:47 INFO - 'NO_EM_RESTART': '1', 05:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:47 INFO - 'PWD': '/builds/slave/test', 05:21:47 INFO - 'SHELL': '/bin/bash', 05:21:47 INFO - 'SHLVL': '1', 05:21:47 INFO - 'TERM': 'linux', 05:21:47 INFO - 'TMOUT': '86400', 05:21:47 INFO - 'USER': 'cltbld', 05:21:47 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 05:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:47 INFO - '_': '/tools/buildbot/bin/python'} 05:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:48 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:49 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:21:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:21:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:21:49 INFO - Installing collected packages: mozsystemmonitor 05:21:49 INFO - Running setup.py install for mozsystemmonitor 05:21:49 INFO - Successfully installed mozsystemmonitor 05:21:49 INFO - Cleaning up... 05:21:49 INFO - Return code: 0 05:21:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:49 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 0x7fc45b6b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f3d0>, '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 0x14caed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:21:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:21:49 INFO - Using env: {'DISPLAY': ':0', 05:21:49 INFO - 'HOME': '/home/cltbld', 05:21:49 INFO - 'LANG': 'en_US.UTF-8', 05:21:49 INFO - 'LANGUAGE': 'en_US:en', 05:21:49 INFO - 'LOGNAME': 'cltbld', 05:21:49 INFO - 'MAIL': '/var/mail/cltbld', 05:21:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:49 INFO - 'MOZ_NO_REMOTE': '1', 05:21:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:49 INFO - 'NO_EM_RESTART': '1', 05:21:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:49 INFO - 'PWD': '/builds/slave/test', 05:21:49 INFO - 'SHELL': '/bin/bash', 05:21:49 INFO - 'SHLVL': '1', 05:21:49 INFO - 'TERM': 'linux', 05:21:49 INFO - 'TMOUT': '86400', 05:21:49 INFO - 'USER': 'cltbld', 05:21:49 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 05:21:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:49 INFO - '_': '/tools/buildbot/bin/python'} 05:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:50 INFO - Downloading/unpacking blobuploader==1.2.4 05:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:51 INFO - Downloading blobuploader-1.2.4.tar.gz 05:21:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:21:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:21:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:21:52 INFO - Downloading docopt-0.6.1.tar.gz 05:21:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:21:52 INFO - Installing collected packages: blobuploader, requests, docopt 05:21:52 INFO - Running setup.py install for blobuploader 05:21:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:21:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:21:52 INFO - Running setup.py install for requests 05:21:52 INFO - Running setup.py install for docopt 05:21:53 INFO - Successfully installed blobuploader requests docopt 05:21:53 INFO - Cleaning up... 05:21:53 INFO - Return code: 0 05:21:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:53 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 0x7fc45b6b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f3d0>, '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 0x14caed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:53 INFO - Using env: {'DISPLAY': ':0', 05:21:53 INFO - 'HOME': '/home/cltbld', 05:21:53 INFO - 'LANG': 'en_US.UTF-8', 05:21:53 INFO - 'LANGUAGE': 'en_US:en', 05:21:53 INFO - 'LOGNAME': 'cltbld', 05:21:53 INFO - 'MAIL': '/var/mail/cltbld', 05:21:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:53 INFO - 'MOZ_NO_REMOTE': '1', 05:21:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:53 INFO - 'NO_EM_RESTART': '1', 05:21:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:53 INFO - 'PWD': '/builds/slave/test', 05:21:53 INFO - 'SHELL': '/bin/bash', 05:21:53 INFO - 'SHLVL': '1', 05:21:53 INFO - 'TERM': 'linux', 05:21:53 INFO - 'TMOUT': '86400', 05:21:53 INFO - 'USER': 'cltbld', 05:21:53 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 05:21:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:53 INFO - '_': '/tools/buildbot/bin/python'} 05:21:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:53 INFO - Running setup.py (path:/tmp/pip-rzpMUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:53 INFO - Running setup.py (path:/tmp/pip-DFvuB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:53 INFO - Running setup.py (path:/tmp/pip-UjimOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:53 INFO - Running setup.py (path:/tmp/pip-Wm7kwi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:53 INFO - Running setup.py (path:/tmp/pip-iEgaPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:53 INFO - Running setup.py (path:/tmp/pip-KIOBFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:53 INFO - Running setup.py (path:/tmp/pip-rMpJxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:53 INFO - Running setup.py (path:/tmp/pip-1cVHiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:53 INFO - Running setup.py (path:/tmp/pip-g7tOOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:53 INFO - Running setup.py (path:/tmp/pip-E_6wRe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:54 INFO - Running setup.py (path:/tmp/pip-AfTJH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:54 INFO - Running setup.py (path:/tmp/pip-iz2Tar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:54 INFO - Running setup.py (path:/tmp/pip-QWZvoz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:54 INFO - Running setup.py (path:/tmp/pip-Ajgyzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:54 INFO - Running setup.py (path:/tmp/pip-X4gOdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:54 INFO - Running setup.py (path:/tmp/pip-yP8E5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:54 INFO - Running setup.py (path:/tmp/pip-gTOitp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:21:54 INFO - Running setup.py install for manifestparser 05:21:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:21:54 INFO - Running setup.py install for mozcrash 05:21:54 INFO - Running setup.py install for mozdebug 05:21:54 INFO - Running setup.py install for mozdevice 05:21:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:21:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:21:54 INFO - Running setup.py install for mozfile 05:21:55 INFO - Running setup.py install for mozhttpd 05:21:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Running setup.py install for mozinfo 05:21:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Running setup.py install for mozInstall 05:21:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Running setup.py install for mozleak 05:21:55 INFO - Running setup.py install for mozlog 05:21:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Running setup.py install for moznetwork 05:21:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Running setup.py install for mozprocess 05:21:55 INFO - Running setup.py install for mozprofile 05:21:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:21:55 INFO - Running setup.py install for mozrunner 05:21:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Running setup.py install for mozscreenshot 05:21:56 INFO - Running setup.py install for moztest 05:21:56 INFO - Running setup.py install for mozversion 05:21:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:21:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:21:56 INFO - Cleaning up... 05:21:56 INFO - Return code: 0 05:21:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fc45b6b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f3d0>, '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 0x14caed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:21:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:56 INFO - Using env: {'DISPLAY': ':0', 05:21:56 INFO - 'HOME': '/home/cltbld', 05:21:56 INFO - 'LANG': 'en_US.UTF-8', 05:21:56 INFO - 'LANGUAGE': 'en_US:en', 05:21:56 INFO - 'LOGNAME': 'cltbld', 05:21:56 INFO - 'MAIL': '/var/mail/cltbld', 05:21:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:56 INFO - 'MOZ_NO_REMOTE': '1', 05:21:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:56 INFO - 'NO_EM_RESTART': '1', 05:21:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:56 INFO - 'PWD': '/builds/slave/test', 05:21:56 INFO - 'SHELL': '/bin/bash', 05:21:56 INFO - 'SHLVL': '1', 05:21:56 INFO - 'TERM': 'linux', 05:21:56 INFO - 'TMOUT': '86400', 05:21:56 INFO - 'USER': 'cltbld', 05:21:56 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 05:21:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:56 INFO - '_': '/tools/buildbot/bin/python'} 05:21:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:21:56 INFO - Running setup.py (path:/tmp/pip-iVGvOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:21:56 INFO - Running setup.py (path:/tmp/pip-3RjP8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:21:56 INFO - Running setup.py (path:/tmp/pip-cAuAnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:21:56 INFO - Running setup.py (path:/tmp/pip-QXwAZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:21:56 INFO - Running setup.py (path:/tmp/pip-yd0Afa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:21:56 INFO - Running setup.py (path:/tmp/pip-Au5laJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:21:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:21:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:21:56 INFO - Running setup.py (path:/tmp/pip-f_qJ_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:21:57 INFO - Running setup.py (path:/tmp/pip-rKiSdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:21:57 INFO - Running setup.py (path:/tmp/pip-5xSGfb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:21:57 INFO - Running setup.py (path:/tmp/pip-GV8GEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:21:57 INFO - Running setup.py (path:/tmp/pip-k3Kq3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:21:57 INFO - Running setup.py (path:/tmp/pip-o21ywP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:21:57 INFO - Running setup.py (path:/tmp/pip-y96w0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:21:57 INFO - Running setup.py (path:/tmp/pip-_lUbdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:57 INFO - Running setup.py (path:/tmp/pip-M7LopT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:21:57 INFO - Running setup.py (path:/tmp/pip-43jSdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:21:57 INFO - Running setup.py (path:/tmp/pip-Kzirzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:21:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21: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 05:21:59 INFO - Downloading blessings-1.5.1.tar.gz 05:21:59 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:21:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:21:59 INFO - Installing collected packages: blessings 05:21:59 INFO - Running setup.py install for blessings 05:21:59 INFO - Successfully installed blessings 05:21:59 INFO - Cleaning up... 05:21:59 INFO - Return code: 0 05:21:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:21:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:21:59 INFO - Reading from file tmpfile_stdout 05:21:59 INFO - Current package versions: 05:21:59 INFO - argparse == 1.2.1 05:21:59 INFO - blessings == 1.5.1 05:21:59 INFO - blobuploader == 1.2.4 05:21:59 INFO - docopt == 0.6.1 05:21:59 INFO - manifestparser == 1.1 05:21:59 INFO - mozInstall == 1.12 05:21:59 INFO - mozcrash == 0.16 05:21:59 INFO - mozdebug == 0.1 05:21:59 INFO - mozdevice == 0.47 05:21:59 INFO - mozfile == 1.2 05:21:59 INFO - mozhttpd == 0.7 05:21:59 INFO - mozinfo == 0.9 05:21:59 INFO - mozleak == 0.1 05:21:59 INFO - mozlog == 3.1 05:21:59 INFO - moznetwork == 0.27 05:21:59 INFO - mozprocess == 0.22 05:21:59 INFO - mozprofile == 0.28 05:21:59 INFO - mozrunner == 6.11 05:21:59 INFO - mozscreenshot == 0.1 05:21:59 INFO - mozsystemmonitor == 0.0 05:21:59 INFO - moztest == 0.7 05:21:59 INFO - mozversion == 1.4 05:21:59 INFO - psutil == 3.1.1 05:21:59 INFO - requests == 1.2.3 05:21:59 INFO - wsgiref == 0.1.2 05:21:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:21:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:21:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:21:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:21:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fc45b6b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f3d0>, '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 0x14caed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:21:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:21:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:21:59 INFO - Using env: {'DISPLAY': ':0', 05:21:59 INFO - 'HOME': '/home/cltbld', 05:21:59 INFO - 'LANG': 'en_US.UTF-8', 05:21:59 INFO - 'LANGUAGE': 'en_US:en', 05:21:59 INFO - 'LOGNAME': 'cltbld', 05:21:59 INFO - 'MAIL': '/var/mail/cltbld', 05:21:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:59 INFO - 'MOZ_NO_REMOTE': '1', 05:21:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:59 INFO - 'NO_EM_RESTART': '1', 05:21:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:59 INFO - 'PWD': '/builds/slave/test', 05:21:59 INFO - 'SHELL': '/bin/bash', 05:21:59 INFO - 'SHLVL': '1', 05:21:59 INFO - 'TERM': 'linux', 05:21:59 INFO - 'TMOUT': '86400', 05:21:59 INFO - 'USER': 'cltbld', 05:21:59 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 05:21:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:59 INFO - '_': '/tools/buildbot/bin/python'} 05:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:22:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:22:00 INFO - Cleaning up... 05:22:00 INFO - Return code: 0 05:22:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:22: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')]} 05:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22: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')]} 05:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:00 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 0x7fc45b6b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f3d0>, '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 0x14caed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:22:00 INFO - Using env: {'DISPLAY': ':0', 05:22:00 INFO - 'HOME': '/home/cltbld', 05:22:00 INFO - 'LANG': 'en_US.UTF-8', 05:22:00 INFO - 'LANGUAGE': 'en_US:en', 05:22:00 INFO - 'LOGNAME': 'cltbld', 05:22:00 INFO - 'MAIL': '/var/mail/cltbld', 05:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:00 INFO - 'MOZ_NO_REMOTE': '1', 05:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:00 INFO - 'NO_EM_RESTART': '1', 05:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:00 INFO - 'PWD': '/builds/slave/test', 05:22:00 INFO - 'SHELL': '/bin/bash', 05:22:00 INFO - 'SHLVL': '1', 05:22:00 INFO - 'TERM': 'linux', 05:22:00 INFO - 'TMOUT': '86400', 05:22:00 INFO - 'USER': 'cltbld', 05:22:00 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 05:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:00 INFO - '_': '/tools/buildbot/bin/python'} 05:22:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:00 INFO - Downloading/unpacking jsonschema 05:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:22:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 05:22:02 INFO - Downloading/unpacking functools32 (from jsonschema) 05:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:02 INFO - Downloading functools32-3.2.3-2.tar.gz 05:22:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:22:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:22:02 INFO - warning: no files found matching '*.txt' 05:22:02 INFO - no previously-included directories found matching 'build' 05:22:02 INFO - no previously-included directories found matching 'dist' 05:22:02 INFO - no previously-included directories found matching '.git*' 05:22:02 INFO - Installing collected packages: jsonschema, functools32 05:22:02 INFO - Running setup.py install for functools32 05:22:02 INFO - warning: no files found matching '*.txt' 05:22:02 INFO - no previously-included directories found matching 'build' 05:22:02 INFO - no previously-included directories found matching 'dist' 05:22:02 INFO - no previously-included directories found matching '.git*' 05:22:02 INFO - Successfully installed jsonschema functools32 05:22:02 INFO - Cleaning up... 05:22:02 INFO - Return code: 0 05:22:02 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:22:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:22:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:22:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fc45b6b5f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13fd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ccdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f3d0>, '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 0x14caed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb360>, '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': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:22:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:22:02 INFO - Using env: {'DISPLAY': ':0', 05:22:02 INFO - 'HOME': '/home/cltbld', 05:22:02 INFO - 'LANG': 'en_US.UTF-8', 05:22:02 INFO - 'LANGUAGE': 'en_US:en', 05:22:02 INFO - 'LOGNAME': 'cltbld', 05:22:02 INFO - 'MAIL': '/var/mail/cltbld', 05:22:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:02 INFO - 'MOZ_NO_REMOTE': '1', 05:22:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:02 INFO - 'NO_EM_RESTART': '1', 05:22:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:02 INFO - 'PWD': '/builds/slave/test', 05:22:02 INFO - 'SHELL': '/bin/bash', 05:22:02 INFO - 'SHLVL': '1', 05:22:02 INFO - 'TERM': 'linux', 05:22:02 INFO - 'TMOUT': '86400', 05:22:02 INFO - 'USER': 'cltbld', 05:22:02 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 05:22:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:02 INFO - '_': '/tools/buildbot/bin/python'} 05:22:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:22:02 INFO - Downloading/unpacking flake8 05:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:04 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:22:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 05:22:04 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:04 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:22:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 05:22:04 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:22:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:22:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:22:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 05:22:05 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22: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 05:22:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:22:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:22:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:05 INFO - no previously-included directories found matching 'docs/_build' 05:22:05 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:22:05 INFO - Running setup.py install for pep8 05:22:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:22:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:22:05 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:22:05 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:22:05 INFO - no previously-included directories found matching 'docs/_build' 05:22:05 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:22:05 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:22:05 INFO - Cleaning up... 05:22:05 INFO - Return code: 0 05:22:05 INFO - Running post-action listener: _resource_record_post_action 05:22:05 INFO - Running post-action listener: _start_resource_monitoring 05:22:05 INFO - Starting resource monitoring. 05:22:05 INFO - ##### 05:22:05 INFO - ##### Running install step. 05:22:05 INFO - ##### 05:22:05 INFO - Running pre-action listener: _resource_record_pre_action 05:22:05 INFO - Running main action method: install 05:22:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:22:05 INFO - Reading from file tmpfile_stdout 05:22:05 INFO - Detecting whether we're running mozinstall >=1.0... 05:22:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:22:05 INFO - Reading from file tmpfile_stdout 05:22:05 INFO - Output received: 05:22:05 INFO - Usage: mozinstall [options] installer 05:22:05 INFO - Options: 05:22:05 INFO - -h, --help show this help message and exit 05:22:05 INFO - -d DEST, --destination=DEST 05:22:05 INFO - Directory to install application into. [default: 05:22:05 INFO - "/builds/slave/test"] 05:22:05 INFO - --app=APP Application being installed. [default: firefox] 05:22:05 INFO - mkdir: /builds/slave/test/build/application 05:22:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:22:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:22:21 INFO - Reading from file tmpfile_stdout 05:22:21 INFO - Output received: 05:22:21 INFO - /builds/slave/test/build/application/firefox/firefox 05:22:21 INFO - Running post-action listener: _resource_record_post_action 05:22:21 INFO - ##### 05:22:21 INFO - ##### Running run-tests step. 05:22:21 INFO - ##### 05:22:21 INFO - Running pre-action listener: _resource_record_pre_action 05:22:21 INFO - Running main action method: run_tests 05:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:22:21 INFO - Python 2.7.3 05:22:21 INFO - Return code: 0 05:22:21 INFO - grabbing minidump binary from tooltool 05:22:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:22:21 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 0x155f3d0>, '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 0x14caed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cb360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:22:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:22:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:22:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:22:21 INFO - Return code: 0 05:22:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:22:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:22:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:22:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:22:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:22:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:22:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:22:22 INFO - Return code: 0 05:22:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:22:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:22:22 INFO - Using env: {'DISPLAY': ':0', 05:22:22 INFO - 'HOME': '/home/cltbld', 05:22:22 INFO - 'LANG': 'en_US.UTF-8', 05:22:22 INFO - 'LANGUAGE': 'en_US:en', 05:22:22 INFO - 'LOGNAME': 'cltbld', 05:22:22 INFO - 'MAIL': '/var/mail/cltbld', 05:22:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:22:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:22:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:22:22 INFO - 'MOZ_NO_REMOTE': '1', 05:22:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:22:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:22:22 INFO - 'NO_EM_RESTART': '1', 05:22:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:22:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:22:22 INFO - 'PWD': '/builds/slave/test', 05:22:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:22:22 INFO - 'SHELL': '/bin/bash', 05:22:22 INFO - 'SHLVL': '1', 05:22:22 INFO - 'TERM': 'linux', 05:22:22 INFO - 'TMOUT': '86400', 05:22:22 INFO - 'USER': 'cltbld', 05:22:22 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218', 05:22:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:22:22 INFO - '_': '/tools/buildbot/bin/python'} 05:22:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:22:22 INFO - mozversion application_buildid: 20160107044007 05:22:22 INFO - mozversion application_changeset: 9c82d5b244d7c6a453a0cb2909cd9444de472bed 05:22:22 INFO - mozversion application_display_name: Nightly 05:22:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:22:22 INFO - mozversion application_name: Firefox 05:22:22 INFO - mozversion application_remotingname: firefox 05:22:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:22:22 INFO - mozversion application_vendor: Mozilla 05:22:22 INFO - mozversion application_version: 46.0a1 05:22:22 INFO - mozversion platform_buildid: 20160107044007 05:22:22 INFO - mozversion platform_changeset: 9c82d5b244d7c6a453a0cb2909cd9444de472bed 05:22:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:22:22 INFO - mozversion platform_version: 46.0a1 05:22:22 INFO - using testdate: 1452172942 05:22:22 INFO - actual date: 1452172942 05:22:22 INFO - starting webserver on 'localhost:46276' 05:22:22 INFO - SUITE-START | Running 3 tests 05:22:22 INFO - TEST-START | dromaeo_css 05:22:22 INFO - operating with platform_type : linux_ 05:22:22 INFO - Initialising browser for dromaeo_css test... 05:22:22 INFO - TEST-INFO | started process 28242 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDB8vC7/profile http://localhost:46276/getInfo.html) 05:22:27 INFO - PROCESS | 28242 | __metrics Screen width/height:1600/1200 05:22:27 INFO - PROCESS | 28242 | colorDepth:24 05:22:27 INFO - PROCESS | 28242 | Browser inner width/height: 1024/697 05:22:27 INFO - PROCESS | 28242 | __metrics 05:22:27 INFO - PROCESS | 28242 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:22:27 INFO - PROCESS | 28242 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:22:28 INFO - TEST-INFO | 28242: exit 0 05:22:28 INFO - Browser initialized. 05:22:28 INFO - Running cycle 1/1 for dromaeo_css test... 05:22:28 INFO - TEST-INFO | started process 28337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDB8vC7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:22:40 INFO - PROCESS | 28337 | RSS: Main: 150020096 05:22:40 INFO - PROCESS | 28337 | 05:23:31 INFO - PROCESS | 28337 | 1452173011780 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:25:43 INFO - PROCESS | 28337 | Cycle 1(1): loaded http://localhost:46276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46276/tests/dromaeo/cssquery-ext.html) 05:25:44 INFO - PROCESS | 28337 | RSS: Main: 244113408 05:25:44 INFO - PROCESS | 28337 | 05:28:47 INFO - PROCESS | 28337 | Cycle 1(1): loaded http://localhost:46276/tests/dromaeo/cssquery-ext.html (next: http://localhost:46276/tests/dromaeo/cssquery-jquery.html) 05:28:48 INFO - PROCESS | 28337 | RSS: Main: 228978688 05:28:48 INFO - PROCESS | 28337 | 05:31:50 INFO - PROCESS | 28337 | Cycle 1(1): loaded http://localhost:46276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46276/tests/dromaeo/cssquery-mootools.html) 05:31:50 INFO - PROCESS | 28337 | RSS: Main: 221745152 05:31:50 INFO - PROCESS | 28337 | 05:34:52 INFO - PROCESS | 28337 | Cycle 1(1): loaded http://localhost:46276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46276/tests/dromaeo/cssquery-prototype.html) 05:34:53 INFO - PROCESS | 28337 | RSS: Main: 212135936 05:34:53 INFO - PROCESS | 28337 | 05:37:56 INFO - PROCESS | 28337 | Cycle 1(1): loaded http://localhost:46276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46276/tests/dromaeo/cssquery-yui.html) 05:37:56 INFO - PROCESS | 28337 | RSS: Main: 192000000 05:37:56 INFO - PROCESS | 28337 | 05:40:59 INFO - PROCESS | 28337 | Cycle 1(1): loaded http://localhost:46276/tests/dromaeo/cssquery-yui.html (next: http://localhost:46276/tests/dromaeo/cssquery-dojo.html) 05:40:59 INFO - PROCESS | 28337 | RSS: Main: 241672192 05:40:59 INFO - PROCESS | 28337 | 05:40:59 INFO - PROCESS | 28337 | __start_tp_report 05:40:59 INFO - PROCESS | 28337 | _x_x_mozilla_page_load 05:40:59 INFO - PROCESS | 28337 | _x_x_mozilla_page_load_details 05:40:59 INFO - PROCESS | 28337 | |i|pagename|runs| 05:40:59 INFO - PROCESS | 28337 | |0;dojo.html;2570.627259047438;2658.508175987441;2661.8003649726274;2680.021792045904;2696.8651567421625;4348.8695339139795;4472.262076757331;4526.207913615117;4536.478304994923;4547.749873756942;4470.418845550074;4513.571210734975;4536.863894083174;4542.0688758804445;4599.172149013176;4107.671386289105;4148.958510414895;4176.248275310443;4290.957090429102;4299.3550967354995;4095.8361665533344;4268.573142685722;4302.26861433557;4319.503257125423;4328.696991210617;4154.450876290457;4202.138561594881;4219.156168766259;4250.14997000598;4257.531671516131;4149.813258403349;4177.5195852476745;4179.6029377209115;4195.727277726938;4215.3044747616605;4136.875893723193;4142.627163555264;4164.083901541686;4180.581941805795;4199.580041995807;4354.412154359153;4400.11997600478;4457.375967364572;4468.039371535103;4474.6420286377015;4886.731229782361;4890.462049174624;4891.779869905863;4896.583790377822;4903.779329930126;4898.485659005824;4912.042151780404;4916.803327866881;4917.385326834145;4960.677555958851;4386.627136693385;4449.221386257392;4504.887377815581;4508.301213311876;4578.473475550288;4973.104841128632;4993;4995.650304478724;4998.6750861193905;5008.348914641147;4777.378940737682;4788.832390866303;4789;4797;4834.685745426536;4687.437507499122;4799.904001919942;4806.134895718735;4827.975860120677;4874.902501949941;4820.783064762094;4839.370881785346;4844.491328410466;4855.174620314555;4887.218045112836;4810.374651295309;4812.085703716282;4812.711237325771;4814.181589129857;4857.80568777252;3914.4715463412645;3961.3463778476803;4016.49793775778;4016.5380981187536;4047.1905618875753;3576.284743051348;3578.0339308386588;3590.7486475946434;3624.5469316335457;3641.289948460025;4223.809928553223;4241.7879106044575;4249.171411574714;4284.592963668447;4289.206496798102;4709.387779588632;4783.976080119577;4825.710457372569;4910.116179087727;4926.6551341406475;4132.214879172948;4218.2196293685765;4233.915321693549;4271;4288.120935208275;4317.222899877989;4326.329418940069;4330;4356.629686476622;4373.1253749249645;4442.178197033559;4550.635949124128;4648.256278995412;4656.278276867091;4689.953100468952;4758.904821903473;4828.855134345975;4857.149998750276;4893.951060489492;4902.01959608087;4617.699849509771;4631.675782695179;4635.443746750411;4638.907221855611;4682.391289132391;4671.11248862715;4809.422869255572;4812.879678007937;4817.253325734517;4853.150698627796;4806.543378379049;4827.155247831545;4833.903321933612;4944.728039957837;4958.082754690394;4739.312799644102;4771.117343291502;4778.689385189951;4786.95213047865;4820.469748327611;4750.8337208197545;4767.141914455431;4774.498677638937;4774.904501909873;4808.831690890802;4428.180786554498;4518.706284091523;4546.522615125365;4546.74992875395;4659.068186362809;4740.810367585258;4757.595604373667;4768.213244814706;4771.117343291502;4808.663393562417;4626.467956184947;4630.0508395778115;4632.374629424984;4668.346431499524;4681.789319480564 05:40:59 INFO - PROCESS | 28337 | |1;ext.html;477.59165913144284;495.69267054426257;502.3946144895399;523.8585581892888;526.3105332015058;24072;24705.25884223474;31512.842435787847;32081.5187772183;32094.197645058885;34574.654253457455;34995.125121871904;35111.64888351116;35112;35127.473087903636;6472.9029064564065;7555.924440755591;7636;7644.044494438195;7698.846023079563;6828.258794007546;6943.236244013155;6948.409385202239;6950.965245173792;9706.563204655773;9538.380005299668;9582.616695332179;9639.08428699276;9641.614335426575;9646.614135434575;9571.66499172529;9670.90329096714;9688.128068473801;9695.806083878353;9696.418214907128;6845.760398386083;7067.257937916496;9713.757156071084;9921.156701680366;9924.057214564677;31160;31403.84298078495;31515;31523.054308370785;31567;2778.971350913844;2870.124611993341;2883.7116288371203;2885.2354126156583;3342.5821772278464;27330.45339093207;27629.585556216673;27691.307717307027;28216;29318.267043323875;3227.80633162011;3242.7243684286864;3296.8351582421024;3299.9010029698907;3303.884364047247;217507;218802.02578729164;219310;219950;220469;53312.73343633257;53761.999999999214;53772.73113634485;53773.193402099;53886.46113538814;48097.27854082191;49435;56089;57588;57602.135967960516;11341.659750207507;11478.94260528692;11505.137114716263;11522.596709115141;11528.423578821026;8316.209960053786;8322.62548185333;8339.332853371716;8348;8362.874556881652;17784.377546786058;17951.281948722168;17955.640887182184;17961.820381796275;17981.730274045898;7259.52813067149;7462.104547454232;7534.623268836536;7599.126100498514;7640.732574359982;804.9396295277878;848.4866655673352;849.3460035772421;851;873.1704880363679;25683.297180043683;25789.61315580268;25986.35034124162;26093.869530652224;26095.217143485726;912.1516989199976;930.437085563238;941.2705153506088;942.528735632184;964.4984608003939;13384.93307533456;13617.523386681418;13719.725605487834;13727.656808579866;14815.407383704747;243407;247699;247936;248315;248967;42115.368269475985;42747.57252427436;42748.78625606914;42811.57188428138;42811.7859410701;1138.1520767028617;1153.7461758413135;1159.7158696119504;1164.6971787335353;1175.7530918507039;24502;25110.246692599252;25241.747582524673;27704.58443123395;27844.721552784213;40326.59673403228;40862.18275634411;40945.38581921214;40974;40986.385204222555;250845;251613;251706;252674;253123;23533.882330588236;23965.161219357935;27051.72948270571;27721.227877212117;28183.154505364873;31505.369892602477;31747.20631984219;33880.3223935515;34912.825435873674;35340;29441.705582943898;29869.10392688136;30031.249218768833;30115;30362.089137325915;25387.61918571186;29707.560271358077;29967.250818729706;31244.843775781887;31650.208744781565;30420;30817.22956926005;30846.383072338875;34716.13209669779;35210.29579408346;26269.73730262673;30827.869342527203;31944.20139496438;31964;33571;22732.20437284687;23112.884435577715;23118.422039448476;23288.4177895554;23459.88270058639 05:40:59 INFO - PROCESS | 28337 | |2;jquery.html;310.22753344172986;318.28862492329637;320.8427870343531;325.0411286704223;326.30985465739957;11962.760744785099;12295.385230738471;15044;15150.166740829236;15464;13885.375158117884;13907.443702251923;14211.71576568468;14215.360308786103;14278.857211427883;4519.9774001129945;4758.928616070762;4905.533974272438;4909.901801963959;5754.942450575503;3700.3709369407266;3857.3442514772414;3860.5946375630433;3866.1107945172485;5768.250127483421;3833.501644786174;3846.0192650873987;5405.837824865261;5718.42815718429;5720.9713951430185;5574.1917421973785;5691.7723291068305;5715.3141623005085;5724.742386592613;5732.31212254528;5008.774605142778;5019.598432125421;5024.924626130611;5035.194368900995;5038.093143234217;17514.299428022863;18260.817391826044;18793.62412751751;18805.15376808047;18836;1835.2750663487982;1841.3187120765404;1858.364124458889;1975.0519750519832;1991.2234228650839;12808.743825123538;12963.935180324132;13081.738365232737;13301.201927884358;13359.799603005962;1751.2819743905065;1779.2255368865074;1805.747195392646;1824.5529845187882;1902.1820617134626;57028;58713.706431467996;59500.70249648768;60299.69850150765;60990.08514872236;9294.395864268801;9541.998090200568;9547.952260238655;9574.569144388519;9612.327137100476;12005.339706316061;12060.879391206152;12087.576934807239;12089.274643521241;12100.092493063055;6529.118568993125;6529.510286728514;6541.103080106811;6569.80290591283;6596.80209593713;6153.630782152995;6157.4458298753325;6210.5031597473;6212.782552610727;6225.750969961241;5680.11958146488;5743.8851222976145;5747.166660834156;5832.358440571534;5955.52355811534;1511.4483213626947;1569.089927841849;1577.968440631204;1578.3765412661935;1690.3799111377316;800.4156965415164;832.0223737108873;862.1421685423044;874.8862647855738;875.671623141322;12420.441080151415;14082.42230379125;14558.344874480674;14699.265036748333;14874.851251487564;806.7741032510907;821.954792486419;826.2316046077086;877.4472082587929;918.5728636184207;8546.2308392245;8632.35257355701;8705.91176102987;8874.86687699685;8881.200691937756;465833;479127;488900;494673;496251;69138;70818.29181708118;70974.29025709677;71209;71223.2877671227;999.0558921818812;999.7600575861886;1007.5516395204064;1009.1523120578603;1009.6213919780082;13252.734945300846;13932.164070155823;14155.292235388395;14593.343299551334;14876.107433554022;29520.852395738744;33223.501647474826;33564.16089597682;33629;33895.32209355848;35109;35466.8226658865;36321.27357452889;37307.06732331605;37794.24411511809;8474.618642160995;8726.345524085593;8743.12568743146;8755.124487551195;8756.387052906235;10675.519601618102;10761.139108871428;14139.929300353844;14794.408223670933;15338.693226135192;12381.319027453577;12455.439505222468;12738.68153296175;12771.169873958162;12910.612681619567;12648.557300494438;12859.614211573667;12873.678158046123;12885.742285154058;13842.58472245794;10671.51978161;11909.940450297692;13286.53497127596;13540.322983850965;14039.50861719835;8437.451565648213;8663.436876603;8691.608877600649;8940.061293564082;8947.507887066275;13734.93132534331;13857.237851917838;13949.930250348683;14221.502247421291;14238.433772285247 05:40:59 INFO - PROCESS | 28337 | |3;mootools.html;1179.4751335655626;1380.1581035568304;1381.088481602142;1479.0328862612726;1693.4580934101084;5995.100734889763;6584.045313429549;6691.531592788507;6694.6987385567645;6708.127943367368;6706.798796036114;6723.428508576764;6798.932010679891;6823.317668233174;6827.180738311409;1736.2100244388773;1770.964580708385;2017.0519855667849;2057.8765274083603;2060.804223598763;2032.2175962254564;2057.77364489906;2076.584683063386;2078.023329035351;2081.198738485686;1986.3345779163997;1989.1844343819037;2016.5361966747657;2032.5223572460459;2038.164352615428;2007.437917383135;2026.7365242518451;2049.569590386006;2051.2205361962433;2051.866628669132;2059.4336557446823;2084.781097984705;2085.1346691123167;2096.308218287961;2101.044024968651;6609.0416889551225;6644.8671026579195;6660;6666.6333351665635;6675.399214070757;3942.7634341939574;4000.0599859033105;4011.0774521860135;4015.1768887378307;4018.2967980603275;2539.2763062527274;2656.907008254702;2660.2418310781336;2680.7051224365305;2684.81206315558;855.5593869157389;907.1427501011481;911.0889110889111;1630.722777127891;1639.0903048807907;8926.821463570692;8989.640414383417;9023.413478123966;9086.727398178065;9121.543922803834;3655.5065066216252;3664.0656632558525;3704.2961837250837;3764.5858955514873;3786.053486628343;7914.485558438798;7932.048154221415;7933.246341597539;7942.523448593103;7965.442419030728;4004.3392840181627;4031.6169963853386;4043.2317859606583;4073.714839961174;4078.3678529827926;3722.1997270586953;3725.5529336479794;3726.347889119393;3726.6646001859963;3727.9254414912093;2977.7320041196394;3017.366353065881;3050.527168288919;3073.5389691546447;3199.568058312145;1042.499600191897;1044.796264728386;1053.773438710681;1054.5623566219933;1055.5672174408455;861.9956900215459;867.444835305405;868.1318681318681;901.4005686218723;1007.8762180169059;6410.8076757697345;6534.640594767334;6548.934510654928;6559.8360040998405;6572.671366431659;986.3588667366126;1005.1707341443339;1020.433659319085;1021.0963297481634;1024.784795193003;5117.232415137759;5133.25567792668;5136.563392111712;5151.536361727388;5159.74201289934;7665.156832748393;7837.09873364559;7838.372930165573;7851.175626559243;7860.034991252187;7876.566788826555;7913.485623434458;7954.801129971797;7992.040955085311;8024.839503209903;6455.193100862392;6464.515161362822;6499.610023398705;6517.185351831021;6547.443467305237;6208.255009398901;6369.426751592379;6380.872382552416;6380.93619063822;6383.1382763326355;7344.30229128232;7556.4710470266555;7589.506682065648;7649.388048956182;7664.310212080716;7247.601381923834;7549.0941087069905;7715.57564333967;7715.92284077152;7734.651940662796;6518.57629254097;6596.373344532261;6600.53796234259;6601.141851559267;6611.537192396679;5707.971460142839;6178.135061091541;6571.310012448624;6669.09967154428;6714.52998290115;6098.634081955097;6271.592346497463;6286.779962701284;6288.874222515616;6393.904091438539;5986.281646202309;6088.847778805565;6157.630542167484;6213.347598502273;6223.875522489616;6039.758409663565;6085.2393450818645;6100.176476175659;6251.624902505864;6258.874822503615;5805.564582656233;5838.854028649148;5842.649441033552;5850.824475265749;5857.765689372377;5908.05471124618;5951.226340575698;5958.731857066356;5961.165436838759;5984.521238300838 05:40:59 INFO - PROCESS | 28337 | |4;prototype.html;288.19162249889064;299.5312336193858;302.1841029221103;306.0970138092626;306.2848249337796;5191.896162076756;5278.36659600848;5286.709230992294;5455.863603409907;5467.261919640857;5257.1851363038695;5329.866753331169;5336.733163341837;5339.439358867321;5343.973280133604;3881.4954055972685;4148.917021659565;4151.875443736678;4152.294110001307;4157.210130075291;3971.8481640324417;3980.383040628707;4034.919301613966;4035.778032208227;4049.5545489996075;3989.122393073519;4013.6387725104737;4019.0354314964343;4023.6781057515327;4026.4966879140106;3853.8843834684726;3927.450156977997;3930.6265904739003;4056.533498647649;4061.614146656063;3471.5660542432197;3471.704905083071;3472.2708231271463;3488.2849015951924;3508.105433114565;5085.084684756743;5117.257997590365;5118.564921981636;5136.383633963911;5148.124818780816;4641.559051890065;4644.512326205768;4648.721076735373;4651.441826980784;4654.69744466612;5308.575313974873;5481.232627432163;5515.4760297771645;5524.779008839641;5532.197831314437;3854.9229015419814;3892.6496615304477;3893.3186692328727;3894.766314021168;3895.2404281165186;5764.942350576483;5823.097419899922;5830.562707796932;5839.357670656224;5842.649441033552;3928.4107383892647;3950.1704642025497;3954.367301231789;3955.4660120883887;3961.980190099031;3917.6278253565865;4023.5775243599587;4024.7987600620436;4027.677785777131;4029.073313137995;4594.931076033795;4602.194615942197;4607.9078418431445;4611.838585649486;4612.838550650711;5557.36090349615;5559.527440167631;5560.165975103686;5566.805161819317;5580.2466666999435;1397.175666356834;1413.8586141385986;1413.9929300353638;1415.497498388078;1415.5187236339693;943.4339396362128;944.1172503709054;946.8674385586023;984.389678399397;992.4888682328607;4864.562189402971;4879.1461494238365;4882.194437917775;4882.389701287339;4884.072026314989;5765.221695071112;5771.7114144293455;5772.682502462405;5778.017736984639;5778.219940308005;4858.514148585184;4866.902661946741;4867.123917694778;4868.391451068616;4874.073925954058;3033.5904652872023;3083.3370825272673;3090.4128215638957;3106.409782141386;3137.231378312328;5525.392206857243;5527.977324195037;5528.143137813645;5529.364123125892;5534.723263836792;5985.22192115031;5994.37059108796;5996.880062398727;5999.280086389661;6000.909986350208;5526.806561770319;5534.418886017072;5538.529225015919;5540.667559946416;5544.889102218014;5655.179998900054;5825.82522524308;5829.562782791223;5835.7373918174635;5839.766409343579;5703.08750599902;5708.429157084424;5710.885782284248;5714.571407144397;5716.828495145152;5524.613277070566;5526.806561770319;5529.253550770755;5531.0873705838085;5534.7786088556;3845.6731177850197;3975.5428125765907;4010.779407132519;4015.598440155961;4016.096378314856;5747.74135163927;5748.396418376177;5754.53963682896;5758.4817366435545;5758.481736643722;5551.528120109836;5558.944410555842;5560.36055853582;5562.360328562268;5568.638038527482;5520.889582208413;5546.223528705904;5548.306461692288;5553.500184983371;5556.555475561864;5253.106971814725;5443.755031023693;5458.781648734006;5466.1527463243265;5474.452554744494;5395.757190926496;5570.6657600544095;5646.632968857011;5649.604527683023;5654.85862853432;5291.9206211906085;5428.4842939920645;5460.781568737365;5469.480399362054;5469.890602188014 05:40:59 INFO - PROCESS | 28337 | |5;yui.html;768.0783060327608;773.7021246819975;776.1152286393516;783.4554984285921;793.4128744728895;12659.683507912296;12786.808197877039;12961.740765184692;13189.406476708547;13321.666958326046;13147.145435546683;13204.471821127143;13221;13223.801642975339;13236.139650922707;605.9394060593927;615.151091493738;766.7776344859984;767.4896194030963;776.3944123583614;748.4237137404195;758.4501236603473;762.572959142879;768.4966347042696;769.6613490064382;811.9634616442245;812.959352032396;817.6933649881295;817.9713710020151;818.3207937411963;625.6371304643296;635.5773410681891;792.4215322814377;807.5074204735137;809.1503920883049;597.6682940967761;598.7126179433852;598.9161517387569;598.9341172471024;598.9371116032797;12331.630051098482;12342.197757145757;12477.812832807514;12477.937610311981;12487.06347023977;10690.251682382237;10905.727356816144;10959.12327013837;11124.443777811077;11184.776304473946;9107.316951228684;9130.223930965876;9260.305477089245;9364.57859396322;9431.811363772686;3134.8746050157965;3141.607299087614;3154.984225078883;3158.478850989607;3175.2220705926966;38603.420948685794;38815.61184388148;39065.41401878974;39845.402318965236;40042;8517.105703901125;8600.225979661735;8664.220220180088;8690;8766.21104100634;15244.390224391122;15258.923705381623;15293;15304.234788260543;15315.923420382827;5808.186853840466;5867.647941123546;5918.674472904032;5922.318933322636;5925.051991681396;3299.0762586475826;3350.748693847971;3357.1439282982683;3392.525046493493;3438.5014172945284;2539.5174916765754;2587.1462417402213;2591.6630837990942;2593.066496061454;2593.81843270973;470.05753464303854;471.96460265480226;477.79454834420835;484.62925861715814;485.8833879868806;475.20517973646076;491.5551425959512;492.72653677208774;546.6337553838858;571.7912961768924;6967.721291148398;7132.0015197872335;7895.171007044292;7992.320652744465;8278.296344810638;463.84924899407827;477.28883962895037;517.2241637543684;530.2602868997803;581.6045089339206;3423.2297733009873;3432.622411534729;3493.825308734553;3575.910602234913;3585.6772890439984;45795.16819327256;46800.7659961698;47175.292370614465;47299;47312;42537.78731106387;42603.14793704109;42808;42952;43124.78437607855;37567.62432375696;38404.23191536098;38408.8079559606;38447.80776096102;39241.41137882934;7179.8564028720175;7180.246074162138;7253.057102576631;7426.554406735613;8057.919420805952;29763.55354669725;29773;30764.69235307618;31071;31220;35770.8211458941;36781.08047298839;36905.81547092248;37710.62289377071;37840.81079594584;9467.20378490181;9578.425294482353;9641.855372169282;9692.22462203008;9825.754356141153;10218.846717299099;10225.897741022494;10364.326318789255;10954.178436617445;10993.835092473459;9801;10166.339187953055;10219.591216351262;10345.27583069208;10592.682219533426;9817.509124543602;10102.242331824995;10135.594576216869;10173.949130254598;10248.538815753458;8760.255378292917;9192.724218273463;10231.386116833013;10334.896651033394;10364.533595988349;8531.872021919551;8597.785055373666;8657.52383618907;8773.561321934005;9078.818423631623;8699.173578510032;8866.822663546822;8944.955275223581;9003.819923601623;9089.772755680897 05:40:59 INFO - PROCESS | 28337 | __end_tp_report 05:40:59 INFO - PROCESS | 28337 | __start_cc_report 05:40:59 INFO - PROCESS | 28337 | _x_x_mozilla_cycle_collect,901 05:40:59 INFO - PROCESS | 28337 | __end_cc_report 05:40:59 INFO - PROCESS | 28337 | __startTimestamp1452174059512__endTimestamp 05:40:59 INFO - PROCESS | 28337 | 05:40:59 INFO - PROCESS | 28337 | ------- Summary: start ------- 05:40:59 INFO - PROCESS | 28337 | Number of tests: 6 05:40:59 INFO - PROCESS | 28337 | 05:40:59 INFO - PROCESS | 28337 | [#0] dojo.html Cycles:165 Average:4491.34 Median:4626.47 stddev:457.47 (9.9%) stddev-sans-first:433.35 05:40:59 INFO - PROCESS | 28337 | Values: 2570.6 2658.5 2661.8 2680.0 2696.9 4348.9 4472.3 4526.2 4536.5 4547.7 4470.4 4513.6 4536.9 4542.1 4599.2 4107.7 4149.0 4176.2 4291.0 4299.4 4095.8 4268.6 4302.3 4319.5 4328.7 4154.5 4202.1 4219.2 4250.1 4257.5 4149.8 4177.5 4179.6 4195.7 4215.3 4136.9 4142.6 4164.1 4180.6 4199.6 4354.4 4400.1 4457.4 4468.0 4474.6 4886.7 4890.5 4891.8 4896.6 4903.8 4898.5 4912.0 4916.8 4917.4 4960.7 4386.6 4449.2 4504.9 4508.3 4578.5 4973.1 4993.0 4995.7 4998.7 5008.3 4777.4 4788.8 4789.0 4797.0 4834.7 4687.4 4799.9 4806.1 4828.0 4874.9 4820.8 4839.4 4844.5 4855.2 4887.2 4810.4 4812.1 4812.7 4814.2 4857.8 3914.5 3961.3 4016.5 4016.5 4047.2 3576.3 3578.0 3590.7 3624.5 3641.3 4223.8 4241.8 4249.2 4284.6 4289.2 4709.4 4784.0 4825.7 4910.1 4926.7 4132.2 4218.2 4233.9 4271.0 4288.1 4317.2 4326.3 4330.0 4356.6 4373.1 4442.2 4550.6 4648.3 4656.3 4690.0 4758.9 4828.9 4857.1 4894.0 4902.0 4617.7 4631.7 4635.4 4638.9 4682.4 4671.1 4809.4 4812.9 4817.3 4853.2 4806.5 4827.2 4833.9 4944.7 4958.1 4739.3 4771.1 4778.7 4787.0 4820.5 4750.8 4767.1 4774.5 4774.9 4808.8 4428.2 4518.7 4546.5 4546.7 4659.1 4740.8 4757.6 4768.2 4771.1 4808.7 4626.5 4630.1 4632.4 4668.3 4681.8 05:40:59 INFO - PROCESS | 28337 | 05:40:59 INFO - PROCESS | 28337 | [#1] ext.html Cycles:180 Average:38942.99 Median:32022.76 stddev:62509.64 (195.2%) stddev-sans-first:62618.28 05:40:59 INFO - PROCESS | 28337 | Values: 477.6 495.7 502.4 523.9 526.3 24072.0 24705.3 31512.8 32081.5 32094.2 34574.7 34995.1 35111.6 35112.0 35127.5 6472.9 7555.9 7636.0 7644.0 7698.8 6828.3 6943.2 6948.4 6951.0 9706.6 9538.4 9582.6 9639.1 9641.6 9646.6 9571.7 9670.9 9688.1 9695.8 9696.4 6845.8 7067.3 9713.8 9921.2 9924.1 31160.0 31403.8 31515.0 31523.1 31567.0 2779.0 2870.1 2883.7 2885.2 3342.6 27330.5 27629.6 27691.3 28216.0 29318.3 3227.8 3242.7 3296.8 3299.9 3303.9 217507.0 218802.0 219310.0 219950.0 220469.0 53312.7 53762.0 53772.7 53773.2 53886.5 48097.3 49435.0 56089.0 57588.0 57602.1 11341.7 11478.9 11505.1 11522.6 11528.4 8316.2 8322.6 8339.3 8348.0 8362.9 17784.4 17951.3 17955.6 17961.8 17981.7 7259.5 7462.1 7534.6 7599.1 7640.7 804.9 848.5 849.3 851.0 873.2 25683.3 25789.6 25986.4 26093.9 26095.2 912.2 930.4 941.3 942.5 964.5 13384.9 13617.5 13719.7 13727.7 14815.4 243407.0 247699.0 247936.0 248315.0 248967.0 42115.4 42747.6 42748.8 42811.6 42811.8 1138.2 1153.7 1159.7 1164.7 1175.8 24502.0 25110.2 25241.7 27704.6 27844.7 40326.6 40862.2 40945.4 40974.0 40986.4 250845.0 251613.0 251706.0 252674.0 253123.0 23533.9 23965.2 27051.7 27721.2 28183.2 31505.4 31747.2 33880.3 34912.8 35340.0 29441.7 29869.1 30031.2 30115.0 30362.1 25387.6 29707.6 29967.3 31244.8 31650.2 30420.0 30817.2 30846.4 34716.1 35210.3 26269.7 30827.9 31944.2 31964.0 33571.0 22732.2 23112.9 23118.4 23288.4 23459.9 05:40:59 INFO - PROCESS | 28337 | 05:40:59 INFO - PROCESS | 28337 | [#2] jquery.html Cycles:180 Average:26025.58 Median:20010.82 stddev:79230.82 (395.9%) stddev-sans-first:79429.55 05:40:59 INFO - PROCESS | 28337 | Values: 310.2 318.3 320.8 325.0 326.3 11962.8 12295.4 15044.0 15150.2 15464.0 13885.4 13907.4 14211.7 14215.4 14278.9 4520.0 4758.9 4905.5 4909.9 5754.9 3700.4 3857.3 3860.6 3866.1 5768.3 3833.5 3846.0 5405.8 5718.4 5721.0 5574.2 5691.8 5715.3 5724.7 5732.3 5008.8 5019.6 5024.9 5035.2 5038.1 17514.3 18260.8 18793.6 18805.2 18836.0 1835.3 1841.3 1858.4 1975.1 1991.2 12808.7 12963.9 13081.7 13301.2 13359.8 1751.3 1779.2 1805.7 1824.6 1902.2 57028.0 58713.7 59500.7 60299.7 60990.1 9294.4 9542.0 9548.0 9574.6 9612.3 12005.3 12060.9 12087.6 12089.3 12100.1 6529.1 6529.5 6541.1 6569.8 6596.8 6153.6 6157.4 6210.5 6212.8 6225.8 5680.1 5743.9 5747.2 5832.4 5955.5 1511.4 1569.1 1578.0 1578.4 1690.4 800.4 832.0 862.1 874.9 875.7 12420.4 14082.4 14558.3 14699.3 14874.9 806.8 822.0 826.2 877.4 918.6 8546.2 8632.4 8705.9 8874.9 8881.2 465833.0 479127.0 488900.0 494673.0 496251.0 69138.0 70818.3 70974.3 71209.0 71223.3 999.1 999.8 1007.6 1009.2 1009.6 13252.7 13932.2 14155.3 14593.3 14876.1 29520.9 33223.5 33564.2 33629.0 33895.3 35109.0 35466.8 36321.3 37307.1 37794.2 8474.6 8726.3 8743.1 8755.1 8756.4 10675.5 10761.1 14139.9 14794.4 15338.7 12381.3 12455.4 12738.7 12771.2 12910.6 12648.6 12859.6 12873.7 12885.7 13842.6 10671.5 11909.9 13286.5 13540.3 14039.5 8437.5 8663.4 8691.6 8940.1 8947.5 13734.9 13857.2 13949.9 14221.5 14238.4 05:40:59 INFO - PROCESS | 28337 | 05:40:59 INFO - PROCESS | 28337 | [#3] mootools.html Cycles:180 Average:4792.84 Median:6062.50 stddev:2438.83 (40.2%) stddev-sans-first:2430.55 05:40:59 INFO - PROCESS | 28337 | Values: 1179.5 1380.2 1381.1 1479.0 1693.5 5995.1 6584.0 6691.5 6694.7 6708.1 6706.8 6723.4 6798.9 6823.3 6827.2 1736.2 1771.0 2017.1 2057.9 2060.8 2032.2 2057.8 2076.6 2078.0 2081.2 1986.3 1989.2 2016.5 2032.5 2038.2 2007.4 2026.7 2049.6 2051.2 2051.9 2059.4 2084.8 2085.1 2096.3 2101.0 6609.0 6644.9 6660.0 6666.6 6675.4 3942.8 4000.1 4011.1 4015.2 4018.3 2539.3 2656.9 2660.2 2680.7 2684.8 855.6 907.1 911.1 1630.7 1639.1 8926.8 8989.6 9023.4 9086.7 9121.5 3655.5 3664.1 3704.3 3764.6 3786.1 7914.5 7932.0 7933.2 7942.5 7965.4 4004.3 4031.6 4043.2 4073.7 4078.4 3722.2 3725.6 3726.3 3726.7 3727.9 2977.7 3017.4 3050.5 3073.5 3199.6 1042.5 1044.8 1053.8 1054.6 1055.6 862.0 867.4 868.1 901.4 1007.9 6410.8 6534.6 6548.9 6559.8 6572.7 986.4 1005.2 1020.4 1021.1 1024.8 5117.2 5133.3 5136.6 5151.5 5159.7 7665.2 7837.1 7838.4 7851.2 7860.0 7876.6 7913.5 7954.8 7992.0 8024.8 6455.2 6464.5 6499.6 6517.2 6547.4 6208.3 6369.4 6380.9 6380.9 6383.1 7344.3 7556.5 7589.5 7649.4 7664.3 7247.6 7549.1 7715.6 7715.9 7734.7 6518.6 6596.4 6600.5 6601.1 6611.5 5708.0 6178.1 6571.3 6669.1 6714.5 6098.6 6271.6 6286.8 6288.9 6393.9 5986.3 6088.8 6157.6 6213.3 6223.9 6039.8 6085.2 6100.2 6251.6 6258.9 5805.6 5838.9 5842.6 5850.8 5857.8 5908.1 5951.2 5958.7 5961.2 5984.5 05:40:59 INFO - PROCESS | 28337 | 05:40:59 INFO - PROCESS | 28337 | [#4] prototype.html Cycles:180 Average:4609.63 Median:5300.25 stddev:1370.41 (25.9%) stddev-sans-first:1335.31 05:40:59 INFO - PROCESS | 28337 | Values: 288.2 299.5 302.2 306.1 306.3 5191.9 5278.4 5286.7 5455.9 5467.3 5257.2 5329.9 5336.7 5339.4 5344.0 3881.5 4148.9 4151.9 4152.3 4157.2 3971.8 3980.4 4034.9 4035.8 4049.6 3989.1 4013.6 4019.0 4023.7 4026.5 3853.9 3927.5 3930.6 4056.5 4061.6 3471.6 3471.7 3472.3 3488.3 3508.1 5085.1 5117.3 5118.6 5136.4 5148.1 4641.6 4644.5 4648.7 4651.4 4654.7 5308.6 5481.2 5515.5 5524.8 5532.2 3854.9 3892.6 3893.3 3894.8 3895.2 5764.9 5823.1 5830.6 5839.4 5842.6 3928.4 3950.2 3954.4 3955.5 3962.0 3917.6 4023.6 4024.8 4027.7 4029.1 4594.9 4602.2 4607.9 4611.8 4612.8 5557.4 5559.5 5560.2 5566.8 5580.2 1397.2 1413.9 1414.0 1415.5 1415.5 943.4 944.1 946.9 984.4 992.5 4864.6 4879.1 4882.2 4882.4 4884.1 5765.2 5771.7 5772.7 5778.0 5778.2 4858.5 4866.9 4867.1 4868.4 4874.1 3033.6 3083.3 3090.4 3106.4 3137.2 5525.4 5528.0 5528.1 5529.4 5534.7 5985.2 5994.4 5996.9 5999.3 6000.9 5526.8 5534.4 5538.5 5540.7 5544.9 5655.2 5825.8 5829.6 5835.7 5839.8 5703.1 5708.4 5710.9 5714.6 5716.8 5524.6 5526.8 5529.3 5531.1 5534.8 3845.7 3975.5 4010.8 4015.6 4016.1 5747.7 5748.4 5754.5 5758.5 5758.5 5551.5 5558.9 5560.4 5562.4 5568.6 5520.9 5546.2 5548.3 5553.5 5556.6 5253.1 5443.8 5458.8 5466.2 5474.5 5395.8 5570.7 5646.6 5649.6 5654.9 5291.9 5428.5 5460.8 5469.5 5469.9 05:40:59 INFO - PROCESS | 28337 | 05:40:59 INFO - PROCESS | 28337 | [#5] yui.html Cycles:180 Average:11807.58 Median:23823.63 stddev:13158.70 (55.2%) stddev-sans-first:13169.50 05:40:59 INFO - PROCESS | 28337 | Values: 768.1 773.7 776.1 783.5 793.4 12659.7 12786.8 12961.7 13189.4 13321.7 13147.1 13204.5 13221.0 13223.8 13236.1 605.9 615.2 766.8 767.5 776.4 748.4 758.5 762.6 768.5 769.7 812.0 813.0 817.7 818.0 818.3 625.6 635.6 792.4 807.5 809.2 597.7 598.7 598.9 598.9 598.9 12331.6 12342.2 12477.8 12477.9 12487.1 10690.3 10905.7 10959.1 11124.4 11184.8 9107.3 9130.2 9260.3 9364.6 9431.8 3134.9 3141.6 3155.0 3158.5 3175.2 38603.4 38815.6 39065.4 39845.4 40042.0 8517.1 8600.2 8664.2 8690.0 8766.2 15244.4 15258.9 15293.0 15304.2 15315.9 5808.2 5867.6 5918.7 5922.3 5925.1 3299.1 3350.7 3357.1 3392.5 3438.5 2539.5 2587.1 2591.7 2593.1 2593.8 470.1 472.0 477.8 484.6 485.9 475.2 491.6 492.7 546.6 571.8 6967.7 7132.0 7895.2 7992.3 8278.3 463.8 477.3 517.2 530.3 581.6 3423.2 3432.6 3493.8 3575.9 3585.7 45795.2 46800.8 47175.3 47299.0 47312.0 42537.8 42603.1 42808.0 42952.0 43124.8 37567.6 38404.2 38408.8 38447.8 39241.4 7179.9 7180.2 7253.1 7426.6 8057.9 29763.6 29773.0 30764.7 31071.0 31220.0 35770.8 36781.1 36905.8 37710.6 37840.8 9467.2 9578.4 9641.9 9692.2 9825.8 10218.8 10225.9 10364.3 10954.2 10993.8 9801.0 10166.3 10219.6 10345.3 10592.7 9817.5 10102.2 10135.6 10173.9 10248.5 8760.3 9192.7 10231.4 10334.9 10364.5 8531.9 8597.8 8657.5 8773.6 9078.8 8699.2 8866.8 8945.0 9003.8 9089.8 05:40:59 INFO - PROCESS | 28337 | -------- Summary: end -------- 05:40:59 INFO - PROCESS | 28337 | 05:41:00 INFO - TEST-INFO | 28337: exit 0 05:41:00 INFO - TEST-OK | dromaeo_css | took 1117528ms 05:41:00 INFO - TEST-START | kraken 05:41:00 INFO - operating with platform_type : linux_ 05:41:00 INFO - Initialising browser for kraken test... 05:41:00 INFO - TEST-INFO | started process 28533 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM3KUVi/profile http://localhost:46276/getInfo.html) 05:41:05 INFO - PROCESS | 28533 | __metrics Screen width/height:1600/1200 05:41:05 INFO - PROCESS | 28533 | colorDepth:24 05:41:05 INFO - PROCESS | 28533 | Browser inner width/height: 1024/697 05:41:05 INFO - PROCESS | 28533 | __metrics 05:41:05 INFO - PROCESS | 28533 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:41:05 INFO - PROCESS | 28533 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:41:06 INFO - TEST-INFO | 28533: exit 0 05:41:06 INFO - Browser initialized. 05:41:06 INFO - Running cycle 1/1 for kraken test... 05:41:06 INFO - TEST-INFO | started process 28614 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpM3KUVi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:18 INFO - PROCESS | 28614 | RSS: Main: 150609920 05:41:18 INFO - PROCESS | 28614 | 05:41:20 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46276/tests/kraken/driver.html?testName=audio-beat-detection) 05:41:21 INFO - PROCESS | 28614 | RSS: Main: 185348096 05:41:21 INFO - PROCESS | 28614 | 05:41:23 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46276/tests/kraken/driver.html?testName=audio-dft) 05:41:24 INFO - PROCESS | 28614 | RSS: Main: 175292416 05:41:24 INFO - PROCESS | 28614 | 05:41:27 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46276/tests/kraken/driver.html?testName=audio-fft) 05:41:28 INFO - PROCESS | 28614 | RSS: Main: 163057664 05:41:28 INFO - PROCESS | 28614 | 05:41:30 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46276/tests/kraken/driver.html?testName=audio-oscillator) 05:41:30 INFO - PROCESS | 28614 | RSS: Main: 164483072 05:41:30 INFO - PROCESS | 28614 | 05:41:32 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:41:33 INFO - PROCESS | 28614 | RSS: Main: 165511168 05:41:33 INFO - PROCESS | 28614 | 05:41:36 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46276/tests/kraken/driver.html?testName=imaging-darkroom) 05:41:37 INFO - PROCESS | 28614 | RSS: Main: 167530496 05:41:37 INFO - PROCESS | 28614 | 05:41:40 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46276/tests/kraken/driver.html?testName=imaging-desaturate) 05:41:41 INFO - PROCESS | 28614 | RSS: Main: 166195200 05:41:41 INFO - PROCESS | 28614 | 05:41:43 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46276/tests/kraken/driver.html?testName=json-parse-financial) 05:41:44 INFO - PROCESS | 28614 | RSS: Main: 167858176 05:41:44 INFO - PROCESS | 28614 | 05:41:46 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:41:46 INFO - PROCESS | 28614 | RSS: Main: 177246208 05:41:46 INFO - PROCESS | 28614 | 05:41:48 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46276/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:41:49 INFO - PROCESS | 28614 | RSS: Main: 174264320 05:41:49 INFO - PROCESS | 28614 | 05:41:51 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:41:52 INFO - PROCESS | 28614 | RSS: Main: 186552320 05:41:52 INFO - PROCESS | 28614 | 05:41:54 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:41:55 INFO - PROCESS | 28614 | RSS: Main: 190193664 05:41:55 INFO - PROCESS | 28614 | 05:41:57 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:41:58 INFO - PROCESS | 28614 | RSS: Main: 187854848 05:41:58 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | Cycle 1(1): loaded http://localhost:46276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46276/tests/kraken/driver.html?testName=ai-astar) 05:42:00 INFO - PROCESS | 28614 | RSS: Main: 247009280 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | __start_tp_report 05:42:00 INFO - PROCESS | 28614 | _x_x_mozilla_page_load 05:42:00 INFO - PROCESS | 28614 | _x_x_mozilla_page_load_details 05:42:00 INFO - PROCESS | 28614 | |i|pagename|runs| 05:42:00 INFO - PROCESS | 28614 | |0;ai-astar;112;114;108;114;113;115;104;115;113;105 05:42:00 INFO - PROCESS | 28614 | |1;audio-beat-detection;160;129;151;169;138;154;160;133;173;129 05:42:00 INFO - PROCESS | 28614 | |2;audio-dft;160;161;161;161;163;160;161;161;161;162 05:42:00 INFO - PROCESS | 28614 | |3;audio-fft;74;74;83;92;73;72;72;96;87;72 05:42:00 INFO - PROCESS | 28614 | |4;audio-oscillator;98;98;136;97;97;97;135;98;97;144 05:42:00 INFO - PROCESS | 28614 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;110;109 05:42:00 INFO - PROCESS | 28614 | |6;imaging-darkroom;146;146;148;148;148;148;146;147;147;146 05:42:00 INFO - PROCESS | 28614 | |7;imaging-desaturate;95;96;95;95;96;95;95;95;95;95 05:42:00 INFO - PROCESS | 28614 | |8;json-parse-financial;74;72;73;72;71;72;73;81;69;68 05:42:00 INFO - PROCESS | 28614 | |9;json-stringify-tinderbox;67;68;67;67;68;68;68;68;68;68 05:42:00 INFO - PROCESS | 28614 | |10;stanford-crypto-aes;83;83;83;84;84;91;84;83;86;84 05:42:00 INFO - PROCESS | 28614 | |11;stanford-crypto-ccm;122;118;127;117;119;128;129;125;131;127 05:42:00 INFO - PROCESS | 28614 | |12;stanford-crypto-pbkdf2;139;138;157;150;153;140;152;145;149;143 05:42:00 INFO - PROCESS | 28614 | |13;stanford-crypto-sha256-iterative;74;73;75;72;72;70;70;73;72;70 05:42:00 INFO - PROCESS | 28614 | __end_tp_report 05:42:00 INFO - PROCESS | 28614 | __start_cc_report 05:42:00 INFO - PROCESS | 28614 | _x_x_mozilla_cycle_collect,974 05:42:00 INFO - PROCESS | 28614 | __end_cc_report 05:42:00 INFO - PROCESS | 28614 | __startTimestamp1452174120418__endTimestamp 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | ------- Summary: start ------- 05:42:00 INFO - PROCESS | 28614 | Number of tests: 14 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.50 stddev:4.11 (3.6%) stddev-sans-first:4.35 05:42:00 INFO - PROCESS | 28614 | Values: 112.0 114.0 108.0 114.0 113.0 115.0 104.0 115.0 113.0 105.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#1] audio-beat-detection Cycles:10 Average:149.60 Median:157.00 stddev:16.40 (10.4%) stddev-sans-first:16.96 05:42:00 INFO - PROCESS | 28614 | Values: 160.0 129.0 151.0 169.0 138.0 154.0 160.0 133.0 173.0 129.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.00 stddev:0.88 (0.5%) stddev-sans-first:0.83 05:42:00 INFO - PROCESS | 28614 | Values: 160.0 161.0 161.0 161.0 163.0 160.0 161.0 161.0 161.0 162.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#3] audio-fft Cycles:10 Average:79.50 Median:78.50 stddev:9.24 (11.8%) stddev-sans-first:9.58 05:42:00 INFO - PROCESS | 28614 | Values: 74.0 74.0 83.0 92.0 73.0 72.0 72.0 96.0 87.0 72.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#4] audio-oscillator Cycles:10 Average:109.70 Median:97.00 stddev:19.90 (20.5%) stddev-sans-first:20.65 05:42:00 INFO - PROCESS | 28614 | Values: 98.0 98.0 136.0 97.0 97.0 97.0 135.0 98.0 97.0 144.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:42:00 INFO - PROCESS | 28614 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 109.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 05:42:00 INFO - PROCESS | 28614 | Values: 146.0 146.0 148.0 148.0 148.0 148.0 146.0 147.0 147.0 146.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:42:00 INFO - PROCESS | 28614 | Values: 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#8] json-parse-financial Cycles:10 Average:72.50 Median:72.50 stddev:3.50 (4.8%) stddev-sans-first:3.67 05:42:00 INFO - PROCESS | 28614 | Values: 74.0 72.0 73.0 72.0 71.0 72.0 73.0 81.0 69.0 68.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 05:42:00 INFO - PROCESS | 28614 | Values: 67.0 68.0 67.0 67.0 68.0 68.0 68.0 68.0 68.0 68.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:2.46 (2.9%) stddev-sans-first:2.55 05:42:00 INFO - PROCESS | 28614 | Values: 83.0 83.0 83.0 84.0 84.0 91.0 84.0 83.0 86.0 84.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:127.00 stddev:4.97 (3.9%) stddev-sans-first:5.20 05:42:00 INFO - PROCESS | 28614 | Values: 122.0 118.0 127.0 117.0 119.0 128.0 129.0 125.0 131.0 127.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.60 Median:149.50 stddev:6.55 (4.4%) stddev-sans-first:6.35 05:42:00 INFO - PROCESS | 28614 | Values: 139.0 138.0 157.0 150.0 153.0 140.0 152.0 145.0 149.0 143.0 05:42:00 INFO - PROCESS | 28614 | 05:42:00 INFO - PROCESS | 28614 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.50 stddev:1.73 (2.4%) stddev-sans-first:1.69 05:42:00 INFO - PROCESS | 28614 | Values: 74.0 73.0 75.0 72.0 72.0 70.0 70.0 73.0 72.0 70.0 05:42:00 INFO - PROCESS | 28614 | -------- Summary: end -------- 05:42:00 INFO - PROCESS | 28614 | 05:42:01 INFO - TEST-INFO | 28614: exit 0 05:42:01 INFO - TEST-OK | kraken | took 61043ms 05:42:01 INFO - TEST-START | v8_7 05:42:01 INFO - operating with platform_type : linux_ 05:42:01 INFO - Initialising browser for v8_7 test... 05:42:01 INFO - TEST-INFO | started process 28865 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnJvAzF/profile http://localhost:46276/getInfo.html) 05:42:06 INFO - PROCESS | 28865 | __metrics Screen width/height:1600/1200 05:42:06 INFO - PROCESS | 28865 | colorDepth:24 05:42:06 INFO - PROCESS | 28865 | Browser inner width/height: 1024/697 05:42:06 INFO - PROCESS | 28865 | __metrics 05:42:06 INFO - PROCESS | 28865 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:42:06 INFO - PROCESS | 28865 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:42:07 INFO - TEST-INFO | 28865: exit 0 05:42:07 INFO - Browser initialized. 05:42:07 INFO - Running cycle 1/1 for v8_7 test... 05:42:07 INFO - TEST-INFO | started process 28947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnJvAzF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:42:19 INFO - PROCESS | 28947 | RSS: Main: 150253568 05:42:19 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | Cycle 1(1): loaded http://localhost:46276/tests/v8_7/run.html (next: http://localhost:46276/tests/v8_7/run.html) 05:42:40 INFO - PROCESS | 28947 | RSS: Main: 451985408 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | __start_tp_report 05:42:40 INFO - PROCESS | 28947 | _x_x_mozilla_page_load 05:42:40 INFO - PROCESS | 28947 | _x_x_mozilla_page_load_details 05:42:40 INFO - PROCESS | 28947 | |i|pagename|runs| 05:42:40 INFO - PROCESS | 28947 | |0;Richards;166.11295681063123 05:42:40 INFO - PROCESS | 28947 | |1;DeltaBlue;187.33608092918695 05:42:40 INFO - PROCESS | 28947 | |2;Encrypt;277.623542476402 05:42:40 INFO - PROCESS | 28947 | |3;Decrypt;5170.103092783505 05:42:40 INFO - PROCESS | 28947 | |4;RayTrace;1978.2608695652175 05:42:40 INFO - PROCESS | 28947 | |5;Earley;805.8017727639001 05:42:40 INFO - PROCESS | 28947 | |6;Boyer;12395.061728395061 05:42:40 INFO - PROCESS | 28947 | |7;RegExp;26552.63157894737 05:42:40 INFO - PROCESS | 28947 | |8;Splay;610.1281269066504 05:42:40 INFO - PROCESS | 28947 | |9;NavierStokes;4835.748792270531 05:42:40 INFO - PROCESS | 28947 | __end_tp_report 05:42:40 INFO - PROCESS | 28947 | __startTimestamp1452174160822__endTimestamp 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | ------- Summary: start ------- 05:42:40 INFO - PROCESS | 28947 | Number of tests: 10 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | [#0] Richards Cycles:1 Average:166.11 Median:166.11 stddev:0.00 (0.0%) 05:42:40 INFO - PROCESS | 28947 | Values: 166.1 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | [#1] DeltaBlue Cycles:1 Average:187.34 Median:187.34 stddev:0.00 (0.0%) 05:42:40 INFO - PROCESS | 28947 | Values: 187.3 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | [#2] Encrypt Cycles:1 Average:277.62 Median:277.62 stddev:0.00 (0.0%) 05:42:40 INFO - PROCESS | 28947 | Values: 277.6 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 05:42:40 INFO - PROCESS | 28947 | Values: 5170.1 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 05:42:40 INFO - PROCESS | 28947 | Values: 1978.3 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | [#5] Earley Cycles:1 Average:805.80 Median:805.80 stddev:0.00 (0.0%) 05:42:40 INFO - PROCESS | 28947 | Values: 805.8 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 05:42:40 INFO - PROCESS | 28947 | Values: 12395.1 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 05:42:40 INFO - PROCESS | 28947 | Values: 26552.6 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | [#8] Splay Cycles:1 Average:610.13 Median:610.13 stddev:0.00 (0.0%) 05:42:40 INFO - PROCESS | 28947 | Values: 610.1 05:42:40 INFO - PROCESS | 28947 | 05:42:40 INFO - PROCESS | 28947 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:42:40 INFO - PROCESS | 28947 | Values: 4835.7 05:42:40 INFO - PROCESS | 28947 | -------- Summary: end -------- 05:42:40 INFO - PROCESS | 28947 | 05:42:41 INFO - TEST-INFO | 28947: exit 0 05:42:41 INFO - TEST-OK | v8_7 | took 40351ms 05:42:41 INFO - SUITE-END | took 1218s 05:42:41 INFO - Completed test suite (00:20:19) 05:42:41 INFO - Working with test: dromaeo_css 05:42:41 INFO - Generating results file: dromaeo_css 05:42:41 INFO - Working with test: kraken 05:42:41 INFO - Generating results file: kraken 05:42:41 INFO - javascript benchmark 05:42:41 INFO - Working with test: v8_7 05:42:41 INFO - Generating results file: v8_7 05:42:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:42:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 05:42:41 INFO - process_Request line: dromaeo_css 6133.82 graph.html#tests=[[72,132,35]] 05:42:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:42:41 INFO - process_Request line: kraken 1530.20 graph.html#tests=[[232,132,35]] 05:42:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:42:41 INFO - process_Request line: v8_7 19744.78 graph.html#tests=[[230,132,35]] 05:42:42 INFO - RETURN: dromaeo_css: 6133.82 05:42:42 INFO - RETURN: kraken: 1530.20 05:42:42 INFO - RETURN: v8_7: 19744.78 05:42:42 INFO - javascript benchmark 05:42:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2570.627259047438, 2658.508175987441, 2661.8003649726274, 2680.021792045904, 2696.8651567421625, 4348.8695339139795, 4472.262076757331, 4526.207913615117, 4536.478304994923, 4547.749873756942, 4470.418845550074, 4513.571210734975, 4536.863894083174, 4542.0688758804445, 4599.172149013176, 4107.671386289105, 4148.958510414895, 4176.248275310443, 4290.957090429102, 4299.3550967354995, 4095.8361665533344, 4268.573142685722, 4302.26861433557, 4319.503257125423, 4328.696991210617, 4154.450876290457, 4202.138561594881, 4219.156168766259, 4250.14997000598, 4257.531671516131, 4149.813258403349, 4177.5195852476745, 4179.6029377209115, 4195.727277726938, 4215.3044747616605, 4136.875893723193, 4142.627163555264, 4164.083901541686, 4180.581941805795, 4199.580041995807, 4354.412154359153, 4400.11997600478, 4457.375967364572, 4468.039371535103, 4474.6420286377015, 4886.731229782361, 4890.462049174624, 4891.779869905863, 4896.583790377822, 4903.779329930126, 4898.485659005824, 4912.042151780404, 4916.803327866881, 4917.385326834145, 4960.677555958851, 4386.627136693385, 4449.221386257392, 4504.887377815581, 4508.301213311876, 4578.473475550288, 4973.104841128632, 4993.0, 4995.650304478724, 4998.6750861193905, 5008.348914641147, 4777.378940737682, 4788.832390866303, 4789.0, 4797.0, 4834.685745426536, 4687.437507499122, 4799.904001919942, 4806.134895718735, 4827.975860120677, 4874.902501949941, 4820.783064762094, 4839.370881785346, 4844.491328410466, 4855.174620314555, 4887.218045112836, 4810.374651295309, 4812.085703716282, 4812.711237325771, 4814.181589129857, 4857.80568777252, 3914.4715463412645, 3961.3463778476803, 4016.49793775778, 4016.5380981187536, 4047.1905618875753, 3576.284743051348, 3578.0339308386588, 3590.7486475946434, 3624.5469316335457, 3641.289948460025, 4223.809928553223, 4241.7879106044575, 4249.171411574714, 4284.592963668447, 4289.206496798102, 4709.387779588632, 4783.976080119577, 4825.710457372569, 4910.116179087727, 4926.6551341406475, 4132.214879172948, 4218.2196293685765, 4233.915321693549, 4271.0, 4288.120935208275, 4317.222899877989, 4326.329418940069, 4330.0, 4356.629686476622, 4373.1253749249645, 4442.178197033559, 4550.635949124128, 4648.256278995412, 4656.278276867091, 4689.953100468952, 4758.904821903473, 4828.855134345975, 4857.149998750276, 4893.951060489492, 4902.01959608087, 4617.699849509771, 4631.675782695179, 4635.443746750411, 4638.907221855611, 4682.391289132391, 4671.11248862715, 4809.422869255572, 4812.879678007937, 4817.253325734517, 4853.150698627796, 4806.543378379049, 4827.155247831545, 4833.903321933612, 4944.728039957837, 4958.082754690394, 4739.312799644102, 4771.117343291502, 4778.689385189951, 4786.95213047865, 4820.469748327611, 4750.8337208197545, 4767.141914455431, 4774.498677638937, 4774.904501909873, 4808.831690890802, 4428.180786554498, 4518.706284091523, 4546.522615125365, 4546.74992875395, 4659.068186362809, 4740.810367585258, 4757.595604373667, 4768.213244814706, 4771.117343291502, 4808.663393562417, 4626.467956184947, 4630.0508395778115, 4632.374629424984, 4668.346431499524, 4681.789319480564], "unit": "score", "name": "dojo.html", "value": 4463.74661207562}, {"lowerIsBetter": false, "replicates": [477.59165913144284, 495.69267054426257, 502.3946144895399, 523.8585581892888, 526.3105332015058, 24072.0, 24705.25884223474, 31512.842435787847, 32081.5187772183, 32094.197645058885, 34574.654253457455, 34995.125121871904, 35111.64888351116, 35112.0, 35127.473087903636, 6472.9029064564065, 7555.924440755591, 7636.0, 7644.044494438195, 7698.846023079563, 6828.258794007546, 6943.236244013155, 6948.409385202239, 6950.965245173792, 9706.563204655773, 9538.380005299668, 9582.616695332179, 9639.08428699276, 9641.614335426575, 9646.614135434575, 9571.66499172529, 9670.90329096714, 9688.128068473801, 9695.806083878353, 9696.418214907128, 6845.760398386083, 7067.257937916496, 9713.757156071084, 9921.156701680366, 9924.057214564677, 31160.0, 31403.84298078495, 31515.0, 31523.054308370785, 31567.0, 2778.971350913844, 2870.124611993341, 2883.7116288371203, 2885.2354126156583, 3342.5821772278464, 27330.45339093207, 27629.585556216673, 27691.307717307027, 28216.0, 29318.267043323875, 3227.80633162011, 3242.7243684286864, 3296.8351582421024, 3299.9010029698907, 3303.884364047247, 217507.0, 218802.02578729164, 219310.0, 219950.0, 220469.0, 53312.73343633257, 53761.999999999214, 53772.73113634485, 53773.193402099, 53886.46113538814, 48097.27854082191, 49435.0, 56089.0, 57588.0, 57602.135967960516, 11341.659750207507, 11478.94260528692, 11505.137114716263, 11522.596709115141, 11528.423578821026, 8316.209960053786, 8322.62548185333, 8339.332853371716, 8348.0, 8362.874556881652, 17784.377546786058, 17951.281948722168, 17955.640887182184, 17961.820381796275, 17981.730274045898, 7259.52813067149, 7462.104547454232, 7534.623268836536, 7599.126100498514, 7640.732574359982, 804.9396295277878, 848.4866655673352, 849.3460035772421, 851.0, 873.1704880363679, 25683.297180043683, 25789.61315580268, 25986.35034124162, 26093.869530652224, 26095.217143485726, 912.1516989199976, 930.437085563238, 941.2705153506088, 942.528735632184, 964.4984608003939, 13384.93307533456, 13617.523386681418, 13719.725605487834, 13727.656808579866, 14815.407383704747, 243407.0, 247699.0, 247936.0, 248315.0, 248967.0, 42115.368269475985, 42747.57252427436, 42748.78625606914, 42811.57188428138, 42811.7859410701, 1138.1520767028617, 1153.7461758413135, 1159.7158696119504, 1164.6971787335353, 1175.7530918507039, 24502.0, 25110.246692599252, 25241.747582524673, 27704.58443123395, 27844.721552784213, 40326.59673403228, 40862.18275634411, 40945.38581921214, 40974.0, 40986.385204222555, 250845.0, 251613.0, 251706.0, 252674.0, 253123.0, 23533.882330588236, 23965.161219357935, 27051.72948270571, 27721.227877212117, 28183.154505364873, 31505.369892602477, 31747.20631984219, 33880.3223935515, 34912.825435873674, 35340.0, 29441.705582943898, 29869.10392688136, 30031.249218768833, 30115.0, 30362.089137325915, 25387.61918571186, 29707.560271358077, 29967.250818729706, 31244.843775781887, 31650.208744781565, 30420.0, 30817.22956926005, 30846.383072338875, 34716.13209669779, 35210.29579408346, 26269.73730262673, 30827.869342527203, 31944.20139496438, 31964.0, 33571.0, 22732.20437284687, 23112.884435577715, 23118.422039448476, 23288.4177895554, 23459.88270058639], "unit": "score", "name": "ext.html", "value": 16079.455968548084}, {"lowerIsBetter": false, "replicates": [310.22753344172986, 318.28862492329637, 320.8427870343531, 325.0411286704223, 326.30985465739957, 11962.760744785099, 12295.385230738471, 15044.0, 15150.166740829236, 15464.0, 13885.375158117884, 13907.443702251923, 14211.71576568468, 14215.360308786103, 14278.857211427883, 4519.9774001129945, 4758.928616070762, 4905.533974272438, 4909.901801963959, 5754.942450575503, 3700.3709369407266, 3857.3442514772414, 3860.5946375630433, 3866.1107945172485, 5768.250127483421, 3833.501644786174, 3846.0192650873987, 5405.837824865261, 5718.42815718429, 5720.9713951430185, 5574.1917421973785, 5691.7723291068305, 5715.3141623005085, 5724.742386592613, 5732.31212254528, 5008.774605142778, 5019.598432125421, 5024.924626130611, 5035.194368900995, 5038.093143234217, 17514.299428022863, 18260.817391826044, 18793.62412751751, 18805.15376808047, 18836.0, 1835.2750663487982, 1841.3187120765404, 1858.364124458889, 1975.0519750519832, 1991.2234228650839, 12808.743825123538, 12963.935180324132, 13081.738365232737, 13301.201927884358, 13359.799603005962, 1751.2819743905065, 1779.2255368865074, 1805.747195392646, 1824.5529845187882, 1902.1820617134626, 57028.0, 58713.706431467996, 59500.70249648768, 60299.69850150765, 60990.08514872236, 9294.395864268801, 9541.998090200568, 9547.952260238655, 9574.569144388519, 9612.327137100476, 12005.339706316061, 12060.879391206152, 12087.576934807239, 12089.274643521241, 12100.092493063055, 6529.118568993125, 6529.510286728514, 6541.103080106811, 6569.80290591283, 6596.80209593713, 6153.630782152995, 6157.4458298753325, 6210.5031597473, 6212.782552610727, 6225.750969961241, 5680.11958146488, 5743.8851222976145, 5747.166660834156, 5832.358440571534, 5955.52355811534, 1511.4483213626947, 1569.089927841849, 1577.968440631204, 1578.3765412661935, 1690.3799111377316, 800.4156965415164, 832.0223737108873, 862.1421685423044, 874.8862647855738, 875.671623141322, 12420.441080151415, 14082.42230379125, 14558.344874480674, 14699.265036748333, 14874.851251487564, 806.7741032510907, 821.954792486419, 826.2316046077086, 877.4472082587929, 918.5728636184207, 8546.2308392245, 8632.35257355701, 8705.91176102987, 8874.86687699685, 8881.200691937756, 465833.0, 479127.0, 488900.0, 494673.0, 496251.0, 69138.0, 70818.29181708118, 70974.29025709677, 71209.0, 71223.2877671227, 999.0558921818812, 999.7600575861886, 1007.5516395204064, 1009.1523120578603, 1009.6213919780082, 13252.734945300846, 13932.164070155823, 14155.292235388395, 14593.343299551334, 14876.107433554022, 29520.852395738744, 33223.501647474826, 33564.16089597682, 33629.0, 33895.32209355848, 35109.0, 35466.8226658865, 36321.27357452889, 37307.06732331605, 37794.24411511809, 8474.618642160995, 8726.345524085593, 8743.12568743146, 8755.124487551195, 8756.387052906235, 10675.519601618102, 10761.139108871428, 14139.929300353844, 14794.408223670933, 15338.693226135192, 12381.319027453577, 12455.439505222468, 12738.68153296175, 12771.169873958162, 12910.612681619567, 12648.557300494438, 12859.614211573667, 12873.678158046123, 12885.742285154058, 13842.58472245794, 10671.51978161, 11909.940450297692, 13286.53497127596, 13540.322983850965, 14039.50861719835, 8437.451565648213, 8663.436876603, 8691.608877600649, 8940.061293564082, 8947.507887066275, 13734.93132534331, 13857.237851917838, 13949.930250348683, 14221.502247421291, 14238.433772285247], "unit": "score", "name": "jquery.html", "value": 8136.008557935703}, {"lowerIsBetter": false, "replicates": [1179.4751335655626, 1380.1581035568304, 1381.088481602142, 1479.0328862612726, 1693.4580934101084, 5995.100734889763, 6584.045313429549, 6691.531592788507, 6694.6987385567645, 6708.127943367368, 6706.798796036114, 6723.428508576764, 6798.932010679891, 6823.317668233174, 6827.180738311409, 1736.2100244388773, 1770.964580708385, 2017.0519855667849, 2057.8765274083603, 2060.804223598763, 2032.2175962254564, 2057.77364489906, 2076.584683063386, 2078.023329035351, 2081.198738485686, 1986.3345779163997, 1989.1844343819037, 2016.5361966747657, 2032.5223572460459, 2038.164352615428, 2007.437917383135, 2026.7365242518451, 2049.569590386006, 2051.2205361962433, 2051.866628669132, 2059.4336557446823, 2084.781097984705, 2085.1346691123167, 2096.308218287961, 2101.044024968651, 6609.0416889551225, 6644.8671026579195, 6660.0, 6666.6333351665635, 6675.399214070757, 3942.7634341939574, 4000.0599859033105, 4011.0774521860135, 4015.1768887378307, 4018.2967980603275, 2539.2763062527274, 2656.907008254702, 2660.2418310781336, 2680.7051224365305, 2684.81206315558, 855.5593869157389, 907.1427501011481, 911.0889110889111, 1630.722777127891, 1639.0903048807907, 8926.821463570692, 8989.640414383417, 9023.413478123966, 9086.727398178065, 9121.543922803834, 3655.5065066216252, 3664.0656632558525, 3704.2961837250837, 3764.5858955514873, 3786.053486628343, 7914.485558438798, 7932.048154221415, 7933.246341597539, 7942.523448593103, 7965.442419030728, 4004.3392840181627, 4031.6169963853386, 4043.2317859606583, 4073.714839961174, 4078.3678529827926, 3722.1997270586953, 3725.5529336479794, 3726.347889119393, 3726.6646001859963, 3727.9254414912093, 2977.7320041196394, 3017.366353065881, 3050.527168288919, 3073.5389691546447, 3199.568058312145, 1042.499600191897, 1044.796264728386, 1053.773438710681, 1054.5623566219933, 1055.5672174408455, 861.9956900215459, 867.444835305405, 868.1318681318681, 901.4005686218723, 1007.8762180169059, 6410.8076757697345, 6534.640594767334, 6548.934510654928, 6559.8360040998405, 6572.671366431659, 986.3588667366126, 1005.1707341443339, 1020.433659319085, 1021.0963297481634, 1024.784795193003, 5117.232415137759, 5133.25567792668, 5136.563392111712, 5151.536361727388, 5159.74201289934, 7665.156832748393, 7837.09873364559, 7838.372930165573, 7851.175626559243, 7860.034991252187, 7876.566788826555, 7913.485623434458, 7954.801129971797, 7992.040955085311, 8024.839503209903, 6455.193100862392, 6464.515161362822, 6499.610023398705, 6517.185351831021, 6547.443467305237, 6208.255009398901, 6369.426751592379, 6380.872382552416, 6380.93619063822, 6383.1382763326355, 7344.30229128232, 7556.4710470266555, 7589.506682065648, 7649.388048956182, 7664.310212080716, 7247.601381923834, 7549.0941087069905, 7715.57564333967, 7715.92284077152, 7734.651940662796, 6518.57629254097, 6596.373344532261, 6600.53796234259, 6601.141851559267, 6611.537192396679, 5707.971460142839, 6178.135061091541, 6571.310012448624, 6669.09967154428, 6714.52998290115, 6098.634081955097, 6271.592346497463, 6286.779962701284, 6288.874222515616, 6393.904091438539, 5986.281646202309, 6088.847778805565, 6157.630542167484, 6213.347598502273, 6223.875522489616, 6039.758409663565, 6085.2393450818645, 6100.176476175659, 6251.624902505864, 6258.874822503615, 5805.564582656233, 5838.854028649148, 5842.649441033552, 5850.824475265749, 5857.765689372377, 5908.05471124618, 5951.226340575698, 5958.731857066356, 5961.165436838759, 5984.521238300838], "unit": "score", "name": "mootools.html", "value": 3969.8185511130227}, {"lowerIsBetter": false, "replicates": [288.19162249889064, 299.5312336193858, 302.1841029221103, 306.0970138092626, 306.2848249337796, 5191.896162076756, 5278.36659600848, 5286.709230992294, 5455.863603409907, 5467.261919640857, 5257.1851363038695, 5329.866753331169, 5336.733163341837, 5339.439358867321, 5343.973280133604, 3881.4954055972685, 4148.917021659565, 4151.875443736678, 4152.294110001307, 4157.210130075291, 3971.8481640324417, 3980.383040628707, 4034.919301613966, 4035.778032208227, 4049.5545489996075, 3989.122393073519, 4013.6387725104737, 4019.0354314964343, 4023.6781057515327, 4026.4966879140106, 3853.8843834684726, 3927.450156977997, 3930.6265904739003, 4056.533498647649, 4061.614146656063, 3471.5660542432197, 3471.704905083071, 3472.2708231271463, 3488.2849015951924, 3508.105433114565, 5085.084684756743, 5117.257997590365, 5118.564921981636, 5136.383633963911, 5148.124818780816, 4641.559051890065, 4644.512326205768, 4648.721076735373, 4651.441826980784, 4654.69744466612, 5308.575313974873, 5481.232627432163, 5515.4760297771645, 5524.779008839641, 5532.197831314437, 3854.9229015419814, 3892.6496615304477, 3893.3186692328727, 3894.766314021168, 3895.2404281165186, 5764.942350576483, 5823.097419899922, 5830.562707796932, 5839.357670656224, 5842.649441033552, 3928.4107383892647, 3950.1704642025497, 3954.367301231789, 3955.4660120883887, 3961.980190099031, 3917.6278253565865, 4023.5775243599587, 4024.7987600620436, 4027.677785777131, 4029.073313137995, 4594.931076033795, 4602.194615942197, 4607.9078418431445, 4611.838585649486, 4612.838550650711, 5557.36090349615, 5559.527440167631, 5560.165975103686, 5566.805161819317, 5580.2466666999435, 1397.175666356834, 1413.8586141385986, 1413.9929300353638, 1415.497498388078, 1415.5187236339693, 943.4339396362128, 944.1172503709054, 946.8674385586023, 984.389678399397, 992.4888682328607, 4864.562189402971, 4879.1461494238365, 4882.194437917775, 4882.389701287339, 4884.072026314989, 5765.221695071112, 5771.7114144293455, 5772.682502462405, 5778.017736984639, 5778.219940308005, 4858.514148585184, 4866.902661946741, 4867.123917694778, 4868.391451068616, 4874.073925954058, 3033.5904652872023, 3083.3370825272673, 3090.4128215638957, 3106.409782141386, 3137.231378312328, 5525.392206857243, 5527.977324195037, 5528.143137813645, 5529.364123125892, 5534.723263836792, 5985.22192115031, 5994.37059108796, 5996.880062398727, 5999.280086389661, 6000.909986350208, 5526.806561770319, 5534.418886017072, 5538.529225015919, 5540.667559946416, 5544.889102218014, 5655.179998900054, 5825.82522524308, 5829.562782791223, 5835.7373918174635, 5839.766409343579, 5703.08750599902, 5708.429157084424, 5710.885782284248, 5714.571407144397, 5716.828495145152, 5524.613277070566, 5526.806561770319, 5529.253550770755, 5531.0873705838085, 5534.7786088556, 3845.6731177850197, 3975.5428125765907, 4010.779407132519, 4015.598440155961, 4016.096378314856, 5747.74135163927, 5748.396418376177, 5754.53963682896, 5758.4817366435545, 5758.481736643722, 5551.528120109836, 5558.944410555842, 5560.36055853582, 5562.360328562268, 5568.638038527482, 5520.889582208413, 5546.223528705904, 5548.306461692288, 5553.500184983371, 5556.555475561864, 5253.106971814725, 5443.755031023693, 5458.781648734006, 5466.1527463243265, 5474.452554744494, 5395.757190926496, 5570.6657600544095, 5646.632968857011, 5649.604527683023, 5654.85862853432, 5291.9206211906085, 5428.4842939920645, 5460.781568737365, 5469.480399362054, 5469.890602188014], "unit": "score", "name": "prototype.html", "value": 4168.465996170754}, {"lowerIsBetter": false, "replicates": [768.0783060327608, 773.7021246819975, 776.1152286393516, 783.4554984285921, 793.4128744728895, 12659.683507912296, 12786.808197877039, 12961.740765184692, 13189.406476708547, 13321.666958326046, 13147.145435546683, 13204.471821127143, 13221.0, 13223.801642975339, 13236.139650922707, 605.9394060593927, 615.151091493738, 766.7776344859984, 767.4896194030963, 776.3944123583614, 748.4237137404195, 758.4501236603473, 762.572959142879, 768.4966347042696, 769.6613490064382, 811.9634616442245, 812.959352032396, 817.6933649881295, 817.9713710020151, 818.3207937411963, 625.6371304643296, 635.5773410681891, 792.4215322814377, 807.5074204735137, 809.1503920883049, 597.6682940967761, 598.7126179433852, 598.9161517387569, 598.9341172471024, 598.9371116032797, 12331.630051098482, 12342.197757145757, 12477.812832807514, 12477.937610311981, 12487.06347023977, 10690.251682382237, 10905.727356816144, 10959.12327013837, 11124.443777811077, 11184.776304473946, 9107.316951228684, 9130.223930965876, 9260.305477089245, 9364.57859396322, 9431.811363772686, 3134.8746050157965, 3141.607299087614, 3154.984225078883, 3158.478850989607, 3175.2220705926966, 38603.420948685794, 38815.61184388148, 39065.41401878974, 39845.402318965236, 40042.0, 8517.105703901125, 8600.225979661735, 8664.220220180088, 8690.0, 8766.21104100634, 15244.390224391122, 15258.923705381623, 15293.0, 15304.234788260543, 15315.923420382827, 5808.186853840466, 5867.647941123546, 5918.674472904032, 5922.318933322636, 5925.051991681396, 3299.0762586475826, 3350.748693847971, 3357.1439282982683, 3392.525046493493, 3438.5014172945284, 2539.5174916765754, 2587.1462417402213, 2591.6630837990942, 2593.066496061454, 2593.81843270973, 470.05753464303854, 471.96460265480226, 477.79454834420835, 484.62925861715814, 485.8833879868806, 475.20517973646076, 491.5551425959512, 492.72653677208774, 546.6337553838858, 571.7912961768924, 6967.721291148398, 7132.0015197872335, 7895.171007044292, 7992.320652744465, 8278.296344810638, 463.84924899407827, 477.28883962895037, 517.2241637543684, 530.2602868997803, 581.6045089339206, 3423.2297733009873, 3432.622411534729, 3493.825308734553, 3575.910602234913, 3585.6772890439984, 45795.16819327256, 46800.7659961698, 47175.292370614465, 47299.0, 47312.0, 42537.78731106387, 42603.14793704109, 42808.0, 42952.0, 43124.78437607855, 37567.62432375696, 38404.23191536098, 38408.8079559606, 38447.80776096102, 39241.41137882934, 7179.8564028720175, 7180.246074162138, 7253.057102576631, 7426.554406735613, 8057.919420805952, 29763.55354669725, 29773.0, 30764.69235307618, 31071.0, 31220.0, 35770.8211458941, 36781.08047298839, 36905.81547092248, 37710.62289377071, 37840.81079594584, 9467.20378490181, 9578.425294482353, 9641.855372169282, 9692.22462203008, 9825.754356141153, 10218.846717299099, 10225.897741022494, 10364.326318789255, 10954.178436617445, 10993.835092473459, 9801.0, 10166.339187953055, 10219.591216351262, 10345.27583069208, 10592.682219533426, 9817.509124543602, 10102.242331824995, 10135.594576216869, 10173.949130254598, 10248.538815753458, 8760.255378292917, 9192.724218273463, 10231.386116833013, 10334.896651033394, 10364.533595988349, 8531.872021919551, 8597.785055373666, 8657.52383618907, 8773.561321934005, 9078.818423631623, 8699.173578510032, 8866.822663546822, 8944.955275223581, 9003.819923601623, 9089.772755680897], "unit": "score", "name": "yui.html", "value": 5510.757241867269}], "name": "dromaeo_css", "value": 6133.818963633706}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 108.0, 114.0, 113.0, 115.0, 104.0, 115.0, 113.0, 105.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [160.0, 129.0, 151.0, 169.0, 138.0, 154.0, 160.0, 133.0, 173.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 161.0, 163.0, 160.0, 161.0, 161.0, 161.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 83.0, 92.0, 73.0, 72.0, 72.0, 96.0, 87.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.5}, {"lowerIsBetter": true, "replicates": [98.0, 98.0, 136.0, 97.0, 97.0, 97.0, 135.0, 98.0, 97.0, 144.0], "unit": "score", "name": "audio-oscillator", "value": 109.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 148.0, 148.0, 148.0, 148.0, 146.0, 147.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 73.0, 72.0, 71.0, 72.0, 73.0, 81.0, 69.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 72.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 83.0, 84.0, 84.0, 91.0, 84.0, 83.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [122.0, 118.0, 127.0, 117.0, 119.0, 128.0, 129.0, 125.0, 131.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [139.0, 138.0, 157.0, 150.0, 153.0, 140.0, 152.0, 145.0, 149.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.6}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 75.0, 72.0, 72.0, 70.0, 70.0, 73.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.1}], "name": "kraken", "value": 1530.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.11295681063123], "unit": "score", "name": "Richards", "value": 212.51804000000004}, {"lowerIsBetter": false, "replicates": [187.33608092918695], "unit": "score", "name": "DeltaBlue", "value": 352.9378840000001}, {"lowerIsBetter": false, "replicates": [277.623542476402], "unit": "score", "name": "Encrypt", "value": 958.7839620000002}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [805.8017727639001], "unit": "score", "name": "Earley", "value": 827.0805830000004}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [610.1281269066504], "unit": "score", "name": "Splay", "value": 133.56374900000003}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19744.78437427821}]} 05:42:42 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19744.78"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1530.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6133.82"}}} 05:42:42 INFO - Return code: 0 05:42:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:42:42 INFO - # TBPL SUCCESS # 05:42:42 INFO - Running post-action listener: _resource_record_post_action 05:42:42 INFO - Running post-run listener: _resource_record_post_run 05:42:43 INFO - Total resource usage - Wall time: 1236s; CPU: 13.0%; Read bytes: 0; Write bytes: 555954176; Read time: 0; Write time: 571624 05:42:43 INFO - install - Wall time: 16s; CPU: 15.0%; Read bytes: 0; Write bytes: 238649344; Read time: 0; Write time: 364176 05:42:43 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 0; Write bytes: 317304832; Read time: 0; Write time: 207448 05:42:43 INFO - Running post-run listener: _upload_blobber_files 05:42:43 INFO - Blob upload gear active. 05:42:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:42:43 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:42:43 INFO - (blobuploader) - INFO - Open directory for files ... 05:42:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:42:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:42:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:44 INFO - (blobuploader) - INFO - Done attempting. 05:42:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:42:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:42:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:42:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:42:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:42:45 INFO - (blobuploader) - INFO - Done attempting. 05:42:45 INFO - (blobuploader) - INFO - Iteration through files over. 05:42:45 INFO - Return code: 0 05:42:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:42:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:42:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbce976af1399344c0bfc985432d09d2aaeb7390cf2961ddd1675dcdecf1ea7f93517d8b0343dd12bcf14359b54e82e8bb2aa7e5dc258a9f8b66f7d79b6e88a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/968c9225c593729cbca81ab34ad7885de2579b3144e983913a5c474fc0d8043e276ce1c18cd128aecdf58f97e11c8e45cfabcb96a39cfa61b786d1d8fef8a5c9"} 05:42:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:42:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:42:45 INFO - Contents: 05:42:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbce976af1399344c0bfc985432d09d2aaeb7390cf2961ddd1675dcdecf1ea7f93517d8b0343dd12bcf14359b54e82e8bb2aa7e5dc258a9f8b66f7d79b6e88a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/968c9225c593729cbca81ab34ad7885de2579b3144e983913a5c474fc0d8043e276ce1c18cd128aecdf58f97e11c8e45cfabcb96a39cfa61b786d1d8fef8a5c9"} 05:42:45 INFO - Copying logs to upload dir... 05:42:45 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.618401 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-07 05:42:45.325697) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 05:42:45.329273) ========= 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=4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbce976af1399344c0bfc985432d09d2aaeb7390cf2961ddd1675dcdecf1ea7f93517d8b0343dd12bcf14359b54e82e8bb2aa7e5dc258a9f8b66f7d79b6e88a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/968c9225c593729cbca81ab34ad7885de2579b3144e983913a5c474fc0d8043e276ce1c18cd128aecdf58f97e11c8e45cfabcb96a39cfa61b786d1d8fef8a5c9"} build_url:https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011438 build_url: 'https://queue.taskcluster.net/v1/task/ASvWth5tSAur8DNN92HALA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cbce976af1399344c0bfc985432d09d2aaeb7390cf2961ddd1675dcdecf1ea7f93517d8b0343dd12bcf14359b54e82e8bb2aa7e5dc258a9f8b66f7d79b6e88a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/968c9225c593729cbca81ab34ad7885de2579b3144e983913a5c474fc0d8043e276ce1c18cd128aecdf58f97e11c8e45cfabcb96a39cfa61b786d1d8fef8a5c9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-07 05:42:45.356272) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:42:45.356913) ========= 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=4dd8011cc2821079d74a932a000001ae-1452172828.661082-1237268218 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-07 05:42:45.438263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 05:42:45.438623) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-07 05:42:45.438988) ========= ========= Total master_lag: 0.26 =========