builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-006 starttime: 1452401904.88 results: success (0) buildid: 20160109201930 builduid: 6ab4ce7498044f0bb7ceb3c4820aaeb5 revision: 1764c03305e60d6b9bee7308670d237ddb7767a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.879221) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.879659) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:24.879997) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006512 basedir: '/builds/slave/test' ========= master_lag: 0.14 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.028131) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.028518) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.071158) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.071458) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004664 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.125385) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.125704) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.126098) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.126410) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-09 20:58:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 85.0M=0s 2016-01-09 20:58:26 (85.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130837 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.274471) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.274803) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018636 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.324342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.324703) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1764c03305e60d6b9bee7308670d237ddb7767a0 --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 1764c03305e60d6b9bee7308670d237ddb7767a0 --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=e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-09 20:58:26,167 truncating revision to first 12 chars 2016-01-09 20:58:26,167 Setting DEBUG logging. 2016-01-09 20:58:26,167 attempt 1/10 2016-01-09 20:58:26,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1764c03305e6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-09 20:58:26,509 unpacking tar archive at: fx-team-1764c03305e6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642908 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.980499) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.980836) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.992927) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.993209) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-09 20:58:25.993642) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-09 20:58:25.993988) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:58:26 INFO - MultiFileLogger online at 20160109 20:58:26 in /builds/slave/test 20:58:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 20:58:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:58:26 INFO - {'append_to_log': False, 20:58:26 INFO - 'base_work_dir': '/builds/slave/test', 20:58:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 20:58:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:58:26 INFO - 'branch': 'Fx-Team-Non-PGO', 20:58:26 INFO - 'buildbot_json_path': 'buildprops.json', 20:58:26 INFO - 'config_files': ('talos/linux_config.py',), 20:58:26 INFO - 'default_actions': ('clobber', 20:58:26 INFO - 'read-buildbot-config', 20:58:26 INFO - 'download-and-extract', 20:58:26 INFO - 'populate-webroot', 20:58:26 INFO - 'create-virtualenv', 20:58:26 INFO - 'install', 20:58:26 INFO - 'run-tests'), 20:58:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:58:26 INFO - 'download_minidump_stackwalk': True, 20:58:26 INFO - 'download_symbols': 'ondemand', 20:58:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:58:26 INFO - 'tooltool.py': '/tools/tooltool.py', 20:58:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:58:26 INFO - '/tools/misc-python/virtualenv.py')}, 20:58:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:58:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:58:26 INFO - 'installer_path': 'installer.exe', 20:58:26 INFO - 'log_level': 'info', 20:58:26 INFO - 'log_name': 'talos', 20:58:26 INFO - 'log_to_console': True, 20:58:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:58:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:58:26 INFO - 'opt_config_files': (), 20:58:26 INFO - 'pip_index': False, 20:58:26 INFO - 'sps_profile': False, 20:58:26 INFO - 'sps_profile_interval': 0, 20:58:26 INFO - 'suite': 'dromaeojs', 20:58:26 INFO - 'system_bits': '32', 20:58:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:58:26 INFO - 'title': 'talos-linux64-ix-006', 20:58:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:58:26 INFO - 'use_talos_json': True, 20:58:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:58:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:58:26 INFO - 'work_dir': 'build'} 20:58:26 INFO - ##### 20:58:26 INFO - ##### Running clobber step. 20:58:26 INFO - ##### 20:58:26 INFO - Running pre-action listener: _resource_record_pre_action 20:58:26 INFO - Running main action method: clobber 20:58:26 INFO - rmtree: /builds/slave/test/build 20:58:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:58:27 INFO - Running post-action listener: _resource_record_post_action 20:58:27 INFO - ##### 20:58:27 INFO - ##### Running read-buildbot-config step. 20:58:27 INFO - ##### 20:58:27 INFO - Running pre-action listener: _resource_record_pre_action 20:58:27 INFO - Running main action method: read_buildbot_config 20:58:27 INFO - Using buildbot properties: 20:58:27 INFO - { 20:58:27 INFO - "project": "", 20:58:27 INFO - "product": "firefox", 20:58:27 INFO - "script_repo_revision": "production", 20:58:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 20:58:27 INFO - "repository": "", 20:58:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 20:58:27 INFO - "buildid": "20160109201930", 20:58:27 INFO - "pgo_build": "False", 20:58:27 INFO - "basedir": "/builds/slave/test", 20:58:27 INFO - "buildnumber": 2336, 20:58:27 INFO - "slavename": "talos-linux64-ix-006", 20:58:27 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 20:58:27 INFO - "platform": "ubuntu64_hw", 20:58:27 INFO - "scheduler": "tests-fx-team-linux64-talos", 20:58:27 INFO - "branch": "fx-team", 20:58:27 INFO - "repo_path": "integration/fx-team", 20:58:27 INFO - "revision": "1764c03305e60d6b9bee7308670d237ddb7767a0", 20:58:27 INFO - "stage_platform": "linux64", 20:58:27 INFO - "builduid": "6ab4ce7498044f0bb7ceb3c4820aaeb5", 20:58:27 INFO - "slavebuilddir": "test" 20:58:27 INFO - } 20:58:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 20:58:27 INFO - Running post-action listener: _resource_record_post_action 20:58:27 INFO - ##### 20:58:27 INFO - ##### Running download-and-extract step. 20:58:27 INFO - ##### 20:58:27 INFO - Running pre-action listener: _resource_record_pre_action 20:58:27 INFO - Running main action method: download_and_extract 20:58:27 INFO - mkdir: /builds/slave/test/build/tests 20:58: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')]} 20:58:27 INFO - https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 20:58:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/test_packages.json 20:58:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/test_packages.json 20:58:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 20:58:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 20:58:39 INFO - Downloaded 1302 bytes. 20:58:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 20:58:39 INFO - Using the following test package requirements: 20:58:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:58:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:58:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:39 INFO - u'jsshell-linux-x86_64.zip'], 20:58:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:58:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:58:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:58:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:58:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:58:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 20:58:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 20:58:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:58:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:58:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:39 INFO - https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:58:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/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 20:58:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/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 20:58:43 INFO - Downloaded 22761271 bytes. 20:58:43 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 20:58:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:43 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 20:58:44 INFO - Return code: 0 20:58:44 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 20:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:44 INFO - https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 20:58:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/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 20:58:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/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 20:58:45 INFO - Downloaded 22761271 bytes. 20:58:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 20:58:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 20:58:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 20:58:46 INFO - Return code: 0 20:58: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')]} 20:58:46 INFO - https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 20:58:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:58:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:58:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/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 20:58:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/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 20:58:49 INFO - Downloaded 11132285 bytes. 20:58:49 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 20:58:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 20:58:49 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 20:58:49 INFO - Return code: 0 20:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:49 INFO - https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 20:58:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:58:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:58:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/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 20:58:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/BQ4sniRISc2FCX6ktKM4RQ/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 20:58:52 INFO - Downloaded 54052138 bytes. 20:58:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:58:52 INFO - mkdir: /builds/slave/test/properties 20:58:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:58:52 INFO - Writing to file /builds/slave/test/properties/build_url 20:58:52 INFO - Contents: 20:58:52 INFO - build_url:https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 20:58:52 INFO - Running post-action listener: _resource_record_post_action 20:58:52 INFO - Running post-action listener: set_extra_try_arguments 20:58:52 INFO - ##### 20:58:52 INFO - ##### Running populate-webroot step. 20:58:52 INFO - ##### 20:58:52 INFO - Running pre-action listener: _resource_record_pre_action 20:58:52 INFO - Running main action method: populate_webroot 20:58:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:58:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:58:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:58:52 INFO - '--tppagecycles', 20:58:52 INFO - '7'], 20:58:52 INFO - 'tests': ['tsvgm']}}, 20:58:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 20:58:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 20:58:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:58:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:58:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 20:58:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 20:58:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:58:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:52 INFO - 'talos_options': ['--e10s'], 20:58:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:58:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:52 INFO - 'tests': ['damp', 'tps']}, 20:58:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:52 INFO - 'talos_options': ['--e10s'], 20:58:52 INFO - 'tests': ['damp', 'tps']}, 20:58:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 20:58:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:58:52 INFO - 'other': {'tests': ['a11yr', 20:58:52 INFO - 'ts_paint', 20:58:52 INFO - 'tpaint', 20:58:52 INFO - 'sessionrestore', 20:58:52 INFO - 'sessionrestore_no_auto_restore']}, 20:58:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 20:58:52 INFO - 'tests': ['a11yr', 20:58:52 INFO - 'ts_paint', 20:58:52 INFO - 'tpaint', 20:58:52 INFO - 'sessionrestore', 20:58:52 INFO - 'sessionrestore_no_auto_restore']}, 20:58:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 20:58:52 INFO - 'tests': ['a11yr', 20:58:52 INFO - 'ts_paint', 20:58:52 INFO - 'tpaint', 20:58:52 INFO - 'sessionrestore', 20:58:52 INFO - 'sessionrestore_no_auto_restore']}, 20:58:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 20:58:52 INFO - 'tests': ['a11yr', 20:58:52 INFO - 'ts_paint', 20:58:52 INFO - 'tpaint', 20:58:52 INFO - 'sessionrestore', 20:58:52 INFO - 'sessionrestore_no_auto_restore']}, 20:58:52 INFO - 'other_l64': {'tests': ['a11yr', 20:58:52 INFO - 'ts_paint', 20:58:52 INFO - 'tpaint', 20:58:52 INFO - 'sessionrestore', 20:58:52 INFO - 'sessionrestore_no_auto_restore']}, 20:58:52 INFO - 'other_nol64': {'tests': ['a11yr', 20:58:52 INFO - 'ts_paint', 20:58:52 INFO - 'tpaint', 20:58:52 INFO - 'sessionrestore', 20:58:52 INFO - 'sessionrestore_no_auto_restore']}, 20:58:52 INFO - 'svgr': {'tests': ['tsvgx', 20:58:52 INFO - 'tsvgr_opacity', 20:58:52 INFO - 'tart', 20:58:52 INFO - 'tscrollx', 20:58:52 INFO - 'cart']}, 20:58:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 20:58:52 INFO - 'tests': ['tsvgx', 20:58:52 INFO - 'tsvgr_opacity', 20:58:52 INFO - 'tart', 20:58:52 INFO - 'tscrollx', 20:58:52 INFO - 'cart']}, 20:58:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:52 INFO - 'tests': ['tp5o']}, 20:58:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:52 INFO - 'talos_options': ['--e10s'], 20:58:52 INFO - 'tests': ['tp5o']}, 20:58:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:52 INFO - 'talos_options': ['--xperf_path', 20:58:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:58:52 INFO - 'tests': ['tp5n']}, 20:58:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:58:52 INFO - 'talos_options': ['--e10s', 20:58:52 INFO - '--xperf_path', 20:58:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:58:52 INFO - 'tests': ['tp5n']}}, 20:58:52 INFO - 'talos.zip': {'path': '', 20:58:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:58:52 INFO - Running post-action listener: _resource_record_post_action 20:58:52 INFO - ##### 20:58:52 INFO - ##### Running create-virtualenv step. 20:58:52 INFO - ##### 20:58:52 INFO - Running pre-action listener: _resource_record_pre_action 20:58:52 INFO - Running main action method: create_virtualenv 20:58:52 INFO - Creating virtualenv /builds/slave/test/build/venv 20:58:52 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 20:58:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:58:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:58:52 INFO - Using real prefix '/usr' 20:58:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:58:53 INFO - Installing distribute.............................................................................................................................................................................................done. 20:58:55 INFO - Installing pip.................done. 20:58:55 INFO - Return code: 0 20:58:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:58: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')]} 20:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58: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')]} 20:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a3ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003d0>, '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 0x196bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196c360>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', '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 20:58: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', 'pip>=1.5'] in /builds/slave/test/build 20:58: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 pip>=1.5 20:58:55 INFO - Using env: {'DISPLAY': ':0', 20:58:55 INFO - 'HOME': '/home/cltbld', 20:58:55 INFO - 'LANG': 'en_US.UTF-8', 20:58:55 INFO - 'LANGUAGE': 'en_US:en', 20:58:55 INFO - 'LOGNAME': 'cltbld', 20:58:55 INFO - 'MAIL': '/var/mail/cltbld', 20:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:55 INFO - 'MOZ_NO_REMOTE': '1', 20:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:58:55 INFO - 'NO_EM_RESTART': '1', 20:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:55 INFO - 'PWD': '/builds/slave/test', 20:58:55 INFO - 'SHELL': '/bin/bash', 20:58:55 INFO - 'SHLVL': '1', 20:58:55 INFO - 'TERM': 'linux', 20:58:55 INFO - 'TMOUT': '86400', 20:58:55 INFO - 'USER': 'cltbld', 20:58:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', 20:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:55 INFO - '_': '/tools/buildbot/bin/python'} 20:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:55 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 20:58:55 INFO - Cleaning up... 20:58:55 INFO - Return code: 0 20:58:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 20:58: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')]} 20:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58: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')]} 20:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58: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', '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 0x7f4a3ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003d0>, '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 0x196bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196c360>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', '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 20:58: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', 'psutil>=0.7.1'] in /builds/slave/test/build 20:58: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 psutil>=0.7.1 20:58:55 INFO - Using env: {'DISPLAY': ':0', 20:58:55 INFO - 'HOME': '/home/cltbld', 20:58:55 INFO - 'LANG': 'en_US.UTF-8', 20:58:55 INFO - 'LANGUAGE': 'en_US:en', 20:58:55 INFO - 'LOGNAME': 'cltbld', 20:58:55 INFO - 'MAIL': '/var/mail/cltbld', 20:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:55 INFO - 'MOZ_NO_REMOTE': '1', 20:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:58:55 INFO - 'NO_EM_RESTART': '1', 20:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:55 INFO - 'PWD': '/builds/slave/test', 20:58:55 INFO - 'SHELL': '/bin/bash', 20:58:55 INFO - 'SHLVL': '1', 20:58:55 INFO - 'TERM': 'linux', 20:58:55 INFO - 'TMOUT': '86400', 20:58:55 INFO - 'USER': 'cltbld', 20:58:55 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', 20:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:55 INFO - '_': '/tools/buildbot/bin/python'} 20:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:55 INFO - Downloading/unpacking psutil>=0.7.1 20:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:58:57 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 20:58:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 20:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:58:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:58:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:58:57 INFO - Installing collected packages: psutil 20:58:57 INFO - Running setup.py install for psutil 20:58:57 INFO - building 'psutil._psutil_linux' extension 20:58:57 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 20:58:57 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 20:58:57 INFO - building 'psutil._psutil_posix' extension 20:58:57 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 20:58:57 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 20:58:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:58:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:58:58 INFO - Successfully installed psutil 20:58:58 INFO - Cleaning up... 20:58:58 INFO - Return code: 0 20:58:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 20:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:58:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f4a3ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003d0>, '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 0x196bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196c360>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', '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 20:58:58 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 20:58:58 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 20:58:58 INFO - Using env: {'DISPLAY': ':0', 20:58:58 INFO - 'HOME': '/home/cltbld', 20:58:58 INFO - 'LANG': 'en_US.UTF-8', 20:58:58 INFO - 'LANGUAGE': 'en_US:en', 20:58:58 INFO - 'LOGNAME': 'cltbld', 20:58:58 INFO - 'MAIL': '/var/mail/cltbld', 20:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:58:58 INFO - 'MOZ_NO_REMOTE': '1', 20:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:58:58 INFO - 'NO_EM_RESTART': '1', 20:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:58:58 INFO - 'PWD': '/builds/slave/test', 20:58:58 INFO - 'SHELL': '/bin/bash', 20:58:58 INFO - 'SHLVL': '1', 20:58:58 INFO - 'TERM': 'linux', 20:58:58 INFO - 'TMOUT': '86400', 20:58:58 INFO - 'USER': 'cltbld', 20:58:58 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', 20:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:58:58 INFO - '_': '/tools/buildbot/bin/python'} 20:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:58:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 20:58: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 20:58: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 20:58: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 20:58: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 20:58: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 20:58: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 20:58:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 20:58:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 20:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:59:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 20:59:00 INFO - Installing collected packages: mozsystemmonitor 20:59:00 INFO - Running setup.py install for mozsystemmonitor 20:59:00 INFO - Successfully installed mozsystemmonitor 20:59:00 INFO - Cleaning up... 20:59:00 INFO - Return code: 0 20:59:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f4a3ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003d0>, '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 0x196bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196c360>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', '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 20:59:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 20:59:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 20:59:00 INFO - Using env: {'DISPLAY': ':0', 20:59:00 INFO - 'HOME': '/home/cltbld', 20:59:00 INFO - 'LANG': 'en_US.UTF-8', 20:59:00 INFO - 'LANGUAGE': 'en_US:en', 20:59:00 INFO - 'LOGNAME': 'cltbld', 20:59:00 INFO - 'MAIL': '/var/mail/cltbld', 20:59:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:00 INFO - 'MOZ_NO_REMOTE': '1', 20:59:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:00 INFO - 'NO_EM_RESTART': '1', 20:59:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:00 INFO - 'PWD': '/builds/slave/test', 20:59:00 INFO - 'SHELL': '/bin/bash', 20:59:00 INFO - 'SHLVL': '1', 20:59:00 INFO - 'TERM': 'linux', 20:59:00 INFO - 'TMOUT': '86400', 20:59:00 INFO - 'USER': 'cltbld', 20:59:00 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', 20:59:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:00 INFO - '_': '/tools/buildbot/bin/python'} 20:59:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:00 INFO - Downloading/unpacking blobuploader==1.2.4 20:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:02 INFO - Downloading blobuploader-1.2.4.tar.gz 20:59:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 20:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:59:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 20:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:59:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:02 INFO - Downloading docopt-0.6.1.tar.gz 20:59:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 20:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:59:02 INFO - Installing collected packages: blobuploader, requests, docopt 20:59:02 INFO - Running setup.py install for blobuploader 20:59:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:59:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:59:02 INFO - Running setup.py install for requests 20:59:03 INFO - Running setup.py install for docopt 20:59:03 INFO - Successfully installed blobuploader requests docopt 20:59:03 INFO - Cleaning up... 20:59:03 INFO - Return code: 0 20:59:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59:03 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')]} 20:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:03 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')]} 20:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:03 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 0x7f4a3ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003d0>, '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 0x196bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196c360>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', '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 20:59:03 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 20:59:03 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 20:59:03 INFO - Using env: {'DISPLAY': ':0', 20:59:03 INFO - 'HOME': '/home/cltbld', 20:59:03 INFO - 'LANG': 'en_US.UTF-8', 20:59:03 INFO - 'LANGUAGE': 'en_US:en', 20:59:03 INFO - 'LOGNAME': 'cltbld', 20:59:03 INFO - 'MAIL': '/var/mail/cltbld', 20:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:03 INFO - 'MOZ_NO_REMOTE': '1', 20:59:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:03 INFO - 'NO_EM_RESTART': '1', 20:59:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:03 INFO - 'PWD': '/builds/slave/test', 20:59:03 INFO - 'SHELL': '/bin/bash', 20:59:03 INFO - 'SHLVL': '1', 20:59:03 INFO - 'TERM': 'linux', 20:59:03 INFO - 'TMOUT': '86400', 20:59:03 INFO - 'USER': 'cltbld', 20:59:03 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', 20:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:03 INFO - '_': '/tools/buildbot/bin/python'} 20:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:59:03 INFO - Running setup.py (path:/tmp/pip-SrP5UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:59:03 INFO - Running setup.py (path:/tmp/pip-LQWd3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:59:03 INFO - Running setup.py (path:/tmp/pip-eWsbQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:59:03 INFO - Running setup.py (path:/tmp/pip-ZjJr1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:59:03 INFO - Running setup.py (path:/tmp/pip-j4ah_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:59:04 INFO - Running setup.py (path:/tmp/pip-3aExlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:59:04 INFO - Running setup.py (path:/tmp/pip-L7BUBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:59:04 INFO - Running setup.py (path:/tmp/pip-SE_0OZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:59:04 INFO - Running setup.py (path:/tmp/pip-sKhOEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:59:04 INFO - Running setup.py (path:/tmp/pip-cr4zkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:59:04 INFO - Running setup.py (path:/tmp/pip-id31H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:59:04 INFO - Running setup.py (path:/tmp/pip-RNdDxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:59:04 INFO - Running setup.py (path:/tmp/pip-Y0w6CX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:59:04 INFO - Running setup.py (path:/tmp/pip-U63rh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:04 INFO - Running setup.py (path:/tmp/pip-x2YNlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:59:04 INFO - Running setup.py (path:/tmp/pip-EkRz4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:59:04 INFO - Running setup.py (path:/tmp/pip-dBdDBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:59:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:59:04 INFO - Running setup.py install for manifestparser 20:59:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Running setup.py install for mozcrash 20:59:05 INFO - Running setup.py install for mozdebug 20:59:05 INFO - Running setup.py install for mozdevice 20:59:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Running setup.py install for mozfile 20:59:05 INFO - Running setup.py install for mozhttpd 20:59:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Running setup.py install for mozinfo 20:59:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Running setup.py install for mozInstall 20:59:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Running setup.py install for mozleak 20:59:05 INFO - Running setup.py install for mozlog 20:59:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:59:05 INFO - Running setup.py install for moznetwork 20:59:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:59:06 INFO - Running setup.py install for mozprocess 20:59:06 INFO - Running setup.py install for mozprofile 20:59:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:59:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:59:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:59:06 INFO - Running setup.py install for mozrunner 20:59:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:59:06 INFO - Running setup.py install for mozscreenshot 20:59:06 INFO - Running setup.py install for moztest 20:59:06 INFO - Running setup.py install for mozversion 20:59:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:59:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:59:06 INFO - Cleaning up... 20:59:06 INFO - Return code: 0 20:59:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59: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')]} 20:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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')]} 20:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59: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', '-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 0x7f4a3ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003d0>, '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 0x196bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196c360>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', '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 20:59:06 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 20:59:06 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 20:59:06 INFO - Using env: {'DISPLAY': ':0', 20:59:06 INFO - 'HOME': '/home/cltbld', 20:59:06 INFO - 'LANG': 'en_US.UTF-8', 20:59:06 INFO - 'LANGUAGE': 'en_US:en', 20:59:06 INFO - 'LOGNAME': 'cltbld', 20:59:06 INFO - 'MAIL': '/var/mail/cltbld', 20:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:06 INFO - 'MOZ_NO_REMOTE': '1', 20:59:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:06 INFO - 'NO_EM_RESTART': '1', 20:59:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:06 INFO - 'PWD': '/builds/slave/test', 20:59:06 INFO - 'SHELL': '/bin/bash', 20:59:06 INFO - 'SHLVL': '1', 20:59:06 INFO - 'TERM': 'linux', 20:59:06 INFO - 'TMOUT': '86400', 20:59:06 INFO - 'USER': 'cltbld', 20:59:06 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', 20:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:06 INFO - '_': '/tools/buildbot/bin/python'} 20:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:59:06 INFO - Running setup.py (path:/tmp/pip-qGUebH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:59:06 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)) 20:59:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:59:06 INFO - Running setup.py (path:/tmp/pip-lLB6cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:59:07 INFO - Running setup.py (path:/tmp/pip-lCccrA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:59:07 INFO - Running setup.py (path:/tmp/pip-dtX24A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:59:07 INFO - Running setup.py (path:/tmp/pip-pY7nYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:59:07 INFO - Running setup.py (path:/tmp/pip-4a15Qq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:59:07 INFO - Running setup.py (path:/tmp/pip-u2WRO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:59:07 INFO - Running setup.py (path:/tmp/pip-_jXYMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:59:07 INFO - Running setup.py (path:/tmp/pip-nHXzMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:59:07 INFO - Running setup.py (path:/tmp/pip-MNxdOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:59:07 INFO - Running setup.py (path:/tmp/pip-g_NWOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:59:07 INFO - Running setup.py (path:/tmp/pip-mGlj9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:59:07 INFO - Running setup.py (path:/tmp/pip-wBxWj5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:59:07 INFO - Running setup.py (path:/tmp/pip-tiVYPw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:07 INFO - Running setup.py (path:/tmp/pip-LMfzbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:59:07 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)) 20:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:59:07 INFO - Running setup.py (path:/tmp/pip-Xj3_jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:59:08 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)) 20:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:59:08 INFO - Running setup.py (path:/tmp/pip-BrAImg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:59:08 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)) 20:59:08 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)) 20:59:08 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)) 20:59:08 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)) 20:59:08 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)) 20:59:08 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)) 20:59:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59:09 INFO - Downloading blessings-1.5.1.tar.gz 20:59:09 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 20:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:59:09 INFO - Installing collected packages: blessings 20:59:09 INFO - Running setup.py install for blessings 20:59:09 INFO - Successfully installed blessings 20:59:09 INFO - Cleaning up... 20:59:10 INFO - Return code: 0 20:59:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:59:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:59:10 INFO - Reading from file tmpfile_stdout 20:59:10 INFO - Current package versions: 20:59:10 INFO - argparse == 1.2.1 20:59:10 INFO - blessings == 1.5.1 20:59:10 INFO - blobuploader == 1.2.4 20:59:10 INFO - docopt == 0.6.1 20:59:10 INFO - manifestparser == 1.1 20:59:10 INFO - mozInstall == 1.12 20:59:10 INFO - mozcrash == 0.16 20:59:10 INFO - mozdebug == 0.1 20:59:10 INFO - mozdevice == 0.47 20:59:10 INFO - mozfile == 1.2 20:59:10 INFO - mozhttpd == 0.7 20:59:10 INFO - mozinfo == 0.9 20:59:10 INFO - mozleak == 0.1 20:59:10 INFO - mozlog == 3.1 20:59:10 INFO - moznetwork == 0.27 20:59:10 INFO - mozprocess == 0.22 20:59:10 INFO - mozprofile == 0.28 20:59:10 INFO - mozrunner == 6.11 20:59:10 INFO - mozscreenshot == 0.1 20:59:10 INFO - mozsystemmonitor == 0.0 20:59:10 INFO - moztest == 0.7 20:59:10 INFO - mozversion == 1.4 20:59:10 INFO - psutil == 3.1.1 20:59:10 INFO - requests == 1.2.3 20:59:10 INFO - wsgiref == 0.1.2 20:59:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f4a3ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003d0>, '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 0x196bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196c360>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', '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 20:59:10 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 20:59:10 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 20:59:10 INFO - Using env: {'DISPLAY': ':0', 20:59:10 INFO - 'HOME': '/home/cltbld', 20:59:10 INFO - 'LANG': 'en_US.UTF-8', 20:59:10 INFO - 'LANGUAGE': 'en_US:en', 20:59:10 INFO - 'LOGNAME': 'cltbld', 20:59:10 INFO - 'MAIL': '/var/mail/cltbld', 20:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:10 INFO - 'MOZ_NO_REMOTE': '1', 20:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:10 INFO - 'NO_EM_RESTART': '1', 20:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:10 INFO - 'PWD': '/builds/slave/test', 20:59:10 INFO - 'SHELL': '/bin/bash', 20:59:10 INFO - 'SHLVL': '1', 20:59:10 INFO - 'TERM': 'linux', 20:59:10 INFO - 'TMOUT': '86400', 20:59:10 INFO - 'USER': 'cltbld', 20:59:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', 20:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:10 INFO - '_': '/tools/buildbot/bin/python'} 20:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:10 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)) 20:59:10 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)) 20:59:10 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)) 20:59:10 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)) 20:59:10 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)) 20:59:10 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)) 20:59:10 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)) 20:59:10 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)) 20:59:10 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)) 20:59:10 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)) 20:59:10 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)) 20:59:10 INFO - Cleaning up... 20:59:10 INFO - Return code: 0 20:59:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f4a3ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003d0>, '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 0x196bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196c360>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', '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 20:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:59:10 INFO - Using env: {'DISPLAY': ':0', 20:59:10 INFO - 'HOME': '/home/cltbld', 20:59:10 INFO - 'LANG': 'en_US.UTF-8', 20:59:10 INFO - 'LANGUAGE': 'en_US:en', 20:59:10 INFO - 'LOGNAME': 'cltbld', 20:59:10 INFO - 'MAIL': '/var/mail/cltbld', 20:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:10 INFO - 'MOZ_NO_REMOTE': '1', 20:59:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:10 INFO - 'NO_EM_RESTART': '1', 20:59:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:10 INFO - 'PWD': '/builds/slave/test', 20:59:10 INFO - 'SHELL': '/bin/bash', 20:59:10 INFO - 'SHLVL': '1', 20:59:10 INFO - 'TERM': 'linux', 20:59:10 INFO - 'TMOUT': '86400', 20:59:10 INFO - 'USER': 'cltbld', 20:59:10 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', 20:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:10 INFO - '_': '/tools/buildbot/bin/python'} 20:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:10 INFO - Downloading/unpacking jsonschema 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59: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 20:59:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:59:12 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 20:59:12 INFO - Downloading/unpacking functools32 (from jsonschema) 20:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:59:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:59:12 INFO - Downloading functools32-3.2.3-2.tar.gz 20:59:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:59:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:59:12 INFO - warning: no files found matching '*.txt' 20:59:12 INFO - no previously-included directories found matching 'build' 20:59:12 INFO - no previously-included directories found matching 'dist' 20:59:12 INFO - no previously-included directories found matching '.git*' 20:59:12 INFO - Installing collected packages: jsonschema, functools32 20:59:12 INFO - Running setup.py install for functools32 20:59:12 INFO - warning: no files found matching '*.txt' 20:59:12 INFO - no previously-included directories found matching 'build' 20:59:12 INFO - no previously-included directories found matching 'dist' 20:59:12 INFO - no previously-included directories found matching '.git*' 20:59:12 INFO - Successfully installed jsonschema functools32 20:59:12 INFO - Cleaning up... 20:59:12 INFO - Return code: 0 20:59:12 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:59:12 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')]} 20:59:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:59:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:12 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')]} 20:59:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:59:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:59:12 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 0x7f4a3ce6af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x189e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x196ddd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a003d0>, '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 0x196bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196c360>, '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': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', '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 20:59:12 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 20:59:12 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 20:59:12 INFO - Using env: {'DISPLAY': ':0', 20:59:12 INFO - 'HOME': '/home/cltbld', 20:59:12 INFO - 'LANG': 'en_US.UTF-8', 20:59:12 INFO - 'LANGUAGE': 'en_US:en', 20:59:12 INFO - 'LOGNAME': 'cltbld', 20:59:12 INFO - 'MAIL': '/var/mail/cltbld', 20:59:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:12 INFO - 'MOZ_NO_REMOTE': '1', 20:59:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:12 INFO - 'NO_EM_RESTART': '1', 20:59:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:12 INFO - 'PWD': '/builds/slave/test', 20:59:12 INFO - 'SHELL': '/bin/bash', 20:59:12 INFO - 'SHLVL': '1', 20:59:12 INFO - 'TERM': 'linux', 20:59:12 INFO - 'TMOUT': '86400', 20:59:12 INFO - 'USER': 'cltbld', 20:59:12 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', 20:59:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:12 INFO - '_': '/tools/buildbot/bin/python'} 20:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:59:13 INFO - Downloading/unpacking flake8 20:59:13 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 20:59:13 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 20:59:13 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 20:59:13 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 20:59:13 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 20:59:13 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 20:59:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:59:14 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 20:59:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:59:14 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 20:59:14 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 20:59:14 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 20:59:14 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 20:59:14 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 20:59:14 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 20:59:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:59:14 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 20:59:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:59:14 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 20:59:14 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 20:59:14 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 20:59:14 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 20:59:14 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 20:59:14 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 20:59:15 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 20:59:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:59:15 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 20:59:15 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 20:59:15 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 20:59:15 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 20:59:15 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 20:59:15 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 20:59:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:59:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:59:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:59:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:59:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:59:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:59:15 INFO - no previously-included directories found matching 'docs/_build' 20:59:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:59:15 INFO - Running setup.py install for pep8 20:59:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:59:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:59:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:59:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:59:15 INFO - no previously-included directories found matching 'docs/_build' 20:59:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:59:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:59:15 INFO - Cleaning up... 20:59:15 INFO - Return code: 0 20:59:15 INFO - Running post-action listener: _resource_record_post_action 20:59:15 INFO - Running post-action listener: _start_resource_monitoring 20:59:15 INFO - Starting resource monitoring. 20:59:15 INFO - ##### 20:59:15 INFO - ##### Running install step. 20:59:15 INFO - ##### 20:59:15 INFO - Running pre-action listener: _resource_record_pre_action 20:59:15 INFO - Running main action method: install 20:59:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:59:15 INFO - Reading from file tmpfile_stdout 20:59:15 INFO - Detecting whether we're running mozinstall >=1.0... 20:59:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:59:16 INFO - Reading from file tmpfile_stdout 20:59:16 INFO - Output received: 20:59:16 INFO - Usage: mozinstall [options] installer 20:59:16 INFO - Options: 20:59:16 INFO - -h, --help show this help message and exit 20:59:16 INFO - -d DEST, --destination=DEST 20:59:16 INFO - Directory to install application into. [default: 20:59:16 INFO - "/builds/slave/test"] 20:59:16 INFO - --app=APP Application being installed. [default: firefox] 20:59:16 INFO - mkdir: /builds/slave/test/build/application 20:59:16 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'] 20:59:16 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 20:59:31 INFO - Reading from file tmpfile_stdout 20:59:31 INFO - Output received: 20:59:31 INFO - /builds/slave/test/build/application/firefox/firefox 20:59:31 INFO - Running post-action listener: _resource_record_post_action 20:59:31 INFO - ##### 20:59:31 INFO - ##### Running run-tests step. 20:59:31 INFO - ##### 20:59:31 INFO - Running pre-action listener: _resource_record_pre_action 20:59:31 INFO - Running main action method: run_tests 20:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:59:31 INFO - Python 2.7.3 20:59:31 INFO - Return code: 0 20:59:31 INFO - grabbing minidump binary from tooltool 20:59:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:59:31 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 0x1a003d0>, '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 0x196bed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x196c360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:59:31 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 20:59:31 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 20:59:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:59:31 INFO - Return code: 0 20:59:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:59:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:59:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:59:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:59:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:59:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:59:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:59:32 INFO - Return code: 0 20:59:32 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/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 20:59:32 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/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-006 --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 20:59:32 INFO - Using env: {'DISPLAY': ':0', 20:59:32 INFO - 'HOME': '/home/cltbld', 20:59:32 INFO - 'LANG': 'en_US.UTF-8', 20:59:32 INFO - 'LANGUAGE': 'en_US:en', 20:59:32 INFO - 'LOGNAME': 'cltbld', 20:59:32 INFO - 'MAIL': '/var/mail/cltbld', 20:59:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:59:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:59:32 INFO - 'MOZ_NO_REMOTE': '1', 20:59:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:59:32 INFO - 'NO_EM_RESTART': '1', 20:59:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:59:32 INFO - 'PWD': '/builds/slave/test', 20:59:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:59:32 INFO - 'SHELL': '/bin/bash', 20:59:32 INFO - 'SHLVL': '1', 20:59:32 INFO - 'TERM': 'linux', 20:59:32 INFO - 'TMOUT': '86400', 20:59:32 INFO - 'USER': 'cltbld', 20:59:32 INFO - 'XDG_SESSION_COOKIE': 'e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808', 20:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:59:32 INFO - '_': '/tools/buildbot/bin/python'} 20:59:32 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/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-006', '--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 20:59:32 INFO - mozversion application_buildid: 20160109201930 20:59:32 INFO - mozversion application_changeset: 1764c03305e60d6b9bee7308670d237ddb7767a0 20:59:32 INFO - mozversion application_display_name: Nightly 20:59:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:59:32 INFO - mozversion application_name: Firefox 20:59:32 INFO - mozversion application_remotingname: firefox 20:59:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:59:32 INFO - mozversion application_vendor: Mozilla 20:59:32 INFO - mozversion application_version: 46.0a1 20:59:32 INFO - mozversion platform_buildid: 20160109201930 20:59:32 INFO - mozversion platform_changeset: 1764c03305e60d6b9bee7308670d237ddb7767a0 20:59:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:59:32 INFO - mozversion platform_version: 46.0a1 20:59:32 INFO - using testdate: 1452401972 20:59:32 INFO - actual date: 1452401972 20:59:32 INFO - starting webserver on 'localhost:49404' 20:59:32 INFO - SUITE-START | Running 3 tests 20:59:32 INFO - TEST-START | dromaeo_css 20:59:32 INFO - operating with platform_type : linux_ 20:59:32 INFO - Initialising browser for dromaeo_css test... 20:59:33 INFO - TEST-INFO | started process 9985 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnj7I2p/profile http://localhost:49404/getInfo.html) 20:59:37 INFO - PROCESS | 9985 | __metrics Screen width/height:1600/1200 20:59:37 INFO - PROCESS | 9985 | colorDepth:24 20:59:37 INFO - PROCESS | 9985 | Browser inner width/height: 1024/697 20:59:37 INFO - PROCESS | 9985 | __metrics 20:59:37 INFO - PROCESS | 9985 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 20:59:37 INFO - PROCESS | 9985 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:59:38 INFO - TEST-INFO | 9985: exit 0 20:59:38 INFO - Browser initialized. 20:59:38 INFO - Running cycle 1/1 for dromaeo_css test... 20:59:38 INFO - TEST-INFO | started process 10078 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnj7I2p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:59:50 INFO - PROCESS | 10078 | RSS: Main: 149127168 20:59:50 INFO - PROCESS | 10078 | 21:00:41 INFO - PROCESS | 10078 | 1452402041480 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] 21:02:53 INFO - PROCESS | 10078 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49404/tests/dromaeo/cssquery-ext.html) 21:02:54 INFO - PROCESS | 10078 | RSS: Main: 251121664 21:02:54 INFO - PROCESS | 10078 | 21:05:57 INFO - PROCESS | 10078 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-ext.html (next: http://localhost:49404/tests/dromaeo/cssquery-jquery.html) 21:05:57 INFO - PROCESS | 10078 | RSS: Main: 230248448 21:05:57 INFO - PROCESS | 10078 | 21:08:59 INFO - PROCESS | 10078 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49404/tests/dromaeo/cssquery-mootools.html) 21:09:00 INFO - PROCESS | 10078 | RSS: Main: 252678144 21:09:00 INFO - PROCESS | 10078 | 21:12:02 INFO - PROCESS | 10078 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49404/tests/dromaeo/cssquery-prototype.html) 21:12:02 INFO - PROCESS | 10078 | RSS: Main: 212189184 21:12:02 INFO - PROCESS | 10078 | 21:15:05 INFO - PROCESS | 10078 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49404/tests/dromaeo/cssquery-yui.html) 21:15:06 INFO - PROCESS | 10078 | RSS: Main: 216633344 21:15:06 INFO - PROCESS | 10078 | 21:18:08 INFO - PROCESS | 10078 | Cycle 1(1): loaded http://localhost:49404/tests/dromaeo/cssquery-yui.html (next: http://localhost:49404/tests/dromaeo/cssquery-dojo.html) 21:18:08 INFO - PROCESS | 10078 | RSS: Main: 259936256 21:18:08 INFO - PROCESS | 10078 | 21:18:08 INFO - PROCESS | 10078 | __start_tp_report 21:18:08 INFO - PROCESS | 10078 | _x_x_mozilla_page_load 21:18:08 INFO - PROCESS | 10078 | _x_x_mozilla_page_load_details 21:18:08 INFO - PROCESS | 10078 | |i|pagename|runs| 21:18:08 INFO - PROCESS | 10078 | |0;dojo.html;2571.074413211244;2681.235847783381;2694.6496955395796;2700.6489156409666;2705.377763114483;4403.0973650401675;4531.7054391464535;4532.750698711569;4541.2733962566;4550.63594912407;4470.8882277942985;4518.847693838066;4527.592516673499;4579.335996280537;4644.5587669171455;3989.52125744911;4115.259253334399;4164.083901541656;4187.350960601104;4350.282203436429;4044.5348784889675;4270.67969902257;4297.742135471866;4319.200947824646;4326.870193894189;4120.773357465338;4144.378343248507;4151.91696166078;4204.915901681949;4239.364095385686;4208.789560521992;4215.178040282146;4215.3887686285625;4217.97891010543;4260.233158031553;4187.51843537994;4201.621854033121;4204.327307630795;4221.197972385237;4238.5761423857675;4359.149965756678;4441.555844415532;4480.417545719069;4482.350059241392;4546.089803741466;4874.049560335736;4874.122657921573;4876.146674331978;4878.975605121987;4897;4891.364122664031;4900.338454308659;4911.68074075184;4912.312276281324;4936.950630493721;4351.064521128004;4446.42196514451;4452.910941781146;4462.687611867138;4580.221362368406;4987.750612469362;4995.675281106716;4995.925061124086;4998.475160108209;5015.122353588181;4796.112719146969;4800.495947925488;4805.063012712488;4805.8558243252755;4843.297721830315;4748.596369308579;4784.6889952153;4855.5387238212315;4860.4896485869185;4879.487653796371;4853.466118726938;4862.367892173995;4871.780769865364;4887.3890763654545;4903.215485522299;4836.347093142451;4838.177509823338;4839.806407743651;4845.878853028703;4878.317035615017;3937.9015524612114;3994.380870965005;4028.073543085107;4030.4760381150263;4087.2029954159248;3594.2092739597247;3605.549306336708;3614.2771445710964;3625.6736893679167;3638.9818050909576;4213.1784302061415;4218.599233072853;4220.451341325669;4223.1553689261655;4252.702310838212;4683.063387322549;4779.259214821708;4819.614430845524;4875.34182885313;4883.487233840467;4154.231467178582;4182.1844740275965;4182.498100227992;4199.286121359376;4220.556841531657;4302.053548219386;4317.460317460317;4326.394304797331;4344.717593356421;4352.434183556117;4464.620507256855;4566.977165114153;4575.839845605387;4631.4905360411;4636.39726835516;4792;4811.350467686818;4811.422629284508;4858;4861.440934292602;4580.267157254823;4581.518940511199;4581.518940511199;4622.514635963175;4648.1168577970075;4620.5379462053525;4727.57451829337;4727.810887564459;4743.454502732092;4773.3555969945;4826.8069277228515;4891.364122664031;4899.11815873132;4900.681455705368;4915.508449155056;4743.430788305425;4745.0509898019845;4757.119932812441;4766.451858036232;4782.521747825329;4540.954590454186;4647.628189744744;4650.116477869194;4760.262159365304;4796.472388037383;4555.40779698637;4609.631229501699;4612.377329060668;4629.305604159403;4671.906561868675;4734.479207287264;4735.313379559876;4746.7863946121815;4772.117158325721;4772.49888761675;4501.212287849678;4606.723596584216;4610.5389461054965;4645.09420662981;4686.390769199982 21:18:08 INFO - PROCESS | 10078 | |1;ext.html;490.5707505932309;493.9407271127465;496.50101647843934;510.55836701253406;520.6459607466926;24139.396515087108;25044.624330635033;32541.51187732186;33225.667743322556;33226.66773332266;34946.650533494656;35337;35404;35438.64561354386;35454.645453545454;6791.286914873941;7550.84898302035;7754.7673569793;7778.64996075178;7780.377569794431;6834.282400347966;9597.280203984694;9837.508124593778;9837.55730992107;9841.26190535709;9695.175910047654;9783.41299522031;9783.95108024459;9785.412875227508;9796.461194634328;6916.896246556305;7080.29197080293;9566;9667.081627245401;9694.272929530314;9488.857667134998;9661.613535458573;9664.71005869825;9668.75828104303;9678;33236.335273294644;33569.496457553156;33638.32723345544;33672.83163584191;33694.663053369644;2846.886124555015;2883.884644614213;2954.1875984104327;3014.050574069161;3449.793012419263;25867.74132258672;26045.609315860278;28438.715612844022;28672.569911451345;28900.710992890014;3355.8154301513405;3460.9826950865086;3471.1322169457635;3496.30073985204;3574.231540218839;219797;220101;220979;221112.8944355284;221211;46369.53630463719;47522.762386187846;49137.26294105591;54489.72755136278;55534.444655553736;48152.27771583429;48161;48190.831412586514;48405;48485.5151448481;15073.170975596227;15442.305096270695;15448.073115613099;15464.381424742884;15532.689346213012;10458.058774710313;10468.371897686164;10469.738256543647;10480.528376223088;10516.474176291154;18615.81384186168;18750.906245468686;18778.53053673669;18834.905825470785;18856.905715471334;6540.313267106981;6793.252742198354;6829.453643708492;6875.106236189264;6935.167779866449;746.1978373248671;776.3168411797582;814.4298990706411;825.8307047055339;935.102301790289;25612.743872561037;25931.611025834627;26009.609855852177;26114.086006989663;26135.215943521725;900.1358695652116;906.582971832951;913.2739472119681;926.9212116969999;964.2093483343591;13359.1316564423;13522;13658.795118073236;13716.519921802888;13750.381232844546;357009;370911;372508;373526;374074;41895;42236.78881605634;42289.57710422918;42338.57661423346;42371.7881410591;1189.7025743564109;1191.5948577483698;1191.773563023023;1195.5994741761608;1329.2423318708436;24202.140950934267;24996;25206.49587008286;25541.744582553936;25555.616665749658;37295;37604.81197593995;37679.24641507209;37725.62274377221;37749;211132;216823;333744;346222;346471;27869.72130278671;28090.2977425566;28168.71831281661;28223.57664635073;28238.294042648275;38114.42828357632;39152.80423597864;39801.40297895476;39806.60193398029;40103.3984490227;32341.5614408692;33039.66960330462;33482.83258583691;34071.148221294665;34096.14759631029;32847;32965.17587060342;33392.33215335728;33681.663183367855;33807.3238535223;32707.509387358732;32990;33216.66783332136;33932.49101263532;34229.65770342265;25123;26861.597076043483;26939.865300673373;26993.59509607397;27093.080092172302;21609.567808644053;22157.335279941628;22169;22360.32919012432;22431.439214019127 21:18:08 INFO - PROCESS | 10078 | |2;jquery.html;311.75215703515704;316.4620145752221;324.45329619590984;326.53468806950104;331.86725309876044;11259;11728.12039097067;13901;13985.93007034966;14403.279836008196;11536.769264614702;13687.24720140392;14079.92960035201;15255.313510892009;15277.312520936557;4696.53034696531;4787.04013503189;4967.801287948478;4978.502149785028;5032.723200223986;3626.256617393441;3745.62543745626;4816.229403295473;4919.508049195088;5468.671879687232;5651.2935883014625;5666.433356664342;5681.176229446728;5690.800821971232;5695.74369153387;5433.266509021271;5736.598438109334;5736.684482353469;5737.77048918047;5740.8851822963725;4842.080004799112;4931.65478416511;4934.506549345073;4955.578775804061;4960.826371077031;17716.114194290232;17985;18192.727109093375;18215.08924553767;18248.543786405313;1691.0868131209131;1707.538964479596;1866.803985581508;1960.0199900049975;2010.316492392579;11792.35142067186;11892.108091893142;12015.579454719043;12161.635150945485;12266.877331226662;1682.697114519386;1693.0045093579142;1698.2867195777803;1706.0872433248276;1771.929122835085;47688.52311476875;48457.75771121157;48557.27164092541;49120.75439622815;50201.995960080596;8198.139195384518;8315;8589.184027517376;8670.696525621574;8675.305975521944;10478.161747060218;10542.683719488428;10561.260711750103;10576.20678449104;10620.840687389695;6951.443884489228;6959.791206263821;6985.336393042653;6999.545029573062;7083.114610673666;6863.862722745517;6888.483363747739;6932.584044957319;6932.6533673316135;6941.167059952838;5250.317458730417;5294.841154765363;5307.867303317448;5323.228131920927;5345.7594408251725;1426.6718654709268;1462.2542503323168;1471.977920331196;1525.9160746158846;1534.7928029716068;810.4731924249285;867.2671592504324;877.4077497689034;988.5847943863595;991.2565575818137;12732.618021459371;14204.36080376365;14864.405423783144;14962.251887405804;16514.75227871583;789.3409003482042;806.4193780478047;808.6967387229789;900.1403659505157;913.7852604637905;8273.793155171168;8599.699010534601;8661.956690216508;8738.21356077956;8871.866921996176;463382;466004;467138;467721;480824;60148;61274;62434;62678;69175.30824691789;457.72536478112863;469.3476068265114;469.73459995102655;471.3989663179474;474.27909577442097;8810.163034511712;9002.549872506217;9180.311476639412;9352.485613291334;9407.341486096182;30773.692263077082;31300.686993129777;31578.684213157576;31832.52251216187;31877.840610797724;39202.411963821134;41185;41246.58753412427;41264.1289976239;41317.793411032755;6388.584741991755;6583.539152259296;6646.501512386493;6694.966525167538;6725.49558783103;7037.190723066913;8469.74590762278;9129.406588571721;9904.900950990686;10020.69937901864;7318.414526837947;7407.333339999426;7577.355924746458;7620.31417172435;7693.923060769321;8146.952885753899;8273.172682731678;8292.968222785456;8470.703525376583;8546.401751877558;7950.40371972116;8381.53901535397;8417.200365965224;8423.410361274651;8482.109378515168;6669.533132680665;6688.665566721547;6691.330866913269;6710.16122984627;6725.764598239038;6553.5084868634085;8067.354611630938;8223.342132629496;8296.543690097102;8370.414071014971 21:18:08 INFO - PROCESS | 10078 | |3;mootools.html;1240.144300432702;1389.84711681715;1398.5804258722385;1515.6665533582616;1735.3232239426618;6188.628682279061;7120.216776154625;7229.240929702384;7265.382442492394;7284.854302913938;7130.9643451782795;7346.632668366587;7346.742863999761;7349.853002939938;7357.779266621997;1753.684336819372;1790.8119647437027;2107.2940564910696;2135.0712440088573;2169.40341406113;2132.5308432144902;2142.946426339346;2145.7746936571593;2146.7638559758493;2146.796054374832;2080.0223894769433;2119.8304135669187;2129.4995676016124;2132.936011919645;2133.8292936565117;2095.413284280389;2107.2940564910696;2114.30228024753;2115.619188546061;2131.2540610786255;2121.3105740634355;2127.3405244374294;2153.4078128514625;2153.7307836520436;2155.935321940329;7380.225076367012;7460.03019607453;7460.701571937116;7461.365783908374;7482.363999060087;4280.272353699847;4355.477342718894;4368.301071828492;4394.143142087294;4398.3842262083335;2843.402885394049;2862.4418238443513;2897.5798509216047;2916.431295897301;3010.1872494426602;918.9264858811279;921.4977837078808;935.8455854783953;956.4787190980932;960.7742180587557;10298.176145908385;10433.947830260877;10454.529546170364;10474.528646210863;10487.947560262226;4101.91796164075;4103.692223083281;4164.83340666376;4170.270202714512;4175.582441755861;9060.682876099305;9071.727848164566;9072.8639070414;9076.500792456347;9088.318376121817;4512.684112112121;4531.3882625845745;4541.68208225421;4545.181867263858;4546.499885012646;4026.456428382131;4059.7361171523758;4062.7765472899273;4067.084905896209;4074.8777536673947;3158.494640857452;3239.5626590410466;3399.354122716676;3470.479428085757;3546.2021045265124;1124.3310230412892;1138.5218208352512;1143.3368646185193;1151.7984352738406;1155.5839897636845;1075.499892549968;1171.2328424881716;1172.4489489939715;1177.664365655784;1206.9879301207052;6824.761133360308;6912.170539535288;6914.757983470555;6945.791626251221;6951.89572156418;1000.0899181744722;1012.488693209939;1024.7335692719946;1038.1227862456212;1042.7653777899911;5414.052540805344;5437.211604317431;5523.364813046471;5538.418466061086;5546.528545073633;8905.109489051043;9080.364374493854;9187.862182067274;9226.354155209205;9233.215176710055;8898.332625053146;9259.953700231456;9264.25885929124;9269.026752191057;9278.396904201205;7295.744648937261;7298.635068246566;7321.304476074764;7373.5207211530005;7377.557346559223;6732.528722989344;6896.586204827727;6908.171019477494;6913.0667359905765;6914.55055421396;7603.239676032353;7828.178041305809;7850.646720897459;7947.761567152995;8031.959840200761;7894.092179399213;8149.9185008151535;8178.100408955129;8201.13888041771;8383.161683831568;6874.725010999504;7012.649367531501;7031.542949708252;7033.613151276729;7041.718331266692;6722.394984451423;6888.690008949709;6898.310168983062;6898.655067246718;6905.516613836983;6369.554131210771;6471.06169605414;6516.967415162894;6559.27847936717;6636.070950067091;6297.433231009231;6359.586626869239;6371.93628063732;6499.545031847725;6513.576617519846;6561.179852518435;6589.868202635825;6628.734850605922;6790.728370865308;6809.489288303496;6014.849628759316;6061.333253342217;6066.332703402711;6067.878642427215;6074.149619053248;6176.4441200292185;6377.96811015942;6380.808575742735;6393.744250230125;6395.5203359747275 21:18:09 INFO - PROCESS | 10078 | |4;prototype.html;295.8165937118985;304.32288158846563;310.4536016610765;312.1696287874253;318.4681581758463;5130.512601302875;5208.427073021964;5302.575793936486;5312.73436328184;5323.89352212956;5161.458046905077;5237.607179461536;5238.030964271603;5239;5246.029484545352;3856.3058649443087;3942.980285098585;4082.3060079786505;4087.9780054986254;4089.754614723126;3936.075022369741;4022.9597704022876;4039.1921615676833;4052.452918855961;4065.8170382332864;4021.3766866135797;4022.0950286185666;4022.1151346703823;4026.3557830747086;4033.536143343509;3815.8092095395396;3870.2453021660785;3936.76379417233;3971.7616942983514;4015.056461731491;3480.878169264089;3486.1633208030144;3487.2851065531504;3492.1967947372245;3497.422925217336;4893.926591101136;4966.950330496685;4990.151674215355;4990.600751939873;4992.425871024842;4600.907981840344;4616.907661846778;4620.792064357112;4623.398958135454;4629.86110416688;5292.735363231823;5420.4850539198715;5430.239766432703;5438.293021907166;5443.292371991655;3823.770573765583;3830.8467661293516;3838.9424158637644;3839.2705385976574;3844.269588778151;5617.297837770278;5696;5698.51562617178;5711.02912504871;5714.828555143353;3942.9605703943166;3961.58403367648;3961.742486738353;3962.7027972902147;3965.4844870166694;3887.7084218683713;4015;4016.6385025347276;4022.4770779798437;4024.4768180136393;4567.794449249792;4570.634349252052;4573.902263456813;4576.153411618861;4577.473590537064;5428.891422171613;5435.83692489226;5442.047641662693;5442.374126975369;5442.428545002717;1404.8876089912783;1421.5735279416133;1422.139605538655;1422.50923431416;1422.7083447893158;959.0361686505017;960.2605993385055;962.3351601729048;982.1455333859587;983.0660872171466;4784.162771515041;4790.329353890458;4792.2332426811545;4792.592629626451;4796.2565802300005;5644;5652.18043383707;5653.23681303027;5654.943450565524;5658.236138121301;4781.115493633689;4784.162771514971;4792.376990991149;4793.209120495079;4799.3041009053495;2805.438912217565;2897.2322334581354;3026.016544623006;3040.5135178371356;3048.5579590959187;5300.363956325188;5389.9191512127345;5445.346558412936;5460.535854452416;5465.988792073479;5871.647701137946;5875.529957603467;5882.088276317178;5882.411758824169;5886.558508111909;5453.563714902798;5459.5359394451125;5466.781328746805;5470.72646367672;5472.932778108231;5495.697736624524;5645.4072322405555;5648.57635677334;5713.9428605715075;5724.284464441945;5521.475459831309;5522.5858060646415;5531.446855314436;5606.355269144101;5609.5512359012;5433.782648694166;5460.399356070909;5470.152126420411;5474.589405794661;5475.206095116266;4059.1475790084414;4103.528094269197;4106.7946602670345;4107.958920410758;4109.3425051991535;5529.917051244154;5648.322201335702;5651.491365777099;5662;5664.773409063756;5412.648177868426;5445.646033007842;5454.127339625641;5461.781528738806;5471.206675032018;5451.754671039734;5457.890842183214;5458.344998600193;5458.4814442627885;5462.972685136708;5214.061468935476;5346;5347.545458636059;5355.25026496283;5359.169328754049;5476.972615137058;5480.3971563127225;5482.671039737628;5483.5064844162625;5484.314460692413;5127.435982042047;5225.197306929103;5258.8159414420315;5338.866528336823;5410.080286351408 21:18:09 INFO - PROCESS | 10078 | |5;yui.html;761.2197497564997;768.2279309294158;769.1769806307253;795.7214974758831;809.2393150438584;12419.68950776231;12596.622101336952;12662.176958497703;12685.302308373035;12689.873101269008;12215.389230538482;12295.262284262928;12299.569515066974;12300.753984920297;12317.507299708024;602.4728362682653;612.0543759890957;773.4083426178963;790.0637744273055;792.2473650032492;757.8787394016958;767.029707420114;772.119783446871;772.8106613879607;773.872311068673;814.9429539932207;823.4153750836883;824.3405275779382;824.5506199121493;825.2655136928139;639.2935805934445;647.1780838335288;648.4261428635645;788.7554857993982;816.2531283875247;588.2529187931303;590.9261342332209;593.9732712027969;594.9791757288474;595.1043679262682;11428.028617567517;11496.540138394454;11530.423478826026;11536;11561;10558.155347572252;10692.625758098508;10816.296940698829;10953.397563134024;11224.270422422598;9327.953360233223;9532.809343813155;9631.181349585293;9646.469444180568;9677.322587418883;3123.107019791257;3166.651668316483;3173.4605117130145;3203.3913556424204;3224.4034853551934;37400.62599373999;37563.62436375629;37925.62074379248;37951.81024094889;38081.619183808085;8763.824723505495;8966.491282163593;9000.63997440095;9023;9120.726378208665;15591.454299099703;15602.765958510632;15610.3755849767;15627.296771645304;15631.609209769847;6251.874962500725;6312.684365781693;6411.5832470889245;6446.161998940108;6559.24568674599;3485;3599.3341231872187;3612.3858943979585;3627.818609069536;3657.250263695936;2582.134984780082;2640.4983053219826;2649.0463433164045;2649.2317228003662;2649.4038841260563;466.92295771198053;473.73234122720555;480.18368773085894;481.40786832196596;481.5714014527074;429.28095440137645;461.16759249554207;508.5219893300286;512.8282025521418;570.6319423971515;8115.840719011359;8324.958375208085;8334.458260213067;8415.863858379164;8472.872906906401;419.9287903772953;442.6635756824836;524.2738806752675;585.318104408368;590.4774274766777;3460.602030766444;3689.5572531296416;3694.094946738013;3698.815059247027;3737.3272810893754;46038.769806150754;47163.5283647166;48423.5157648419;49365.75317123463;49582;42785.786071069444;42835.7858210707;43216.13567728628;43265.78367108207;43374.783126084796;37739.24521509554;38353;39035.609643903765;39534.406983895264;39722.801385993465;7311.41508679315;7388.187299397169;7488.400927925644;7520.548767073993;7589.924100759143;28763.28091797722;28864;28982.565261521515;29245.85377073101;29854;34865.65134348624;35080.47379289262;36044.27911441809;38468.807655961544;38580.42129368118;8239.299659529008;8888;8926.86609700842;9030;9119.088091190828;9479.241660666992;9550.140487356171;9633.08485693858;9686.70939871805;9880;8615.396922215385;8877.600507977028;8922.776930576787;9212.861807073034;9329.626814927327;8939.106089391009;8965.282777377664;9070.455772653662;9079.727608171765;9277.67528136512;8715.172058654418;8823.382363234512;9014.549272536478;9141.862872057058;9324.720258392259;7429.182789893;7535.773926782205;7683.500572462772;7703.768886933401;7991.28078472917;7636.389088872988;7961.482503637245;8033.959830200812;8053.114157442559;8131.83736325282 21:18:09 INFO - PROCESS | 10078 | __end_tp_report 21:18:09 INFO - PROCESS | 10078 | __start_cc_report 21:18:09 INFO - PROCESS | 10078 | _x_x_mozilla_cycle_collect,856 21:18:09 INFO - PROCESS | 10078 | __end_cc_report 21:18:09 INFO - PROCESS | 10078 | __startTimestamp1452403088992__endTimestamp 21:18:09 INFO - PROCESS | 10078 | 21:18:09 INFO - PROCESS | 10078 | ------- Summary: start ------- 21:18:09 INFO - PROCESS | 10078 | Number of tests: 6 21:18:09 INFO - PROCESS | 10078 | 21:18:09 INFO - PROCESS | 10078 | [#0] dojo.html Cycles:165 Average:4485.66 Median:4581.52 stddev:452.59 (9.9%) stddev-sans-first:428.33 21:18:09 INFO - PROCESS | 10078 | Values: 2571.1 2681.2 2694.6 2700.6 2705.4 4403.1 4531.7 4532.8 4541.3 4550.6 4470.9 4518.8 4527.6 4579.3 4644.6 3989.5 4115.3 4164.1 4187.4 4350.3 4044.5 4270.7 4297.7 4319.2 4326.9 4120.8 4144.4 4151.9 4204.9 4239.4 4208.8 4215.2 4215.4 4218.0 4260.2 4187.5 4201.6 4204.3 4221.2 4238.6 4359.1 4441.6 4480.4 4482.4 4546.1 4874.0 4874.1 4876.1 4879.0 4897.0 4891.4 4900.3 4911.7 4912.3 4937.0 4351.1 4446.4 4452.9 4462.7 4580.2 4987.8 4995.7 4995.9 4998.5 5015.1 4796.1 4800.5 4805.1 4805.9 4843.3 4748.6 4784.7 4855.5 4860.5 4879.5 4853.5 4862.4 4871.8 4887.4 4903.2 4836.3 4838.2 4839.8 4845.9 4878.3 3937.9 3994.4 4028.1 4030.5 4087.2 3594.2 3605.5 3614.3 3625.7 3639.0 4213.2 4218.6 4220.5 4223.2 4252.7 4683.1 4779.3 4819.6 4875.3 4883.5 4154.2 4182.2 4182.5 4199.3 4220.6 4302.1 4317.5 4326.4 4344.7 4352.4 4464.6 4567.0 4575.8 4631.5 4636.4 4792.0 4811.4 4811.4 4858.0 4861.4 4580.3 4581.5 4581.5 4622.5 4648.1 4620.5 4727.6 4727.8 4743.5 4773.4 4826.8 4891.4 4899.1 4900.7 4915.5 4743.4 4745.1 4757.1 4766.5 4782.5 4541.0 4647.6 4650.1 4760.3 4796.5 4555.4 4609.6 4612.4 4629.3 4671.9 4734.5 4735.3 4746.8 4772.1 4772.5 4501.2 4606.7 4610.5 4645.1 4686.4 21:18:09 INFO - PROCESS | 10078 | 21:18:09 INFO - PROCESS | 10078 | [#1] ext.html Cycles:180 Average:43698.32 Median:34083.65 stddev:79603.23 (233.6%) stddev-sans-first:79760.44 21:18:09 INFO - PROCESS | 10078 | Values: 490.6 493.9 496.5 510.6 520.6 24139.4 25044.6 32541.5 33225.7 33226.7 34946.7 35337.0 35404.0 35438.6 35454.6 6791.3 7550.8 7754.8 7778.6 7780.4 6834.3 9597.3 9837.5 9837.6 9841.3 9695.2 9783.4 9784.0 9785.4 9796.5 6916.9 7080.3 9566.0 9667.1 9694.3 9488.9 9661.6 9664.7 9668.8 9678.0 33236.3 33569.5 33638.3 33672.8 33694.7 2846.9 2883.9 2954.2 3014.1 3449.8 25867.7 26045.6 28438.7 28672.6 28900.7 3355.8 3461.0 3471.1 3496.3 3574.2 219797.0 220101.0 220979.0 221112.9 221211.0 46369.5 47522.8 49137.3 54489.7 55534.4 48152.3 48161.0 48190.8 48405.0 48485.5 15073.2 15442.3 15448.1 15464.4 15532.7 10458.1 10468.4 10469.7 10480.5 10516.5 18615.8 18750.9 18778.5 18834.9 18856.9 6540.3 6793.3 6829.5 6875.1 6935.2 746.2 776.3 814.4 825.8 935.1 25612.7 25931.6 26009.6 26114.1 26135.2 900.1 906.6 913.3 926.9 964.2 13359.1 13522.0 13658.8 13716.5 13750.4 357009.0 370911.0 372508.0 373526.0 374074.0 41895.0 42236.8 42289.6 42338.6 42371.8 1189.7 1191.6 1191.8 1195.6 1329.2 24202.1 24996.0 25206.5 25541.7 25555.6 37295.0 37604.8 37679.2 37725.6 37749.0 211132.0 216823.0 333744.0 346222.0 346471.0 27869.7 28090.3 28168.7 28223.6 28238.3 38114.4 39152.8 39801.4 39806.6 40103.4 32341.6 33039.7 33482.8 34071.1 34096.1 32847.0 32965.2 33392.3 33681.7 33807.3 32707.5 32990.0 33216.7 33932.5 34229.7 25123.0 26861.6 26939.9 26993.6 27093.1 21609.6 22157.3 22169.0 22360.3 22431.4 21:18:09 INFO - PROCESS | 10078 | 21:18:09 INFO - PROCESS | 10078 | [#2] jquery.html Cycles:180 Average:24129.99 Median:5272.58 stddev:76622.84 (1453.2%) stddev-sans-first:76816.91 21:18:09 INFO - PROCESS | 10078 | Values: 311.8 316.5 324.5 326.5 331.9 11259.0 11728.1 13901.0 13985.9 14403.3 11536.8 13687.2 14079.9 15255.3 15277.3 4696.5 4787.0 4967.8 4978.5 5032.7 3626.3 3745.6 4816.2 4919.5 5468.7 5651.3 5666.4 5681.2 5690.8 5695.7 5433.3 5736.6 5736.7 5737.8 5740.9 4842.1 4931.7 4934.5 4955.6 4960.8 17716.1 17985.0 18192.7 18215.1 18248.5 1691.1 1707.5 1866.8 1960.0 2010.3 11792.4 11892.1 12015.6 12161.6 12266.9 1682.7 1693.0 1698.3 1706.1 1771.9 47688.5 48457.8 48557.3 49120.8 50202.0 8198.1 8315.0 8589.2 8670.7 8675.3 10478.2 10542.7 10561.3 10576.2 10620.8 6951.4 6959.8 6985.3 6999.5 7083.1 6863.9 6888.5 6932.6 6932.7 6941.2 5250.3 5294.8 5307.9 5323.2 5345.8 1426.7 1462.3 1472.0 1525.9 1534.8 810.5 867.3 877.4 988.6 991.3 12732.6 14204.4 14864.4 14962.3 16514.8 789.3 806.4 808.7 900.1 913.8 8273.8 8599.7 8662.0 8738.2 8871.9 463382.0 466004.0 467138.0 467721.0 480824.0 60148.0 61274.0 62434.0 62678.0 69175.3 457.7 469.3 469.7 471.4 474.3 8810.2 9002.5 9180.3 9352.5 9407.3 30773.7 31300.7 31578.7 31832.5 31877.8 39202.4 41185.0 41246.6 41264.1 41317.8 6388.6 6583.5 6646.5 6695.0 6725.5 7037.2 8469.7 9129.4 9904.9 10020.7 7318.4 7407.3 7577.4 7620.3 7693.9 8147.0 8273.2 8293.0 8470.7 8546.4 7950.4 8381.5 8417.2 8423.4 8482.1 6669.5 6688.7 6691.3 6710.2 6725.8 6553.5 8067.4 8223.3 8296.5 8370.4 21:18:09 INFO - PROCESS | 10078 | 21:18:09 INFO - PROCESS | 10078 | [#3] mootools.html Cycles:180 Average:5213.14 Median:6182.54 stddev:2741.76 (44.3%) stddev-sans-first:2733.18 21:18:09 INFO - PROCESS | 10078 | Values: 1240.1 1389.8 1398.6 1515.7 1735.3 6188.6 7120.2 7229.2 7265.4 7284.9 7131.0 7346.6 7346.7 7349.9 7357.8 1753.7 1790.8 2107.3 2135.1 2169.4 2132.5 2142.9 2145.8 2146.8 2146.8 2080.0 2119.8 2129.5 2132.9 2133.8 2095.4 2107.3 2114.3 2115.6 2131.3 2121.3 2127.3 2153.4 2153.7 2155.9 7380.2 7460.0 7460.7 7461.4 7482.4 4280.3 4355.5 4368.3 4394.1 4398.4 2843.4 2862.4 2897.6 2916.4 3010.2 918.9 921.5 935.8 956.5 960.8 10298.2 10433.9 10454.5 10474.5 10487.9 4101.9 4103.7 4164.8 4170.3 4175.6 9060.7 9071.7 9072.9 9076.5 9088.3 4512.7 4531.4 4541.7 4545.2 4546.5 4026.5 4059.7 4062.8 4067.1 4074.9 3158.5 3239.6 3399.4 3470.5 3546.2 1124.3 1138.5 1143.3 1151.8 1155.6 1075.5 1171.2 1172.4 1177.7 1207.0 6824.8 6912.2 6914.8 6945.8 6951.9 1000.1 1012.5 1024.7 1038.1 1042.8 5414.1 5437.2 5523.4 5538.4 5546.5 8905.1 9080.4 9187.9 9226.4 9233.2 8898.3 9260.0 9264.3 9269.0 9278.4 7295.7 7298.6 7321.3 7373.5 7377.6 6732.5 6896.6 6908.2 6913.1 6914.6 7603.2 7828.2 7850.6 7947.8 8032.0 7894.1 8149.9 8178.1 8201.1 8383.2 6874.7 7012.6 7031.5 7033.6 7041.7 6722.4 6888.7 6898.3 6898.7 6905.5 6369.6 6471.1 6517.0 6559.3 6636.1 6297.4 6359.6 6371.9 6499.5 6513.6 6561.2 6589.9 6628.7 6790.7 6809.5 6014.8 6061.3 6066.3 6067.9 6074.1 6176.4 6378.0 6380.8 6393.7 6395.5 21:18:09 INFO - PROCESS | 10078 | 21:18:09 INFO - PROCESS | 10078 | [#4] prototype.html Cycles:180 Average:4540.52 Median:5231.40 stddev:1330.83 (25.4%) stddev-sans-first:1295.87 21:18:09 INFO - PROCESS | 10078 | Values: 295.8 304.3 310.5 312.2 318.5 5130.5 5208.4 5302.6 5312.7 5323.9 5161.5 5237.6 5238.0 5239.0 5246.0 3856.3 3943.0 4082.3 4088.0 4089.8 3936.1 4023.0 4039.2 4052.5 4065.8 4021.4 4022.1 4022.1 4026.4 4033.5 3815.8 3870.2 3936.8 3971.8 4015.1 3480.9 3486.2 3487.3 3492.2 3497.4 4893.9 4967.0 4990.2 4990.6 4992.4 4600.9 4616.9 4620.8 4623.4 4629.9 5292.7 5420.5 5430.2 5438.3 5443.3 3823.8 3830.8 3838.9 3839.3 3844.3 5617.3 5696.0 5698.5 5711.0 5714.8 3943.0 3961.6 3961.7 3962.7 3965.5 3887.7 4015.0 4016.6 4022.5 4024.5 4567.8 4570.6 4573.9 4576.2 4577.5 5428.9 5435.8 5442.0 5442.4 5442.4 1404.9 1421.6 1422.1 1422.5 1422.7 959.0 960.3 962.3 982.1 983.1 4784.2 4790.3 4792.2 4792.6 4796.3 5644.0 5652.2 5653.2 5654.9 5658.2 4781.1 4784.2 4792.4 4793.2 4799.3 2805.4 2897.2 3026.0 3040.5 3048.6 5300.4 5389.9 5445.3 5460.5 5466.0 5871.6 5875.5 5882.1 5882.4 5886.6 5453.6 5459.5 5466.8 5470.7 5472.9 5495.7 5645.4 5648.6 5713.9 5724.3 5521.5 5522.6 5531.4 5606.4 5609.6 5433.8 5460.4 5470.2 5474.6 5475.2 4059.1 4103.5 4106.8 4108.0 4109.3 5529.9 5648.3 5651.5 5662.0 5664.8 5412.6 5445.6 5454.1 5461.8 5471.2 5451.8 5457.9 5458.3 5458.5 5463.0 5214.1 5346.0 5347.5 5355.3 5359.2 5477.0 5480.4 5482.7 5483.5 5484.3 5127.4 5225.2 5258.8 5338.9 5410.1 21:18:09 INFO - PROCESS | 10078 | 21:18:09 INFO - PROCESS | 10078 | [#5] yui.html Cycles:180 Average:11592.64 Median:590.70 stddev:13154.89 (2227.0%) stddev-sans-first:13166.65 21:18:09 INFO - PROCESS | 10078 | Values: 761.2 768.2 769.2 795.7 809.2 12419.7 12596.6 12662.2 12685.3 12689.9 12215.4 12295.3 12299.6 12300.8 12317.5 602.5 612.1 773.4 790.1 792.2 757.9 767.0 772.1 772.8 773.9 814.9 823.4 824.3 824.6 825.3 639.3 647.2 648.4 788.8 816.3 588.3 590.9 594.0 595.0 595.1 11428.0 11496.5 11530.4 11536.0 11561.0 10558.2 10692.6 10816.3 10953.4 11224.3 9328.0 9532.8 9631.2 9646.5 9677.3 3123.1 3166.7 3173.5 3203.4 3224.4 37400.6 37563.6 37925.6 37951.8 38081.6 8763.8 8966.5 9000.6 9023.0 9120.7 15591.5 15602.8 15610.4 15627.3 15631.6 6251.9 6312.7 6411.6 6446.2 6559.2 3485.0 3599.3 3612.4 3627.8 3657.3 2582.1 2640.5 2649.0 2649.2 2649.4 466.9 473.7 480.2 481.4 481.6 429.3 461.2 508.5 512.8 570.6 8115.8 8325.0 8334.5 8415.9 8472.9 419.9 442.7 524.3 585.3 590.5 3460.6 3689.6 3694.1 3698.8 3737.3 46038.8 47163.5 48423.5 49365.8 49582.0 42785.8 42835.8 43216.1 43265.8 43374.8 37739.2 38353.0 39035.6 39534.4 39722.8 7311.4 7388.2 7488.4 7520.5 7589.9 28763.3 28864.0 28982.6 29245.9 29854.0 34865.7 35080.5 36044.3 38468.8 38580.4 8239.3 8888.0 8926.9 9030.0 9119.1 9479.2 9550.1 9633.1 9686.7 9880.0 8615.4 8877.6 8922.8 9212.9 9329.6 8939.1 8965.3 9070.5 9079.7 9277.7 8715.2 8823.4 9014.5 9141.9 9324.7 7429.2 7535.8 7683.5 7703.8 7991.3 7636.4 7961.5 8034.0 8053.1 8131.8 21:18:09 INFO - PROCESS | 10078 | -------- Summary: end -------- 21:18:09 INFO - PROCESS | 10078 | 21:18:09 INFO - TEST-INFO | 10078: exit 0 21:18:09 INFO - TEST-OK | dromaeo_css | took 1116838ms 21:18:09 INFO - TEST-START | kraken 21:18:09 INFO - operating with platform_type : linux_ 21:18:09 INFO - Initialising browser for kraken test... 21:18:09 INFO - TEST-INFO | started process 10272 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzs_eeP/profile http://localhost:49404/getInfo.html) 21:18:13 INFO - PROCESS | 10272 | __metrics Screen width/height:1600/1200 21:18:13 INFO - PROCESS | 10272 | colorDepth:24 21:18:13 INFO - PROCESS | 10272 | Browser inner width/height: 1024/697 21:18:13 INFO - PROCESS | 10272 | __metrics 21:18:14 INFO - PROCESS | 10272 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:18:14 INFO - PROCESS | 10272 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:18:15 INFO - TEST-INFO | 10272: exit 0 21:18:15 INFO - Browser initialized. 21:18:15 INFO - Running cycle 1/1 for kraken test... 21:18:15 INFO - TEST-INFO | started process 10351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzs_eeP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:18:27 INFO - PROCESS | 10351 | RSS: Main: 149135360 21:18:27 INFO - PROCESS | 10351 | 21:18:29 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49404/tests/kraken/driver.html?testName=audio-beat-detection) 21:18:30 INFO - PROCESS | 10351 | RSS: Main: 187633664 21:18:30 INFO - PROCESS | 10351 | 21:18:32 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49404/tests/kraken/driver.html?testName=audio-dft) 21:18:33 INFO - PROCESS | 10351 | RSS: Main: 177250304 21:18:33 INFO - PROCESS | 10351 | 21:18:36 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49404/tests/kraken/driver.html?testName=audio-fft) 21:18:37 INFO - PROCESS | 10351 | RSS: Main: 160559104 21:18:37 INFO - PROCESS | 10351 | 21:18:39 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49404/tests/kraken/driver.html?testName=audio-oscillator) 21:18:39 INFO - PROCESS | 10351 | RSS: Main: 162615296 21:18:39 INFO - PROCESS | 10351 | 21:18:42 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49404/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:18:42 INFO - PROCESS | 10351 | RSS: Main: 164249600 21:18:42 INFO - PROCESS | 10351 | 21:18:45 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49404/tests/kraken/driver.html?testName=imaging-darkroom) 21:18:46 INFO - PROCESS | 10351 | RSS: Main: 164155392 21:18:46 INFO - PROCESS | 10351 | 21:18:49 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49404/tests/kraken/driver.html?testName=imaging-desaturate) 21:18:50 INFO - PROCESS | 10351 | RSS: Main: 164958208 21:18:50 INFO - PROCESS | 10351 | 21:18:52 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49404/tests/kraken/driver.html?testName=json-parse-financial) 21:18:53 INFO - PROCESS | 10351 | RSS: Main: 165445632 21:18:53 INFO - PROCESS | 10351 | 21:18:55 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49404/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:18:55 INFO - PROCESS | 10351 | RSS: Main: 177332224 21:18:55 INFO - PROCESS | 10351 | 21:18:57 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:18:58 INFO - PROCESS | 10351 | RSS: Main: 174776320 21:18:58 INFO - PROCESS | 10351 | 21:19:00 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:19:01 INFO - PROCESS | 10351 | RSS: Main: 181993472 21:19:01 INFO - PROCESS | 10351 | 21:19:03 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:19:04 INFO - PROCESS | 10351 | RSS: Main: 187035648 21:19:04 INFO - PROCESS | 10351 | 21:19:06 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:19:07 INFO - PROCESS | 10351 | RSS: Main: 186064896 21:19:07 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | Cycle 1(1): loaded http://localhost:49404/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49404/tests/kraken/driver.html?testName=ai-astar) 21:19:09 INFO - PROCESS | 10351 | RSS: Main: 245166080 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | __start_tp_report 21:19:09 INFO - PROCESS | 10351 | _x_x_mozilla_page_load 21:19:09 INFO - PROCESS | 10351 | _x_x_mozilla_page_load_details 21:19:09 INFO - PROCESS | 10351 | |i|pagename|runs| 21:19:09 INFO - PROCESS | 10351 | |0;ai-astar;110;112;105;110;112;113;100;112;110;118 21:19:09 INFO - PROCESS | 10351 | |1;audio-beat-detection;156;138;155;174;138;154;153;139;173;129 21:19:09 INFO - PROCESS | 10351 | |2;audio-dft;161;159;162;161;161;160;162;162;162;161 21:19:09 INFO - PROCESS | 10351 | |3;audio-fft;73;73;84;92;75;72;72;112;91;73 21:19:09 INFO - PROCESS | 10351 | |4;audio-oscillator;97;98;140;96;96;96;139;97;96;134 21:19:09 INFO - PROCESS | 10351 | |5;imaging-gaussian-blur;109;109;109;109;109;110;109;109;109;110 21:19:09 INFO - PROCESS | 10351 | |6;imaging-darkroom;146;146;146;147;146;146;146;146;147;146 21:19:09 INFO - PROCESS | 10351 | |7;imaging-desaturate;95;95;95;95;96;96;95;95;96;96 21:19:09 INFO - PROCESS | 10351 | |8;json-parse-financial;69;71;71;69;70;71;71;78;68;68 21:19:09 INFO - PROCESS | 10351 | |9;json-stringify-tinderbox;68;68;68;67;67;68;68;67;68;68 21:19:09 INFO - PROCESS | 10351 | |10;stanford-crypto-aes;83;83;91;91;83;84;83;82;84;85 21:19:09 INFO - PROCESS | 10351 | |11;stanford-crypto-ccm;128;127;126;122;126;139;121;118;121;130 21:19:09 INFO - PROCESS | 10351 | |12;stanford-crypto-pbkdf2;140;153;150;152;150;138;151;151;148;139 21:19:09 INFO - PROCESS | 10351 | |13;stanford-crypto-sha256-iterative;74;70;74;72;71;71;72;71;73;72 21:19:09 INFO - PROCESS | 10351 | __end_tp_report 21:19:09 INFO - PROCESS | 10351 | __start_cc_report 21:19:09 INFO - PROCESS | 10351 | _x_x_mozilla_cycle_collect,1006 21:19:09 INFO - PROCESS | 10351 | __end_cc_report 21:19:09 INFO - PROCESS | 10351 | __startTimestamp1452403149442__endTimestamp 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | ------- Summary: start ------- 21:19:09 INFO - PROCESS | 10351 | Number of tests: 14 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:4.83 (4.3%) stddev-sans-first:5.12 21:19:09 INFO - PROCESS | 10351 | Values: 110.0 112.0 105.0 110.0 112.0 113.0 100.0 112.0 110.0 118.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#1] audio-beat-detection Cycles:10 Average:150.90 Median:154.50 stddev:15.03 (9.7%) stddev-sans-first:15.83 21:19:09 INFO - PROCESS | 10351 | Values: 156.0 138.0 155.0 174.0 138.0 154.0 153.0 139.0 173.0 129.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.99 (0.6%) stddev-sans-first:1.05 21:19:09 INFO - PROCESS | 10351 | Values: 161.0 159.0 162.0 161.0 161.0 160.0 162.0 162.0 162.0 161.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#3] audio-fft Cycles:10 Average:81.70 Median:74.00 stddev:13.23 (17.9%) stddev-sans-first:13.66 21:19:09 INFO - PROCESS | 10351 | Values: 73.0 73.0 84.0 92.0 75.0 72.0 72.0 112.0 91.0 73.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:96.00 stddev:19.92 (20.7%) stddev-sans-first:20.66 21:19:09 INFO - PROCESS | 10351 | Values: 97.0 98.0 140.0 96.0 96.0 96.0 139.0 97.0 96.0 134.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 21:19:09 INFO - PROCESS | 10351 | Values: 109.0 109.0 109.0 109.0 109.0 110.0 109.0 109.0 109.0 110.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 21:19:09 INFO - PROCESS | 10351 | Values: 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 21:19:09 INFO - PROCESS | 10351 | Values: 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#8] json-parse-financial Cycles:10 Average:70.60 Median:71.00 stddev:2.88 (4.0%) stddev-sans-first:2.99 21:19:09 INFO - PROCESS | 10351 | Values: 69.0 71.0 71.0 69.0 70.0 71.0 71.0 78.0 68.0 68.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 21:19:09 INFO - PROCESS | 10351 | Values: 68.0 68.0 68.0 67.0 67.0 68.0 68.0 67.0 68.0 68.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.00 stddev:3.31 (3.9%) stddev-sans-first:3.44 21:19:09 INFO - PROCESS | 10351 | Values: 83.0 83.0 91.0 91.0 83.0 84.0 83.0 82.0 84.0 85.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#11] stanford-crypto-ccm Cycles:10 Average:125.80 Median:126.50 stddev:5.96 (4.7%) stddev-sans-first:6.27 21:19:09 INFO - PROCESS | 10351 | Values: 128.0 127.0 126.0 122.0 126.0 139.0 121.0 118.0 121.0 130.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.20 Median:150.50 stddev:5.83 (3.9%) stddev-sans-first:5.57 21:19:09 INFO - PROCESS | 10351 | Values: 140.0 153.0 150.0 152.0 150.0 138.0 151.0 151.0 148.0 139.0 21:19:09 INFO - PROCESS | 10351 | 21:19:09 INFO - PROCESS | 10351 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.00 Median:72.00 stddev:1.33 (1.9%) stddev-sans-first:1.20 21:19:09 INFO - PROCESS | 10351 | Values: 74.0 70.0 74.0 72.0 71.0 71.0 72.0 71.0 73.0 72.0 21:19:09 INFO - PROCESS | 10351 | -------- Summary: end -------- 21:19:09 INFO - PROCESS | 10351 | 21:19:10 INFO - TEST-INFO | 10351: exit 0 21:19:10 INFO - TEST-OK | kraken | took 60628ms 21:19:10 INFO - TEST-START | v8_7 21:19:10 INFO - operating with platform_type : linux_ 21:19:10 INFO - Initialising browser for v8_7 test... 21:19:10 INFO - TEST-INFO | started process 10599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt61meN/profile http://localhost:49404/getInfo.html) 21:19:14 INFO - PROCESS | 10599 | __metrics Screen width/height:1600/1200 21:19:14 INFO - PROCESS | 10599 | colorDepth:24 21:19:14 INFO - PROCESS | 10599 | Browser inner width/height: 1024/697 21:19:14 INFO - PROCESS | 10599 | __metrics 21:19:14 INFO - PROCESS | 10599 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 21:19:14 INFO - PROCESS | 10599 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:19:15 INFO - TEST-INFO | 10599: exit 0 21:19:15 INFO - Browser initialized. 21:19:15 INFO - Running cycle 1/1 for v8_7 test... 21:19:15 INFO - TEST-INFO | started process 10684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpt61meN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:19:27 INFO - PROCESS | 10684 | RSS: Main: 148963328 21:19:27 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | Cycle 1(1): loaded http://localhost:49404/tests/v8_7/run.html (next: http://localhost:49404/tests/v8_7/run.html) 21:19:50 INFO - PROCESS | 10684 | RSS: Main: 447504384 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | __start_tp_report 21:19:50 INFO - PROCESS | 10684 | _x_x_mozilla_page_load 21:19:50 INFO - PROCESS | 10684 | _x_x_mozilla_page_load_details 21:19:50 INFO - PROCESS | 10684 | |i|pagename|runs| 21:19:50 INFO - PROCESS | 10684 | |0;Richards;167.2800267648043 21:19:50 INFO - PROCESS | 10684 | |1;DeltaBlue;186.9508319312021 21:19:50 INFO - PROCESS | 10684 | |2;Encrypt;279.4076557697681 21:19:50 INFO - PROCESS | 10684 | |3;Decrypt;5213.541666666667 21:19:50 INFO - PROCESS | 10684 | |4;RayTrace;1972.3865877712033 21:19:50 INFO - PROCESS | 10684 | |5;Earley;801.924619085806 21:19:50 INFO - PROCESS | 10684 | |6;Boyer;12228.915662650603 21:19:50 INFO - PROCESS | 10684 | |7;RegExp;44086.95652173913 21:19:50 INFO - PROCESS | 10684 | |8;Splay;595.605700712589 21:19:50 INFO - PROCESS | 10684 | |9;NavierStokes;4830.917874396136 21:19:50 INFO - PROCESS | 10684 | __end_tp_report 21:19:50 INFO - PROCESS | 10684 | __startTimestamp1452403190541__endTimestamp 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | ------- Summary: start ------- 21:19:50 INFO - PROCESS | 10684 | Number of tests: 10 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | [#0] Richards Cycles:1 Average:167.28 Median:167.28 stddev:0.00 (0.0%) 21:19:50 INFO - PROCESS | 10684 | Values: 167.3 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | [#1] DeltaBlue Cycles:1 Average:186.95 Median:186.95 stddev:0.00 (0.0%) 21:19:50 INFO - PROCESS | 10684 | Values: 187.0 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 21:19:50 INFO - PROCESS | 10684 | Values: 279.4 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | [#3] Decrypt Cycles:1 Average:5213.54 Median:5213.54 stddev:0.00 (0.0%) 21:19:50 INFO - PROCESS | 10684 | Values: 5213.5 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 21:19:50 INFO - PROCESS | 10684 | Values: 1972.4 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | [#5] Earley Cycles:1 Average:801.92 Median:801.92 stddev:0.00 (0.0%) 21:19:50 INFO - PROCESS | 10684 | Values: 801.9 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | [#6] Boyer Cycles:1 Average:12228.92 Median:12228.92 stddev:0.00 (0.0%) 21:19:50 INFO - PROCESS | 10684 | Values: 12228.9 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | [#7] RegExp Cycles:1 Average:44086.96 Median:44086.96 stddev:0.00 (0.0%) 21:19:50 INFO - PROCESS | 10684 | Values: 44087.0 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | [#8] Splay Cycles:1 Average:595.61 Median:595.61 stddev:0.00 (0.0%) 21:19:50 INFO - PROCESS | 10684 | Values: 595.6 21:19:50 INFO - PROCESS | 10684 | 21:19:50 INFO - PROCESS | 10684 | [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 21:19:50 INFO - PROCESS | 10684 | Values: 4830.9 21:19:50 INFO - PROCESS | 10684 | -------- Summary: end -------- 21:19:50 INFO - PROCESS | 10684 | 21:19:51 INFO - TEST-INFO | 10684: exit 0 21:19:51 INFO - TEST-OK | v8_7 | took 41005ms 21:19:51 INFO - SUITE-END | took 1218s 21:19:51 INFO - Completed test suite (00:20:18) 21:19:51 INFO - Working with test: dromaeo_css 21:19:51 INFO - Generating results file: dromaeo_css 21:19:51 INFO - Working with test: kraken 21:19:51 INFO - Generating results file: kraken 21:19:51 INFO - javascript benchmark 21:19:51 INFO - Working with test: v8_7 21:19:51 INFO - Generating results file: v8_7 21:19:51 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:19:51 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 21:19:51 INFO - process_Request line: dromaeo_css 6085.07 graph.html#tests=[[72,132,35]] 21:19:51 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:19:51 INFO - process_Request line: kraken 1531.80 graph.html#tests=[[232,132,35]] 21:19:51 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:19:51 INFO - process_Request line: v8_7 18848.65 graph.html#tests=[[230,132,35]] 21:19:51 INFO - RETURN: dromaeo_css: 6085.07 21:19:51 INFO - RETURN: kraken: 1531.80 21:19:51 INFO - RETURN: v8_7: 18848.65 21:19:51 INFO - javascript benchmark 21:19:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2571.074413211244, 2681.235847783381, 2694.6496955395796, 2700.6489156409666, 2705.377763114483, 4403.0973650401675, 4531.7054391464535, 4532.750698711569, 4541.2733962566, 4550.63594912407, 4470.8882277942985, 4518.847693838066, 4527.592516673499, 4579.335996280537, 4644.5587669171455, 3989.52125744911, 4115.259253334399, 4164.083901541656, 4187.350960601104, 4350.282203436429, 4044.5348784889675, 4270.67969902257, 4297.742135471866, 4319.200947824646, 4326.870193894189, 4120.773357465338, 4144.378343248507, 4151.91696166078, 4204.915901681949, 4239.364095385686, 4208.789560521992, 4215.178040282146, 4215.3887686285625, 4217.97891010543, 4260.233158031553, 4187.51843537994, 4201.621854033121, 4204.327307630795, 4221.197972385237, 4238.5761423857675, 4359.149965756678, 4441.555844415532, 4480.417545719069, 4482.350059241392, 4546.089803741466, 4874.049560335736, 4874.122657921573, 4876.146674331978, 4878.975605121987, 4897.0, 4891.364122664031, 4900.338454308659, 4911.68074075184, 4912.312276281324, 4936.950630493721, 4351.064521128004, 4446.42196514451, 4452.910941781146, 4462.687611867138, 4580.221362368406, 4987.750612469362, 4995.675281106716, 4995.925061124086, 4998.475160108209, 5015.122353588181, 4796.112719146969, 4800.495947925488, 4805.063012712488, 4805.8558243252755, 4843.297721830315, 4748.596369308579, 4784.6889952153, 4855.5387238212315, 4860.4896485869185, 4879.487653796371, 4853.466118726938, 4862.367892173995, 4871.780769865364, 4887.3890763654545, 4903.215485522299, 4836.347093142451, 4838.177509823338, 4839.806407743651, 4845.878853028703, 4878.317035615017, 3937.9015524612114, 3994.380870965005, 4028.073543085107, 4030.4760381150263, 4087.2029954159248, 3594.2092739597247, 3605.549306336708, 3614.2771445710964, 3625.6736893679167, 3638.9818050909576, 4213.1784302061415, 4218.599233072853, 4220.451341325669, 4223.1553689261655, 4252.702310838212, 4683.063387322549, 4779.259214821708, 4819.614430845524, 4875.34182885313, 4883.487233840467, 4154.231467178582, 4182.1844740275965, 4182.498100227992, 4199.286121359376, 4220.556841531657, 4302.053548219386, 4317.460317460317, 4326.394304797331, 4344.717593356421, 4352.434183556117, 4464.620507256855, 4566.977165114153, 4575.839845605387, 4631.4905360411, 4636.39726835516, 4792.0, 4811.350467686818, 4811.422629284508, 4858.0, 4861.440934292602, 4580.267157254823, 4581.518940511199, 4581.518940511199, 4622.514635963175, 4648.1168577970075, 4620.5379462053525, 4727.57451829337, 4727.810887564459, 4743.454502732092, 4773.3555969945, 4826.8069277228515, 4891.364122664031, 4899.11815873132, 4900.681455705368, 4915.508449155056, 4743.430788305425, 4745.0509898019845, 4757.119932812441, 4766.451858036232, 4782.521747825329, 4540.954590454186, 4647.628189744744, 4650.116477869194, 4760.262159365304, 4796.472388037383, 4555.40779698637, 4609.631229501699, 4612.377329060668, 4629.305604159403, 4671.906561868675, 4734.479207287264, 4735.313379559876, 4746.7863946121815, 4772.117158325721, 4772.49888761675, 4501.212287849678, 4606.723596584216, 4610.5389461054965, 4645.09420662981, 4686.390769199982], "unit": "score", "name": "dojo.html", "value": 4458.743287909352}, {"lowerIsBetter": false, "replicates": [490.5707505932309, 493.9407271127465, 496.50101647843934, 510.55836701253406, 520.6459607466926, 24139.396515087108, 25044.624330635033, 32541.51187732186, 33225.667743322556, 33226.66773332266, 34946.650533494656, 35337.0, 35404.0, 35438.64561354386, 35454.645453545454, 6791.286914873941, 7550.84898302035, 7754.7673569793, 7778.64996075178, 7780.377569794431, 6834.282400347966, 9597.280203984694, 9837.508124593778, 9837.55730992107, 9841.26190535709, 9695.175910047654, 9783.41299522031, 9783.95108024459, 9785.412875227508, 9796.461194634328, 6916.896246556305, 7080.29197080293, 9566.0, 9667.081627245401, 9694.272929530314, 9488.857667134998, 9661.613535458573, 9664.71005869825, 9668.75828104303, 9678.0, 33236.335273294644, 33569.496457553156, 33638.32723345544, 33672.83163584191, 33694.663053369644, 2846.886124555015, 2883.884644614213, 2954.1875984104327, 3014.050574069161, 3449.793012419263, 25867.74132258672, 26045.609315860278, 28438.715612844022, 28672.569911451345, 28900.710992890014, 3355.8154301513405, 3460.9826950865086, 3471.1322169457635, 3496.30073985204, 3574.231540218839, 219797.0, 220101.0, 220979.0, 221112.8944355284, 221211.0, 46369.53630463719, 47522.762386187846, 49137.26294105591, 54489.72755136278, 55534.444655553736, 48152.27771583429, 48161.0, 48190.831412586514, 48405.0, 48485.5151448481, 15073.170975596227, 15442.305096270695, 15448.073115613099, 15464.381424742884, 15532.689346213012, 10458.058774710313, 10468.371897686164, 10469.738256543647, 10480.528376223088, 10516.474176291154, 18615.81384186168, 18750.906245468686, 18778.53053673669, 18834.905825470785, 18856.905715471334, 6540.313267106981, 6793.252742198354, 6829.453643708492, 6875.106236189264, 6935.167779866449, 746.1978373248671, 776.3168411797582, 814.4298990706411, 825.8307047055339, 935.102301790289, 25612.743872561037, 25931.611025834627, 26009.609855852177, 26114.086006989663, 26135.215943521725, 900.1358695652116, 906.582971832951, 913.2739472119681, 926.9212116969999, 964.2093483343591, 13359.1316564423, 13522.0, 13658.795118073236, 13716.519921802888, 13750.381232844546, 357009.0, 370911.0, 372508.0, 373526.0, 374074.0, 41895.0, 42236.78881605634, 42289.57710422918, 42338.57661423346, 42371.7881410591, 1189.7025743564109, 1191.5948577483698, 1191.773563023023, 1195.5994741761608, 1329.2423318708436, 24202.140950934267, 24996.0, 25206.49587008286, 25541.744582553936, 25555.616665749658, 37295.0, 37604.81197593995, 37679.24641507209, 37725.62274377221, 37749.0, 211132.0, 216823.0, 333744.0, 346222.0, 346471.0, 27869.72130278671, 28090.2977425566, 28168.71831281661, 28223.57664635073, 28238.294042648275, 38114.42828357632, 39152.80423597864, 39801.40297895476, 39806.60193398029, 40103.3984490227, 32341.5614408692, 33039.66960330462, 33482.83258583691, 34071.148221294665, 34096.14759631029, 32847.0, 32965.17587060342, 33392.33215335728, 33681.663183367855, 33807.3238535223, 32707.509387358732, 32990.0, 33216.66783332136, 33932.49101263532, 34229.65770342265, 25123.0, 26861.597076043483, 26939.865300673373, 26993.59509607397, 27093.080092172302, 21609.567808644053, 22157.335279941628, 22169.0, 22360.32919012432, 22431.439214019127], "unit": "score", "name": "ext.html", "value": 16717.13611193285}, {"lowerIsBetter": false, "replicates": [311.75215703515704, 316.4620145752221, 324.45329619590984, 326.53468806950104, 331.86725309876044, 11259.0, 11728.12039097067, 13901.0, 13985.93007034966, 14403.279836008196, 11536.769264614702, 13687.24720140392, 14079.92960035201, 15255.313510892009, 15277.312520936557, 4696.53034696531, 4787.04013503189, 4967.801287948478, 4978.502149785028, 5032.723200223986, 3626.256617393441, 3745.62543745626, 4816.229403295473, 4919.508049195088, 5468.671879687232, 5651.2935883014625, 5666.433356664342, 5681.176229446728, 5690.800821971232, 5695.74369153387, 5433.266509021271, 5736.598438109334, 5736.684482353469, 5737.77048918047, 5740.8851822963725, 4842.080004799112, 4931.65478416511, 4934.506549345073, 4955.578775804061, 4960.826371077031, 17716.114194290232, 17985.0, 18192.727109093375, 18215.08924553767, 18248.543786405313, 1691.0868131209131, 1707.538964479596, 1866.803985581508, 1960.0199900049975, 2010.316492392579, 11792.35142067186, 11892.108091893142, 12015.579454719043, 12161.635150945485, 12266.877331226662, 1682.697114519386, 1693.0045093579142, 1698.2867195777803, 1706.0872433248276, 1771.929122835085, 47688.52311476875, 48457.75771121157, 48557.27164092541, 49120.75439622815, 50201.995960080596, 8198.139195384518, 8315.0, 8589.184027517376, 8670.696525621574, 8675.305975521944, 10478.161747060218, 10542.683719488428, 10561.260711750103, 10576.20678449104, 10620.840687389695, 6951.443884489228, 6959.791206263821, 6985.336393042653, 6999.545029573062, 7083.114610673666, 6863.862722745517, 6888.483363747739, 6932.584044957319, 6932.6533673316135, 6941.167059952838, 5250.317458730417, 5294.841154765363, 5307.867303317448, 5323.228131920927, 5345.7594408251725, 1426.6718654709268, 1462.2542503323168, 1471.977920331196, 1525.9160746158846, 1534.7928029716068, 810.4731924249285, 867.2671592504324, 877.4077497689034, 988.5847943863595, 991.2565575818137, 12732.618021459371, 14204.36080376365, 14864.405423783144, 14962.251887405804, 16514.75227871583, 789.3409003482042, 806.4193780478047, 808.6967387229789, 900.1403659505157, 913.7852604637905, 8273.793155171168, 8599.699010534601, 8661.956690216508, 8738.21356077956, 8871.866921996176, 463382.0, 466004.0, 467138.0, 467721.0, 480824.0, 60148.0, 61274.0, 62434.0, 62678.0, 69175.30824691789, 457.72536478112863, 469.3476068265114, 469.73459995102655, 471.3989663179474, 474.27909577442097, 8810.163034511712, 9002.549872506217, 9180.311476639412, 9352.485613291334, 9407.341486096182, 30773.692263077082, 31300.686993129777, 31578.684213157576, 31832.52251216187, 31877.840610797724, 39202.411963821134, 41185.0, 41246.58753412427, 41264.1289976239, 41317.793411032755, 6388.584741991755, 6583.539152259296, 6646.501512386493, 6694.966525167538, 6725.49558783103, 7037.190723066913, 8469.74590762278, 9129.406588571721, 9904.900950990686, 10020.69937901864, 7318.414526837947, 7407.333339999426, 7577.355924746458, 7620.31417172435, 7693.923060769321, 8146.952885753899, 8273.172682731678, 8292.968222785456, 8470.703525376583, 8546.401751877558, 7950.40371972116, 8381.53901535397, 8417.200365965224, 8423.410361274651, 8482.109378515168, 6669.533132680665, 6688.665566721547, 6691.330866913269, 6710.16122984627, 6725.764598239038, 6553.5084868634085, 8067.354611630938, 8223.342132629496, 8296.543690097102, 8370.414071014971], "unit": "score", "name": "jquery.html", "value": 7164.2218478885015}, {"lowerIsBetter": false, "replicates": [1240.144300432702, 1389.84711681715, 1398.5804258722385, 1515.6665533582616, 1735.3232239426618, 6188.628682279061, 7120.216776154625, 7229.240929702384, 7265.382442492394, 7284.854302913938, 7130.9643451782795, 7346.632668366587, 7346.742863999761, 7349.853002939938, 7357.779266621997, 1753.684336819372, 1790.8119647437027, 2107.2940564910696, 2135.0712440088573, 2169.40341406113, 2132.5308432144902, 2142.946426339346, 2145.7746936571593, 2146.7638559758493, 2146.796054374832, 2080.0223894769433, 2119.8304135669187, 2129.4995676016124, 2132.936011919645, 2133.8292936565117, 2095.413284280389, 2107.2940564910696, 2114.30228024753, 2115.619188546061, 2131.2540610786255, 2121.3105740634355, 2127.3405244374294, 2153.4078128514625, 2153.7307836520436, 2155.935321940329, 7380.225076367012, 7460.03019607453, 7460.701571937116, 7461.365783908374, 7482.363999060087, 4280.272353699847, 4355.477342718894, 4368.301071828492, 4394.143142087294, 4398.3842262083335, 2843.402885394049, 2862.4418238443513, 2897.5798509216047, 2916.431295897301, 3010.1872494426602, 918.9264858811279, 921.4977837078808, 935.8455854783953, 956.4787190980932, 960.7742180587557, 10298.176145908385, 10433.947830260877, 10454.529546170364, 10474.528646210863, 10487.947560262226, 4101.91796164075, 4103.692223083281, 4164.83340666376, 4170.270202714512, 4175.582441755861, 9060.682876099305, 9071.727848164566, 9072.8639070414, 9076.500792456347, 9088.318376121817, 4512.684112112121, 4531.3882625845745, 4541.68208225421, 4545.181867263858, 4546.499885012646, 4026.456428382131, 4059.7361171523758, 4062.7765472899273, 4067.084905896209, 4074.8777536673947, 3158.494640857452, 3239.5626590410466, 3399.354122716676, 3470.479428085757, 3546.2021045265124, 1124.3310230412892, 1138.5218208352512, 1143.3368646185193, 1151.7984352738406, 1155.5839897636845, 1075.499892549968, 1171.2328424881716, 1172.4489489939715, 1177.664365655784, 1206.9879301207052, 6824.761133360308, 6912.170539535288, 6914.757983470555, 6945.791626251221, 6951.89572156418, 1000.0899181744722, 1012.488693209939, 1024.7335692719946, 1038.1227862456212, 1042.7653777899911, 5414.052540805344, 5437.211604317431, 5523.364813046471, 5538.418466061086, 5546.528545073633, 8905.109489051043, 9080.364374493854, 9187.862182067274, 9226.354155209205, 9233.215176710055, 8898.332625053146, 9259.953700231456, 9264.25885929124, 9269.026752191057, 9278.396904201205, 7295.744648937261, 7298.635068246566, 7321.304476074764, 7373.5207211530005, 7377.557346559223, 6732.528722989344, 6896.586204827727, 6908.171019477494, 6913.0667359905765, 6914.55055421396, 7603.239676032353, 7828.178041305809, 7850.646720897459, 7947.761567152995, 8031.959840200761, 7894.092179399213, 8149.9185008151535, 8178.100408955129, 8201.13888041771, 8383.161683831568, 6874.725010999504, 7012.649367531501, 7031.542949708252, 7033.613151276729, 7041.718331266692, 6722.394984451423, 6888.690008949709, 6898.310168983062, 6898.655067246718, 6905.516613836983, 6369.554131210771, 6471.06169605414, 6516.967415162894, 6559.27847936717, 6636.070950067091, 6297.433231009231, 6359.586626869239, 6371.93628063732, 6499.545031847725, 6513.576617519846, 6561.179852518435, 6589.868202635825, 6628.734850605922, 6790.728370865308, 6809.489288303496, 6014.849628759316, 6061.333253342217, 6066.332703402711, 6067.878642427215, 6074.149619053248, 6176.4441200292185, 6377.96811015942, 6380.808575742735, 6393.744250230125, 6395.5203359747275], "unit": "score", "name": "mootools.html", "value": 4264.384794482903}, {"lowerIsBetter": false, "replicates": [295.8165937118985, 304.32288158846563, 310.4536016610765, 312.1696287874253, 318.4681581758463, 5130.512601302875, 5208.427073021964, 5302.575793936486, 5312.73436328184, 5323.89352212956, 5161.458046905077, 5237.607179461536, 5238.030964271603, 5239.0, 5246.029484545352, 3856.3058649443087, 3942.980285098585, 4082.3060079786505, 4087.9780054986254, 4089.754614723126, 3936.075022369741, 4022.9597704022876, 4039.1921615676833, 4052.452918855961, 4065.8170382332864, 4021.3766866135797, 4022.0950286185666, 4022.1151346703823, 4026.3557830747086, 4033.536143343509, 3815.8092095395396, 3870.2453021660785, 3936.76379417233, 3971.7616942983514, 4015.056461731491, 3480.878169264089, 3486.1633208030144, 3487.2851065531504, 3492.1967947372245, 3497.422925217336, 4893.926591101136, 4966.950330496685, 4990.151674215355, 4990.600751939873, 4992.425871024842, 4600.907981840344, 4616.907661846778, 4620.792064357112, 4623.398958135454, 4629.86110416688, 5292.735363231823, 5420.4850539198715, 5430.239766432703, 5438.293021907166, 5443.292371991655, 3823.770573765583, 3830.8467661293516, 3838.9424158637644, 3839.2705385976574, 3844.269588778151, 5617.297837770278, 5696.0, 5698.51562617178, 5711.02912504871, 5714.828555143353, 3942.9605703943166, 3961.58403367648, 3961.742486738353, 3962.7027972902147, 3965.4844870166694, 3887.7084218683713, 4015.0, 4016.6385025347276, 4022.4770779798437, 4024.4768180136393, 4567.794449249792, 4570.634349252052, 4573.902263456813, 4576.153411618861, 4577.473590537064, 5428.891422171613, 5435.83692489226, 5442.047641662693, 5442.374126975369, 5442.428545002717, 1404.8876089912783, 1421.5735279416133, 1422.139605538655, 1422.50923431416, 1422.7083447893158, 959.0361686505017, 960.2605993385055, 962.3351601729048, 982.1455333859587, 983.0660872171466, 4784.162771515041, 4790.329353890458, 4792.2332426811545, 4792.592629626451, 4796.2565802300005, 5644.0, 5652.18043383707, 5653.23681303027, 5654.943450565524, 5658.236138121301, 4781.115493633689, 4784.162771514971, 4792.376990991149, 4793.209120495079, 4799.3041009053495, 2805.438912217565, 2897.2322334581354, 3026.016544623006, 3040.5135178371356, 3048.5579590959187, 5300.363956325188, 5389.9191512127345, 5445.346558412936, 5460.535854452416, 5465.988792073479, 5871.647701137946, 5875.529957603467, 5882.088276317178, 5882.411758824169, 5886.558508111909, 5453.563714902798, 5459.5359394451125, 5466.781328746805, 5470.72646367672, 5472.932778108231, 5495.697736624524, 5645.4072322405555, 5648.57635677334, 5713.9428605715075, 5724.284464441945, 5521.475459831309, 5522.5858060646415, 5531.446855314436, 5606.355269144101, 5609.5512359012, 5433.782648694166, 5460.399356070909, 5470.152126420411, 5474.589405794661, 5475.206095116266, 4059.1475790084414, 4103.528094269197, 4106.7946602670345, 4107.958920410758, 4109.3425051991535, 5529.917051244154, 5648.322201335702, 5651.491365777099, 5662.0, 5664.773409063756, 5412.648177868426, 5445.646033007842, 5454.127339625641, 5461.781528738806, 5471.206675032018, 5451.754671039734, 5457.890842183214, 5458.344998600193, 5458.4814442627885, 5462.972685136708, 5214.061468935476, 5346.0, 5347.545458636059, 5355.25026496283, 5359.169328754049, 5476.972615137058, 5480.3971563127225, 5482.671039737628, 5483.5064844162625, 5484.314460692413, 5127.435982042047, 5225.197306929103, 5258.8159414420315, 5338.866528336823, 5410.080286351408], "unit": "score", "name": "prototype.html", "value": 4117.218618981814}, {"lowerIsBetter": false, "replicates": [761.2197497564997, 768.2279309294158, 769.1769806307253, 795.7214974758831, 809.2393150438584, 12419.68950776231, 12596.622101336952, 12662.176958497703, 12685.302308373035, 12689.873101269008, 12215.389230538482, 12295.262284262928, 12299.569515066974, 12300.753984920297, 12317.507299708024, 602.4728362682653, 612.0543759890957, 773.4083426178963, 790.0637744273055, 792.2473650032492, 757.8787394016958, 767.029707420114, 772.119783446871, 772.8106613879607, 773.872311068673, 814.9429539932207, 823.4153750836883, 824.3405275779382, 824.5506199121493, 825.2655136928139, 639.2935805934445, 647.1780838335288, 648.4261428635645, 788.7554857993982, 816.2531283875247, 588.2529187931303, 590.9261342332209, 593.9732712027969, 594.9791757288474, 595.1043679262682, 11428.028617567517, 11496.540138394454, 11530.423478826026, 11536.0, 11561.0, 10558.155347572252, 10692.625758098508, 10816.296940698829, 10953.397563134024, 11224.270422422598, 9327.953360233223, 9532.809343813155, 9631.181349585293, 9646.469444180568, 9677.322587418883, 3123.107019791257, 3166.651668316483, 3173.4605117130145, 3203.3913556424204, 3224.4034853551934, 37400.62599373999, 37563.62436375629, 37925.62074379248, 37951.81024094889, 38081.619183808085, 8763.824723505495, 8966.491282163593, 9000.63997440095, 9023.0, 9120.726378208665, 15591.454299099703, 15602.765958510632, 15610.3755849767, 15627.296771645304, 15631.609209769847, 6251.874962500725, 6312.684365781693, 6411.5832470889245, 6446.161998940108, 6559.24568674599, 3485.0, 3599.3341231872187, 3612.3858943979585, 3627.818609069536, 3657.250263695936, 2582.134984780082, 2640.4983053219826, 2649.0463433164045, 2649.2317228003662, 2649.4038841260563, 466.92295771198053, 473.73234122720555, 480.18368773085894, 481.40786832196596, 481.5714014527074, 429.28095440137645, 461.16759249554207, 508.5219893300286, 512.8282025521418, 570.6319423971515, 8115.840719011359, 8324.958375208085, 8334.458260213067, 8415.863858379164, 8472.872906906401, 419.9287903772953, 442.6635756824836, 524.2738806752675, 585.318104408368, 590.4774274766777, 3460.602030766444, 3689.5572531296416, 3694.094946738013, 3698.815059247027, 3737.3272810893754, 46038.769806150754, 47163.5283647166, 48423.5157648419, 49365.75317123463, 49582.0, 42785.786071069444, 42835.7858210707, 43216.13567728628, 43265.78367108207, 43374.783126084796, 37739.24521509554, 38353.0, 39035.609643903765, 39534.406983895264, 39722.801385993465, 7311.41508679315, 7388.187299397169, 7488.400927925644, 7520.548767073993, 7589.924100759143, 28763.28091797722, 28864.0, 28982.565261521515, 29245.85377073101, 29854.0, 34865.65134348624, 35080.47379289262, 36044.27911441809, 38468.807655961544, 38580.42129368118, 8239.299659529008, 8888.0, 8926.86609700842, 9030.0, 9119.088091190828, 9479.241660666992, 9550.140487356171, 9633.08485693858, 9686.70939871805, 9880.0, 8615.396922215385, 8877.600507977028, 8922.776930576787, 9212.861807073034, 9329.626814927327, 8939.106089391009, 8965.282777377664, 9070.455772653662, 9079.727608171765, 9277.67528136512, 8715.172058654418, 8823.382363234512, 9014.549272536478, 9141.862872057058, 9324.720258392259, 7429.182789893, 7535.773926782205, 7683.500572462772, 7703.768886933401, 7991.28078472917, 7636.389088872988, 7961.482503637245, 8033.959830200812, 8053.114157442559, 8131.83736325282], "unit": "score", "name": "yui.html", "value": 5414.347766929285}], "name": "dromaeo_css", "value": 6085.069219103072}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 105.0, 110.0, 112.0, 113.0, 100.0, 112.0, 110.0, 118.0], "unit": "score", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [156.0, 138.0, 155.0, 174.0, 138.0, 154.0, 153.0, 139.0, 173.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [161.0, 159.0, 162.0, 161.0, 161.0, 160.0, 162.0, 162.0, 162.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.1}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 84.0, 92.0, 75.0, 72.0, 72.0, 112.0, 91.0, 73.0], "unit": "score", "name": "audio-fft", "value": 81.7}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 140.0, 96.0, 96.0, 96.0, 139.0, 97.0, 96.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 71.0, 69.0, 70.0, 71.0, 71.0, 78.0, 68.0, 68.0], "unit": "score", "name": "json-parse-financial", "value": 70.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 67.0, 67.0, 68.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 91.0, 91.0, 83.0, 84.0, 83.0, 82.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [128.0, 127.0, 126.0, 122.0, 126.0, 139.0, 121.0, 118.0, 121.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.8}, {"lowerIsBetter": true, "replicates": [140.0, 153.0, 150.0, 152.0, 150.0, 138.0, 151.0, 151.0, 148.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.2}, {"lowerIsBetter": true, "replicates": [74.0, 70.0, 74.0, 72.0, 71.0, 71.0, 72.0, 71.0, 73.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.0}], "name": "kraken", "value": 1531.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.2800267648043], "unit": "score", "name": "Richards", "value": 211.03535600000004}, {"lowerIsBetter": false, "replicates": [186.9508319312021], "unit": "score", "name": "DeltaBlue", "value": 353.66518199999996}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5213.541666666667], "unit": "score", "name": "Decrypt", "value": 51.05569630369634}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [801.924619085806], "unit": "score", "name": "Earley", "value": 831.079361}, {"lowerIsBetter": false, "replicates": [12228.915662650603], "unit": "score", "name": "Boyer", "value": 54.498944827586165}, {"lowerIsBetter": false, "replicates": [44086.95652173913], "unit": "score", "name": "RegExp", "value": 20.663367850098613}, {"lowerIsBetter": false, "replicates": [595.605700712589], "unit": "score", "name": "Splay", "value": 136.82038285144571}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 18848.6527724664}]} 21:19:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "18848.65"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1531.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6085.07"}}} 21:19:51 INFO - Return code: 0 21:19:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 21:19:51 INFO - # TBPL SUCCESS # 21:19:51 INFO - Running post-action listener: _resource_record_post_action 21:19:51 INFO - Running post-run listener: _resource_record_post_run 21:19:52 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 541233152; Read time: 0; Write time: 368892 21:19:52 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 168153088; Read time: 0; Write time: 140192 21:19:52 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 318246912; Read time: 0; Write time: 190996 21:19:52 INFO - Running post-run listener: _upload_blobber_files 21:19:52 INFO - Blob upload gear active. 21:19:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:19:52 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 21:19:52 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'] 21:19:52 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 21:19:53 INFO - (blobuploader) - INFO - Open directory for files ... 21:19:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:19:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:19:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:53 INFO - (blobuploader) - INFO - Done attempting. 21:19:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:19:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:19:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:19:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:19:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:19:54 INFO - (blobuploader) - INFO - Done attempting. 21:19:54 INFO - (blobuploader) - INFO - Iteration through files over. 21:19:54 INFO - Return code: 0 21:19:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:19:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:19:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fe6ee8c63d05b20aa9d015871fded20f4eae5803c224a9b06b3ad5ab4dcc9baa9906ceb346242e4362048b9fa0d86a46c7f5fbaa0114c284e08d22f66f0baac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87b28ac0a5bdc6ad22416eaaca695b3d9713e4d0fb5a44bdba92621f4e9dfedd202969d36d2f5ec7d61bf5a8b0e6cbd9427b1cb5cc6d80593594eed2c255440c"} 21:19:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:19:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:19:54 INFO - Contents: 21:19:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2fe6ee8c63d05b20aa9d015871fded20f4eae5803c224a9b06b3ad5ab4dcc9baa9906ceb346242e4362048b9fa0d86a46c7f5fbaa0114c284e08d22f66f0baac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87b28ac0a5bdc6ad22416eaaca695b3d9713e4d0fb5a44bdba92621f4e9dfedd202969d36d2f5ec7d61bf5a8b0e6cbd9427b1cb5cc6d80593594eed2c255440c"} 21:19:54 INFO - Copying logs to upload dir... 21:19:54 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1288.144179 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2016-01-09 21:19:54.169278) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 21:19:54.174095) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808 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/2fe6ee8c63d05b20aa9d015871fded20f4eae5803c224a9b06b3ad5ab4dcc9baa9906ceb346242e4362048b9fa0d86a46c7f5fbaa0114c284e08d22f66f0baac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87b28ac0a5bdc6ad22416eaaca695b3d9713e4d0fb5a44bdba92621f4e9dfedd202969d36d2f5ec7d61bf5a8b0e6cbd9427b1cb5cc6d80593594eed2c255440c"} build_url:https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011412 build_url: 'https://queue.taskcluster.net/v1/task/BQ4sniRISc2FCX6ktKM4RQ/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/2fe6ee8c63d05b20aa9d015871fded20f4eae5803c224a9b06b3ad5ab4dcc9baa9906ceb346242e4362048b9fa0d86a46c7f5fbaa0114c284e08d22f66f0baac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/87b28ac0a5bdc6ad22416eaaca695b3d9713e4d0fb5a44bdba92621f4e9dfedd202969d36d2f5ec7d61bf5a8b0e6cbd9427b1cb5cc6d80593594eed2c255440c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-09 21:19:54.201444) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 21:19:54.201800) ========= 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=e31afd3c0f0de4e86ebe4d94000001b5-1452399947.465647-1932459808 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-09 21:19:54.282733) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 21:19:54.283075) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-09 21:19:54.283361) ========= ========= Total master_lag: 0.38 =========