builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-062 starttime: 1451954724.64 results: success (0) buildid: 20160104161139 builduid: cf6f93ad33d44061802b0216120aa129 revision: c38424a542eb0e9149d4adabfe1db57bd390f398 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.642394) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.643126) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.643630) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006482 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.692942) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.693740) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.762281) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.762541) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004681 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.818254) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.818561) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.818942) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.819510) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-04 16:45: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% 226M=0s 2016-01-04 16:45:25 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130621 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.974037) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:24.974355) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015287 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:25.031926) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:25.032264) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c38424a542eb0e9149d4adabfe1db57bd390f398 --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 c38424a542eb0e9149d4adabfe1db57bd390f398 --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=a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-04 16:45:25,325 truncating revision to first 12 chars 2016-01-04 16:45:25,325 Setting DEBUG logging. 2016-01-04 16:45:25,325 attempt 1/10 2016-01-04 16:45:25,325 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c38424a542eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-04 16:45:25,699 unpacking tar archive at: fx-team-c38424a542eb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652959 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:25.701866) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:25.702497) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:25.716147) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:25.716580) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-04 16:45:25.717185) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-04 16:45:25.717585) ========= /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=a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:45:26 INFO - MultiFileLogger online at 20160104 16:45:26 in /builds/slave/test 16:45: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 16:45:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:45:26 INFO - {'append_to_log': False, 16:45:26 INFO - 'base_work_dir': '/builds/slave/test', 16:45:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:45:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:45:26 INFO - 'branch': 'Fx-Team-Non-PGO', 16:45:26 INFO - 'buildbot_json_path': 'buildprops.json', 16:45:26 INFO - 'config_files': ('talos/linux_config.py',), 16:45:26 INFO - 'default_actions': ('clobber', 16:45:26 INFO - 'read-buildbot-config', 16:45:26 INFO - 'download-and-extract', 16:45:26 INFO - 'populate-webroot', 16:45:26 INFO - 'create-virtualenv', 16:45:26 INFO - 'install', 16:45:26 INFO - 'run-tests'), 16:45:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:45:26 INFO - 'download_minidump_stackwalk': True, 16:45:26 INFO - 'download_symbols': 'ondemand', 16:45:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:45:26 INFO - 'tooltool.py': '/tools/tooltool.py', 16:45:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:45:26 INFO - '/tools/misc-python/virtualenv.py')}, 16:45:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:45:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:45:26 INFO - 'installer_path': 'installer.exe', 16:45:26 INFO - 'log_level': 'info', 16:45:26 INFO - 'log_name': 'talos', 16:45:26 INFO - 'log_to_console': True, 16:45:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:45:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:45:26 INFO - 'opt_config_files': (), 16:45:26 INFO - 'pip_index': False, 16:45:26 INFO - 'sps_profile': False, 16:45:26 INFO - 'sps_profile_interval': 0, 16:45:26 INFO - 'suite': 'dromaeojs', 16:45:26 INFO - 'system_bits': '32', 16:45:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:45:26 INFO - 'title': 'talos-linux64-ix-062', 16:45:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:45:26 INFO - 'use_talos_json': True, 16:45:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:45:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:45:26 INFO - 'work_dir': 'build'} 16:45:26 INFO - ##### 16:45:26 INFO - ##### Running clobber step. 16:45:26 INFO - ##### 16:45:26 INFO - Running pre-action listener: _resource_record_pre_action 16:45:26 INFO - Running main action method: clobber 16:45:26 INFO - rmtree: /builds/slave/test/build 16:45:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:45:26 INFO - Running post-action listener: _resource_record_post_action 16:45:26 INFO - ##### 16:45:26 INFO - ##### Running read-buildbot-config step. 16:45:26 INFO - ##### 16:45:26 INFO - Running pre-action listener: _resource_record_pre_action 16:45:26 INFO - Running main action method: read_buildbot_config 16:45:26 INFO - Using buildbot properties: 16:45:26 INFO - { 16:45:26 INFO - "project": "", 16:45:26 INFO - "product": "firefox", 16:45:26 INFO - "script_repo_revision": "production", 16:45:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:45:26 INFO - "repository": "", 16:45:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:45:26 INFO - "buildid": "20160104161139", 16:45:26 INFO - "pgo_build": "False", 16:45:26 INFO - "basedir": "/builds/slave/test", 16:45:26 INFO - "buildnumber": 2287, 16:45:26 INFO - "slavename": "talos-linux64-ix-062", 16:45:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 16:45:26 INFO - "platform": "ubuntu64_hw", 16:45:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:45:26 INFO - "branch": "fx-team", 16:45:26 INFO - "repo_path": "integration/fx-team", 16:45:26 INFO - "revision": "c38424a542eb0e9149d4adabfe1db57bd390f398", 16:45:26 INFO - "stage_platform": "linux64", 16:45:26 INFO - "builduid": "cf6f93ad33d44061802b0216120aa129", 16:45:26 INFO - "slavebuilddir": "test" 16:45:26 INFO - } 16:45:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:45:26 INFO - Running post-action listener: _resource_record_post_action 16:45:26 INFO - ##### 16:45:26 INFO - ##### Running download-and-extract step. 16:45:26 INFO - ##### 16:45:26 INFO - Running pre-action listener: _resource_record_pre_action 16:45:26 INFO - Running main action method: download_and_extract 16:45:26 INFO - mkdir: /builds/slave/test/build/tests 16:45: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')]} 16:45:26 INFO - https://queue.taskcluster.net/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:45:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/test_packages.json 16:45:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/test_packages.json 16:45:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:45:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:45:34 INFO - Downloaded 1302 bytes. 16:45:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:45:34 INFO - Using the following test package requirements: 16:45:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:45:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:45:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:34 INFO - u'jsshell-linux-x86_64.zip'], 16:45:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:45:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:45:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:45:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:45:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:45:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:45:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:45:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:45:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:45: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')]} 16:45:34 INFO - https://queue.taskcluster.net/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:45:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/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 16:45:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/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 16:45:37 INFO - Downloaded 21949638 bytes. 16:45:37 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 16:45:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:37 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 16:45:38 INFO - Return code: 0 16:45:38 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 16:45:38 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')]} 16:45:38 INFO - https://queue.taskcluster.net/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/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 16:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/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 16:45:40 INFO - Downloaded 21949638 bytes. 16:45:40 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 16:45:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:45:40 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 16:45:41 INFO - Return code: 0 16:45:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:41 INFO - https://queue.taskcluster.net/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:45:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:45:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:45:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/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 16:45:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/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 16:45:42 INFO - Downloaded 11132285 bytes. 16:45:42 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 16:45:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:45:42 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 16:45:43 INFO - Return code: 0 16:45:43 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')]} 16:45:43 INFO - https://queue.taskcluster.net/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:45:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:45:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:45:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/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 16:45:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/MuqKpOkGR5mG65NoASbOXQ/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 16:45:44 INFO - Downloaded 53376623 bytes. 16:45:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:45:44 INFO - mkdir: /builds/slave/test/properties 16:45:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:45:44 INFO - Writing to file /builds/slave/test/properties/build_url 16:45:44 INFO - Contents: 16:45:44 INFO - build_url:https://queue.taskcluster.net/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:45:44 INFO - Running post-action listener: _resource_record_post_action 16:45:44 INFO - Running post-action listener: set_extra_try_arguments 16:45:44 INFO - ##### 16:45:44 INFO - ##### Running populate-webroot step. 16:45:44 INFO - ##### 16:45:44 INFO - Running pre-action listener: _resource_record_pre_action 16:45:44 INFO - Running main action method: populate_webroot 16:45:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:45:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:45:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:45:44 INFO - '--tppagecycles', 16:45:44 INFO - '7'], 16:45:44 INFO - 'tests': ['tsvgm']}}, 16:45:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:45:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:45:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:45:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:45:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:45:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:45:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:44 INFO - 'talos_options': ['--e10s'], 16:45:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:45:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:44 INFO - 'tests': ['damp', 'tps']}, 16:45:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:44 INFO - 'talos_options': ['--e10s'], 16:45:44 INFO - 'tests': ['damp', 'tps']}, 16:45:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:45:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:45:44 INFO - 'other': {'tests': ['a11yr', 16:45:44 INFO - 'ts_paint', 16:45:44 INFO - 'tpaint', 16:45:44 INFO - 'sessionrestore', 16:45:44 INFO - 'sessionrestore_no_auto_restore']}, 16:45:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:45:44 INFO - 'tests': ['a11yr', 16:45:44 INFO - 'ts_paint', 16:45:44 INFO - 'tpaint', 16:45:44 INFO - 'sessionrestore', 16:45:44 INFO - 'sessionrestore_no_auto_restore']}, 16:45:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:45:44 INFO - 'tests': ['a11yr', 16:45:44 INFO - 'ts_paint', 16:45:44 INFO - 'tpaint', 16:45:44 INFO - 'sessionrestore', 16:45:44 INFO - 'sessionrestore_no_auto_restore']}, 16:45:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:45:44 INFO - 'tests': ['a11yr', 16:45:44 INFO - 'ts_paint', 16:45:44 INFO - 'tpaint', 16:45:44 INFO - 'sessionrestore', 16:45:44 INFO - 'sessionrestore_no_auto_restore']}, 16:45:44 INFO - 'other_l64': {'tests': ['a11yr', 16:45:44 INFO - 'ts_paint', 16:45:44 INFO - 'tpaint', 16:45:44 INFO - 'sessionrestore', 16:45:44 INFO - 'sessionrestore_no_auto_restore']}, 16:45:44 INFO - 'other_nol64': {'tests': ['a11yr', 16:45:44 INFO - 'ts_paint', 16:45:44 INFO - 'tpaint', 16:45:44 INFO - 'sessionrestore', 16:45:44 INFO - 'sessionrestore_no_auto_restore']}, 16:45:44 INFO - 'svgr': {'tests': ['tsvgx', 16:45:44 INFO - 'tsvgr_opacity', 16:45:44 INFO - 'tart', 16:45:44 INFO - 'tscrollx', 16:45:44 INFO - 'cart']}, 16:45:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:45:44 INFO - 'tests': ['tsvgx', 16:45:44 INFO - 'tsvgr_opacity', 16:45:44 INFO - 'tart', 16:45:44 INFO - 'tscrollx', 16:45:44 INFO - 'cart']}, 16:45:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:44 INFO - 'tests': ['tp5o']}, 16:45:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:44 INFO - 'talos_options': ['--e10s'], 16:45:44 INFO - 'tests': ['tp5o']}, 16:45:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:44 INFO - 'talos_options': ['--xperf_path', 16:45:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:44 INFO - 'tests': ['tp5n']}, 16:45:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:45:44 INFO - 'talos_options': ['--e10s', 16:45:44 INFO - '--xperf_path', 16:45:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:45:44 INFO - 'tests': ['tp5n']}}, 16:45:44 INFO - 'talos.zip': {'path': '', 16:45:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:45:44 INFO - Running post-action listener: _resource_record_post_action 16:45:44 INFO - ##### 16:45:44 INFO - ##### Running create-virtualenv step. 16:45:44 INFO - ##### 16:45:44 INFO - Running pre-action listener: _resource_record_pre_action 16:45:44 INFO - Running main action method: create_virtualenv 16:45:44 INFO - Creating virtualenv /builds/slave/test/build/venv 16:45:44 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 16:45:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:45:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:45:44 INFO - Using real prefix '/usr' 16:45:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:45:45 INFO - Installing distribute.............................................................................................................................................................................................done. 16:45:47 INFO - Installing pip.................done. 16:45:47 INFO - Return code: 0 16:45:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f314c15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264c3d0>, '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 0x25b7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8360>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', '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 16:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:45:47 INFO - Using env: {'DISPLAY': ':0', 16:45:47 INFO - 'HOME': '/home/cltbld', 16:45:47 INFO - 'LANG': 'en_US.UTF-8', 16:45:47 INFO - 'LANGUAGE': 'en_US:en', 16:45:47 INFO - 'LOGNAME': 'cltbld', 16:45:47 INFO - 'MAIL': '/var/mail/cltbld', 16:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:47 INFO - 'MOZ_NO_REMOTE': '1', 16:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:47 INFO - 'NO_EM_RESTART': '1', 16:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:47 INFO - 'PWD': '/builds/slave/test', 16:45:47 INFO - 'SHELL': '/bin/bash', 16:45:47 INFO - 'SHLVL': '1', 16:45:47 INFO - 'TERM': 'linux', 16:45:47 INFO - 'TMOUT': '86400', 16:45:47 INFO - 'USER': 'cltbld', 16:45:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', 16:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:47 INFO - '_': '/tools/buildbot/bin/python'} 16:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:47 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 16:45:47 INFO - Cleaning up... 16:45:47 INFO - Return code: 0 16:45:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f314c15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264c3d0>, '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 0x25b7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8360>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', '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 16:45:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:45:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:45:47 INFO - Using env: {'DISPLAY': ':0', 16:45:47 INFO - 'HOME': '/home/cltbld', 16:45:47 INFO - 'LANG': 'en_US.UTF-8', 16:45:47 INFO - 'LANGUAGE': 'en_US:en', 16:45:47 INFO - 'LOGNAME': 'cltbld', 16:45:47 INFO - 'MAIL': '/var/mail/cltbld', 16:45:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:47 INFO - 'MOZ_NO_REMOTE': '1', 16:45:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:47 INFO - 'NO_EM_RESTART': '1', 16:45:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:47 INFO - 'PWD': '/builds/slave/test', 16:45:47 INFO - 'SHELL': '/bin/bash', 16:45:47 INFO - 'SHLVL': '1', 16:45:47 INFO - 'TERM': 'linux', 16:45:47 INFO - 'TMOUT': '86400', 16:45:47 INFO - 'USER': 'cltbld', 16:45:47 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', 16:45:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:47 INFO - '_': '/tools/buildbot/bin/python'} 16:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:47 INFO - Downloading/unpacking psutil>=0.7.1 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:45:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:45:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:49 INFO - Installing collected packages: psutil 16:45:49 INFO - Running setup.py install for psutil 16:45:49 INFO - building 'psutil._psutil_linux' extension 16:45:49 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 16:45:49 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 16:45:49 INFO - building 'psutil._psutil_posix' extension 16:45:49 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 16:45:49 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 16:45:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:45:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:45:49 INFO - Successfully installed psutil 16:45:49 INFO - Cleaning up... 16:45:49 INFO - Return code: 0 16:45:49 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:45:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f314c15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264c3d0>, '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 0x25b7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8360>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', '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 16:45:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:45:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:45:49 INFO - Using env: {'DISPLAY': ':0', 16:45:49 INFO - 'HOME': '/home/cltbld', 16:45:49 INFO - 'LANG': 'en_US.UTF-8', 16:45:49 INFO - 'LANGUAGE': 'en_US:en', 16:45:49 INFO - 'LOGNAME': 'cltbld', 16:45:49 INFO - 'MAIL': '/var/mail/cltbld', 16:45:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:49 INFO - 'MOZ_NO_REMOTE': '1', 16:45:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:49 INFO - 'NO_EM_RESTART': '1', 16:45:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:49 INFO - 'PWD': '/builds/slave/test', 16:45:49 INFO - 'SHELL': '/bin/bash', 16:45:49 INFO - 'SHLVL': '1', 16:45:49 INFO - 'TERM': 'linux', 16:45:49 INFO - 'TMOUT': '86400', 16:45:49 INFO - 'USER': 'cltbld', 16:45:49 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', 16:45:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:49 INFO - '_': '/tools/buildbot/bin/python'} 16:45:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:51 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:45:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:45:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:45:51 INFO - Installing collected packages: mozsystemmonitor 16:45:51 INFO - Running setup.py install for mozsystemmonitor 16:45:51 INFO - Successfully installed mozsystemmonitor 16:45:51 INFO - Cleaning up... 16:45:51 INFO - Return code: 0 16:45:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f314c15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264c3d0>, '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 0x25b7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8360>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', '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 16:45:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:45:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:45:51 INFO - Using env: {'DISPLAY': ':0', 16:45:51 INFO - 'HOME': '/home/cltbld', 16:45:51 INFO - 'LANG': 'en_US.UTF-8', 16:45:51 INFO - 'LANGUAGE': 'en_US:en', 16:45:51 INFO - 'LOGNAME': 'cltbld', 16:45:51 INFO - 'MAIL': '/var/mail/cltbld', 16:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:51 INFO - 'MOZ_NO_REMOTE': '1', 16:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:51 INFO - 'NO_EM_RESTART': '1', 16:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:51 INFO - 'PWD': '/builds/slave/test', 16:45:51 INFO - 'SHELL': '/bin/bash', 16:45:51 INFO - 'SHLVL': '1', 16:45:51 INFO - 'TERM': 'linux', 16:45:51 INFO - 'TMOUT': '86400', 16:45:51 INFO - 'USER': 'cltbld', 16:45:51 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', 16:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:51 INFO - '_': '/tools/buildbot/bin/python'} 16:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:52 INFO - Downloading/unpacking blobuploader==1.2.4 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45:53 INFO - Downloading blobuploader-1.2.4.tar.gz 16:45:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:45:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:45:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:45:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:45:54 INFO - Downloading docopt-0.6.1.tar.gz 16:45:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:45:54 INFO - Installing collected packages: blobuploader, requests, docopt 16:45:54 INFO - Running setup.py install for blobuploader 16:45:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:45:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:45:54 INFO - Running setup.py install for requests 16:45:55 INFO - Running setup.py install for docopt 16:45:55 INFO - Successfully installed blobuploader requests docopt 16:45:55 INFO - Cleaning up... 16:45:55 INFO - Return code: 0 16:45:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45: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')]} 16:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45: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')]} 16:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:55 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 0x7f314c15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264c3d0>, '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 0x25b7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8360>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', '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 16:45:55 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 16:45:55 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 16:45:55 INFO - Using env: {'DISPLAY': ':0', 16:45:55 INFO - 'HOME': '/home/cltbld', 16:45:55 INFO - 'LANG': 'en_US.UTF-8', 16:45:55 INFO - 'LANGUAGE': 'en_US:en', 16:45:55 INFO - 'LOGNAME': 'cltbld', 16:45:55 INFO - 'MAIL': '/var/mail/cltbld', 16:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:55 INFO - 'MOZ_NO_REMOTE': '1', 16:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:55 INFO - 'NO_EM_RESTART': '1', 16:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:55 INFO - 'PWD': '/builds/slave/test', 16:45:55 INFO - 'SHELL': '/bin/bash', 16:45:55 INFO - 'SHLVL': '1', 16:45:55 INFO - 'TERM': 'linux', 16:45:55 INFO - 'TMOUT': '86400', 16:45:55 INFO - 'USER': 'cltbld', 16:45:55 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', 16:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:55 INFO - '_': '/tools/buildbot/bin/python'} 16:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:55 INFO - Running setup.py (path:/tmp/pip-IUhgvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:55 INFO - Running setup.py (path:/tmp/pip-a5OopR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:55 INFO - Running setup.py (path:/tmp/pip-K5rJ7K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:55 INFO - Running setup.py (path:/tmp/pip-8m2RtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:55 INFO - Running setup.py (path:/tmp/pip-kRfyr9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:55 INFO - Running setup.py (path:/tmp/pip-aeXRl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:55 INFO - Running setup.py (path:/tmp/pip-qQzrT4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:55 INFO - Running setup.py (path:/tmp/pip-MsydoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:56 INFO - Running setup.py (path:/tmp/pip-ialmXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:56 INFO - Running setup.py (path:/tmp/pip-CDu4du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:56 INFO - Running setup.py (path:/tmp/pip-8s3pLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:56 INFO - Running setup.py (path:/tmp/pip-q9yyFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:56 INFO - Running setup.py (path:/tmp/pip-oEVNsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:56 INFO - Running setup.py (path:/tmp/pip-eWnxIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:56 INFO - Running setup.py (path:/tmp/pip-yV7sxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:56 INFO - Running setup.py (path:/tmp/pip-_xFc0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:56 INFO - Running setup.py (path:/tmp/pip-XPdLpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:45:56 INFO - Running setup.py install for manifestparser 16:45:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:45:56 INFO - Running setup.py install for mozcrash 16:45:56 INFO - Running setup.py install for mozdebug 16:45:56 INFO - Running setup.py install for mozdevice 16:45:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:45:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:45:57 INFO - Running setup.py install for mozfile 16:45:57 INFO - Running setup.py install for mozhttpd 16:45:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:45:57 INFO - Running setup.py install for mozinfo 16:45:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:45:57 INFO - Running setup.py install for mozInstall 16:45:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:45:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:45:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:45:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:45:57 INFO - Running setup.py install for mozleak 16:45:57 INFO - Running setup.py install for mozlog 16:45:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:45:57 INFO - Running setup.py install for moznetwork 16:45:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:45:57 INFO - Running setup.py install for mozprocess 16:45:57 INFO - Running setup.py install for mozprofile 16:45:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:45:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:45:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:45:58 INFO - Running setup.py install for mozrunner 16:45:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:45:58 INFO - Running setup.py install for mozscreenshot 16:45:58 INFO - Running setup.py install for moztest 16:45:58 INFO - Running setup.py install for mozversion 16:45:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:45:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:45:58 INFO - Cleaning up... 16:45:58 INFO - Return code: 0 16:45:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:45:58 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')]} 16:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:58 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')]} 16:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:45:58 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 0x7f314c15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264c3d0>, '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 0x25b7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8360>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', '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 16:45:58 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 16:45:58 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 16:45:58 INFO - Using env: {'DISPLAY': ':0', 16:45:58 INFO - 'HOME': '/home/cltbld', 16:45:58 INFO - 'LANG': 'en_US.UTF-8', 16:45:58 INFO - 'LANGUAGE': 'en_US:en', 16:45:58 INFO - 'LOGNAME': 'cltbld', 16:45:58 INFO - 'MAIL': '/var/mail/cltbld', 16:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:45:58 INFO - 'MOZ_NO_REMOTE': '1', 16:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:45:58 INFO - 'NO_EM_RESTART': '1', 16:45:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:45:58 INFO - 'PWD': '/builds/slave/test', 16:45:58 INFO - 'SHELL': '/bin/bash', 16:45:58 INFO - 'SHLVL': '1', 16:45:58 INFO - 'TERM': 'linux', 16:45:58 INFO - 'TMOUT': '86400', 16:45:58 INFO - 'USER': 'cltbld', 16:45:58 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', 16:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:45:58 INFO - '_': '/tools/buildbot/bin/python'} 16:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:45:58 INFO - Running setup.py (path:/tmp/pip-dEKHeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:45:58 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)) 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:45:58 INFO - Running setup.py (path:/tmp/pip-TkCP5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:45:58 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)) 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:45:58 INFO - Running setup.py (path:/tmp/pip-LmD6nH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:45:58 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)) 16:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:45:58 INFO - Running setup.py (path:/tmp/pip-w9lAWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:45:59 INFO - Running setup.py (path:/tmp/pip-EjPTdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:45:59 INFO - Running setup.py (path:/tmp/pip-P9YmG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:45:59 INFO - Running setup.py (path:/tmp/pip-yGBD3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:45:59 INFO - Running setup.py (path:/tmp/pip-8cuTst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:45:59 INFO - Running setup.py (path:/tmp/pip-SWxc2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:45:59 INFO - Running setup.py (path:/tmp/pip-v7vMnF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:45:59 INFO - Running setup.py (path:/tmp/pip-PCIxTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:45:59 INFO - Running setup.py (path:/tmp/pip-m8G5Dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:45:59 INFO - Running setup.py (path:/tmp/pip-1ePhqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:45:59 INFO - Running setup.py (path:/tmp/pip-cE4OWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:59 INFO - Running setup.py (path:/tmp/pip-pQFhXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:45:59 INFO - Running setup.py (path:/tmp/pip-KfV5yD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:45:59 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)) 16:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:45:59 INFO - Running setup.py (path:/tmp/pip-mCtefm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:45:59 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)) 16:45:59 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)) 16:45:59 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)) 16:45:59 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)) 16:45:59 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)) 16:45:59 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)) 16:45:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:45: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 16:46:01 INFO - Downloading blessings-1.5.1.tar.gz 16:46:01 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 16:46:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:46:01 INFO - Installing collected packages: blessings 16:46:01 INFO - Running setup.py install for blessings 16:46:01 INFO - Successfully installed blessings 16:46:01 INFO - Cleaning up... 16:46:01 INFO - Return code: 0 16:46:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:46:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:46:02 INFO - Reading from file tmpfile_stdout 16:46:02 INFO - Current package versions: 16:46:02 INFO - argparse == 1.2.1 16:46:02 INFO - blessings == 1.5.1 16:46:02 INFO - blobuploader == 1.2.4 16:46:02 INFO - docopt == 0.6.1 16:46:02 INFO - manifestparser == 1.1 16:46:02 INFO - mozInstall == 1.12 16:46:02 INFO - mozcrash == 0.16 16:46:02 INFO - mozdebug == 0.1 16:46:02 INFO - mozdevice == 0.47 16:46:02 INFO - mozfile == 1.2 16:46:02 INFO - mozhttpd == 0.7 16:46:02 INFO - mozinfo == 0.9 16:46:02 INFO - mozleak == 0.1 16:46:02 INFO - mozlog == 3.1 16:46:02 INFO - moznetwork == 0.27 16:46:02 INFO - mozprocess == 0.22 16:46:02 INFO - mozprofile == 0.28 16:46:02 INFO - mozrunner == 6.11 16:46:02 INFO - mozscreenshot == 0.1 16:46:02 INFO - mozsystemmonitor == 0.0 16:46:02 INFO - moztest == 0.7 16:46:02 INFO - mozversion == 1.4 16:46:02 INFO - psutil == 3.1.1 16:46:02 INFO - requests == 1.2.3 16:46:02 INFO - wsgiref == 0.1.2 16:46:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f314c15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264c3d0>, '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 0x25b7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8360>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', '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 16:46:02 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 16:46:02 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 16:46:02 INFO - Using env: {'DISPLAY': ':0', 16:46:02 INFO - 'HOME': '/home/cltbld', 16:46:02 INFO - 'LANG': 'en_US.UTF-8', 16:46:02 INFO - 'LANGUAGE': 'en_US:en', 16:46:02 INFO - 'LOGNAME': 'cltbld', 16:46:02 INFO - 'MAIL': '/var/mail/cltbld', 16:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:02 INFO - 'MOZ_NO_REMOTE': '1', 16:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:02 INFO - 'NO_EM_RESTART': '1', 16:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:02 INFO - 'PWD': '/builds/slave/test', 16:46:02 INFO - 'SHELL': '/bin/bash', 16:46:02 INFO - 'SHLVL': '1', 16:46:02 INFO - 'TERM': 'linux', 16:46:02 INFO - 'TMOUT': '86400', 16:46:02 INFO - 'USER': 'cltbld', 16:46:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', 16:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:02 INFO - '_': '/tools/buildbot/bin/python'} 16:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 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)) 16:46:02 INFO - Cleaning up... 16:46:02 INFO - Return code: 0 16:46:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f314c15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264c3d0>, '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 0x25b7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8360>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', '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 16:46:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:46:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:46:02 INFO - Using env: {'DISPLAY': ':0', 16:46:02 INFO - 'HOME': '/home/cltbld', 16:46:02 INFO - 'LANG': 'en_US.UTF-8', 16:46:02 INFO - 'LANGUAGE': 'en_US:en', 16:46:02 INFO - 'LOGNAME': 'cltbld', 16:46:02 INFO - 'MAIL': '/var/mail/cltbld', 16:46:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:02 INFO - 'MOZ_NO_REMOTE': '1', 16:46:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:02 INFO - 'NO_EM_RESTART': '1', 16:46:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:02 INFO - 'PWD': '/builds/slave/test', 16:46:02 INFO - 'SHELL': '/bin/bash', 16:46:02 INFO - 'SHLVL': '1', 16:46:02 INFO - 'TERM': 'linux', 16:46:02 INFO - 'TMOUT': '86400', 16:46:02 INFO - 'USER': 'cltbld', 16:46:02 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', 16:46:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:02 INFO - '_': '/tools/buildbot/bin/python'} 16:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:02 INFO - Downloading/unpacking jsonschema 16:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:46:04 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 16:46:04 INFO - Downloading/unpacking functools32 (from jsonschema) 16:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:04 INFO - Downloading functools32-3.2.3-2.tar.gz 16:46:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:46:04 INFO - warning: no files found matching '*.txt' 16:46:04 INFO - no previously-included directories found matching 'build' 16:46:04 INFO - no previously-included directories found matching 'dist' 16:46:04 INFO - no previously-included directories found matching '.git*' 16:46:04 INFO - Installing collected packages: jsonschema, functools32 16:46:04 INFO - Running setup.py install for functools32 16:46:04 INFO - warning: no files found matching '*.txt' 16:46:04 INFO - no previously-included directories found matching 'build' 16:46:04 INFO - no previously-included directories found matching 'dist' 16:46:04 INFO - no previously-included directories found matching '.git*' 16:46:04 INFO - Successfully installed jsonschema functools32 16:46:04 INFO - Cleaning up... 16:46:04 INFO - Return code: 0 16:46:04 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:46:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f314c15cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24ea8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x25b9dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x264c3d0>, '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 0x25b7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8360>, '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': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', '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 16:46:04 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 16:46:04 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 16:46:04 INFO - Using env: {'DISPLAY': ':0', 16:46:04 INFO - 'HOME': '/home/cltbld', 16:46:04 INFO - 'LANG': 'en_US.UTF-8', 16:46:04 INFO - 'LANGUAGE': 'en_US:en', 16:46:04 INFO - 'LOGNAME': 'cltbld', 16:46:04 INFO - 'MAIL': '/var/mail/cltbld', 16:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:04 INFO - 'MOZ_NO_REMOTE': '1', 16:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:04 INFO - 'NO_EM_RESTART': '1', 16:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:04 INFO - 'PWD': '/builds/slave/test', 16:46:04 INFO - 'SHELL': '/bin/bash', 16:46:04 INFO - 'SHLVL': '1', 16:46:04 INFO - 'TERM': 'linux', 16:46:04 INFO - 'TMOUT': '86400', 16:46:04 INFO - 'USER': 'cltbld', 16:46:04 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', 16:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:04 INFO - '_': '/tools/buildbot/bin/python'} 16:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:46:04 INFO - Downloading/unpacking flake8 16:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:46:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:46:06 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 16:46:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:46:06 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 16:46:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 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 16:46:06 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 16:46:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:46:07 INFO - no previously-included directories found matching 'docs/_build' 16:46:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:46:07 INFO - Running setup.py install for pep8 16:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:46:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:46:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:46:07 INFO - no previously-included directories found matching 'docs/_build' 16:46:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:46:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:46:07 INFO - Cleaning up... 16:46:07 INFO - Return code: 0 16:46:07 INFO - Running post-action listener: _resource_record_post_action 16:46:07 INFO - Running post-action listener: _start_resource_monitoring 16:46:07 INFO - Starting resource monitoring. 16:46:07 INFO - ##### 16:46:07 INFO - ##### Running install step. 16:46:07 INFO - ##### 16:46:07 INFO - Running pre-action listener: _resource_record_pre_action 16:46:07 INFO - Running main action method: install 16:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:46:07 INFO - Reading from file tmpfile_stdout 16:46:07 INFO - Detecting whether we're running mozinstall >=1.0... 16:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:46:07 INFO - Reading from file tmpfile_stdout 16:46:07 INFO - Output received: 16:46:07 INFO - Usage: mozinstall [options] installer 16:46:07 INFO - Options: 16:46:07 INFO - -h, --help show this help message and exit 16:46:07 INFO - -d DEST, --destination=DEST 16:46:07 INFO - Directory to install application into. [default: 16:46:07 INFO - "/builds/slave/test"] 16:46:07 INFO - --app=APP Application being installed. [default: firefox] 16:46:07 INFO - mkdir: /builds/slave/test/build/application 16:46:07 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'] 16:46:07 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 16:46:23 INFO - Reading from file tmpfile_stdout 16:46:23 INFO - Output received: 16:46:23 INFO - /builds/slave/test/build/application/firefox/firefox 16:46:23 INFO - Running post-action listener: _resource_record_post_action 16:46:23 INFO - ##### 16:46:23 INFO - ##### Running run-tests step. 16:46:23 INFO - ##### 16:46:23 INFO - Running pre-action listener: _resource_record_pre_action 16:46:23 INFO - Running main action method: run_tests 16:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:46:23 INFO - Python 2.7.3 16:46:23 INFO - Return code: 0 16:46:23 INFO - grabbing minidump binary from tooltool 16:46:23 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')]} 16:46:23 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 0x264c3d0>, '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 0x25b7ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b8360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:46:23 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 16:46:23 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 16:46:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:46:23 INFO - Return code: 0 16:46:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:46:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:46:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:46:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:46:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:46:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:46:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:46:24 INFO - Return code: 0 16:46:24 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/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 16:46:24 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/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-062 --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 16:46:24 INFO - Using env: {'DISPLAY': ':0', 16:46:24 INFO - 'HOME': '/home/cltbld', 16:46:24 INFO - 'LANG': 'en_US.UTF-8', 16:46:24 INFO - 'LANGUAGE': 'en_US:en', 16:46:24 INFO - 'LOGNAME': 'cltbld', 16:46:24 INFO - 'MAIL': '/var/mail/cltbld', 16:46:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:46:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:46:24 INFO - 'MOZ_NO_REMOTE': '1', 16:46:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:46:24 INFO - 'NO_EM_RESTART': '1', 16:46:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:46:24 INFO - 'PWD': '/builds/slave/test', 16:46:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:46:24 INFO - 'SHELL': '/bin/bash', 16:46:24 INFO - 'SHLVL': '1', 16:46:24 INFO - 'TERM': 'linux', 16:46:24 INFO - 'TMOUT': '86400', 16:46:24 INFO - 'USER': 'cltbld', 16:46:24 INFO - 'XDG_SESSION_COOKIE': 'a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480', 16:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:46:24 INFO - '_': '/tools/buildbot/bin/python'} 16:46:24 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/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-062', '--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 16:46:24 INFO - mozversion application_buildid: 20160104161139 16:46:24 INFO - mozversion application_changeset: c38424a542eb0e9149d4adabfe1db57bd390f398 16:46:24 INFO - mozversion application_display_name: Nightly 16:46:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:46:24 INFO - mozversion application_name: Firefox 16:46:24 INFO - mozversion application_remotingname: firefox 16:46:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:46:24 INFO - mozversion application_vendor: Mozilla 16:46:24 INFO - mozversion application_version: 46.0a1 16:46:24 INFO - mozversion platform_buildid: 20160104161139 16:46:24 INFO - mozversion platform_changeset: c38424a542eb0e9149d4adabfe1db57bd390f398 16:46:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:46:24 INFO - mozversion platform_version: 46.0a1 16:46:24 INFO - using testdate: 1451954784 16:46:24 INFO - actual date: 1451954784 16:46:24 INFO - starting webserver on 'localhost:40288' 16:46:24 INFO - SUITE-START | Running 3 tests 16:46:24 INFO - TEST-START | dromaeo_css 16:46:24 INFO - operating with platform_type : linux_ 16:46:24 INFO - Initialising browser for dromaeo_css test... 16:46:24 INFO - TEST-INFO | started process 31348 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7tfiKS/profile http://localhost:40288/getInfo.html) 16:46:28 INFO - PROCESS | 31348 | __metrics Screen width/height:1600/1200 16:46:28 INFO - PROCESS | 31348 | colorDepth:24 16:46:28 INFO - PROCESS | 31348 | Browser inner width/height: 1024/697 16:46:28 INFO - PROCESS | 31348 | __metrics 16:46:28 INFO - PROCESS | 31348 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:46:28 INFO - PROCESS | 31348 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:46:29 INFO - TEST-INFO | 31348: exit 0 16:46:29 INFO - Browser initialized. 16:46:29 INFO - Running cycle 1/1 for dromaeo_css test... 16:46:29 INFO - TEST-INFO | started process 31440 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7tfiKS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:46:41 INFO - PROCESS | 31440 | RSS: Main: 150003712 16:46:41 INFO - PROCESS | 31440 | 16:47:32 INFO - PROCESS | 31440 | 1451954852860 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] 16:49:44 INFO - PROCESS | 31440 | Cycle 1(1): loaded http://localhost:40288/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40288/tests/dromaeo/cssquery-ext.html) 16:49:45 INFO - PROCESS | 31440 | RSS: Main: 243650560 16:49:45 INFO - PROCESS | 31440 | 16:52:48 INFO - PROCESS | 31440 | Cycle 1(1): loaded http://localhost:40288/tests/dromaeo/cssquery-ext.html (next: http://localhost:40288/tests/dromaeo/cssquery-jquery.html) 16:52:48 INFO - PROCESS | 31440 | RSS: Main: 227041280 16:52:48 INFO - PROCESS | 31440 | 16:55:50 INFO - PROCESS | 31440 | Cycle 1(1): loaded http://localhost:40288/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40288/tests/dromaeo/cssquery-mootools.html) 16:55:51 INFO - PROCESS | 31440 | RSS: Main: 221724672 16:55:51 INFO - PROCESS | 31440 | 16:58:53 INFO - PROCESS | 31440 | Cycle 1(1): loaded http://localhost:40288/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40288/tests/dromaeo/cssquery-prototype.html) 16:58:54 INFO - PROCESS | 31440 | RSS: Main: 208707584 16:58:54 INFO - PROCESS | 31440 | 17:01:56 INFO - PROCESS | 31440 | Cycle 1(1): loaded http://localhost:40288/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40288/tests/dromaeo/cssquery-yui.html) 17:01:57 INFO - PROCESS | 31440 | RSS: Main: 212004864 17:01:57 INFO - PROCESS | 31440 | 17:04:59 INFO - PROCESS | 31440 | Cycle 1(1): loaded http://localhost:40288/tests/dromaeo/cssquery-yui.html (next: http://localhost:40288/tests/dromaeo/cssquery-dojo.html) 17:05:00 INFO - PROCESS | 31440 | RSS: Main: 255668224 17:05:00 INFO - PROCESS | 31440 | 17:05:00 INFO - PROCESS | 31440 | __start_tp_report 17:05:00 INFO - PROCESS | 31440 | _x_x_mozilla_page_load 17:05:00 INFO - PROCESS | 31440 | _x_x_mozilla_page_load_details 17:05:00 INFO - PROCESS | 31440 | |i|pagename|runs| 17:05:00 INFO - PROCESS | 31440 | |0;dojo.html;2566.076212563477;2663.533881570726;2664.2007397780662;2681.7184195659456;2691.636629055078;4359.542248063955;4483.798229079691;4522.706024108435;4529.34324522944;4534.0705155443175;4439.978804874881;4518.096380723852;4523;4542.750148741826;4568.634509239261;4103.692223083266;4145.378193271018;4165;4215.628818054495;4262.339337402707;4045;4219.029623186669;4256.425382573344;4280.9143817123795;4307.569243075683;4131.5248746394245;4193.580641935782;4257.638100761439;4290.528041915387;4296.871093867189;4180.686448516343;4182.602652747984;4183.142455796555;4189.476315460567;4229.55589663084;4150.294449943517;4165.479315085614;4176.248275310443;4183.937240941388;4225.408442818008;4268.381084742695;4391;4407.537208593084;4407.977960110211;4490.21421251283;4809.110314591777;4842.636802239811;4845.781939812717;4850.054239423313;4896.804127834882;4863.708177509326;4875.390576177978;4877.682950608235;4879.243717223801;4927.285543596158;4360.433143691332;4379.934300985424;4405.229084910128;4409.76526572557;4573.47405048417;4925.261210818334;4937.1606826839525;4943.777530011158;4956.355673762388;4956.677815942025;4710.52894710533;4747.83382581608;4751.477337492873;4764.4520880099235;4807.086653535817;4654.697444666153;4762.119007983534;4783.067301876101;4792.544708252711;4862.9756851216225;4766.690165139325;4768.451628062748;4782.713037217778;4784.378030855966;4803.303520989437;4739.170645137087;4751.287306903992;4758.667573079543;4766.833160839354;4787.54518320759;3899.805009749501;3985.262726395626;3993.740406873544;3994.9201015979515;4049.493813273341;3497.2655742294405;3557.395242808677;3591.066322756102;3593.2993066352333;3618.5295911531334;4170.854020109342;4182.91634167315;4194.853180138681;4208.85269015583;4232.090100628379;4670.579647831712;4837.932729791912;4844.224924012141;4853.635977301717;4911.386076740408;4118.567550407224;4161.583841615875;4229.788510574459;4233.491980962304;4263.70154089217;4314.09404025152;4325.9134817303475;4335.28467802809;4342.934855977162;4379.102284031829;4647.651426142985;4648.604868586208;4650.302454631832;4652.581267685924;4698.694584851974;4684.718916864999;4774.570288674036;4799.304100905419;4801.7118972861745;4873.805047798049;4605.700629459075;4624.815007399801;4626.699264547794;4628.213203755302;4668;4776.020915712201;4785.856424307276;4803.759812009455;4816.807327706852;4845.788552861784;4657.0685862826895;4769.594584460359;4773.570378665937;4807.302941073594;4926.753662316798;4677;4752.168370535212;4756.262779269219;4757.881052973703;4801.351817504732;4725.8582242532775;4761.6904901181315;4763.095011947719;4764.571188593043;4809.639277054165;4518.841840535565;4581.266997280419;4634.374359461564;4636.698614590041;4705.12955103307;4681.555252251031;4713.128071306819;4713.858584242478;4721.5750582447745;4748.59636930851;4620.5379462053525;4620.653450991122;4623.352730617784;4647.651426142985;4650.558196971418 17:05:00 INFO - PROCESS | 31440 | |1;ext.html;512.1753976098483;530.3635637235317;535.138427132317;539.4497612435316;542.6743953627824;22780.54438911221;32153.99999999997;32161.839190804043;32198.839005804995;32231;34985;35498;35544.82227588858;35653;35670.10824729376;6714.227863795677;6809.489288303373;7592.27873352032;7783.766487005399;7786.3381612563;9721.708348749513;9969.700908972742;9969.850452243221;9979.051990060932;9988.75028124299;9532.428054316728;9731;9740.805183896318;9743.464109473976;9746.805063898717;6953.096097507342;7093.751718689873;9568.138867501924;9692.806143877153;9921.206303495776;9376.718698439057;9523.476208808514;9537.284703647254;9541.284403669753;9544.761380965461;32643.510347344807;33231.833840830644;33272.6672733272;33276.168095797555;33316.83341583301;2380.4405964598304;2383.7020372453444;2519.9748002519923;2538.82228244023;2692.151972128773;24777;26066.34834129162;26212.73787262122;26419.73580264192;26724.19827405181;2890.5383839036695;3030.1212648331957;3040.771942104351;3129.749620030392;3144.292534179814;219477;221589;222564;222757;223074;44494;51923.48076519262;52341.2148817768;52596;52679.47320526822;41555.168896622505;56697.43302567004;57519.712401437726;57568.4243157563;57584;10893.891061089445;11057.281276716987;11129.721756956142;11148.777024459465;11152.832707509393;7630.313271805453;7634.122075961335;7653.387728981668;7664.4634875559295;7668.463207575416;17348;17433.47699569015;17475.300987960338;17611.38360157388;18285.451436456926;7340.229275926058;7456.1798202197715;7569.205233450519;7628.656710448043;7702.383809295243;798.5368486277945;866.3285953386176;873.0832625742944;886.414966122369;887.2148148888281;25402.491950160893;25567.488650226893;26856.731432685425;28663.71336286652;28710;899.919007289334;900.1853322742797;948.5257371314343;963.9951800240954;987.2891518106951;12451.128421010624;12637.304948227937;12815.615531533882;13038.120562953105;13081.280529570964;332621;338556;339541;339779;341703;45072.774636127266;45081;45295.32057019147;45352.10422645101;45728.314075288894;973.5083782689696;1052.957881684724;1111.9722006949892;1119.8488204092343;1150.0741902768184;24059.278221653378;25920.611190831776;26037.349066273495;26149.869250653624;26272;35776.82111589425;36142.09644758902;36338;36345.818270909534;36348.63651363558;225465;230757;334170;343093;344114;25840.353991150372;25909.740902590733;25912.22263332103;26000.47999039971;26038.218853434428;37002.44496332503;37168.628313716516;37494.81252593829;37945.62054379531;37980.810095949346;31307.84346078255;31440.842795785873;31526;32480.67519324871;32503.837480812446;32060.358792823547;32243.838780805945;32300.35399292048;32393.676063240007;33325.50011749874;31667.52498712567;31929.68070319267;32387;32581.511277330384;32705.18237044093;28970.7102928968;29223.853880731313;29259;29440.11679649614;29703.663335150402;21065.578688426453;21211.15155393767;21295.78704212938;21332.680009800177;21388.679169812152 17:05:00 INFO - PROCESS | 31440 | |2;jquery.html;319.19721899422956;326.38802245789145;327.1778698067882;328.7025242155847;330.3261346852421;11978.401079946012;12272.815907761391;14531.70936581269;15015.324310406031;15087.245637718112;12247;12363.93818030911;12568.93715531421;12781.233126012447;12788;4709.740964246965;4749.976250118744;4855.611551075923;4867.099586576494;4868.294097355899;3684.2078953025093;3796.6583007529316;4807.543283388072;5400.621956463049;5575.972120139414;5492.505674489295;5532;5548.112302031675;5567.248421463111;5580.414056524068;5384.730763461831;5557.305336832896;5567.248421463091;5573.136163894583;5595.468430499096;4837.443693975203;4838.080764654705;4862.246351815475;4866.732329721864;4873.537013983666;18773.530661733428;19006.194411530883;19194.616107677768;19197.424077277563;19388;1789.6689112514096;1794.3809385761892;1861.7393564900924;1875.8217969292896;1918.9520261993423;12281.508739650404;12374.62876113718;12477;12802.103852730312;12998.805017924738;1689.8563622092138;1695.6693444778273;1713.3660545598084;1763.3563749231566;1841.4659748672868;52855.471445285824;55477.1678424824;55805.44194558043;55944.44055559433;56468.99999999959;9186.448813071238;9426.245900327956;9497.382670126419;9513.191378732885;9516.857247141299;11916.344601047025;11972.58095966637;12004.819927701092;12059.21615095016;12061.396930153458;6323.051542268697;6365.777197798055;6368.872622547523;6528.510361722795;6591.736330546724;5867.3839246879315;5876.823695289148;5975.492083172892;5997.790077347272;6034.306054803666;5588.692621905834;5619;5682.232898558642;5692.9146062809095;5742.052561327418;1512.4177191781243;1545.4513647654921;1589.3880855870573;1591.077175238359;1616.7332390155493;796.9282764551102;823.9176082391713;840.9026220781939;841.7011960753966;949.2785483032944;13370.429094245008;15368.923155384375;15883.761743573856;16174.433894813625;16305.266263018193;810.9878351824609;842.4271495383076;901.0088902207519;906.5342269028233;906.71891713569;8944.8658270126;8945.552722363856;9141.451512909247;9338.252939764803;9393.859092113624;459737;460117;461645;483226;491282;60540.69729651412;62354.37645623576;62848;63473;64337;1017.4709151241461;1018.8369860822232;1022.672744721682;1030.7114008077751;1030.8041472120424;14084.436622535393;14212.502562410265;14245.64385890361;14291.928540357647;14628.707425851211;29479.85260073686;31105.68894311028;31884.521732173573;32044.359112817147;32320.191995199366;38436.80781596074;38725.6127438722;40275.59724402719;40355.394669079404;40609.18781624292;8651.567421629019;8802.207801297915;8858.73423797287;8871.157240062184;8939.73180804577;8511.489310641382;9913.355631883904;10108.545115469675;10127.898721012696;10288.434136122585;7843.215678432111;8697.26073283778;8942.73171804847;9017.549122543978;9449.102335278138;8764.868526971974;8942.329325300758;8949;8957.776055598662;9157.49633770149;8931.776705582412;9092.181703646704;9147.451152930846;9325.347225694137;9431.292653051185;12747.171433856769;13141.211527308393;13603.591892243248;13706.93146534261;14024.859751402355;13444.663883402993;13767;13839.930800345934;14293.428262869786;14799.334029968893 17:05:00 INFO - PROCESS | 31440 | |3;mootools.html;1206.2099324942167;1286.7941129419291;1300.6618279247396;1346.4479563379011;1650.4718490083171;5550.555955523553;6354.7775827846035;6387.904181437282;6401.071844582532;6414.422701956823;6331.746730130789;6517.250516190639;6526.347365263471;6529.640869752162;6538.673066346688;1965.665836807746;1989.8607097503182;2006.508405440669;2011.5373464103266;2013.0236835135022;1957.784643689193;2000.649886269897;2004.4988752811796;2006.107282259395;2018.8788672679614;1952.1020330647918;1969;1976.4070778766384;1985.1662301833192;1993.8535342178234;1939.2824654877716;1962.2445358536922;1969.4583989402886;1969.4977780665981;1970.330087770165;1932.8936908470027;1959.8432125430074;1966.6066786642587;1972.2406873353718;1979.297349440942;6460.580062295982;6528.543001989862;6531;6538.607683539003;6540.574862633961;3698.8890333290046;3772.6981841452894;3785.9621403785886;3797.2025874566375;3798.8480460781534;2532.7467253274526;2584.5864661654045;2610.7911367090587;2628.132716203648;2637.3933995181214;824.4888169335051;839.0644431458941;851.5529347092826;875.3522393428881;875.369733791669;8991.786108875349;9060.411073280282;9063.184313411759;9064.864027039534;9104.908950910538;3681.0981309578788;3706.7961262130843;3739.9065023374087;3754.324221640131;3777.8299976501125;7884.093329267208;7891.092524359658;7916.643751031217;7916.802079948047;7930.246626570467;3828.48315477407;3838.443425703257;3850.7497012694084;3852.3065848147603;3856.4986551748093;2951.424472227895;2998.055612482061;3404.2000129969438;3477.0438129514587;3510.7717998330027;3253.3818574471247;3262.1844538865284;3300.818454984999;3310.4372256716415;3319.8008119512906;992.9056739609725;994.1748348870565;998.9650362237287;1002.2783595811151;1022.0750221049962;681.621699956519;684.9589024658536;774.9073805933607;836.7029704454952;852.2457625001917;6031.517478601701;6145.10895920098;6153.784617538365;6176.474999624992;6191.5665903387235;401.02350775860873;404.20371867421136;405.07440498460875;405.83563656719076;407.31570960786166;4565.931511027337;4596.37948876904;4610.838620648261;4617.561331673485;4637;7815.101263354787;7868.881966770503;8020.598970051474;8070.1526339734655;8071.838563228703;8005.279524842792;8011;8062.355011599058;8097.433179677366;8103.392245581605;5765.04876695349;5878.823635290948;5958.195643588147;5964.582479226413;5972.820815375546;5725.656460612377;5733.655980641175;5740.397258287987;5754.56840736938;5794.159846822272;7140.464465165237;7210.711571537289;7252.585745779523;7287.380572651384;7354.264573542603;7282.817929551804;7414.332710056121;7492.40060795146;7494.662740176815;7551.093868735787;4948;5039.823606173766;5666.291713535808;5725.2843394575675;5740.856478587902;5815.098659707752;5872.412758724265;5912.231409916683;5921.911171332347;5923.289205295392;5459.208414779914;5507.394186639386;5635.267415236157;5710.914336284876;5720.914186287126;5535.418781027934;5551.528120109836;5609.382967873449;5614.85962850932;5645.125005624135;5426.918596220981;5436.211749296251;5466.3713672928125;5541.224228607917;5549.556035517229;5134.921666450087;5218.425973142876;5221.712805795718;5221.843344699665;5374.623776335619;5248.343957005374;5300.549453296513;5305.495977882095;5312.389075256395;5318.57451403879 17:05:00 INFO - PROCESS | 31440 | |4;prototype.html;288.43610741001334;291.835113161064;298.4553190427469;300.45317522109764;304.36236085401106;5149.124648809702;5247.291615631893;5296.655717378368;5304.4430334814815;5308.840734777953;5069.771860266288;5224.242484839696;5283.1546952487515;5293.994141113186;5339.5728341732665;4045.2111838191563;4072.9592704072875;4097.16008218316;4113.753174809521;4124.938125928114;3879.1465877507044;3959.148783011652;3989.501312335958;4056.1887622475474;4066.227416790815;3997.0806714455694;3997.5003124609425;4019.2162528306844;4019.9397009044887;4038.474998250238;4001;4001.4397984282223;4036.555978842325;4043.3126368517424;4064.0855807443386;3545.4327307630656;3553.786772793615;3558.2527669189503;3561.7684850484634;3561.982190089059;4941.48114447985;5085.288059671649;5095.617828662828;5101.362329708786;5145.7873114560725;4704.506026867164;4710.811567537295;4715.174844402216;4721.858344249678;4739.3838800956;5616.494515493584;5629.521490673298;5633.57748168889;5640.830775076754;5650.067738823089;3659.7255205859665;3727.869524566627;3775.5091838060875;3829.636184562462;3830.2148059647984;5786.132080188006;5872.383399743051;5872.999999999957;5877.324107727581;5900.43945825146;4052.1085361220485;4053.5541090480024;4054.270231358325;4054.55399906016;4059.106996460774;4113.650339721157;4114.280000999813;4117.464729585195;4118.155778065489;4125;4507.301368287921;4657.115148121914;4665.136949664323;4675.719456832601;4690.390249267642;5528.640638358494;5541.639793413416;5609.298837645294;5615.18579805934;5626.746796394172;1422.317287701909;1452.244832686997;1452.6223181972764;1465.7141857337717;1470.4265336518765;973.0561355485167;1001.6293971230691;1002.2915213709305;1007.0584003956325;1023.7389465686202;4910.484399138039;4926.975365123223;4934.284528743312;4941.579965702956;4984.875378115504;5778.306603207642;5800.506956908625;5804.071348584206;5810.1865738796605;5811.593188476766;4885.267209918541;4921.8523444296725;4927.457979622239;4929.950700493021;4931.161702510582;3024.8185108893535;3096.6593674695764;3126.6716994715225;3127.56214130022;3145.779795414345;5540.750666219949;5542.7782888684005;5545.334559852843;5546.445355464502;5547.639403438763;5988.9401105989255;6055.303640081447;6063.514918806485;6069.0592958091565;6074.42292982166;5473.17902314648;5497.39528651848;5503.697296648643;5532.197831314517;5538.667679939216;5649;5817.127430885401;5829.912551311819;5842.415758424124;5851.297844258716;5420.701861397661;5537.723113844372;5543.972280138573;5681.857953551194;5725.856853578527;5527.005139074844;5541.196526503554;5554.305711786027;5557.499825015768;5564.638298510584;3907.29668659644;3941.2117576485393;3952.8616498422416;3956.0307724607655;3959.7426167300187;5663.122216056518;5813.912791308049;5816.01127808282;5827.388124246893;5836.9416305838095;5640.153976903333;5653;5654.915176272277;5658.575606829422;5660.7169641518585;5642.576806739593;5657.9151312731165;5659.179418984142;5659.603827732184;5660.037793575019;5530.064477432867;5538.172403106884;5538.833834984957;5543.77824887;5545.140503222007;5520.475554822286;5671.943280567307;5678.517326027169;5680.460356266148;5680.943190568207;5538.91691624634;5539.473749993744;5545.556355491632;5546.611737178358;5554.944450555605 17:05:00 INFO - PROCESS | 31440 | |5;yui.html;533.8531903726472;616.9691515424233;656.1339032477131;657.2209793686304;661.4047357378358;9907.455089970057;10042.648507302236;10067.34562253453;10087.142592879605;10089.394636321807;9969.601215951354;10613;10616.46917654118;10618.57525698971;10622.840657390145;593.3236110833653;603.7192705391992;727.9563226206418;742.624974387936;742.8922806193099;597.1132867691475;740.3447948565531;744.3338212299989;744.7989042958397;754.660402818731;633.1357696743935;637.9553431259814;649.7758273395671;650.2392201124695;650.4958657040784;617.043582447205;625.4777260987081;641.377863472431;644.2204932032247;763.385474692872;572.7565784541553;573.8938296415134;575.9769609215668;576.3775122867335;577.5812535911473;9379.718608441757;9480.810383792354;9489.430634161903;9493.477858717768;9520.571574279174;10339.224558158094;10396;10714.142868570496;10729.356238625707;11507.539698412138;8264.132266112032;8427.494350338939;8444.915550844475;8456.788580285542;8482.618282177255;2679.946401071987;2715.6062370956297;2750;2756.9172924812287;2765.363966287745;37558.06104847373;37650.81174594137;37666.43500347497;37757.433638495444;37841.43237851434;8956;8980.8652870207;9083.227925626396;9211.278102099119;9261.16649501548;15918;15956.962797418131;15961.521154365388;15983.120928349052;16030.358785648677;5632.943670563324;5785;5877.089051197071;5947.31605865331;6011.27864656244;3159.210197450637;3165.1612322734495;3174.698403651649;3193.9680603194133;3249.9187520311707;2382.749056745223;2408.9759102409103;2421;2426.4904370082127;2427.9878600606885;438.7740313738427;441.15518781533007;448.8092560661706;449.19818124648;451.62515112456583;399.9400089986525;427.6856510464806;429.9852348457637;485.49023525299003;506.37968488601905;5755.65466072037;5877.676727779927;5900.262467191601;5983.1623572699855;6002.159697642333;426.3093788063295;461.96073333767004;483.2533735378848;490.70557665401185;495.10633306881425;3254.397936381777;3328.4341661917047;3339.148517128117;3340.365330587181;3377.611574668895;49549.504504954486;49564.752176238886;49912.251316230286;49930;50349;43765.34351984723;44151.33772993408;44239.336409953874;44292.3356149658;44392.3341149883;38860.99999999943;39016;39028.80485597554;39741.40387894184;39945.201095977915;6656.700448479927;7352.77941661751;7571.091469023752;7591.3926885847895;8050.677972881019;30879;30977.380452391277;31672.208194795316;31944.6805531951;32083.518747219277;39073.609263907;39722.40416393698;40127;40366.59633403629;40644.79677601593;8928.15182557656;9076.636934522545;9097.13577210164;9176.862347064933;9221.400608960395;10087.394756314645;10087.596496140071;10098.497562535174;10211.23415743837;10259.487025648838;9830.606775728891;9873.40759554429;9874;9950.402975821475;10038.046385593358;9701.951490242503;9808.803823923625;9901.15840153595;9973.052560006789;9988.800223995624;7808.7657370278985;9088.136627020422;9860.26048046385;10055.195584353089;10073.093421591799;8124.431289809657;8187.222213889671;8596.398252122292;8598.158820447472;8659.913400866162;8309.875351869607;8315.584220789058;8320.875186872323;8484;8512.74461766148 17:05:00 INFO - PROCESS | 31440 | __end_tp_report 17:05:00 INFO - PROCESS | 31440 | __start_cc_report 17:05:00 INFO - PROCESS | 31440 | _x_x_mozilla_cycle_collect,897 17:05:00 INFO - PROCESS | 31440 | __end_cc_report 17:05:00 INFO - PROCESS | 31440 | __startTimestamp1451955900186__endTimestamp 17:05:00 INFO - PROCESS | 31440 | 17:05:00 INFO - PROCESS | 31440 | ------- Summary: start ------- 17:05:00 INFO - PROCESS | 31440 | Number of tests: 6 17:05:00 INFO - PROCESS | 31440 | 17:05:00 INFO - PROCESS | 31440 | [#0] dojo.html Cycles:165 Average:4469.58 Median:4626.70 stddev:449.36 (9.7%) stddev-sans-first:425.20 17:05:00 INFO - PROCESS | 31440 | Values: 2566.1 2663.5 2664.2 2681.7 2691.6 4359.5 4483.8 4522.7 4529.3 4534.1 4440.0 4518.1 4523.0 4542.8 4568.6 4103.7 4145.4 4165.0 4215.6 4262.3 4045.0 4219.0 4256.4 4280.9 4307.6 4131.5 4193.6 4257.6 4290.5 4296.9 4180.7 4182.6 4183.1 4189.5 4229.6 4150.3 4165.5 4176.2 4183.9 4225.4 4268.4 4391.0 4407.5 4408.0 4490.2 4809.1 4842.6 4845.8 4850.1 4896.8 4863.7 4875.4 4877.7 4879.2 4927.3 4360.4 4379.9 4405.2 4409.8 4573.5 4925.3 4937.2 4943.8 4956.4 4956.7 4710.5 4747.8 4751.5 4764.5 4807.1 4654.7 4762.1 4783.1 4792.5 4863.0 4766.7 4768.5 4782.7 4784.4 4803.3 4739.2 4751.3 4758.7 4766.8 4787.5 3899.8 3985.3 3993.7 3994.9 4049.5 3497.3 3557.4 3591.1 3593.3 3618.5 4170.9 4182.9 4194.9 4208.9 4232.1 4670.6 4837.9 4844.2 4853.6 4911.4 4118.6 4161.6 4229.8 4233.5 4263.7 4314.1 4325.9 4335.3 4342.9 4379.1 4647.7 4648.6 4650.3 4652.6 4698.7 4684.7 4774.6 4799.3 4801.7 4873.8 4605.7 4624.8 4626.7 4628.2 4668.0 4776.0 4785.9 4803.8 4816.8 4845.8 4657.1 4769.6 4773.6 4807.3 4926.8 4677.0 4752.2 4756.3 4757.9 4801.4 4725.9 4761.7 4763.1 4764.6 4809.6 4518.8 4581.3 4634.4 4636.7 4705.1 4681.6 4713.1 4713.9 4721.6 4748.6 4620.5 4620.7 4623.4 4647.7 4650.6 17:05:00 INFO - PROCESS | 31440 | 17:05:00 INFO - PROCESS | 31440 | [#1] ext.html Cycles:180 Average:42817.20 Median:33321.17 stddev:76608.37 (229.9%) stddev-sans-first:76757.43 17:05:00 INFO - PROCESS | 31440 | Values: 512.2 530.4 535.1 539.4 542.7 22780.5 32154.0 32161.8 32198.8 32231.0 34985.0 35498.0 35544.8 35653.0 35670.1 6714.2 6809.5 7592.3 7783.8 7786.3 9721.7 9969.7 9969.9 9979.1 9988.8 9532.4 9731.0 9740.8 9743.5 9746.8 6953.1 7093.8 9568.1 9692.8 9921.2 9376.7 9523.5 9537.3 9541.3 9544.8 32643.5 33231.8 33272.7 33276.2 33316.8 2380.4 2383.7 2520.0 2538.8 2692.2 24777.0 26066.3 26212.7 26419.7 26724.2 2890.5 3030.1 3040.8 3129.7 3144.3 219477.0 221589.0 222564.0 222757.0 223074.0 44494.0 51923.5 52341.2 52596.0 52679.5 41555.2 56697.4 57519.7 57568.4 57584.0 10893.9 11057.3 11129.7 11148.8 11152.8 7630.3 7634.1 7653.4 7664.5 7668.5 17348.0 17433.5 17475.3 17611.4 18285.5 7340.2 7456.2 7569.2 7628.7 7702.4 798.5 866.3 873.1 886.4 887.2 25402.5 25567.5 26856.7 28663.7 28710.0 899.9 900.2 948.5 964.0 987.3 12451.1 12637.3 12815.6 13038.1 13081.3 332621.0 338556.0 339541.0 339779.0 341703.0 45072.8 45081.0 45295.3 45352.1 45728.3 973.5 1053.0 1112.0 1119.8 1150.1 24059.3 25920.6 26037.3 26149.9 26272.0 35776.8 36142.1 36338.0 36345.8 36348.6 225465.0 230757.0 334170.0 343093.0 344114.0 25840.4 25909.7 25912.2 26000.5 26038.2 37002.4 37168.6 37494.8 37945.6 37980.8 31307.8 31440.8 31526.0 32480.7 32503.8 32060.4 32243.8 32300.4 32393.7 33325.5 31667.5 31929.7 32387.0 32581.5 32705.2 28970.7 29223.9 29259.0 29440.1 29703.7 21065.6 21211.2 21295.8 21332.7 21388.7 17:05:00 INFO - PROCESS | 31440 | 17:05:00 INFO - PROCESS | 31440 | [#2] jquery.html Cycles:180 Average:25091.51 Median:244016.77 stddev:76912.86 (31.5%) stddev-sans-first:77106.13 17:05:00 INFO - PROCESS | 31440 | Values: 319.2 326.4 327.2 328.7 330.3 11978.4 12272.8 14531.7 15015.3 15087.2 12247.0 12363.9 12568.9 12781.2 12788.0 4709.7 4750.0 4855.6 4867.1 4868.3 3684.2 3796.7 4807.5 5400.6 5576.0 5492.5 5532.0 5548.1 5567.2 5580.4 5384.7 5557.3 5567.2 5573.1 5595.5 4837.4 4838.1 4862.2 4866.7 4873.5 18773.5 19006.2 19194.6 19197.4 19388.0 1789.7 1794.4 1861.7 1875.8 1919.0 12281.5 12374.6 12477.0 12802.1 12998.8 1689.9 1695.7 1713.4 1763.4 1841.5 52855.5 55477.2 55805.4 55944.4 56469.0 9186.4 9426.2 9497.4 9513.2 9516.9 11916.3 11972.6 12004.8 12059.2 12061.4 6323.1 6365.8 6368.9 6528.5 6591.7 5867.4 5876.8 5975.5 5997.8 6034.3 5588.7 5619.0 5682.2 5692.9 5742.1 1512.4 1545.5 1589.4 1591.1 1616.7 796.9 823.9 840.9 841.7 949.3 13370.4 15368.9 15883.8 16174.4 16305.3 811.0 842.4 901.0 906.5 906.7 8944.9 8945.6 9141.5 9338.3 9393.9 459737.0 460117.0 461645.0 483226.0 491282.0 60540.7 62354.4 62848.0 63473.0 64337.0 1017.5 1018.8 1022.7 1030.7 1030.8 14084.4 14212.5 14245.6 14291.9 14628.7 29479.9 31105.7 31884.5 32044.4 32320.2 38436.8 38725.6 40275.6 40355.4 40609.2 8651.6 8802.2 8858.7 8871.2 8939.7 8511.5 9913.4 10108.5 10127.9 10288.4 7843.2 8697.3 8942.7 9017.5 9449.1 8764.9 8942.3 8949.0 8957.8 9157.5 8931.8 9092.2 9147.5 9325.3 9431.3 12747.2 13141.2 13603.6 13706.9 14024.9 13444.7 13767.0 13839.9 14293.4 14799.3 17:05:00 INFO - PROCESS | 31440 | 17:05:00 INFO - PROCESS | 31440 | [#3] mootools.html Cycles:180 Average:4517.47 Median:5545.39 stddev:2389.03 (43.1%) stddev-sans-first:2382.77 17:05:00 INFO - PROCESS | 31440 | Values: 1206.2 1286.8 1300.7 1346.4 1650.5 5550.6 6354.8 6387.9 6401.1 6414.4 6331.7 6517.3 6526.3 6529.6 6538.7 1965.7 1989.9 2006.5 2011.5 2013.0 1957.8 2000.6 2004.5 2006.1 2018.9 1952.1 1969.0 1976.4 1985.2 1993.9 1939.3 1962.2 1969.5 1969.5 1970.3 1932.9 1959.8 1966.6 1972.2 1979.3 6460.6 6528.5 6531.0 6538.6 6540.6 3698.9 3772.7 3786.0 3797.2 3798.8 2532.7 2584.6 2610.8 2628.1 2637.4 824.5 839.1 851.6 875.4 875.4 8991.8 9060.4 9063.2 9064.9 9104.9 3681.1 3706.8 3739.9 3754.3 3777.8 7884.1 7891.1 7916.6 7916.8 7930.2 3828.5 3838.4 3850.7 3852.3 3856.5 2951.4 2998.1 3404.2 3477.0 3510.8 3253.4 3262.2 3300.8 3310.4 3319.8 992.9 994.2 999.0 1002.3 1022.1 681.6 685.0 774.9 836.7 852.2 6031.5 6145.1 6153.8 6176.5 6191.6 401.0 404.2 405.1 405.8 407.3 4565.9 4596.4 4610.8 4617.6 4637.0 7815.1 7868.9 8020.6 8070.2 8071.8 8005.3 8011.0 8062.4 8097.4 8103.4 5765.0 5878.8 5958.2 5964.6 5972.8 5725.7 5733.7 5740.4 5754.6 5794.2 7140.5 7210.7 7252.6 7287.4 7354.3 7282.8 7414.3 7492.4 7494.7 7551.1 4948.0 5039.8 5666.3 5725.3 5740.9 5815.1 5872.4 5912.2 5921.9 5923.3 5459.2 5507.4 5635.3 5710.9 5720.9 5535.4 5551.5 5609.4 5614.9 5645.1 5426.9 5436.2 5466.4 5541.2 5549.6 5134.9 5218.4 5221.7 5221.8 5374.6 5248.3 5300.5 5305.5 5312.4 5318.6 17:05:00 INFO - PROCESS | 31440 | 17:05:00 INFO - PROCESS | 31440 | [#4] prototype.html Cycles:180 Average:4637.66 Median:5186.68 stddev:1375.06 (26.5%) stddev-sans-first:1339.61 17:05:00 INFO - PROCESS | 31440 | Values: 288.4 291.8 298.5 300.5 304.4 5149.1 5247.3 5296.7 5304.4 5308.8 5069.8 5224.2 5283.2 5294.0 5339.6 4045.2 4073.0 4097.2 4113.8 4124.9 3879.1 3959.1 3989.5 4056.2 4066.2 3997.1 3997.5 4019.2 4019.9 4038.5 4001.0 4001.4 4036.6 4043.3 4064.1 3545.4 3553.8 3558.3 3561.8 3562.0 4941.5 5085.3 5095.6 5101.4 5145.8 4704.5 4710.8 4715.2 4721.9 4739.4 5616.5 5629.5 5633.6 5640.8 5650.1 3659.7 3727.9 3775.5 3829.6 3830.2 5786.1 5872.4 5873.0 5877.3 5900.4 4052.1 4053.6 4054.3 4054.6 4059.1 4113.7 4114.3 4117.5 4118.2 4125.0 4507.3 4657.1 4665.1 4675.7 4690.4 5528.6 5541.6 5609.3 5615.2 5626.7 1422.3 1452.2 1452.6 1465.7 1470.4 973.1 1001.6 1002.3 1007.1 1023.7 4910.5 4927.0 4934.3 4941.6 4984.9 5778.3 5800.5 5804.1 5810.2 5811.6 4885.3 4921.9 4927.5 4930.0 4931.2 3024.8 3096.7 3126.7 3127.6 3145.8 5540.8 5542.8 5545.3 5546.4 5547.6 5988.9 6055.3 6063.5 6069.1 6074.4 5473.2 5497.4 5503.7 5532.2 5538.7 5649.0 5817.1 5829.9 5842.4 5851.3 5420.7 5537.7 5544.0 5681.9 5725.9 5527.0 5541.2 5554.3 5557.5 5564.6 3907.3 3941.2 3952.9 3956.0 3959.7 5663.1 5813.9 5816.0 5827.4 5836.9 5640.2 5653.0 5654.9 5658.6 5660.7 5642.6 5657.9 5659.2 5659.6 5660.0 5530.1 5538.2 5538.8 5543.8 5545.1 5520.5 5671.9 5678.5 5680.5 5680.9 5538.9 5539.5 5545.6 5546.6 5554.9 17:05:00 INFO - PROCESS | 31440 | 17:05:00 INFO - PROCESS | 31440 | [#5] yui.html Cycles:180 Average:11614.68 Median:520.12 stddev:13720.26 (2637.9%) stddev-sans-first:13733.51 17:05:00 INFO - PROCESS | 31440 | Values: 533.9 617.0 656.1 657.2 661.4 9907.5 10042.6 10067.3 10087.1 10089.4 9969.6 10613.0 10616.5 10618.6 10622.8 593.3 603.7 728.0 742.6 742.9 597.1 740.3 744.3 744.8 754.7 633.1 638.0 649.8 650.2 650.5 617.0 625.5 641.4 644.2 763.4 572.8 573.9 576.0 576.4 577.6 9379.7 9480.8 9489.4 9493.5 9520.6 10339.2 10396.0 10714.1 10729.4 11507.5 8264.1 8427.5 8444.9 8456.8 8482.6 2679.9 2715.6 2750.0 2756.9 2765.4 37558.1 37650.8 37666.4 37757.4 37841.4 8956.0 8980.9 9083.2 9211.3 9261.2 15918.0 15957.0 15961.5 15983.1 16030.4 5632.9 5785.0 5877.1 5947.3 6011.3 3159.2 3165.2 3174.7 3194.0 3249.9 2382.7 2409.0 2421.0 2426.5 2428.0 438.8 441.2 448.8 449.2 451.6 399.9 427.7 430.0 485.5 506.4 5755.7 5877.7 5900.3 5983.2 6002.2 426.3 462.0 483.3 490.7 495.1 3254.4 3328.4 3339.1 3340.4 3377.6 49549.5 49564.8 49912.3 49930.0 50349.0 43765.3 44151.3 44239.3 44292.3 44392.3 38861.0 39016.0 39028.8 39741.4 39945.2 6656.7 7352.8 7571.1 7591.4 8050.7 30879.0 30977.4 31672.2 31944.7 32083.5 39073.6 39722.4 40127.0 40366.6 40644.8 8928.2 9076.6 9097.1 9176.9 9221.4 10087.4 10087.6 10098.5 10211.2 10259.5 9830.6 9873.4 9874.0 9950.4 10038.0 9702.0 9808.8 9901.2 9973.1 9988.8 7808.8 9088.1 9860.3 10055.2 10073.1 8124.4 8187.2 8596.4 8598.2 8659.9 8309.9 8315.6 8320.9 8484.0 8512.7 17:05:00 INFO - PROCESS | 31440 | -------- Summary: end -------- 17:05:00 INFO - PROCESS | 31440 | 17:05:00 INFO - TEST-INFO | 31440: exit 0 17:05:00 INFO - TEST-OK | dromaeo_css | took 1116289ms 17:05:00 INFO - TEST-START | kraken 17:05:00 INFO - operating with platform_type : linux_ 17:05:00 INFO - Initialising browser for kraken test... 17:05:00 INFO - TEST-INFO | started process 31629 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPXu_JH/profile http://localhost:40288/getInfo.html) 17:05:04 INFO - PROCESS | 31629 | __metrics Screen width/height:1600/1200 17:05:04 INFO - PROCESS | 31629 | colorDepth:24 17:05:04 INFO - PROCESS | 31629 | Browser inner width/height: 1024/697 17:05:04 INFO - PROCESS | 31629 | __metrics 17:05:05 INFO - PROCESS | 31629 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:05:05 INFO - PROCESS | 31629 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:05:05 INFO - TEST-INFO | 31629: exit 0 17:05:05 INFO - Browser initialized. 17:05:05 INFO - Running cycle 1/1 for kraken test... 17:05:05 INFO - TEST-INFO | started process 31709 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPXu_JH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:17 INFO - PROCESS | 31709 | RSS: Main: 150204416 17:05:17 INFO - PROCESS | 31709 | 17:05:20 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40288/tests/kraken/driver.html?testName=audio-beat-detection) 17:05:21 INFO - PROCESS | 31709 | RSS: Main: 186503168 17:05:21 INFO - PROCESS | 31709 | 17:05:23 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40288/tests/kraken/driver.html?testName=audio-dft) 17:05:24 INFO - PROCESS | 31709 | RSS: Main: 176979968 17:05:24 INFO - PROCESS | 31709 | 17:05:27 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40288/tests/kraken/driver.html?testName=audio-fft) 17:05:28 INFO - PROCESS | 31709 | RSS: Main: 160870400 17:05:28 INFO - PROCESS | 31709 | 17:05:30 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40288/tests/kraken/driver.html?testName=audio-oscillator) 17:05:30 INFO - PROCESS | 31709 | RSS: Main: 163635200 17:05:30 INFO - PROCESS | 31709 | 17:05:33 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40288/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:05:33 INFO - PROCESS | 31709 | RSS: Main: 166100992 17:05:33 INFO - PROCESS | 31709 | 17:05:36 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40288/tests/kraken/driver.html?testName=imaging-darkroom) 17:05:37 INFO - PROCESS | 31709 | RSS: Main: 164139008 17:05:37 INFO - PROCESS | 31709 | 17:05:40 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40288/tests/kraken/driver.html?testName=imaging-desaturate) 17:05:41 INFO - PROCESS | 31709 | RSS: Main: 165928960 17:05:41 INFO - PROCESS | 31709 | 17:05:43 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40288/tests/kraken/driver.html?testName=json-parse-financial) 17:05:44 INFO - PROCESS | 31709 | RSS: Main: 165904384 17:05:44 INFO - PROCESS | 31709 | 17:05:46 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40288/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:05:46 INFO - PROCESS | 31709 | RSS: Main: 176029696 17:05:46 INFO - PROCESS | 31709 | 17:05:48 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40288/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:05:49 INFO - PROCESS | 31709 | RSS: Main: 174682112 17:05:49 INFO - PROCESS | 31709 | 17:05:51 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40288/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:05:52 INFO - PROCESS | 31709 | RSS: Main: 187428864 17:05:52 INFO - PROCESS | 31709 | 17:05:54 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:05:55 INFO - PROCESS | 31709 | RSS: Main: 189091840 17:05:55 INFO - PROCESS | 31709 | 17:05:57 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:05:58 INFO - PROCESS | 31709 | RSS: Main: 187883520 17:05:58 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | Cycle 1(1): loaded http://localhost:40288/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40288/tests/kraken/driver.html?testName=ai-astar) 17:06:00 INFO - PROCESS | 31709 | RSS: Main: 245891072 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | __start_tp_report 17:06:00 INFO - PROCESS | 31709 | _x_x_mozilla_page_load 17:06:00 INFO - PROCESS | 31709 | _x_x_mozilla_page_load_details 17:06:00 INFO - PROCESS | 31709 | |i|pagename|runs| 17:06:00 INFO - PROCESS | 31709 | |0;ai-astar;112;115;107;113;114;114;104;116;114;122 17:06:00 INFO - PROCESS | 31709 | |1;audio-beat-detection;154;137;160;179;140;161;153;134;178;133 17:06:00 INFO - PROCESS | 31709 | |2;audio-dft;164;164;164;164;163;162;163;161;163;164 17:06:00 INFO - PROCESS | 31709 | |3;audio-fft;73;74;94;98;74;73;72;97;97;74 17:06:00 INFO - PROCESS | 31709 | |4;audio-oscillator;99;99;136;98;100;99;135;100;99;134 17:06:00 INFO - PROCESS | 31709 | |5;imaging-gaussian-blur;109;110;110;110;109;109;109;109;109;109 17:06:00 INFO - PROCESS | 31709 | |6;imaging-darkroom;147;147;146;146;148;146;147;147;146;147 17:06:00 INFO - PROCESS | 31709 | |7;imaging-desaturate;96;95;95;95;96;96;96;95;95;96 17:06:00 INFO - PROCESS | 31709 | |8;json-parse-financial;73;71;71;72;72;72;73;82;70;70 17:06:00 INFO - PROCESS | 31709 | |9;json-stringify-tinderbox;67;68;68;67;68;69;68;69;68;68 17:06:00 INFO - PROCESS | 31709 | |10;stanford-crypto-aes;84;93;85;86;86;87;86;91;86;87 17:06:00 INFO - PROCESS | 31709 | |11;stanford-crypto-ccm;125;125;121;121;121;121;123;122;122;123 17:06:00 INFO - PROCESS | 31709 | |12;stanford-crypto-pbkdf2;139;137;150;160;153;141;150;150;150;141 17:06:00 INFO - PROCESS | 31709 | |13;stanford-crypto-sha256-iterative;71;71;70;71;71;71;71;71;72;70 17:06:00 INFO - PROCESS | 31709 | __end_tp_report 17:06:00 INFO - PROCESS | 31709 | __start_cc_report 17:06:00 INFO - PROCESS | 31709 | _x_x_mozilla_cycle_collect,1008 17:06:00 INFO - PROCESS | 31709 | __end_cc_report 17:06:00 INFO - PROCESS | 31709 | __startTimestamp1451955960518__endTimestamp 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | ------- Summary: start ------- 17:06:00 INFO - PROCESS | 31709 | Number of tests: 14 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:4.89 (4.3%) stddev-sans-first:5.17 17:06:00 INFO - PROCESS | 31709 | Values: 112.0 115.0 107.0 113.0 114.0 114.0 104.0 116.0 114.0 122.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:157.00 stddev:17.00 (10.8%) stddev-sans-first:18.03 17:06:00 INFO - PROCESS | 31709 | Values: 154.0 137.0 160.0 179.0 140.0 161.0 153.0 134.0 178.0 133.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#2] audio-dft Cycles:10 Average:163.20 Median:164.00 stddev:1.03 (0.6%) stddev-sans-first:1.05 17:06:00 INFO - PROCESS | 31709 | Values: 164.0 164.0 164.0 164.0 163.0 162.0 163.0 161.0 163.0 164.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#3] audio-fft Cycles:10 Average:82.60 Median:84.00 stddev:12.02 (14.3%) stddev-sans-first:12.24 17:06:00 INFO - PROCESS | 31709 | Values: 73.0 74.0 94.0 98.0 74.0 73.0 72.0 97.0 97.0 74.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#4] audio-oscillator Cycles:10 Average:109.90 Median:98.50 stddev:17.34 (17.6%) stddev-sans-first:17.93 17:06:00 INFO - PROCESS | 31709 | Values: 99.0 99.0 136.0 98.0 100.0 99.0 135.0 100.0 99.0 134.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 17:06:00 INFO - PROCESS | 31709 | Values: 109.0 110.0 110.0 110.0 109.0 109.0 109.0 109.0 109.0 109.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:06:00 INFO - PROCESS | 31709 | Values: 147.0 147.0 146.0 146.0 148.0 146.0 147.0 147.0 146.0 147.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 17:06:00 INFO - PROCESS | 31709 | Values: 96.0 95.0 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#8] json-parse-financial Cycles:10 Average:72.60 Median:72.00 stddev:3.47 (4.8%) stddev-sans-first:3.68 17:06:00 INFO - PROCESS | 31709 | Values: 73.0 71.0 71.0 72.0 72.0 72.0 73.0 82.0 70.0 70.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 17:06:00 INFO - PROCESS | 31709 | Values: 67.0 68.0 68.0 67.0 68.0 69.0 68.0 69.0 68.0 68.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:86.50 stddev:2.77 (3.2%) stddev-sans-first:2.70 17:06:00 INFO - PROCESS | 31709 | Values: 84.0 93.0 85.0 86.0 86.0 87.0 86.0 91.0 86.0 87.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:122.50 stddev:1.58 (1.3%) stddev-sans-first:1.36 17:06:00 INFO - PROCESS | 31709 | Values: 125.0 125.0 121.0 121.0 121.0 121.0 123.0 122.0 122.0 123.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.10 Median:150.00 stddev:7.28 (4.9%) stddev-sans-first:7.11 17:06:00 INFO - PROCESS | 31709 | Values: 139.0 137.0 150.0 160.0 153.0 141.0 150.0 150.0 150.0 141.0 17:06:00 INFO - PROCESS | 31709 | 17:06:00 INFO - PROCESS | 31709 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:71.00 stddev:0.57 (0.8%) stddev-sans-first:0.60 17:06:00 INFO - PROCESS | 31709 | Values: 71.0 71.0 70.0 71.0 71.0 71.0 71.0 71.0 72.0 70.0 17:06:00 INFO - PROCESS | 31709 | -------- Summary: end -------- 17:06:00 INFO - PROCESS | 31709 | 17:06:01 INFO - TEST-INFO | 31709: exit 0 17:06:01 INFO - TEST-OK | kraken | took 60574ms 17:06:01 INFO - TEST-START | v8_7 17:06:01 INFO - operating with platform_type : linux_ 17:06:01 INFO - Initialising browser for v8_7 test... 17:06:01 INFO - TEST-INFO | started process 31959 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUfvb0B/profile http://localhost:40288/getInfo.html) 17:06:05 INFO - PROCESS | 31959 | __metrics Screen width/height:1600/1200 17:06:05 INFO - PROCESS | 31959 | colorDepth:24 17:06:05 INFO - PROCESS | 31959 | Browser inner width/height: 1024/697 17:06:05 INFO - PROCESS | 31959 | __metrics 17:06:05 INFO - PROCESS | 31959 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:06:05 INFO - PROCESS | 31959 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:06:06 INFO - PROCESS | 31959 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 17:06:06 INFO - TEST-INFO | 31959: exit 0 17:06:06 INFO - Browser initialized. 17:06:06 INFO - Running cycle 1/1 for v8_7 test... 17:06:06 INFO - TEST-INFO | started process 32044 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUfvb0B/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:06:18 INFO - PROCESS | 32044 | RSS: Main: 147730432 17:06:18 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | Cycle 1(1): loaded http://localhost:40288/tests/v8_7/run.html (next: http://localhost:40288/tests/v8_7/run.html) 17:06:40 INFO - PROCESS | 32044 | RSS: Main: 448983040 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | __start_tp_report 17:06:40 INFO - PROCESS | 32044 | _x_x_mozilla_page_load 17:06:40 INFO - PROCESS | 32044 | _x_x_mozilla_page_load_details 17:06:40 INFO - PROCESS | 32044 | |i|pagename|runs| 17:06:40 INFO - PROCESS | 32044 | |0;Richards;167.98252981689905 17:06:40 INFO - PROCESS | 32044 | |1;DeltaBlue;187.79342723004694 17:06:40 INFO - PROCESS | 32044 | |2;Encrypt;278.2415136338342 17:06:40 INFO - PROCESS | 32044 | |3;Decrypt;5256.544502617801 17:06:40 INFO - PROCESS | 32044 | |4;RayTrace;2014.0845070422536 17:06:40 INFO - PROCESS | 32044 | |5;Earley;806.4516129032259 17:06:40 INFO - PROCESS | 32044 | |6;Boyer;12395.061728395061 17:06:40 INFO - PROCESS | 32044 | |7;RegExp;27216.216216216217 17:06:40 INFO - PROCESS | 32044 | |8;Splay;609.9939061547836 17:06:40 INFO - PROCESS | 32044 | |9;NavierStokes;4845.410628019324 17:06:40 INFO - PROCESS | 32044 | __end_tp_report 17:06:40 INFO - PROCESS | 32044 | __startTimestamp1451956000359__endTimestamp 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | ------- Summary: start ------- 17:06:40 INFO - PROCESS | 32044 | Number of tests: 10 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | [#0] Richards Cycles:1 Average:167.98 Median:167.98 stddev:0.00 (0.0%) 17:06:40 INFO - PROCESS | 32044 | Values: 168.0 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | [#1] DeltaBlue Cycles:1 Average:187.79 Median:187.79 stddev:0.00 (0.0%) 17:06:40 INFO - PROCESS | 32044 | Values: 187.8 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | [#2] Encrypt Cycles:1 Average:278.24 Median:278.24 stddev:0.00 (0.0%) 17:06:40 INFO - PROCESS | 32044 | Values: 278.2 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 17:06:40 INFO - PROCESS | 32044 | Values: 5256.5 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | [#4] RayTrace Cycles:1 Average:2014.08 Median:2014.08 stddev:0.00 (0.0%) 17:06:40 INFO - PROCESS | 32044 | Values: 2014.1 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | [#5] Earley Cycles:1 Average:806.45 Median:806.45 stddev:0.00 (0.0%) 17:06:40 INFO - PROCESS | 32044 | Values: 806.5 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | [#6] Boyer Cycles:1 Average:12395.06 Median:12395.06 stddev:0.00 (0.0%) 17:06:40 INFO - PROCESS | 32044 | Values: 12395.1 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | [#7] RegExp Cycles:1 Average:27216.22 Median:27216.22 stddev:0.00 (0.0%) 17:06:40 INFO - PROCESS | 32044 | Values: 27216.2 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | [#8] Splay Cycles:1 Average:609.99 Median:609.99 stddev:0.00 (0.0%) 17:06:40 INFO - PROCESS | 32044 | Values: 610.0 17:06:40 INFO - PROCESS | 32044 | 17:06:40 INFO - PROCESS | 32044 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 17:06:40 INFO - PROCESS | 32044 | Values: 4845.4 17:06:40 INFO - PROCESS | 32044 | -------- Summary: end -------- 17:06:40 INFO - PROCESS | 32044 | 17:06:41 INFO - TEST-INFO | 32044: exit 0 17:06:41 INFO - TEST-OK | v8_7 | took 39734ms 17:06:41 INFO - SUITE-END | took 1216s 17:06:41 INFO - Completed test suite (00:20:16) 17:06:41 INFO - Working with test: dromaeo_css 17:06:41 INFO - Generating results file: dromaeo_css 17:06:41 INFO - Working with test: kraken 17:06:41 INFO - Generating results file: kraken 17:06:41 INFO - javascript benchmark 17:06:41 INFO - Working with test: v8_7 17:06:41 INFO - Generating results file: v8_7 17:06:41 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:06:41 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 17:06:41 INFO - process_Request line: dromaeo_css 5961.05 graph.html#tests=[[72,132,35]] 17:06:41 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:06:41 INFO - process_Request line: kraken 1541.30 graph.html#tests=[[232,132,35]] 17:06:41 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:06:41 INFO - process_Request line: v8_7 19593.54 graph.html#tests=[[230,132,35]] 17:06:41 INFO - RETURN: dromaeo_css: 5961.05 17:06:41 INFO - RETURN: kraken: 1541.30 17:06:41 INFO - RETURN: v8_7: 19593.54 17:06:41 INFO - javascript benchmark 17:06:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2566.076212563477, 2663.533881570726, 2664.2007397780662, 2681.7184195659456, 2691.636629055078, 4359.542248063955, 4483.798229079691, 4522.706024108435, 4529.34324522944, 4534.0705155443175, 4439.978804874881, 4518.096380723852, 4523.0, 4542.750148741826, 4568.634509239261, 4103.692223083266, 4145.378193271018, 4165.0, 4215.628818054495, 4262.339337402707, 4045.0, 4219.029623186669, 4256.425382573344, 4280.9143817123795, 4307.569243075683, 4131.5248746394245, 4193.580641935782, 4257.638100761439, 4290.528041915387, 4296.871093867189, 4180.686448516343, 4182.602652747984, 4183.142455796555, 4189.476315460567, 4229.55589663084, 4150.294449943517, 4165.479315085614, 4176.248275310443, 4183.937240941388, 4225.408442818008, 4268.381084742695, 4391.0, 4407.537208593084, 4407.977960110211, 4490.21421251283, 4809.110314591777, 4842.636802239811, 4845.781939812717, 4850.054239423313, 4896.804127834882, 4863.708177509326, 4875.390576177978, 4877.682950608235, 4879.243717223801, 4927.285543596158, 4360.433143691332, 4379.934300985424, 4405.229084910128, 4409.76526572557, 4573.47405048417, 4925.261210818334, 4937.1606826839525, 4943.777530011158, 4956.355673762388, 4956.677815942025, 4710.52894710533, 4747.83382581608, 4751.477337492873, 4764.4520880099235, 4807.086653535817, 4654.697444666153, 4762.119007983534, 4783.067301876101, 4792.544708252711, 4862.9756851216225, 4766.690165139325, 4768.451628062748, 4782.713037217778, 4784.378030855966, 4803.303520989437, 4739.170645137087, 4751.287306903992, 4758.667573079543, 4766.833160839354, 4787.54518320759, 3899.805009749501, 3985.262726395626, 3993.740406873544, 3994.9201015979515, 4049.493813273341, 3497.2655742294405, 3557.395242808677, 3591.066322756102, 3593.2993066352333, 3618.5295911531334, 4170.854020109342, 4182.91634167315, 4194.853180138681, 4208.85269015583, 4232.090100628379, 4670.579647831712, 4837.932729791912, 4844.224924012141, 4853.635977301717, 4911.386076740408, 4118.567550407224, 4161.583841615875, 4229.788510574459, 4233.491980962304, 4263.70154089217, 4314.09404025152, 4325.9134817303475, 4335.28467802809, 4342.934855977162, 4379.102284031829, 4647.651426142985, 4648.604868586208, 4650.302454631832, 4652.581267685924, 4698.694584851974, 4684.718916864999, 4774.570288674036, 4799.304100905419, 4801.7118972861745, 4873.805047798049, 4605.700629459075, 4624.815007399801, 4626.699264547794, 4628.213203755302, 4668.0, 4776.020915712201, 4785.856424307276, 4803.759812009455, 4816.807327706852, 4845.788552861784, 4657.0685862826895, 4769.594584460359, 4773.570378665937, 4807.302941073594, 4926.753662316798, 4677.0, 4752.168370535212, 4756.262779269219, 4757.881052973703, 4801.351817504732, 4725.8582242532775, 4761.6904901181315, 4763.095011947719, 4764.571188593043, 4809.639277054165, 4518.841840535565, 4581.266997280419, 4634.374359461564, 4636.698614590041, 4705.12955103307, 4681.555252251031, 4713.128071306819, 4713.858584242478, 4721.5750582447745, 4748.59636930851, 4620.5379462053525, 4620.653450991122, 4623.352730617784, 4647.651426142985, 4650.558196971418], "unit": "score", "name": "dojo.html", "value": 4442.773966002947}, {"lowerIsBetter": false, "replicates": [512.1753976098483, 530.3635637235317, 535.138427132317, 539.4497612435316, 542.6743953627824, 22780.54438911221, 32153.99999999997, 32161.839190804043, 32198.839005804995, 32231.0, 34985.0, 35498.0, 35544.82227588858, 35653.0, 35670.10824729376, 6714.227863795677, 6809.489288303373, 7592.27873352032, 7783.766487005399, 7786.3381612563, 9721.708348749513, 9969.700908972742, 9969.850452243221, 9979.051990060932, 9988.75028124299, 9532.428054316728, 9731.0, 9740.805183896318, 9743.464109473976, 9746.805063898717, 6953.096097507342, 7093.751718689873, 9568.138867501924, 9692.806143877153, 9921.206303495776, 9376.718698439057, 9523.476208808514, 9537.284703647254, 9541.284403669753, 9544.761380965461, 32643.510347344807, 33231.833840830644, 33272.6672733272, 33276.168095797555, 33316.83341583301, 2380.4405964598304, 2383.7020372453444, 2519.9748002519923, 2538.82228244023, 2692.151972128773, 24777.0, 26066.34834129162, 26212.73787262122, 26419.73580264192, 26724.19827405181, 2890.5383839036695, 3030.1212648331957, 3040.771942104351, 3129.749620030392, 3144.292534179814, 219477.0, 221589.0, 222564.0, 222757.0, 223074.0, 44494.0, 51923.48076519262, 52341.2148817768, 52596.0, 52679.47320526822, 41555.168896622505, 56697.43302567004, 57519.712401437726, 57568.4243157563, 57584.0, 10893.891061089445, 11057.281276716987, 11129.721756956142, 11148.777024459465, 11152.832707509393, 7630.313271805453, 7634.122075961335, 7653.387728981668, 7664.4634875559295, 7668.463207575416, 17348.0, 17433.47699569015, 17475.300987960338, 17611.38360157388, 18285.451436456926, 7340.229275926058, 7456.1798202197715, 7569.205233450519, 7628.656710448043, 7702.383809295243, 798.5368486277945, 866.3285953386176, 873.0832625742944, 886.414966122369, 887.2148148888281, 25402.491950160893, 25567.488650226893, 26856.731432685425, 28663.71336286652, 28710.0, 899.919007289334, 900.1853322742797, 948.5257371314343, 963.9951800240954, 987.2891518106951, 12451.128421010624, 12637.304948227937, 12815.615531533882, 13038.120562953105, 13081.280529570964, 332621.0, 338556.0, 339541.0, 339779.0, 341703.0, 45072.774636127266, 45081.0, 45295.32057019147, 45352.10422645101, 45728.314075288894, 973.5083782689696, 1052.957881684724, 1111.9722006949892, 1119.8488204092343, 1150.0741902768184, 24059.278221653378, 25920.611190831776, 26037.349066273495, 26149.869250653624, 26272.0, 35776.82111589425, 36142.09644758902, 36338.0, 36345.818270909534, 36348.63651363558, 225465.0, 230757.0, 334170.0, 343093.0, 344114.0, 25840.353991150372, 25909.740902590733, 25912.22263332103, 26000.47999039971, 26038.218853434428, 37002.44496332503, 37168.628313716516, 37494.81252593829, 37945.62054379531, 37980.810095949346, 31307.84346078255, 31440.842795785873, 31526.0, 32480.67519324871, 32503.837480812446, 32060.358792823547, 32243.838780805945, 32300.35399292048, 32393.676063240007, 33325.50011749874, 31667.52498712567, 31929.68070319267, 32387.0, 32581.511277330384, 32705.18237044093, 28970.7102928968, 29223.853880731313, 29259.0, 29440.11679649614, 29703.663335150402, 21065.578688426453, 21211.15155393767, 21295.78704212938, 21332.680009800177, 21388.679169812152], "unit": "score", "name": "ext.html", "value": 16251.504177845458}, {"lowerIsBetter": false, "replicates": [319.19721899422956, 326.38802245789145, 327.1778698067882, 328.7025242155847, 330.3261346852421, 11978.401079946012, 12272.815907761391, 14531.70936581269, 15015.324310406031, 15087.245637718112, 12247.0, 12363.93818030911, 12568.93715531421, 12781.233126012447, 12788.0, 4709.740964246965, 4749.976250118744, 4855.611551075923, 4867.099586576494, 4868.294097355899, 3684.2078953025093, 3796.6583007529316, 4807.543283388072, 5400.621956463049, 5575.972120139414, 5492.505674489295, 5532.0, 5548.112302031675, 5567.248421463111, 5580.414056524068, 5384.730763461831, 5557.305336832896, 5567.248421463091, 5573.136163894583, 5595.468430499096, 4837.443693975203, 4838.080764654705, 4862.246351815475, 4866.732329721864, 4873.537013983666, 18773.530661733428, 19006.194411530883, 19194.616107677768, 19197.424077277563, 19388.0, 1789.6689112514096, 1794.3809385761892, 1861.7393564900924, 1875.8217969292896, 1918.9520261993423, 12281.508739650404, 12374.62876113718, 12477.0, 12802.103852730312, 12998.805017924738, 1689.8563622092138, 1695.6693444778273, 1713.3660545598084, 1763.3563749231566, 1841.4659748672868, 52855.471445285824, 55477.1678424824, 55805.44194558043, 55944.44055559433, 56468.99999999959, 9186.448813071238, 9426.245900327956, 9497.382670126419, 9513.191378732885, 9516.857247141299, 11916.344601047025, 11972.58095966637, 12004.819927701092, 12059.21615095016, 12061.396930153458, 6323.051542268697, 6365.777197798055, 6368.872622547523, 6528.510361722795, 6591.736330546724, 5867.3839246879315, 5876.823695289148, 5975.492083172892, 5997.790077347272, 6034.306054803666, 5588.692621905834, 5619.0, 5682.232898558642, 5692.9146062809095, 5742.052561327418, 1512.4177191781243, 1545.4513647654921, 1589.3880855870573, 1591.077175238359, 1616.7332390155493, 796.9282764551102, 823.9176082391713, 840.9026220781939, 841.7011960753966, 949.2785483032944, 13370.429094245008, 15368.923155384375, 15883.761743573856, 16174.433894813625, 16305.266263018193, 810.9878351824609, 842.4271495383076, 901.0088902207519, 906.5342269028233, 906.71891713569, 8944.8658270126, 8945.552722363856, 9141.451512909247, 9338.252939764803, 9393.859092113624, 459737.0, 460117.0, 461645.0, 483226.0, 491282.0, 60540.69729651412, 62354.37645623576, 62848.0, 63473.0, 64337.0, 1017.4709151241461, 1018.8369860822232, 1022.672744721682, 1030.7114008077751, 1030.8041472120424, 14084.436622535393, 14212.502562410265, 14245.64385890361, 14291.928540357647, 14628.707425851211, 29479.85260073686, 31105.68894311028, 31884.521732173573, 32044.359112817147, 32320.191995199366, 38436.80781596074, 38725.6127438722, 40275.59724402719, 40355.394669079404, 40609.18781624292, 8651.567421629019, 8802.207801297915, 8858.73423797287, 8871.157240062184, 8939.73180804577, 8511.489310641382, 9913.355631883904, 10108.545115469675, 10127.898721012696, 10288.434136122585, 7843.215678432111, 8697.26073283778, 8942.73171804847, 9017.549122543978, 9449.102335278138, 8764.868526971974, 8942.329325300758, 8949.0, 8957.776055598662, 9157.49633770149, 8931.776705582412, 9092.181703646704, 9147.451152930846, 9325.347225694137, 9431.292653051185, 12747.171433856769, 13141.211527308393, 13603.591892243248, 13706.93146534261, 14024.859751402355, 13444.663883402993, 13767.0, 13839.930800345934, 14293.428262869786, 14799.334029968893], "unit": "score", "name": "jquery.html", "value": 7901.745408111903}, {"lowerIsBetter": false, "replicates": [1206.2099324942167, 1286.7941129419291, 1300.6618279247396, 1346.4479563379011, 1650.4718490083171, 5550.555955523553, 6354.7775827846035, 6387.904181437282, 6401.071844582532, 6414.422701956823, 6331.746730130789, 6517.250516190639, 6526.347365263471, 6529.640869752162, 6538.673066346688, 1965.665836807746, 1989.8607097503182, 2006.508405440669, 2011.5373464103266, 2013.0236835135022, 1957.784643689193, 2000.649886269897, 2004.4988752811796, 2006.107282259395, 2018.8788672679614, 1952.1020330647918, 1969.0, 1976.4070778766384, 1985.1662301833192, 1993.8535342178234, 1939.2824654877716, 1962.2445358536922, 1969.4583989402886, 1969.4977780665981, 1970.330087770165, 1932.8936908470027, 1959.8432125430074, 1966.6066786642587, 1972.2406873353718, 1979.297349440942, 6460.580062295982, 6528.543001989862, 6531.0, 6538.607683539003, 6540.574862633961, 3698.8890333290046, 3772.6981841452894, 3785.9621403785886, 3797.2025874566375, 3798.8480460781534, 2532.7467253274526, 2584.5864661654045, 2610.7911367090587, 2628.132716203648, 2637.3933995181214, 824.4888169335051, 839.0644431458941, 851.5529347092826, 875.3522393428881, 875.369733791669, 8991.786108875349, 9060.411073280282, 9063.184313411759, 9064.864027039534, 9104.908950910538, 3681.0981309578788, 3706.7961262130843, 3739.9065023374087, 3754.324221640131, 3777.8299976501125, 7884.093329267208, 7891.092524359658, 7916.643751031217, 7916.802079948047, 7930.246626570467, 3828.48315477407, 3838.443425703257, 3850.7497012694084, 3852.3065848147603, 3856.4986551748093, 2951.424472227895, 2998.055612482061, 3404.2000129969438, 3477.0438129514587, 3510.7717998330027, 3253.3818574471247, 3262.1844538865284, 3300.818454984999, 3310.4372256716415, 3319.8008119512906, 992.9056739609725, 994.1748348870565, 998.9650362237287, 1002.2783595811151, 1022.0750221049962, 681.621699956519, 684.9589024658536, 774.9073805933607, 836.7029704454952, 852.2457625001917, 6031.517478601701, 6145.10895920098, 6153.784617538365, 6176.474999624992, 6191.5665903387235, 401.02350775860873, 404.20371867421136, 405.07440498460875, 405.83563656719076, 407.31570960786166, 4565.931511027337, 4596.37948876904, 4610.838620648261, 4617.561331673485, 4637.0, 7815.101263354787, 7868.881966770503, 8020.598970051474, 8070.1526339734655, 8071.838563228703, 8005.279524842792, 8011.0, 8062.355011599058, 8097.433179677366, 8103.392245581605, 5765.04876695349, 5878.823635290948, 5958.195643588147, 5964.582479226413, 5972.820815375546, 5725.656460612377, 5733.655980641175, 5740.397258287987, 5754.56840736938, 5794.159846822272, 7140.464465165237, 7210.711571537289, 7252.585745779523, 7287.380572651384, 7354.264573542603, 7282.817929551804, 7414.332710056121, 7492.40060795146, 7494.662740176815, 7551.093868735787, 4948.0, 5039.823606173766, 5666.291713535808, 5725.2843394575675, 5740.856478587902, 5815.098659707752, 5872.412758724265, 5912.231409916683, 5921.911171332347, 5923.289205295392, 5459.208414779914, 5507.394186639386, 5635.267415236157, 5710.914336284876, 5720.914186287126, 5535.418781027934, 5551.528120109836, 5609.382967873449, 5614.85962850932, 5645.125005624135, 5426.918596220981, 5436.211749296251, 5466.3713672928125, 5541.224228607917, 5549.556035517229, 5134.921666450087, 5218.425973142876, 5221.712805795718, 5221.843344699665, 5374.623776335619, 5248.343957005374, 5300.549453296513, 5305.495977882095, 5312.389075256395, 5318.57451403879], "unit": "score", "name": "mootools.html", "value": 3640.066697209244}, {"lowerIsBetter": false, "replicates": [288.43610741001334, 291.835113161064, 298.4553190427469, 300.45317522109764, 304.36236085401106, 5149.124648809702, 5247.291615631893, 5296.655717378368, 5304.4430334814815, 5308.840734777953, 5069.771860266288, 5224.242484839696, 5283.1546952487515, 5293.994141113186, 5339.5728341732665, 4045.2111838191563, 4072.9592704072875, 4097.16008218316, 4113.753174809521, 4124.938125928114, 3879.1465877507044, 3959.148783011652, 3989.501312335958, 4056.1887622475474, 4066.227416790815, 3997.0806714455694, 3997.5003124609425, 4019.2162528306844, 4019.9397009044887, 4038.474998250238, 4001.0, 4001.4397984282223, 4036.555978842325, 4043.3126368517424, 4064.0855807443386, 3545.4327307630656, 3553.786772793615, 3558.2527669189503, 3561.7684850484634, 3561.982190089059, 4941.48114447985, 5085.288059671649, 5095.617828662828, 5101.362329708786, 5145.7873114560725, 4704.506026867164, 4710.811567537295, 4715.174844402216, 4721.858344249678, 4739.3838800956, 5616.494515493584, 5629.521490673298, 5633.57748168889, 5640.830775076754, 5650.067738823089, 3659.7255205859665, 3727.869524566627, 3775.5091838060875, 3829.636184562462, 3830.2148059647984, 5786.132080188006, 5872.383399743051, 5872.999999999957, 5877.324107727581, 5900.43945825146, 4052.1085361220485, 4053.5541090480024, 4054.270231358325, 4054.55399906016, 4059.106996460774, 4113.650339721157, 4114.280000999813, 4117.464729585195, 4118.155778065489, 4125.0, 4507.301368287921, 4657.115148121914, 4665.136949664323, 4675.719456832601, 4690.390249267642, 5528.640638358494, 5541.639793413416, 5609.298837645294, 5615.18579805934, 5626.746796394172, 1422.317287701909, 1452.244832686997, 1452.6223181972764, 1465.7141857337717, 1470.4265336518765, 973.0561355485167, 1001.6293971230691, 1002.2915213709305, 1007.0584003956325, 1023.7389465686202, 4910.484399138039, 4926.975365123223, 4934.284528743312, 4941.579965702956, 4984.875378115504, 5778.306603207642, 5800.506956908625, 5804.071348584206, 5810.1865738796605, 5811.593188476766, 4885.267209918541, 4921.8523444296725, 4927.457979622239, 4929.950700493021, 4931.161702510582, 3024.8185108893535, 3096.6593674695764, 3126.6716994715225, 3127.56214130022, 3145.779795414345, 5540.750666219949, 5542.7782888684005, 5545.334559852843, 5546.445355464502, 5547.639403438763, 5988.9401105989255, 6055.303640081447, 6063.514918806485, 6069.0592958091565, 6074.42292982166, 5473.17902314648, 5497.39528651848, 5503.697296648643, 5532.197831314517, 5538.667679939216, 5649.0, 5817.127430885401, 5829.912551311819, 5842.415758424124, 5851.297844258716, 5420.701861397661, 5537.723113844372, 5543.972280138573, 5681.857953551194, 5725.856853578527, 5527.005139074844, 5541.196526503554, 5554.305711786027, 5557.499825015768, 5564.638298510584, 3907.29668659644, 3941.2117576485393, 3952.8616498422416, 3956.0307724607655, 3959.7426167300187, 5663.122216056518, 5813.912791308049, 5816.01127808282, 5827.388124246893, 5836.9416305838095, 5640.153976903333, 5653.0, 5654.915176272277, 5658.575606829422, 5660.7169641518585, 5642.576806739593, 5657.9151312731165, 5659.179418984142, 5659.603827732184, 5660.037793575019, 5530.064477432867, 5538.172403106884, 5538.833834984957, 5543.77824887, 5545.140503222007, 5520.475554822286, 5671.943280567307, 5678.517326027169, 5680.460356266148, 5680.943190568207, 5538.91691624634, 5539.473749993744, 5545.556355491632, 5546.611737178358, 5554.944450555605], "unit": "score", "name": "prototype.html", "value": 4196.574903113968}, {"lowerIsBetter": false, "replicates": [533.8531903726472, 616.9691515424233, 656.1339032477131, 657.2209793686304, 661.4047357378358, 9907.455089970057, 10042.648507302236, 10067.34562253453, 10087.142592879605, 10089.394636321807, 9969.601215951354, 10613.0, 10616.46917654118, 10618.57525698971, 10622.840657390145, 593.3236110833653, 603.7192705391992, 727.9563226206418, 742.624974387936, 742.8922806193099, 597.1132867691475, 740.3447948565531, 744.3338212299989, 744.7989042958397, 754.660402818731, 633.1357696743935, 637.9553431259814, 649.7758273395671, 650.2392201124695, 650.4958657040784, 617.043582447205, 625.4777260987081, 641.377863472431, 644.2204932032247, 763.385474692872, 572.7565784541553, 573.8938296415134, 575.9769609215668, 576.3775122867335, 577.5812535911473, 9379.718608441757, 9480.810383792354, 9489.430634161903, 9493.477858717768, 9520.571574279174, 10339.224558158094, 10396.0, 10714.142868570496, 10729.356238625707, 11507.539698412138, 8264.132266112032, 8427.494350338939, 8444.915550844475, 8456.788580285542, 8482.618282177255, 2679.946401071987, 2715.6062370956297, 2750.0, 2756.9172924812287, 2765.363966287745, 37558.06104847373, 37650.81174594137, 37666.43500347497, 37757.433638495444, 37841.43237851434, 8956.0, 8980.8652870207, 9083.227925626396, 9211.278102099119, 9261.16649501548, 15918.0, 15956.962797418131, 15961.521154365388, 15983.120928349052, 16030.358785648677, 5632.943670563324, 5785.0, 5877.089051197071, 5947.31605865331, 6011.27864656244, 3159.210197450637, 3165.1612322734495, 3174.698403651649, 3193.9680603194133, 3249.9187520311707, 2382.749056745223, 2408.9759102409103, 2421.0, 2426.4904370082127, 2427.9878600606885, 438.7740313738427, 441.15518781533007, 448.8092560661706, 449.19818124648, 451.62515112456583, 399.9400089986525, 427.6856510464806, 429.9852348457637, 485.49023525299003, 506.37968488601905, 5755.65466072037, 5877.676727779927, 5900.262467191601, 5983.1623572699855, 6002.159697642333, 426.3093788063295, 461.96073333767004, 483.2533735378848, 490.70557665401185, 495.10633306881425, 3254.397936381777, 3328.4341661917047, 3339.148517128117, 3340.365330587181, 3377.611574668895, 49549.504504954486, 49564.752176238886, 49912.251316230286, 49930.0, 50349.0, 43765.34351984723, 44151.33772993408, 44239.336409953874, 44292.3356149658, 44392.3341149883, 38860.99999999943, 39016.0, 39028.80485597554, 39741.40387894184, 39945.201095977915, 6656.700448479927, 7352.77941661751, 7571.091469023752, 7591.3926885847895, 8050.677972881019, 30879.0, 30977.380452391277, 31672.208194795316, 31944.6805531951, 32083.518747219277, 39073.609263907, 39722.40416393698, 40127.0, 40366.59633403629, 40644.79677601593, 8928.15182557656, 9076.636934522545, 9097.13577210164, 9176.862347064933, 9221.400608960395, 10087.394756314645, 10087.596496140071, 10098.497562535174, 10211.23415743837, 10259.487025648838, 9830.606775728891, 9873.40759554429, 9874.0, 9950.402975821475, 10038.046385593358, 9701.951490242503, 9808.803823923625, 9901.15840153595, 9973.052560006789, 9988.800223995624, 7808.7657370278985, 9088.136627020422, 9860.26048046385, 10055.195584353089, 10073.093421591799, 8124.431289809657, 8187.222213889671, 8596.398252122292, 8598.158820447472, 8659.913400866162, 8309.875351869607, 8315.584220789058, 8320.875186872323, 8484.0, 8512.74461766148], "unit": "score", "name": "yui.html", "value": 5147.6659140961065}], "name": "dromaeo_css", "value": 5961.046238176223}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 107.0, 113.0, 114.0, 114.0, 104.0, 116.0, 114.0, 122.0], "unit": "score", "name": "ai-astar", "value": 113.1}, {"lowerIsBetter": true, "replicates": [154.0, 137.0, 160.0, 179.0, 140.0, 161.0, 153.0, 134.0, 178.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 152.9}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 164.0, 163.0, 162.0, 163.0, 161.0, 163.0, 164.0], "unit": "score", "name": "audio-dft", "value": 163.2}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 94.0, 98.0, 74.0, 73.0, 72.0, 97.0, 97.0, 74.0], "unit": "score", "name": "audio-fft", "value": 82.6}, {"lowerIsBetter": true, "replicates": [99.0, 99.0, 136.0, 98.0, 100.0, 99.0, 135.0, 100.0, 99.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 109.9}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 148.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [73.0, 71.0, 71.0, 72.0, 72.0, 72.0, 73.0, 82.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 67.0, 68.0, 69.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [84.0, 93.0, 85.0, 86.0, 86.0, 87.0, 86.0, 91.0, 86.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 87.1}, {"lowerIsBetter": true, "replicates": [125.0, 125.0, 121.0, 121.0, 121.0, 121.0, 123.0, 122.0, 122.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [139.0, 137.0, 150.0, 160.0, 153.0, 141.0, 150.0, 150.0, 150.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.1}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 71.0, 71.0, 71.0, 71.0, 71.0, 72.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1541.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.98252981689905], "unit": "score", "name": "Richards", "value": 210.15280599999997}, {"lowerIsBetter": false, "replicates": [187.79342723004694], "unit": "score", "name": "DeltaBlue", "value": 352.0783499999999}, {"lowerIsBetter": false, "replicates": [278.2415136338342], "unit": "score", "name": "Encrypt", "value": 956.654514}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [2014.0845070422536], "unit": "score", "name": "RayTrace", "value": 367.4071258741258}, {"lowerIsBetter": false, "replicates": [806.4516129032259], "unit": "score", "name": "Earley", "value": 826.4141199999997}, {"lowerIsBetter": false, "replicates": [12395.061728395061], "unit": "score", "name": "Boyer", "value": 53.768429282868496}, {"lowerIsBetter": false, "replicates": [27216.216216216217], "unit": "score", "name": "RegExp", "value": 33.472140019860944}, {"lowerIsBetter": false, "replicates": [609.9939061547836], "unit": "score", "name": "Splay", "value": 133.59313786213784}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19593.539551647187}]} 17:06:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19593.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1541.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "5961.05"}}} 17:06:41 INFO - Return code: 0 17:06:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:06:41 INFO - # TBPL SUCCESS # 17:06:41 INFO - Running post-action listener: _resource_record_post_action 17:06:41 INFO - Running post-run listener: _resource_record_post_run 17:06:42 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 546238464; Read time: 0; Write time: 463020 17:06:42 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 228286464; Read time: 0; Write time: 256240 17:06:42 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 317952000; Read time: 0; Write time: 206780 17:06:42 INFO - Running post-run listener: _upload_blobber_files 17:06:42 INFO - Blob upload gear active. 17:06:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:06:42 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 17:06:42 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'] 17:06:42 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 17:06:43 INFO - (blobuploader) - INFO - Open directory for files ... 17:06:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:06:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:06:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:44 INFO - (blobuploader) - INFO - Done attempting. 17:06:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:06:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:06:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:06:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:06:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:06:44 INFO - (blobuploader) - INFO - Done attempting. 17:06:44 INFO - (blobuploader) - INFO - Iteration through files over. 17:06:44 INFO - Return code: 0 17:06:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:06:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:06:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1cb75586ad1c3e432fc2b92836025f47ceee224c43aba609733c8be38fbe58fa41537d86acc58b495978fc13ed3f853b76f87b51a73695de6417c2b798cbe514", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b2601d711b79d57b31450a10c4fd91193992f161c76e3bbb7c9f7d458a303bb8fe0ad3b4508929f2aadf8e37215e330345ce24eae773805d96d271a01c2993a"} 17:06:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:06:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:06:44 INFO - Contents: 17:06:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1cb75586ad1c3e432fc2b92836025f47ceee224c43aba609733c8be38fbe58fa41537d86acc58b495978fc13ed3f853b76f87b51a73695de6417c2b798cbe514", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b2601d711b79d57b31450a10c4fd91193992f161c76e3bbb7c9f7d458a303bb8fe0ad3b4508929f2aadf8e37215e330345ce24eae773805d96d271a01c2993a"} 17:06:44 INFO - Copying logs to upload dir... 17:06:44 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.998997 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-04 17:06:44.732045) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 17:06:44.735455) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480 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/1cb75586ad1c3e432fc2b92836025f47ceee224c43aba609733c8be38fbe58fa41537d86acc58b495978fc13ed3f853b76f87b51a73695de6417c2b798cbe514", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b2601d711b79d57b31450a10c4fd91193992f161c76e3bbb7c9f7d458a303bb8fe0ad3b4508929f2aadf8e37215e330345ce24eae773805d96d271a01c2993a"} build_url:https://queue.taskcluster.net/v1/task/MuqKpOkGR5mG65NoASbOXQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011399 build_url: 'https://queue.taskcluster.net/v1/task/MuqKpOkGR5mG65NoASbOXQ/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/1cb75586ad1c3e432fc2b92836025f47ceee224c43aba609733c8be38fbe58fa41537d86acc58b495978fc13ed3f853b76f87b51a73695de6417c2b798cbe514", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8b2601d711b79d57b31450a10c4fd91193992f161c76e3bbb7c9f7d458a303bb8fe0ad3b4508929f2aadf8e37215e330345ce24eae773805d96d271a01c2993a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-04 17:06:44.762303) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:06:44.762625) ========= 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=a4ce256d2ec601f24a60a71e000001bc-1451952729.619646-1236093480 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004464 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-04 17:06:44.849466) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 17:06:44.849773) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-04 17:06:44.850156) ========= ========= Total master_lag: 0.29 =========