builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-041 starttime: 1451580864.81 results: success (0) buildid: 20151231081838 builduid: fe02c224ae42403a8ad633a6be7bae97 revision: ff863d8cdf7ad551bc4843e3614e09236400a6da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.811667) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.812220) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.812556) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006448 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.873399) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.873735) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.945170) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.945485) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004579 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.997444) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.997754) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.998191) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:24.998551) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 08:54:25-- 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% 43.9M=0s 2015-12-31 08:54:25 (43.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.109124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:25.128557) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:25.128920) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022414 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:25.179100) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:25.179546) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev ff863d8cdf7ad551bc4843e3614e09236400a6da --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 ff863d8cdf7ad551bc4843e3614e09236400a6da --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=7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 08:54:25,431 truncating revision to first 12 chars 2015-12-31 08:54:25,431 Setting DEBUG logging. 2015-12-31 08:54:25,432 attempt 1/10 2015-12-31 08:54:25,432 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/ff863d8cdf7a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 08:54:25,779 unpacking tar archive at: fx-team-ff863d8cdf7a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615584 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:25.810874) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:25.811239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:25.829868) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:25.830240) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 08:54:25.830769) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-31 08:54:25.831160) ========= /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=7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:54:26 INFO - MultiFileLogger online at 20151231 08:54:26 in /builds/slave/test 08:54:26 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 08:54:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:54:26 INFO - {'append_to_log': False, 08:54:26 INFO - 'base_work_dir': '/builds/slave/test', 08:54:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:54:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:54:26 INFO - 'branch': 'Fx-Team-Non-PGO', 08:54:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:54:26 INFO - 'config_files': ('talos/linux_config.py',), 08:54:26 INFO - 'default_actions': ('clobber', 08:54:26 INFO - 'read-buildbot-config', 08:54:26 INFO - 'download-and-extract', 08:54:26 INFO - 'populate-webroot', 08:54:26 INFO - 'create-virtualenv', 08:54:26 INFO - 'install', 08:54:26 INFO - 'run-tests'), 08:54:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:54:26 INFO - 'download_minidump_stackwalk': True, 08:54:26 INFO - 'download_symbols': 'ondemand', 08:54:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:54:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:54:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:54:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:54:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:54:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:54:26 INFO - 'installer_path': 'installer.exe', 08:54:26 INFO - 'log_level': 'info', 08:54:26 INFO - 'log_name': 'talos', 08:54:26 INFO - 'log_to_console': True, 08:54:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:54:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:54:26 INFO - 'opt_config_files': (), 08:54:26 INFO - 'pip_index': False, 08:54:26 INFO - 'sps_profile': False, 08:54:26 INFO - 'sps_profile_interval': 0, 08:54:26 INFO - 'suite': 'dromaeojs', 08:54:26 INFO - 'system_bits': '32', 08:54:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:54:26 INFO - 'title': 'talos-linux64-ix-041', 08:54:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:54:26 INFO - 'use_talos_json': True, 08:54:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:54:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:54:26 INFO - 'work_dir': 'build'} 08:54:26 INFO - ##### 08:54:26 INFO - ##### Running clobber step. 08:54:26 INFO - ##### 08:54:26 INFO - Running pre-action listener: _resource_record_pre_action 08:54:26 INFO - Running main action method: clobber 08:54:26 INFO - rmtree: /builds/slave/test/build 08:54:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:54:26 INFO - Running post-action listener: _resource_record_post_action 08:54:26 INFO - ##### 08:54:26 INFO - ##### Running read-buildbot-config step. 08:54:26 INFO - ##### 08:54:26 INFO - Running pre-action listener: _resource_record_pre_action 08:54:26 INFO - Running main action method: read_buildbot_config 08:54:26 INFO - Using buildbot properties: 08:54:26 INFO - { 08:54:26 INFO - "project": "", 08:54:26 INFO - "product": "firefox", 08:54:26 INFO - "script_repo_revision": "production", 08:54:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:54:26 INFO - "repository": "", 08:54:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:54:26 INFO - "buildid": "20151231081838", 08:54:26 INFO - "pgo_build": "False", 08:54:26 INFO - "basedir": "/builds/slave/test", 08:54:26 INFO - "buildnumber": 2274, 08:54:26 INFO - "slavename": "talos-linux64-ix-041", 08:54:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:54:26 INFO - "platform": "ubuntu64_hw", 08:54:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:54:26 INFO - "branch": "fx-team", 08:54:26 INFO - "repo_path": "integration/fx-team", 08:54:26 INFO - "revision": "ff863d8cdf7ad551bc4843e3614e09236400a6da", 08:54:26 INFO - "stage_platform": "linux64", 08:54:26 INFO - "builduid": "fe02c224ae42403a8ad633a6be7bae97", 08:54:26 INFO - "slavebuilddir": "test" 08:54:26 INFO - } 08:54:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 08:54:26 INFO - Running post-action listener: _resource_record_post_action 08:54:26 INFO - ##### 08:54:26 INFO - ##### Running download-and-extract step. 08:54:26 INFO - ##### 08:54:26 INFO - Running pre-action listener: _resource_record_pre_action 08:54:26 INFO - Running main action method: download_and_extract 08:54:26 INFO - mkdir: /builds/slave/test/build/tests 08:54: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')]} 08:54:26 INFO - https://queue.taskcluster.net/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 08:54:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/test_packages.json 08:54:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/test_packages.json 08:54:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 08:54:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 08:54:28 INFO - Downloaded 1302 bytes. 08:54:28 INFO - Reading from file /builds/slave/test/build/test_packages.json 08:54:28 INFO - Using the following test package requirements: 08:54:28 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:54:28 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:54:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:54:28 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:54:28 INFO - u'jsshell-linux-x86_64.zip'], 08:54:28 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:54:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:54:28 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:54:28 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:54:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:54:28 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:54:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:54:28 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:54:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:54:28 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 08:54:28 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 08:54:28 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:54:28 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:54:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:28 INFO - https://queue.taskcluster.net/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:54:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:54:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:54:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/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 08:54:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/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 08:54:29 INFO - Downloaded 21946183 bytes. 08:54:29 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 08:54:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:54:29 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 08:54:30 INFO - Return code: 0 08:54:30 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 08:54:30 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')]} 08:54:30 INFO - https://queue.taskcluster.net/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:54:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:54:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:54:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/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 08:54:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/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 08:54:32 INFO - Downloaded 21946183 bytes. 08:54:32 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 08:54:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 08:54:32 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 08:54:33 INFO - Return code: 0 08:54:33 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')]} 08:54:33 INFO - https://queue.taskcluster.net/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:54:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:54:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:54:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/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 08:54:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/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 08:54:34 INFO - Downloaded 11132285 bytes. 08:54:34 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 08:54:34 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 08:54:34 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 08:54:34 INFO - Return code: 0 08:54:34 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')]} 08:54:34 INFO - https://queue.taskcluster.net/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:54:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:54:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:54:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/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 08:54:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LiViTvU2QeuOk62av5h7xw/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 08:54:37 INFO - Downloaded 53361197 bytes. 08:54:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:54:37 INFO - mkdir: /builds/slave/test/properties 08:54:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:54:37 INFO - Writing to file /builds/slave/test/properties/build_url 08:54:37 INFO - Contents: 08:54:37 INFO - build_url:https://queue.taskcluster.net/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 08:54:37 INFO - Running post-action listener: _resource_record_post_action 08:54:37 INFO - Running post-action listener: set_extra_try_arguments 08:54:37 INFO - ##### 08:54:37 INFO - ##### Running populate-webroot step. 08:54:37 INFO - ##### 08:54:37 INFO - Running pre-action listener: _resource_record_pre_action 08:54:37 INFO - Running main action method: populate_webroot 08:54:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:54:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:54:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:54:37 INFO - '--tppagecycles', 08:54:37 INFO - '7'], 08:54:37 INFO - 'tests': ['tsvgm']}}, 08:54:37 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 08:54:37 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 08:54:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:54:37 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:54:37 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 08:54:37 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 08:54:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'talos_options': ['--e10s'], 08:54:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'tests': ['damp', 'tps']}, 08:54:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'talos_options': ['--e10s'], 08:54:37 INFO - 'tests': ['damp', 'tps']}, 08:54:37 INFO - 'g3': {'tests': ['dromaeo_dom']}, 08:54:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:54:37 INFO - 'other': {'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore']}, 08:54:37 INFO - 'other-e10s': {'talos_options': ['--e10s'], 08:54:37 INFO - 'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore']}, 08:54:37 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 08:54:37 INFO - 'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore']}, 08:54:37 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 08:54:37 INFO - 'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore']}, 08:54:37 INFO - 'other_l64': {'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore']}, 08:54:37 INFO - 'other_nol64': {'tests': ['a11yr', 08:54:37 INFO - 'ts_paint', 08:54:37 INFO - 'tpaint', 08:54:37 INFO - 'sessionrestore', 08:54:37 INFO - 'sessionrestore_no_auto_restore']}, 08:54:37 INFO - 'svgr': {'tests': ['tsvgx', 08:54:37 INFO - 'tsvgr_opacity', 08:54:37 INFO - 'tart', 08:54:37 INFO - 'tscrollx', 08:54:37 INFO - 'cart']}, 08:54:37 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 08:54:37 INFO - 'tests': ['tsvgx', 08:54:37 INFO - 'tsvgr_opacity', 08:54:37 INFO - 'tart', 08:54:37 INFO - 'tscrollx', 08:54:37 INFO - 'cart']}, 08:54:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'tests': ['tp5o']}, 08:54:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'talos_options': ['--e10s'], 08:54:37 INFO - 'tests': ['tp5o']}, 08:54:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'talos_options': ['--xperf_path', 08:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:37 INFO - 'tests': ['tp5n']}, 08:54:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:54:37 INFO - 'talos_options': ['--e10s', 08:54:37 INFO - '--xperf_path', 08:54:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:37 INFO - 'tests': ['tp5n']}}, 08:54:37 INFO - 'talos.zip': {'path': '', 08:54:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:54:37 INFO - Running post-action listener: _resource_record_post_action 08:54:37 INFO - ##### 08:54:37 INFO - ##### Running create-virtualenv step. 08:54:37 INFO - ##### 08:54:37 INFO - Running pre-action listener: _resource_record_pre_action 08:54:37 INFO - Running main action method: create_virtualenv 08:54:37 INFO - Creating virtualenv /builds/slave/test/build/venv 08:54:37 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 08:54:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:54:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:54:37 INFO - Using real prefix '/usr' 08:54:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:54:37 INFO - Installing distribute.............................................................................................................................................................................................done. 08:54:39 INFO - Installing pip.................done. 08:54:39 INFO - Return code: 0 08:54:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:54: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')]} 08:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:39 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 0x7fca97485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac3d0>, '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 0x2917ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2918360>, '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': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', '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 08:54:39 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 08:54:39 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 08:54:39 INFO - Using env: {'DISPLAY': ':0', 08:54:39 INFO - 'HOME': '/home/cltbld', 08:54:39 INFO - 'LANG': 'en_US.UTF-8', 08:54:39 INFO - 'LANGUAGE': 'en_US:en', 08:54:39 INFO - 'LOGNAME': 'cltbld', 08:54:39 INFO - 'MAIL': '/var/mail/cltbld', 08:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:39 INFO - 'MOZ_NO_REMOTE': '1', 08:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:39 INFO - 'NO_EM_RESTART': '1', 08:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:39 INFO - 'PWD': '/builds/slave/test', 08:54:39 INFO - 'SHELL': '/bin/bash', 08:54:39 INFO - 'SHLVL': '1', 08:54:39 INFO - 'TERM': 'linux', 08:54:39 INFO - 'TMOUT': '86400', 08:54:39 INFO - 'USER': 'cltbld', 08:54:39 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', 08:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:39 INFO - '_': '/tools/buildbot/bin/python'} 08:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:40 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 08:54:40 INFO - Cleaning up... 08:54:40 INFO - Return code: 0 08:54:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:40 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 0x7fca97485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac3d0>, '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 0x2917ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2918360>, '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': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', '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 08:54:40 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 08:54:40 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 08:54:40 INFO - Using env: {'DISPLAY': ':0', 08:54:40 INFO - 'HOME': '/home/cltbld', 08:54:40 INFO - 'LANG': 'en_US.UTF-8', 08:54:40 INFO - 'LANGUAGE': 'en_US:en', 08:54:40 INFO - 'LOGNAME': 'cltbld', 08:54:40 INFO - 'MAIL': '/var/mail/cltbld', 08:54:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:40 INFO - 'MOZ_NO_REMOTE': '1', 08:54:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:40 INFO - 'NO_EM_RESTART': '1', 08:54:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:40 INFO - 'PWD': '/builds/slave/test', 08:54:40 INFO - 'SHELL': '/bin/bash', 08:54:40 INFO - 'SHLVL': '1', 08:54:40 INFO - 'TERM': 'linux', 08:54:40 INFO - 'TMOUT': '86400', 08:54:40 INFO - 'USER': 'cltbld', 08:54:40 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', 08:54:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:40 INFO - '_': '/tools/buildbot/bin/python'} 08:54:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:40 INFO - Downloading/unpacking psutil>=0.7.1 08:54:40 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 08:54:40 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 08:54:40 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 08:54:40 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 08:54:40 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 08:54:40 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 08:54:41 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 08:54:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 08:54:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:42 INFO - Installing collected packages: psutil 08:54:42 INFO - Running setup.py install for psutil 08:54:42 INFO - building 'psutil._psutil_linux' extension 08:54:42 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 08:54:42 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 08:54:42 INFO - building 'psutil._psutil_posix' extension 08:54:42 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 08:54:42 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 08:54:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:42 INFO - Successfully installed psutil 08:54:42 INFO - Cleaning up... 08:54:42 INFO - Return code: 0 08:54:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:42 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 0x7fca97485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac3d0>, '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 0x2917ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2918360>, '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': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', '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 08:54:42 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 08:54:42 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 08:54:42 INFO - Using env: {'DISPLAY': ':0', 08:54:42 INFO - 'HOME': '/home/cltbld', 08:54:42 INFO - 'LANG': 'en_US.UTF-8', 08:54:42 INFO - 'LANGUAGE': 'en_US:en', 08:54:42 INFO - 'LOGNAME': 'cltbld', 08:54:42 INFO - 'MAIL': '/var/mail/cltbld', 08:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:42 INFO - 'MOZ_NO_REMOTE': '1', 08:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:42 INFO - 'NO_EM_RESTART': '1', 08:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:42 INFO - 'PWD': '/builds/slave/test', 08:54:42 INFO - 'SHELL': '/bin/bash', 08:54:42 INFO - 'SHLVL': '1', 08:54:42 INFO - 'TERM': 'linux', 08:54:42 INFO - 'TMOUT': '86400', 08:54:42 INFO - 'USER': 'cltbld', 08:54:42 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', 08:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:42 INFO - '_': '/tools/buildbot/bin/python'} 08:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:54:42 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 08:54:42 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 08:54:42 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 08:54:42 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 08:54:42 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 08:54:42 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 08:54:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:54:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 08:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:54:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:54:44 INFO - Installing collected packages: mozsystemmonitor 08:54:44 INFO - Running setup.py install for mozsystemmonitor 08:54:44 INFO - Successfully installed mozsystemmonitor 08:54:44 INFO - Cleaning up... 08:54:44 INFO - Return code: 0 08:54:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:44 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 0x7fca97485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac3d0>, '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 0x2917ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2918360>, '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': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', '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 08:54:44 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 08:54:44 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 08:54:44 INFO - Using env: {'DISPLAY': ':0', 08:54:44 INFO - 'HOME': '/home/cltbld', 08:54:44 INFO - 'LANG': 'en_US.UTF-8', 08:54:44 INFO - 'LANGUAGE': 'en_US:en', 08:54:44 INFO - 'LOGNAME': 'cltbld', 08:54:44 INFO - 'MAIL': '/var/mail/cltbld', 08:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:44 INFO - 'MOZ_NO_REMOTE': '1', 08:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:44 INFO - 'NO_EM_RESTART': '1', 08:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:44 INFO - 'PWD': '/builds/slave/test', 08:54:44 INFO - 'SHELL': '/bin/bash', 08:54:44 INFO - 'SHLVL': '1', 08:54:44 INFO - 'TERM': 'linux', 08:54:44 INFO - 'TMOUT': '86400', 08:54:44 INFO - 'USER': 'cltbld', 08:54:44 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', 08:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:44 INFO - '_': '/tools/buildbot/bin/python'} 08:54:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:44 INFO - Downloading/unpacking blobuploader==1.2.4 08:54:44 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 08:54:44 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 08:54:44 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 08:54:44 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 08:54:44 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 08:54:44 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 08:54:46 INFO - Downloading blobuploader-1.2.4.tar.gz 08:54:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 08:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:54:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:54:46 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 08:54:46 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 08:54:46 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 08:54:46 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 08:54:46 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 08:54:46 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 08:54:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 08:54:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:54:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:54:47 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 08:54:47 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 08:54:47 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 08:54:47 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 08:54:47 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 08:54:47 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 08:54:47 INFO - Downloading docopt-0.6.1.tar.gz 08:54:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 08:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:54:47 INFO - Installing collected packages: blobuploader, requests, docopt 08:54:47 INFO - Running setup.py install for blobuploader 08:54:47 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:54:47 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:54:47 INFO - Running setup.py install for requests 08:54:47 INFO - Running setup.py install for docopt 08:54:47 INFO - Successfully installed blobuploader requests docopt 08:54:47 INFO - Cleaning up... 08:54:47 INFO - Return code: 0 08:54:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54: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')]} 08:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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')]} 08:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:47 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 0x7fca97485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac3d0>, '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 0x2917ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2918360>, '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': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', '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 08:54:47 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 08:54:47 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 08:54:47 INFO - Using env: {'DISPLAY': ':0', 08:54:47 INFO - 'HOME': '/home/cltbld', 08:54:47 INFO - 'LANG': 'en_US.UTF-8', 08:54:47 INFO - 'LANGUAGE': 'en_US:en', 08:54:47 INFO - 'LOGNAME': 'cltbld', 08:54:47 INFO - 'MAIL': '/var/mail/cltbld', 08:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:47 INFO - 'MOZ_NO_REMOTE': '1', 08:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:47 INFO - 'NO_EM_RESTART': '1', 08:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:47 INFO - 'PWD': '/builds/slave/test', 08:54:47 INFO - 'SHELL': '/bin/bash', 08:54:47 INFO - 'SHLVL': '1', 08:54:47 INFO - 'TERM': 'linux', 08:54:47 INFO - 'TMOUT': '86400', 08:54:47 INFO - 'USER': 'cltbld', 08:54:47 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', 08:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:47 INFO - '_': '/tools/buildbot/bin/python'} 08:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:48 INFO - Running setup.py (path:/tmp/pip-blNJt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:48 INFO - Running setup.py (path:/tmp/pip-OC0XUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:48 INFO - Running setup.py (path:/tmp/pip-rFG_yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:48 INFO - Running setup.py (path:/tmp/pip-lgkQnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:48 INFO - Running setup.py (path:/tmp/pip-ynLbOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:48 INFO - Running setup.py (path:/tmp/pip-txKFwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:48 INFO - Running setup.py (path:/tmp/pip-e0_XHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:48 INFO - Running setup.py (path:/tmp/pip-bGiXxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:48 INFO - Running setup.py (path:/tmp/pip-NpOd2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:48 INFO - Running setup.py (path:/tmp/pip-YeV6rS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:48 INFO - Running setup.py (path:/tmp/pip-6cPovw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:48 INFO - Running setup.py (path:/tmp/pip-I_m5HC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:49 INFO - Running setup.py (path:/tmp/pip-PNwENG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:49 INFO - Running setup.py (path:/tmp/pip-uL8oCz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:49 INFO - Running setup.py (path:/tmp/pip-suHm4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:49 INFO - Running setup.py (path:/tmp/pip-yLoucM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:49 INFO - Running setup.py (path:/tmp/pip-vtfONH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:54:49 INFO - Running setup.py install for manifestparser 08:54:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:54:49 INFO - Running setup.py install for mozcrash 08:54:49 INFO - Running setup.py install for mozdebug 08:54:49 INFO - Running setup.py install for mozdevice 08:54:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:54:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:54:49 INFO - Running setup.py install for mozfile 08:54:49 INFO - Running setup.py install for mozhttpd 08:54:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:54:49 INFO - Running setup.py install for mozinfo 08:54:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Running setup.py install for mozInstall 08:54:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Running setup.py install for mozleak 08:54:50 INFO - Running setup.py install for mozlog 08:54:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Running setup.py install for moznetwork 08:54:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Running setup.py install for mozprocess 08:54:50 INFO - Running setup.py install for mozprofile 08:54:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Running setup.py install for mozrunner 08:54:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:54:50 INFO - Running setup.py install for mozscreenshot 08:54:50 INFO - Running setup.py install for moztest 08:54:51 INFO - Running setup.py install for mozversion 08:54:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:54:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:54:51 INFO - Cleaning up... 08:54:51 INFO - Return code: 0 08:54:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fca97485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac3d0>, '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 0x2917ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2918360>, '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': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', '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 08:54:51 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 08:54:51 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 08:54:51 INFO - Using env: {'DISPLAY': ':0', 08:54:51 INFO - 'HOME': '/home/cltbld', 08:54:51 INFO - 'LANG': 'en_US.UTF-8', 08:54:51 INFO - 'LANGUAGE': 'en_US:en', 08:54:51 INFO - 'LOGNAME': 'cltbld', 08:54:51 INFO - 'MAIL': '/var/mail/cltbld', 08:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:51 INFO - 'MOZ_NO_REMOTE': '1', 08:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:51 INFO - 'NO_EM_RESTART': '1', 08:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:51 INFO - 'PWD': '/builds/slave/test', 08:54:51 INFO - 'SHELL': '/bin/bash', 08:54:51 INFO - 'SHLVL': '1', 08:54:51 INFO - 'TERM': 'linux', 08:54:51 INFO - 'TMOUT': '86400', 08:54:51 INFO - 'USER': 'cltbld', 08:54:51 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', 08:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:51 INFO - '_': '/tools/buildbot/bin/python'} 08:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:51 INFO - Running setup.py (path:/tmp/pip-F5pfXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:51 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)) 08:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:51 INFO - Running setup.py (path:/tmp/pip-_QY6Ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:51 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)) 08:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:51 INFO - Running setup.py (path:/tmp/pip-YOLRjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:51 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)) 08:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:51 INFO - Running setup.py (path:/tmp/pip-EGh9c4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:51 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)) 08:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:51 INFO - Running setup.py (path:/tmp/pip-eOBrtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:51 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)) 08:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:51 INFO - Running setup.py (path:/tmp/pip-GKHHVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:51 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)) 08:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:51 INFO - Running setup.py (path:/tmp/pip-q_V_X1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:51 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)) 08:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:51 INFO - Running setup.py (path:/tmp/pip-DV__D7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:51 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)) 08:54:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:51 INFO - Running setup.py (path:/tmp/pip-WR68B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:52 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)) 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:52 INFO - Running setup.py (path:/tmp/pip-sHt7k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:52 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)) 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:52 INFO - Running setup.py (path:/tmp/pip-jfmarI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:52 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)) 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:52 INFO - Running setup.py (path:/tmp/pip-mCDZNU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:52 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)) 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:52 INFO - Running setup.py (path:/tmp/pip-JJxIEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:52 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)) 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:52 INFO - Running setup.py (path:/tmp/pip-NLvaJ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:52 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)) 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:52 INFO - Running setup.py (path:/tmp/pip-45Libn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:52 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)) 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:52 INFO - Running setup.py (path:/tmp/pip-IJYuvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:52 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)) 08:54:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:52 INFO - Running setup.py (path:/tmp/pip-eS2Inf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:52 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)) 08:54:52 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)) 08:54:52 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)) 08:54:52 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)) 08:54:52 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)) 08:54:52 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)) 08:54:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:54 INFO - Downloading blessings-1.5.1.tar.gz 08:54:54 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 08:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:54:54 INFO - Installing collected packages: blessings 08:54:54 INFO - Running setup.py install for blessings 08:54:54 INFO - Successfully installed blessings 08:54:54 INFO - Cleaning up... 08:54:54 INFO - Return code: 0 08:54:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:54:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:54 INFO - Reading from file tmpfile_stdout 08:54:54 INFO - Current package versions: 08:54:54 INFO - argparse == 1.2.1 08:54:54 INFO - blessings == 1.5.1 08:54:54 INFO - blobuploader == 1.2.4 08:54:54 INFO - docopt == 0.6.1 08:54:54 INFO - manifestparser == 1.1 08:54:54 INFO - mozInstall == 1.12 08:54:54 INFO - mozcrash == 0.16 08:54:54 INFO - mozdebug == 0.1 08:54:54 INFO - mozdevice == 0.47 08:54:54 INFO - mozfile == 1.2 08:54:54 INFO - mozhttpd == 0.7 08:54:54 INFO - mozinfo == 0.9 08:54:54 INFO - mozleak == 0.1 08:54:54 INFO - mozlog == 3.1 08:54:54 INFO - moznetwork == 0.27 08:54:54 INFO - mozprocess == 0.22 08:54:54 INFO - mozprofile == 0.28 08:54:54 INFO - mozrunner == 6.11 08:54:54 INFO - mozscreenshot == 0.1 08:54:54 INFO - mozsystemmonitor == 0.0 08:54:54 INFO - moztest == 0.7 08:54:54 INFO - mozversion == 1.4 08:54:54 INFO - psutil == 3.1.1 08:54:54 INFO - requests == 1.2.3 08:54:54 INFO - wsgiref == 0.1.2 08:54:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fca97485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac3d0>, '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 0x2917ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2918360>, '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': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', '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 08:54:54 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 08:54:54 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 08:54:54 INFO - Using env: {'DISPLAY': ':0', 08:54:54 INFO - 'HOME': '/home/cltbld', 08:54:54 INFO - 'LANG': 'en_US.UTF-8', 08:54:54 INFO - 'LANGUAGE': 'en_US:en', 08:54:54 INFO - 'LOGNAME': 'cltbld', 08:54:54 INFO - 'MAIL': '/var/mail/cltbld', 08:54:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:54 INFO - 'MOZ_NO_REMOTE': '1', 08:54:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:54 INFO - 'NO_EM_RESTART': '1', 08:54:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:54 INFO - 'PWD': '/builds/slave/test', 08:54:54 INFO - 'SHELL': '/bin/bash', 08:54:54 INFO - 'SHLVL': '1', 08:54:54 INFO - 'TERM': 'linux', 08:54:54 INFO - 'TMOUT': '86400', 08:54:54 INFO - 'USER': 'cltbld', 08:54:54 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', 08:54:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:54 INFO - '_': '/tools/buildbot/bin/python'} 08:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:55 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)) 08:54:55 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)) 08:54:55 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)) 08:54:55 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)) 08:54:55 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)) 08:54:55 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)) 08:54:55 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)) 08:54:55 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)) 08:54:55 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)) 08:54:55 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)) 08:54:55 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)) 08:54:55 INFO - Cleaning up... 08:54:55 INFO - Return code: 0 08:54:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca97485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac3d0>, '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 0x2917ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2918360>, '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': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', '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 08:54:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:54:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:54:55 INFO - Using env: {'DISPLAY': ':0', 08:54:55 INFO - 'HOME': '/home/cltbld', 08:54:55 INFO - 'LANG': 'en_US.UTF-8', 08:54:55 INFO - 'LANGUAGE': 'en_US:en', 08:54:55 INFO - 'LOGNAME': 'cltbld', 08:54:55 INFO - 'MAIL': '/var/mail/cltbld', 08:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:55 INFO - 'MOZ_NO_REMOTE': '1', 08:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:55 INFO - 'NO_EM_RESTART': '1', 08:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:55 INFO - 'PWD': '/builds/slave/test', 08:54:55 INFO - 'SHELL': '/bin/bash', 08:54:55 INFO - 'SHLVL': '1', 08:54:55 INFO - 'TERM': 'linux', 08:54:55 INFO - 'TMOUT': '86400', 08:54:55 INFO - 'USER': 'cltbld', 08:54:55 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', 08:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:55 INFO - '_': '/tools/buildbot/bin/python'} 08:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:55 INFO - Downloading/unpacking jsonschema 08:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:54:57 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 08:54:57 INFO - Downloading/unpacking functools32 (from jsonschema) 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:57 INFO - Downloading functools32-3.2.3-2.tar.gz 08:54:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 08:54:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:54:57 INFO - warning: no files found matching '*.txt' 08:54:57 INFO - no previously-included directories found matching 'build' 08:54:57 INFO - no previously-included directories found matching 'dist' 08:54:57 INFO - no previously-included directories found matching '.git*' 08:54:57 INFO - Installing collected packages: jsonschema, functools32 08:54:57 INFO - Running setup.py install for functools32 08:54:57 INFO - warning: no files found matching '*.txt' 08:54:57 INFO - no previously-included directories found matching 'build' 08:54:57 INFO - no previously-included directories found matching 'dist' 08:54:57 INFO - no previously-included directories found matching '.git*' 08:54:57 INFO - Successfully installed jsonschema functools32 08:54:57 INFO - Cleaning up... 08:54:57 INFO - Return code: 0 08:54:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:54:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fca97485f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x284a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2919dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ac3d0>, '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 0x2917ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2918360>, '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': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', '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 08:54:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:54:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:54:57 INFO - Using env: {'DISPLAY': ':0', 08:54:57 INFO - 'HOME': '/home/cltbld', 08:54:57 INFO - 'LANG': 'en_US.UTF-8', 08:54:57 INFO - 'LANGUAGE': 'en_US:en', 08:54:57 INFO - 'LOGNAME': 'cltbld', 08:54:57 INFO - 'MAIL': '/var/mail/cltbld', 08:54:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:57 INFO - 'MOZ_NO_REMOTE': '1', 08:54:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:57 INFO - 'NO_EM_RESTART': '1', 08:54:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:57 INFO - 'PWD': '/builds/slave/test', 08:54:57 INFO - 'SHELL': '/bin/bash', 08:54:57 INFO - 'SHLVL': '1', 08:54:57 INFO - 'TERM': 'linux', 08:54:57 INFO - 'TMOUT': '86400', 08:54:57 INFO - 'USER': 'cltbld', 08:54:57 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', 08:54:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:57 INFO - '_': '/tools/buildbot/bin/python'} 08:54:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:57 INFO - Downloading/unpacking flake8 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54: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 08:54:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:54:59 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 08:54:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:59 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:54:59 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 08:54:59 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:59 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 08:54:59 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 08:55:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:55:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:55:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:55:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:55:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:55:00 INFO - no previously-included directories found matching 'docs/_build' 08:55:00 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:55:00 INFO - Running setup.py install for pep8 08:55:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:55:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:55:00 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:55:00 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:55:00 INFO - no previously-included directories found matching 'docs/_build' 08:55:00 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:55:00 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:55:00 INFO - Cleaning up... 08:55:00 INFO - Return code: 0 08:55:00 INFO - Running post-action listener: _resource_record_post_action 08:55:00 INFO - Running post-action listener: _start_resource_monitoring 08:55:00 INFO - Starting resource monitoring. 08:55:00 INFO - ##### 08:55:00 INFO - ##### Running install step. 08:55:00 INFO - ##### 08:55:00 INFO - Running pre-action listener: _resource_record_pre_action 08:55:00 INFO - Running main action method: install 08:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:00 INFO - Reading from file tmpfile_stdout 08:55:00 INFO - Detecting whether we're running mozinstall >=1.0... 08:55:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:55:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:55:00 INFO - Reading from file tmpfile_stdout 08:55:00 INFO - Output received: 08:55:00 INFO - Usage: mozinstall [options] installer 08:55:00 INFO - Options: 08:55:00 INFO - -h, --help show this help message and exit 08:55:00 INFO - -d DEST, --destination=DEST 08:55:00 INFO - Directory to install application into. [default: 08:55:00 INFO - "/builds/slave/test"] 08:55:00 INFO - --app=APP Application being installed. [default: firefox] 08:55:00 INFO - mkdir: /builds/slave/test/build/application 08:55:00 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'] 08:55:00 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 08:55:16 INFO - Reading from file tmpfile_stdout 08:55:16 INFO - Output received: 08:55:16 INFO - /builds/slave/test/build/application/firefox/firefox 08:55:16 INFO - Running post-action listener: _resource_record_post_action 08:55:16 INFO - ##### 08:55:16 INFO - ##### Running run-tests step. 08:55:16 INFO - ##### 08:55:16 INFO - Running pre-action listener: _resource_record_pre_action 08:55:16 INFO - Running main action method: run_tests 08:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:55:16 INFO - Python 2.7.3 08:55:16 INFO - Return code: 0 08:55:16 INFO - grabbing minidump binary from tooltool 08:55:16 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')]} 08:55:16 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 0x29ac3d0>, '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 0x2917ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2918360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:55:16 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 08:55:16 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 08:55:16 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:55:16 INFO - Return code: 0 08:55:16 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:55:16 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:55:16 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:55:16 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:55:16 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:55:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:55:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:55:17 INFO - Return code: 0 08:55:17 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/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 08:55:17 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/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 08:55:17 INFO - Using env: {'DISPLAY': ':0', 08:55:17 INFO - 'HOME': '/home/cltbld', 08:55:17 INFO - 'LANG': 'en_US.UTF-8', 08:55:17 INFO - 'LANGUAGE': 'en_US:en', 08:55:17 INFO - 'LOGNAME': 'cltbld', 08:55:17 INFO - 'MAIL': '/var/mail/cltbld', 08:55:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:55:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:17 INFO - 'MOZ_NO_REMOTE': '1', 08:55:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:55:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:17 INFO - 'NO_EM_RESTART': '1', 08:55:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:17 INFO - 'PWD': '/builds/slave/test', 08:55:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:55:17 INFO - 'SHELL': '/bin/bash', 08:55:17 INFO - 'SHLVL': '1', 08:55:17 INFO - 'TERM': 'linux', 08:55:17 INFO - 'TMOUT': '86400', 08:55:17 INFO - 'USER': 'cltbld', 08:55:17 INFO - 'XDG_SESSION_COOKIE': '7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848', 08:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:17 INFO - '_': '/tools/buildbot/bin/python'} 08:55:17 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/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 08:55:17 INFO - mozversion application_buildid: 20151231081838 08:55:17 INFO - mozversion application_changeset: ff863d8cdf7ad551bc4843e3614e09236400a6da 08:55:17 INFO - mozversion application_display_name: Nightly 08:55:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:55:17 INFO - mozversion application_name: Firefox 08:55:17 INFO - mozversion application_remotingname: firefox 08:55:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:55:17 INFO - mozversion application_vendor: Mozilla 08:55:17 INFO - mozversion application_version: 46.0a1 08:55:17 INFO - mozversion platform_buildid: 20151231081838 08:55:17 INFO - mozversion platform_changeset: ff863d8cdf7ad551bc4843e3614e09236400a6da 08:55:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:55:17 INFO - mozversion platform_version: 46.0a1 08:55:17 INFO - using testdate: 1451580917 08:55:17 INFO - actual date: 1451580917 08:55:17 INFO - starting webserver on 'localhost:57743' 08:55:17 INFO - SUITE-START | Running 3 tests 08:55:17 INFO - TEST-START | dromaeo_css 08:55:17 INFO - operating with platform_type : linux_ 08:55:17 INFO - Initialising browser for dromaeo_css test... 08:55:17 INFO - TEST-INFO | started process 9837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfMi8Ti/profile http://localhost:57743/getInfo.html) 08:55:22 INFO - PROCESS | 9837 | __metrics Screen width/height:1600/1200 08:55:22 INFO - PROCESS | 9837 | colorDepth:24 08:55:22 INFO - PROCESS | 9837 | Browser inner width/height: 1024/697 08:55:22 INFO - PROCESS | 9837 | __metrics 08:55:22 INFO - PROCESS | 9837 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 08:55:22 INFO - PROCESS | 9837 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:55:23 INFO - TEST-INFO | 9837: exit 0 08:55:23 INFO - Browser initialized. 08:55:23 INFO - Running cycle 1/1 for dromaeo_css test... 08:55:23 INFO - TEST-INFO | started process 9930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfMi8Ti/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:35 INFO - PROCESS | 9930 | RSS: Main: 150155264 08:55:35 INFO - PROCESS | 9930 | 08:56:26 INFO - PROCESS | 9930 | 1451580986669 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] 08:58:37 INFO - PROCESS | 9930 | Cycle 1(1): loaded http://localhost:57743/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57743/tests/dromaeo/cssquery-ext.html) 08:58:39 INFO - PROCESS | 9930 | RSS: Main: 321646592 08:58:39 INFO - PROCESS | 9930 | 09:01:42 INFO - PROCESS | 9930 | Cycle 1(1): loaded http://localhost:57743/tests/dromaeo/cssquery-ext.html (next: http://localhost:57743/tests/dromaeo/cssquery-jquery.html) 09:01:42 INFO - PROCESS | 9930 | RSS: Main: 229601280 09:01:42 INFO - PROCESS | 9930 | 09:04:45 INFO - PROCESS | 9930 | Cycle 1(1): loaded http://localhost:57743/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57743/tests/dromaeo/cssquery-mootools.html) 09:04:45 INFO - PROCESS | 9930 | RSS: Main: 218263552 09:04:45 INFO - PROCESS | 9930 | 09:07:47 INFO - PROCESS | 9930 | Cycle 1(1): loaded http://localhost:57743/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57743/tests/dromaeo/cssquery-prototype.html) 09:07:48 INFO - PROCESS | 9930 | RSS: Main: 207507456 09:07:48 INFO - PROCESS | 9930 | 09:10:51 INFO - PROCESS | 9930 | Cycle 1(1): loaded http://localhost:57743/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57743/tests/dromaeo/cssquery-yui.html) 09:10:51 INFO - PROCESS | 9930 | RSS: Main: 185561088 09:10:51 INFO - PROCESS | 9930 | 09:13:54 INFO - PROCESS | 9930 | Cycle 1(1): loaded http://localhost:57743/tests/dromaeo/cssquery-yui.html (next: http://localhost:57743/tests/dromaeo/cssquery-dojo.html) 09:13:54 INFO - PROCESS | 9930 | RSS: Main: 249802752 09:13:54 INFO - PROCESS | 9930 | 09:13:54 INFO - PROCESS | 9930 | __start_tp_report 09:13:54 INFO - PROCESS | 9930 | _x_x_mozilla_page_load 09:13:54 INFO - PROCESS | 9930 | _x_x_mozilla_page_load_details 09:13:54 INFO - PROCESS | 9930 | |i|pagename|runs| 09:13:54 INFO - PROCESS | 9930 | |0;dojo.html;2584.366830126619;2669.546177149883;2672.1449136276374;2686.086730511626;2706.837589744615;4416.249237629602;4551.431071116111;4554;4554.339620754993;4570.108828778381;4533.184026875161;4576.1762882681105;4580.175568397687;4659.836905708301;4661.277501987189;4216.578342165774;4216.725912815665;4228.4080228768;4284.443022407083;4296.140771845643;4272.914541709164;4297.677674174433;4300.56994300569;4309.0735491869245;4344.97827510862;4103.9179216415805;4144.5026596808275;4255.829766809324;4259.063006138645;4296.935545966798;4211.3261878099665;4241.978790106061;4245.596668316505;4265.019045619525;4269.893252668677;4208.200441916026;4216.599423054836;4220.556841531657;4229.069604686964;4257.254980378452;4368.279233926399;4495.887602809923;4497.168023915553;4556.157110934488;4570.291604801261;4790.904181916377;4817.542333478314;4822.927656085161;4921.606271498307;4936.358273424432;4961.18140506816;4973;4976.850694479172;4980.05378977993;4997.50024997501;4578.931316030262;4606.124836281096;4606.700564463299;4616.238320677118;4652.860414187546;4735.266033764772;4855.5387238212315;4856.975715121473;5058.013687331008;5073.086844367976;4763.4522029967;4829.758512074382;4830;4830.734309612934;4875.414950205998;4879.536444037811;4886.682365646222;4889.657723959289;4895.877603059952;4898.485659005753;4696.624270058455;4829.275608658659;4850.393700787402;4854.344663470457;4897.7795999180125;4729.668923175344;4751.501092385319;4816.614670826326;4838.540338667821;4855.975720121447;4077.7961101944784;4095.32427149517;4095.3242714952294;4095.488063992001;4133.966508372907;3582.498450216972;3585.1216451969435;3590.389633762267;3596.047047532406;3612.4942508048894;3967.940480892789;4054.2296963576828;4055.5944405559208;4168.291390463568;4265.232258193493;4902.632302577321;4927.95072049282;4929.359183306219;4943.802247910044;4987.426445958688;4204.159168166379;4231.238377092153;4238.17355615652;4244.766537840386;4276.2089013532595;4191.140816132746;4265.125649241898;4296.677749168824;4297.763623000703;4338.457692788402;4649.883752906069;4670.9766451167525;4672.229082201467;4698.906021879543;4719.787609557509;4890.315355850113;4890.462049174517;4892.363992681071;4894;4942.5304596063315;4548.295014272793;4647.047355292089;4656.254999200111;4661.184292748823;4665.743384113906;4681.812727490862;4737.265723812815;4744.810207591658;4745.193317136164;4746.121967436035;4753.976230118966;4806.49531799156;4811.591014763784;4813.879653008563;4877.1221180186485;4711.19909615373;4722.598579120676;4728.739919304334;4730.172219861442;4754.096721622881;4704.647151463585;4705.435347758154;4706.505816889177;4710.364100846342;4723.763811809465;4451.854773089274;4601.355810186509;4610.377599024089;4611.746353950431;4633.189191891338;4714.717116972993;4724.48030716614;4730.881727956828;4739.312799644102;4744.905101898012;4678.321643361762;4678.485366609738;4678.50875658051;4695.436547614308;4724.196886529229 09:13:54 INFO - PROCESS | 9930 | |1;ext.html;521.8356217791393;550.3725752641991;576.6943519934435;579.5103137848516;583.5448350286778;24684;34077.31845363091;34984.82507587465;34995.12512187196;35008;38683.22633547327;39135.21729565407;39168.804155979255;39202.8039859801;39286.21427571447;6608.372204640552;6686.665666716644;7956;7967.521948683097;8045.316148127416;9785.070418310284;10081.44552049637;10099.949500252489;10109.342892711988;10109.59561617538;9640.75898102546;9753.95123024384;9756;9757.073078057572;9763.21894248462;6952.478564107687;7086.185088714812;9654.275929305295;9811.950940245324;10026;9536.475493847836;9783.559739811726;9793.363431376938;9801.362911410806;9802.607895684165;31517.36965260682;31964.360712785845;31975.6802431975;31998.520022199686;32046.359072818414;2760.7791376689815;2763.585462180669;2830.05193260256;2846.146156153146;2946.8231906085703;27672.58491122635;27975.720242797513;28130;28210.15369538917;28515.57226641602;3376.3172490293946;3508.438649816043;3510.7366947478786;3573.678368946781;3624.4925710400566;221502;222830.99999999837;222917;223077;223168;52910.973457521475;53350.199747003826;53353.46646533485;53385.1992220117;53452.73273633607;47438.28842567364;48424;56182.71908640512;57774.7111264441;58148;11990.460429280703;11991.460384282727;12053.397330133459;12084.879151208552;12139.939300303618;10226.437545935045;10307.793844123225;10321.793564128826;10328.277020608486;10346;16895.324187032627;16916;17149.485515434557;17157.57106072358;17187.570310742332;7302.1967583565765;7436.3679087277105;7553.73561925341;7566.497933729423;7608.315251627269;743.6579173580105;745.4334705623766;763.4045444553258;801.2668408406244;927.2118699105706;26022.34944126412;26588.202353929413;27325.590116148273;27390.726092738816;27496.312592185357;866.4108406283788;882.9381943264038;915.2174890468686;949.2785483032944;951.6669165792056;11982.58060967862;12391.75216495665;12395.62813115608;14112.435502579781;14536.200508971897;267627;276383;276898;277243;277495;41612.167756644696;41621;41725;41758.37362439505;41761;1220.3166226912956;1222.2177806204036;1240.55340077572;1245.3399698159628;1248.8126780982743;20860;26117.608235876098;26878.462430751668;27439.862800685867;27441.86279068592;36070;36856.26287474289;36864.26271474502;36965.445518317785;36973;164933.17533412256;165357;166787;167236;167351.163244183;24125.03499859986;24649;25923.481530369663;26349.341266467723;27825.44349113047;32850.34299313952;33536.49695254524;33768;33829.83085084657;33895.66104338925;28352.432951340445;28685.713142868302;31381.68618313879;33050.173745655586;33717.83141084279;29146.7085329144;29223.85388073046;29418.705812941596;29433.85283073571;29450.11649650514;29512.852435737685;29845.70154298516;32467.837660811543;33056.338873222885;33182.5022624656;25203.495930081663;27059.323516912234;27106.593401099395;27143.59284610772;27201.59197612077;21219.575608487434;21479.677804833253;21699.674504882125;21714.565708685423;21750.238741643967 09:13:54 INFO - PROCESS | 9930 | |2;jquery.html;329.706561160567;336.8719886443152;337.50892451483094;339.3772427595362;339.6705195959919;12313.815292770616;12827.743445131091;14839.925800370997;15214.315355808987;15598.454054108108;8525.445846020004;8815.955920220405;10729.946350268257;11469.197156199069;12856.100072994894;4376.912461750755;4500.549945005506;4520.2089634314025;4521.773911304438;4525.072360166158;3411.5394421752994;4460.063386688799;4495.820167193308;5114.923276150861;5131.281620573122;5080.974595127019;5100.41345245296;5112.923306150411;5117.309163262968;5122.92315615266;5121.411037730652;5495.862603434906;5501.642393244446;5503.2020357048405;5511.311086114236;4900.436449808282;4903.53416425439;4904.288878112689;4916.041371932474;4918.336024636664;11494.195406321562;15006;16634.916825415796;17110.828891711048;17125.31498740049;1710.1021963469154;1749;1758.841704246624;1764.700000999833;1799.38820800927;8789.868151977726;8796.384253102286;11617.535298588047;11833.467493962793;11983.580574679845;1620.5219460259134;1743.8517725993306;1755.6839768841603;1767.054625775217;1803.5040363899902;50614.24078638823;53160.734196329155;53251.467485325426;53596.19605705918;54149.187762183596;9419.105185007413;9586.424814511152;9593.712188634352;9664.081912218327;9739.853902191331;12165.695857603454;12186.268823870596;12193.024558035337;12205.084618653636;12213.572524961584;6657.700403481855;6837.555558888656;6950.096487456598;6986.021956926034;7061.152661680631;6761.391474767294;6807.944768560881;6826.897596536056;6852.897206541906;6883.965580172167;3894.727369084137;3941.6452519273403;3998;4009.0177906413114;4053.61490658387;1555.1757568488492;1568.1061794777095;1615.402301148559;1627.6337823989745;1705.8208888066574;785.4501848705929;839.9263571677437;885.7431344910033;922.2714055895901;931.3527098666361;15111.848881511045;15636.3745450183;15671.294791734399;15990.120543369994;16077.758833617505;819.496009953874;855.3242938078972;857.2554850878432;857.6869442653386;894.3828758156981;8674.349423793241;8983.775405614912;9025.23285520725;9165.266778657691;9218.723438296862;459814;478240.7407407399;490536;490785;495178;66078;66745;67060.66469667718;67155;67378;917.2341095185594;962.2879069488528;1012.0537297626743;1029.624187171692;1030.4744580263969;13465.932670336586;13896.444142234603;14127.364268608142;14206.78689819633;14366.209858457885;29676;30028.24929376783;30277.545836812023;30417.23956901095;30734.53898191484;38266.808665956494;39703.80148099356;39771.2045759089;40097.39853902136;41268.38097428601;2386.391470175094;4873.683210591442;8163.306118979715;8166.142555031874;8314;9276.443413395218;12882.742345152858;16285.67428651444;16606.833931660527;16854.241559129623;9569.712908612475;11876.346800926032;13364.398602062736;13556.389962451516;13893.166410015432;11842.644720658394;12533.310667912987;12862.421191046613;12975.221486710827;13033.543825966046;10299.3820370778;10374.221933354878;13766.793498097737;13789.310534473438;13954.37205325783;7432.777016689508;8026.197380262161;8197.83604327922;8564;8651.48091114535;8931.866022009544;10721.839172412576;13349;13530.526431574848;13560.38978246001 09:13:54 INFO - PROCESS | 9930 | |3;mootools.html;1147.6614398752367;1178.734784673448;1181.161375423449;1241.0319950438654;1504.4583949778084;5753.4246575342495;6441.259255185655;6585.341465853412;6588.967055164718;6590.835229119274;6771.153605799275;6969.930300696991;6972.651367431621;6973.337532934376;6979.197392299887;2028.3509277031355;2065.7004734313514;2069.9068541915576;2076.9896150519226;2077.66757318829;2051.2615458434952;2059.330717516813;2062.175129948018;2106.7682554918947;2128.648772952461;2038.2254743197564;2054.291269512016;2081.5524662197627;2084.4684605425673;2084.4893001214723;2028.9188432462759;2059.011674396291;2061.5567652954537;2062.9174833006664;2063.597598468299;2079.2826474866147;2111.1344348817065;2128.435964469417;2133.125418578391;2137.7648458669532;7006.299370063004;7113.928860711379;7114.039604653409;7115.53749006313;7121.501494895359;3928.626780455852;4008.358662613997;4018.2365350583295;4035.778032208227;4040.151568170688;2582.8321159124785;2617.3849145450804;2650.7614314711577;2654.309879431362;2659.574468085097;785.8899754034439;795.550513959611;808.1958451340895;828.5484410996022;847.3136759225048;9078.727638170865;9089.772755681095;9099.772505687344;9100.8634870477;9109.726708198765;3758.5489741231227;3791.336516109725;3825.617438256152;3850.8074596270076;3853.788041657736;8004.879926801103;8007.079185893696;8011.7997050073045;8016.238457346542;8028.9197108028175;4021.577734337911;4021.6380525752825;4071.776052317151;4073.246449406869;4076.30702780528;2980.5976193214074;3049.573059771634;3568.2149927016017;3583.086312990171;3601.3877640801124;3198.6641402652854;3204.1829333519804;3229.7254733347927;3240.7731458797657;3247.967520324814;971.4705485510414;999.3604093380243;1004.5730564510054;1009.5557954500143;1013.1843865688045;842.1914961636897;858.7638399440204;860.0195776814437;920.663957655451;1027.3322340478749;6266.467350275187;6397.200349956255;6447.194100737408;6467.094606755058;6467.256265529524;399.22749479756766;403.57019773941244;1020.8928062553325;1038.133158812385;1074.4573990134932;5259.395169555473;5336.573074154058;5349.277847490617;5351.678899266057;5355.3841308249275;8259.8348033039;8273.8345233095;8423.831523369498;8428.410011299273;8493.193146651058;8364.456310339809;8429.114942930904;8429.536375499283;8433.620487078097;8438.493690378597;6364.777232796922;6600;6661.866762664719;6675.299093595199;6678.766243181465;6511.706973186123;6572.375624315682;6585.176852893388;6588.40704336612;6593.208814942238;7273.636318183963;7418.9629051856555;7492.363149132385;7533;7554.357879580297;7505.286997735207;7578.507397019176;7674.347680447225;7783.1827658097345;7783.766487005399;5194.584433245407;5278.630495865406;5937.554683398676;5948.583599148018;6010.669413182317;6446.129772480655;6571.967140164268;6584.670766461753;6610.206775187008;6613.503987200883;6061.181740465157;6136.110264011604;6178.721957511832;6236.968815155895;6413.390727880844;5956.851078723066;5996.640201587918;6038.939610604013;6039.849003774941;6071.058985857199;6139.386061393825;6232.781852635136;6241.8751624966335;6281.685915704105;6283.3402492737605;5825.679587622722;5857.619254748428;5859.94140058594;5862.94137058641;5865.706714664335;5807.245058142415;5846.269216347957;5859.091840764689;5904.409559044061;5907.763689452374 09:13:54 INFO - PROCESS | 9930 | |4;prototype.html;297.3710602076608;299.95650630658554;302.43746631265844;304.0953164336099;305.1486353074921;5231.39838918524;5291.576673866091;5308.787648494061;5360.91958620621;5394.811181608645;5201.661891977019;5274.05067087924;5301.5228629423345;5306.814261500848;5322.520973112419;3924.1366899282257;4122.381642753596;4130.318497447917;4134.8966275843195;4138.2758017347;3993.381025940984;4001.8999525011964;4074.8777536673947;4081.2041651877894;4088.7546747195265;4006.9599304007024;4031.0325521874684;4033.394990751396;4035.8587449439274;4076.7362117743596;3846.59610740871;3924.7645141291614;3955.406688996645;4072.9592704073025;4083.9591604084026;3556.110972256936;3556.7865928044143;3573.249617580311;3584.62361452049;3585.695215906651;5020.272060551236;5031.0441016206805;5033.7734801934;5034.421041580228;5061.392632884041;4680;4681.110588988081;4691.741954192518;4693.342931989524;4700.341952126705;5380.596455265871;5544.417836127229;5547.528460080898;5552.944470555323;5592.804251851207;3942.093318536724;3944.7830369329677;3947.131631041166;3947.4473573699706;3951.1900060487533;5781.739821708034;5856.443637854397;5869.354371019142;5871.794487192928;5878.323992740804;4047.919041619151;4049.0889549851636;4050.594940505926;4055.918881622351;4056.249593825152;3866.7486613370043;3961.9405708914387;4090.0183955850976;4104.0970986382945;4107.219628270619;4142.171565686875;4538.183127037165;4540.477845047796;4568.109218702321;4635.976820115945;5398.082326004589;5488.231647569343;5550.91673624896;5564.582656300713;5576.581756368289;1425.5367005722974;1447.3197597129333;1448.2541491132076;1448.2686243446992;1449.3333066789185;974.5955428497236;988.7528117970508;992.1318846009741;1000.1398797034544;1006.5772375602264;4874.341963834837;4882.316475693406;4885.633577481632;4889.65772395936;4890.315355850184;5784.421557844182;5788.247527821356;5788.768449261982;5790.88418231633;5791.073428251544;4839.975800120977;4855.247436647325;4863.732494712754;4874.805007799649;4875.975620121877;3046.34503581731;3078.1535077853323;3112.3152906360565;3116.2520994961046;3119.641241257239;5510.91733623988;5543.556515478752;5558.610897237155;5577.386487486373;5578.693171875505;5997.70011499432;6008.489278411384;6009.2188015557695;6011.1884895539415;6015.729292181863;5557.638753481092;5559.499645031967;5566.081596536607;5566.997940370772;5570.303712035996;5664.348599911063;5812.738426770721;5816.883662326645;5828.854278642898;5836.591438599257;5680.6591604503865;5684.602077854676;5693.345265294544;5695.800646977336;5697.6296540724725;5548.334199896039;5551.555875529867;5555.583331250254;5561.1658251261015;5563.554915606823;3788.943165852459;3867.9806600966817;3914.5693973662305;3917.0011647029824;3921.3333733265986;5707.400722924033;5708.429157084258;5709;5709.229254050816;5716.5998380113;5488.4237155098135;5550.722463876709;5556.055470569932;5559.16612508127;5572.498475137095;5556.111022236423;5568.248286481273;5569.359523654832;5570.944290557042;5588.077967135539;5323.414424413389;5517.393086760373;5518.2826232589505;5519.862003449946;5527.977324195037;5416.647917885325;5573.7770489179975;5655.434456554476;5657.632253903483;5662.03745363281;5292.682439053515;5469;5472.835814925558;5483.369412517612;5491.972540137273 09:13:54 INFO - PROCESS | 9930 | |5;yui.html;635.1742734445221;675.1425689374495;762.2453770766942;785.9292663660269;803.6102490292208;10790.190735694825;10961;10971.945140274298;10980.835287470674;10982.780344393108;10823.080038196762;10935.343879367243;10941.945290273557;10943.726406839833;10949.343039417621;614.443928244939;623.803501896901;624.9312575616678;774.0865778381522;779.7621725373758;790.6955822008539;795.6419611174965;802.2378740196807;802.3460879383313;802.4022103532847;831.1522247307743;834.4492634860993;834.6369329341726;835.3275613131457;836.3058661311097;622.9096780966757;629.7355110853407;816.8611336072881;831.8211584509329;834.2825170353491;618.3630860213987;618.9473894718955;619.2228752915063;620.9565330426872;621.4344946099073;10573.207009474243;10722.946385268024;10730.248882578222;10737.83893241602;10748.677539673823;9940.453275069869;10347.689569312932;10465.47672616366;10550.577976880915;11158.274712143684;8911.688090916852;9165.358424910259;9630.374025688378;9836.016398360178;9888.653897113638;3181.18879685681;3231.515272709089;3238.757093218018;3246.5617141685807;3246.8376581171083;39832.80083599593;40217.79891100526;40239.7988010061;40287.39568906469;40395;7895.763127106196;7908.52548847071;8189.303909167668;8241.175882411711;8328.6668533258;12987.935060324828;15384.538463846102;15386.076835389913;15390.615234619225;15413.383464661512;6098.5426093042315;6108.5723999319625;6134.6625935573975;6191.504679625619;6320.367963203643;3466.9133271667906;3567.1973805893986;3627.764195327295;3642.581103173116;3644.726645501598;2612.673415823022;2642.4715056988293;2647.033832651107;2648.4835457085683;2649.205238428502;451.4221796100996;453.0327750253233;453.5691093461225;462.52591094128786;463.2888516127795;402.0792385437374;404.4479285774955;415.16551731020866;421.9662427005832;433.9761313127745;7164.21193668696;7234.746783862644;7345.853082938418;7862.52824830512;7871.252231038042;422.76536522229844;505.55511150188335;513.4659953648164;513.6917849290396;602.1660000898787;3257.397381484433;3609.205974685565;3619.1314084619503;3657.6159503251774;3662.7252956027874;49492.25761613579;49550.256746148116;49573.25640115401;49599.256011159865;50649.24026139611;42876.35685464721;43164.352534712;43266.783666081465;44041.11917761627;44262.55737442649;38820;38830.805845971154;38944.80527597344;38989.610103898594;40207.396889046686;7218.3503484686635;7378.520396174232;7539.208383119693;7559.622018899143;7812.335951444191;29248.56127158137;29795;29816.10551683453;30005.549916750828;30124.84937575298;34795.478067828495;35021.29957400889;38393.80803096078;38720.2255954885;38770.6122938767;8603.52680602573;8872.290216782512;8889.111088891059;9238.815223695623;9341.57962891658;9652.662156824477;9720.41677499324;10024.348417352849;10058.49707514636;10481.37111773296;9055.773605659911;9179.816403672023;9262.814743705223;9316;9332.766680833034;8846.690365837165;9051.818963620559;9080.091990800867;9198.310126740655;9201.171894529256;9181.219596334386;9318.860217096884;9323.766905827137;9328.440293582407;9334.813303734023;8443.577821108796;8452.66189352419;8537.871931920901;8574.072784085702;8623.82752344937;7438.479306448713;8024.197580241929;8070.273675369245;8104.554249516334;8254.752357429286 09:13:54 INFO - PROCESS | 9930 | __end_tp_report 09:13:54 INFO - PROCESS | 9930 | __start_cc_report 09:13:54 INFO - PROCESS | 9930 | _x_x_mozilla_cycle_collect,1691 09:13:54 INFO - PROCESS | 9930 | __end_cc_report 09:13:54 INFO - PROCESS | 9930 | __startTimestamp1451582034464__endTimestamp 09:13:54 INFO - PROCESS | 9930 | 09:13:54 INFO - PROCESS | 9930 | ------- Summary: start ------- 09:13:54 INFO - PROCESS | 9930 | Number of tests: 6 09:13:54 INFO - PROCESS | 9930 | 09:13:54 INFO - PROCESS | 9930 | [#0] dojo.html Cycles:165 Average:4505.81 Median:4659.84 stddev:454.76 (9.8%) stddev-sans-first:430.45 09:13:54 INFO - PROCESS | 9930 | Values: 2584.4 2669.5 2672.1 2686.1 2706.8 4416.2 4551.4 4554.0 4554.3 4570.1 4533.2 4576.2 4580.2 4659.8 4661.3 4216.6 4216.7 4228.4 4284.4 4296.1 4272.9 4297.7 4300.6 4309.1 4345.0 4103.9 4144.5 4255.8 4259.1 4296.9 4211.3 4242.0 4245.6 4265.0 4269.9 4208.2 4216.6 4220.6 4229.1 4257.3 4368.3 4495.9 4497.2 4556.2 4570.3 4790.9 4817.5 4822.9 4921.6 4936.4 4961.2 4973.0 4976.9 4980.1 4997.5 4578.9 4606.1 4606.7 4616.2 4652.9 4735.3 4855.5 4857.0 5058.0 5073.1 4763.5 4829.8 4830.0 4830.7 4875.4 4879.5 4886.7 4889.7 4895.9 4898.5 4696.6 4829.3 4850.4 4854.3 4897.8 4729.7 4751.5 4816.6 4838.5 4856.0 4077.8 4095.3 4095.3 4095.5 4134.0 3582.5 3585.1 3590.4 3596.0 3612.5 3967.9 4054.2 4055.6 4168.3 4265.2 4902.6 4928.0 4929.4 4943.8 4987.4 4204.2 4231.2 4238.2 4244.8 4276.2 4191.1 4265.1 4296.7 4297.8 4338.5 4649.9 4671.0 4672.2 4698.9 4719.8 4890.3 4890.5 4892.4 4894.0 4942.5 4548.3 4647.0 4656.3 4661.2 4665.7 4681.8 4737.3 4744.8 4745.2 4746.1 4754.0 4806.5 4811.6 4813.9 4877.1 4711.2 4722.6 4728.7 4730.2 4754.1 4704.6 4705.4 4706.5 4710.4 4723.8 4451.9 4601.4 4610.4 4611.7 4633.2 4714.7 4724.5 4730.9 4739.3 4744.9 4678.3 4678.5 4678.5 4695.4 4724.2 09:13:54 INFO - PROCESS | 9930 | 09:13:54 INFO - PROCESS | 9930 | [#1] ext.html Cycles:180 Average:37478.39 Median:31449.53 stddev:58870.91 (187.2%) stddev-sans-first:58970.66 09:13:54 INFO - PROCESS | 9930 | Values: 521.8 550.4 576.7 579.5 583.5 24684.0 34077.3 34984.8 34995.1 35008.0 38683.2 39135.2 39168.8 39202.8 39286.2 6608.4 6686.7 7956.0 7967.5 8045.3 9785.1 10081.4 10099.9 10109.3 10109.6 9640.8 9754.0 9756.0 9757.1 9763.2 6952.5 7086.2 9654.3 9812.0 10026.0 9536.5 9783.6 9793.4 9801.4 9802.6 31517.4 31964.4 31975.7 31998.5 32046.4 2760.8 2763.6 2830.1 2846.1 2946.8 27672.6 27975.7 28130.0 28210.2 28515.6 3376.3 3508.4 3510.7 3573.7 3624.5 221502.0 222831.0 222917.0 223077.0 223168.0 52911.0 53350.2 53353.5 53385.2 53452.7 47438.3 48424.0 56182.7 57774.7 58148.0 11990.5 11991.5 12053.4 12084.9 12139.9 10226.4 10307.8 10321.8 10328.3 10346.0 16895.3 16916.0 17149.5 17157.6 17187.6 7302.2 7436.4 7553.7 7566.5 7608.3 743.7 745.4 763.4 801.3 927.2 26022.3 26588.2 27325.6 27390.7 27496.3 866.4 882.9 915.2 949.3 951.7 11982.6 12391.8 12395.6 14112.4 14536.2 267627.0 276383.0 276898.0 277243.0 277495.0 41612.2 41621.0 41725.0 41758.4 41761.0 1220.3 1222.2 1240.6 1245.3 1248.8 20860.0 26117.6 26878.5 27439.9 27441.9 36070.0 36856.3 36864.3 36965.4 36973.0 164933.2 165357.0 166787.0 167236.0 167351.2 24125.0 24649.0 25923.5 26349.3 27825.4 32850.3 33536.5 33768.0 33829.8 33895.7 28352.4 28685.7 31381.7 33050.2 33717.8 29146.7 29223.9 29418.7 29433.9 29450.1 29512.9 29845.7 32467.8 33056.3 33182.5 25203.5 27059.3 27106.6 27143.6 27201.6 21219.6 21479.7 21699.7 21714.6 21750.2 09:13:54 INFO - PROCESS | 9930 | 09:13:54 INFO - PROCESS | 9930 | [#2] jquery.html Cycles:180 Average:25356.87 Median:22075.51 stddev:78859.43 (357.2%) stddev-sans-first:79058.26 09:13:54 INFO - PROCESS | 9930 | Values: 329.7 336.9 337.5 339.4 339.7 12313.8 12827.7 14839.9 15214.3 15598.5 8525.4 8816.0 10729.9 11469.2 12856.1 4376.9 4500.5 4520.2 4521.8 4525.1 3411.5 4460.1 4495.8 5114.9 5131.3 5081.0 5100.4 5112.9 5117.3 5122.9 5121.4 5495.9 5501.6 5503.2 5511.3 4900.4 4903.5 4904.3 4916.0 4918.3 11494.2 15006.0 16634.9 17110.8 17125.3 1710.1 1749.0 1758.8 1764.7 1799.4 8789.9 8796.4 11617.5 11833.5 11983.6 1620.5 1743.9 1755.7 1767.1 1803.5 50614.2 53160.7 53251.5 53596.2 54149.2 9419.1 9586.4 9593.7 9664.1 9739.9 12165.7 12186.3 12193.0 12205.1 12213.6 6657.7 6837.6 6950.1 6986.0 7061.2 6761.4 6807.9 6826.9 6852.9 6884.0 3894.7 3941.6 3998.0 4009.0 4053.6 1555.2 1568.1 1615.4 1627.6 1705.8 785.5 839.9 885.7 922.3 931.4 15111.8 15636.4 15671.3 15990.1 16077.8 819.5 855.3 857.3 857.7 894.4 8674.3 8983.8 9025.2 9165.3 9218.7 459814.0 478240.7 490536.0 490785.0 495178.0 66078.0 66745.0 67060.7 67155.0 67378.0 917.2 962.3 1012.1 1029.6 1030.5 13465.9 13896.4 14127.4 14206.8 14366.2 29676.0 30028.2 30277.5 30417.2 30734.5 38266.8 39703.8 39771.2 40097.4 41268.4 2386.4 4873.7 8163.3 8166.1 8314.0 9276.4 12882.7 16285.7 16606.8 16854.2 9569.7 11876.3 13364.4 13556.4 13893.2 11842.6 12533.3 12862.4 12975.2 13033.5 10299.4 10374.2 13766.8 13789.3 13954.4 7432.8 8026.2 8197.8 8564.0 8651.5 8931.9 10721.8 13349.0 13530.5 13560.4 09:13:54 INFO - PROCESS | 9930 | 09:13:54 INFO - PROCESS | 9930 | [#3] mootools.html Cycles:180 Average:4805.50 Median:6003.65 stddev:2514.74 (41.9%) stddev-sans-first:2506.76 09:13:54 INFO - PROCESS | 9930 | Values: 1147.7 1178.7 1181.2 1241.0 1504.5 5753.4 6441.3 6585.3 6589.0 6590.8 6771.2 6969.9 6972.7 6973.3 6979.2 2028.4 2065.7 2069.9 2077.0 2077.7 2051.3 2059.3 2062.2 2106.8 2128.6 2038.2 2054.3 2081.6 2084.5 2084.5 2028.9 2059.0 2061.6 2062.9 2063.6 2079.3 2111.1 2128.4 2133.1 2137.8 7006.3 7113.9 7114.0 7115.5 7121.5 3928.6 4008.4 4018.2 4035.8 4040.2 2582.8 2617.4 2650.8 2654.3 2659.6 785.9 795.6 808.2 828.5 847.3 9078.7 9089.8 9099.8 9100.9 9109.7 3758.5 3791.3 3825.6 3850.8 3853.8 8004.9 8007.1 8011.8 8016.2 8028.9 4021.6 4021.6 4071.8 4073.2 4076.3 2980.6 3049.6 3568.2 3583.1 3601.4 3198.7 3204.2 3229.7 3240.8 3248.0 971.5 999.4 1004.6 1009.6 1013.2 842.2 858.8 860.0 920.7 1027.3 6266.5 6397.2 6447.2 6467.1 6467.3 399.2 403.6 1020.9 1038.1 1074.5 5259.4 5336.6 5349.3 5351.7 5355.4 8259.8 8273.8 8423.8 8428.4 8493.2 8364.5 8429.1 8429.5 8433.6 8438.5 6364.8 6600.0 6661.9 6675.3 6678.8 6511.7 6572.4 6585.2 6588.4 6593.2 7273.6 7419.0 7492.4 7533.0 7554.4 7505.3 7578.5 7674.3 7783.2 7783.8 5194.6 5278.6 5937.6 5948.6 6010.7 6446.1 6572.0 6584.7 6610.2 6613.5 6061.2 6136.1 6178.7 6237.0 6413.4 5956.9 5996.6 6038.9 6039.8 6071.1 6139.4 6232.8 6241.9 6281.7 6283.3 5825.7 5857.6 5859.9 5862.9 5865.7 5807.2 5846.3 5859.1 5904.4 5907.8 09:13:54 INFO - PROCESS | 9930 | 09:13:54 INFO - PROCESS | 9930 | [#4] prototype.html Cycles:180 Average:4616.79 Median:5292.13 stddev:1364.04 (25.8%) stddev-sans-first:1328.78 09:13:54 INFO - PROCESS | 9930 | Values: 297.4 300.0 302.4 304.1 305.1 5231.4 5291.6 5308.8 5360.9 5394.8 5201.7 5274.1 5301.5 5306.8 5322.5 3924.1 4122.4 4130.3 4134.9 4138.3 3993.4 4001.9 4074.9 4081.2 4088.8 4007.0 4031.0 4033.4 4035.9 4076.7 3846.6 3924.8 3955.4 4073.0 4084.0 3556.1 3556.8 3573.2 3584.6 3585.7 5020.3 5031.0 5033.8 5034.4 5061.4 4680.0 4681.1 4691.7 4693.3 4700.3 5380.6 5544.4 5547.5 5552.9 5592.8 3942.1 3944.8 3947.1 3947.4 3951.2 5781.7 5856.4 5869.4 5871.8 5878.3 4047.9 4049.1 4050.6 4055.9 4056.2 3866.7 3961.9 4090.0 4104.1 4107.2 4142.2 4538.2 4540.5 4568.1 4636.0 5398.1 5488.2 5550.9 5564.6 5576.6 1425.5 1447.3 1448.3 1448.3 1449.3 974.6 988.8 992.1 1000.1 1006.6 4874.3 4882.3 4885.6 4889.7 4890.3 5784.4 5788.2 5788.8 5790.9 5791.1 4840.0 4855.2 4863.7 4874.8 4876.0 3046.3 3078.2 3112.3 3116.3 3119.6 5510.9 5543.6 5558.6 5577.4 5578.7 5997.7 6008.5 6009.2 6011.2 6015.7 5557.6 5559.5 5566.1 5567.0 5570.3 5664.3 5812.7 5816.9 5828.9 5836.6 5680.7 5684.6 5693.3 5695.8 5697.6 5548.3 5551.6 5555.6 5561.2 5563.6 3788.9 3868.0 3914.6 3917.0 3921.3 5707.4 5708.4 5709.0 5709.2 5716.6 5488.4 5550.7 5556.1 5559.2 5572.5 5556.1 5568.2 5569.4 5570.9 5588.1 5323.4 5517.4 5518.3 5519.9 5528.0 5416.6 5573.8 5655.4 5657.6 5662.0 5292.7 5469.0 5472.8 5483.4 5492.0 09:13:54 INFO - PROCESS | 9930 | 09:13:54 INFO - PROCESS | 9930 | [#5] yui.html Cycles:180 Average:11617.24 Median:557.93 stddev:13521.38 (2423.5%) stddev-sans-first:13534.16 09:13:54 INFO - PROCESS | 9930 | Values: 635.2 675.1 762.2 785.9 803.6 10790.2 10961.0 10971.9 10980.8 10982.8 10823.1 10935.3 10941.9 10943.7 10949.3 614.4 623.8 624.9 774.1 779.8 790.7 795.6 802.2 802.3 802.4 831.2 834.4 834.6 835.3 836.3 622.9 629.7 816.9 831.8 834.3 618.4 618.9 619.2 621.0 621.4 10573.2 10722.9 10730.2 10737.8 10748.7 9940.5 10347.7 10465.5 10550.6 11158.3 8911.7 9165.4 9630.4 9836.0 9888.7 3181.2 3231.5 3238.8 3246.6 3246.8 39832.8 40217.8 40239.8 40287.4 40395.0 7895.8 7908.5 8189.3 8241.2 8328.7 12987.9 15384.5 15386.1 15390.6 15413.4 6098.5 6108.6 6134.7 6191.5 6320.4 3466.9 3567.2 3627.8 3642.6 3644.7 2612.7 2642.5 2647.0 2648.5 2649.2 451.4 453.0 453.6 462.5 463.3 402.1 404.4 415.2 422.0 434.0 7164.2 7234.7 7345.9 7862.5 7871.3 422.8 505.6 513.5 513.7 602.2 3257.4 3609.2 3619.1 3657.6 3662.7 49492.3 49550.3 49573.3 49599.3 50649.2 42876.4 43164.4 43266.8 44041.1 44262.6 38820.0 38830.8 38944.8 38989.6 40207.4 7218.4 7378.5 7539.2 7559.6 7812.3 29248.6 29795.0 29816.1 30005.5 30124.8 34795.5 35021.3 38393.8 38720.2 38770.6 8603.5 8872.3 8889.1 9238.8 9341.6 9652.7 9720.4 10024.3 10058.5 10481.4 9055.8 9179.8 9262.8 9316.0 9332.8 8846.7 9051.8 9080.1 9198.3 9201.2 9181.2 9318.9 9323.8 9328.4 9334.8 8443.6 8452.7 8537.9 8574.1 8623.8 7438.5 8024.2 8070.3 8104.6 8254.8 09:13:54 INFO - PROCESS | 9930 | -------- Summary: end -------- 09:13:54 INFO - PROCESS | 9930 | 09:13:55 INFO - TEST-INFO | 9930: exit 0 09:13:55 INFO - TEST-OK | dromaeo_css | took 1117769ms 09:13:55 INFO - TEST-START | kraken 09:13:55 INFO - operating with platform_type : linux_ 09:13:55 INFO - Initialising browser for kraken test... 09:13:55 INFO - TEST-INFO | started process 10113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpER56Cd/profile http://localhost:57743/getInfo.html) 09:14:00 INFO - PROCESS | 10113 | __metrics Screen width/height:1600/1200 09:14:00 INFO - PROCESS | 10113 | colorDepth:24 09:14:00 INFO - PROCESS | 10113 | Browser inner width/height: 1024/697 09:14:00 INFO - PROCESS | 10113 | __metrics 09:14:00 INFO - PROCESS | 10113 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:14:00 INFO - PROCESS | 10113 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:14:01 INFO - TEST-INFO | 10113: exit 0 09:14:01 INFO - Browser initialized. 09:14:01 INFO - Running cycle 1/1 for kraken test... 09:14:01 INFO - TEST-INFO | started process 10197 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpER56Cd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:13 INFO - PROCESS | 10197 | RSS: Main: 149737472 09:14:13 INFO - PROCESS | 10197 | 09:14:15 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57743/tests/kraken/driver.html?testName=audio-beat-detection) 09:14:16 INFO - PROCESS | 10197 | RSS: Main: 184958976 09:14:16 INFO - PROCESS | 10197 | 09:14:19 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57743/tests/kraken/driver.html?testName=audio-dft) 09:14:19 INFO - PROCESS | 10197 | RSS: Main: 174637056 09:14:19 INFO - PROCESS | 10197 | 09:14:22 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57743/tests/kraken/driver.html?testName=audio-fft) 09:14:23 INFO - PROCESS | 10197 | RSS: Main: 159232000 09:14:23 INFO - PROCESS | 10197 | 09:14:25 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57743/tests/kraken/driver.html?testName=audio-oscillator) 09:14:25 INFO - PROCESS | 10197 | RSS: Main: 162885632 09:14:25 INFO - PROCESS | 10197 | 09:14:28 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57743/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:14:28 INFO - PROCESS | 10197 | RSS: Main: 164622336 09:14:28 INFO - PROCESS | 10197 | 09:14:31 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57743/tests/kraken/driver.html?testName=imaging-darkroom) 09:14:32 INFO - PROCESS | 10197 | RSS: Main: 164184064 09:14:32 INFO - PROCESS | 10197 | 09:14:35 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57743/tests/kraken/driver.html?testName=imaging-desaturate) 09:14:36 INFO - PROCESS | 10197 | RSS: Main: 163868672 09:14:36 INFO - PROCESS | 10197 | 09:14:39 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57743/tests/kraken/driver.html?testName=json-parse-financial) 09:14:39 INFO - PROCESS | 10197 | RSS: Main: 165167104 09:14:39 INFO - PROCESS | 10197 | 09:14:41 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57743/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:14:42 INFO - PROCESS | 10197 | RSS: Main: 175153152 09:14:42 INFO - PROCESS | 10197 | 09:14:43 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57743/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:14:44 INFO - PROCESS | 10197 | RSS: Main: 172638208 09:14:44 INFO - PROCESS | 10197 | 09:14:46 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57743/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:14:47 INFO - PROCESS | 10197 | RSS: Main: 187437056 09:14:47 INFO - PROCESS | 10197 | 09:14:49 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:14:50 INFO - PROCESS | 10197 | RSS: Main: 192221184 09:14:50 INFO - PROCESS | 10197 | 09:14:52 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:53 INFO - PROCESS | 10197 | RSS: Main: 188633088 09:14:53 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | Cycle 1(1): loaded http://localhost:57743/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57743/tests/kraken/driver.html?testName=ai-astar) 09:14:55 INFO - PROCESS | 10197 | RSS: Main: 246591488 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | __start_tp_report 09:14:55 INFO - PROCESS | 10197 | _x_x_mozilla_page_load 09:14:55 INFO - PROCESS | 10197 | _x_x_mozilla_page_load_details 09:14:55 INFO - PROCESS | 10197 | |i|pagename|runs| 09:14:55 INFO - PROCESS | 10197 | |0;ai-astar;112;114;109;112;114;112;105;115;112;103 09:14:55 INFO - PROCESS | 10197 | |1;audio-beat-detection;156;132;154;172;139;167;153;132;170;136 09:14:55 INFO - PROCESS | 10197 | |2;audio-dft;161;162;163;159;162;161;163;162;163;161 09:14:55 INFO - PROCESS | 10197 | |3;audio-fft;72;72;83;93;75;71;72;112;91;73 09:14:55 INFO - PROCESS | 10197 | |4;audio-oscillator;98;99;133;98;97;98;134;97;99;136 09:14:55 INFO - PROCESS | 10197 | |5;imaging-gaussian-blur;110;109;110;110;109;109;109;109;110;109 09:14:55 INFO - PROCESS | 10197 | |6;imaging-darkroom;146;147;146;147;147;146;147;147;147;147 09:14:55 INFO - PROCESS | 10197 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;95;95 09:14:55 INFO - PROCESS | 10197 | |8;json-parse-financial;80;72;73;71;71;71;71;81;69;70 09:14:55 INFO - PROCESS | 10197 | |9;json-stringify-tinderbox;69;69;69;69;68;69;70;70;69;69 09:14:55 INFO - PROCESS | 10197 | |10;stanford-crypto-aes;84;87;86;86;85;85;86;93;92;85 09:14:55 INFO - PROCESS | 10197 | |11;stanford-crypto-ccm;127;129;122;121;137;127;127;124;130;129 09:14:55 INFO - PROCESS | 10197 | |12;stanford-crypto-pbkdf2;140;152;152;151;150;140;141;144;156;139 09:14:55 INFO - PROCESS | 10197 | |13;stanford-crypto-sha256-iterative;71;71;71;72;70;71;70;72;73;71 09:14:55 INFO - PROCESS | 10197 | __end_tp_report 09:14:55 INFO - PROCESS | 10197 | __start_cc_report 09:14:55 INFO - PROCESS | 10197 | _x_x_mozilla_cycle_collect,1000 09:14:55 INFO - PROCESS | 10197 | __end_cc_report 09:14:55 INFO - PROCESS | 10197 | __startTimestamp1451582095562__endTimestamp 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | ------- Summary: start ------- 09:14:55 INFO - PROCESS | 10197 | Number of tests: 14 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:3.97 (3.5%) stddev-sans-first:4.18 09:14:55 INFO - PROCESS | 10197 | Values: 112.0 114.0 109.0 112.0 114.0 112.0 105.0 115.0 112.0 103.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:155.00 stddev:15.59 (10.1%) stddev-sans-first:16.43 09:14:55 INFO - PROCESS | 10197 | Values: 156.0 132.0 154.0 172.0 139.0 167.0 153.0 132.0 170.0 136.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.25 (0.8%) stddev-sans-first:1.30 09:14:55 INFO - PROCESS | 10197 | Values: 161.0 162.0 163.0 159.0 162.0 161.0 163.0 162.0 163.0 161.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#3] audio-fft Cycles:10 Average:81.40 Median:74.00 stddev:13.54 (18.3%) stddev-sans-first:13.93 09:14:55 INFO - PROCESS | 10197 | Values: 72.0 72.0 83.0 93.0 75.0 71.0 72.0 112.0 91.0 73.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:98.00 stddev:17.58 (17.9%) stddev-sans-first:18.20 09:14:55 INFO - PROCESS | 10197 | Values: 98.0 99.0 133.0 98.0 97.0 98.0 134.0 97.0 99.0 136.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 09:14:55 INFO - PROCESS | 10197 | Values: 110.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 09:14:55 INFO - PROCESS | 10197 | Values: 146.0 147.0 146.0 147.0 147.0 146.0 147.0 147.0 147.0 147.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:14:55 INFO - PROCESS | 10197 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#8] json-parse-financial Cycles:10 Average:72.90 Median:71.50 stddev:4.15 (5.8%) stddev-sans-first:3.52 09:14:55 INFO - PROCESS | 10197 | Values: 80.0 72.0 73.0 71.0 71.0 71.0 71.0 81.0 69.0 70.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 09:14:55 INFO - PROCESS | 10197 | Values: 69.0 69.0 69.0 69.0 68.0 69.0 70.0 70.0 69.0 69.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:3.07 (3.6%) stddev-sans-first:3.07 09:14:55 INFO - PROCESS | 10197 | Values: 84.0 87.0 86.0 86.0 85.0 85.0 86.0 93.0 92.0 85.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:128.00 stddev:4.55 (3.6%) stddev-sans-first:4.82 09:14:55 INFO - PROCESS | 10197 | Values: 127.0 129.0 122.0 121.0 137.0 127.0 127.0 124.0 130.0 129.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:150.50 stddev:6.33 (4.2%) stddev-sans-first:6.26 09:14:55 INFO - PROCESS | 10197 | Values: 140.0 152.0 152.0 151.0 150.0 140.0 141.0 144.0 156.0 139.0 09:14:55 INFO - PROCESS | 10197 | 09:14:55 INFO - PROCESS | 10197 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:71.00 stddev:0.92 (1.3%) stddev-sans-first:0.97 09:14:55 INFO - PROCESS | 10197 | Values: 71.0 71.0 71.0 72.0 70.0 71.0 70.0 72.0 73.0 71.0 09:14:55 INFO - PROCESS | 10197 | -------- Summary: end -------- 09:14:55 INFO - PROCESS | 10197 | 09:14:56 INFO - TEST-INFO | 10197: exit 0 09:14:56 INFO - TEST-OK | kraken | took 61292ms 09:14:56 INFO - TEST-START | v8_7 09:14:56 INFO - operating with platform_type : linux_ 09:14:56 INFO - Initialising browser for v8_7 test... 09:14:56 INFO - TEST-INFO | started process 10446 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI0N7RQ/profile http://localhost:57743/getInfo.html) 09:15:01 INFO - PROCESS | 10446 | __metrics Screen width/height:1600/1200 09:15:01 INFO - PROCESS | 10446 | colorDepth:24 09:15:01 INFO - PROCESS | 10446 | Browser inner width/height: 1024/697 09:15:01 INFO - PROCESS | 10446 | __metrics 09:15:01 INFO - PROCESS | 10446 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 09:15:01 INFO - PROCESS | 10446 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:15:02 INFO - TEST-INFO | 10446: exit 0 09:15:02 INFO - Browser initialized. 09:15:02 INFO - Running cycle 1/1 for v8_7 test... 09:15:02 INFO - TEST-INFO | started process 10529 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpI0N7RQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:14 INFO - PROCESS | 10529 | RSS: Main: 149782528 09:15:14 INFO - PROCESS | 10529 | 09:15:35 INFO - PROCESS | 10529 | Cycle 1(1): loaded http://localhost:57743/tests/v8_7/run.html (next: http://localhost:57743/tests/v8_7/run.html) 09:15:36 INFO - PROCESS | 10529 | RSS: Main: 449273856 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | __start_tp_report 09:15:36 INFO - PROCESS | 10529 | _x_x_mozilla_page_load 09:15:36 INFO - PROCESS | 10529 | _x_x_mozilla_page_load_details 09:15:36 INFO - PROCESS | 10529 | |i|pagename|runs| 09:15:36 INFO - PROCESS | 10529 | |0;Richards;166.55562958027983 09:15:36 INFO - PROCESS | 10529 | |1;DeltaBlue;189.9335232668566 09:15:36 INFO - PROCESS | 10529 | |2;Encrypt;279.01785714285717 09:15:36 INFO - PROCESS | 10529 | |3;Decrypt;5240.837696335078 09:15:36 INFO - PROCESS | 10529 | |4;RayTrace;2000 09:15:36 INFO - PROCESS | 10529 | |5;Earley;801.924619085806 09:15:36 INFO - PROCESS | 10529 | |6;Boyer;12268.292682926829 09:15:36 INFO - PROCESS | 10529 | |7;RegExp;26921.052631578947 09:15:36 INFO - PROCESS | 10529 | |8;Splay;613.7339055793991 09:15:36 INFO - PROCESS | 10529 | |9;NavierStokes;4826.923076923077 09:15:36 INFO - PROCESS | 10529 | __end_tp_report 09:15:36 INFO - PROCESS | 10529 | __startTimestamp1451582136053__endTimestamp 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | ------- Summary: start ------- 09:15:36 INFO - PROCESS | 10529 | Number of tests: 10 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | [#0] Richards Cycles:1 Average:166.56 Median:166.56 stddev:0.00 (0.0%) 09:15:36 INFO - PROCESS | 10529 | Values: 166.6 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | [#1] DeltaBlue Cycles:1 Average:189.93 Median:189.93 stddev:0.00 (0.0%) 09:15:36 INFO - PROCESS | 10529 | Values: 189.9 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | [#2] Encrypt Cycles:1 Average:279.02 Median:279.02 stddev:0.00 (0.0%) 09:15:36 INFO - PROCESS | 10529 | Values: 279.0 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 09:15:36 INFO - PROCESS | 10529 | Values: 5240.8 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | [#4] RayTrace Cycles:1 Average:2000.00 Median:2000.00 stddev:0.00 (0.0%) 09:15:36 INFO - PROCESS | 10529 | Values: 2000.0 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 09:15:36 INFO - PROCESS | 10529 | Values: 801.9 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 09:15:36 INFO - PROCESS | 10529 | Values: 12268.3 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 09:15:36 INFO - PROCESS | 10529 | Values: 26921.1 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | [#8] Splay Cycles:1 Average:613.73 Median:613.73 stddev:0.00 (0.0%) 09:15:36 INFO - PROCESS | 10529 | Values: 613.7 09:15:36 INFO - PROCESS | 10529 | 09:15:36 INFO - PROCESS | 10529 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 09:15:36 INFO - PROCESS | 10529 | Values: 4826.9 09:15:36 INFO - PROCESS | 10529 | -------- Summary: end -------- 09:15:36 INFO - PROCESS | 10529 | 09:15:37 INFO - TEST-INFO | 10529: exit 0 09:15:37 INFO - TEST-OK | v8_7 | took 40549ms 09:15:37 INFO - SUITE-END | took 1219s 09:15:37 INFO - Completed test suite (00:20:20) 09:15:37 INFO - Working with test: dromaeo_css 09:15:37 INFO - Generating results file: dromaeo_css 09:15:37 INFO - Working with test: kraken 09:15:37 INFO - Generating results file: kraken 09:15:37 INFO - javascript benchmark 09:15:37 INFO - Working with test: v8_7 09:15:37 INFO - Generating results file: v8_7 09:15:37 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:15:37 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 09:15:37 INFO - process_Request line: dromaeo_css 6055.96 graph.html#tests=[[72,132,35]] 09:15:37 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:15:37 INFO - process_Request line: kraken 1539.10 graph.html#tests=[[232,132,35]] 09:15:37 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 09:15:38 INFO - process_Request line: v8_7 19649.53 graph.html#tests=[[230,132,35]] 09:15:38 INFO - RETURN: dromaeo_css: 6055.96 09:15:38 INFO - RETURN: kraken: 1539.10 09:15:38 INFO - RETURN: v8_7: 19649.53 09:15:38 INFO - javascript benchmark 09:15:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2584.366830126619, 2669.546177149883, 2672.1449136276374, 2686.086730511626, 2706.837589744615, 4416.249237629602, 4551.431071116111, 4554.0, 4554.339620754993, 4570.108828778381, 4533.184026875161, 4576.1762882681105, 4580.175568397687, 4659.836905708301, 4661.277501987189, 4216.578342165774, 4216.725912815665, 4228.4080228768, 4284.443022407083, 4296.140771845643, 4272.914541709164, 4297.677674174433, 4300.56994300569, 4309.0735491869245, 4344.97827510862, 4103.9179216415805, 4144.5026596808275, 4255.829766809324, 4259.063006138645, 4296.935545966798, 4211.3261878099665, 4241.978790106061, 4245.596668316505, 4265.019045619525, 4269.893252668677, 4208.200441916026, 4216.599423054836, 4220.556841531657, 4229.069604686964, 4257.254980378452, 4368.279233926399, 4495.887602809923, 4497.168023915553, 4556.157110934488, 4570.291604801261, 4790.904181916377, 4817.542333478314, 4822.927656085161, 4921.606271498307, 4936.358273424432, 4961.18140506816, 4973.0, 4976.850694479172, 4980.05378977993, 4997.50024997501, 4578.931316030262, 4606.124836281096, 4606.700564463299, 4616.238320677118, 4652.860414187546, 4735.266033764772, 4855.5387238212315, 4856.975715121473, 5058.013687331008, 5073.086844367976, 4763.4522029967, 4829.758512074382, 4830.0, 4830.734309612934, 4875.414950205998, 4879.536444037811, 4886.682365646222, 4889.657723959289, 4895.877603059952, 4898.485659005753, 4696.624270058455, 4829.275608658659, 4850.393700787402, 4854.344663470457, 4897.7795999180125, 4729.668923175344, 4751.501092385319, 4816.614670826326, 4838.540338667821, 4855.975720121447, 4077.7961101944784, 4095.32427149517, 4095.3242714952294, 4095.488063992001, 4133.966508372907, 3582.498450216972, 3585.1216451969435, 3590.389633762267, 3596.047047532406, 3612.4942508048894, 3967.940480892789, 4054.2296963576828, 4055.5944405559208, 4168.291390463568, 4265.232258193493, 4902.632302577321, 4927.95072049282, 4929.359183306219, 4943.802247910044, 4987.426445958688, 4204.159168166379, 4231.238377092153, 4238.17355615652, 4244.766537840386, 4276.2089013532595, 4191.140816132746, 4265.125649241898, 4296.677749168824, 4297.763623000703, 4338.457692788402, 4649.883752906069, 4670.9766451167525, 4672.229082201467, 4698.906021879543, 4719.787609557509, 4890.315355850113, 4890.462049174517, 4892.363992681071, 4894.0, 4942.5304596063315, 4548.295014272793, 4647.047355292089, 4656.254999200111, 4661.184292748823, 4665.743384113906, 4681.812727490862, 4737.265723812815, 4744.810207591658, 4745.193317136164, 4746.121967436035, 4753.976230118966, 4806.49531799156, 4811.591014763784, 4813.879653008563, 4877.1221180186485, 4711.19909615373, 4722.598579120676, 4728.739919304334, 4730.172219861442, 4754.096721622881, 4704.647151463585, 4705.435347758154, 4706.505816889177, 4710.364100846342, 4723.763811809465, 4451.854773089274, 4601.355810186509, 4610.377599024089, 4611.746353950431, 4633.189191891338, 4714.717116972993, 4724.48030716614, 4730.881727956828, 4739.312799644102, 4744.905101898012, 4678.321643361762, 4678.485366609738, 4678.50875658051, 4695.436547614308, 4724.196886529229], "unit": "score", "name": "dojo.html", "value": 4478.505485763468}, {"lowerIsBetter": false, "replicates": [521.8356217791393, 550.3725752641991, 576.6943519934435, 579.5103137848516, 583.5448350286778, 24684.0, 34077.31845363091, 34984.82507587465, 34995.12512187196, 35008.0, 38683.22633547327, 39135.21729565407, 39168.804155979255, 39202.8039859801, 39286.21427571447, 6608.372204640552, 6686.665666716644, 7956.0, 7967.521948683097, 8045.316148127416, 9785.070418310284, 10081.44552049637, 10099.949500252489, 10109.342892711988, 10109.59561617538, 9640.75898102546, 9753.95123024384, 9756.0, 9757.073078057572, 9763.21894248462, 6952.478564107687, 7086.185088714812, 9654.275929305295, 9811.950940245324, 10026.0, 9536.475493847836, 9783.559739811726, 9793.363431376938, 9801.362911410806, 9802.607895684165, 31517.36965260682, 31964.360712785845, 31975.6802431975, 31998.520022199686, 32046.359072818414, 2760.7791376689815, 2763.585462180669, 2830.05193260256, 2846.146156153146, 2946.8231906085703, 27672.58491122635, 27975.720242797513, 28130.0, 28210.15369538917, 28515.57226641602, 3376.3172490293946, 3508.438649816043, 3510.7366947478786, 3573.678368946781, 3624.4925710400566, 221502.0, 222830.99999999837, 222917.0, 223077.0, 223168.0, 52910.973457521475, 53350.199747003826, 53353.46646533485, 53385.1992220117, 53452.73273633607, 47438.28842567364, 48424.0, 56182.71908640512, 57774.7111264441, 58148.0, 11990.460429280703, 11991.460384282727, 12053.397330133459, 12084.879151208552, 12139.939300303618, 10226.437545935045, 10307.793844123225, 10321.793564128826, 10328.277020608486, 10346.0, 16895.324187032627, 16916.0, 17149.485515434557, 17157.57106072358, 17187.570310742332, 7302.1967583565765, 7436.3679087277105, 7553.73561925341, 7566.497933729423, 7608.315251627269, 743.6579173580105, 745.4334705623766, 763.4045444553258, 801.2668408406244, 927.2118699105706, 26022.34944126412, 26588.202353929413, 27325.590116148273, 27390.726092738816, 27496.312592185357, 866.4108406283788, 882.9381943264038, 915.2174890468686, 949.2785483032944, 951.6669165792056, 11982.58060967862, 12391.75216495665, 12395.62813115608, 14112.435502579781, 14536.200508971897, 267627.0, 276383.0, 276898.0, 277243.0, 277495.0, 41612.167756644696, 41621.0, 41725.0, 41758.37362439505, 41761.0, 1220.3166226912956, 1222.2177806204036, 1240.55340077572, 1245.3399698159628, 1248.8126780982743, 20860.0, 26117.608235876098, 26878.462430751668, 27439.862800685867, 27441.86279068592, 36070.0, 36856.26287474289, 36864.26271474502, 36965.445518317785, 36973.0, 164933.17533412256, 165357.0, 166787.0, 167236.0, 167351.163244183, 24125.03499859986, 24649.0, 25923.481530369663, 26349.341266467723, 27825.44349113047, 32850.34299313952, 33536.49695254524, 33768.0, 33829.83085084657, 33895.66104338925, 28352.432951340445, 28685.713142868302, 31381.68618313879, 33050.173745655586, 33717.83141084279, 29146.7085329144, 29223.85388073046, 29418.705812941596, 29433.85283073571, 29450.11649650514, 29512.852435737685, 29845.70154298516, 32467.837660811543, 33056.338873222885, 33182.5022624656, 25203.495930081663, 27059.323516912234, 27106.593401099395, 27143.59284610772, 27201.59197612077, 21219.575608487434, 21479.677804833253, 21699.674504882125, 21714.565708685423, 21750.238741643967], "unit": "score", "name": "ext.html", "value": 16176.769635513136}, {"lowerIsBetter": false, "replicates": [329.706561160567, 336.8719886443152, 337.50892451483094, 339.3772427595362, 339.6705195959919, 12313.815292770616, 12827.743445131091, 14839.925800370997, 15214.315355808987, 15598.454054108108, 8525.445846020004, 8815.955920220405, 10729.946350268257, 11469.197156199069, 12856.100072994894, 4376.912461750755, 4500.549945005506, 4520.2089634314025, 4521.773911304438, 4525.072360166158, 3411.5394421752994, 4460.063386688799, 4495.820167193308, 5114.923276150861, 5131.281620573122, 5080.974595127019, 5100.41345245296, 5112.923306150411, 5117.309163262968, 5122.92315615266, 5121.411037730652, 5495.862603434906, 5501.642393244446, 5503.2020357048405, 5511.311086114236, 4900.436449808282, 4903.53416425439, 4904.288878112689, 4916.041371932474, 4918.336024636664, 11494.195406321562, 15006.0, 16634.916825415796, 17110.828891711048, 17125.31498740049, 1710.1021963469154, 1749.0, 1758.841704246624, 1764.700000999833, 1799.38820800927, 8789.868151977726, 8796.384253102286, 11617.535298588047, 11833.467493962793, 11983.580574679845, 1620.5219460259134, 1743.8517725993306, 1755.6839768841603, 1767.054625775217, 1803.5040363899902, 50614.24078638823, 53160.734196329155, 53251.467485325426, 53596.19605705918, 54149.187762183596, 9419.105185007413, 9586.424814511152, 9593.712188634352, 9664.081912218327, 9739.853902191331, 12165.695857603454, 12186.268823870596, 12193.024558035337, 12205.084618653636, 12213.572524961584, 6657.700403481855, 6837.555558888656, 6950.096487456598, 6986.021956926034, 7061.152661680631, 6761.391474767294, 6807.944768560881, 6826.897596536056, 6852.897206541906, 6883.965580172167, 3894.727369084137, 3941.6452519273403, 3998.0, 4009.0177906413114, 4053.61490658387, 1555.1757568488492, 1568.1061794777095, 1615.402301148559, 1627.6337823989745, 1705.8208888066574, 785.4501848705929, 839.9263571677437, 885.7431344910033, 922.2714055895901, 931.3527098666361, 15111.848881511045, 15636.3745450183, 15671.294791734399, 15990.120543369994, 16077.758833617505, 819.496009953874, 855.3242938078972, 857.2554850878432, 857.6869442653386, 894.3828758156981, 8674.349423793241, 8983.775405614912, 9025.23285520725, 9165.266778657691, 9218.723438296862, 459814.0, 478240.7407407399, 490536.0, 490785.0, 495178.0, 66078.0, 66745.0, 67060.66469667718, 67155.0, 67378.0, 917.2341095185594, 962.2879069488528, 1012.0537297626743, 1029.624187171692, 1030.4744580263969, 13465.932670336586, 13896.444142234603, 14127.364268608142, 14206.78689819633, 14366.209858457885, 29676.0, 30028.24929376783, 30277.545836812023, 30417.23956901095, 30734.53898191484, 38266.808665956494, 39703.80148099356, 39771.2045759089, 40097.39853902136, 41268.38097428601, 2386.391470175094, 4873.683210591442, 8163.306118979715, 8166.142555031874, 8314.0, 9276.443413395218, 12882.742345152858, 16285.67428651444, 16606.833931660527, 16854.241559129623, 9569.712908612475, 11876.346800926032, 13364.398602062736, 13556.389962451516, 13893.166410015432, 11842.644720658394, 12533.310667912987, 12862.421191046613, 12975.221486710827, 13033.543825966046, 10299.3820370778, 10374.221933354878, 13766.793498097737, 13789.310534473438, 13954.37205325783, 7432.777016689508, 8026.197380262161, 8197.83604327922, 8564.0, 8651.48091114535, 8931.866022009544, 10721.839172412576, 13349.0, 13530.526431574848, 13560.38978246001], "unit": "score", "name": "jquery.html", "value": 7801.803286712933}, {"lowerIsBetter": false, "replicates": [1147.6614398752367, 1178.734784673448, 1181.161375423449, 1241.0319950438654, 1504.4583949778084, 5753.4246575342495, 6441.259255185655, 6585.341465853412, 6588.967055164718, 6590.835229119274, 6771.153605799275, 6969.930300696991, 6972.651367431621, 6973.337532934376, 6979.197392299887, 2028.3509277031355, 2065.7004734313514, 2069.9068541915576, 2076.9896150519226, 2077.66757318829, 2051.2615458434952, 2059.330717516813, 2062.175129948018, 2106.7682554918947, 2128.648772952461, 2038.2254743197564, 2054.291269512016, 2081.5524662197627, 2084.4684605425673, 2084.4893001214723, 2028.9188432462759, 2059.011674396291, 2061.5567652954537, 2062.9174833006664, 2063.597598468299, 2079.2826474866147, 2111.1344348817065, 2128.435964469417, 2133.125418578391, 2137.7648458669532, 7006.299370063004, 7113.928860711379, 7114.039604653409, 7115.53749006313, 7121.501494895359, 3928.626780455852, 4008.358662613997, 4018.2365350583295, 4035.778032208227, 4040.151568170688, 2582.8321159124785, 2617.3849145450804, 2650.7614314711577, 2654.309879431362, 2659.574468085097, 785.8899754034439, 795.550513959611, 808.1958451340895, 828.5484410996022, 847.3136759225048, 9078.727638170865, 9089.772755681095, 9099.772505687344, 9100.8634870477, 9109.726708198765, 3758.5489741231227, 3791.336516109725, 3825.617438256152, 3850.8074596270076, 3853.788041657736, 8004.879926801103, 8007.079185893696, 8011.7997050073045, 8016.238457346542, 8028.9197108028175, 4021.577734337911, 4021.6380525752825, 4071.776052317151, 4073.246449406869, 4076.30702780528, 2980.5976193214074, 3049.573059771634, 3568.2149927016017, 3583.086312990171, 3601.3877640801124, 3198.6641402652854, 3204.1829333519804, 3229.7254733347927, 3240.7731458797657, 3247.967520324814, 971.4705485510414, 999.3604093380243, 1004.5730564510054, 1009.5557954500143, 1013.1843865688045, 842.1914961636897, 858.7638399440204, 860.0195776814437, 920.663957655451, 1027.3322340478749, 6266.467350275187, 6397.200349956255, 6447.194100737408, 6467.094606755058, 6467.256265529524, 399.22749479756766, 403.57019773941244, 1020.8928062553325, 1038.133158812385, 1074.4573990134932, 5259.395169555473, 5336.573074154058, 5349.277847490617, 5351.678899266057, 5355.3841308249275, 8259.8348033039, 8273.8345233095, 8423.831523369498, 8428.410011299273, 8493.193146651058, 8364.456310339809, 8429.114942930904, 8429.536375499283, 8433.620487078097, 8438.493690378597, 6364.777232796922, 6600.0, 6661.866762664719, 6675.299093595199, 6678.766243181465, 6511.706973186123, 6572.375624315682, 6585.176852893388, 6588.40704336612, 6593.208814942238, 7273.636318183963, 7418.9629051856555, 7492.363149132385, 7533.0, 7554.357879580297, 7505.286997735207, 7578.507397019176, 7674.347680447225, 7783.1827658097345, 7783.766487005399, 5194.584433245407, 5278.630495865406, 5937.554683398676, 5948.583599148018, 6010.669413182317, 6446.129772480655, 6571.967140164268, 6584.670766461753, 6610.206775187008, 6613.503987200883, 6061.181740465157, 6136.110264011604, 6178.721957511832, 6236.968815155895, 6413.390727880844, 5956.851078723066, 5996.640201587918, 6038.939610604013, 6039.849003774941, 6071.058985857199, 6139.386061393825, 6232.781852635136, 6241.8751624966335, 6281.685915704105, 6283.3402492737605, 5825.679587622722, 5857.619254748428, 5859.94140058594, 5862.94137058641, 5865.706714664335, 5807.245058142415, 5846.269216347957, 5859.091840764689, 5904.409559044061, 5907.763689452374], "unit": "score", "name": "mootools.html", "value": 3906.447536546224}, {"lowerIsBetter": false, "replicates": [297.3710602076608, 299.95650630658554, 302.43746631265844, 304.0953164336099, 305.1486353074921, 5231.39838918524, 5291.576673866091, 5308.787648494061, 5360.91958620621, 5394.811181608645, 5201.661891977019, 5274.05067087924, 5301.5228629423345, 5306.814261500848, 5322.520973112419, 3924.1366899282257, 4122.381642753596, 4130.318497447917, 4134.8966275843195, 4138.2758017347, 3993.381025940984, 4001.8999525011964, 4074.8777536673947, 4081.2041651877894, 4088.7546747195265, 4006.9599304007024, 4031.0325521874684, 4033.394990751396, 4035.8587449439274, 4076.7362117743596, 3846.59610740871, 3924.7645141291614, 3955.406688996645, 4072.9592704073025, 4083.9591604084026, 3556.110972256936, 3556.7865928044143, 3573.249617580311, 3584.62361452049, 3585.695215906651, 5020.272060551236, 5031.0441016206805, 5033.7734801934, 5034.421041580228, 5061.392632884041, 4680.0, 4681.110588988081, 4691.741954192518, 4693.342931989524, 4700.341952126705, 5380.596455265871, 5544.417836127229, 5547.528460080898, 5552.944470555323, 5592.804251851207, 3942.093318536724, 3944.7830369329677, 3947.131631041166, 3947.4473573699706, 3951.1900060487533, 5781.739821708034, 5856.443637854397, 5869.354371019142, 5871.794487192928, 5878.323992740804, 4047.919041619151, 4049.0889549851636, 4050.594940505926, 4055.918881622351, 4056.249593825152, 3866.7486613370043, 3961.9405708914387, 4090.0183955850976, 4104.0970986382945, 4107.219628270619, 4142.171565686875, 4538.183127037165, 4540.477845047796, 4568.109218702321, 4635.976820115945, 5398.082326004589, 5488.231647569343, 5550.91673624896, 5564.582656300713, 5576.581756368289, 1425.5367005722974, 1447.3197597129333, 1448.2541491132076, 1448.2686243446992, 1449.3333066789185, 974.5955428497236, 988.7528117970508, 992.1318846009741, 1000.1398797034544, 1006.5772375602264, 4874.341963834837, 4882.316475693406, 4885.633577481632, 4889.65772395936, 4890.315355850184, 5784.421557844182, 5788.247527821356, 5788.768449261982, 5790.88418231633, 5791.073428251544, 4839.975800120977, 4855.247436647325, 4863.732494712754, 4874.805007799649, 4875.975620121877, 3046.34503581731, 3078.1535077853323, 3112.3152906360565, 3116.2520994961046, 3119.641241257239, 5510.91733623988, 5543.556515478752, 5558.610897237155, 5577.386487486373, 5578.693171875505, 5997.70011499432, 6008.489278411384, 6009.2188015557695, 6011.1884895539415, 6015.729292181863, 5557.638753481092, 5559.499645031967, 5566.081596536607, 5566.997940370772, 5570.303712035996, 5664.348599911063, 5812.738426770721, 5816.883662326645, 5828.854278642898, 5836.591438599257, 5680.6591604503865, 5684.602077854676, 5693.345265294544, 5695.800646977336, 5697.6296540724725, 5548.334199896039, 5551.555875529867, 5555.583331250254, 5561.1658251261015, 5563.554915606823, 3788.943165852459, 3867.9806600966817, 3914.5693973662305, 3917.0011647029824, 3921.3333733265986, 5707.400722924033, 5708.429157084258, 5709.0, 5709.229254050816, 5716.5998380113, 5488.4237155098135, 5550.722463876709, 5556.055470569932, 5559.16612508127, 5572.498475137095, 5556.111022236423, 5568.248286481273, 5569.359523654832, 5570.944290557042, 5588.077967135539, 5323.414424413389, 5517.393086760373, 5518.2826232589505, 5519.862003449946, 5527.977324195037, 5416.647917885325, 5573.7770489179975, 5655.434456554476, 5657.632253903483, 5662.03745363281, 5292.682439053515, 5469.0, 5472.835814925558, 5483.369412517612, 5491.972540137273], "unit": "score", "name": "prototype.html", "value": 4180.994482126237}, {"lowerIsBetter": false, "replicates": [635.1742734445221, 675.1425689374495, 762.2453770766942, 785.9292663660269, 803.6102490292208, 10790.190735694825, 10961.0, 10971.945140274298, 10980.835287470674, 10982.780344393108, 10823.080038196762, 10935.343879367243, 10941.945290273557, 10943.726406839833, 10949.343039417621, 614.443928244939, 623.803501896901, 624.9312575616678, 774.0865778381522, 779.7621725373758, 790.6955822008539, 795.6419611174965, 802.2378740196807, 802.3460879383313, 802.4022103532847, 831.1522247307743, 834.4492634860993, 834.6369329341726, 835.3275613131457, 836.3058661311097, 622.9096780966757, 629.7355110853407, 816.8611336072881, 831.8211584509329, 834.2825170353491, 618.3630860213987, 618.9473894718955, 619.2228752915063, 620.9565330426872, 621.4344946099073, 10573.207009474243, 10722.946385268024, 10730.248882578222, 10737.83893241602, 10748.677539673823, 9940.453275069869, 10347.689569312932, 10465.47672616366, 10550.577976880915, 11158.274712143684, 8911.688090916852, 9165.358424910259, 9630.374025688378, 9836.016398360178, 9888.653897113638, 3181.18879685681, 3231.515272709089, 3238.757093218018, 3246.5617141685807, 3246.8376581171083, 39832.80083599593, 40217.79891100526, 40239.7988010061, 40287.39568906469, 40395.0, 7895.763127106196, 7908.52548847071, 8189.303909167668, 8241.175882411711, 8328.6668533258, 12987.935060324828, 15384.538463846102, 15386.076835389913, 15390.615234619225, 15413.383464661512, 6098.5426093042315, 6108.5723999319625, 6134.6625935573975, 6191.504679625619, 6320.367963203643, 3466.9133271667906, 3567.1973805893986, 3627.764195327295, 3642.581103173116, 3644.726645501598, 2612.673415823022, 2642.4715056988293, 2647.033832651107, 2648.4835457085683, 2649.205238428502, 451.4221796100996, 453.0327750253233, 453.5691093461225, 462.52591094128786, 463.2888516127795, 402.0792385437374, 404.4479285774955, 415.16551731020866, 421.9662427005832, 433.9761313127745, 7164.21193668696, 7234.746783862644, 7345.853082938418, 7862.52824830512, 7871.252231038042, 422.76536522229844, 505.55511150188335, 513.4659953648164, 513.6917849290396, 602.1660000898787, 3257.397381484433, 3609.205974685565, 3619.1314084619503, 3657.6159503251774, 3662.7252956027874, 49492.25761613579, 49550.256746148116, 49573.25640115401, 49599.256011159865, 50649.24026139611, 42876.35685464721, 43164.352534712, 43266.783666081465, 44041.11917761627, 44262.55737442649, 38820.0, 38830.805845971154, 38944.80527597344, 38989.610103898594, 40207.396889046686, 7218.3503484686635, 7378.520396174232, 7539.208383119693, 7559.622018899143, 7812.335951444191, 29248.56127158137, 29795.0, 29816.10551683453, 30005.549916750828, 30124.84937575298, 34795.478067828495, 35021.29957400889, 38393.80803096078, 38720.2255954885, 38770.6122938767, 8603.52680602573, 8872.290216782512, 8889.111088891059, 9238.815223695623, 9341.57962891658, 9652.662156824477, 9720.41677499324, 10024.348417352849, 10058.49707514636, 10481.37111773296, 9055.773605659911, 9179.816403672023, 9262.814743705223, 9316.0, 9332.766680833034, 8846.690365837165, 9051.818963620559, 9080.091990800867, 9198.310126740655, 9201.171894529256, 9181.219596334386, 9318.860217096884, 9323.766905827137, 9328.440293582407, 9334.813303734023, 8443.577821108796, 8452.66189352419, 8537.871931920901, 8574.072784085702, 8623.82752344937, 7438.479306448713, 8024.197580241929, 8070.273675369245, 8104.554249516334, 8254.752357429286], "unit": "score", "name": "yui.html", "value": 5342.833609767664}], "name": "dromaeo_css", "value": 6055.9615866145905}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 109.0, 112.0, 114.0, 112.0, 105.0, 115.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [156.0, 132.0, 154.0, 172.0, 139.0, 167.0, 153.0, 132.0, 170.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 151.1}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 163.0, 159.0, 162.0, 161.0, 163.0, 162.0, 163.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 83.0, 93.0, 75.0, 71.0, 72.0, 112.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [98.0, 99.0, 133.0, 98.0, 97.0, 98.0, 134.0, 97.0, 99.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [80.0, 72.0, 73.0, 71.0, 71.0, 71.0, 71.0, 81.0, 69.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 70.0, 70.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [84.0, 87.0, 86.0, 86.0, 85.0, 85.0, 86.0, 93.0, 92.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [127.0, 129.0, 122.0, 121.0, 137.0, 127.0, 127.0, 124.0, 130.0, 129.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.3}, {"lowerIsBetter": true, "replicates": [140.0, 152.0, 152.0, 151.0, 150.0, 140.0, 141.0, 144.0, 156.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 72.0, 70.0, 71.0, 70.0, 72.0, 73.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.2}], "name": "kraken", "value": 1539.1000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.55562958027983], "unit": "score", "name": "Richards", "value": 211.95320800000005}, {"lowerIsBetter": false, "replicates": [189.9335232668566], "unit": "score", "name": "DeltaBlue", "value": 348.11126999999993}, {"lowerIsBetter": false, "replicates": [279.01785714285717], "unit": "score", "name": "Encrypt", "value": 953.9927040000001}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [2000.0], "unit": "score", "name": "RayTrace", "value": 369.9945}, {"lowerIsBetter": false, "replicates": [801.924619085806], "unit": "score", "name": "Earley", "value": 831.079361}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [613.7339055793991], "unit": "score", "name": "Splay", "value": 132.77904195804194}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 19649.52873883312}]} 09:15:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19649.53"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1539.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6055.96"}}} 09:15:38 INFO - Return code: 0 09:15:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:15:38 INFO - # TBPL SUCCESS # 09:15:38 INFO - Running post-action listener: _resource_record_post_action 09:15:38 INFO - Running post-run listener: _resource_record_post_run 09:15:39 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549163008; Read time: 16; Write time: 461604 09:15:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 234672128; Read time: 0; Write time: 237040 09:15:39 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313626624; Read time: 16; Write time: 224512 09:15:39 INFO - Running post-run listener: _upload_blobber_files 09:15:39 INFO - Blob upload gear active. 09:15:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:15:39 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 09:15:39 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'] 09:15:39 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 09:15:39 INFO - (blobuploader) - INFO - Open directory for files ... 09:15:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:15:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:15:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:40 INFO - (blobuploader) - INFO - Done attempting. 09:15:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:15:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:15:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:41 INFO - (blobuploader) - INFO - Done attempting. 09:15:41 INFO - (blobuploader) - INFO - Iteration through files over. 09:15:41 INFO - Return code: 0 09:15:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:15:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:15:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6c9ee81b20de1729a7cae5a8539723d9b3294a7987971383771ac10c4820fe60f8f215571602554a667525486b30d93a5a5d535da070d108e50fb012e2ffd60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f81e0aed0ca2860b7d77f54f52419a56acb1e7cf95b244260a6304437e3c12aba0cdaf72ff1ba618bf22c9922b94932824c06ba6d99fb18c48f249cf485babb"} 09:15:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:15:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:15:41 INFO - Contents: 09:15:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a6c9ee81b20de1729a7cae5a8539723d9b3294a7987971383771ac10c4820fe60f8f215571602554a667525486b30d93a5a5d535da070d108e50fb012e2ffd60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f81e0aed0ca2860b7d77f54f52419a56acb1e7cf95b244260a6304437e3c12aba0cdaf72ff1ba618bf22c9922b94932824c06ba6d99fb18c48f249cf485babb"} 09:15:41 INFO - Copying logs to upload dir... 09:15:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1275.181398 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-31 09:15:41.048890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 09:15:41.052428) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848 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/a6c9ee81b20de1729a7cae5a8539723d9b3294a7987971383771ac10c4820fe60f8f215571602554a667525486b30d93a5a5d535da070d108e50fb012e2ffd60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f81e0aed0ca2860b7d77f54f52419a56acb1e7cf95b244260a6304437e3c12aba0cdaf72ff1ba618bf22c9922b94932824c06ba6d99fb18c48f249cf485babb"} build_url:https://queue.taskcluster.net/v1/task/LiViTvU2QeuOk62av5h7xw/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011260 build_url: 'https://queue.taskcluster.net/v1/task/LiViTvU2QeuOk62av5h7xw/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/a6c9ee81b20de1729a7cae5a8539723d9b3294a7987971383771ac10c4820fe60f8f215571602554a667525486b30d93a5a5d535da070d108e50fb012e2ffd60", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3f81e0aed0ca2860b7d77f54f52419a56acb1e7cf95b244260a6304437e3c12aba0cdaf72ff1ba618bf22c9922b94932824c06ba6d99fb18c48f249cf485babb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 09:15:41.077019) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 09:15:41.077372) ========= 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=7f67ac1ceef7774224e327f2000001f6-1451574185.775182-349112848 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 09:15:41.159862) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 09:15:41.160194) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 09:15:41.160481) ========= ========= Total master_lag: 0.29 =========