builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-038 starttime: 1452547910.51 results: success (0) buildid: 20160111130128 builduid: d6e9c244d6e4485e953f971bf82409d2 revision: 250c5bf5634e9ca85c4b96ba3a8aab07a665f915 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.508196) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.508746) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.509083) ========= 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=8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004405 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.547540) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.547878) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.564737) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.565033) ========= 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=8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004525 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.614990) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.615337) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.615782) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.616118) ========= 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=8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-11 13:31:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-01-11 13:31:50 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.247670 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.876566) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:50.876934) ========= 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=8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.203381 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:51.090399) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:51.090830) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 250c5bf5634e9ca85c4b96ba3a8aab07a665f915 --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 250c5bf5634e9ca85c4b96ba3a8aab07a665f915 --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=8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-11 13:31:51,090 truncating revision to first 12 chars 2016-01-11 13:31:51,090 Setting DEBUG logging. 2016-01-11 13:31:51,090 attempt 1/10 2016-01-11 13:31:51,090 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/250c5bf5634e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-11 13:31:51,371 unpacking tar archive at: fx-team-250c5bf5634e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.600725 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:51.703807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:51.704159) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:51.711900) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:51.713718) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-11 13:31:51.714265) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-01-11 13:31:51.714903) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:31:51 INFO - MultiFileLogger online at 20160111 13:31:51 in /builds/slave/test 13:31:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 13:31:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:31:51 INFO - {'append_to_log': False, 13:31:51 INFO - 'base_work_dir': '/builds/slave/test', 13:31:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 13:31:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:31:51 INFO - 'branch': 'Fx-Team-Non-PGO', 13:31:51 INFO - 'buildbot_json_path': 'buildprops.json', 13:31:51 INFO - 'config_files': ('talos/linux_config.py',), 13:31:51 INFO - 'default_actions': ('clobber', 13:31:51 INFO - 'read-buildbot-config', 13:31:51 INFO - 'download-and-extract', 13:31:51 INFO - 'populate-webroot', 13:31:51 INFO - 'create-virtualenv', 13:31:51 INFO - 'install', 13:31:51 INFO - 'run-tests'), 13:31:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:31:51 INFO - 'download_minidump_stackwalk': True, 13:31:51 INFO - 'download_symbols': 'ondemand', 13:31:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:31:51 INFO - 'tooltool.py': '/tools/tooltool.py', 13:31:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:31:51 INFO - '/tools/misc-python/virtualenv.py')}, 13:31:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:31:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:31:51 INFO - 'installer_path': 'installer.exe', 13:31:51 INFO - 'log_level': 'info', 13:31:51 INFO - 'log_name': 'talos', 13:31:51 INFO - 'log_to_console': True, 13:31:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:31:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:31:51 INFO - 'opt_config_files': (), 13:31:51 INFO - 'pip_index': False, 13:31:51 INFO - 'sps_profile': False, 13:31:51 INFO - 'sps_profile_interval': 0, 13:31:51 INFO - 'suite': 'dromaeojs-e10s', 13:31:51 INFO - 'system_bits': '32', 13:31:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:31:51 INFO - 'title': 'talos-linux64-ix-038', 13:31:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:31:51 INFO - 'use_talos_json': True, 13:31:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:31:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:31:51 INFO - 'work_dir': 'build'} 13:31:51 INFO - ##### 13:31:51 INFO - ##### Running clobber step. 13:31:51 INFO - ##### 13:31:51 INFO - Running pre-action listener: _resource_record_pre_action 13:31:51 INFO - Running main action method: clobber 13:31:51 INFO - rmtree: /builds/slave/test/build 13:31:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:31:54 INFO - Running post-action listener: _resource_record_post_action 13:31:54 INFO - ##### 13:31:54 INFO - ##### Running read-buildbot-config step. 13:31:54 INFO - ##### 13:31:54 INFO - Running pre-action listener: _resource_record_pre_action 13:31:54 INFO - Running main action method: read_buildbot_config 13:31:54 INFO - Using buildbot properties: 13:31:54 INFO - { 13:31:54 INFO - "project": "", 13:31:54 INFO - "product": "firefox", 13:31:54 INFO - "script_repo_revision": "production", 13:31:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 13:31:54 INFO - "repository": "", 13:31:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 13:31:54 INFO - "buildid": "20160111130128", 13:31:54 INFO - "pgo_build": "False", 13:31:54 INFO - "basedir": "/builds/slave/test", 13:31:54 INFO - "buildnumber": 630, 13:31:54 INFO - "slavename": "talos-linux64-ix-038", 13:31:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 13:31:54 INFO - "platform": "ubuntu64_hw", 13:31:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 13:31:54 INFO - "branch": "fx-team", 13:31:54 INFO - "repo_path": "integration/fx-team", 13:31:54 INFO - "revision": "250c5bf5634e9ca85c4b96ba3a8aab07a665f915", 13:31:54 INFO - "stage_platform": "linux64", 13:31:54 INFO - "builduid": "d6e9c244d6e4485e953f971bf82409d2", 13:31:54 INFO - "slavebuilddir": "test" 13:31:54 INFO - } 13:31:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 13:31:54 INFO - Running post-action listener: _resource_record_post_action 13:31:54 INFO - ##### 13:31:54 INFO - ##### Running download-and-extract step. 13:31:54 INFO - ##### 13:31:54 INFO - Running pre-action listener: _resource_record_pre_action 13:31:54 INFO - Running main action method: download_and_extract 13:31:54 INFO - mkdir: /builds/slave/test/build/tests 13:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:54 INFO - https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 13:31:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/test_packages.json 13:31:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/test_packages.json 13:31:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 13:31:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 13:31:55 INFO - Downloaded 1302 bytes. 13:31:55 INFO - Reading from file /builds/slave/test/build/test_packages.json 13:31:55 INFO - Using the following test package requirements: 13:31:55 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:31:55 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:31:55 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:55 INFO - u'jsshell-linux-x86_64.zip'], 13:31:55 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:31:55 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:31:55 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:31:55 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:31:55 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:31:55 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 13:31:55 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 13:31:55 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:31:55 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:55 INFO - https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:31:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:31:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:31:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/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 13:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/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 13:31:58 INFO - Downloaded 22756958 bytes. 13:31:58 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 13:31:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:31:58 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 13:31:59 INFO - Return code: 0 13:31:59 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 13:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:31:59 INFO - https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 13:31:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:31:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:31:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/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 13:31:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/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 13:32:02 INFO - Downloaded 22756958 bytes. 13:32:02 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 13:32:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 13:32:02 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 13:32:03 INFO - Return code: 0 13:32: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')]} 13:32:03 INFO - https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 13:32:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/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 13:32:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/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 13:32:05 INFO - Downloaded 11132285 bytes. 13:32:05 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 13:32:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 13:32:05 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 13:32:05 INFO - Return code: 0 13:32:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:05 INFO - https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 13:32:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:32:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:32:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/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 13:32:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NmTFIoJdR0qKaMH5JbGteQ/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 13:32:08 INFO - Downloaded 53748784 bytes. 13:32:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:32:08 INFO - mkdir: /builds/slave/test/properties 13:32:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:32:08 INFO - Writing to file /builds/slave/test/properties/build_url 13:32:08 INFO - Contents: 13:32:08 INFO - build_url:https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 13:32:08 INFO - Running post-action listener: _resource_record_post_action 13:32:08 INFO - Running post-action listener: set_extra_try_arguments 13:32:08 INFO - ##### 13:32:08 INFO - ##### Running populate-webroot step. 13:32:08 INFO - ##### 13:32:08 INFO - Running pre-action listener: _resource_record_pre_action 13:32:08 INFO - Running main action method: populate_webroot 13:32:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:32:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:32:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:32:08 INFO - '--tppagecycles', 13:32:08 INFO - '7'], 13:32:08 INFO - 'tests': ['tsvgm']}}, 13:32:08 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 13:32:08 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 13:32:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:32:08 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:32:08 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 13:32:08 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 13:32:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:08 INFO - 'talos_options': ['--e10s'], 13:32:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:32:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:08 INFO - 'tests': ['damp', 'tps']}, 13:32:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:08 INFO - 'talos_options': ['--e10s'], 13:32:08 INFO - 'tests': ['damp', 'tps']}, 13:32:08 INFO - 'g3': {'tests': ['dromaeo_dom']}, 13:32:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:32:08 INFO - 'other': {'tests': ['a11yr', 13:32:08 INFO - 'ts_paint', 13:32:08 INFO - 'tpaint', 13:32:08 INFO - 'sessionrestore', 13:32:08 INFO - 'sessionrestore_no_auto_restore']}, 13:32:08 INFO - 'other-e10s': {'talos_options': ['--e10s'], 13:32:08 INFO - 'tests': ['a11yr', 13:32:08 INFO - 'ts_paint', 13:32:08 INFO - 'tpaint', 13:32:08 INFO - 'sessionrestore', 13:32:08 INFO - 'sessionrestore_no_auto_restore']}, 13:32:08 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 13:32:08 INFO - 'tests': ['a11yr', 13:32:08 INFO - 'ts_paint', 13:32:08 INFO - 'tpaint', 13:32:08 INFO - 'sessionrestore', 13:32:08 INFO - 'sessionrestore_no_auto_restore']}, 13:32:08 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 13:32:08 INFO - 'tests': ['a11yr', 13:32:08 INFO - 'ts_paint', 13:32:08 INFO - 'tpaint', 13:32:08 INFO - 'sessionrestore', 13:32:08 INFO - 'sessionrestore_no_auto_restore']}, 13:32:08 INFO - 'other_l64': {'tests': ['a11yr', 13:32:08 INFO - 'ts_paint', 13:32:08 INFO - 'tpaint', 13:32:08 INFO - 'sessionrestore', 13:32:08 INFO - 'sessionrestore_no_auto_restore']}, 13:32:08 INFO - 'other_nol64': {'tests': ['a11yr', 13:32:08 INFO - 'ts_paint', 13:32:08 INFO - 'tpaint', 13:32:08 INFO - 'sessionrestore', 13:32:08 INFO - 'sessionrestore_no_auto_restore']}, 13:32:08 INFO - 'svgr': {'tests': ['tsvgx', 13:32:08 INFO - 'tsvgr_opacity', 13:32:08 INFO - 'tart', 13:32:08 INFO - 'tscrollx', 13:32:08 INFO - 'cart']}, 13:32:08 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 13:32:08 INFO - 'tests': ['tsvgx', 13:32:08 INFO - 'tsvgr_opacity', 13:32:08 INFO - 'tart', 13:32:08 INFO - 'tscrollx', 13:32:08 INFO - 'cart']}, 13:32:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:08 INFO - 'tests': ['tp5o']}, 13:32:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:08 INFO - 'talos_options': ['--e10s'], 13:32:08 INFO - 'tests': ['tp5o']}, 13:32:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:08 INFO - 'talos_options': ['--xperf_path', 13:32:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:08 INFO - 'tests': ['tp5n']}, 13:32:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:32:08 INFO - 'talos_options': ['--e10s', 13:32:08 INFO - '--xperf_path', 13:32:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:32:08 INFO - 'tests': ['tp5n']}}, 13:32:08 INFO - 'talos.zip': {'path': '', 13:32:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:32:08 INFO - Running post-action listener: _resource_record_post_action 13:32:08 INFO - ##### 13:32:08 INFO - ##### Running create-virtualenv step. 13:32:08 INFO - ##### 13:32:08 INFO - Running pre-action listener: _resource_record_pre_action 13:32:08 INFO - Running main action method: create_virtualenv 13:32:08 INFO - Creating virtualenv /builds/slave/test/build/venv 13:32:08 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 13:32:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:32:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:32:08 INFO - Using real prefix '/usr' 13:32:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:32:11 INFO - Installing distribute.............................................................................................................................................................................................done. 13:32:13 INFO - Installing pip.................done. 13:32:13 INFO - Return code: 0 13:32:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:32:13 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')]} 13:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:13 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')]} 13:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:13 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 0x7f98532eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f3d0>, '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 0x107aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b360>, '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': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', '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 13:32:13 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 13:32:13 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 13:32:13 INFO - Using env: {'DISPLAY': ':0', 13:32:13 INFO - 'HOME': '/home/cltbld', 13:32:13 INFO - 'LANG': 'en_US.UTF-8', 13:32:13 INFO - 'LANGUAGE': 'en_US:en', 13:32:13 INFO - 'LOGNAME': 'cltbld', 13:32:13 INFO - 'MAIL': '/var/mail/cltbld', 13:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:13 INFO - 'MOZ_NO_REMOTE': '1', 13:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:13 INFO - 'NO_EM_RESTART': '1', 13:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:13 INFO - 'PWD': '/builds/slave/test', 13:32:13 INFO - 'SHELL': '/bin/bash', 13:32:13 INFO - 'SHLVL': '1', 13:32:13 INFO - 'TERM': 'linux', 13:32:13 INFO - 'TMOUT': '86400', 13:32:13 INFO - 'USER': 'cltbld', 13:32:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', 13:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:13 INFO - '_': '/tools/buildbot/bin/python'} 13:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:13 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 13:32:13 INFO - Cleaning up... 13:32:13 INFO - Return code: 0 13:32:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:32:13 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')]} 13:32:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:13 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')]} 13:32:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:13 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 0x7f98532eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f3d0>, '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 0x107aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b360>, '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': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', '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 13:32:13 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 13:32:13 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 13:32:13 INFO - Using env: {'DISPLAY': ':0', 13:32:13 INFO - 'HOME': '/home/cltbld', 13:32:13 INFO - 'LANG': 'en_US.UTF-8', 13:32:13 INFO - 'LANGUAGE': 'en_US:en', 13:32:13 INFO - 'LOGNAME': 'cltbld', 13:32:13 INFO - 'MAIL': '/var/mail/cltbld', 13:32:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:13 INFO - 'MOZ_NO_REMOTE': '1', 13:32:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:13 INFO - 'NO_EM_RESTART': '1', 13:32:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:13 INFO - 'PWD': '/builds/slave/test', 13:32:13 INFO - 'SHELL': '/bin/bash', 13:32:13 INFO - 'SHLVL': '1', 13:32:13 INFO - 'TERM': 'linux', 13:32:13 INFO - 'TMOUT': '86400', 13:32:13 INFO - 'USER': 'cltbld', 13:32:13 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', 13:32:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:13 INFO - '_': '/tools/buildbot/bin/python'} 13:32:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:13 INFO - Downloading/unpacking psutil>=0.7.1 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32: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 13:32:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 13:32:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 13:32:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:32:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:16 INFO - Installing collected packages: psutil 13:32:16 INFO - Running setup.py install for psutil 13:32:16 INFO - building 'psutil._psutil_linux' extension 13:32:16 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 13:32:17 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 13:32:17 INFO - building 'psutil._psutil_posix' extension 13:32:17 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 13:32:17 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 13:32:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:32:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:32:17 INFO - Successfully installed psutil 13:32:17 INFO - Cleaning up... 13:32:17 INFO - Return code: 0 13:32:17 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:32:17 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')]} 13:32:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:17 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')]} 13:32:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:17 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 0x7f98532eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f3d0>, '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 0x107aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b360>, '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': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', '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 13:32:17 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 13:32:17 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 13:32:17 INFO - Using env: {'DISPLAY': ':0', 13:32:17 INFO - 'HOME': '/home/cltbld', 13:32:17 INFO - 'LANG': 'en_US.UTF-8', 13:32:17 INFO - 'LANGUAGE': 'en_US:en', 13:32:17 INFO - 'LOGNAME': 'cltbld', 13:32:17 INFO - 'MAIL': '/var/mail/cltbld', 13:32:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:17 INFO - 'MOZ_NO_REMOTE': '1', 13:32:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:17 INFO - 'NO_EM_RESTART': '1', 13:32:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:17 INFO - 'PWD': '/builds/slave/test', 13:32:17 INFO - 'SHELL': '/bin/bash', 13:32:17 INFO - 'SHLVL': '1', 13:32:17 INFO - 'TERM': 'linux', 13:32:17 INFO - 'TMOUT': '86400', 13:32:17 INFO - 'USER': 'cltbld', 13:32:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', 13:32:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:17 INFO - '_': '/tools/buildbot/bin/python'} 13:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:32:18 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 13:32:18 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 13:32:18 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 13:32:18 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 13:32:18 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 13:32:18 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 13:32:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:32:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 13:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:32:20 INFO - Installing collected packages: mozsystemmonitor 13:32:20 INFO - Running setup.py install for mozsystemmonitor 13:32:21 INFO - Successfully installed mozsystemmonitor 13:32:21 INFO - Cleaning up... 13:32:21 INFO - Return code: 0 13:32:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:21 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 0x7f98532eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f3d0>, '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 0x107aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b360>, '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': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', '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 13:32:21 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 13:32:21 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 13:32:21 INFO - Using env: {'DISPLAY': ':0', 13:32:21 INFO - 'HOME': '/home/cltbld', 13:32:21 INFO - 'LANG': 'en_US.UTF-8', 13:32:21 INFO - 'LANGUAGE': 'en_US:en', 13:32:21 INFO - 'LOGNAME': 'cltbld', 13:32:21 INFO - 'MAIL': '/var/mail/cltbld', 13:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:21 INFO - 'MOZ_NO_REMOTE': '1', 13:32:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:21 INFO - 'NO_EM_RESTART': '1', 13:32:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:21 INFO - 'PWD': '/builds/slave/test', 13:32:21 INFO - 'SHELL': '/bin/bash', 13:32:21 INFO - 'SHLVL': '1', 13:32:21 INFO - 'TERM': 'linux', 13:32:21 INFO - 'TMOUT': '86400', 13:32:21 INFO - 'USER': 'cltbld', 13:32:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', 13:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:21 INFO - '_': '/tools/buildbot/bin/python'} 13:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:21 INFO - Downloading/unpacking blobuploader==1.2.4 13:32:21 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 13:32:21 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 13:32:21 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 13:32:21 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 13:32:21 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 13:32:21 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 13:32:23 INFO - Downloading blobuploader-1.2.4.tar.gz 13:32:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 13:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:32:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 13:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:32:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 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 13:32:23 INFO - Downloading docopt-0.6.1.tar.gz 13:32:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 13:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:32:23 INFO - Installing collected packages: blobuploader, requests, docopt 13:32:23 INFO - Running setup.py install for blobuploader 13:32:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:32:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:32:23 INFO - Running setup.py install for requests 13:32:24 INFO - Running setup.py install for docopt 13:32:24 INFO - Successfully installed blobuploader requests docopt 13:32:24 INFO - Cleaning up... 13:32:24 INFO - Return code: 0 13:32:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:24 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')]} 13:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:24 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')]} 13:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:24 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 0x7f98532eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f3d0>, '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 0x107aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b360>, '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': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', '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 13:32:24 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 13:32:24 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 13:32:24 INFO - Using env: {'DISPLAY': ':0', 13:32:24 INFO - 'HOME': '/home/cltbld', 13:32:24 INFO - 'LANG': 'en_US.UTF-8', 13:32:24 INFO - 'LANGUAGE': 'en_US:en', 13:32:24 INFO - 'LOGNAME': 'cltbld', 13:32:24 INFO - 'MAIL': '/var/mail/cltbld', 13:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:24 INFO - 'MOZ_NO_REMOTE': '1', 13:32:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:24 INFO - 'NO_EM_RESTART': '1', 13:32:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:24 INFO - 'PWD': '/builds/slave/test', 13:32:24 INFO - 'SHELL': '/bin/bash', 13:32:24 INFO - 'SHLVL': '1', 13:32:24 INFO - 'TERM': 'linux', 13:32:24 INFO - 'TMOUT': '86400', 13:32:24 INFO - 'USER': 'cltbld', 13:32:24 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', 13:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:24 INFO - '_': '/tools/buildbot/bin/python'} 13:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:24 INFO - Running setup.py (path:/tmp/pip-8Q2DzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:24 INFO - Running setup.py (path:/tmp/pip-jVTkQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:24 INFO - Running setup.py (path:/tmp/pip-UZmoFa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:24 INFO - Running setup.py (path:/tmp/pip-PBMQhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:24 INFO - Running setup.py (path:/tmp/pip-9oZi4H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:24 INFO - Running setup.py (path:/tmp/pip-HGcnkW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:24 INFO - Running setup.py (path:/tmp/pip-HvXOTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:25 INFO - Running setup.py (path:/tmp/pip-9IQExl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:25 INFO - Running setup.py (path:/tmp/pip-nms7qR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:25 INFO - Running setup.py (path:/tmp/pip-le3k1X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:25 INFO - Running setup.py (path:/tmp/pip-etyIjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:25 INFO - Running setup.py (path:/tmp/pip-Z5KmmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:25 INFO - Running setup.py (path:/tmp/pip-QTG4c8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:25 INFO - Running setup.py (path:/tmp/pip-qw01bW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:25 INFO - Running setup.py (path:/tmp/pip-30I8Y_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:25 INFO - Running setup.py (path:/tmp/pip-Ery3mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:25 INFO - Running setup.py (path:/tmp/pip-BE_cfl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:32:25 INFO - Running setup.py install for manifestparser 13:32:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:32:25 INFO - Running setup.py install for mozcrash 13:32:25 INFO - Running setup.py install for mozdebug 13:32:26 INFO - Running setup.py install for mozdevice 13:32:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:32:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:32:26 INFO - Running setup.py install for mozfile 13:32:26 INFO - Running setup.py install for mozhttpd 13:32:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:32:26 INFO - Running setup.py install for mozinfo 13:32:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:32:26 INFO - Running setup.py install for mozInstall 13:32:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:32:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:32:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:32:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:32:26 INFO - Running setup.py install for mozleak 13:32:26 INFO - Running setup.py install for mozlog 13:32:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:32:26 INFO - Running setup.py install for moznetwork 13:32:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:32:26 INFO - Running setup.py install for mozprocess 13:32:26 INFO - Running setup.py install for mozprofile 13:32:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:32:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:32:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:32:27 INFO - Running setup.py install for mozrunner 13:32:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:32:27 INFO - Running setup.py install for mozscreenshot 13:32:27 INFO - Running setup.py install for moztest 13:32:27 INFO - Running setup.py install for mozversion 13:32:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:32:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:32:27 INFO - Cleaning up... 13:32:27 INFO - Return code: 0 13:32:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:27 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 0x7f98532eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f3d0>, '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 0x107aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b360>, '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': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', '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 13:32:27 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 13:32:27 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 13:32:27 INFO - Using env: {'DISPLAY': ':0', 13:32:27 INFO - 'HOME': '/home/cltbld', 13:32:27 INFO - 'LANG': 'en_US.UTF-8', 13:32:27 INFO - 'LANGUAGE': 'en_US:en', 13:32:27 INFO - 'LOGNAME': 'cltbld', 13:32:27 INFO - 'MAIL': '/var/mail/cltbld', 13:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:27 INFO - 'MOZ_NO_REMOTE': '1', 13:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:27 INFO - 'NO_EM_RESTART': '1', 13:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:27 INFO - 'PWD': '/builds/slave/test', 13:32:27 INFO - 'SHELL': '/bin/bash', 13:32:27 INFO - 'SHLVL': '1', 13:32:27 INFO - 'TERM': 'linux', 13:32:27 INFO - 'TMOUT': '86400', 13:32:27 INFO - 'USER': 'cltbld', 13:32:27 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', 13:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:27 INFO - '_': '/tools/buildbot/bin/python'} 13:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:32:27 INFO - Running setup.py (path:/tmp/pip-fLJeWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:32:27 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)) 13:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:32:27 INFO - Running setup.py (path:/tmp/pip-VEn2XZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:32:27 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)) 13:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:32:27 INFO - Running setup.py (path:/tmp/pip-w46lyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:32:27 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)) 13:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:32:27 INFO - Running setup.py (path:/tmp/pip-NuIH5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:32:28 INFO - Running setup.py (path:/tmp/pip-pa_Fmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:32:28 INFO - Running setup.py (path:/tmp/pip-Q8XYBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:32:28 INFO - Running setup.py (path:/tmp/pip-8UCE_I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:32:28 INFO - Running setup.py (path:/tmp/pip-yLKRsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:32:28 INFO - Running setup.py (path:/tmp/pip-R2eV34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:32:28 INFO - Running setup.py (path:/tmp/pip-L4xTNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:32:28 INFO - Running setup.py (path:/tmp/pip-7kojFI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:32:28 INFO - Running setup.py (path:/tmp/pip-zKChcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:32:28 INFO - Running setup.py (path:/tmp/pip-YrtkpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:32:28 INFO - Running setup.py (path:/tmp/pip-7p_Fsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:28 INFO - Running setup.py (path:/tmp/pip-xowowR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:32:28 INFO - Running setup.py (path:/tmp/pip-m_ryPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:32:28 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)) 13:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:32:28 INFO - Running setup.py (path:/tmp/pip-Ovy9Sc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:32:28 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)) 13:32:28 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)) 13:32:28 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)) 13:32:28 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)) 13:32:28 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)) 13:32:28 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)) 13:32:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:32:28 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 13:32:28 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 13:32:28 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 13:32:28 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 13:32:28 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 13:32:28 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 13:32:30 INFO - Downloading blessings-1.5.1.tar.gz 13:32:30 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 13:32:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:32:30 INFO - Installing collected packages: blessings 13:32:30 INFO - Running setup.py install for blessings 13:32:30 INFO - Successfully installed blessings 13:32:30 INFO - Cleaning up... 13:32:30 INFO - Return code: 0 13:32:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:32:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:31 INFO - Reading from file tmpfile_stdout 13:32:31 INFO - Current package versions: 13:32:31 INFO - argparse == 1.2.1 13:32:31 INFO - blessings == 1.5.1 13:32:31 INFO - blobuploader == 1.2.4 13:32:31 INFO - docopt == 0.6.1 13:32:31 INFO - manifestparser == 1.1 13:32:31 INFO - mozInstall == 1.12 13:32:31 INFO - mozcrash == 0.16 13:32:31 INFO - mozdebug == 0.1 13:32:31 INFO - mozdevice == 0.47 13:32:31 INFO - mozfile == 1.2 13:32:31 INFO - mozhttpd == 0.7 13:32:31 INFO - mozinfo == 0.9 13:32:31 INFO - mozleak == 0.1 13:32:31 INFO - mozlog == 3.1 13:32:31 INFO - moznetwork == 0.27 13:32:31 INFO - mozprocess == 0.22 13:32:31 INFO - mozprofile == 0.28 13:32:31 INFO - mozrunner == 6.11 13:32:31 INFO - mozscreenshot == 0.1 13:32:31 INFO - mozsystemmonitor == 0.0 13:32:31 INFO - moztest == 0.7 13:32:31 INFO - mozversion == 1.4 13:32:31 INFO - psutil == 3.1.1 13:32:31 INFO - requests == 1.2.3 13:32:31 INFO - wsgiref == 0.1.2 13:32:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:31 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 0x7f98532eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f3d0>, '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 0x107aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b360>, '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': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', '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 13:32:31 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 13:32:31 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 13:32:31 INFO - Using env: {'DISPLAY': ':0', 13:32:31 INFO - 'HOME': '/home/cltbld', 13:32:31 INFO - 'LANG': 'en_US.UTF-8', 13:32:31 INFO - 'LANGUAGE': 'en_US:en', 13:32:31 INFO - 'LOGNAME': 'cltbld', 13:32:31 INFO - 'MAIL': '/var/mail/cltbld', 13:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:31 INFO - 'MOZ_NO_REMOTE': '1', 13:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:31 INFO - 'NO_EM_RESTART': '1', 13:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:31 INFO - 'PWD': '/builds/slave/test', 13:32:31 INFO - 'SHELL': '/bin/bash', 13:32:31 INFO - 'SHLVL': '1', 13:32:31 INFO - 'TERM': 'linux', 13:32:31 INFO - 'TMOUT': '86400', 13:32:31 INFO - 'USER': 'cltbld', 13:32:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', 13:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:31 INFO - '_': '/tools/buildbot/bin/python'} 13:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:31 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)) 13:32:31 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)) 13:32:31 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)) 13:32:31 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)) 13:32:31 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)) 13:32:31 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)) 13:32:31 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)) 13:32:31 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)) 13:32:31 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)) 13:32:31 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)) 13:32:31 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)) 13:32:31 INFO - Cleaning up... 13:32:31 INFO - Return code: 0 13:32:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:32: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')]} 13:32:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32: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')]} 13:32:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:31 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 0x7f98532eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f3d0>, '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 0x107aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b360>, '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': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', '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 13:32:31 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 13:32:31 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 13:32:31 INFO - Using env: {'DISPLAY': ':0', 13:32:31 INFO - 'HOME': '/home/cltbld', 13:32:31 INFO - 'LANG': 'en_US.UTF-8', 13:32:31 INFO - 'LANGUAGE': 'en_US:en', 13:32:31 INFO - 'LOGNAME': 'cltbld', 13:32:31 INFO - 'MAIL': '/var/mail/cltbld', 13:32:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:31 INFO - 'MOZ_NO_REMOTE': '1', 13:32:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:31 INFO - 'NO_EM_RESTART': '1', 13:32:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:31 INFO - 'PWD': '/builds/slave/test', 13:32:31 INFO - 'SHELL': '/bin/bash', 13:32:31 INFO - 'SHLVL': '1', 13:32:31 INFO - 'TERM': 'linux', 13:32:31 INFO - 'TMOUT': '86400', 13:32:31 INFO - 'USER': 'cltbld', 13:32:31 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', 13:32:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:31 INFO - '_': '/tools/buildbot/bin/python'} 13:32:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:31 INFO - Downloading/unpacking jsonschema 13:32:31 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 13:32:31 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 13:32:31 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 13:32:31 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 13:32:31 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 13:32:31 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 13:32:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:32:33 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 13:32:33 INFO - Downloading/unpacking functools32 (from jsonschema) 13:32:33 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 13:32:33 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 13:32:33 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 13:32:33 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 13:32:33 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 13:32:33 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 13:32:33 INFO - Downloading functools32-3.2.3-2.tar.gz 13:32:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 13:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:32:33 INFO - warning: no files found matching '*.txt' 13:32:33 INFO - no previously-included directories found matching 'build' 13:32:33 INFO - no previously-included directories found matching 'dist' 13:32:33 INFO - no previously-included directories found matching '.git*' 13:32:33 INFO - Installing collected packages: jsonschema, functools32 13:32:33 INFO - Running setup.py install for functools32 13:32:33 INFO - warning: no files found matching '*.txt' 13:32:33 INFO - no previously-included directories found matching 'build' 13:32:33 INFO - no previously-included directories found matching 'dist' 13:32:33 INFO - no previously-included directories found matching '.git*' 13:32:33 INFO - Successfully installed jsonschema functools32 13:32:33 INFO - Cleaning up... 13:32:33 INFO - Return code: 0 13:32:33 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:32:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:32:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:32:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:32:33 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 0x7f98532eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110f3d0>, '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 0x107aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b360>, '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': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', '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 13:32:33 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 13:32:33 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 13:32:33 INFO - Using env: {'DISPLAY': ':0', 13:32:33 INFO - 'HOME': '/home/cltbld', 13:32:33 INFO - 'LANG': 'en_US.UTF-8', 13:32:33 INFO - 'LANGUAGE': 'en_US:en', 13:32:33 INFO - 'LOGNAME': 'cltbld', 13:32:33 INFO - 'MAIL': '/var/mail/cltbld', 13:32:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:33 INFO - 'MOZ_NO_REMOTE': '1', 13:32:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:33 INFO - 'NO_EM_RESTART': '1', 13:32:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:33 INFO - 'PWD': '/builds/slave/test', 13:32:33 INFO - 'SHELL': '/bin/bash', 13:32:33 INFO - 'SHLVL': '1', 13:32:33 INFO - 'TERM': 'linux', 13:32:33 INFO - 'TMOUT': '86400', 13:32:33 INFO - 'USER': 'cltbld', 13:32:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', 13:32:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:33 INFO - '_': '/tools/buildbot/bin/python'} 13:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:32:34 INFO - Downloading/unpacking flake8 13:32:34 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 13:32:34 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 13:32:34 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 13:32:34 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 13:32:34 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 13:32:34 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 13:32:35 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:32:35 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 13:32:35 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:32:35 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 13:32:35 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 13:32:35 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 13:32:35 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 13:32:35 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 13:32:35 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 13:32:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:32:35 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 13:32:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:32:35 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 13:32:35 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 13:32:35 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 13:32:35 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 13:32:35 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 13:32:35 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 13:32:36 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 13:32:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:32:36 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 13:32:36 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 13:32:36 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 13:32:36 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 13:32:36 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 13:32:36 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 13:32:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 13:32:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:32:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:36 INFO - no previously-included directories found matching 'docs/_build' 13:32:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:32:36 INFO - Running setup.py install for pep8 13:32:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:32:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:32:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:32:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:32:36 INFO - no previously-included directories found matching 'docs/_build' 13:32:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:32:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:32:36 INFO - Cleaning up... 13:32:36 INFO - Return code: 0 13:32:36 INFO - Running post-action listener: _resource_record_post_action 13:32:36 INFO - Running post-action listener: _start_resource_monitoring 13:32:36 INFO - Starting resource monitoring. 13:32:36 INFO - ##### 13:32:36 INFO - ##### Running install step. 13:32:36 INFO - ##### 13:32:36 INFO - Running pre-action listener: _resource_record_pre_action 13:32:36 INFO - Running main action method: install 13:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:32:36 INFO - Reading from file tmpfile_stdout 13:32:36 INFO - Detecting whether we're running mozinstall >=1.0... 13:32:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:32:36 INFO - Reading from file tmpfile_stdout 13:32:36 INFO - Output received: 13:32:36 INFO - Usage: mozinstall [options] installer 13:32:36 INFO - Options: 13:32:36 INFO - -h, --help show this help message and exit 13:32:36 INFO - -d DEST, --destination=DEST 13:32:36 INFO - Directory to install application into. [default: 13:32:36 INFO - "/builds/slave/test"] 13:32:36 INFO - --app=APP Application being installed. [default: firefox] 13:32:36 INFO - mkdir: /builds/slave/test/build/application 13:32:36 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'] 13:32:36 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 13:32:52 INFO - Reading from file tmpfile_stdout 13:32:52 INFO - Output received: 13:32:52 INFO - /builds/slave/test/build/application/firefox/firefox 13:32:52 INFO - Running post-action listener: _resource_record_post_action 13:32:52 INFO - ##### 13:32:52 INFO - ##### Running run-tests step. 13:32:52 INFO - ##### 13:32:52 INFO - Running pre-action listener: _resource_record_pre_action 13:32:52 INFO - Running main action method: run_tests 13:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:32:52 INFO - Python 2.7.3 13:32:52 INFO - Return code: 0 13:32:52 INFO - grabbing minidump binary from tooltool 13:32:52 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')]} 13:32:52 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 0x110f3d0>, '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 0x107aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107b360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:32:52 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 13:32:52 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 13:32:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:32:52 INFO - Return code: 0 13:32:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:32:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:32:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:32:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:32:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:32:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:32:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:32:53 INFO - Return code: 0 13:32:53 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:32:53 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:32:53 INFO - Using env: {'DISPLAY': ':0', 13:32:53 INFO - 'HOME': '/home/cltbld', 13:32:53 INFO - 'LANG': 'en_US.UTF-8', 13:32:53 INFO - 'LANGUAGE': 'en_US:en', 13:32:53 INFO - 'LOGNAME': 'cltbld', 13:32:53 INFO - 'MAIL': '/var/mail/cltbld', 13:32:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:32:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:32:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:32:53 INFO - 'MOZ_NO_REMOTE': '1', 13:32:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:32:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:32:53 INFO - 'NO_EM_RESTART': '1', 13:32:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:32:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:32:53 INFO - 'PWD': '/builds/slave/test', 13:32:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:32:53 INFO - 'SHELL': '/bin/bash', 13:32:53 INFO - 'SHLVL': '1', 13:32:53 INFO - 'TERM': 'linux', 13:32:53 INFO - 'TMOUT': '86400', 13:32:53 INFO - 'USER': 'cltbld', 13:32:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545', 13:32:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:32:53 INFO - '_': '/tools/buildbot/bin/python'} 13:32:53 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:32:53 INFO - mozversion application_buildid: 20160111130128 13:32:53 INFO - mozversion application_changeset: 250c5bf5634e9ca85c4b96ba3a8aab07a665f915 13:32:53 INFO - mozversion application_display_name: Nightly 13:32:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:32:53 INFO - mozversion application_name: Firefox 13:32:53 INFO - mozversion application_remotingname: firefox 13:32:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 13:32:53 INFO - mozversion application_vendor: Mozilla 13:32:53 INFO - mozversion application_version: 46.0a1 13:32:53 INFO - mozversion platform_buildid: 20160111130128 13:32:53 INFO - mozversion platform_changeset: 250c5bf5634e9ca85c4b96ba3a8aab07a665f915 13:32:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 13:32:53 INFO - mozversion platform_version: 46.0a1 13:32:53 INFO - using testdate: 1452547973 13:32:53 INFO - actual date: 1452547973 13:32:53 INFO - starting webserver on 'localhost:60583' 13:32:53 INFO - SUITE-START | Running 3 tests 13:32:53 INFO - TEST-START | dromaeo_css 13:32:53 INFO - operating with platform_type : linux_ 13:32:53 INFO - Initialising browser for dromaeo_css test... 13:32:53 INFO - TEST-INFO | started process 3334 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSXCxB6/profile http://localhost:60583/getInfo.html) 13:33:02 INFO - PROCESS | 3334 | 13:33:02 INFO - PROCESS | 3334 | (process:3414): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:33:04 INFO - PROCESS | 3334 | __metrics Screen width/height:1600/1200 13:33:04 INFO - PROCESS | 3334 | colorDepth:24 13:33:04 INFO - PROCESS | 3334 | Browser inner width/height: 1024/697 13:33:04 INFO - PROCESS | 3334 | __metrics 13:33:04 INFO - PROCESS | 3334 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:33:05 INFO - TEST-INFO | 3334: exit 0 13:33:05 INFO - Browser initialized. 13:33:05 INFO - Running cycle 1/1 for dromaeo_css test... 13:33:05 INFO - TEST-INFO | started process 3463 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSXCxB6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:33:06 INFO - PROCESS | 3463 | 13:33:06 INFO - PROCESS | 3463 | (process:3519): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:33:17 INFO - PROCESS | 3463 | RSS: Main: 150302720 13:33:17 INFO - PROCESS | 3463 | 13:34:06 INFO - PROCESS | 3463 | 1452548046927 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] 13:36:18 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:60583/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60583/tests/dromaeo/cssquery-ext.html) 13:36:19 INFO - PROCESS | 3463 | RSS: Main: 152301568 13:36:19 INFO - PROCESS | 3463 | 13:39:21 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:60583/tests/dromaeo/cssquery-ext.html (next: http://localhost:60583/tests/dromaeo/cssquery-jquery.html) 13:39:22 INFO - PROCESS | 3463 | RSS: Main: 151928832 13:39:22 INFO - PROCESS | 3463 | 13:42:24 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:60583/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60583/tests/dromaeo/cssquery-mootools.html) 13:42:24 INFO - PROCESS | 3463 | RSS: Main: 152014848 13:42:24 INFO - PROCESS | 3463 | 13:45:26 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:60583/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60583/tests/dromaeo/cssquery-prototype.html) 13:45:27 INFO - PROCESS | 3463 | RSS: Main: 150646784 13:45:27 INFO - PROCESS | 3463 | 13:48:29 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:60583/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60583/tests/dromaeo/cssquery-yui.html) 13:48:30 INFO - PROCESS | 3463 | RSS: Main: 151764992 13:48:30 INFO - PROCESS | 3463 | 13:51:32 INFO - PROCESS | 3463 | Cycle 1(1): loaded http://localhost:60583/tests/dromaeo/cssquery-yui.html (next: http://localhost:60583/tests/dromaeo/cssquery-dojo.html) 13:51:33 INFO - PROCESS | 3463 | RSS: Main: 152784896 13:51:33 INFO - PROCESS | 3463 | 13:51:33 INFO - PROCESS | 3463 | __start_tp_report 13:51:33 INFO - PROCESS | 3463 | _x_x_mozilla_page_load 13:51:33 INFO - PROCESS | 3463 | _x_x_mozilla_page_load_details 13:51:33 INFO - PROCESS | 3463 | |i|pagename|runs| 13:51:33 INFO - PROCESS | 3463 | |0;dojo.html;2641.920742377728;2674.1175412114003;2707.6209330693705;2719.04833308342;2727.113688051383;4543.681942264043;4604.102200070984;4611.308303754438;4643.953560464394;4650.720956742593;4559.908801823962;4577.244754615484;4610.262358022717;4680.719156850591;4708.387909571751;4286.357046443035;4333.133373325331;4372.672049596277;4393.604575588196;4413.095315460323;4263.893402664927;4334.5448727883595;4362.280223763075;4415.955840441603;4437.2013037653205;4171.10321280923;4172.18642364739;4284;4358.8038538265855;4386.035072284077;4286.721363111388;4309.5690430956965;4323.351497275403;4326.069894972565;4351.717138386027;4273.358996150571;4285.764282964436;4288.378185163165;4300.182965236595;4345.521992580813;4401.801918913657;4516.503184649686;4517.548245175456;4553.112143132091;4647.53524647536;4973.42805577356;4978;5000.399952005746;5027.2207807789855;5035.471275516054;4993.325901003354;5004.199328107522;5032.974835125801;5033.446320904697;5034.597232221414;4504.617107545862;4566.1552612766745;4624.930626040578;4668.603168730696;4689.976550117228;5111.207762796698;5124.256982737482;5130.79476820923;5134.589232861362;5181.145111056633;4716.599089077398;4913.901721965541;4923.926141107886;4924;4957.851264462072;4860.1737704590305;4899.730514821647;5000.224965130411;5006.574441172468;5047.4447810740785;4874.975625121922;4891.364122664031;4896.510348965075;4937.407511098691;4950.985048065138;4739.952600473951;4867.63492738039;4917.9426423319155;4931.3835770528685;4962.578180854595;4151.169766046743;4195.538490766014;4206.810693518799;4229.851955181553;4234.026173980002;3678.9632103679155;3693.9445908311395;3707.147356108056;3708.1841994761107;3744.2885851688093;4185.560516145822;4296.806643701041;4298.914021719548;4336.176126536011;4361.694681372273;5040.495950405004;5048.116579598555;5051.191809310492;5055.7219352935945;5068.391792984792;4354.760488173181;4358.6730995175485;4362.1275744851155;4384.276594361958;4395.428594282723;4307.8492252771;4413.492448368479;4428.933565996513;4502.459704835441;4536.070105628338;4734.005858769697;4751.40607424072;4755.358026666356;4774.761261936958;4804.783784729626;5004.224345226496;5012.1980483122525;5014.17266151081;5027.472115427828;5077.720725360141;4498.595126438636;4630.722156670476;4653.162430762495;4653.60444362233;4671.299305104261;4883.5116488352305;4948.05986862495;4952.529509696573;4968.8757781055765;4983.27742477346;4956.454789973172;4987.1521841287795;4991.326170966873;4998.775055122601;5023.673461225008;4681;4757.976210118927;4783.6651434399255;4836.056968891173;4872.780724867319;4894.608431325557;4902.8774280643265;4908.263760435963;4910.631702622246;4917.631177661761;4730.716157030589;4762.738049407178;4776.307435421914;4784.712917224978;4792.376990991149;4727.2436410174205;4795.424549054136;4847.733374664286;4879.536444037811;4884.096442158212;4771.117343291502;4775.665703400868;4783.6412269079265;4797.880052998703;4807.6394270429155 13:51:33 INFO - PROCESS | 3463 | |1;ext.html;510.90803655342023;513.0662194805456;536.0565404887399;536.9221462887881;542.3166809819627;34937.45813044304;35274.823625881836;35336.82331588345;35539.2892142157;35589.2882142357;40273.597264027354;40750;40854.182916341655;40923.59076409235;40929.795351023204;7762.4178186635945;7949.801254968643;7976.361891048702;7977.920220797776;7981.720639777609;7615.276548727862;7656.349210317129;7714.151443341228;7734.342580880632;7742.225777422269;7676.501027433227;7742.729004484844;7747.147813740484;7750.728724494644;7798.2981531662135;7665.616719164047;7730.265624765694;7733;7752.573608451533;7756.185600511922;7744.148143704188;7796.688132474695;7855.607219639052;7865.567393793339;7882.448228623999;36361.45457818135;36406.63593364086;36925;36989.260214795555;36994.81502592497;2897.101898411478;2911.956320655192;2958.5562165675105;3077.615298087739;3556.05764472415;27524.311892202655;27919.720802791915;28150.296242593893;28281.57577636337;28329.008484703143;3322.551455553518;3329.716974057208;3363.831808409594;3368.1579605098727;3461.4060215289915;208790;212058;212218;212391;212795;46815.765921170176;47519.287210691866;55951;57148;58082.12876806851;48060.27909581359;48335.5166448331;48436.78908027327;48627.27059094117;48752.26871596858;12559.811602825965;12681.429335679917;12734.68163295925;12777.68055798594;12797.23216606988;10642.946785266024;10653.520591573242;10688.89311106879;10719.356838589709;10745.623903163352;19112.426627201206;19226;19401.32095376655;19483.707744383846;19518;7510.511816731895;7624.80937976555;7751.844963100706;7780.961095194601;7835.138134805281;804.8631732605354;830.6884918155691;839.1817977472039;866.696656170348;911.1298709732322;23970.52058958811;24319.756802432104;24480.02079916819;24481.387965300655;24756.752432475805;910.4355299714219;934.56075644447;966.1401352796017;987.9110880020833;1032.5611615063567;12408.81386779199;12455.929526968783;12538.185017973985;12554.309512976874;12643.747125057447;241048;244962;245437;245591;245687;46276.5372346279;46284.5371546287;46290.30564541535;46336.5366346339;46711;1234.2656119608819;1241.5654520917606;1249.6001279590625;1251.2117366059324;1253.2042153232762;24056.51886962216;24157.879210603835;24205.258194410657;24330.93187079118;24378.26865194047;34617.134571635914;35145;35204;35232.11919702028;35510.28979420449;238572;239297;239351;239564;241856;28995.13014609565;37809.432858507695;37922.345435819225;38166.47334106605;38464.6153538461;34262.31475370529;34951.475727864614;34971.82514087515;35250.306165804606;35415;29690.851545742134;33146.17134571655;34583.30833383369;35247;35683.82158089193;30405.087847364615;32169.517457238628;34317.65682343145;34627.826860865534;34766.82616586901;30260.54609180908;34565.13587160341;35445.82277088598;35447.64552354444;35498.11254718549;25819.87090064613;27369.45261094727;27535.31161720973;27572.72427275782;27613;19391;19562.413127606196;19645.11596978111;20126.59746805085;20323.08546115458 13:51:33 INFO - PROCESS | 3463 | |2;jquery.html;324.68829923273654;338.9271306669067;341.72320420459425;341.85471174750734;341.87008936604104;14162.71674566508;14578.635534111652;15098.320575574111;15249.237538123105;16036.35854565816;9686.225101991842;9996.800063998715;12624.495020199181;14667.339969701363;14700.926495367536;4432.202203603359;4499.730016199039;4623.1678297906365;5055.5702765265;5081.923771143436;4926.802927882881;5003.949960500385;5010.997800439908;5014.222795466709;5016.046951079284;4778.546038126373;4795.640326975491;4983.053219888227;5005.524475174852;5037.118504261758;4972.925406118911;4987.451380348177;5013.974930125344;5056.115179843549;5794.62334948227;5089.898202035939;5142.228665700138;5142.588592912558;5143.099957507421;5153.6392452528335;11588.536458541732;16873.24070416822;17233.569160770956;17315.56711082233;17741.556461088447;1809.638072385515;1833.587442825367;1862.9347972821022;1883.7080252560875;1899.5251187203198;8258.215469530385;8525.976882774106;8621.956890215508;8772.473651580925;10540;1693.593537550979;1695.85585225256;1706.556295363202;1748.1870930017603;1751.5270876863303;42553;44253.77873110614;44505;45502.54497455016;49248;9340.57967391469;9728.708138755848;9816.705498835046;9836.704898853046;9868.80262394748;12372.381380930918;12407.317597532041;12422.503099876085;12431.502739890484;12458.314792686308;7031.718731250795;7035.33164349386;7082.468814838805;7098.219195888448;7122.430205583541;6619.172603424572;6624.6025238485845;6653.567518111404;6667.86664266712;6731.899021514681;3886.3004659161056;3933.449317095609;3943.1127996200626;3956.1889812588925;3965.107850733562;1637.8198398176191;1723.1987125986477;1727.421313859871;1744.904030278347;1745.1448790093018;399.88403363024395;762.2644148396823;895.0512456795817;912.3522299167665;991.1426615977127;9103.408278461879;9236.353455258068;9512.667056653123;9627.229821614254;9723.611055557698;370.890587276754;400.3854083981133;401.0935286253089;404.0061448835897;405.16940272441377;5007.524285192901;5161.819336323286;5171.120909445403;5228.503292187236;5243.868903277448;398385;401890;436304;439731;442705;61750;63773.36226637767;64660;65024;65435.672821635584;455.5512819872423;458.59643513707726;458.95869371756703;459.2239115894128;461.43704680289994;8794.912050879666;9136.49749263797;9162.633494660406;9310.115539023782;9374.67188648394;27634.861825691547;27793.44413111767;28283.858580706965;28396.57405138966;28740.281492962007;33261.667383325854;33460.83269583636;33787.662123379436;33877;35415.82292088523;6094.725737341919;6241.344658810941;6297.905531416941;6372.203474565679;6375.043743438521;7313.634318284171;8959.998400535893;9017.278617710435;9252.95373523128;9282.118198771106;7478.214787447458;7517.361024312776;7881.448298619041;7951.125376208497;7970.442069055111;7900.130985591465;8182.862852860355;8361.331093512626;8428.45215061019;8594.570271486526;7914.44598878073;7980.12218655959;8134.511929284262;8169;8210.055843578066;6275.246970363585;6328.430441260309;6510;6560.737570497126;6624.337566243337;7549.886751698838;7784.9610751945875;7807.765767026998;7918.168592297956;8376.916230837858 13:51:33 INFO - PROCESS | 3463 | |3;mootools.html;1368.6578355411148;1370.7601169795282;1473.8747206487449;1702.3190723710522;1718.4930445518562;6117.2659280886355;6216.191895053648;7009.088818453601;7219.205887352387;7228.457865660077;6833.794986150411;6993.265707100757;7054.57672539648;7061.258567850379;7079.6814143363545;2140.2937030779844;2172.5654869026257;2173.119886445984;2174.56508698261;2180.3132013415725;2076.2006627448463;2082.66677331627;2122.373899699592;2139.796719311663;2141.122139922632;2123.9893800530976;2126.0326551419143;2132.8507004509693;2140.6039882621685;2170.8371872109574;2144.0673307111456;2149.720536330283;2151.354593621915;2152.5049238675115;2155.073318473056;2083.510375061859;2118.385668156233;2125.447383680239;2130.6803979403057;2131.968020479694;7255.2744725527555;7296.817579560554;7305.050343455317;7306.342429181346;7329.8900516492295;4217.6204141627095;4293.270144075484;4322.222000039991;4322.848700295474;4327.459067616548;2589.029114082219;2616.306678730138;2827.2225138086983;2828.872700728472;2834.7307005834414;824.1099612418633;837.8994520657499;841.5371545649868;851.5699571716306;898.4654130792168;9307.395019323721;9340.626374944994;9400.576974036185;9426.15164635193;9435.103665151868;4003.679705623543;4029.9194016119513;4030.5767894371256;4036.334004889219;4108.342665173558;8248.051474080557;8259.917400826034;8264.83470330602;8279.50322980623;8281.089080201173;4324.827006919751;4347.760873151944;4356.825726970886;4357.673174511924;4366.410534577792;3275.7051865332232;3363.075154332578;3842.615738426135;3938.2714197873483;3959;3512.2097528055983;3534.699550538233;3534.734894882894;3538.0800991741817;3540.13266749648;1147.867995180565;1153.210051114989;1153.5789436855487;1154.359330571524;1161.9070474362031;1188.6671731915078;1197.461142485885;1201.195199216527;1209.0810983652311;1214.313912639356;6502.0246962955935;6580.374864387875;6605.900911486331;6628.767993120314;6690.163729533809;431.15063325249207;435.7407342631129;443.7005021610465;444.62873500627336;445.72365133617365;5056.115179843513;5131.409887862869;5135.12702840518;5139.408967968657;5145.279660847485;8430.578471076422;8478.06741258461;8678.218960293478;8718.302535797122;8777.736667899973;8558.272546833465;8620;8650.35122365825;8651.913480865236;8682.95658521716;6699.665016749143;6743.797686069426;6859.2454829968665;6891.138607674041;6893.448524118159;6411.262704789009;6420.646864422315;6421.389967953037;6424.100625912282;6428.228612566522;7518.962405187939;7615.276548727862;7779.4554381192775;7808.5314881107315;7927.128015918129;7843.254890785366;8010.3992200584025;8062.355011598941;8078.798030049295;8088.919110808816;5508.669479831223;5654.943450565442;6047.425494578008;6251.218597675291;6311.779087732091;6683.331666833278;6720.428763555153;6730.4952128589575;6731.966340168267;6738.898916516158;6091.329953705001;6404.359564043559;6501.902471463027;6553.082568440327;6669.199696036507;6208.4722798562625;6217.751289948352;6276.6547839869245;6305.274893387319;6390.137331460193;6425.742970281323;6521.054447105048;6522.5760325578685;6526.053722210348;6534.967325163344;5956.076808094752;5959.702014899324;5983.760649573968;5992.550558708027;6011.158437818622;6033.577649564489;6049.304330002106;6051.1830902829315;6082.817515474543;6133.478654314434 13:51:33 INFO - PROCESS | 3463 | |4;prototype.html;320.26019894044754;321.1905996887843;327.06133397150154;329.7180910321675;332.4166088514658;5473.8357849264485;5561.277033985586;5591.1054231323;5617.83146505605;5653.745581448834;5410.756515956781;5527.751251193696;5582.944170558293;5596.748146333414;5609.046462101443;4369.606735393814;4372.038151606657;4373.781310934456;4380.233459144652;4386.32012038133;4373.409589705397;4374.081442896995;4376.934345984812;4377;4384.320430333303;4250.553691862357;4281.807318670667;4313.374560688714;4338.97830510847;4346.8913277168;4310.48274207094;4310.741355518648;4314.913701725948;4316.9136617267795;4320.0711846952745;3783.1677031053123;3785.167263202091;3785.6025117362833;3790.298794722985;3794;5371.086915224382;5394.622376433651;5395.514403703646;5398.811041613564;5416.079266524661;4744.525547445262;4874.049560335736;4950.4307004694565;4952.182889823175;4973.129702302119;5689.118186681071;5825.126231065332;5854.5023672987845;5916.585838991272;5924.674142922137;4084.264832330179;4085.121698834735;4092.815823287959;4094.3858421236755;4099.97950010251;6143.600665956698;6209.658468784215;6213.068039794022;6213.782517611907;6222;4139.441175441277;4212.747235165839;4218.346156345771;4223.155368926227;4226.978865105655;4269.487661480643;4269.87190384289;4271;4272.209641216385;4278.080212754273;4904.239842824368;4909.042736666316;4910.116179087799;4925.1381008324115;4929.288891109875;5857.531397488191;5878.647281163144;5883.235179426647;5898.587098903122;5910.615809972338;1470.8161479815024;1483.5549335199396;1519.6808670179164;1519.8708109810568;1527.129536164398;973.7808992976524;1015.1878497202356;1021.4943602916604;1021.5045702834119;1028.1774580335702;5039.143345631178;5054.1407960646775;5076.213186956028;5076.44159142494;5081.0854046272025;5990.820275391745;6090.847728806727;6099;6104.114903338991;6118.296395914438;5099.260607212008;5110.565601923804;5116.846494605168;5122.667026643257;5126.769295381717;3262.6574209708115;3268.3299923515624;3277.492353517361;3309.7683162178896;3319.7842140260805;5738.885222295614;5756.33802112754;5758.049921762946;5759.798407055817;5764.769409223584;6250.781222657276;6267.467265282411;6268.652239768472;6281.466075383552;6283.842903927347;5704.22992895962;5736.913946290809;5774.68239246837;5860.912086318794;5891.469767720926;6203.8138855834395;6223.626582405071;6225.844353891189;6229.595076320024;6254.343293954252;6053.515718742578;6062.787802426894;6064.514838812973;6065.909011364744;6067.514598832171;5770.653760774367;5831.533477321889;5850.180974663635;5866.706664666664;5876.3536011039605;4195.811188496464;4224.15516896628;4232.111256636141;4236.110416812504;4236.512801027921;6202.2867370253;6208.81373558794;6209.534284928739;6223;6228.688565571794;5865.875926027295;5964.761409543569;5967.433093856251;5968.7612495501435;5972.910406343822;5928.822135335774;5985.610935289193;5989.101634754822;5990.550708696952;5995.070764031582;5823.1847541343395;5853.414658534112;5856.472917437451;5869.765209391577;5871.03127983895;5982.4017598239825;6001.399860013964;6011.639301641915;6018.157457955802;6030.788922387871;5726.484616384545;5853.736581853912;5871.119332100048;5884.764609415575;5894.145348924296 13:51:33 INFO - PROCESS | 3463 | |5;yui.html;640.7693230437042;719.4172720096722;721.8736721073814;724.5362967700669;727.1964479250428;11166.274192177503;11198.664040078791;11310.321380717141;11318;11324.886751132497;10856.891431085687;11517;11536.826947595793;11544.07647388209;11552.133589980744;620.1813606040029;627.0124553827717;774.5159275452842;779.4388040610751;779.7115067425033;791.9445638805286;799.7720649614861;801.8396320735847;805.7341077444459;807.0597753617029;833.7332053742805;836.5399030533213;837.2799392522426;837.4849467577457;838;832.4713806732738;835.3317346123077;835.7826964989085;835.9289460395843;837.1084794693662;619.8078595635322;619.8140557832633;620.5314987184692;620.6462316479608;623.7910300049489;11850.644480665595;11896.405179740977;11906.821397679041;11928.582499612472;11933.701657458547;11952.103592230618;12036.63890083299;12127.508338345404;12195.45120469581;12229.205101668364;9546.713598591983;9605.711828645151;9666.661666841697;9680.806383872354;9765.90234097657;3262.1681471224924;3269.264415506516;3280.1963518938014;3320.7509436792097;3391.8812841550425;36197.27605447876;36317.99999999974;36411.4538281926;36517.81741091304;36552.63447365545;8756.168164024408;8776.297896168291;8816.294696424271;8830;8884.777880553038;16623.584410389838;16669.749953750703;16688.91655541739;16763.91618041902;16770.32918683239;6379.936200638027;6477.384648458389;6510.511711621647;6596.076549283104;6770.289119642367;3482.233908540117;3542.3092496962845;3556.8043757593064;3602.225521512887;3665;2632.197179860161;2677.718839521861;2684.758371746513;2686.1001564475728;2697.8381297122237;461.3172504693073;517.2138349708422;523.1838332201702;523.6962561714197;537.196890648483;456.1970931161114;464.2687766767355;472.7329059081608;516.9560587350043;519.6803965561153;6930.3762661360715;6993.2657071007825;6994.860102797916;7109.928900710926;7265.273472652692;485.91253574356955;530.3370786516854;532.1671583971073;606.2300877885061;617.7035023188895;3219.259570298844;3302.1909632140278;3308.6856748608843;3376.69609735125;3389.6610338965907;48278;48329.51670483321;48376.5162348379;48431.273530897066;48641.27038094431;38239;38889.805550972065;38971.61028389737;39133.60866391357;39362;31741.20646983844;32513.18717032046;32625.51061734076;32953.835230824174;33103.172420689676;7341.559506429631;7637.809054773675;7685.03937007874;7698.307152356091;7944.563049032358;28727;30525.54211686871;30873;31597;32283;35908.820455897556;35962.28075438529;36584.26831463409;36642.45036324404;36661;9894.257930655085;10123.341982771097;10192.745181370525;10368.118709909742;10463.319884207502;11016.944915275373;11055.72360690957;11220.270682405617;11919;12136.211146275464;9516.38143520669;9710;9729.951350243204;10007.199424046205;10057.49712514386;9677.467739274407;10127.848082278624;10520.053195212467;10697.358158510515;10790.406527641055;9083;9713.174380177481;9800.705978820646;10087.445190514592;10120.342177758423;8040.557769322743;8099.493284402248;8189.590520474072;8286.088530261786;8543;7787.883181752165;8025.317847982987;8306.169383061646;8491.320694344315;8546.2308392245 13:51:33 INFO - PROCESS | 3463 | __end_tp_report 13:51:33 INFO - PROCESS | 3463 | __start_cc_report 13:51:33 INFO - PROCESS | 3463 | _x_x_mozilla_cycle_collect,333 13:51:33 INFO - PROCESS | 3463 | __end_cc_report 13:51:33 INFO - PROCESS | 3463 | __startTimestamp1452549093072__endTimestamp 13:51:33 INFO - PROCESS | 3463 | 13:51:33 INFO - PROCESS | 3463 | ------- Summary: start ------- 13:51:33 INFO - PROCESS | 3463 | Number of tests: 6 13:51:33 INFO - PROCESS | 3463 | 13:51:33 INFO - PROCESS | 3463 | [#0] dojo.html Cycles:165 Average:4605.57 Median:4727.24 stddev:468.00 (9.9%) stddev-sans-first:443.36 13:51:33 INFO - PROCESS | 3463 | Values: 2641.9 2674.1 2707.6 2719.0 2727.1 4543.7 4604.1 4611.3 4644.0 4650.7 4559.9 4577.2 4610.3 4680.7 4708.4 4286.4 4333.1 4372.7 4393.6 4413.1 4263.9 4334.5 4362.3 4416.0 4437.2 4171.1 4172.2 4284.0 4358.8 4386.0 4286.7 4309.6 4323.4 4326.1 4351.7 4273.4 4285.8 4288.4 4300.2 4345.5 4401.8 4516.5 4517.5 4553.1 4647.5 4973.4 4978.0 5000.4 5027.2 5035.5 4993.3 5004.2 5033.0 5033.4 5034.6 4504.6 4566.2 4624.9 4668.6 4690.0 5111.2 5124.3 5130.8 5134.6 5181.1 4716.6 4913.9 4923.9 4924.0 4957.9 4860.2 4899.7 5000.2 5006.6 5047.4 4875.0 4891.4 4896.5 4937.4 4951.0 4740.0 4867.6 4917.9 4931.4 4962.6 4151.2 4195.5 4206.8 4229.9 4234.0 3679.0 3693.9 3707.1 3708.2 3744.3 4185.6 4296.8 4298.9 4336.2 4361.7 5040.5 5048.1 5051.2 5055.7 5068.4 4354.8 4358.7 4362.1 4384.3 4395.4 4307.8 4413.5 4428.9 4502.5 4536.1 4734.0 4751.4 4755.4 4774.8 4804.8 5004.2 5012.2 5014.2 5027.5 5077.7 4498.6 4630.7 4653.2 4653.6 4671.3 4883.5 4948.1 4952.5 4968.9 4983.3 4956.5 4987.2 4991.3 4998.8 5023.7 4681.0 4758.0 4783.7 4836.1 4872.8 4894.6 4902.9 4908.3 4910.6 4917.6 4730.7 4762.7 4776.3 4784.7 4792.4 4727.2 4795.4 4847.7 4879.5 4884.1 4771.1 4775.7 4783.6 4797.9 4807.6 13:51:33 INFO - PROCESS | 3463 | 13:51:33 INFO - PROCESS | 3463 | [#1] ext.html Cycles:180 Average:38883.66 Median:35058.41 stddev:60433.75 (172.4%) stddev-sans-first:60534.60 13:51:33 INFO - PROCESS | 3463 | Values: 510.9 513.1 536.1 536.9 542.3 34937.5 35274.8 35336.8 35539.3 35589.3 40273.6 40750.0 40854.2 40923.6 40929.8 7762.4 7949.8 7976.4 7977.9 7981.7 7615.3 7656.3 7714.2 7734.3 7742.2 7676.5 7742.7 7747.1 7750.7 7798.3 7665.6 7730.3 7733.0 7752.6 7756.2 7744.1 7796.7 7855.6 7865.6 7882.4 36361.5 36406.6 36925.0 36989.3 36994.8 2897.1 2912.0 2958.6 3077.6 3556.1 27524.3 27919.7 28150.3 28281.6 28329.0 3322.6 3329.7 3363.8 3368.2 3461.4 208790.0 212058.0 212218.0 212391.0 212795.0 46815.8 47519.3 55951.0 57148.0 58082.1 48060.3 48335.5 48436.8 48627.3 48752.3 12559.8 12681.4 12734.7 12777.7 12797.2 10642.9 10653.5 10688.9 10719.4 10745.6 19112.4 19226.0 19401.3 19483.7 19518.0 7510.5 7624.8 7751.8 7781.0 7835.1 804.9 830.7 839.2 866.7 911.1 23970.5 24319.8 24480.0 24481.4 24756.8 910.4 934.6 966.1 987.9 1032.6 12408.8 12455.9 12538.2 12554.3 12643.7 241048.0 244962.0 245437.0 245591.0 245687.0 46276.5 46284.5 46290.3 46336.5 46711.0 1234.3 1241.6 1249.6 1251.2 1253.2 24056.5 24157.9 24205.3 24330.9 24378.3 34617.1 35145.0 35204.0 35232.1 35510.3 238572.0 239297.0 239351.0 239564.0 241856.0 28995.1 37809.4 37922.3 38166.5 38464.6 34262.3 34951.5 34971.8 35250.3 35415.0 29690.9 33146.2 34583.3 35247.0 35683.8 30405.1 32169.5 34317.7 34627.8 34766.8 30260.5 34565.1 35445.8 35447.6 35498.1 25819.9 27369.5 27535.3 27572.7 27613.0 19391.0 19562.4 19645.1 20126.6 20323.1 13:51:33 INFO - PROCESS | 3463 | 13:51:33 INFO - PROCESS | 3463 | [#2] jquery.html Cycles:180 Average:22140.23 Median:5026.58 stddev:69372.78 (1380.1%) stddev-sans-first:69548.05 13:51:33 INFO - PROCESS | 3463 | Values: 324.7 338.9 341.7 341.9 341.9 14162.7 14578.6 15098.3 15249.2 16036.4 9686.2 9996.8 12624.5 14667.3 14700.9 4432.2 4499.7 4623.2 5055.6 5081.9 4926.8 5003.9 5011.0 5014.2 5016.0 4778.5 4795.6 4983.1 5005.5 5037.1 4972.9 4987.5 5014.0 5056.1 5794.6 5089.9 5142.2 5142.6 5143.1 5153.6 11588.5 16873.2 17233.6 17315.6 17741.6 1809.6 1833.6 1862.9 1883.7 1899.5 8258.2 8526.0 8622.0 8772.5 10540.0 1693.6 1695.9 1706.6 1748.2 1751.5 42553.0 44253.8 44505.0 45502.5 49248.0 9340.6 9728.7 9816.7 9836.7 9868.8 12372.4 12407.3 12422.5 12431.5 12458.3 7031.7 7035.3 7082.5 7098.2 7122.4 6619.2 6624.6 6653.6 6667.9 6731.9 3886.3 3933.4 3943.1 3956.2 3965.1 1637.8 1723.2 1727.4 1744.9 1745.1 399.9 762.3 895.1 912.4 991.1 9103.4 9236.4 9512.7 9627.2 9723.6 370.9 400.4 401.1 404.0 405.2 5007.5 5161.8 5171.1 5228.5 5243.9 398385.0 401890.0 436304.0 439731.0 442705.0 61750.0 63773.4 64660.0 65024.0 65435.7 455.6 458.6 459.0 459.2 461.4 8794.9 9136.5 9162.6 9310.1 9374.7 27634.9 27793.4 28283.9 28396.6 28740.3 33261.7 33460.8 33787.7 33877.0 35415.8 6094.7 6241.3 6297.9 6372.2 6375.0 7313.6 8960.0 9017.3 9253.0 9282.1 7478.2 7517.4 7881.4 7951.1 7970.4 7900.1 8182.9 8361.3 8428.5 8594.6 7914.4 7980.1 8134.5 8169.0 8210.1 6275.2 6328.4 6510.0 6560.7 6624.3 7549.9 7785.0 7807.8 7918.2 8376.9 13:51:33 INFO - PROCESS | 3463 | 13:51:33 INFO - PROCESS | 3463 | [#3] mootools.html Cycles:180 Average:4975.60 Median:6067.00 stddev:2571.03 (42.4%) stddev-sans-first:2563.95 13:51:33 INFO - PROCESS | 3463 | Values: 1368.7 1370.8 1473.9 1702.3 1718.5 6117.3 6216.2 7009.1 7219.2 7228.5 6833.8 6993.3 7054.6 7061.3 7079.7 2140.3 2172.6 2173.1 2174.6 2180.3 2076.2 2082.7 2122.4 2139.8 2141.1 2124.0 2126.0 2132.9 2140.6 2170.8 2144.1 2149.7 2151.4 2152.5 2155.1 2083.5 2118.4 2125.4 2130.7 2132.0 7255.3 7296.8 7305.1 7306.3 7329.9 4217.6 4293.3 4322.2 4322.8 4327.5 2589.0 2616.3 2827.2 2828.9 2834.7 824.1 837.9 841.5 851.6 898.5 9307.4 9340.6 9400.6 9426.2 9435.1 4003.7 4029.9 4030.6 4036.3 4108.3 8248.1 8259.9 8264.8 8279.5 8281.1 4324.8 4347.8 4356.8 4357.7 4366.4 3275.7 3363.1 3842.6 3938.3 3959.0 3512.2 3534.7 3534.7 3538.1 3540.1 1147.9 1153.2 1153.6 1154.4 1161.9 1188.7 1197.5 1201.2 1209.1 1214.3 6502.0 6580.4 6605.9 6628.8 6690.2 431.2 435.7 443.7 444.6 445.7 5056.1 5131.4 5135.1 5139.4 5145.3 8430.6 8478.1 8678.2 8718.3 8777.7 8558.3 8620.0 8650.4 8651.9 8683.0 6699.7 6743.8 6859.2 6891.1 6893.4 6411.3 6420.6 6421.4 6424.1 6428.2 7519.0 7615.3 7779.5 7808.5 7927.1 7843.3 8010.4 8062.4 8078.8 8088.9 5508.7 5654.9 6047.4 6251.2 6311.8 6683.3 6720.4 6730.5 6732.0 6738.9 6091.3 6404.4 6501.9 6553.1 6669.2 6208.5 6217.8 6276.7 6305.3 6390.1 6425.7 6521.1 6522.6 6526.1 6535.0 5956.1 5959.7 5983.8 5992.6 6011.2 6033.6 6049.3 6051.2 6082.8 6133.5 13:51:33 INFO - PROCESS | 3463 | 13:51:33 INFO - PROCESS | 3463 | [#4] prototype.html Cycles:180 Average:4900.21 Median:5500.79 stddev:1449.83 (26.4%) stddev-sans-first:1412.55 13:51:33 INFO - PROCESS | 3463 | Values: 320.3 321.2 327.1 329.7 332.4 5473.8 5561.3 5591.1 5617.8 5653.7 5410.8 5527.8 5582.9 5596.7 5609.0 4369.6 4372.0 4373.8 4380.2 4386.3 4373.4 4374.1 4376.9 4377.0 4384.3 4250.6 4281.8 4313.4 4339.0 4346.9 4310.5 4310.7 4314.9 4316.9 4320.1 3783.2 3785.2 3785.6 3790.3 3794.0 5371.1 5394.6 5395.5 5398.8 5416.1 4744.5 4874.0 4950.4 4952.2 4973.1 5689.1 5825.1 5854.5 5916.6 5924.7 4084.3 4085.1 4092.8 4094.4 4100.0 6143.6 6209.7 6213.1 6213.8 6222.0 4139.4 4212.7 4218.3 4223.2 4227.0 4269.5 4269.9 4271.0 4272.2 4278.1 4904.2 4909.0 4910.1 4925.1 4929.3 5857.5 5878.6 5883.2 5898.6 5910.6 1470.8 1483.6 1519.7 1519.9 1527.1 973.8 1015.2 1021.5 1021.5 1028.2 5039.1 5054.1 5076.2 5076.4 5081.1 5990.8 6090.8 6099.0 6104.1 6118.3 5099.3 5110.6 5116.8 5122.7 5126.8 3262.7 3268.3 3277.5 3309.8 3319.8 5738.9 5756.3 5758.0 5759.8 5764.8 6250.8 6267.5 6268.7 6281.5 6283.8 5704.2 5736.9 5774.7 5860.9 5891.5 6203.8 6223.6 6225.8 6229.6 6254.3 6053.5 6062.8 6064.5 6065.9 6067.5 5770.7 5831.5 5850.2 5866.7 5876.4 4195.8 4224.2 4232.1 4236.1 4236.5 6202.3 6208.8 6209.5 6223.0 6228.7 5865.9 5964.8 5967.4 5968.8 5972.9 5928.8 5985.6 5989.1 5990.6 5995.1 5823.2 5853.4 5856.5 5869.8 5871.0 5982.4 6001.4 6011.6 6018.2 6030.8 5726.5 5853.7 5871.1 5884.8 5894.1 13:51:33 INFO - PROCESS | 3463 | 13:51:33 INFO - PROCESS | 3463 | [#5] yui.html Cycles:180 Average:11488.65 Median:24375.37 stddev:12539.52 (51.4%) stddev-sans-first:12548.23 13:51:33 INFO - PROCESS | 3463 | Values: 640.8 719.4 721.9 724.5 727.2 11166.3 11198.7 11310.3 11318.0 11324.9 10856.9 11517.0 11536.8 11544.1 11552.1 620.2 627.0 774.5 779.4 779.7 791.9 799.8 801.8 805.7 807.1 833.7 836.5 837.3 837.5 838.0 832.5 835.3 835.8 835.9 837.1 619.8 619.8 620.5 620.6 623.8 11850.6 11896.4 11906.8 11928.6 11933.7 11952.1 12036.6 12127.5 12195.5 12229.2 9546.7 9605.7 9666.7 9680.8 9765.9 3262.2 3269.3 3280.2 3320.8 3391.9 36197.3 36318.0 36411.5 36517.8 36552.6 8756.2 8776.3 8816.3 8830.0 8884.8 16623.6 16669.7 16688.9 16763.9 16770.3 6379.9 6477.4 6510.5 6596.1 6770.3 3482.2 3542.3 3556.8 3602.2 3665.0 2632.2 2677.7 2684.8 2686.1 2697.8 461.3 517.2 523.2 523.7 537.2 456.2 464.3 472.7 517.0 519.7 6930.4 6993.3 6994.9 7109.9 7265.3 485.9 530.3 532.2 606.2 617.7 3219.3 3302.2 3308.7 3376.7 3389.7 48278.0 48329.5 48376.5 48431.3 48641.3 38239.0 38889.8 38971.6 39133.6 39362.0 31741.2 32513.2 32625.5 32953.8 33103.2 7341.6 7637.8 7685.0 7698.3 7944.6 28727.0 30525.5 30873.0 31597.0 32283.0 35908.8 35962.3 36584.3 36642.5 36661.0 9894.3 10123.3 10192.7 10368.1 10463.3 11016.9 11055.7 11220.3 11919.0 12136.2 9516.4 9710.0 9730.0 10007.2 10057.5 9677.5 10127.8 10520.1 10697.4 10790.4 9083.0 9713.2 9800.7 10087.4 10120.3 8040.6 8099.5 8189.6 8286.1 8543.0 7787.9 8025.3 8306.2 8491.3 8546.2 13:51:33 INFO - PROCESS | 3463 | -------- Summary: end -------- 13:51:33 INFO - PROCESS | 3463 | 13:51:33 INFO - TEST-INFO | 3463: exit 0 13:51:33 INFO - TEST-OK | dromaeo_css | took 1120000ms 13:51:33 INFO - TEST-START | kraken 13:51:33 INFO - operating with platform_type : linux_ 13:51:33 INFO - Initialising browser for kraken test... 13:51:33 INFO - TEST-INFO | started process 3697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptHNTAE/profile http://localhost:60583/getInfo.html) 13:51:38 INFO - PROCESS | 3697 | 13:51:38 INFO - PROCESS | 3697 | (process:3772): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:51:39 INFO - PROCESS | 3697 | __metrics Screen width/height:1600/1200 13:51:39 INFO - PROCESS | 3697 | colorDepth:24 13:51:39 INFO - PROCESS | 3697 | Browser inner width/height: 1024/697 13:51:39 INFO - PROCESS | 3697 | __metrics 13:51:39 INFO - PROCESS | 3697 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:51:40 INFO - TEST-INFO | 3697: exit 0 13:51:40 INFO - Browser initialized. 13:51:40 INFO - Running cycle 1/1 for kraken test... 13:51:40 INFO - TEST-INFO | started process 3821 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptHNTAE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:51:41 INFO - PROCESS | 3821 | 13:51:41 INFO - PROCESS | 3821 | (process:3880): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:51:52 INFO - PROCESS | 3821 | RSS: Main: 149970944 13:51:52 INFO - PROCESS | 3821 | 13:51:54 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60583/tests/kraken/driver.html?testName=audio-beat-detection) 13:51:55 INFO - PROCESS | 3821 | RSS: Main: 150032384 13:51:55 INFO - PROCESS | 3821 | 13:51:58 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60583/tests/kraken/driver.html?testName=audio-dft) 13:51:58 INFO - PROCESS | 3821 | RSS: Main: 150769664 13:51:58 INFO - PROCESS | 3821 | 13:52:01 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60583/tests/kraken/driver.html?testName=audio-fft) 13:52:02 INFO - PROCESS | 3821 | RSS: Main: 145702912 13:52:02 INFO - PROCESS | 3821 | 13:52:04 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60583/tests/kraken/driver.html?testName=audio-oscillator) 13:52:05 INFO - PROCESS | 3821 | RSS: Main: 146231296 13:52:05 INFO - PROCESS | 3821 | 13:52:07 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60583/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:52:08 INFO - PROCESS | 3821 | RSS: Main: 147337216 13:52:08 INFO - PROCESS | 3821 | 13:52:11 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60583/tests/kraken/driver.html?testName=imaging-darkroom) 13:52:11 INFO - PROCESS | 3821 | RSS: Main: 147726336 13:52:11 INFO - PROCESS | 3821 | 13:52:15 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60583/tests/kraken/driver.html?testName=imaging-desaturate) 13:52:15 INFO - PROCESS | 3821 | RSS: Main: 146472960 13:52:15 INFO - PROCESS | 3821 | 13:52:18 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60583/tests/kraken/driver.html?testName=json-parse-financial) 13:52:19 INFO - PROCESS | 3821 | RSS: Main: 146862080 13:52:19 INFO - PROCESS | 3821 | 13:52:21 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60583/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:52:21 INFO - PROCESS | 3821 | RSS: Main: 148221952 13:52:21 INFO - PROCESS | 3821 | 13:52:23 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60583/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:52:24 INFO - PROCESS | 3821 | RSS: Main: 148701184 13:52:24 INFO - PROCESS | 3821 | 13:52:26 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60583/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:52:26 INFO - PROCESS | 3821 | RSS: Main: 148934656 13:52:26 INFO - PROCESS | 3821 | 13:52:29 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:52:30 INFO - PROCESS | 3821 | RSS: Main: 149192704 13:52:30 INFO - PROCESS | 3821 | 13:52:32 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:52:33 INFO - PROCESS | 3821 | RSS: Main: 149401600 13:52:33 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | Cycle 1(1): loaded http://localhost:60583/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60583/tests/kraken/driver.html?testName=ai-astar) 13:52:35 INFO - PROCESS | 3821 | RSS: Main: 150298624 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | __start_tp_report 13:52:35 INFO - PROCESS | 3821 | _x_x_mozilla_page_load 13:52:35 INFO - PROCESS | 3821 | _x_x_mozilla_page_load_details 13:52:35 INFO - PROCESS | 3821 | |i|pagename|runs| 13:52:35 INFO - PROCESS | 3821 | |0;ai-astar;114;110;113;113;114;123;113;113;114;112 13:52:35 INFO - PROCESS | 3821 | |1;audio-beat-detection;152;132;152;178;133;153;162;136;185;138 13:52:35 INFO - PROCESS | 3821 | |2;audio-dft;162;162;163;162;162;165;172;164;162;163 13:52:35 INFO - PROCESS | 3821 | |3;audio-fft;73;76;72;77;73;73;136;73;73;73 13:52:35 INFO - PROCESS | 3821 | |4;audio-oscillator;99;97;138;97;98;97;138;97;98;137 13:52:35 INFO - PROCESS | 3821 | |5;imaging-gaussian-blur;109;110;109;110;110;109;110;109;111;110 13:52:35 INFO - PROCESS | 3821 | |6;imaging-darkroom;148;148;148;149;147;148;147;148;148;148 13:52:35 INFO - PROCESS | 3821 | |7;imaging-desaturate;97;97;96;96;95;95;96;96;100;96 13:52:35 INFO - PROCESS | 3821 | |8;json-parse-financial;75;71;76;73;73;71;71;74;73;71 13:52:35 INFO - PROCESS | 3821 | |9;json-stringify-tinderbox;67;71;68;67;67;67;67;67;69;67 13:52:35 INFO - PROCESS | 3821 | |10;stanford-crypto-aes;83;92;84;88;84;86;86;88;87;84 13:52:35 INFO - PROCESS | 3821 | |11;stanford-crypto-ccm;124;121;120;126;122;123;123;127;124;132 13:52:35 INFO - PROCESS | 3821 | |12;stanford-crypto-pbkdf2;141;141;155;150;149;143;154;162;146;137 13:52:35 INFO - PROCESS | 3821 | |13;stanford-crypto-sha256-iterative;72;73;73;71;73;71;73;73;73;71 13:52:35 INFO - PROCESS | 3821 | __end_tp_report 13:52:35 INFO - PROCESS | 3821 | __start_cc_report 13:52:35 INFO - PROCESS | 3821 | _x_x_mozilla_cycle_collect,791 13:52:35 INFO - PROCESS | 3821 | __end_cc_report 13:52:35 INFO - PROCESS | 3821 | __startTimestamp1452549155343__endTimestamp 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | ------- Summary: start ------- 13:52:35 INFO - PROCESS | 3821 | Number of tests: 14 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#0] ai-astar Cycles:10 Average:113.90 Median:113.50 stddev:3.41 (3.0%) stddev-sans-first:3.62 13:52:35 INFO - PROCESS | 3821 | Values: 114.0 110.0 113.0 113.0 114.0 123.0 113.0 113.0 114.0 112.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#1] audio-beat-detection Cycles:10 Average:152.10 Median:152.50 stddev:18.50 (12.1%) stddev-sans-first:19.62 13:52:35 INFO - PROCESS | 3821 | Values: 152.0 132.0 152.0 178.0 133.0 153.0 162.0 136.0 185.0 138.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#2] audio-dft Cycles:10 Average:163.70 Median:163.00 stddev:3.09 (1.9%) stddev-sans-first:3.22 13:52:35 INFO - PROCESS | 3821 | Values: 162.0 162.0 163.0 162.0 162.0 165.0 172.0 164.0 162.0 163.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#3] audio-fft Cycles:10 Average:79.90 Median:73.00 stddev:19.77 (27.1%) stddev-sans-first:20.81 13:52:35 INFO - PROCESS | 3821 | Values: 73.0 76.0 72.0 77.0 73.0 73.0 136.0 73.0 73.0 73.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:97.00 stddev:19.38 (20.0%) stddev-sans-first:20.17 13:52:35 INFO - PROCESS | 3821 | Values: 99.0 97.0 138.0 97.0 98.0 97.0 138.0 97.0 98.0 137.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 13:52:35 INFO - PROCESS | 3821 | Values: 109.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 111.0 110.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 13:52:35 INFO - PROCESS | 3821 | Values: 148.0 148.0 148.0 149.0 147.0 148.0 147.0 148.0 148.0 148.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.43 (1.5%) stddev-sans-first:1.50 13:52:35 INFO - PROCESS | 3821 | Values: 97.0 97.0 96.0 96.0 95.0 95.0 96.0 96.0 100.0 96.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#8] json-parse-financial Cycles:10 Average:72.80 Median:73.00 stddev:1.81 (2.5%) stddev-sans-first:1.74 13:52:35 INFO - PROCESS | 3821 | Values: 75.0 71.0 76.0 73.0 73.0 71.0 71.0 74.0 73.0 71.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:67.00 stddev:1.34 (2.0%) stddev-sans-first:1.39 13:52:35 INFO - PROCESS | 3821 | Values: 67.0 71.0 68.0 67.0 67.0 67.0 67.0 67.0 69.0 67.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.50 stddev:2.70 (3.1%) stddev-sans-first:2.60 13:52:35 INFO - PROCESS | 3821 | Values: 83.0 92.0 84.0 88.0 84.0 86.0 86.0 88.0 87.0 84.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#11] stanford-crypto-ccm Cycles:10 Average:124.20 Median:124.00 stddev:3.46 (2.8%) stddev-sans-first:3.67 13:52:35 INFO - PROCESS | 3821 | Values: 124.0 121.0 120.0 126.0 122.0 123.0 123.0 127.0 124.0 132.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.80 Median:149.50 stddev:7.70 (5.2%) stddev-sans-first:7.76 13:52:35 INFO - PROCESS | 3821 | Values: 141.0 141.0 155.0 150.0 149.0 143.0 154.0 162.0 146.0 137.0 13:52:35 INFO - PROCESS | 3821 | 13:52:35 INFO - PROCESS | 3821 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:73.00 stddev:0.95 (1.3%) stddev-sans-first:1.00 13:52:35 INFO - PROCESS | 3821 | Values: 72.0 73.0 73.0 71.0 73.0 71.0 73.0 73.0 73.0 71.0 13:52:35 INFO - PROCESS | 3821 | -------- Summary: end -------- 13:52:35 INFO - PROCESS | 3821 | 13:52:36 INFO - TEST-INFO | 3821: exit 0 13:52:36 INFO - TEST-OK | kraken | took 62464ms 13:52:36 INFO - TEST-START | v8_7 13:52:36 INFO - operating with platform_type : linux_ 13:52:36 INFO - Initialising browser for v8_7 test... 13:52:36 INFO - TEST-INFO | started process 4108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp094Ogc/profile http://localhost:60583/getInfo.html) 13:52:41 INFO - PROCESS | 4108 | 13:52:41 INFO - PROCESS | 4108 | (process:4180): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:52:41 INFO - PROCESS | 4108 | __metrics Screen width/height:1600/1200 13:52:41 INFO - PROCESS | 4108 | colorDepth:24 13:52:41 INFO - PROCESS | 4108 | Browser inner width/height: 1024/697 13:52:41 INFO - PROCESS | 4108 | __metrics 13:52:42 INFO - PROCESS | 4108 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 13:52:42 INFO - PROCESS | 4108 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 13:52:43 INFO - TEST-INFO | 4108: exit 0 13:52:43 INFO - Browser initialized. 13:52:43 INFO - Running cycle 1/1 for v8_7 test... 13:52:43 INFO - TEST-INFO | started process 4229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp094Ogc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:52:44 INFO - PROCESS | 4229 | 13:52:44 INFO - PROCESS | 4229 | (process:4287): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 13:52:55 INFO - PROCESS | 4229 | RSS: Main: 150310912 13:52:55 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | Cycle 1(1): loaded http://localhost:60583/tests/v8_7/run.html (next: http://localhost:60583/tests/v8_7/run.html) 13:53:17 INFO - PROCESS | 4229 | RSS: Main: 145944576 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | __start_tp_report 13:53:17 INFO - PROCESS | 4229 | _x_x_mozilla_page_load 13:53:17 INFO - PROCESS | 4229 | _x_x_mozilla_page_load_details 13:53:17 INFO - PROCESS | 4229 | |i|pagename|runs| 13:53:17 INFO - PROCESS | 4229 | |0;Richards;171.3796058269066 13:53:17 INFO - PROCESS | 4229 | |1;DeltaBlue;187.44142455482663 13:53:17 INFO - PROCESS | 4229 | |2;Encrypt;277.9321845469705 13:53:17 INFO - PROCESS | 4229 | |3;Decrypt;5175.257731958763 13:53:17 INFO - PROCESS | 4229 | |4;RayTrace;1098.901098901099 13:53:17 INFO - PROCESS | 4229 | |5;Earley;702.7406886858749 13:53:17 INFO - PROCESS | 4229 | |6;Boyer;12345.67901234568 13:53:17 INFO - PROCESS | 4229 | |7;RegExp;44866.666666666664 13:53:17 INFO - PROCESS | 4229 | |8;Splay;595.7320687611144 13:53:17 INFO - PROCESS | 4229 | |9;NavierStokes;4826.923076923077 13:53:17 INFO - PROCESS | 4229 | __end_tp_report 13:53:17 INFO - PROCESS | 4229 | __startTimestamp1452549197751__endTimestamp 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | ------- Summary: start ------- 13:53:17 INFO - PROCESS | 4229 | Number of tests: 10 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | [#0] Richards Cycles:1 Average:171.38 Median:171.38 stddev:0.00 (0.0%) 13:53:17 INFO - PROCESS | 4229 | Values: 171.4 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | [#1] DeltaBlue Cycles:1 Average:187.44 Median:187.44 stddev:0.00 (0.0%) 13:53:17 INFO - PROCESS | 4229 | Values: 187.4 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 13:53:17 INFO - PROCESS | 4229 | Values: 277.9 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 13:53:17 INFO - PROCESS | 4229 | Values: 5175.3 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | [#4] RayTrace Cycles:1 Average:1098.90 Median:1098.90 stddev:0.00 (0.0%) 13:53:17 INFO - PROCESS | 4229 | Values: 1098.9 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | [#5] Earley Cycles:1 Average:702.74 Median:702.74 stddev:0.00 (0.0%) 13:53:17 INFO - PROCESS | 4229 | Values: 702.7 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | [#6] Boyer Cycles:1 Average:12345.68 Median:12345.68 stddev:0.00 (0.0%) 13:53:17 INFO - PROCESS | 4229 | Values: 12345.7 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | [#7] RegExp Cycles:1 Average:44866.67 Median:44866.67 stddev:0.00 (0.0%) 13:53:17 INFO - PROCESS | 4229 | Values: 44866.7 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | [#8] Splay Cycles:1 Average:595.73 Median:595.73 stddev:0.00 (0.0%) 13:53:17 INFO - PROCESS | 4229 | Values: 595.7 13:53:17 INFO - PROCESS | 4229 | 13:53:17 INFO - PROCESS | 4229 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 13:53:17 INFO - PROCESS | 4229 | Values: 4826.9 13:53:17 INFO - PROCESS | 4229 | -------- Summary: end -------- 13:53:17 INFO - PROCESS | 4229 | 13:53:18 INFO - TEST-INFO | 4229: exit 0 13:53:18 INFO - TEST-OK | v8_7 | took 42436ms 13:53:18 INFO - SUITE-END | took 1224s 13:53:18 INFO - Completed test suite (00:20:24) 13:53:18 INFO - Working with test: dromaeo_css 13:53:18 INFO - Generating results file: dromaeo_css 13:53:18 INFO - Working with test: kraken 13:53:18 INFO - Generating results file: kraken 13:53:18 INFO - javascript benchmark 13:53:18 INFO - Working with test: v8_7 13:53:18 INFO - Generating results file: v8_7 13:53:18 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:53:18 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 13:53:18 INFO - process_Request line: dromaeo_css 6048.58 graph.html#tests=[[72,132,43]] 13:53:18 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:53:18 INFO - process_Request line: kraken 1544.20 graph.html#tests=[[232,132,43]] 13:53:18 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:53:18 INFO - process_Request line: v8_7 20173.89 graph.html#tests=[[230,132,43]] 13:53:18 INFO - RETURN: dromaeo_css: 6048.58 13:53:18 INFO - RETURN: kraken: 1544.20 13:53:18 INFO - RETURN: v8_7: 20173.89 13:53:18 INFO - javascript benchmark 13:53:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2641.920742377728, 2674.1175412114003, 2707.6209330693705, 2719.04833308342, 2727.113688051383, 4543.681942264043, 4604.102200070984, 4611.308303754438, 4643.953560464394, 4650.720956742593, 4559.908801823962, 4577.244754615484, 4610.262358022717, 4680.719156850591, 4708.387909571751, 4286.357046443035, 4333.133373325331, 4372.672049596277, 4393.604575588196, 4413.095315460323, 4263.893402664927, 4334.5448727883595, 4362.280223763075, 4415.955840441603, 4437.2013037653205, 4171.10321280923, 4172.18642364739, 4284.0, 4358.8038538265855, 4386.035072284077, 4286.721363111388, 4309.5690430956965, 4323.351497275403, 4326.069894972565, 4351.717138386027, 4273.358996150571, 4285.764282964436, 4288.378185163165, 4300.182965236595, 4345.521992580813, 4401.801918913657, 4516.503184649686, 4517.548245175456, 4553.112143132091, 4647.53524647536, 4973.42805577356, 4978.0, 5000.399952005746, 5027.2207807789855, 5035.471275516054, 4993.325901003354, 5004.199328107522, 5032.974835125801, 5033.446320904697, 5034.597232221414, 4504.617107545862, 4566.1552612766745, 4624.930626040578, 4668.603168730696, 4689.976550117228, 5111.207762796698, 5124.256982737482, 5130.79476820923, 5134.589232861362, 5181.145111056633, 4716.599089077398, 4913.901721965541, 4923.926141107886, 4924.0, 4957.851264462072, 4860.1737704590305, 4899.730514821647, 5000.224965130411, 5006.574441172468, 5047.4447810740785, 4874.975625121922, 4891.364122664031, 4896.510348965075, 4937.407511098691, 4950.985048065138, 4739.952600473951, 4867.63492738039, 4917.9426423319155, 4931.3835770528685, 4962.578180854595, 4151.169766046743, 4195.538490766014, 4206.810693518799, 4229.851955181553, 4234.026173980002, 3678.9632103679155, 3693.9445908311395, 3707.147356108056, 3708.1841994761107, 3744.2885851688093, 4185.560516145822, 4296.806643701041, 4298.914021719548, 4336.176126536011, 4361.694681372273, 5040.495950405004, 5048.116579598555, 5051.191809310492, 5055.7219352935945, 5068.391792984792, 4354.760488173181, 4358.6730995175485, 4362.1275744851155, 4384.276594361958, 4395.428594282723, 4307.8492252771, 4413.492448368479, 4428.933565996513, 4502.459704835441, 4536.070105628338, 4734.005858769697, 4751.40607424072, 4755.358026666356, 4774.761261936958, 4804.783784729626, 5004.224345226496, 5012.1980483122525, 5014.17266151081, 5027.472115427828, 5077.720725360141, 4498.595126438636, 4630.722156670476, 4653.162430762495, 4653.60444362233, 4671.299305104261, 4883.5116488352305, 4948.05986862495, 4952.529509696573, 4968.8757781055765, 4983.27742477346, 4956.454789973172, 4987.1521841287795, 4991.326170966873, 4998.775055122601, 5023.673461225008, 4681.0, 4757.976210118927, 4783.6651434399255, 4836.056968891173, 4872.780724867319, 4894.608431325557, 4902.8774280643265, 4908.263760435963, 4910.631702622246, 4917.631177661761, 4730.716157030589, 4762.738049407178, 4776.307435421914, 4784.712917224978, 4792.376990991149, 4727.2436410174205, 4795.424549054136, 4847.733374664286, 4879.536444037811, 4884.096442158212, 4771.117343291502, 4775.665703400868, 4783.6412269079265, 4797.880052998703, 4807.6394270429155], "unit": "score", "name": "dojo.html", "value": 4577.2022469229605}, {"lowerIsBetter": false, "replicates": [510.90803655342023, 513.0662194805456, 536.0565404887399, 536.9221462887881, 542.3166809819627, 34937.45813044304, 35274.823625881836, 35336.82331588345, 35539.2892142157, 35589.2882142357, 40273.597264027354, 40750.0, 40854.182916341655, 40923.59076409235, 40929.795351023204, 7762.4178186635945, 7949.801254968643, 7976.361891048702, 7977.920220797776, 7981.720639777609, 7615.276548727862, 7656.349210317129, 7714.151443341228, 7734.342580880632, 7742.225777422269, 7676.501027433227, 7742.729004484844, 7747.147813740484, 7750.728724494644, 7798.2981531662135, 7665.616719164047, 7730.265624765694, 7733.0, 7752.573608451533, 7756.185600511922, 7744.148143704188, 7796.688132474695, 7855.607219639052, 7865.567393793339, 7882.448228623999, 36361.45457818135, 36406.63593364086, 36925.0, 36989.260214795555, 36994.81502592497, 2897.101898411478, 2911.956320655192, 2958.5562165675105, 3077.615298087739, 3556.05764472415, 27524.311892202655, 27919.720802791915, 28150.296242593893, 28281.57577636337, 28329.008484703143, 3322.551455553518, 3329.716974057208, 3363.831808409594, 3368.1579605098727, 3461.4060215289915, 208790.0, 212058.0, 212218.0, 212391.0, 212795.0, 46815.765921170176, 47519.287210691866, 55951.0, 57148.0, 58082.12876806851, 48060.27909581359, 48335.5166448331, 48436.78908027327, 48627.27059094117, 48752.26871596858, 12559.811602825965, 12681.429335679917, 12734.68163295925, 12777.68055798594, 12797.23216606988, 10642.946785266024, 10653.520591573242, 10688.89311106879, 10719.356838589709, 10745.623903163352, 19112.426627201206, 19226.0, 19401.32095376655, 19483.707744383846, 19518.0, 7510.511816731895, 7624.80937976555, 7751.844963100706, 7780.961095194601, 7835.138134805281, 804.8631732605354, 830.6884918155691, 839.1817977472039, 866.696656170348, 911.1298709732322, 23970.52058958811, 24319.756802432104, 24480.02079916819, 24481.387965300655, 24756.752432475805, 910.4355299714219, 934.56075644447, 966.1401352796017, 987.9110880020833, 1032.5611615063567, 12408.81386779199, 12455.929526968783, 12538.185017973985, 12554.309512976874, 12643.747125057447, 241048.0, 244962.0, 245437.0, 245591.0, 245687.0, 46276.5372346279, 46284.5371546287, 46290.30564541535, 46336.5366346339, 46711.0, 1234.2656119608819, 1241.5654520917606, 1249.6001279590625, 1251.2117366059324, 1253.2042153232762, 24056.51886962216, 24157.879210603835, 24205.258194410657, 24330.93187079118, 24378.26865194047, 34617.134571635914, 35145.0, 35204.0, 35232.11919702028, 35510.28979420449, 238572.0, 239297.0, 239351.0, 239564.0, 241856.0, 28995.13014609565, 37809.432858507695, 37922.345435819225, 38166.47334106605, 38464.6153538461, 34262.31475370529, 34951.475727864614, 34971.82514087515, 35250.306165804606, 35415.0, 29690.851545742134, 33146.17134571655, 34583.30833383369, 35247.0, 35683.82158089193, 30405.087847364615, 32169.517457238628, 34317.65682343145, 34627.826860865534, 34766.82616586901, 30260.54609180908, 34565.13587160341, 35445.82277088598, 35447.64552354444, 35498.11254718549, 25819.87090064613, 27369.45261094727, 27535.31161720973, 27572.72427275782, 27613.0, 19391.0, 19562.413127606196, 19645.11596978111, 20126.59746805085, 20323.08546115458], "unit": "score", "name": "ext.html", "value": 16351.59432425055}, {"lowerIsBetter": false, "replicates": [324.68829923273654, 338.9271306669067, 341.72320420459425, 341.85471174750734, 341.87008936604104, 14162.71674566508, 14578.635534111652, 15098.320575574111, 15249.237538123105, 16036.35854565816, 9686.225101991842, 9996.800063998715, 12624.495020199181, 14667.339969701363, 14700.926495367536, 4432.202203603359, 4499.730016199039, 4623.1678297906365, 5055.5702765265, 5081.923771143436, 4926.802927882881, 5003.949960500385, 5010.997800439908, 5014.222795466709, 5016.046951079284, 4778.546038126373, 4795.640326975491, 4983.053219888227, 5005.524475174852, 5037.118504261758, 4972.925406118911, 4987.451380348177, 5013.974930125344, 5056.115179843549, 5794.62334948227, 5089.898202035939, 5142.228665700138, 5142.588592912558, 5143.099957507421, 5153.6392452528335, 11588.536458541732, 16873.24070416822, 17233.569160770956, 17315.56711082233, 17741.556461088447, 1809.638072385515, 1833.587442825367, 1862.9347972821022, 1883.7080252560875, 1899.5251187203198, 8258.215469530385, 8525.976882774106, 8621.956890215508, 8772.473651580925, 10540.0, 1693.593537550979, 1695.85585225256, 1706.556295363202, 1748.1870930017603, 1751.5270876863303, 42553.0, 44253.77873110614, 44505.0, 45502.54497455016, 49248.0, 9340.57967391469, 9728.708138755848, 9816.705498835046, 9836.704898853046, 9868.80262394748, 12372.381380930918, 12407.317597532041, 12422.503099876085, 12431.502739890484, 12458.314792686308, 7031.718731250795, 7035.33164349386, 7082.468814838805, 7098.219195888448, 7122.430205583541, 6619.172603424572, 6624.6025238485845, 6653.567518111404, 6667.86664266712, 6731.899021514681, 3886.3004659161056, 3933.449317095609, 3943.1127996200626, 3956.1889812588925, 3965.107850733562, 1637.8198398176191, 1723.1987125986477, 1727.421313859871, 1744.904030278347, 1745.1448790093018, 399.88403363024395, 762.2644148396823, 895.0512456795817, 912.3522299167665, 991.1426615977127, 9103.408278461879, 9236.353455258068, 9512.667056653123, 9627.229821614254, 9723.611055557698, 370.890587276754, 400.3854083981133, 401.0935286253089, 404.0061448835897, 405.16940272441377, 5007.524285192901, 5161.819336323286, 5171.120909445403, 5228.503292187236, 5243.868903277448, 398385.0, 401890.0, 436304.0, 439731.0, 442705.0, 61750.0, 63773.36226637767, 64660.0, 65024.0, 65435.672821635584, 455.5512819872423, 458.59643513707726, 458.95869371756703, 459.2239115894128, 461.43704680289994, 8794.912050879666, 9136.49749263797, 9162.633494660406, 9310.115539023782, 9374.67188648394, 27634.861825691547, 27793.44413111767, 28283.858580706965, 28396.57405138966, 28740.281492962007, 33261.667383325854, 33460.83269583636, 33787.662123379436, 33877.0, 35415.82292088523, 6094.725737341919, 6241.344658810941, 6297.905531416941, 6372.203474565679, 6375.043743438521, 7313.634318284171, 8959.998400535893, 9017.278617710435, 9252.95373523128, 9282.118198771106, 7478.214787447458, 7517.361024312776, 7881.448298619041, 7951.125376208497, 7970.442069055111, 7900.130985591465, 8182.862852860355, 8361.331093512626, 8428.45215061019, 8594.570271486526, 7914.44598878073, 7980.12218655959, 8134.511929284262, 8169.0, 8210.055843578066, 6275.246970363585, 6328.430441260309, 6510.0, 6560.737570497126, 6624.337566243337, 7549.886751698838, 7784.9610751945875, 7807.765767026998, 7918.168592297956, 8376.916230837858], "unit": "score", "name": "jquery.html", "value": 6632.483109678001}, {"lowerIsBetter": false, "replicates": [1368.6578355411148, 1370.7601169795282, 1473.8747206487449, 1702.3190723710522, 1718.4930445518562, 6117.2659280886355, 6216.191895053648, 7009.088818453601, 7219.205887352387, 7228.457865660077, 6833.794986150411, 6993.265707100757, 7054.57672539648, 7061.258567850379, 7079.6814143363545, 2140.2937030779844, 2172.5654869026257, 2173.119886445984, 2174.56508698261, 2180.3132013415725, 2076.2006627448463, 2082.66677331627, 2122.373899699592, 2139.796719311663, 2141.122139922632, 2123.9893800530976, 2126.0326551419143, 2132.8507004509693, 2140.6039882621685, 2170.8371872109574, 2144.0673307111456, 2149.720536330283, 2151.354593621915, 2152.5049238675115, 2155.073318473056, 2083.510375061859, 2118.385668156233, 2125.447383680239, 2130.6803979403057, 2131.968020479694, 7255.2744725527555, 7296.817579560554, 7305.050343455317, 7306.342429181346, 7329.8900516492295, 4217.6204141627095, 4293.270144075484, 4322.222000039991, 4322.848700295474, 4327.459067616548, 2589.029114082219, 2616.306678730138, 2827.2225138086983, 2828.872700728472, 2834.7307005834414, 824.1099612418633, 837.8994520657499, 841.5371545649868, 851.5699571716306, 898.4654130792168, 9307.395019323721, 9340.626374944994, 9400.576974036185, 9426.15164635193, 9435.103665151868, 4003.679705623543, 4029.9194016119513, 4030.5767894371256, 4036.334004889219, 4108.342665173558, 8248.051474080557, 8259.917400826034, 8264.83470330602, 8279.50322980623, 8281.089080201173, 4324.827006919751, 4347.760873151944, 4356.825726970886, 4357.673174511924, 4366.410534577792, 3275.7051865332232, 3363.075154332578, 3842.615738426135, 3938.2714197873483, 3959.0, 3512.2097528055983, 3534.699550538233, 3534.734894882894, 3538.0800991741817, 3540.13266749648, 1147.867995180565, 1153.210051114989, 1153.5789436855487, 1154.359330571524, 1161.9070474362031, 1188.6671731915078, 1197.461142485885, 1201.195199216527, 1209.0810983652311, 1214.313912639356, 6502.0246962955935, 6580.374864387875, 6605.900911486331, 6628.767993120314, 6690.163729533809, 431.15063325249207, 435.7407342631129, 443.7005021610465, 444.62873500627336, 445.72365133617365, 5056.115179843513, 5131.409887862869, 5135.12702840518, 5139.408967968657, 5145.279660847485, 8430.578471076422, 8478.06741258461, 8678.218960293478, 8718.302535797122, 8777.736667899973, 8558.272546833465, 8620.0, 8650.35122365825, 8651.913480865236, 8682.95658521716, 6699.665016749143, 6743.797686069426, 6859.2454829968665, 6891.138607674041, 6893.448524118159, 6411.262704789009, 6420.646864422315, 6421.389967953037, 6424.100625912282, 6428.228612566522, 7518.962405187939, 7615.276548727862, 7779.4554381192775, 7808.5314881107315, 7927.128015918129, 7843.254890785366, 8010.3992200584025, 8062.355011598941, 8078.798030049295, 8088.919110808816, 5508.669479831223, 5654.943450565442, 6047.425494578008, 6251.218597675291, 6311.779087732091, 6683.331666833278, 6720.428763555153, 6730.4952128589575, 6731.966340168267, 6738.898916516158, 6091.329953705001, 6404.359564043559, 6501.902471463027, 6553.082568440327, 6669.199696036507, 6208.4722798562625, 6217.751289948352, 6276.6547839869245, 6305.274893387319, 6390.137331460193, 6425.742970281323, 6521.054447105048, 6522.5760325578685, 6526.053722210348, 6534.967325163344, 5956.076808094752, 5959.702014899324, 5983.760649573968, 5992.550558708027, 6011.158437818622, 6033.577649564489, 6049.304330002106, 6051.1830902829315, 6082.817515474543, 6133.478654314434], "unit": "score", "name": "mootools.html", "value": 4038.650471672823}, {"lowerIsBetter": false, "replicates": [320.26019894044754, 321.1905996887843, 327.06133397150154, 329.7180910321675, 332.4166088514658, 5473.8357849264485, 5561.277033985586, 5591.1054231323, 5617.83146505605, 5653.745581448834, 5410.756515956781, 5527.751251193696, 5582.944170558293, 5596.748146333414, 5609.046462101443, 4369.606735393814, 4372.038151606657, 4373.781310934456, 4380.233459144652, 4386.32012038133, 4373.409589705397, 4374.081442896995, 4376.934345984812, 4377.0, 4384.320430333303, 4250.553691862357, 4281.807318670667, 4313.374560688714, 4338.97830510847, 4346.8913277168, 4310.48274207094, 4310.741355518648, 4314.913701725948, 4316.9136617267795, 4320.0711846952745, 3783.1677031053123, 3785.167263202091, 3785.6025117362833, 3790.298794722985, 3794.0, 5371.086915224382, 5394.622376433651, 5395.514403703646, 5398.811041613564, 5416.079266524661, 4744.525547445262, 4874.049560335736, 4950.4307004694565, 4952.182889823175, 4973.129702302119, 5689.118186681071, 5825.126231065332, 5854.5023672987845, 5916.585838991272, 5924.674142922137, 4084.264832330179, 4085.121698834735, 4092.815823287959, 4094.3858421236755, 4099.97950010251, 6143.600665956698, 6209.658468784215, 6213.068039794022, 6213.782517611907, 6222.0, 4139.441175441277, 4212.747235165839, 4218.346156345771, 4223.155368926227, 4226.978865105655, 4269.487661480643, 4269.87190384289, 4271.0, 4272.209641216385, 4278.080212754273, 4904.239842824368, 4909.042736666316, 4910.116179087799, 4925.1381008324115, 4929.288891109875, 5857.531397488191, 5878.647281163144, 5883.235179426647, 5898.587098903122, 5910.615809972338, 1470.8161479815024, 1483.5549335199396, 1519.6808670179164, 1519.8708109810568, 1527.129536164398, 973.7808992976524, 1015.1878497202356, 1021.4943602916604, 1021.5045702834119, 1028.1774580335702, 5039.143345631178, 5054.1407960646775, 5076.213186956028, 5076.44159142494, 5081.0854046272025, 5990.820275391745, 6090.847728806727, 6099.0, 6104.114903338991, 6118.296395914438, 5099.260607212008, 5110.565601923804, 5116.846494605168, 5122.667026643257, 5126.769295381717, 3262.6574209708115, 3268.3299923515624, 3277.492353517361, 3309.7683162178896, 3319.7842140260805, 5738.885222295614, 5756.33802112754, 5758.049921762946, 5759.798407055817, 5764.769409223584, 6250.781222657276, 6267.467265282411, 6268.652239768472, 6281.466075383552, 6283.842903927347, 5704.22992895962, 5736.913946290809, 5774.68239246837, 5860.912086318794, 5891.469767720926, 6203.8138855834395, 6223.626582405071, 6225.844353891189, 6229.595076320024, 6254.343293954252, 6053.515718742578, 6062.787802426894, 6064.514838812973, 6065.909011364744, 6067.514598832171, 5770.653760774367, 5831.533477321889, 5850.180974663635, 5866.706664666664, 5876.3536011039605, 4195.811188496464, 4224.15516896628, 4232.111256636141, 4236.110416812504, 4236.512801027921, 6202.2867370253, 6208.81373558794, 6209.534284928739, 6223.0, 6228.688565571794, 5865.875926027295, 5964.761409543569, 5967.433093856251, 5968.7612495501435, 5972.910406343822, 5928.822135335774, 5985.610935289193, 5989.101634754822, 5990.550708696952, 5995.070764031582, 5823.1847541343395, 5853.414658534112, 5856.472917437451, 5869.765209391577, 5871.03127983895, 5982.4017598239825, 6001.399860013964, 6011.639301641915, 6018.157457955802, 6030.788922387871, 5726.484616384545, 5853.736581853912, 5871.119332100048, 5884.764609415575, 5894.145348924296], "unit": "score", "name": "prototype.html", "value": 4434.78266831513}, {"lowerIsBetter": false, "replicates": [640.7693230437042, 719.4172720096722, 721.8736721073814, 724.5362967700669, 727.1964479250428, 11166.274192177503, 11198.664040078791, 11310.321380717141, 11318.0, 11324.886751132497, 10856.891431085687, 11517.0, 11536.826947595793, 11544.07647388209, 11552.133589980744, 620.1813606040029, 627.0124553827717, 774.5159275452842, 779.4388040610751, 779.7115067425033, 791.9445638805286, 799.7720649614861, 801.8396320735847, 805.7341077444459, 807.0597753617029, 833.7332053742805, 836.5399030533213, 837.2799392522426, 837.4849467577457, 838.0, 832.4713806732738, 835.3317346123077, 835.7826964989085, 835.9289460395843, 837.1084794693662, 619.8078595635322, 619.8140557832633, 620.5314987184692, 620.6462316479608, 623.7910300049489, 11850.644480665595, 11896.405179740977, 11906.821397679041, 11928.582499612472, 11933.701657458547, 11952.103592230618, 12036.63890083299, 12127.508338345404, 12195.45120469581, 12229.205101668364, 9546.713598591983, 9605.711828645151, 9666.661666841697, 9680.806383872354, 9765.90234097657, 3262.1681471224924, 3269.264415506516, 3280.1963518938014, 3320.7509436792097, 3391.8812841550425, 36197.27605447876, 36317.99999999974, 36411.4538281926, 36517.81741091304, 36552.63447365545, 8756.168164024408, 8776.297896168291, 8816.294696424271, 8830.0, 8884.777880553038, 16623.584410389838, 16669.749953750703, 16688.91655541739, 16763.91618041902, 16770.32918683239, 6379.936200638027, 6477.384648458389, 6510.511711621647, 6596.076549283104, 6770.289119642367, 3482.233908540117, 3542.3092496962845, 3556.8043757593064, 3602.225521512887, 3665.0, 2632.197179860161, 2677.718839521861, 2684.758371746513, 2686.1001564475728, 2697.8381297122237, 461.3172504693073, 517.2138349708422, 523.1838332201702, 523.6962561714197, 537.196890648483, 456.1970931161114, 464.2687766767355, 472.7329059081608, 516.9560587350043, 519.6803965561153, 6930.3762661360715, 6993.2657071007825, 6994.860102797916, 7109.928900710926, 7265.273472652692, 485.91253574356955, 530.3370786516854, 532.1671583971073, 606.2300877885061, 617.7035023188895, 3219.259570298844, 3302.1909632140278, 3308.6856748608843, 3376.69609735125, 3389.6610338965907, 48278.0, 48329.51670483321, 48376.5162348379, 48431.273530897066, 48641.27038094431, 38239.0, 38889.805550972065, 38971.61028389737, 39133.60866391357, 39362.0, 31741.20646983844, 32513.18717032046, 32625.51061734076, 32953.835230824174, 33103.172420689676, 7341.559506429631, 7637.809054773675, 7685.03937007874, 7698.307152356091, 7944.563049032358, 28727.0, 30525.54211686871, 30873.0, 31597.0, 32283.0, 35908.820455897556, 35962.28075438529, 36584.26831463409, 36642.45036324404, 36661.0, 9894.257930655085, 10123.341982771097, 10192.745181370525, 10368.118709909742, 10463.319884207502, 11016.944915275373, 11055.72360690957, 11220.270682405617, 11919.0, 12136.211146275464, 9516.38143520669, 9710.0, 9729.951350243204, 10007.199424046205, 10057.49712514386, 9677.467739274407, 10127.848082278624, 10520.053195212467, 10697.358158510515, 10790.406527641055, 9083.0, 9713.174380177481, 9800.705978820646, 10087.445190514592, 10120.342177758423, 8040.557769322743, 8099.493284402248, 8189.590520474072, 8286.088530261786, 8543.0, 7787.883181752165, 8025.317847982987, 8306.169383061646, 8491.320694344315, 8546.2308392245], "unit": "score", "name": "yui.html", "value": 5507.281059054909}], "name": "dromaeo_css", "value": 6048.584783957465}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 113.0, 113.0, 114.0, 123.0, 113.0, 113.0, 114.0, 112.0], "unit": "score", "name": "ai-astar", "value": 113.9}, {"lowerIsBetter": true, "replicates": [152.0, 132.0, 152.0, 178.0, 133.0, 153.0, 162.0, 136.0, 185.0, 138.0], "unit": "score", "name": "audio-beat-detection", "value": 152.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 165.0, 172.0, 164.0, 162.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.7}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 72.0, 77.0, 73.0, 73.0, 136.0, 73.0, 73.0, 73.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [99.0, 97.0, 138.0, 97.0, 98.0, 97.0, 138.0, 97.0, 98.0, 137.0], "unit": "score", "name": "audio-oscillator", "value": 109.6}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 111.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 148.0, 149.0, 147.0, 148.0, 147.0, 148.0, 148.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 100.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 76.0, 73.0, 73.0, 71.0, 71.0, 74.0, 73.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 68.0, 67.0, 67.0, 67.0, 67.0, 67.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 92.0, 84.0, 88.0, 84.0, 86.0, 86.0, 88.0, 87.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [124.0, 121.0, 120.0, 126.0, 122.0, 123.0, 123.0, 127.0, 124.0, 132.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.2}, {"lowerIsBetter": true, "replicates": [141.0, 141.0, 155.0, 150.0, 149.0, 143.0, 154.0, 162.0, 146.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.8}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 73.0, 71.0, 73.0, 71.0, 73.0, 73.0, 73.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1544.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [171.3796058269066], "unit": "score", "name": "Richards", "value": 205.98717000000005}, {"lowerIsBetter": false, "replicates": [187.44142455482663], "unit": "score", "name": "DeltaBlue", "value": 352.7395299999999}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1098.901098901099], "unit": "score", "name": "RayTrace", "value": 673.3899900000001}, {"lowerIsBetter": false, "replicates": [702.7406886858749], "unit": "score", "name": "Earley", "value": 948.3768489999995}, {"lowerIsBetter": false, "replicates": [12345.67901234568], "unit": "score", "name": "Boyer", "value": 53.98350299999995}, {"lowerIsBetter": false, "replicates": [44866.666666666664], "unit": "score", "name": "RegExp", "value": 20.304271916790476}, {"lowerIsBetter": false, "replicates": [595.7320687611144], "unit": "score", "name": "Splay", "value": 136.79136019900503}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20173.89065867739}]} 13:53:18 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20173.89"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1544.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6048.58"}}} 13:53:18 INFO - Return code: 0 13:53:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:53:18 INFO - # TBPL SUCCESS # 13:53:18 INFO - Running post-action listener: _resource_record_post_action 13:53:18 INFO - Running post-run listener: _resource_record_post_run 13:53:20 INFO - Total resource usage - Wall time: 1242s; CPU: 13.0%; Read bytes: 10366976; Write bytes: 335253504; Read time: 2980; Write time: 379156 13:53:20 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 16609280; Read time: 0; Write time: 2676 13:53:20 INFO - run-tests - Wall time: 1226s; CPU: 13.0%; Read bytes: 8630272; Write bytes: 318644224; Read time: 2912; Write time: 376480 13:53:20 INFO - Running post-run listener: _upload_blobber_files 13:53:20 INFO - Blob upload gear active. 13:53:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:53:20 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 13:53:20 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'] 13:53:20 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 13:53:20 INFO - (blobuploader) - INFO - Open directory for files ... 13:53:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:53:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:53:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:21 INFO - (blobuploader) - INFO - Done attempting. 13:53:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:53:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:53:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:53:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:53:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:53:22 INFO - (blobuploader) - INFO - Done attempting. 13:53:22 INFO - (blobuploader) - INFO - Iteration through files over. 13:53:22 INFO - Return code: 0 13:53:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:53:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:53:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c812844c6edc0c7055c33a985a289401c9b6682e29a9d62ba2d4babd502b6f306f87af2df75b92191f9080b1179d091cbbcbebad3751e635086d7924809a7012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e146eafbe938d6043d2b7d78d16638704e210fadb3a9cfb637fa241dae83489a472fce9fa23c0c51a1283cd8426b80b09a56add2b8bea69b238e08fcdd1bd85"} 13:53:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:53:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:53:22 INFO - Contents: 13:53:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c812844c6edc0c7055c33a985a289401c9b6682e29a9d62ba2d4babd502b6f306f87af2df75b92191f9080b1179d091cbbcbebad3751e635086d7924809a7012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e146eafbe938d6043d2b7d78d16638704e210fadb3a9cfb637fa241dae83489a472fce9fa23c0c51a1283cd8426b80b09a56add2b8bea69b238e08fcdd1bd85"} 13:53:22 INFO - Copying logs to upload dir... 13:53:22 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1290.630893 ========= master_lag: -0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2016-01-11 13:53:22.283837) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 13:53:22.288338) ========= 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=8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c812844c6edc0c7055c33a985a289401c9b6682e29a9d62ba2d4babd502b6f306f87af2df75b92191f9080b1179d091cbbcbebad3751e635086d7924809a7012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e146eafbe938d6043d2b7d78d16638704e210fadb3a9cfb637fa241dae83489a472fce9fa23c0c51a1283cd8426b80b09a56add2b8bea69b238e08fcdd1bd85"} build_url:https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011125 build_url: 'https://queue.taskcluster.net/v1/task/NmTFIoJdR0qKaMH5JbGteQ/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/c812844c6edc0c7055c33a985a289401c9b6682e29a9d62ba2d4babd502b6f306f87af2df75b92191f9080b1179d091cbbcbebad3751e635086d7924809a7012", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0e146eafbe938d6043d2b7d78d16638704e210fadb3a9cfb637fa241dae83489a472fce9fa23c0c51a1283cd8426b80b09a56add2b8bea69b238e08fcdd1bd85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-11 13:53:22.316678) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:53:22.317011) ========= 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=8783db0840cc980e80bb0bd400000236-1452547877.620794-97351545 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004547 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-11 13:53:22.402488) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 13:53:22.402820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-11 13:53:22.403108) ========= ========= Total master_lag: 0.15 =========