builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1451158284.68 results: success (0) buildid: 20151226105347 builduid: be42ed71fc84465587f5b37f0cbb883c revision: 10ddceabece05224d104081ba4edf7a4a994c9c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.677427) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.678330) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.678969) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006433 basedir: '/builds/slave/test' ========= master_lag: 0.09 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.773319) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.773655) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.959626) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.959915) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004661 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.988141) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.988451) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.988863) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:24.989204) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-26 11:31: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|: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 2015-12-26 11:31:25 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.106975 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:25.117958) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:25.118443) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022093 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:25.169798) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:25.170175) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 10ddceabece05224d104081ba4edf7a4a994c9c4 --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 10ddceabece05224d104081ba4edf7a4a994c9c4 --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=9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-26 11:31:25,787 truncating revision to first 12 chars 2015-12-26 11:31:25,787 Setting DEBUG logging. 2015-12-26 11:31:25,787 attempt 1/10 2015-12-26 11:31:25,787 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/10ddceabece0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-26 11:31:26,263 unpacking tar archive at: fx-team-10ddceabece0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.955707 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:26.139464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:26.139809) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:26.151107) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:26.151505) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-26 11:31:26.152019) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-26 11:31:26.152358) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --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', '--system-bits', '64', '--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=9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:31:26 INFO - MultiFileLogger online at 20151226 11:31:26 in /builds/slave/test 11:31:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:31:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:31:26 INFO - {'append_to_log': False, 11:31:26 INFO - 'base_work_dir': '/builds/slave/test', 11:31:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:31:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:31:26 INFO - 'branch': 'Fx-Team-Non-PGO', 11:31:26 INFO - 'buildbot_json_path': 'buildprops.json', 11:31:26 INFO - 'config_files': ('talos/linux_config.py',), 11:31:26 INFO - 'default_actions': ('clobber', 11:31:26 INFO - 'read-buildbot-config', 11:31:26 INFO - 'download-and-extract', 11:31:26 INFO - 'populate-webroot', 11:31:26 INFO - 'create-virtualenv', 11:31:26 INFO - 'install', 11:31:26 INFO - 'run-tests'), 11:31:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:31:26 INFO - 'download_minidump_stackwalk': True, 11:31:26 INFO - 'download_symbols': 'ondemand', 11:31:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:31:26 INFO - 'tooltool.py': '/tools/tooltool.py', 11:31:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:31:26 INFO - '/tools/misc-python/virtualenv.py')}, 11:31:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:31:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:31:26 INFO - 'installer_path': 'installer.exe', 11:31:26 INFO - 'log_level': 'info', 11:31:26 INFO - 'log_name': 'talos', 11:31:26 INFO - 'log_to_console': True, 11:31:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:31:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:31:26 INFO - 'opt_config_files': (), 11:31:26 INFO - 'pip_index': False, 11:31:26 INFO - 'sps_profile': False, 11:31:26 INFO - 'sps_profile_interval': 0, 11:31:26 INFO - 'suite': 'dromaeojs', 11:31:26 INFO - 'system_bits': '64', 11:31:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:31:26 INFO - 'title': 'talos-linux64-ix-036', 11:31:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:31:26 INFO - 'use_talos_json': True, 11:31:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:31:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:31:26 INFO - 'work_dir': 'build'} 11:31:26 INFO - ##### 11:31:26 INFO - ##### Running clobber step. 11:31:26 INFO - ##### 11:31:26 INFO - Running pre-action listener: _resource_record_pre_action 11:31:26 INFO - Running main action method: clobber 11:31:26 INFO - rmtree: /builds/slave/test/build 11:31:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:31:27 INFO - Running post-action listener: _resource_record_post_action 11:31:27 INFO - ##### 11:31:27 INFO - ##### Running read-buildbot-config step. 11:31:27 INFO - ##### 11:31:27 INFO - Running pre-action listener: _resource_record_pre_action 11:31:27 INFO - Running main action method: read_buildbot_config 11:31:27 INFO - Using buildbot properties: 11:31:27 INFO - { 11:31:27 INFO - "project": "", 11:31:27 INFO - "product": "firefox", 11:31:27 INFO - "script_repo_revision": "production", 11:31:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:31:27 INFO - "repository": "", 11:31:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:31:27 INFO - "buildid": "20151226105347", 11:31:27 INFO - "pgo_build": "False", 11:31:27 INFO - "basedir": "/builds/slave/test", 11:31:27 INFO - "buildnumber": 2257, 11:31:27 INFO - "slavename": "talos-linux64-ix-036", 11:31:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 11:31:27 INFO - "platform": "ubuntu64_hw", 11:31:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:31:27 INFO - "branch": "fx-team", 11:31:27 INFO - "repo_path": "integration/fx-team", 11:31:27 INFO - "revision": "10ddceabece05224d104081ba4edf7a4a994c9c4", 11:31:27 INFO - "stage_platform": "linux64", 11:31:27 INFO - "builduid": "be42ed71fc84465587f5b37f0cbb883c", 11:31:27 INFO - "slavebuilddir": "test" 11:31:27 INFO - } 11:31:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 11:31:27 INFO - Running post-action listener: _resource_record_post_action 11:31:27 INFO - ##### 11:31:27 INFO - ##### Running download-and-extract step. 11:31:27 INFO - ##### 11:31:27 INFO - Running pre-action listener: _resource_record_pre_action 11:31:27 INFO - Running main action method: download_and_extract 11:31:27 INFO - mkdir: /builds/slave/test/build/tests 11:31:27 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')]} 11:31:27 INFO - https://queue.taskcluster.net/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:31:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/test_packages.json 11:31:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/test_packages.json 11:31:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:31:34 INFO - Downloaded 1302 bytes. 11:31:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:31:34 INFO - Using the following test package requirements: 11:31:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:31:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:31:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'jsshell-linux-x86_64.zip'], 11:31:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:31:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:31:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:31:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:31:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:31:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 11:31:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 11:31:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:31:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:31: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')]} 11:31:34 INFO - https://queue.taskcluster.net/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:31:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:31:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:31:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/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 11:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/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 11:31:41 INFO - Downloaded 21942261 bytes. 11:31:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:31:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:31:41 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:31:42 INFO - Return code: 0 11:31:42 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:42 INFO - https://queue.taskcluster.net/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:31:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:31:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:31:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/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 11:31:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/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 11:31:44 INFO - Downloaded 21942261 bytes. 11:31:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 11:31:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 11:31:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 11:31:46 INFO - Return code: 0 11:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:46 INFO - https://queue.taskcluster.net/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:31:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:31:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:31:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/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 11:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/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 11:31:47 INFO - Downloaded 11132270 bytes. 11:31:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 11:31:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 11:31:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 11:31:47 INFO - Return code: 0 11:31: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')]} 11:31:47 INFO - https://queue.taskcluster.net/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:31:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:31:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:31:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/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 11:31:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/rAWddqYfRBW-lXsbdmIx8Q/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 11:31:48 INFO - Downloaded 53334531 bytes. 11:31:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:31:48 INFO - mkdir: /builds/slave/test/properties 11:31:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:31:48 INFO - Writing to file /builds/slave/test/properties/build_url 11:31:48 INFO - Contents: 11:31:48 INFO - build_url:https://queue.taskcluster.net/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 11:31:48 INFO - Running post-action listener: _resource_record_post_action 11:31:48 INFO - Running post-action listener: set_extra_try_arguments 11:31:48 INFO - ##### 11:31:48 INFO - ##### Running populate-webroot step. 11:31:48 INFO - ##### 11:31:48 INFO - Running pre-action listener: _resource_record_pre_action 11:31:48 INFO - Running main action method: populate_webroot 11:31:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:31:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:31:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:31:48 INFO - '--tppagecycles', 11:31:48 INFO - '7'], 11:31:48 INFO - 'tests': ['tsvgm']}}, 11:31:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:31:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:31:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:31:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:31:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:31:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:31:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:48 INFO - 'talos_options': ['--e10s'], 11:31:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:31:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:48 INFO - 'tests': ['damp', 'tps']}, 11:31:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:48 INFO - 'talos_options': ['--e10s'], 11:31:48 INFO - 'tests': ['damp', 'tps']}, 11:31:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:31:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:31:48 INFO - 'other': {'tests': ['a11yr', 11:31:48 INFO - 'ts_paint', 11:31:48 INFO - 'tpaint', 11:31:48 INFO - 'sessionrestore', 11:31:48 INFO - 'sessionrestore_no_auto_restore']}, 11:31:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:31:48 INFO - 'tests': ['a11yr', 11:31:48 INFO - 'ts_paint', 11:31:48 INFO - 'tpaint', 11:31:48 INFO - 'sessionrestore', 11:31:48 INFO - 'sessionrestore_no_auto_restore']}, 11:31:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:31:48 INFO - 'tests': ['a11yr', 11:31:48 INFO - 'ts_paint', 11:31:48 INFO - 'tpaint', 11:31:48 INFO - 'sessionrestore', 11:31:48 INFO - 'sessionrestore_no_auto_restore']}, 11:31:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:31:48 INFO - 'tests': ['a11yr', 11:31:48 INFO - 'ts_paint', 11:31:48 INFO - 'tpaint', 11:31:48 INFO - 'sessionrestore', 11:31:48 INFO - 'sessionrestore_no_auto_restore']}, 11:31:48 INFO - 'other_l64': {'tests': ['a11yr', 11:31:48 INFO - 'ts_paint', 11:31:48 INFO - 'tpaint', 11:31:48 INFO - 'sessionrestore', 11:31:48 INFO - 'sessionrestore_no_auto_restore']}, 11:31:48 INFO - 'other_nol64': {'tests': ['a11yr', 11:31:48 INFO - 'ts_paint', 11:31:48 INFO - 'tpaint', 11:31:48 INFO - 'sessionrestore', 11:31:48 INFO - 'sessionrestore_no_auto_restore']}, 11:31:48 INFO - 'svgr': {'tests': ['tsvgx', 11:31:48 INFO - 'tsvgr_opacity', 11:31:48 INFO - 'tart', 11:31:48 INFO - 'tscrollx', 11:31:48 INFO - 'cart']}, 11:31:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:31:48 INFO - 'tests': ['tsvgx', 11:31:48 INFO - 'tsvgr_opacity', 11:31:48 INFO - 'tart', 11:31:48 INFO - 'tscrollx', 11:31:48 INFO - 'cart']}, 11:31:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:48 INFO - 'tests': ['tp5o']}, 11:31:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:48 INFO - 'talos_options': ['--e10s'], 11:31:48 INFO - 'tests': ['tp5o']}, 11:31:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:48 INFO - 'talos_options': ['--xperf_path', 11:31:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:48 INFO - 'tests': ['tp5n']}, 11:31:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:31:48 INFO - 'talos_options': ['--e10s', 11:31:48 INFO - '--xperf_path', 11:31:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:31:48 INFO - 'tests': ['tp5n']}}, 11:31:48 INFO - 'talos.zip': {'path': '', 11:31:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:31:48 INFO - Running post-action listener: _resource_record_post_action 11:31:48 INFO - ##### 11:31:48 INFO - ##### Running create-virtualenv step. 11:31:48 INFO - ##### 11:31:48 INFO - Running pre-action listener: _resource_record_pre_action 11:31:48 INFO - Running main action method: create_virtualenv 11:31:48 INFO - Creating virtualenv /builds/slave/test/build/venv 11:31:48 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 11:31:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:31:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:31:48 INFO - Using real prefix '/usr' 11:31:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:31:49 INFO - Installing distribute.............................................................................................................................................................................................done. 11:31:51 INFO - Installing pip.................done. 11:31:51 INFO - Return code: 0 11:31:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31: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')]} 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9841358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1215dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a83d0>, '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 0x1213ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1214360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', '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 11:31:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 11:31:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 11:31:51 INFO - Using env: {'DISPLAY': ':0', 11:31:51 INFO - 'HOME': '/home/cltbld', 11:31:51 INFO - 'LANG': 'en_US.UTF-8', 11:31:51 INFO - 'LANGUAGE': 'en_US:en', 11:31:51 INFO - 'LOGNAME': 'cltbld', 11:31:51 INFO - 'MAIL': '/var/mail/cltbld', 11:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:51 INFO - 'MOZ_NO_REMOTE': '1', 11:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:51 INFO - 'NO_EM_RESTART': '1', 11:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:51 INFO - 'PWD': '/builds/slave/test', 11:31:51 INFO - 'SHELL': '/bin/bash', 11:31:51 INFO - 'SHLVL': '1', 11:31:51 INFO - 'TERM': 'linux', 11:31:51 INFO - 'TMOUT': '86400', 11:31:51 INFO - 'USER': 'cltbld', 11:31:51 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', 11:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:51 INFO - '_': '/tools/buildbot/bin/python'} 11:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:51 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 11:31:51 INFO - Cleaning up... 11:31:51 INFO - Return code: 0 11:31:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31: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')]} 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31: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', '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 0x7f9841358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1215dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a83d0>, '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 0x1213ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1214360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', '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 11:31: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', 'psutil>=0.7.1'] in /builds/slave/test/build 11:31: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 psutil>=0.7.1 11:31:51 INFO - Using env: {'DISPLAY': ':0', 11:31:51 INFO - 'HOME': '/home/cltbld', 11:31:51 INFO - 'LANG': 'en_US.UTF-8', 11:31:51 INFO - 'LANGUAGE': 'en_US:en', 11:31:51 INFO - 'LOGNAME': 'cltbld', 11:31:51 INFO - 'MAIL': '/var/mail/cltbld', 11:31:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:51 INFO - 'MOZ_NO_REMOTE': '1', 11:31:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:51 INFO - 'NO_EM_RESTART': '1', 11:31:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:51 INFO - 'PWD': '/builds/slave/test', 11:31:51 INFO - 'SHELL': '/bin/bash', 11:31:51 INFO - 'SHLVL': '1', 11:31:51 INFO - 'TERM': 'linux', 11:31:51 INFO - 'TMOUT': '86400', 11:31:51 INFO - 'USER': 'cltbld', 11:31:51 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', 11:31:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:51 INFO - '_': '/tools/buildbot/bin/python'} 11:31:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:51 INFO - Downloading/unpacking psutil>=0.7.1 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:53 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:31:53 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:31:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:31:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:53 INFO - Installing collected packages: psutil 11:31:53 INFO - Running setup.py install for psutil 11:31:53 INFO - building 'psutil._psutil_linux' extension 11:31:53 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 11:31:53 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 11:31:53 INFO - building 'psutil._psutil_posix' extension 11:31:53 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 11:31:53 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 11:31:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:31:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:31:53 INFO - Successfully installed psutil 11:31:53 INFO - Cleaning up... 11:31:53 INFO - Return code: 0 11:31:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:53 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 0x7f9841358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1215dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a83d0>, '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 0x1213ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1214360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', '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 11:31:53 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 11:31:53 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 11:31:53 INFO - Using env: {'DISPLAY': ':0', 11:31:53 INFO - 'HOME': '/home/cltbld', 11:31:53 INFO - 'LANG': 'en_US.UTF-8', 11:31:53 INFO - 'LANGUAGE': 'en_US:en', 11:31:53 INFO - 'LOGNAME': 'cltbld', 11:31:53 INFO - 'MAIL': '/var/mail/cltbld', 11:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:53 INFO - 'MOZ_NO_REMOTE': '1', 11:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:53 INFO - 'NO_EM_RESTART': '1', 11:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:53 INFO - 'PWD': '/builds/slave/test', 11:31:53 INFO - 'SHELL': '/bin/bash', 11:31:53 INFO - 'SHLVL': '1', 11:31:53 INFO - 'TERM': 'linux', 11:31:53 INFO - 'TMOUT': '86400', 11:31:53 INFO - 'USER': 'cltbld', 11:31:53 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', 11:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:53 INFO - '_': '/tools/buildbot/bin/python'} 11:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:31: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 11:31: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 11:31: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 11:31: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 11:31: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 11:31: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 11:31:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:31:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:31:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:31:55 INFO - Installing collected packages: mozsystemmonitor 11:31:55 INFO - Running setup.py install for mozsystemmonitor 11:31:55 INFO - Successfully installed mozsystemmonitor 11:31:55 INFO - Cleaning up... 11:31:55 INFO - Return code: 0 11:31:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:31: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')]} 11:31:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31: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')]} 11:31:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f9841358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1215dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a83d0>, '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 0x1213ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1214360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', '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 11:31:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:31:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:31:55 INFO - Using env: {'DISPLAY': ':0', 11:31:55 INFO - 'HOME': '/home/cltbld', 11:31:55 INFO - 'LANG': 'en_US.UTF-8', 11:31:55 INFO - 'LANGUAGE': 'en_US:en', 11:31:55 INFO - 'LOGNAME': 'cltbld', 11:31:55 INFO - 'MAIL': '/var/mail/cltbld', 11:31:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:55 INFO - 'MOZ_NO_REMOTE': '1', 11:31:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:55 INFO - 'NO_EM_RESTART': '1', 11:31:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:55 INFO - 'PWD': '/builds/slave/test', 11:31:55 INFO - 'SHELL': '/bin/bash', 11:31:55 INFO - 'SHLVL': '1', 11:31:55 INFO - 'TERM': 'linux', 11:31:55 INFO - 'TMOUT': '86400', 11:31:55 INFO - 'USER': 'cltbld', 11:31:55 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', 11:31:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:55 INFO - '_': '/tools/buildbot/bin/python'} 11:31:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:56 INFO - Downloading/unpacking blobuploader==1.2.4 11:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:57 INFO - Downloading blobuploader-1.2.4.tar.gz 11:31:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:31:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:31:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:31:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:31:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:31:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:31:58 INFO - Downloading docopt-0.6.1.tar.gz 11:31:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:31:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:31:58 INFO - Installing collected packages: blobuploader, requests, docopt 11:31:58 INFO - Running setup.py install for blobuploader 11:31:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:31:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:31:58 INFO - Running setup.py install for requests 11:31:58 INFO - Running setup.py install for docopt 11:31:59 INFO - Successfully installed blobuploader requests docopt 11:31:59 INFO - Cleaning up... 11:31:59 INFO - Return code: 0 11:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:31:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9841358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1215dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a83d0>, '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 0x1213ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1214360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', '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 11:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 11:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:31:59 INFO - Using env: {'DISPLAY': ':0', 11:31:59 INFO - 'HOME': '/home/cltbld', 11:31:59 INFO - 'LANG': 'en_US.UTF-8', 11:31:59 INFO - 'LANGUAGE': 'en_US:en', 11:31:59 INFO - 'LOGNAME': 'cltbld', 11:31:59 INFO - 'MAIL': '/var/mail/cltbld', 11:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:31:59 INFO - 'MOZ_NO_REMOTE': '1', 11:31:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:31:59 INFO - 'NO_EM_RESTART': '1', 11:31:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:31:59 INFO - 'PWD': '/builds/slave/test', 11:31:59 INFO - 'SHELL': '/bin/bash', 11:31:59 INFO - 'SHLVL': '1', 11:31:59 INFO - 'TERM': 'linux', 11:31:59 INFO - 'TMOUT': '86400', 11:31:59 INFO - 'USER': 'cltbld', 11:31:59 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', 11:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:31:59 INFO - '_': '/tools/buildbot/bin/python'} 11:31:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:31:59 INFO - Running setup.py (path:/tmp/pip-N0SxVC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:31:59 INFO - Running setup.py (path:/tmp/pip-n_G1sY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:31:59 INFO - Running setup.py (path:/tmp/pip-MReGF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:31:59 INFO - Running setup.py (path:/tmp/pip-IB6LZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:31:59 INFO - Running setup.py (path:/tmp/pip-lVzSRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:31:59 INFO - Running setup.py (path:/tmp/pip-LsXCbe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:31:59 INFO - Running setup.py (path:/tmp/pip-uglfsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:31:59 INFO - Running setup.py (path:/tmp/pip-iZQc_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:31:59 INFO - Running setup.py (path:/tmp/pip-hK3Jux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:31:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:31:59 INFO - Running setup.py (path:/tmp/pip-AExJWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:00 INFO - Running setup.py (path:/tmp/pip-K_aRQg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:00 INFO - Running setup.py (path:/tmp/pip-Rm_vjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:00 INFO - Running setup.py (path:/tmp/pip-JFkqV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:00 INFO - Running setup.py (path:/tmp/pip-wB0a7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:00 INFO - Running setup.py (path:/tmp/pip-DHWmcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:00 INFO - Running setup.py (path:/tmp/pip-kTQmuX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:00 INFO - Running setup.py (path:/tmp/pip-h_vfFl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:32:00 INFO - Running setup.py install for manifestparser 11:32:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:32:00 INFO - Running setup.py install for mozcrash 11:32:00 INFO - Running setup.py install for mozdebug 11:32:00 INFO - Running setup.py install for mozdevice 11:32:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:32:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:32:00 INFO - Running setup.py install for mozfile 11:32:01 INFO - Running setup.py install for mozhttpd 11:32:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozinfo 11:32:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozInstall 11:32:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozleak 11:32:01 INFO - Running setup.py install for mozlog 11:32:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for moznetwork 11:32:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozprocess 11:32:01 INFO - Running setup.py install for mozprofile 11:32:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:32:01 INFO - Running setup.py install for mozrunner 11:32:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:32:02 INFO - Running setup.py install for mozscreenshot 11:32:02 INFO - Running setup.py install for moztest 11:32:02 INFO - Running setup.py install for mozversion 11:32:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:32:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:32:02 INFO - Cleaning up... 11:32:02 INFO - Return code: 0 11:32:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32: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')]} 11:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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')]} 11:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32: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/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 0x7f9841358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1215dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a83d0>, '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 0x1213ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1214360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', '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 11:32: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/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 11:32: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/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 11:32:02 INFO - Using env: {'DISPLAY': ':0', 11:32:02 INFO - 'HOME': '/home/cltbld', 11:32:02 INFO - 'LANG': 'en_US.UTF-8', 11:32:02 INFO - 'LANGUAGE': 'en_US:en', 11:32:02 INFO - 'LOGNAME': 'cltbld', 11:32:02 INFO - 'MAIL': '/var/mail/cltbld', 11:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:02 INFO - 'MOZ_NO_REMOTE': '1', 11:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:02 INFO - 'NO_EM_RESTART': '1', 11:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:02 INFO - 'PWD': '/builds/slave/test', 11:32:02 INFO - 'SHELL': '/bin/bash', 11:32:02 INFO - 'SHLVL': '1', 11:32:02 INFO - 'TERM': 'linux', 11:32:02 INFO - 'TMOUT': '86400', 11:32:02 INFO - 'USER': 'cltbld', 11:32:02 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', 11:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:02 INFO - '_': '/tools/buildbot/bin/python'} 11:32:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:32:02 INFO - Running setup.py (path:/tmp/pip-UwDx4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:32:02 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)) 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:32:02 INFO - Running setup.py (path:/tmp/pip-Y6zmnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:32:02 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)) 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:32:02 INFO - Running setup.py (path:/tmp/pip-qwhhvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:32:02 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)) 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:32:02 INFO - Running setup.py (path:/tmp/pip-FGRtML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:32:02 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)) 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:32:02 INFO - Running setup.py (path:/tmp/pip-8Y94z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:32:02 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)) 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:32:02 INFO - Running setup.py (path:/tmp/pip-1pIBSZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:32:02 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)) 11:32:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:32:02 INFO - Running setup.py (path:/tmp/pip-ewPD2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:32:03 INFO - Running setup.py (path:/tmp/pip-MmQB96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:32:03 INFO - Running setup.py (path:/tmp/pip-_EErNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:32:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:32:03 INFO - Running setup.py (path:/tmp/pip-pfsEon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:32:03 INFO - Running setup.py (path:/tmp/pip-brKU8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:32:03 INFO - Running setup.py (path:/tmp/pip-cXKb_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:32:03 INFO - Running setup.py (path:/tmp/pip-3VSoU6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:32:03 INFO - Running setup.py (path:/tmp/pip-4R4f_y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:03 INFO - Running setup.py (path:/tmp/pip-ATdmti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:32:03 INFO - Running setup.py (path:/tmp/pip-lEYKjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:32:03 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)) 11:32:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:32:03 INFO - Running setup.py (path:/tmp/pip-7ZgXdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:32:03 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)) 11:32:03 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)) 11:32:03 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)) 11:32:03 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)) 11:32:03 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)) 11:32:03 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)) 11:32:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:32:03 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 11:32:03 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 11:32:03 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 11:32:03 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 11:32:03 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 11:32:03 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 11:32:05 INFO - Downloading blessings-1.5.1.tar.gz 11:32:05 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 11:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:32:05 INFO - Installing collected packages: blessings 11:32:05 INFO - Running setup.py install for blessings 11:32:05 INFO - Successfully installed blessings 11:32:05 INFO - Cleaning up... 11:32:05 INFO - Return code: 0 11:32:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:32:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:05 INFO - Reading from file tmpfile_stdout 11:32:05 INFO - Current package versions: 11:32:05 INFO - argparse == 1.2.1 11:32:05 INFO - blessings == 1.5.1 11:32:05 INFO - blobuploader == 1.2.4 11:32:05 INFO - docopt == 0.6.1 11:32:05 INFO - manifestparser == 1.1 11:32:05 INFO - mozInstall == 1.12 11:32:05 INFO - mozcrash == 0.16 11:32:05 INFO - mozdebug == 0.1 11:32:05 INFO - mozdevice == 0.47 11:32:05 INFO - mozfile == 1.2 11:32:05 INFO - mozhttpd == 0.7 11:32:05 INFO - mozinfo == 0.9 11:32:05 INFO - mozleak == 0.1 11:32:05 INFO - mozlog == 3.1 11:32:05 INFO - moznetwork == 0.27 11:32:05 INFO - mozprocess == 0.22 11:32:05 INFO - mozprofile == 0.28 11:32:05 INFO - mozrunner == 6.11 11:32:05 INFO - mozscreenshot == 0.1 11:32:05 INFO - mozsystemmonitor == 0.0 11:32:05 INFO - moztest == 0.7 11:32:05 INFO - mozversion == 1.4 11:32:05 INFO - psutil == 3.1.1 11:32:05 INFO - requests == 1.2.3 11:32:05 INFO - wsgiref == 0.1.2 11:32:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:32:05 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')]} 11:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:05 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')]} 11:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:05 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 0x7f9841358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1215dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a83d0>, '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 0x1213ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1214360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', '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 11:32:05 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 11:32:05 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 11:32:05 INFO - Using env: {'DISPLAY': ':0', 11:32:05 INFO - 'HOME': '/home/cltbld', 11:32:05 INFO - 'LANG': 'en_US.UTF-8', 11:32:05 INFO - 'LANGUAGE': 'en_US:en', 11:32:05 INFO - 'LOGNAME': 'cltbld', 11:32:05 INFO - 'MAIL': '/var/mail/cltbld', 11:32:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:05 INFO - 'MOZ_NO_REMOTE': '1', 11:32:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:05 INFO - 'NO_EM_RESTART': '1', 11:32:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:05 INFO - 'PWD': '/builds/slave/test', 11:32:05 INFO - 'SHELL': '/bin/bash', 11:32:05 INFO - 'SHLVL': '1', 11:32:05 INFO - 'TERM': 'linux', 11:32:05 INFO - 'TMOUT': '86400', 11:32:05 INFO - 'USER': 'cltbld', 11:32:05 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', 11:32:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:05 INFO - '_': '/tools/buildbot/bin/python'} 11:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:06 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)) 11:32:06 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)) 11:32:06 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)) 11:32:06 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)) 11:32:06 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)) 11:32:06 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)) 11:32:06 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)) 11:32:06 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)) 11:32:06 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)) 11:32:06 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)) 11:32:06 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)) 11:32:06 INFO - Cleaning up... 11:32:06 INFO - Return code: 0 11:32:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:32:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f9841358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1215dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a83d0>, '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 0x1213ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1214360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', '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 11:32:06 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 11:32:06 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 11:32:06 INFO - Using env: {'DISPLAY': ':0', 11:32:06 INFO - 'HOME': '/home/cltbld', 11:32:06 INFO - 'LANG': 'en_US.UTF-8', 11:32:06 INFO - 'LANGUAGE': 'en_US:en', 11:32:06 INFO - 'LOGNAME': 'cltbld', 11:32:06 INFO - 'MAIL': '/var/mail/cltbld', 11:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:06 INFO - 'MOZ_NO_REMOTE': '1', 11:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:06 INFO - 'NO_EM_RESTART': '1', 11:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:06 INFO - 'PWD': '/builds/slave/test', 11:32:06 INFO - 'SHELL': '/bin/bash', 11:32:06 INFO - 'SHLVL': '1', 11:32:06 INFO - 'TERM': 'linux', 11:32:06 INFO - 'TMOUT': '86400', 11:32:06 INFO - 'USER': 'cltbld', 11:32:06 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', 11:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:06 INFO - '_': '/tools/buildbot/bin/python'} 11:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:06 INFO - Downloading/unpacking jsonschema 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32: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 11:32:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:32:08 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 11:32:08 INFO - Downloading/unpacking functools32 (from jsonschema) 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:08 INFO - Downloading functools32-3.2.3-2.tar.gz 11:32:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:32:08 INFO - warning: no files found matching '*.txt' 11:32:08 INFO - no previously-included directories found matching 'build' 11:32:08 INFO - no previously-included directories found matching 'dist' 11:32:08 INFO - no previously-included directories found matching '.git*' 11:32:08 INFO - Installing collected packages: jsonschema, functools32 11:32:08 INFO - Running setup.py install for functools32 11:32:08 INFO - warning: no files found matching '*.txt' 11:32:08 INFO - no previously-included directories found matching 'build' 11:32:08 INFO - no previously-included directories found matching 'dist' 11:32:08 INFO - no previously-included directories found matching '.git*' 11:32:08 INFO - Successfully installed jsonschema functools32 11:32:08 INFO - Cleaning up... 11:32:08 INFO - Return code: 0 11:32:08 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:32:08 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')]} 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:08 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')]} 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:32:08 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 0x7f9841358f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1215dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12a83d0>, '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 0x1213ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1214360>, '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': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', '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 11:32:08 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 11:32:08 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 11:32:08 INFO - Using env: {'DISPLAY': ':0', 11:32:08 INFO - 'HOME': '/home/cltbld', 11:32:08 INFO - 'LANG': 'en_US.UTF-8', 11:32:08 INFO - 'LANGUAGE': 'en_US:en', 11:32:08 INFO - 'LOGNAME': 'cltbld', 11:32:08 INFO - 'MAIL': '/var/mail/cltbld', 11:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:08 INFO - 'MOZ_NO_REMOTE': '1', 11:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:08 INFO - 'NO_EM_RESTART': '1', 11:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:08 INFO - 'PWD': '/builds/slave/test', 11:32:08 INFO - 'SHELL': '/bin/bash', 11:32:08 INFO - 'SHLVL': '1', 11:32:08 INFO - 'TERM': 'linux', 11:32:08 INFO - 'TMOUT': '86400', 11:32:08 INFO - 'USER': 'cltbld', 11:32:08 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', 11:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:08 INFO - '_': '/tools/buildbot/bin/python'} 11:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:32:08 INFO - Downloading/unpacking flake8 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:10 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:32:10 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 11:32:10 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:32:10 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 11:32:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:10 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 11:32:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:32:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:32:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:32:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:32:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:32:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:32:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:32:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:32:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:32:11 INFO - no previously-included directories found matching 'docs/_build' 11:32:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:32:11 INFO - Running setup.py install for pep8 11:32:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:32:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:32:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:32:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:32:11 INFO - no previously-included directories found matching 'docs/_build' 11:32:11 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:32:11 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:32:11 INFO - Cleaning up... 11:32:11 INFO - Return code: 0 11:32:11 INFO - Running post-action listener: _resource_record_post_action 11:32:11 INFO - Running post-action listener: _start_resource_monitoring 11:32:11 INFO - Starting resource monitoring. 11:32:11 INFO - ##### 11:32:11 INFO - ##### Running install step. 11:32:11 INFO - ##### 11:32:11 INFO - Running pre-action listener: _resource_record_pre_action 11:32:11 INFO - Running main action method: install 11:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:32:11 INFO - Reading from file tmpfile_stdout 11:32:11 INFO - Detecting whether we're running mozinstall >=1.0... 11:32:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:32:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:32:11 INFO - Reading from file tmpfile_stdout 11:32:11 INFO - Output received: 11:32:11 INFO - Usage: mozinstall [options] installer 11:32:11 INFO - Options: 11:32:11 INFO - -h, --help show this help message and exit 11:32:11 INFO - -d DEST, --destination=DEST 11:32:11 INFO - Directory to install application into. [default: 11:32:11 INFO - "/builds/slave/test"] 11:32:11 INFO - --app=APP Application being installed. [default: firefox] 11:32:11 INFO - mkdir: /builds/slave/test/build/application 11:32:11 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'] 11:32:11 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 11:32:27 INFO - Reading from file tmpfile_stdout 11:32:27 INFO - Output received: 11:32:27 INFO - /builds/slave/test/build/application/firefox/firefox 11:32:27 INFO - Running post-action listener: _resource_record_post_action 11:32:27 INFO - ##### 11:32:27 INFO - ##### Running run-tests step. 11:32:27 INFO - ##### 11:32:27 INFO - Running pre-action listener: _resource_record_pre_action 11:32:27 INFO - Running main action method: run_tests 11:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:32:27 INFO - Python 2.7.3 11:32:27 INFO - Return code: 0 11:32:27 INFO - grabbing minidump binary from tooltool 11:32:27 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')]} 11:32:27 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 0x12a83d0>, '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 0x1213ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1214360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:32:27 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 11:32:27 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 11:32:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:32:27 INFO - Return code: 0 11:32:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:32:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:32:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:32:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:32:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:32:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:32:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:32:28 INFO - Return code: 0 11:32:28 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/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 11:32:28 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/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 11:32:28 INFO - Using env: {'DISPLAY': ':0', 11:32:28 INFO - 'HOME': '/home/cltbld', 11:32:28 INFO - 'LANG': 'en_US.UTF-8', 11:32:28 INFO - 'LANGUAGE': 'en_US:en', 11:32:28 INFO - 'LOGNAME': 'cltbld', 11:32:28 INFO - 'MAIL': '/var/mail/cltbld', 11:32:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:32:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:32:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:32:28 INFO - 'MOZ_NO_REMOTE': '1', 11:32:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:32:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:32:28 INFO - 'NO_EM_RESTART': '1', 11:32:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:32:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:32:28 INFO - 'PWD': '/builds/slave/test', 11:32:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:32:28 INFO - 'SHELL': '/bin/bash', 11:32:28 INFO - 'SHLVL': '1', 11:32:28 INFO - 'TERM': 'linux', 11:32:28 INFO - 'TMOUT': '86400', 11:32:28 INFO - 'USER': 'cltbld', 11:32:28 INFO - 'XDG_SESSION_COOKIE': '9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584', 11:32:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:32:28 INFO - '_': '/tools/buildbot/bin/python'} 11:32:28 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/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 11:32:28 INFO - mozversion application_buildid: 20151226105347 11:32:28 INFO - mozversion application_changeset: 10ddceabece05224d104081ba4edf7a4a994c9c4 11:32:28 INFO - mozversion application_display_name: Nightly 11:32:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:32:28 INFO - mozversion application_name: Firefox 11:32:28 INFO - mozversion application_remotingname: firefox 11:32:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 11:32:28 INFO - mozversion application_vendor: Mozilla 11:32:28 INFO - mozversion application_version: 46.0a1 11:32:28 INFO - mozversion platform_buildid: 20151226105347 11:32:28 INFO - mozversion platform_changeset: 10ddceabece05224d104081ba4edf7a4a994c9c4 11:32:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 11:32:28 INFO - mozversion platform_version: 46.0a1 11:32:28 INFO - using testdate: 1451158348 11:32:28 INFO - actual date: 1451158348 11:32:28 INFO - starting webserver on 'localhost:41367' 11:32:28 INFO - SUITE-START | Running 3 tests 11:32:28 INFO - TEST-START | dromaeo_css 11:32:28 INFO - operating with platform_type : linux_ 11:32:28 INFO - Initialising browser for dromaeo_css test... 11:32:28 INFO - TEST-INFO | started process 16534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwpUlON/profile http://localhost:41367/getInfo.html) 11:32:33 INFO - PROCESS | 16534 | __metrics Screen width/height:1600/1200 11:32:33 INFO - PROCESS | 16534 | colorDepth:24 11:32:33 INFO - PROCESS | 16534 | Browser inner width/height: 1024/697 11:32:33 INFO - PROCESS | 16534 | __metrics 11:32:33 INFO - PROCESS | 16534 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:32:33 INFO - PROCESS | 16534 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:32:34 INFO - TEST-INFO | 16534: exit 0 11:32:34 INFO - Browser initialized. 11:32:34 INFO - Running cycle 1/1 for dromaeo_css test... 11:32:34 INFO - TEST-INFO | started process 16627 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwpUlON/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:32:46 INFO - PROCESS | 16627 | RSS: Main: 150364160 11:32:46 INFO - PROCESS | 16627 | 11:33:37 INFO - PROCESS | 16627 | 1451158417606 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] 11:35:49 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41367/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41367/tests/dromaeo/cssquery-ext.html) 11:35:50 INFO - PROCESS | 16627 | RSS: Main: 264720384 11:35:50 INFO - PROCESS | 16627 | 11:38:53 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41367/tests/dromaeo/cssquery-ext.html (next: http://localhost:41367/tests/dromaeo/cssquery-jquery.html) 11:38:54 INFO - PROCESS | 16627 | RSS: Main: 233123840 11:38:54 INFO - PROCESS | 16627 | 11:41:56 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41367/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41367/tests/dromaeo/cssquery-mootools.html) 11:41:56 INFO - PROCESS | 16627 | RSS: Main: 232488960 11:41:56 INFO - PROCESS | 16627 | 11:44:58 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41367/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41367/tests/dromaeo/cssquery-prototype.html) 11:44:59 INFO - PROCESS | 16627 | RSS: Main: 217178112 11:44:59 INFO - PROCESS | 16627 | 11:48:01 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41367/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41367/tests/dromaeo/cssquery-yui.html) 11:48:02 INFO - PROCESS | 16627 | RSS: Main: 217870336 11:48:02 INFO - PROCESS | 16627 | 11:51:05 INFO - PROCESS | 16627 | Cycle 1(1): loaded http://localhost:41367/tests/dromaeo/cssquery-yui.html (next: http://localhost:41367/tests/dromaeo/cssquery-dojo.html) 11:51:05 INFO - PROCESS | 16627 | RSS: Main: 260259840 11:51:05 INFO - PROCESS | 16627 | 11:51:05 INFO - PROCESS | 16627 | __start_tp_report 11:51:05 INFO - PROCESS | 16627 | _x_x_mozilla_page_load 11:51:05 INFO - PROCESS | 16627 | _x_x_mozilla_page_load_details 11:51:05 INFO - PROCESS | 16627 | |i|pagename|runs| 11:51:05 INFO - PROCESS | 16627 | |0;dojo.html;2589.6892372915254;2669.8398096114247;2671.7194694557083;2681.021427179079;2689.6772387313526;4409.757463339515;4549.954500454995;4614.607758340541;4615.492295847454;4617.699849509784;4507.93238101428;4555.088982203564;4613.7231766094055;4626.190820401109;4627.329037289591;4200.012996945716;4226.852060177895;4296.7207131536425;4318.719283246594;4355.128974205156;4048.9392659110135;4274.038341373197;4299.527052024275;4319.71921825082;4355.390245365636;4142.150859073913;4162.791860406967;4183.769892655902;4252.2345977724;4264.147170565868;4260.978695106535;4263.658907287409;4270.978645106755;4274.316109422478;4319.935200971988;4255.957440425618;4260.424842646234;4260.850870219559;4273.273543497613;4299.91400171998;4367.410399596078;4454.955450445486;4465.933011004805;4487.169873573399;4568.977155114203;4876.195427754416;4876.561109500127;4877.3903262092235;4878.804847806084;4922.237053256751;4909.729964851932;4919.26211068339;4920.5571498565305;4925.064237794843;4956.628252881048;4489.393931819195;4574.199515084847;4575.679702420799;4589.059242855206;4625.514320996281;5005.224190250517;5118.61610379223;5122.564582010571;5136;5141.151709967813;4876.683015603974;4881.707097574157;4884.7313397762755;4887.315775791392;4887.34020907173;4656.976715116402;4981.4769449207315;4983.127952608279;4983.875403114878;5028.195488721787;4704.200285951397;4738.668293219442;4752.14461396945;4830.3479030331155;4962.280469331927;4817;4851.56335929768;4854.344663470457;4899.559039686445;4900.485449027872;4112.280350938574;4125.401816736557;4127.030147915238;4147.564505726916;4165.042040330741;3547.94678079829;3637.454381842692;3656.213914008501;3663.9633603663624;3692.5753538343433;4210.810513526899;4264.616184543406;4269.530351661315;4309.806058727302;4309.870703878889;4932.53140951609;4936.259561065797;4938.58022068121;4963.503649635008;4974.452810190876;4024.2353952748886;4143.709940304149;4147.212029714345;4211.220924129046;4216.9578304217175;4300.8709738707885;4375.693701440869;4376.956230437655;4443.266860967904;4444.73331600105;4643.141018911512;4644.187267228289;4662.510436404196;4665.04366604852;4705.576498115118;4739.691920025188;4866.05112003156;4868.780904859361;4875.366202393808;4907.214845624683;4487.349334346567;4529.2300308948215;4643.86068417948;4747.738874361943;4751.524847515221;4817;4818.903621927612;4818.95181048185;4840.636952228668;4863.635227357891;4875.561199492063;4883.169861123546;4888.071266459361;4898.608111351155;4931.556159945622;4619.491855895916;4730.550597693214;4731.550502702238;4740.3837501124635;4764.332993380999;4731.313959475788;4811.711297322172;4816.084943860656;4818.445878723852;4842.128416884994;4607.723536587815;4660.883477913079;4663.533646635445;4714.057188562233;4715.764211789466;4631.745254010927;4701.271302948048;4721.433427988663;4732.668713190182;4873.244647079709;4659.394278743742;4672.76636168197;4677.579017888406;4721.763911804464;4724.929126063043 11:51:05 INFO - PROCESS | 16627 | |1;ext.html;528.6722232216024;530.1411713024895;565.6973519167246;576.5935015813851;579.2151634535205;23430.648540271908;23784.643230351536;32355.352892942155;32725.67274327262;32871.835640821824;34554.8272258639;35015.4747678785;35053.64946350536;35064.82467587658;35080.82459587705;6707.3628005339415;7502.062242219737;7713.691452341927;7718.6912523498995;7722.150563438017;6757.594544327356;9628.614855405775;9792.608295668164;9810.803783924317;9818.26363022776;9361.297902657328;9441.952790236039;9449.669261575846;9450.102240287162;9450.4802235877;6903.6548172591165;7043.7534686285735;9510.239180865583;9569.377990430634;9699.709008729784;9533.237341012702;9696.17582505488;9696.369735967139;9696.903030969741;9707.61169553217;32280.35439291201;32701.18247043843;32802.50796238059;32816;32819.17952051194;2798.692143864194;2837.517622004264;2978.091682036978;3071.846407679607;3234.2884565395575;25316.240512784647;27491;27670.446591068267;27853.58219626707;28105.85947070272;3331.916702082443;3475.6871881530533;3488.1977145256733;3502.807345595991;3584.211473475831;218847;222862;223650;223822;223869;44960.3255951161;45928.540714592426;54485.72757136268;54780.17829732557;54872.176917346274;58929.41070589325;59863.401365986654;60215.39784602186;60259.397406026255;60360.094598581054;12827.422765975554;13017.609471715863;13035.348232588332;13037.348132593332;13061.673458163621;9732.367396119229;9743.464109474047;9772.951135244279;9789.118979291898;9850.950745246228;18518.16668249932;18904.71642925357;18904.810951890304;18916.90541547311;18918;7381.926180738231;7640.235976402315;7664.961675191588;7714.112877019103;7727.845443091219;824.7402068348451;832.8042909916165;841.9579021048924;842.4818736477145;908.6737950845855;26311.73688263093;26365.34086647811;26639.33401664935;26671.733282667312;26833.597496037575;973.5035132082547;1030.9690709278734;1034;1067.8665166854144;1109.750306181119;13713.17720936747;13882.930585347009;13983.720325593431;14073.71852562943;14128;252666;259217;259499;259829;260551;44735.77632111819;45228.3215751764;45275.32087018697;45413.77293113579;45418.54581454143;1138.7551676389617;1140.244024202735;1154.2266681323533;1154.9595764148214;1155.757290968889;24869.50260994806;25737.485250294514;26225.213243602724;26259.929710894077;26267.868660656575;33260.33479330448;34139.48790768091;39149.2170156601;39379.6062039376;39403;241164;245452;247350;247510;247550;28766.568501472913;29548.261293467836;29564.852175739845;29579.852100739357;29651.406971860873;37379.81310093432;38123.2375352497;38673;38693;38704.61295387123;32388.514172287905;32947.67052329446;32973.34053318968;33213.667863321054;33647.663523364456;33127.17182070467;33199.66800331966;33485.665143348255;33546.49680254847;33616.83191584027;35089;35371.46942795911;35605.64394356023;36026.63973360233;36209.63790362063;24913.252602421955;25807.612885807102;28270.71729282681;29325;29343.11970640884;23257.3022809316;24965.500689985736;25119.497610048064;25269.24192274235;25663.358416039748 11:51:05 INFO - PROCESS | 16627 | |2;jquery.html;329.88783813503403;330.48114460297313;330.6016250418246;330.9106541233867;335.2189398701027;11705.473253703583;12072.758544829097;14701.117932924031;15161.39354425823;15766.999999999985;11496.482658280376;13372.063955523117;13374;13597.796033059512;14388.856111438883;4269.231538323101;4819.855404337866;4836.515940861922;4950.712814668194;4951.752412379385;3717.7955212463303;3774.8112594370173;4873.8781530461665;4900;5617.325920889499;5703.828885133453;5741.483266506014;5766.769329226826;5768.826935191951;5772.769089236446;5544.362398324184;5631.493165615073;5635.49280564747;5637.80267690633;5730.169125476803;4946.629002824802;4948.4309304429735;4953.356063711731;4953.801847926079;4954.157793175169;17291.654166916716;18685.252589896525;18916.148773305234;19075.427737167767;19319.90340048291;1887.4960842909304;1903.0294549779574;1957.4127761671584;1987.125664707524;1992.2031187525106;8410.32717382608;8634.654613815439;8798.51608161551;8879;10576.418296993663;1657.2459530913407;1695.7286834106483;1697.3041053168265;1743.3985275080076;1804.5127815489743;47046.529534704554;49432.25851612229;49452.258216126786;49625.25562116535;49934.500654993346;9231.399959002643;9310.115539023782;9314.208292295096;9327.860082098774;9588.185004274716;12186.573469928688;12239.69400764988;12280.938595306967;12282;12288.754224915452;6744.123263975652;6768.323167683291;6768.898466523006;6778.084958530535;6834.863302733917;6309.873802523924;6326.810195694136;6341.175647165931;6344.6827658616885;6362.872742545123;3949.980250098731;4027.899302517402;4066.877993660195;4068.9389659155136;4069.1251380953236;1570.2305870123785;1630.6657135287237;1635.4357746577411;1677.7818883545306;1709.734991076385;792.9722459713882;800.0399520575332;814.8506024216479;820.5897051474263;832.8667413213857;14752.336144873507;15351.15568643713;15705.921470392575;15713.21433928299;16922.830771692126;766.5860435364953;794.9085855126618;827.2802661684253;858.3690987124584;870.2472361407337;7850.8429831403055;8429.957850210709;8454.408191426664;8466.111058338909;9004.099590041074;501478;503939;516251;516849.82051256805;520603;74342.62828685822;74944;75644.24355756483;76176.61911690405;76262.23737762662;1023.9334443261164;1034.622362837574;1035.4874337203132;1035.6012935020071;1051.2746205118597;13290.401931912893;13551.661208469473;13601.931990339985;13718.794218086936;13812.447502100205;30357.696423035486;30549.23626909345;30702.84648576743;31144;31694.683053169174;47056.7647161762;47527.049459011316;47764.7611761939;48104.27843582419;49784.751076244385;8434.114417986024;8742.737717868475;8751.124887511198;8787.209151176425;8844.336674749291;11289.322640641587;16180.595485112495;16282.918585407471;16507.504774856774;16654.333826647282;12857.485700571873;13001.674958126123;13113.950883929072;13418.664533386744;13757;13376.665583360495;13411.262380568773;13418.798718019432;13442.93278533601;13597.184168949894;13562.321883905963;13584.728305434033;13938.163710177421;14114.576562703136;14292.42830286777;8733.257673097858;8733.388662793543;8740.956295218482;8809.251213646656;9006.414583052081;13048.804267936179;13401.865981340452;13540.119892206974;13707.45170193221;14082.859171408565 11:51:05 INFO - PROCESS | 16627 | |3;mootools.html;1130.4121856634545;1389.0901459544;1391.1235921369537;1495.6260934766308;1710.8545773609242;5802.129680547915;6788.558743681663;6908.274631163718;6909.896351554725;6917;6772.72909083636;6963.895541566881;6964.791056268307;6967.198772141205;6967.72129114836;1996.6605677034902;2028.959420811583;2029.9086541105685;2031.065709773506;2034.4608678700156;1987.0660789429016;2008.417558907915;2016.4353980885303;2038.1337931379178;2048.4878780304925;1988.6221617892554;1997.330894150454;2020.2626041494896;2021.423894190156;2023.9392818215476;1996.1516355548906;2027.5843452092286;2029.6245194639039;2033.8474614403979;2034.9491262718402;2010.668239740441;2038.775734669185;2085.384811480602;2087.9791202087936;2088.9477763056043;6994.545354551989;7068.08114945059;7074.610896400696;7075.8584828303665;7085.822854428629;4145.958540414587;4205.5794420558;4225.514065882401;4227.365895115727;4229.069604686964;2661.8535980521065;2669.6129061286197;2678.638383818179;2713.0775536317747;2763.115802943059;840.5125027484106;847.6482259862149;855.6748435594496;861.6165806216236;872.4067634008871;9278.814423711556;9316.161545460942;9321.487318197496;9329.860052099224;9353.906460935372;3776.2825063237897;3812.0850995760816;3813.218290250492;3899.6100389961343;3906.453096566483;8164.224398682116;8167.754967350989;8174.141715119827;8174.6730130795295;8179;4171.0823618803815;4181.414601955728;4204.957950420457;4211.43145675336;4217.283061879488;3144.434001879638;3238.611366636019;3567.857285708543;3799.0882188274613;3800.657940785343;3295.20914980403;3343.3313337332143;3349.933001340008;3417.5898892133105;3439.3465241604017;1076.9730756730987;1080.346390433792;1082.4695899009428;1087.5595383869545;1099.4063205868902;1197.6886009637558;1199.4902166579168;1201.813718873576;1215.3619349841404;1221.1146918484028;6604.240512341143;6690.130283063268;6698.631575263407;6713.664316784141;6741.561798483083;417.3156024120445;418.53542567749776;418.704813106759;419.1093925408507;419.5657494493185;5283.709395983181;5323.653962492425;5328.893422131536;5328.893422131613;5332.760025798849;8241.381896357678;8352;8438.324934005264;8539.402241843012;8552.871706924401;8325.125861784547;8346.624401901929;8448.619812108469;8451.535165565952;8460.238578527962;6593.076969224312;6667.933320666732;6684.1978962523835;6742.561733487308;6748.527603067836;6411.134496842867;6424.614523128627;6426.678666066771;6429.2284925807335;6434;7459.850802984019;7538.283863033003;7586.544807311579;7608.543487390552;7630.542167469969;7649.61751912391;7696.961515192612;7740.806479838049;7791.883121753292;7863.685452581833;5229.163333866563;5347.652402593819;5967.731452084579;5968.253968253968;6012;6468.838279043061;6537.803865884031;6594.934050659432;6599.934000659932;6610.140681711539;6025.909611355921;6071.423214794588;6090.573659843769;6155.076738489262;6158.507319414346;6103.328633850362;6198.163247961467;6242.094896240111;6274.592151510137;6295.18162638854;6245.125682404558;6274;6283.214598175228;6290.716917738804;6295.622262664255;5804.984127777538;5833.67914764692;5835.183074369676;5838.737256823538;5851.736671849862;5902.085176797603;5938.732757025858;5958.4210184302065;6006.48944839676;6009.909851352146 11:51:05 INFO - PROCESS | 16627 | |4;prototype.html;296.43233208405906;299.39372770140477;306.53406821631114;307.86607825595866;312.6482706954676;5318.78724851006;5365.865853353668;5418.647787893784;5421.484958928905;5426.864328391792;5303;5303.257543943851;5306.7346632668405;5310.3893052299;5314.734263286829;3931.115499012728;4140;4140.81366338514;4141.964508872782;4145.481814773153;4011.6188962048705;4049.129437171008;4114.506259248894;4120.814563344642;4136.048708796979;4074.470318858544;4075.1645912587996;4076.2458945095104;4080.5307389650125;4081.979590102045;3883.339832228528;3967.028078120879;3994.8801535953967;4078.286299897521;4083.816228269735;3585.480105384731;3594.155373487228;3595.137167079908;3596.2088340565033;3599.6940260077927;5084.466131056222;5089.083964886319;5105.948940510584;5109.463506331819;5115.104856650071;4719.764011799431;4724.622030237572;4725.787339569728;4728.692634978715;4730.526947305277;5451.618386712932;5568.7215639217875;5570.526505247059;5581.5813813963705;5602.663840169603;3960;3962.8204487531743;3963.7225394222414;3964.6431821136234;3968.146848427573;5872.236609240814;5881.470667639933;5884.911726324109;5893.8821223575715;5895.056790913476;4076.30702780528;4076.612721791425;4079.3880917862557;4079.938800917989;4080.1227736036303;3777.7166712496123;3865.1883104547796;4135.669146468335;4136.21411931732;4142.130152667974;4542.909141817145;4618.122556714214;4630.560096790799;4649.883752906137;4666.0901124280435;5587.05020146576;5593.692346920959;5595.720213989365;5598.076317407664;5599;1433.383645032646;1461.335092532895;1462.656275775192;1462.8829693624484;1463.8462961389114;986.4475893499663;992.265723364705;1005.8239808033564;1012.2155329619603;1023.8259495885717;4878.121938051114;4879.365682461328;4884.072026314989;4890.462049174588;4897.436794768647;5803;5803.941960580424;5805.970970145122;5806.854828629318;5809.82570522885;4867.3915760529935;4881.316615673809;4892.09496243189;4896.632752543503;4905.632077594195;3050.23744063984;3086.506159014592;3104.487759519699;3113.066080175938;3119.610048743907;5491.697956612345;5491.780328786804;5493.09363954943;5494.340679118532;5500.257465242221;5955.82132536016;5962.910556341659;5965.433283838029;5966.164736936832;5975.462208401264;5463.180522921593;5492.148716948879;5497.038018346853;5497.422770609109;5500.7524661391135;5600.831975040755;5786.5081468074;5793.304803423448;5794.507466865363;5798.33319168301;5676.091825307931;5676.4323567642905;5681.0626246668835;5686.800961966312;5687.289088863892;5489.533389661923;5496.890062198813;5498.560115190695;5499.2576002240785;5509.972450137724;4007.5391329996255;4090.202410529918;4096.40602112698;4099.85650502231;4110.486189226347;5581.827816158652;5774.769009239583;5804.303483581997;5806.941930580809;5810.215620891126;5521.420250873761;5548.223248745098;5553.694546799965;5555.8888822224135;5558.221848941071;5632.295963004624;5636.85907852307;5648.293963254593;5655.066913959316;5658.264425624642;5369.865753356197;5494.752736126804;5496.835094947158;5505.146702261156;5506.559475241891;5672.801451949162;5676.176954341515;5676.659400435987;5681.687507187145;5682.687452190169;5492.313460817398;5518.475744804237;5519.2824932758485;5519.668819870821;5586.832395028156 11:51:05 INFO - PROCESS | 16627 | |5;yui.html;723.1102668762926;751.1587022534761;776.8756998880181;781.9296263336298;783.7178615698348;11200.439978001108;13034.348282585868;13147.4083666235;13176;13184;13309.334533273322;13460.057795954262;13471.057026008184;13473.797893031588;13476.393562289695;580.7415700013496;587.9823605291848;774.8295375017501;786.4769927997875;787.0948409329288;772.8067983004249;780.0561320801837;786.2255678157011;787.2757063501564;787.5668382389691;819.2994989284166;820.0774129104757;822.0464261456711;826.8387664405443;827.0612854410227;580.6429046136637;593.6912805341199;803;819.4878201124297;819.6434550970347;605.8182545236456;608.0605464557269;608.7534548507862;608.8721368512618;609.7378127405213;10689.465526723632;10791.514381852758;10828.242023058388;10857.782844343068;10869.076128529085;10243.590256389736;10797.62208322705;10830.40432776197;10902.836457453144;11348.773024539545;9015.852211515088;9095.727128186165;9128.3153763468;9271;9415.858762118574;3107.1610665120293;3150.212446888278;3153.731932785716;3207.7273431758326;3236.1909522619344;40487;41373.1725365491;41450.79274603638;41497.377539336936;42397.57602423998;9097.703055169328;9134.26925845944;9153.35926485153;9179.311551633655;9231.676891308905;15867.603309917113;15940.043597384194;15956.601084972737;15963.840361596236;15976.680466390608;6078.75684972605;6208.410201030895;6265.937340626535;6348.682565871781;6363.172787537591;3452.7583069184916;3480.982595087059;3564.697000754913;3640.0899775056237;3660.249648821985;2596.7533084356955;2634.236071539232;2634.3545831271463;2636.1037247336;2636.815422920377;474.65587449099127;477.1625796726722;485.39325842696627;486.31429684145894;490.70312460960605;588.664461257088;598.1565991951328;614.2199406753398;619.4579742725116;628.6950828848005;7285.380742636829;7465.626718664045;7731.62493648312;7749.612519374009;7853.607319633996;406.362359690448;512.4199654738375;613.6655522740117;616.4051690118966;619.891518984176;3588.964110358863;3626.492291079251;3637.9818100909324;3682.2451397463456;3693.2244228711734;51082.74458627683;51103.744481278096;51738;52019;52073.21890171651;43615.563844361786;43951.78024109923;44017;44096.779516102215;44191.33712994308;39365;41006.79496602498;41136.97157571085;41207.58792412098;42021.78989105035;7206.567605943451;7535.773926782205;7684;7696.191899850659;7790.571518566533;31699.20751981219;31922.20194495156;32015.35969280555;32180;32365.838170808995;38224.23551528898;40321;40434.39348409717;40572.18855622812;40578.59421405866;8807.119288071142;8921.732348029569;8976.506292153994;9145.86281205769;9168.266538677024;10198.082172604501;10281.331713438902;10322.432266225429;10372.066514013775;10391.740206494898;9752.756181095529;9826.9017309826;9922.057404546556;10297.691069267934;10307.742306442398;9136.497492637704;9608.423494590346;9702.223822094356;9709.077637624414;9718.076782705632;9453.480058596842;10397;10501.684949451528;10512.632057877938;11278.436078195893;8457.957710211409;8521.275691566287;8908.198262156437;9231.214912193096;9439.952800235955;9009.459432434074;9064.909350906406;9359.625614975597;9405.43567385959;9430.669926552539 11:51:05 INFO - PROCESS | 16627 | __end_tp_report 11:51:05 INFO - PROCESS | 16627 | __start_cc_report 11:51:05 INFO - PROCESS | 16627 | _x_x_mozilla_cycle_collect,1012 11:51:05 INFO - PROCESS | 16627 | __end_cc_report 11:51:05 INFO - PROCESS | 16627 | __startTimestamp1451159465431__endTimestamp 11:51:05 INFO - PROCESS | 16627 | 11:51:05 INFO - PROCESS | 16627 | ------- Summary: start ------- 11:51:05 INFO - PROCESS | 16627 | Number of tests: 6 11:51:05 INFO - PROCESS | 16627 | 11:51:05 INFO - PROCESS | 16627 | [#0] dojo.html Cycles:165 Average:4531.85 Median:4644.19 stddev:461.17 (9.9%) stddev-sans-first:436.69 11:51:05 INFO - PROCESS | 16627 | Values: 2589.7 2669.8 2671.7 2681.0 2689.7 4409.8 4550.0 4614.6 4615.5 4617.7 4507.9 4555.1 4613.7 4626.2 4627.3 4200.0 4226.9 4296.7 4318.7 4355.1 4048.9 4274.0 4299.5 4319.7 4355.4 4142.2 4162.8 4183.8 4252.2 4264.1 4261.0 4263.7 4271.0 4274.3 4319.9 4256.0 4260.4 4260.9 4273.3 4299.9 4367.4 4455.0 4465.9 4487.2 4569.0 4876.2 4876.6 4877.4 4878.8 4922.2 4909.7 4919.3 4920.6 4925.1 4956.6 4489.4 4574.2 4575.7 4589.1 4625.5 5005.2 5118.6 5122.6 5136.0 5141.2 4876.7 4881.7 4884.7 4887.3 4887.3 4657.0 4981.5 4983.1 4983.9 5028.2 4704.2 4738.7 4752.1 4830.3 4962.3 4817.0 4851.6 4854.3 4899.6 4900.5 4112.3 4125.4 4127.0 4147.6 4165.0 3547.9 3637.5 3656.2 3664.0 3692.6 4210.8 4264.6 4269.5 4309.8 4309.9 4932.5 4936.3 4938.6 4963.5 4974.5 4024.2 4143.7 4147.2 4211.2 4217.0 4300.9 4375.7 4377.0 4443.3 4444.7 4643.1 4644.2 4662.5 4665.0 4705.6 4739.7 4866.1 4868.8 4875.4 4907.2 4487.3 4529.2 4643.9 4747.7 4751.5 4817.0 4818.9 4819.0 4840.6 4863.6 4875.6 4883.2 4888.1 4898.6 4931.6 4619.5 4730.6 4731.6 4740.4 4764.3 4731.3 4811.7 4816.1 4818.4 4842.1 4607.7 4660.9 4663.5 4714.1 4715.8 4631.7 4701.3 4721.4 4732.7 4873.2 4659.4 4672.8 4677.6 4721.8 4724.9 11:51:05 INFO - PROCESS | 16627 | 11:51:05 INFO - PROCESS | 16627 | [#1] ext.html Cycles:180 Average:39891.99 Median:18296.13 stddev:63168.38 (345.3%) stddev-sans-first:63276.44 11:51:05 INFO - PROCESS | 16627 | Values: 528.7 530.1 565.7 576.6 579.2 23430.6 23784.6 32355.4 32725.7 32871.8 34554.8 35015.5 35053.6 35064.8 35080.8 6707.4 7502.1 7713.7 7718.7 7722.2 6757.6 9628.6 9792.6 9810.8 9818.3 9361.3 9442.0 9449.7 9450.1 9450.5 6903.7 7043.8 9510.2 9569.4 9699.7 9533.2 9696.2 9696.4 9696.9 9707.6 32280.4 32701.2 32802.5 32816.0 32819.2 2798.7 2837.5 2978.1 3071.8 3234.3 25316.2 27491.0 27670.4 27853.6 28105.9 3331.9 3475.7 3488.2 3502.8 3584.2 218847.0 222862.0 223650.0 223822.0 223869.0 44960.3 45928.5 54485.7 54780.2 54872.2 58929.4 59863.4 60215.4 60259.4 60360.1 12827.4 13017.6 13035.3 13037.3 13061.7 9732.4 9743.5 9773.0 9789.1 9851.0 18518.2 18904.7 18904.8 18916.9 18918.0 7381.9 7640.2 7665.0 7714.1 7727.8 824.7 832.8 842.0 842.5 908.7 26311.7 26365.3 26639.3 26671.7 26833.6 973.5 1031.0 1034.0 1067.9 1109.8 13713.2 13882.9 13983.7 14073.7 14128.0 252666.0 259217.0 259499.0 259829.0 260551.0 44735.8 45228.3 45275.3 45413.8 45418.5 1138.8 1140.2 1154.2 1155.0 1155.8 24869.5 25737.5 26225.2 26259.9 26267.9 33260.3 34139.5 39149.2 39379.6 39403.0 241164.0 245452.0 247350.0 247510.0 247550.0 28766.6 29548.3 29564.9 29579.9 29651.4 37379.8 38123.2 38673.0 38693.0 38704.6 32388.5 32947.7 32973.3 33213.7 33647.7 33127.2 33199.7 33485.7 33546.5 33616.8 35089.0 35371.5 35605.6 36026.6 36209.6 24913.3 25807.6 28270.7 29325.0 29343.1 23257.3 24965.5 25119.5 25269.2 25663.4 11:51:05 INFO - PROCESS | 16627 | 11:51:05 INFO - PROCESS | 16627 | [#2] jquery.html Cycles:180 Average:26880.35 Median:4067.91 stddev:83616.22 (2055.5%) stddev-sans-first:83827.02 11:51:05 INFO - PROCESS | 16627 | Values: 329.9 330.5 330.6 330.9 335.2 11705.5 12072.8 14701.1 15161.4 15767.0 11496.5 13372.1 13374.0 13597.8 14388.9 4269.2 4819.9 4836.5 4950.7 4951.8 3717.8 3774.8 4873.9 4900.0 5617.3 5703.8 5741.5 5766.8 5768.8 5772.8 5544.4 5631.5 5635.5 5637.8 5730.2 4946.6 4948.4 4953.4 4953.8 4954.2 17291.7 18685.3 18916.1 19075.4 19319.9 1887.5 1903.0 1957.4 1987.1 1992.2 8410.3 8634.7 8798.5 8879.0 10576.4 1657.2 1695.7 1697.3 1743.4 1804.5 47046.5 49432.3 49452.3 49625.3 49934.5 9231.4 9310.1 9314.2 9327.9 9588.2 12186.6 12239.7 12280.9 12282.0 12288.8 6744.1 6768.3 6768.9 6778.1 6834.9 6309.9 6326.8 6341.2 6344.7 6362.9 3950.0 4027.9 4066.9 4068.9 4069.1 1570.2 1630.7 1635.4 1677.8 1709.7 793.0 800.0 814.9 820.6 832.9 14752.3 15351.2 15705.9 15713.2 16922.8 766.6 794.9 827.3 858.4 870.2 7850.8 8430.0 8454.4 8466.1 9004.1 501478.0 503939.0 516251.0 516849.8 520603.0 74342.6 74944.0 75644.2 76176.6 76262.2 1023.9 1034.6 1035.5 1035.6 1051.3 13290.4 13551.7 13601.9 13718.8 13812.4 30357.7 30549.2 30702.8 31144.0 31694.7 47056.8 47527.0 47764.8 48104.3 49784.8 8434.1 8742.7 8751.1 8787.2 8844.3 11289.3 16180.6 16282.9 16507.5 16654.3 12857.5 13001.7 13114.0 13418.7 13757.0 13376.7 13411.3 13418.8 13442.9 13597.2 13562.3 13584.7 13938.2 14114.6 14292.4 8733.3 8733.4 8741.0 8809.3 9006.4 13048.8 13401.9 13540.1 13707.5 14082.9 11:51:05 INFO - PROCESS | 16627 | 11:51:05 INFO - PROCESS | 16627 | [#3] mootools.html Cycles:180 Average:4861.87 Median:5963.08 stddev:2540.56 (42.6%) stddev-sans-first:2532.20 11:51:05 INFO - PROCESS | 16627 | Values: 1130.4 1389.1 1391.1 1495.6 1710.9 5802.1 6788.6 6908.3 6909.9 6917.0 6772.7 6963.9 6964.8 6967.2 6967.7 1996.7 2029.0 2029.9 2031.1 2034.5 1987.1 2008.4 2016.4 2038.1 2048.5 1988.6 1997.3 2020.3 2021.4 2023.9 1996.2 2027.6 2029.6 2033.8 2034.9 2010.7 2038.8 2085.4 2088.0 2088.9 6994.5 7068.1 7074.6 7075.9 7085.8 4146.0 4205.6 4225.5 4227.4 4229.1 2661.9 2669.6 2678.6 2713.1 2763.1 840.5 847.6 855.7 861.6 872.4 9278.8 9316.2 9321.5 9329.9 9353.9 3776.3 3812.1 3813.2 3899.6 3906.5 8164.2 8167.8 8174.1 8174.7 8179.0 4171.1 4181.4 4205.0 4211.4 4217.3 3144.4 3238.6 3567.9 3799.1 3800.7 3295.2 3343.3 3349.9 3417.6 3439.3 1077.0 1080.3 1082.5 1087.6 1099.4 1197.7 1199.5 1201.8 1215.4 1221.1 6604.2 6690.1 6698.6 6713.7 6741.6 417.3 418.5 418.7 419.1 419.6 5283.7 5323.7 5328.9 5328.9 5332.8 8241.4 8352.0 8438.3 8539.4 8552.9 8325.1 8346.6 8448.6 8451.5 8460.2 6593.1 6667.9 6684.2 6742.6 6748.5 6411.1 6424.6 6426.7 6429.2 6434.0 7459.9 7538.3 7586.5 7608.5 7630.5 7649.6 7697.0 7740.8 7791.9 7863.7 5229.2 5347.7 5967.7 5968.3 6012.0 6468.8 6537.8 6594.9 6599.9 6610.1 6025.9 6071.4 6090.6 6155.1 6158.5 6103.3 6198.2 6242.1 6274.6 6295.2 6245.1 6274.0 6283.2 6290.7 6295.6 5805.0 5833.7 5835.2 5838.7 5851.7 5902.1 5938.7 5958.4 6006.5 6009.9 11:51:05 INFO - PROCESS | 16627 | 11:51:05 INFO - PROCESS | 16627 | [#4] prototype.html Cycles:180 Average:4642.50 Median:5308.56 stddev:1362.14 (25.7%) stddev-sans-first:1326.33 11:51:05 INFO - PROCESS | 16627 | Values: 296.4 299.4 306.5 307.9 312.6 5318.8 5365.9 5418.6 5421.5 5426.9 5303.0 5303.3 5306.7 5310.4 5314.7 3931.1 4140.0 4140.8 4142.0 4145.5 4011.6 4049.1 4114.5 4120.8 4136.0 4074.5 4075.2 4076.2 4080.5 4082.0 3883.3 3967.0 3994.9 4078.3 4083.8 3585.5 3594.2 3595.1 3596.2 3599.7 5084.5 5089.1 5105.9 5109.5 5115.1 4719.8 4724.6 4725.8 4728.7 4730.5 5451.6 5568.7 5570.5 5581.6 5602.7 3960.0 3962.8 3963.7 3964.6 3968.1 5872.2 5881.5 5884.9 5893.9 5895.1 4076.3 4076.6 4079.4 4079.9 4080.1 3777.7 3865.2 4135.7 4136.2 4142.1 4542.9 4618.1 4630.6 4649.9 4666.1 5587.1 5593.7 5595.7 5598.1 5599.0 1433.4 1461.3 1462.7 1462.9 1463.8 986.4 992.3 1005.8 1012.2 1023.8 4878.1 4879.4 4884.1 4890.5 4897.4 5803.0 5803.9 5806.0 5806.9 5809.8 4867.4 4881.3 4892.1 4896.6 4905.6 3050.2 3086.5 3104.5 3113.1 3119.6 5491.7 5491.8 5493.1 5494.3 5500.3 5955.8 5962.9 5965.4 5966.2 5975.5 5463.2 5492.1 5497.0 5497.4 5500.8 5600.8 5786.5 5793.3 5794.5 5798.3 5676.1 5676.4 5681.1 5686.8 5687.3 5489.5 5496.9 5498.6 5499.3 5510.0 4007.5 4090.2 4096.4 4099.9 4110.5 5581.8 5774.8 5804.3 5806.9 5810.2 5521.4 5548.2 5553.7 5555.9 5558.2 5632.3 5636.9 5648.3 5655.1 5658.3 5369.9 5494.8 5496.8 5505.1 5506.6 5672.8 5676.2 5676.7 5681.7 5682.7 5492.3 5518.5 5519.3 5519.7 5586.8 11:51:05 INFO - PROCESS | 16627 | 11:51:05 INFO - PROCESS | 16627 | [#5] yui.html Cycles:180 Average:12226.35 Median:51878.50 stddev:14078.82 (27.1%) stddev-sans-first:14091.81 11:51:05 INFO - PROCESS | 16627 | Values: 723.1 751.2 776.9 781.9 783.7 11200.4 13034.3 13147.4 13176.0 13184.0 13309.3 13460.1 13471.1 13473.8 13476.4 580.7 588.0 774.8 786.5 787.1 772.8 780.1 786.2 787.3 787.6 819.3 820.1 822.0 826.8 827.1 580.6 593.7 803.0 819.5 819.6 605.8 608.1 608.8 608.9 609.7 10689.5 10791.5 10828.2 10857.8 10869.1 10243.6 10797.6 10830.4 10902.8 11348.8 9015.9 9095.7 9128.3 9271.0 9415.9 3107.2 3150.2 3153.7 3207.7 3236.2 40487.0 41373.2 41450.8 41497.4 42397.6 9097.7 9134.3 9153.4 9179.3 9231.7 15867.6 15940.0 15956.6 15963.8 15976.7 6078.8 6208.4 6265.9 6348.7 6363.2 3452.8 3481.0 3564.7 3640.1 3660.2 2596.8 2634.2 2634.4 2636.1 2636.8 474.7 477.2 485.4 486.3 490.7 588.7 598.2 614.2 619.5 628.7 7285.4 7465.6 7731.6 7749.6 7853.6 406.4 512.4 613.7 616.4 619.9 3589.0 3626.5 3638.0 3682.2 3693.2 51082.7 51103.7 51738.0 52019.0 52073.2 43615.6 43951.8 44017.0 44096.8 44191.3 39365.0 41006.8 41137.0 41207.6 42021.8 7206.6 7535.8 7684.0 7696.2 7790.6 31699.2 31922.2 32015.4 32180.0 32365.8 38224.2 40321.0 40434.4 40572.2 40578.6 8807.1 8921.7 8976.5 9145.9 9168.3 10198.1 10281.3 10322.4 10372.1 10391.7 9752.8 9826.9 9922.1 10297.7 10307.7 9136.5 9608.4 9702.2 9709.1 9718.1 9453.5 10397.0 10501.7 10512.6 11278.4 8458.0 8521.3 8908.2 9231.2 9440.0 9009.5 9064.9 9359.6 9405.4 9430.7 11:51:05 INFO - PROCESS | 16627 | -------- Summary: end -------- 11:51:05 INFO - PROCESS | 16627 | 11:51:06 INFO - TEST-INFO | 16627: exit 0 11:51:06 INFO - TEST-OK | dromaeo_css | took 1117845ms 11:51:06 INFO - TEST-START | kraken 11:51:06 INFO - operating with platform_type : linux_ 11:51:06 INFO - Initialising browser for kraken test... 11:51:06 INFO - TEST-INFO | started process 16820 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXG8bsq/profile http://localhost:41367/getInfo.html) 11:51:10 INFO - PROCESS | 16820 | __metrics Screen width/height:1600/1200 11:51:10 INFO - PROCESS | 16820 | colorDepth:24 11:51:10 INFO - PROCESS | 16820 | Browser inner width/height: 1024/697 11:51:10 INFO - PROCESS | 16820 | __metrics 11:51:11 INFO - PROCESS | 16820 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:51:11 INFO - PROCESS | 16820 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:51:12 INFO - TEST-INFO | 16820: exit 0 11:51:12 INFO - Browser initialized. 11:51:12 INFO - Running cycle 1/1 for kraken test... 11:51:12 INFO - TEST-INFO | started process 16900 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXG8bsq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:51:24 INFO - PROCESS | 16900 | RSS: Main: 150720512 11:51:24 INFO - PROCESS | 16900 | 11:51:27 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41367/tests/kraken/driver.html?testName=audio-beat-detection) 11:51:27 INFO - PROCESS | 16900 | RSS: Main: 184885248 11:51:27 INFO - PROCESS | 16900 | 11:51:30 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41367/tests/kraken/driver.html?testName=audio-dft) 11:51:30 INFO - PROCESS | 16900 | RSS: Main: 176558080 11:51:30 INFO - PROCESS | 16900 | 11:51:33 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41367/tests/kraken/driver.html?testName=audio-fft) 11:51:34 INFO - PROCESS | 16900 | RSS: Main: 160256000 11:51:34 INFO - PROCESS | 16900 | 11:51:36 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41367/tests/kraken/driver.html?testName=audio-oscillator) 11:51:37 INFO - PROCESS | 16900 | RSS: Main: 163209216 11:51:37 INFO - PROCESS | 16900 | 11:51:39 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41367/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:51:39 INFO - PROCESS | 16900 | RSS: Main: 164274176 11:51:39 INFO - PROCESS | 16900 | 11:51:42 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41367/tests/kraken/driver.html?testName=imaging-darkroom) 11:51:43 INFO - PROCESS | 16900 | RSS: Main: 163905536 11:51:43 INFO - PROCESS | 16900 | 11:51:46 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41367/tests/kraken/driver.html?testName=imaging-desaturate) 11:51:47 INFO - PROCESS | 16900 | RSS: Main: 165695488 11:51:47 INFO - PROCESS | 16900 | 11:51:50 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41367/tests/kraken/driver.html?testName=json-parse-financial) 11:51:51 INFO - PROCESS | 16900 | RSS: Main: 165650432 11:51:51 INFO - PROCESS | 16900 | 11:51:52 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41367/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:51:53 INFO - PROCESS | 16900 | RSS: Main: 177639424 11:51:53 INFO - PROCESS | 16900 | 11:51:55 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41367/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:51:55 INFO - PROCESS | 16900 | RSS: Main: 176377856 11:51:55 INFO - PROCESS | 16900 | 11:51:57 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41367/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:51:58 INFO - PROCESS | 16900 | RSS: Main: 186687488 11:51:58 INFO - PROCESS | 16900 | 11:52:00 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:52:01 INFO - PROCESS | 16900 | RSS: Main: 192397312 11:52:01 INFO - PROCESS | 16900 | 11:52:04 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:52:04 INFO - PROCESS | 16900 | RSS: Main: 190144512 11:52:04 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | Cycle 1(1): loaded http://localhost:41367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41367/tests/kraken/driver.html?testName=ai-astar) 11:52:06 INFO - PROCESS | 16900 | RSS: Main: 248479744 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | __start_tp_report 11:52:06 INFO - PROCESS | 16900 | _x_x_mozilla_page_load 11:52:06 INFO - PROCESS | 16900 | _x_x_mozilla_page_load_details 11:52:06 INFO - PROCESS | 16900 | |i|pagename|runs| 11:52:06 INFO - PROCESS | 16900 | |0;ai-astar;109;114;106;111;114;115;102;111;112;103 11:52:06 INFO - PROCESS | 16900 | |1;audio-beat-detection;161;140;158;169;138;161;149;140;168;133 11:52:06 INFO - PROCESS | 16900 | |2;audio-dft;162;161;160;162;163;161;165;164;163;163 11:52:06 INFO - PROCESS | 16900 | |3;audio-fft;72;75;83;91;73;72;74;102;90;72 11:52:06 INFO - PROCESS | 16900 | |4;audio-oscillator;98;97;134;98;97;97;129;104;97;130 11:52:06 INFO - PROCESS | 16900 | |5;imaging-gaussian-blur;109;109;109;109;109;109;110;110;109;109 11:52:06 INFO - PROCESS | 16900 | |6;imaging-darkroom;147;147;148;147;148;148;147;148;147;147 11:52:06 INFO - PROCESS | 16900 | |7;imaging-desaturate;95;95;95;96;96;97;96;96;96;96 11:52:06 INFO - PROCESS | 16900 | |8;json-parse-financial;70;82;69;70;70;69;69;78;67;68 11:52:06 INFO - PROCESS | 16900 | |9;json-stringify-tinderbox;68;69;68;68;68;69;68;68;69;68 11:52:06 INFO - PROCESS | 16900 | |10;stanford-crypto-aes;83;83;85;85;90;84;84;84;84;84 11:52:06 INFO - PROCESS | 16900 | |11;stanford-crypto-ccm;120;118;132;121;123;121;120;123;119;121 11:52:06 INFO - PROCESS | 16900 | |12;stanford-crypto-pbkdf2;139;148;149;155;147;136;148;145;146;136 11:52:06 INFO - PROCESS | 16900 | |13;stanford-crypto-sha256-iterative;69;70;70;69;69;70;69;71;71;69 11:52:06 INFO - PROCESS | 16900 | __end_tp_report 11:52:06 INFO - PROCESS | 16900 | __start_cc_report 11:52:06 INFO - PROCESS | 16900 | _x_x_mozilla_cycle_collect,980 11:52:06 INFO - PROCESS | 16900 | __end_cc_report 11:52:06 INFO - PROCESS | 16900 | __startTimestamp1451159526744__endTimestamp 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | ------- Summary: start ------- 11:52:06 INFO - PROCESS | 16900 | Number of tests: 14 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#0] ai-astar Cycles:10 Average:109.70 Median:111.50 stddev:4.62 (4.1%) stddev-sans-first:4.89 11:52:06 INFO - PROCESS | 16900 | Values: 109.0 114.0 106.0 111.0 114.0 115.0 102.0 111.0 112.0 103.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:159.50 stddev:13.32 (8.3%) stddev-sans-first:13.69 11:52:06 INFO - PROCESS | 16900 | Values: 161.0 140.0 158.0 169.0 138.0 161.0 149.0 140.0 168.0 133.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.51 (0.9%) stddev-sans-first:1.59 11:52:06 INFO - PROCESS | 16900 | Values: 162.0 161.0 160.0 162.0 163.0 161.0 165.0 164.0 163.0 163.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#3] audio-fft Cycles:10 Average:80.40 Median:74.50 stddev:10.62 (14.3%) stddev-sans-first:10.82 11:52:06 INFO - PROCESS | 16900 | Values: 72.0 75.0 83.0 91.0 73.0 72.0 74.0 102.0 90.0 72.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:97.00 stddev:15.99 (16.5%) stddev-sans-first:16.54 11:52:06 INFO - PROCESS | 16900 | Values: 98.0 97.0 134.0 98.0 97.0 97.0 129.0 104.0 97.0 130.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:52:06 INFO - PROCESS | 16900 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 11:52:06 INFO - PROCESS | 16900 | Values: 147.0 147.0 148.0 147.0 148.0 148.0 147.0 148.0 147.0 147.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 11:52:06 INFO - PROCESS | 16900 | Values: 95.0 95.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#8] json-parse-financial Cycles:10 Average:71.20 Median:70.00 stddev:4.83 (6.9%) stddev-sans-first:5.10 11:52:06 INFO - PROCESS | 16900 | Values: 70.0 82.0 69.0 70.0 70.0 69.0 69.0 78.0 67.0 68.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 11:52:06 INFO - PROCESS | 16900 | Values: 68.0 69.0 68.0 68.0 68.0 69.0 68.0 68.0 69.0 68.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.00 stddev:2.01 (2.4%) stddev-sans-first:2.05 11:52:06 INFO - PROCESS | 16900 | Values: 83.0 83.0 85.0 85.0 90.0 84.0 84.0 84.0 84.0 84.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#11] stanford-crypto-ccm Cycles:10 Average:121.80 Median:121.00 stddev:3.91 (3.2%) stddev-sans-first:4.09 11:52:06 INFO - PROCESS | 16900 | Values: 120.0 118.0 132.0 121.0 123.0 121.0 120.0 123.0 119.0 121.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:147.50 stddev:6.12 (4.1%) stddev-sans-first:6.11 11:52:06 INFO - PROCESS | 16900 | Values: 139.0 148.0 149.0 155.0 147.0 136.0 148.0 145.0 146.0 136.0 11:52:06 INFO - PROCESS | 16900 | 11:52:06 INFO - PROCESS | 16900 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 11:52:06 INFO - PROCESS | 16900 | Values: 69.0 70.0 70.0 69.0 69.0 70.0 69.0 71.0 71.0 69.0 11:52:06 INFO - PROCESS | 16900 | -------- Summary: end -------- 11:52:06 INFO - PROCESS | 16900 | 11:52:07 INFO - TEST-INFO | 16900: exit 0 11:52:07 INFO - TEST-OK | kraken | took 61387ms 11:52:07 INFO - TEST-START | v8_7 11:52:07 INFO - operating with platform_type : linux_ 11:52:07 INFO - Initialising browser for v8_7 test... 11:52:07 INFO - TEST-INFO | started process 17146 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMT3ViA/profile http://localhost:41367/getInfo.html) 11:52:12 INFO - PROCESS | 17146 | __metrics Screen width/height:1600/1200 11:52:12 INFO - PROCESS | 17146 | colorDepth:24 11:52:12 INFO - PROCESS | 17146 | Browser inner width/height: 1024/697 11:52:12 INFO - PROCESS | 17146 | __metrics 11:52:12 INFO - PROCESS | 17146 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 11:52:12 INFO - PROCESS | 17146 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:52:13 INFO - TEST-INFO | 17146: exit 0 11:52:13 INFO - Browser initialized. 11:52:13 INFO - Running cycle 1/1 for v8_7 test... 11:52:13 INFO - TEST-INFO | started process 17228 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMT3ViA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:52:25 INFO - PROCESS | 17228 | RSS: Main: 149000192 11:52:25 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | Cycle 1(1): loaded http://localhost:41367/tests/v8_7/run.html (next: http://localhost:41367/tests/v8_7/run.html) 11:52:47 INFO - PROCESS | 17228 | RSS: Main: 448684032 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | __start_tp_report 11:52:47 INFO - PROCESS | 17228 | _x_x_mozilla_page_load 11:52:47 INFO - PROCESS | 17228 | _x_x_mozilla_page_load_details 11:52:47 INFO - PROCESS | 17228 | |i|pagename|runs| 11:52:47 INFO - PROCESS | 17228 | |0;Richards;166.47244880972198 11:52:47 INFO - PROCESS | 17228 | |1;DeltaBlue;188.32391713747646 11:52:47 INFO - PROCESS | 17228 | |2;Encrypt;278.473962684489 11:52:47 INFO - PROCESS | 17228 | |3;Decrypt;5170.103092783505 11:52:47 INFO - PROCESS | 17228 | |4;RayTrace;1978.2608695652175 11:52:47 INFO - PROCESS | 17228 | |5;Earley;802.5682182985554 11:52:47 INFO - PROCESS | 17228 | |6;Boyer;11674.418604651162 11:52:47 INFO - PROCESS | 17228 | |7;RegExp;26552.63157894737 11:52:47 INFO - PROCESS | 17228 | |8;Splay;619.3111931119312 11:52:47 INFO - PROCESS | 17228 | |9;NavierStokes;4859.223300970873 11:52:47 INFO - PROCESS | 17228 | __end_tp_report 11:52:47 INFO - PROCESS | 17228 | __startTimestamp1451159567530__endTimestamp 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | ------- Summary: start ------- 11:52:47 INFO - PROCESS | 17228 | Number of tests: 10 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | [#0] Richards Cycles:1 Average:166.47 Median:166.47 stddev:0.00 (0.0%) 11:52:47 INFO - PROCESS | 17228 | Values: 166.5 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | [#1] DeltaBlue Cycles:1 Average:188.32 Median:188.32 stddev:0.00 (0.0%) 11:52:47 INFO - PROCESS | 17228 | Values: 188.3 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | [#2] Encrypt Cycles:1 Average:278.47 Median:278.47 stddev:0.00 (0.0%) 11:52:47 INFO - PROCESS | 17228 | Values: 278.5 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | [#3] Decrypt Cycles:1 Average:5170.10 Median:5170.10 stddev:0.00 (0.0%) 11:52:47 INFO - PROCESS | 17228 | Values: 5170.1 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | [#4] RayTrace Cycles:1 Average:1978.26 Median:1978.26 stddev:0.00 (0.0%) 11:52:47 INFO - PROCESS | 17228 | Values: 1978.3 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | [#5] Earley Cycles:1 Average:802.57 Median:802.57 stddev:0.00 (0.0%) 11:52:47 INFO - PROCESS | 17228 | Values: 802.6 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | [#6] Boyer Cycles:1 Average:11674.42 Median:11674.42 stddev:0.00 (0.0%) 11:52:47 INFO - PROCESS | 17228 | Values: 11674.4 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 11:52:47 INFO - PROCESS | 17228 | Values: 26552.6 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | [#8] Splay Cycles:1 Average:619.31 Median:619.31 stddev:0.00 (0.0%) 11:52:47 INFO - PROCESS | 17228 | Values: 619.3 11:52:47 INFO - PROCESS | 17228 | 11:52:47 INFO - PROCESS | 17228 | [#9] NavierStokes Cycles:1 Average:4859.22 Median:4859.22 stddev:0.00 (0.0%) 11:52:47 INFO - PROCESS | 17228 | Values: 4859.2 11:52:47 INFO - PROCESS | 17228 | -------- Summary: end -------- 11:52:47 INFO - PROCESS | 17228 | 11:52:48 INFO - TEST-INFO | 17228: exit 0 11:52:48 INFO - TEST-OK | v8_7 | took 40743ms 11:52:48 INFO - SUITE-END | took 1219s 11:52:48 INFO - Completed test suite (00:20:20) 11:52:48 INFO - Working with test: dromaeo_css 11:52:48 INFO - Generating results file: dromaeo_css 11:52:48 INFO - Working with test: kraken 11:52:48 INFO - Generating results file: kraken 11:52:48 INFO - javascript benchmark 11:52:48 INFO - Working with test: v8_7 11:52:48 INFO - Generating results file: v8_7 11:52:48 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:52:48 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:52:48 INFO - process_Request line: dromaeo_css 6200.37 graph.html#tests=[[72,132,35]] 11:52:48 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:52:48 INFO - process_Request line: kraken 1525.20 graph.html#tests=[[232,132,35]] 11:52:48 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:52:48 INFO - process_Request line: v8_7 19809.88 graph.html#tests=[[230,132,35]] 11:52:48 INFO - RETURN: dromaeo_css: 6200.37 11:52:48 INFO - RETURN: kraken: 1525.20 11:52:48 INFO - RETURN: v8_7: 19809.88 11:52:48 INFO - javascript benchmark 11:52:48 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2589.6892372915254, 2669.8398096114247, 2671.7194694557083, 2681.021427179079, 2689.6772387313526, 4409.757463339515, 4549.954500454995, 4614.607758340541, 4615.492295847454, 4617.699849509784, 4507.93238101428, 4555.088982203564, 4613.7231766094055, 4626.190820401109, 4627.329037289591, 4200.012996945716, 4226.852060177895, 4296.7207131536425, 4318.719283246594, 4355.128974205156, 4048.9392659110135, 4274.038341373197, 4299.527052024275, 4319.71921825082, 4355.390245365636, 4142.150859073913, 4162.791860406967, 4183.769892655902, 4252.2345977724, 4264.147170565868, 4260.978695106535, 4263.658907287409, 4270.978645106755, 4274.316109422478, 4319.935200971988, 4255.957440425618, 4260.424842646234, 4260.850870219559, 4273.273543497613, 4299.91400171998, 4367.410399596078, 4454.955450445486, 4465.933011004805, 4487.169873573399, 4568.977155114203, 4876.195427754416, 4876.561109500127, 4877.3903262092235, 4878.804847806084, 4922.237053256751, 4909.729964851932, 4919.26211068339, 4920.5571498565305, 4925.064237794843, 4956.628252881048, 4489.393931819195, 4574.199515084847, 4575.679702420799, 4589.059242855206, 4625.514320996281, 5005.224190250517, 5118.61610379223, 5122.564582010571, 5136.0, 5141.151709967813, 4876.683015603974, 4881.707097574157, 4884.7313397762755, 4887.315775791392, 4887.34020907173, 4656.976715116402, 4981.4769449207315, 4983.127952608279, 4983.875403114878, 5028.195488721787, 4704.200285951397, 4738.668293219442, 4752.14461396945, 4830.3479030331155, 4962.280469331927, 4817.0, 4851.56335929768, 4854.344663470457, 4899.559039686445, 4900.485449027872, 4112.280350938574, 4125.401816736557, 4127.030147915238, 4147.564505726916, 4165.042040330741, 3547.94678079829, 3637.454381842692, 3656.213914008501, 3663.9633603663624, 3692.5753538343433, 4210.810513526899, 4264.616184543406, 4269.530351661315, 4309.806058727302, 4309.870703878889, 4932.53140951609, 4936.259561065797, 4938.58022068121, 4963.503649635008, 4974.452810190876, 4024.2353952748886, 4143.709940304149, 4147.212029714345, 4211.220924129046, 4216.9578304217175, 4300.8709738707885, 4375.693701440869, 4376.956230437655, 4443.266860967904, 4444.73331600105, 4643.141018911512, 4644.187267228289, 4662.510436404196, 4665.04366604852, 4705.576498115118, 4739.691920025188, 4866.05112003156, 4868.780904859361, 4875.366202393808, 4907.214845624683, 4487.349334346567, 4529.2300308948215, 4643.86068417948, 4747.738874361943, 4751.524847515221, 4817.0, 4818.903621927612, 4818.95181048185, 4840.636952228668, 4863.635227357891, 4875.561199492063, 4883.169861123546, 4888.071266459361, 4898.608111351155, 4931.556159945622, 4619.491855895916, 4730.550597693214, 4731.550502702238, 4740.3837501124635, 4764.332993380999, 4731.313959475788, 4811.711297322172, 4816.084943860656, 4818.445878723852, 4842.128416884994, 4607.723536587815, 4660.883477913079, 4663.533646635445, 4714.057188562233, 4715.764211789466, 4631.745254010927, 4701.271302948048, 4721.433427988663, 4732.668713190182, 4873.244647079709, 4659.394278743742, 4672.76636168197, 4677.579017888406, 4721.763911804464, 4724.929126063043], "unit": "score", "name": "dojo.html", "value": 4504.020436421614}, {"lowerIsBetter": false, "replicates": [528.6722232216024, 530.1411713024895, 565.6973519167246, 576.5935015813851, 579.2151634535205, 23430.648540271908, 23784.643230351536, 32355.352892942155, 32725.67274327262, 32871.835640821824, 34554.8272258639, 35015.4747678785, 35053.64946350536, 35064.82467587658, 35080.82459587705, 6707.3628005339415, 7502.062242219737, 7713.691452341927, 7718.6912523498995, 7722.150563438017, 6757.594544327356, 9628.614855405775, 9792.608295668164, 9810.803783924317, 9818.26363022776, 9361.297902657328, 9441.952790236039, 9449.669261575846, 9450.102240287162, 9450.4802235877, 6903.6548172591165, 7043.7534686285735, 9510.239180865583, 9569.377990430634, 9699.709008729784, 9533.237341012702, 9696.17582505488, 9696.369735967139, 9696.903030969741, 9707.61169553217, 32280.35439291201, 32701.18247043843, 32802.50796238059, 32816.0, 32819.17952051194, 2798.692143864194, 2837.517622004264, 2978.091682036978, 3071.846407679607, 3234.2884565395575, 25316.240512784647, 27491.0, 27670.446591068267, 27853.58219626707, 28105.85947070272, 3331.916702082443, 3475.6871881530533, 3488.1977145256733, 3502.807345595991, 3584.211473475831, 218847.0, 222862.0, 223650.0, 223822.0, 223869.0, 44960.3255951161, 45928.540714592426, 54485.72757136268, 54780.17829732557, 54872.176917346274, 58929.41070589325, 59863.401365986654, 60215.39784602186, 60259.397406026255, 60360.094598581054, 12827.422765975554, 13017.609471715863, 13035.348232588332, 13037.348132593332, 13061.673458163621, 9732.367396119229, 9743.464109474047, 9772.951135244279, 9789.118979291898, 9850.950745246228, 18518.16668249932, 18904.71642925357, 18904.810951890304, 18916.90541547311, 18918.0, 7381.926180738231, 7640.235976402315, 7664.961675191588, 7714.112877019103, 7727.845443091219, 824.7402068348451, 832.8042909916165, 841.9579021048924, 842.4818736477145, 908.6737950845855, 26311.73688263093, 26365.34086647811, 26639.33401664935, 26671.733282667312, 26833.597496037575, 973.5035132082547, 1030.9690709278734, 1034.0, 1067.8665166854144, 1109.750306181119, 13713.17720936747, 13882.930585347009, 13983.720325593431, 14073.71852562943, 14128.0, 252666.0, 259217.0, 259499.0, 259829.0, 260551.0, 44735.77632111819, 45228.3215751764, 45275.32087018697, 45413.77293113579, 45418.54581454143, 1138.7551676389617, 1140.244024202735, 1154.2266681323533, 1154.9595764148214, 1155.757290968889, 24869.50260994806, 25737.485250294514, 26225.213243602724, 26259.929710894077, 26267.868660656575, 33260.33479330448, 34139.48790768091, 39149.2170156601, 39379.6062039376, 39403.0, 241164.0, 245452.0, 247350.0, 247510.0, 247550.0, 28766.568501472913, 29548.261293467836, 29564.852175739845, 29579.852100739357, 29651.406971860873, 37379.81310093432, 38123.2375352497, 38673.0, 38693.0, 38704.61295387123, 32388.514172287905, 32947.67052329446, 32973.34053318968, 33213.667863321054, 33647.663523364456, 33127.17182070467, 33199.66800331966, 33485.665143348255, 33546.49680254847, 33616.83191584027, 35089.0, 35371.46942795911, 35605.64394356023, 36026.63973360233, 36209.63790362063, 24913.252602421955, 25807.612885807102, 28270.71729282681, 29325.0, 29343.11970640884, 23257.3022809316, 24965.500689985736, 25119.497610048064, 25269.24192274235, 25663.358416039748], "unit": "score", "name": "ext.html", "value": 16723.780876889618}, {"lowerIsBetter": false, "replicates": [329.88783813503403, 330.48114460297313, 330.6016250418246, 330.9106541233867, 335.2189398701027, 11705.473253703583, 12072.758544829097, 14701.117932924031, 15161.39354425823, 15766.999999999985, 11496.482658280376, 13372.063955523117, 13374.0, 13597.796033059512, 14388.856111438883, 4269.231538323101, 4819.855404337866, 4836.515940861922, 4950.712814668194, 4951.752412379385, 3717.7955212463303, 3774.8112594370173, 4873.8781530461665, 4900.0, 5617.325920889499, 5703.828885133453, 5741.483266506014, 5766.769329226826, 5768.826935191951, 5772.769089236446, 5544.362398324184, 5631.493165615073, 5635.49280564747, 5637.80267690633, 5730.169125476803, 4946.629002824802, 4948.4309304429735, 4953.356063711731, 4953.801847926079, 4954.157793175169, 17291.654166916716, 18685.252589896525, 18916.148773305234, 19075.427737167767, 19319.90340048291, 1887.4960842909304, 1903.0294549779574, 1957.4127761671584, 1987.125664707524, 1992.2031187525106, 8410.32717382608, 8634.654613815439, 8798.51608161551, 8879.0, 10576.418296993663, 1657.2459530913407, 1695.7286834106483, 1697.3041053168265, 1743.3985275080076, 1804.5127815489743, 47046.529534704554, 49432.25851612229, 49452.258216126786, 49625.25562116535, 49934.500654993346, 9231.399959002643, 9310.115539023782, 9314.208292295096, 9327.860082098774, 9588.185004274716, 12186.573469928688, 12239.69400764988, 12280.938595306967, 12282.0, 12288.754224915452, 6744.123263975652, 6768.323167683291, 6768.898466523006, 6778.084958530535, 6834.863302733917, 6309.873802523924, 6326.810195694136, 6341.175647165931, 6344.6827658616885, 6362.872742545123, 3949.980250098731, 4027.899302517402, 4066.877993660195, 4068.9389659155136, 4069.1251380953236, 1570.2305870123785, 1630.6657135287237, 1635.4357746577411, 1677.7818883545306, 1709.734991076385, 792.9722459713882, 800.0399520575332, 814.8506024216479, 820.5897051474263, 832.8667413213857, 14752.336144873507, 15351.15568643713, 15705.921470392575, 15713.21433928299, 16922.830771692126, 766.5860435364953, 794.9085855126618, 827.2802661684253, 858.3690987124584, 870.2472361407337, 7850.8429831403055, 8429.957850210709, 8454.408191426664, 8466.111058338909, 9004.099590041074, 501478.0, 503939.0, 516251.0, 516849.82051256805, 520603.0, 74342.62828685822, 74944.0, 75644.24355756483, 76176.61911690405, 76262.23737762662, 1023.9334443261164, 1034.622362837574, 1035.4874337203132, 1035.6012935020071, 1051.2746205118597, 13290.401931912893, 13551.661208469473, 13601.931990339985, 13718.794218086936, 13812.447502100205, 30357.696423035486, 30549.23626909345, 30702.84648576743, 31144.0, 31694.683053169174, 47056.7647161762, 47527.049459011316, 47764.7611761939, 48104.27843582419, 49784.751076244385, 8434.114417986024, 8742.737717868475, 8751.124887511198, 8787.209151176425, 8844.336674749291, 11289.322640641587, 16180.595485112495, 16282.918585407471, 16507.504774856774, 16654.333826647282, 12857.485700571873, 13001.674958126123, 13113.950883929072, 13418.664533386744, 13757.0, 13376.665583360495, 13411.262380568773, 13418.798718019432, 13442.93278533601, 13597.184168949894, 13562.321883905963, 13584.728305434033, 13938.163710177421, 14114.576562703136, 14292.42830286777, 8733.257673097858, 8733.388662793543, 8740.956295218482, 8809.251213646656, 9006.414583052081, 13048.804267936179, 13401.865981340452, 13540.119892206974, 13707.45170193221, 14082.859171408565], "unit": "score", "name": "jquery.html", "value": 8118.777978158807}, {"lowerIsBetter": false, "replicates": [1130.4121856634545, 1389.0901459544, 1391.1235921369537, 1495.6260934766308, 1710.8545773609242, 5802.129680547915, 6788.558743681663, 6908.274631163718, 6909.896351554725, 6917.0, 6772.72909083636, 6963.895541566881, 6964.791056268307, 6967.198772141205, 6967.72129114836, 1996.6605677034902, 2028.959420811583, 2029.9086541105685, 2031.065709773506, 2034.4608678700156, 1987.0660789429016, 2008.417558907915, 2016.4353980885303, 2038.1337931379178, 2048.4878780304925, 1988.6221617892554, 1997.330894150454, 2020.2626041494896, 2021.423894190156, 2023.9392818215476, 1996.1516355548906, 2027.5843452092286, 2029.6245194639039, 2033.8474614403979, 2034.9491262718402, 2010.668239740441, 2038.775734669185, 2085.384811480602, 2087.9791202087936, 2088.9477763056043, 6994.545354551989, 7068.08114945059, 7074.610896400696, 7075.8584828303665, 7085.822854428629, 4145.958540414587, 4205.5794420558, 4225.514065882401, 4227.365895115727, 4229.069604686964, 2661.8535980521065, 2669.6129061286197, 2678.638383818179, 2713.0775536317747, 2763.115802943059, 840.5125027484106, 847.6482259862149, 855.6748435594496, 861.6165806216236, 872.4067634008871, 9278.814423711556, 9316.161545460942, 9321.487318197496, 9329.860052099224, 9353.906460935372, 3776.2825063237897, 3812.0850995760816, 3813.218290250492, 3899.6100389961343, 3906.453096566483, 8164.224398682116, 8167.754967350989, 8174.141715119827, 8174.6730130795295, 8179.0, 4171.0823618803815, 4181.414601955728, 4204.957950420457, 4211.43145675336, 4217.283061879488, 3144.434001879638, 3238.611366636019, 3567.857285708543, 3799.0882188274613, 3800.657940785343, 3295.20914980403, 3343.3313337332143, 3349.933001340008, 3417.5898892133105, 3439.3465241604017, 1076.9730756730987, 1080.346390433792, 1082.4695899009428, 1087.5595383869545, 1099.4063205868902, 1197.6886009637558, 1199.4902166579168, 1201.813718873576, 1215.3619349841404, 1221.1146918484028, 6604.240512341143, 6690.130283063268, 6698.631575263407, 6713.664316784141, 6741.561798483083, 417.3156024120445, 418.53542567749776, 418.704813106759, 419.1093925408507, 419.5657494493185, 5283.709395983181, 5323.653962492425, 5328.893422131536, 5328.893422131613, 5332.760025798849, 8241.381896357678, 8352.0, 8438.324934005264, 8539.402241843012, 8552.871706924401, 8325.125861784547, 8346.624401901929, 8448.619812108469, 8451.535165565952, 8460.238578527962, 6593.076969224312, 6667.933320666732, 6684.1978962523835, 6742.561733487308, 6748.527603067836, 6411.134496842867, 6424.614523128627, 6426.678666066771, 6429.2284925807335, 6434.0, 7459.850802984019, 7538.283863033003, 7586.544807311579, 7608.543487390552, 7630.542167469969, 7649.61751912391, 7696.961515192612, 7740.806479838049, 7791.883121753292, 7863.685452581833, 5229.163333866563, 5347.652402593819, 5967.731452084579, 5968.253968253968, 6012.0, 6468.838279043061, 6537.803865884031, 6594.934050659432, 6599.934000659932, 6610.140681711539, 6025.909611355921, 6071.423214794588, 6090.573659843769, 6155.076738489262, 6158.507319414346, 6103.328633850362, 6198.163247961467, 6242.094896240111, 6274.592151510137, 6295.18162638854, 6245.125682404558, 6274.0, 6283.214598175228, 6290.716917738804, 6295.622262664255, 5804.984127777538, 5833.67914764692, 5835.183074369676, 5838.737256823538, 5851.736671849862, 5902.085176797603, 5938.732757025858, 5958.4210184302065, 6006.48944839676, 6009.909851352146], "unit": "score", "name": "mootools.html", "value": 3927.054706598607}, {"lowerIsBetter": false, "replicates": [296.43233208405906, 299.39372770140477, 306.53406821631114, 307.86607825595866, 312.6482706954676, 5318.78724851006, 5365.865853353668, 5418.647787893784, 5421.484958928905, 5426.864328391792, 5303.0, 5303.257543943851, 5306.7346632668405, 5310.3893052299, 5314.734263286829, 3931.115499012728, 4140.0, 4140.81366338514, 4141.964508872782, 4145.481814773153, 4011.6188962048705, 4049.129437171008, 4114.506259248894, 4120.814563344642, 4136.048708796979, 4074.470318858544, 4075.1645912587996, 4076.2458945095104, 4080.5307389650125, 4081.979590102045, 3883.339832228528, 3967.028078120879, 3994.8801535953967, 4078.286299897521, 4083.816228269735, 3585.480105384731, 3594.155373487228, 3595.137167079908, 3596.2088340565033, 3599.6940260077927, 5084.466131056222, 5089.083964886319, 5105.948940510584, 5109.463506331819, 5115.104856650071, 4719.764011799431, 4724.622030237572, 4725.787339569728, 4728.692634978715, 4730.526947305277, 5451.618386712932, 5568.7215639217875, 5570.526505247059, 5581.5813813963705, 5602.663840169603, 3960.0, 3962.8204487531743, 3963.7225394222414, 3964.6431821136234, 3968.146848427573, 5872.236609240814, 5881.470667639933, 5884.911726324109, 5893.8821223575715, 5895.056790913476, 4076.30702780528, 4076.612721791425, 4079.3880917862557, 4079.938800917989, 4080.1227736036303, 3777.7166712496123, 3865.1883104547796, 4135.669146468335, 4136.21411931732, 4142.130152667974, 4542.909141817145, 4618.122556714214, 4630.560096790799, 4649.883752906137, 4666.0901124280435, 5587.05020146576, 5593.692346920959, 5595.720213989365, 5598.076317407664, 5599.0, 1433.383645032646, 1461.335092532895, 1462.656275775192, 1462.8829693624484, 1463.8462961389114, 986.4475893499663, 992.265723364705, 1005.8239808033564, 1012.2155329619603, 1023.8259495885717, 4878.121938051114, 4879.365682461328, 4884.072026314989, 4890.462049174588, 4897.436794768647, 5803.0, 5803.941960580424, 5805.970970145122, 5806.854828629318, 5809.82570522885, 4867.3915760529935, 4881.316615673809, 4892.09496243189, 4896.632752543503, 4905.632077594195, 3050.23744063984, 3086.506159014592, 3104.487759519699, 3113.066080175938, 3119.610048743907, 5491.697956612345, 5491.780328786804, 5493.09363954943, 5494.340679118532, 5500.257465242221, 5955.82132536016, 5962.910556341659, 5965.433283838029, 5966.164736936832, 5975.462208401264, 5463.180522921593, 5492.148716948879, 5497.038018346853, 5497.422770609109, 5500.7524661391135, 5600.831975040755, 5786.5081468074, 5793.304803423448, 5794.507466865363, 5798.33319168301, 5676.091825307931, 5676.4323567642905, 5681.0626246668835, 5686.800961966312, 5687.289088863892, 5489.533389661923, 5496.890062198813, 5498.560115190695, 5499.2576002240785, 5509.972450137724, 4007.5391329996255, 4090.202410529918, 4096.40602112698, 4099.85650502231, 4110.486189226347, 5581.827816158652, 5774.769009239583, 5804.303483581997, 5806.941930580809, 5810.215620891126, 5521.420250873761, 5548.223248745098, 5553.694546799965, 5555.8888822224135, 5558.221848941071, 5632.295963004624, 5636.85907852307, 5648.293963254593, 5655.066913959316, 5658.264425624642, 5369.865753356197, 5494.752736126804, 5496.835094947158, 5505.146702261156, 5506.559475241891, 5672.801451949162, 5676.176954341515, 5676.659400435987, 5681.687507187145, 5682.687452190169, 5492.313460817398, 5518.475744804237, 5519.2824932758485, 5519.668819870821, 5586.832395028156], "unit": "score", "name": "prototype.html", "value": 4207.391654869415}, {"lowerIsBetter": false, "replicates": [723.1102668762926, 751.1587022534761, 776.8756998880181, 781.9296263336298, 783.7178615698348, 11200.439978001108, 13034.348282585868, 13147.4083666235, 13176.0, 13184.0, 13309.334533273322, 13460.057795954262, 13471.057026008184, 13473.797893031588, 13476.393562289695, 580.7415700013496, 587.9823605291848, 774.8295375017501, 786.4769927997875, 787.0948409329288, 772.8067983004249, 780.0561320801837, 786.2255678157011, 787.2757063501564, 787.5668382389691, 819.2994989284166, 820.0774129104757, 822.0464261456711, 826.8387664405443, 827.0612854410227, 580.6429046136637, 593.6912805341199, 803.0, 819.4878201124297, 819.6434550970347, 605.8182545236456, 608.0605464557269, 608.7534548507862, 608.8721368512618, 609.7378127405213, 10689.465526723632, 10791.514381852758, 10828.242023058388, 10857.782844343068, 10869.076128529085, 10243.590256389736, 10797.62208322705, 10830.40432776197, 10902.836457453144, 11348.773024539545, 9015.852211515088, 9095.727128186165, 9128.3153763468, 9271.0, 9415.858762118574, 3107.1610665120293, 3150.212446888278, 3153.731932785716, 3207.7273431758326, 3236.1909522619344, 40487.0, 41373.1725365491, 41450.79274603638, 41497.377539336936, 42397.57602423998, 9097.703055169328, 9134.26925845944, 9153.35926485153, 9179.311551633655, 9231.676891308905, 15867.603309917113, 15940.043597384194, 15956.601084972737, 15963.840361596236, 15976.680466390608, 6078.75684972605, 6208.410201030895, 6265.937340626535, 6348.682565871781, 6363.172787537591, 3452.7583069184916, 3480.982595087059, 3564.697000754913, 3640.0899775056237, 3660.249648821985, 2596.7533084356955, 2634.236071539232, 2634.3545831271463, 2636.1037247336, 2636.815422920377, 474.65587449099127, 477.1625796726722, 485.39325842696627, 486.31429684145894, 490.70312460960605, 588.664461257088, 598.1565991951328, 614.2199406753398, 619.4579742725116, 628.6950828848005, 7285.380742636829, 7465.626718664045, 7731.62493648312, 7749.612519374009, 7853.607319633996, 406.362359690448, 512.4199654738375, 613.6655522740117, 616.4051690118966, 619.891518984176, 3588.964110358863, 3626.492291079251, 3637.9818100909324, 3682.2451397463456, 3693.2244228711734, 51082.74458627683, 51103.744481278096, 51738.0, 52019.0, 52073.21890171651, 43615.563844361786, 43951.78024109923, 44017.0, 44096.779516102215, 44191.33712994308, 39365.0, 41006.79496602498, 41136.97157571085, 41207.58792412098, 42021.78989105035, 7206.567605943451, 7535.773926782205, 7684.0, 7696.191899850659, 7790.571518566533, 31699.20751981219, 31922.20194495156, 32015.35969280555, 32180.0, 32365.838170808995, 38224.23551528898, 40321.0, 40434.39348409717, 40572.18855622812, 40578.59421405866, 8807.119288071142, 8921.732348029569, 8976.506292153994, 9145.86281205769, 9168.266538677024, 10198.082172604501, 10281.331713438902, 10322.432266225429, 10372.066514013775, 10391.740206494898, 9752.756181095529, 9826.9017309826, 9922.057404546556, 10297.691069267934, 10307.742306442398, 9136.497492637704, 9608.423494590346, 9702.223822094356, 9709.077637624414, 9718.076782705632, 9453.480058596842, 10397.0, 10501.684949451528, 10512.632057877938, 11278.436078195893, 8457.957710211409, 8521.275691566287, 8908.198262156437, 9231.214912193096, 9439.952800235955, 9009.459432434074, 9064.909350906406, 9359.625614975597, 9405.43567385959, 9430.669926552539], "unit": "score", "name": "yui.html", "value": 5622.811405764055}], "name": "dromaeo_css", "value": 6200.36980732404}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 114.0, 106.0, 111.0, 114.0, 115.0, 102.0, 111.0, 112.0, 103.0], "unit": "score", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [161.0, 140.0, 158.0, 169.0, 138.0, 161.0, 149.0, 140.0, 168.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.7}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 162.0, 163.0, 161.0, 165.0, 164.0, 163.0, 163.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 83.0, 91.0, 73.0, 72.0, 74.0, 102.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 134.0, 98.0, 97.0, 97.0, 129.0, 104.0, 97.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [70.0, 82.0, 69.0, 70.0, 70.0, 69.0, 69.0, 78.0, 67.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 71.2}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 85.0, 85.0, 90.0, 84.0, 84.0, 84.0, 84.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.6}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 132.0, 121.0, 123.0, 121.0, 120.0, 123.0, 119.0, 121.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 121.8}, {"lowerIsBetter": true, "replicates": [139.0, 148.0, 149.0, 155.0, 147.0, 136.0, 148.0, 145.0, 146.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 69.0, 69.0, 70.0, 69.0, 71.0, 71.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1525.1999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.47244880972198], "unit": "score", "name": "Richards", "value": 212.05911400000002}, {"lowerIsBetter": false, "replicates": [188.32391713747646], "unit": "score", "name": "DeltaBlue", "value": 351.08658000000014}, {"lowerIsBetter": false, "replicates": [278.473962684489], "unit": "score", "name": "Encrypt", "value": 955.8559709999997}, {"lowerIsBetter": false, "replicates": [5170.103092783505], "unit": "score", "name": "Decrypt", "value": 51.48466001994015}, {"lowerIsBetter": false, "replicates": [1978.2608695652175], "unit": "score", "name": "RayTrace", "value": 374.06037362637363}, {"lowerIsBetter": false, "replicates": [802.5682182985554], "unit": "score", "name": "Earley", "value": 830.4128980000002}, {"lowerIsBetter": false, "replicates": [11674.418604651162], "unit": "score", "name": "Boyer", "value": 57.08746812749006}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [619.3111931119312], "unit": "score", "name": "Splay", "value": 131.58328301886795}, {"lowerIsBetter": false, "replicates": [4859.223300970873], "unit": "score", "name": "NavierStokes", "value": 305.39860139860156}], "name": "v8_7", "value": 19809.87631765728}]} 11:52:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19809.88"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1525.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6200.37"}}} 11:52:48 INFO - Return code: 0 11:52:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:52:48 INFO - # TBPL SUCCESS # 11:52:48 INFO - Running post-action listener: _resource_record_post_action 11:52:48 INFO - Running post-run listener: _resource_record_post_run 11:52:49 INFO - Total resource usage - Wall time: 1237s; CPU: 13.0%; Read bytes: 4096; Write bytes: 542146560; Read time: 16; Write time: 525348 11:52:49 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 227602432; Read time: 0; Write time: 276964 11:52:50 INFO - run-tests - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 313679872; Read time: 16; Write time: 248344 11:52:50 INFO - Running post-run listener: _upload_blobber_files 11:52:50 INFO - Blob upload gear active. 11:52:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:52:50 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 11:52:50 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'] 11:52:50 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 11:52:50 INFO - (blobuploader) - INFO - Open directory for files ... 11:52:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 11:52:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 11:52:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:51 INFO - (blobuploader) - INFO - Done attempting. 11:52:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 11:52:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:52:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:52:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 11:52:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:52:52 INFO - (blobuploader) - INFO - Done attempting. 11:52:52 INFO - (blobuploader) - INFO - Iteration through files over. 11:52:52 INFO - Return code: 0 11:52:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:52:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:52:52 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e821f8f072e3cf629bc058b4509b5135c62260ed6214d9284622578221145b30617f006264200decffb5488e0bc7b56d67aa40e1e47a02765573495ba6d4008", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4676cef2e756f99d63e87a14128e968d0171c8beba7144e64435dfb79e197c213712901ac8bfaacada603837cca0c3af73de4c3bcd754444ee6b6b12433ada85"} 11:52:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:52:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:52:52 INFO - Contents: 11:52:52 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8e821f8f072e3cf629bc058b4509b5135c62260ed6214d9284622578221145b30617f006264200decffb5488e0bc7b56d67aa40e1e47a02765573495ba6d4008", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4676cef2e756f99d63e87a14128e968d0171c8beba7144e64435dfb79e197c213712901ac8bfaacada603837cca0c3af73de4c3bcd754444ee6b6b12433ada85"} 11:52:52 INFO - Copying logs to upload dir... 11:52:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1285.377399 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2015-12-26 11:52:51.553904) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 11:52:51.557526) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584 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/8e821f8f072e3cf629bc058b4509b5135c62260ed6214d9284622578221145b30617f006264200decffb5488e0bc7b56d67aa40e1e47a02765573495ba6d4008", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4676cef2e756f99d63e87a14128e968d0171c8beba7144e64435dfb79e197c213712901ac8bfaacada603837cca0c3af73de4c3bcd754444ee6b6b12433ada85"} build_url:https://queue.taskcluster.net/v1/task/rAWddqYfRBW-lXsbdmIx8Q/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/rAWddqYfRBW-lXsbdmIx8Q/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/8e821f8f072e3cf629bc058b4509b5135c62260ed6214d9284622578221145b30617f006264200decffb5488e0bc7b56d67aa40e1e47a02765573495ba6d4008", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/4676cef2e756f99d63e87a14128e968d0171c8beba7144e64435dfb79e197c213712901ac8bfaacada603837cca0c3af73de4c3bcd754444ee6b6b12433ada85"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-26 11:52:51.583441) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 11:52:51.583816) ========= 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=9c54e757a4c805d85fea3bc7000001f2-1451142761.862529-998211584 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-26 11:52:51.666277) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 11:52:51.666632) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-26 11:52:51.666974) ========= ========= Total master_lag: 0.29 =========