builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1452715235.28 results: success (0) buildid: 20160113103434 builduid: f43abcffe6414798b9bd5e717da85506 revision: ad1f85f172b7302bef0fa9780df8e2b962780ac6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.280117) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.280549) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.280840) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006442 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.312306) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.312611) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.330093) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.330548) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004634 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.378956) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.379252) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.379651) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.379926) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 12:00:36-- 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% 53.9M=0s 2016-01-13 12:00:36 (53.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094582 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.486662) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.486960) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023519 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:35.536724) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-01-13 12:00:35.537081) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ad1f85f172b7302bef0fa9780df8e2b962780ac6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev ad1f85f172b7302bef0fa9780df8e2b962780ac6 --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=5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 12:00:36,277 truncating revision to first 12 chars 2016-01-13 12:00:36,277 Setting DEBUG logging. 2016-01-13 12:00:36,277 attempt 1/10 2016-01-13 12:00:36,277 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ad1f85f172b7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 12:00:37,564 unpacking tar archive at: mozilla-central-ad1f85f172b7/testing/mozharness/ program finished with exit code 0 elapsedTime=2.212010 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-01-13 12:00:37.763841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:37.764274) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:37.773634) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:37.773979) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 12:00:37.774388) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-13 12:00:37.774699) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:00:38 INFO - MultiFileLogger online at 20160113 12:00:38 in /builds/slave/test 12:00:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 12:00:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:00:38 INFO - {'append_to_log': False, 12:00:38 INFO - 'base_work_dir': '/builds/slave/test', 12:00:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:00:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:00:38 INFO - 'branch': 'Firefox-Non-PGO', 12:00:38 INFO - 'buildbot_json_path': 'buildprops.json', 12:00:38 INFO - 'config_files': ('talos/linux_config.py',), 12:00:38 INFO - 'default_actions': ('clobber', 12:00:38 INFO - 'read-buildbot-config', 12:00:38 INFO - 'download-and-extract', 12:00:38 INFO - 'populate-webroot', 12:00:38 INFO - 'create-virtualenv', 12:00:38 INFO - 'install', 12:00:38 INFO - 'run-tests'), 12:00:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:00:38 INFO - 'download_minidump_stackwalk': True, 12:00:38 INFO - 'download_symbols': 'ondemand', 12:00:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:00:38 INFO - 'tooltool.py': '/tools/tooltool.py', 12:00:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:00:38 INFO - '/tools/misc-python/virtualenv.py')}, 12:00:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:00:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:00:38 INFO - 'installer_path': 'installer.exe', 12:00:38 INFO - 'log_level': 'info', 12:00:38 INFO - 'log_name': 'talos', 12:00:38 INFO - 'log_to_console': True, 12:00:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:00:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:00:38 INFO - 'opt_config_files': (), 12:00:38 INFO - 'pip_index': False, 12:00:38 INFO - 'sps_profile': False, 12:00:38 INFO - 'sps_profile_interval': 0, 12:00:38 INFO - 'suite': 'dromaeojs', 12:00:38 INFO - 'system_bits': '32', 12:00:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:00:38 INFO - 'title': 'talos-linux64-ix-039', 12:00:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:00:38 INFO - 'use_talos_json': True, 12:00:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:00:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:00:38 INFO - 'work_dir': 'build'} 12:00:38 INFO - ##### 12:00:38 INFO - ##### Running clobber step. 12:00:38 INFO - ##### 12:00:38 INFO - Running pre-action listener: _resource_record_pre_action 12:00:38 INFO - Running main action method: clobber 12:00:38 INFO - rmtree: /builds/slave/test/build 12:00:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:00:39 INFO - Running post-action listener: _resource_record_post_action 12:00:39 INFO - ##### 12:00:39 INFO - ##### Running read-buildbot-config step. 12:00:39 INFO - ##### 12:00:39 INFO - Running pre-action listener: _resource_record_pre_action 12:00:39 INFO - Running main action method: read_buildbot_config 12:00:39 INFO - Using buildbot properties: 12:00:39 INFO - { 12:00:39 INFO - "project": "", 12:00:39 INFO - "product": "firefox", 12:00:39 INFO - "script_repo_revision": "production", 12:00:39 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:00:39 INFO - "repository": "", 12:00:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 12:00:39 INFO - "buildid": "20160113103434", 12:00:39 INFO - "pgo_build": "False", 12:00:39 INFO - "basedir": "/builds/slave/test", 12:00:39 INFO - "buildnumber": 384, 12:00:39 INFO - "slavename": "talos-linux64-ix-039", 12:00:39 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:00:39 INFO - "platform": "ubuntu64_hw", 12:00:39 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:00:39 INFO - "branch": "mozilla-central", 12:00:39 INFO - "repo_path": "mozilla-central", 12:00:39 INFO - "revision": "ad1f85f172b7302bef0fa9780df8e2b962780ac6", 12:00:39 INFO - "stage_platform": "linux64", 12:00:39 INFO - "builduid": "f43abcffe6414798b9bd5e717da85506", 12:00:39 INFO - "slavebuilddir": "test" 12:00:39 INFO - } 12:00:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 12:00:39 INFO - Running post-action listener: _resource_record_post_action 12:00:39 INFO - ##### 12:00:39 INFO - ##### Running download-and-extract step. 12:00:39 INFO - ##### 12:00:39 INFO - Running pre-action listener: _resource_record_pre_action 12:00:39 INFO - Running main action method: download_and_extract 12:00:39 INFO - mkdir: /builds/slave/test/build/tests 12:00:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:39 INFO - https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:00:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/test_packages.json 12:00:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/test_packages.json 12:00:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:00:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:00:43 INFO - Downloaded 1448 bytes. 12:00:43 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:00:43 INFO - Using the following test package requirements: 12:00:43 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:43 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:00:43 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:00:43 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:43 INFO - u'jsshell-linux-x86_64.zip'], 12:00:43 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:00:43 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:43 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:00:43 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:00:43 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:00:43 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 12:00:43 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 12:00:43 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:00:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:43 INFO - https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:00:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:00:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:00:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/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 12:00:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/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 12:00:59 INFO - Downloaded 22760516 bytes. 12:00:59 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 12:00:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:00:59 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 12:01:00 INFO - Return code: 0 12:01:00 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 12:01:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:00 INFO - https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:01:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:01:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:01:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/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 12:01:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/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 12:01:05 INFO - Downloaded 22760516 bytes. 12:01:05 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 12:01:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 12:01:05 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 12:01:07 INFO - Return code: 0 12:01:07 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')]} 12:01:07 INFO - https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:01:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:01:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:01:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/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 12:01:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/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 12:01:09 INFO - Downloaded 11132279 bytes. 12:01:09 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 12:01:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 12:01:09 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 12:01:10 INFO - Return code: 0 12:01:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:10 INFO - https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:01:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:01:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:01:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/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 12:01:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Hpz9JW9HQPCYchwXhgOlPg/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 12:01:13 INFO - Downloaded 53903405 bytes. 12:01:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:01:13 INFO - mkdir: /builds/slave/test/properties 12:01:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:01:13 INFO - Writing to file /builds/slave/test/properties/build_url 12:01:13 INFO - Contents: 12:01:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 12:01:13 INFO - Running post-action listener: _resource_record_post_action 12:01:13 INFO - Running post-action listener: set_extra_try_arguments 12:01:13 INFO - ##### 12:01:13 INFO - ##### Running populate-webroot step. 12:01:13 INFO - ##### 12:01:13 INFO - Running pre-action listener: _resource_record_pre_action 12:01:13 INFO - Running main action method: populate_webroot 12:01:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:01:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:01:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:01:13 INFO - '--tppagecycles', 12:01:13 INFO - '7'], 12:01:13 INFO - 'tests': ['tsvgm']}}, 12:01:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:01:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:01:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:01:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:01:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:01:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:01:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:01:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:13 INFO - 'talos_options': ['--e10s'], 12:01:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:01:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:13 INFO - 'tests': ['damp', 'tps']}, 12:01:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:13 INFO - 'talos_options': ['--e10s'], 12:01:13 INFO - 'tests': ['damp', 'tps']}, 12:01:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:01:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:01:13 INFO - 'other': {'tests': ['a11yr', 12:01:13 INFO - 'ts_paint', 12:01:13 INFO - 'tpaint', 12:01:13 INFO - 'sessionrestore', 12:01:13 INFO - 'sessionrestore_no_auto_restore']}, 12:01:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:01:13 INFO - 'tests': ['a11yr', 12:01:13 INFO - 'ts_paint', 12:01:13 INFO - 'tpaint', 12:01:13 INFO - 'sessionrestore', 12:01:13 INFO - 'sessionrestore_no_auto_restore']}, 12:01:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:01:13 INFO - 'tests': ['a11yr', 12:01:13 INFO - 'ts_paint', 12:01:13 INFO - 'tpaint', 12:01:13 INFO - 'sessionrestore', 12:01:13 INFO - 'sessionrestore_no_auto_restore']}, 12:01:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:01:13 INFO - 'tests': ['a11yr', 12:01:13 INFO - 'ts_paint', 12:01:13 INFO - 'tpaint', 12:01:13 INFO - 'sessionrestore', 12:01:13 INFO - 'sessionrestore_no_auto_restore']}, 12:01:13 INFO - 'other_l64': {'tests': ['a11yr', 12:01:13 INFO - 'ts_paint', 12:01:13 INFO - 'tpaint', 12:01:13 INFO - 'sessionrestore', 12:01:13 INFO - 'sessionrestore_no_auto_restore']}, 12:01:13 INFO - 'other_nol64': {'tests': ['a11yr', 12:01:13 INFO - 'ts_paint', 12:01:13 INFO - 'tpaint', 12:01:13 INFO - 'sessionrestore', 12:01:13 INFO - 'sessionrestore_no_auto_restore']}, 12:01:13 INFO - 'svgr': {'tests': ['tsvgx', 12:01:13 INFO - 'tsvgr_opacity', 12:01:13 INFO - 'tart', 12:01:13 INFO - 'tscrollx', 12:01:13 INFO - 'cart']}, 12:01:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:01:13 INFO - 'tests': ['tsvgx', 12:01:13 INFO - 'tsvgr_opacity', 12:01:13 INFO - 'tart', 12:01:13 INFO - 'tscrollx', 12:01:13 INFO - 'cart']}, 12:01:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:13 INFO - 'tests': ['tp5o']}, 12:01:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:13 INFO - 'talos_options': ['--e10s'], 12:01:13 INFO - 'tests': ['tp5o']}, 12:01:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:13 INFO - 'talos_options': ['--xperf_path', 12:01:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:01:13 INFO - 'tests': ['tp5n']}, 12:01:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:01:13 INFO - 'talos_options': ['--e10s', 12:01:13 INFO - '--xperf_path', 12:01:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:01:13 INFO - 'tests': ['tp5n']}}, 12:01:13 INFO - 'talos.zip': {'path': '', 12:01:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:01:13 INFO - Running post-action listener: _resource_record_post_action 12:01:13 INFO - ##### 12:01:13 INFO - ##### Running create-virtualenv step. 12:01:13 INFO - ##### 12:01:13 INFO - Running pre-action listener: _resource_record_pre_action 12:01:13 INFO - Running main action method: create_virtualenv 12:01:13 INFO - Creating virtualenv /builds/slave/test/build/venv 12:01:13 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 12:01:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:01:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:01:14 INFO - Using real prefix '/usr' 12:01:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:01:14 INFO - Installing distribute.............................................................................................................................................................................................done. 12:01:16 INFO - Installing pip.................done. 12:01:16 INFO - Return code: 0 12:01:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:16 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 0x7f60ac38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b83d0>, '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 0x2723ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724360>, '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': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', '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 12:01:16 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 12:01:16 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 12:01:16 INFO - Using env: {'DISPLAY': ':0', 12:01:16 INFO - 'HOME': '/home/cltbld', 12:01:16 INFO - 'LANG': 'en_US.UTF-8', 12:01:16 INFO - 'LANGUAGE': 'en_US:en', 12:01:16 INFO - 'LOGNAME': 'cltbld', 12:01:16 INFO - 'MAIL': '/var/mail/cltbld', 12:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:16 INFO - 'MOZ_NO_REMOTE': '1', 12:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:16 INFO - 'NO_EM_RESTART': '1', 12:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:16 INFO - 'PWD': '/builds/slave/test', 12:01:16 INFO - 'SHELL': '/bin/bash', 12:01:16 INFO - 'SHLVL': '1', 12:01:16 INFO - 'TERM': 'linux', 12:01:16 INFO - 'TMOUT': '86400', 12:01:16 INFO - 'USER': 'cltbld', 12:01:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', 12:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:16 INFO - '_': '/tools/buildbot/bin/python'} 12:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:16 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 12:01:16 INFO - Cleaning up... 12:01:16 INFO - Return code: 0 12:01:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:16 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 0x7f60ac38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b83d0>, '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 0x2723ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724360>, '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': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', '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 12:01:16 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 12:01:16 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 12:01:16 INFO - Using env: {'DISPLAY': ':0', 12:01:16 INFO - 'HOME': '/home/cltbld', 12:01:16 INFO - 'LANG': 'en_US.UTF-8', 12:01:16 INFO - 'LANGUAGE': 'en_US:en', 12:01:16 INFO - 'LOGNAME': 'cltbld', 12:01:16 INFO - 'MAIL': '/var/mail/cltbld', 12:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:16 INFO - 'MOZ_NO_REMOTE': '1', 12:01:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:16 INFO - 'NO_EM_RESTART': '1', 12:01:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:16 INFO - 'PWD': '/builds/slave/test', 12:01:16 INFO - 'SHELL': '/bin/bash', 12:01:16 INFO - 'SHLVL': '1', 12:01:16 INFO - 'TERM': 'linux', 12:01:16 INFO - 'TMOUT': '86400', 12:01:16 INFO - 'USER': 'cltbld', 12:01:16 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', 12:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:16 INFO - '_': '/tools/buildbot/bin/python'} 12:01:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:16 INFO - Downloading/unpacking psutil>=0.7.1 12:01:16 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 12:01:16 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 12:01:16 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 12:01:16 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 12:01:16 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 12:01:16 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 12:01:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:01:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:01:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:01:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:01:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:01:18 INFO - Installing collected packages: psutil 12:01:18 INFO - Running setup.py install for psutil 12:01:18 INFO - building 'psutil._psutil_linux' extension 12:01:18 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 12:01:18 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 12:01:19 INFO - building 'psutil._psutil_posix' extension 12:01:19 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 12:01:19 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 12:01:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:01:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:01:19 INFO - Successfully installed psutil 12:01:19 INFO - Cleaning up... 12:01:19 INFO - Return code: 0 12:01:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:01:19 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')]} 12:01:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:19 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')]} 12:01:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:19 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 0x7f60ac38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b83d0>, '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 0x2723ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724360>, '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': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', '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 12:01:19 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 12:01:19 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 12:01:19 INFO - Using env: {'DISPLAY': ':0', 12:01:19 INFO - 'HOME': '/home/cltbld', 12:01:19 INFO - 'LANG': 'en_US.UTF-8', 12:01:19 INFO - 'LANGUAGE': 'en_US:en', 12:01:19 INFO - 'LOGNAME': 'cltbld', 12:01:19 INFO - 'MAIL': '/var/mail/cltbld', 12:01:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:19 INFO - 'MOZ_NO_REMOTE': '1', 12:01:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:19 INFO - 'NO_EM_RESTART': '1', 12:01:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:19 INFO - 'PWD': '/builds/slave/test', 12:01:19 INFO - 'SHELL': '/bin/bash', 12:01:19 INFO - 'SHLVL': '1', 12:01:19 INFO - 'TERM': 'linux', 12:01:19 INFO - 'TMOUT': '86400', 12:01:19 INFO - 'USER': 'cltbld', 12:01:19 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', 12:01:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:19 INFO - '_': '/tools/buildbot/bin/python'} 12:01:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:01:19 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 12:01:19 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 12:01:19 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 12:01:19 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 12:01:19 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 12:01:19 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 12:01:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:01:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:01:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:01:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:01:21 INFO - Installing collected packages: mozsystemmonitor 12:01:21 INFO - Running setup.py install for mozsystemmonitor 12:01:21 INFO - Successfully installed mozsystemmonitor 12:01:21 INFO - Cleaning up... 12:01:21 INFO - Return code: 0 12:01:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:01: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')]} 12:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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')]} 12:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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 0x7f60ac38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b83d0>, '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 0x2723ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724360>, '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': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', '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 12:01: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 12:01: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 12:01:21 INFO - Using env: {'DISPLAY': ':0', 12:01:21 INFO - 'HOME': '/home/cltbld', 12:01:21 INFO - 'LANG': 'en_US.UTF-8', 12:01:21 INFO - 'LANGUAGE': 'en_US:en', 12:01:21 INFO - 'LOGNAME': 'cltbld', 12:01:21 INFO - 'MAIL': '/var/mail/cltbld', 12:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:21 INFO - 'MOZ_NO_REMOTE': '1', 12:01:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:21 INFO - 'NO_EM_RESTART': '1', 12:01:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:21 INFO - 'PWD': '/builds/slave/test', 12:01:21 INFO - 'SHELL': '/bin/bash', 12:01:21 INFO - 'SHLVL': '1', 12:01:21 INFO - 'TERM': 'linux', 12:01:21 INFO - 'TMOUT': '86400', 12:01:21 INFO - 'USER': 'cltbld', 12:01:21 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', 12:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:21 INFO - '_': '/tools/buildbot/bin/python'} 12:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:21 INFO - Downloading/unpacking blobuploader==1.2.4 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:23 INFO - Downloading blobuploader-1.2.4.tar.gz 12:01:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:01:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:01:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:23 INFO - Downloading docopt-0.6.1.tar.gz 12:01:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:01:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:01:24 INFO - Installing collected packages: blobuploader, requests, docopt 12:01:24 INFO - Running setup.py install for blobuploader 12:01:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:01:24 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:01:24 INFO - Running setup.py install for requests 12:01:24 INFO - Running setup.py install for docopt 12:01:24 INFO - Successfully installed blobuploader requests docopt 12:01:24 INFO - Cleaning up... 12:01:24 INFO - Return code: 0 12:01:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01: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')]} 12:01:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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')]} 12:01:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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 0x7f60ac38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b83d0>, '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 0x2723ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724360>, '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': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', '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 12:01: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 12:01: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 12:01:24 INFO - Using env: {'DISPLAY': ':0', 12:01:24 INFO - 'HOME': '/home/cltbld', 12:01:24 INFO - 'LANG': 'en_US.UTF-8', 12:01:24 INFO - 'LANGUAGE': 'en_US:en', 12:01:24 INFO - 'LOGNAME': 'cltbld', 12:01:24 INFO - 'MAIL': '/var/mail/cltbld', 12:01:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:24 INFO - 'MOZ_NO_REMOTE': '1', 12:01:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:24 INFO - 'NO_EM_RESTART': '1', 12:01:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:24 INFO - 'PWD': '/builds/slave/test', 12:01:24 INFO - 'SHELL': '/bin/bash', 12:01:24 INFO - 'SHLVL': '1', 12:01:24 INFO - 'TERM': 'linux', 12:01:24 INFO - 'TMOUT': '86400', 12:01:24 INFO - 'USER': 'cltbld', 12:01:24 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', 12:01:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:24 INFO - '_': '/tools/buildbot/bin/python'} 12:01:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:01:24 INFO - Running setup.py (path:/tmp/pip-RNQVA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:01:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:01:24 INFO - Running setup.py (path:/tmp/pip-as6x1_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:01:25 INFO - Running setup.py (path:/tmp/pip-bLcDaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:01:25 INFO - Running setup.py (path:/tmp/pip-0MeCyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:01:25 INFO - Running setup.py (path:/tmp/pip-Db5oSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:01:25 INFO - Running setup.py (path:/tmp/pip-5EhxJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:01:25 INFO - Running setup.py (path:/tmp/pip-Syfo9m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:01:25 INFO - Running setup.py (path:/tmp/pip-LXXlFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:01:25 INFO - Running setup.py (path:/tmp/pip-i9czY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:01:25 INFO - Running setup.py (path:/tmp/pip-XLvvL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:01:25 INFO - Running setup.py (path:/tmp/pip-OJzn41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:01:25 INFO - Running setup.py (path:/tmp/pip-iw8l2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:01:25 INFO - Running setup.py (path:/tmp/pip-FqUb3j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:01:25 INFO - Running setup.py (path:/tmp/pip-YnfTXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:25 INFO - Running setup.py (path:/tmp/pip-5SlFdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:01:25 INFO - Running setup.py (path:/tmp/pip-aAhIxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:01:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:01:26 INFO - Running setup.py (path:/tmp/pip-2mzIBL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:01:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:01:26 INFO - Running setup.py install for manifestparser 12:01:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:01:26 INFO - Running setup.py install for mozcrash 12:01:26 INFO - Running setup.py install for mozdebug 12:01:26 INFO - Running setup.py install for mozdevice 12:01:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:01:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:01:26 INFO - Running setup.py install for mozfile 12:01:26 INFO - Running setup.py install for mozhttpd 12:01:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:01:26 INFO - Running setup.py install for mozinfo 12:01:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:01:26 INFO - Running setup.py install for mozInstall 12:01:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:01:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:01:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:01:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:01:26 INFO - Running setup.py install for mozleak 12:01:26 INFO - Running setup.py install for mozlog 12:01:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:01:27 INFO - Running setup.py install for moznetwork 12:01:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:01:27 INFO - Running setup.py install for mozprocess 12:01:27 INFO - Running setup.py install for mozprofile 12:01:27 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:01:27 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:01:27 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:01:27 INFO - Running setup.py install for mozrunner 12:01:27 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:01:27 INFO - Running setup.py install for mozscreenshot 12:01:27 INFO - Running setup.py install for moztest 12:01:27 INFO - Running setup.py install for mozversion 12:01:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:01:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:01:27 INFO - Cleaning up... 12:01:27 INFO - Return code: 0 12:01:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01: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')]} 12:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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')]} 12:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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 0x7f60ac38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b83d0>, '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 0x2723ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724360>, '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': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', '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 12:01: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 12:01: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 12:01:27 INFO - Using env: {'DISPLAY': ':0', 12:01:27 INFO - 'HOME': '/home/cltbld', 12:01:27 INFO - 'LANG': 'en_US.UTF-8', 12:01:27 INFO - 'LANGUAGE': 'en_US:en', 12:01:27 INFO - 'LOGNAME': 'cltbld', 12:01:27 INFO - 'MAIL': '/var/mail/cltbld', 12:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:27 INFO - 'MOZ_NO_REMOTE': '1', 12:01:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:27 INFO - 'NO_EM_RESTART': '1', 12:01:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:27 INFO - 'PWD': '/builds/slave/test', 12:01:27 INFO - 'SHELL': '/bin/bash', 12:01:27 INFO - 'SHLVL': '1', 12:01:27 INFO - 'TERM': 'linux', 12:01:27 INFO - 'TMOUT': '86400', 12:01:27 INFO - 'USER': 'cltbld', 12:01:27 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', 12:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:27 INFO - '_': '/tools/buildbot/bin/python'} 12:01:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:01:28 INFO - Running setup.py (path:/tmp/pip-hcKwmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:01:28 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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:01:28 INFO - Running setup.py (path:/tmp/pip-16T7jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:01:28 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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:01:28 INFO - Running setup.py (path:/tmp/pip-Evoi72-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:01:28 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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:01:28 INFO - Running setup.py (path:/tmp/pip-ppwxed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:01:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:01:28 INFO - Running setup.py (path:/tmp/pip-Rjddlq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:01: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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:01:28 INFO - Running setup.py (path:/tmp/pip-5lDl_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:01: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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:01:28 INFO - Running setup.py (path:/tmp/pip-EnBkAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:01: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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:01:28 INFO - Running setup.py (path:/tmp/pip-ZDT9CA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:01: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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:01:28 INFO - Running setup.py (path:/tmp/pip-fbO5iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:01: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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:01:28 INFO - Running setup.py (path:/tmp/pip-ACx7Nt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:01: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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:01:28 INFO - Running setup.py (path:/tmp/pip-5j0Po_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:01: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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:01:28 INFO - Running setup.py (path:/tmp/pip-2liy2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:01: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)) 12:01:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:01:28 INFO - Running setup.py (path:/tmp/pip-kPbg7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:01:29 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)) 12:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:01:29 INFO - Running setup.py (path:/tmp/pip-b3HBuc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:01:29 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)) 12:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:29 INFO - Running setup.py (path:/tmp/pip-Wb2qzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:29 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)) 12:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:01:29 INFO - Running setup.py (path:/tmp/pip-ihSE8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:01:29 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)) 12:01:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:01:29 INFO - Running setup.py (path:/tmp/pip-LwXCvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:01:29 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)) 12:01:29 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)) 12:01:29 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)) 12:01:29 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)) 12:01:29 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:01:29 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:01:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:01:29 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 12:01:29 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 12:01:29 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 12:01:29 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 12:01:29 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 12:01:29 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 12:01:31 INFO - Downloading blessings-1.5.1.tar.gz 12:01:31 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 12:01:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:01:31 INFO - Installing collected packages: blessings 12:01:31 INFO - Running setup.py install for blessings 12:01:31 INFO - Successfully installed blessings 12:01:31 INFO - Cleaning up... 12:01:31 INFO - Return code: 0 12:01:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:01:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:01:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:01:31 INFO - Reading from file tmpfile_stdout 12:01:31 INFO - Current package versions: 12:01:31 INFO - argparse == 1.2.1 12:01:31 INFO - blessings == 1.5.1 12:01:31 INFO - blobuploader == 1.2.4 12:01:31 INFO - docopt == 0.6.1 12:01:31 INFO - manifestparser == 1.1 12:01:31 INFO - mozInstall == 1.12 12:01:31 INFO - mozcrash == 0.16 12:01:31 INFO - mozdebug == 0.1 12:01:31 INFO - mozdevice == 0.48 12:01:31 INFO - mozfile == 1.2 12:01:31 INFO - mozhttpd == 0.7 12:01:31 INFO - mozinfo == 0.9 12:01:31 INFO - mozleak == 0.1 12:01:31 INFO - mozlog == 3.1 12:01:31 INFO - moznetwork == 0.27 12:01:31 INFO - mozprocess == 0.22 12:01:31 INFO - mozprofile == 0.28 12:01:31 INFO - mozrunner == 6.11 12:01:31 INFO - mozscreenshot == 0.1 12:01:31 INFO - mozsystemmonitor == 0.0 12:01:31 INFO - moztest == 0.7 12:01:31 INFO - mozversion == 1.4 12:01:31 INFO - psutil == 3.1.1 12:01:31 INFO - requests == 1.2.3 12:01:31 INFO - wsgiref == 0.1.2 12:01:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01: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')]} 12:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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')]} 12:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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 0x7f60ac38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b83d0>, '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 0x2723ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724360>, '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': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', '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 12:01: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 12:01: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 12:01:31 INFO - Using env: {'DISPLAY': ':0', 12:01:31 INFO - 'HOME': '/home/cltbld', 12:01:31 INFO - 'LANG': 'en_US.UTF-8', 12:01:31 INFO - 'LANGUAGE': 'en_US:en', 12:01:31 INFO - 'LOGNAME': 'cltbld', 12:01:31 INFO - 'MAIL': '/var/mail/cltbld', 12:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:31 INFO - 'MOZ_NO_REMOTE': '1', 12:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:31 INFO - 'NO_EM_RESTART': '1', 12:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:31 INFO - 'PWD': '/builds/slave/test', 12:01:31 INFO - 'SHELL': '/bin/bash', 12:01:31 INFO - 'SHLVL': '1', 12:01:31 INFO - 'TERM': 'linux', 12:01:31 INFO - 'TMOUT': '86400', 12:01:31 INFO - 'USER': 'cltbld', 12:01:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', 12:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:31 INFO - '_': '/tools/buildbot/bin/python'} 12:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01: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)) 12:01: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)) 12:01: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)) 12:01: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)) 12:01: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)) 12:01: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)) 12:01: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)) 12:01: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)) 12:01: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)) 12:01: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)) 12:01: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)) 12:01:31 INFO - Cleaning up... 12:01:31 INFO - Return code: 0 12:01:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:01: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')]} 12:01:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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')]} 12:01:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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 0x7f60ac38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b83d0>, '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 0x2723ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724360>, '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': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', '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 12:01: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 12:01: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 12:01:31 INFO - Using env: {'DISPLAY': ':0', 12:01:31 INFO - 'HOME': '/home/cltbld', 12:01:31 INFO - 'LANG': 'en_US.UTF-8', 12:01:31 INFO - 'LANGUAGE': 'en_US:en', 12:01:31 INFO - 'LOGNAME': 'cltbld', 12:01:31 INFO - 'MAIL': '/var/mail/cltbld', 12:01:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:31 INFO - 'MOZ_NO_REMOTE': '1', 12:01:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:31 INFO - 'NO_EM_RESTART': '1', 12:01:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:31 INFO - 'PWD': '/builds/slave/test', 12:01:31 INFO - 'SHELL': '/bin/bash', 12:01:31 INFO - 'SHLVL': '1', 12:01:31 INFO - 'TERM': 'linux', 12:01:31 INFO - 'TMOUT': '86400', 12:01:31 INFO - 'USER': 'cltbld', 12:01:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', 12:01:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:31 INFO - '_': '/tools/buildbot/bin/python'} 12:01:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:31 INFO - Downloading/unpacking jsonschema 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:01: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 12:01:33 INFO - Downloading/unpacking functools32 (from jsonschema) 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:33 INFO - Downloading functools32-3.2.3-2.tar.gz 12:01: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 12:01:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:01:33 INFO - warning: no files found matching '*.txt' 12:01:33 INFO - no previously-included directories found matching 'build' 12:01:33 INFO - no previously-included directories found matching 'dist' 12:01:33 INFO - no previously-included directories found matching '.git*' 12:01:33 INFO - Installing collected packages: jsonschema, functools32 12:01:33 INFO - Running setup.py install for functools32 12:01:34 INFO - warning: no files found matching '*.txt' 12:01:34 INFO - no previously-included directories found matching 'build' 12:01:34 INFO - no previously-included directories found matching 'dist' 12:01:34 INFO - no previously-included directories found matching '.git*' 12:01:34 INFO - Successfully installed jsonschema functools32 12:01:34 INFO - Cleaning up... 12:01:34 INFO - Return code: 0 12:01:34 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 12:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:34 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 0x7f60ac38df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26568a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2725dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27b83d0>, '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 0x2723ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724360>, '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': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', '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 12:01:34 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 12:01:34 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 12:01:34 INFO - Using env: {'DISPLAY': ':0', 12:01:34 INFO - 'HOME': '/home/cltbld', 12:01:34 INFO - 'LANG': 'en_US.UTF-8', 12:01:34 INFO - 'LANGUAGE': 'en_US:en', 12:01:34 INFO - 'LOGNAME': 'cltbld', 12:01:34 INFO - 'MAIL': '/var/mail/cltbld', 12:01:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:34 INFO - 'MOZ_NO_REMOTE': '1', 12:01:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:34 INFO - 'NO_EM_RESTART': '1', 12:01:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:34 INFO - 'PWD': '/builds/slave/test', 12:01:34 INFO - 'SHELL': '/bin/bash', 12:01:34 INFO - 'SHLVL': '1', 12:01:34 INFO - 'TERM': 'linux', 12:01:34 INFO - 'TMOUT': '86400', 12:01:34 INFO - 'USER': 'cltbld', 12:01:34 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', 12:01:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:34 INFO - '_': '/tools/buildbot/bin/python'} 12:01:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:34 INFO - Downloading/unpacking flake8 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:01:36 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 12:01:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:01:36 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 12:01:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:01:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 12:01:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:01:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:01:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:01:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:01:36 INFO - no previously-included directories found matching 'docs/_build' 12:01:36 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:01:36 INFO - Running setup.py install for pep8 12:01:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:01:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:01:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:01:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:01:36 INFO - no previously-included directories found matching 'docs/_build' 12:01:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 12:01:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:01:36 INFO - Cleaning up... 12:01:36 INFO - Return code: 0 12:01:36 INFO - Running post-action listener: _resource_record_post_action 12:01:36 INFO - Running post-action listener: _start_resource_monitoring 12:01:36 INFO - Starting resource monitoring. 12:01:36 INFO - ##### 12:01:36 INFO - ##### Running install step. 12:01:36 INFO - ##### 12:01:36 INFO - Running pre-action listener: _resource_record_pre_action 12:01:36 INFO - Running main action method: install 12:01:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:01:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:01:37 INFO - Reading from file tmpfile_stdout 12:01:37 INFO - Detecting whether we're running mozinstall >=1.0... 12:01:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:01:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:01:37 INFO - Reading from file tmpfile_stdout 12:01:37 INFO - Output received: 12:01:37 INFO - Usage: mozinstall [options] installer 12:01:37 INFO - Options: 12:01:37 INFO - -h, --help show this help message and exit 12:01:37 INFO - -d DEST, --destination=DEST 12:01:37 INFO - Directory to install application into. [default: 12:01:37 INFO - "/builds/slave/test"] 12:01:37 INFO - --app=APP Application being installed. [default: firefox] 12:01:37 INFO - mkdir: /builds/slave/test/build/application 12:01:37 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'] 12:01:37 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 12:01:52 INFO - Reading from file tmpfile_stdout 12:01:52 INFO - Output received: 12:01:52 INFO - /builds/slave/test/build/application/firefox/firefox 12:01:52 INFO - Running post-action listener: _resource_record_post_action 12:01:52 INFO - ##### 12:01:52 INFO - ##### Running run-tests step. 12:01:52 INFO - ##### 12:01:52 INFO - Running pre-action listener: _resource_record_pre_action 12:01:52 INFO - Running main action method: run_tests 12:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:01:52 INFO - Python 2.7.3 12:01:52 INFO - Return code: 0 12:01:52 INFO - grabbing minidump binary from tooltool 12:01: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')]} 12:01: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 0x27b83d0>, '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 0x2723ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2724360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:01: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 12:01: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 12:01:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:01:52 INFO - Return code: 0 12:01:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:01:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:01:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:01:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:01:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:01:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 12:01:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 12:01:53 INFO - Return code: 0 12:01:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 12:01:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 12:01:53 INFO - Using env: {'DISPLAY': ':0', 12:01:53 INFO - 'HOME': '/home/cltbld', 12:01:53 INFO - 'LANG': 'en_US.UTF-8', 12:01:53 INFO - 'LANGUAGE': 'en_US:en', 12:01:53 INFO - 'LOGNAME': 'cltbld', 12:01:53 INFO - 'MAIL': '/var/mail/cltbld', 12:01:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:01:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:01:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:53 INFO - 'MOZ_NO_REMOTE': '1', 12:01:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:01:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:01:53 INFO - 'NO_EM_RESTART': '1', 12:01:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:01:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:53 INFO - 'PWD': '/builds/slave/test', 12:01:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:01:53 INFO - 'SHELL': '/bin/bash', 12:01:53 INFO - 'SHLVL': '1', 12:01:53 INFO - 'TERM': 'linux', 12:01:53 INFO - 'TMOUT': '86400', 12:01:53 INFO - 'USER': 'cltbld', 12:01:53 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157', 12:01:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:53 INFO - '_': '/tools/buildbot/bin/python'} 12:01:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 12:01:54 INFO - mozversion application_buildid: 20160113103434 12:01:54 INFO - mozversion application_changeset: ad1f85f172b7302bef0fa9780df8e2b962780ac6 12:01:54 INFO - mozversion application_display_name: Nightly 12:01:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:01:54 INFO - mozversion application_name: Firefox 12:01:54 INFO - mozversion application_remotingname: firefox 12:01:54 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:01:54 INFO - mozversion application_vendor: Mozilla 12:01:54 INFO - mozversion application_version: 46.0a1 12:01:54 INFO - mozversion platform_buildid: 20160113103434 12:01:54 INFO - mozversion platform_changeset: ad1f85f172b7302bef0fa9780df8e2b962780ac6 12:01:54 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:01:54 INFO - mozversion platform_version: 46.0a1 12:01:54 INFO - using testdate: 1452715314 12:01:54 INFO - actual date: 1452715314 12:01:54 INFO - starting webserver on 'localhost:50782' 12:01:54 INFO - SUITE-START | Running 3 tests 12:01:54 INFO - TEST-START | dromaeo_css 12:01:54 INFO - operating with platform_type : linux_ 12:01:54 INFO - Initialising browser for dromaeo_css test... 12:01:54 INFO - TEST-INFO | started process 6311 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmpjuPR/profile http://localhost:50782/getInfo.html) 12:01:58 INFO - PROCESS | 6311 | __metrics Screen width/height:1600/1200 12:01:58 INFO - PROCESS | 6311 | colorDepth:24 12:01:58 INFO - PROCESS | 6311 | Browser inner width/height: 1024/697 12:01:58 INFO - PROCESS | 6311 | __metrics 12:01:58 INFO - PROCESS | 6311 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:01:58 INFO - PROCESS | 6311 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:01:59 INFO - TEST-INFO | 6311: exit 0 12:01:59 INFO - Browser initialized. 12:01:59 INFO - Running cycle 1/1 for dromaeo_css test... 12:01:59 INFO - TEST-INFO | started process 6404 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmpjuPR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:02:11 INFO - PROCESS | 6404 | RSS: Main: 149401600 12:02:11 INFO - PROCESS | 6404 | 12:03:02 INFO - PROCESS | 6404 | 1452715382387 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] 12:05:13 INFO - PROCESS | 6404 | Cycle 1(1): loaded http://localhost:50782/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50782/tests/dromaeo/cssquery-ext.html) 12:05:14 INFO - PROCESS | 6404 | RSS: Main: 253939712 12:05:14 INFO - PROCESS | 6404 | 12:08:17 INFO - PROCESS | 6404 | Cycle 1(1): loaded http://localhost:50782/tests/dromaeo/cssquery-ext.html (next: http://localhost:50782/tests/dromaeo/cssquery-jquery.html) 12:08:17 INFO - PROCESS | 6404 | RSS: Main: 226918400 12:08:17 INFO - PROCESS | 6404 | 12:11:19 INFO - PROCESS | 6404 | Cycle 1(1): loaded http://localhost:50782/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50782/tests/dromaeo/cssquery-mootools.html) 12:11:20 INFO - PROCESS | 6404 | RSS: Main: 234651648 12:11:20 INFO - PROCESS | 6404 | 12:14:22 INFO - PROCESS | 6404 | Cycle 1(1): loaded http://localhost:50782/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50782/tests/dromaeo/cssquery-prototype.html) 12:14:23 INFO - PROCESS | 6404 | RSS: Main: 210837504 12:14:23 INFO - PROCESS | 6404 | 12:17:25 INFO - PROCESS | 6404 | Cycle 1(1): loaded http://localhost:50782/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50782/tests/dromaeo/cssquery-yui.html) 12:17:26 INFO - PROCESS | 6404 | RSS: Main: 211460096 12:17:26 INFO - PROCESS | 6404 | 12:20:29 INFO - PROCESS | 6404 | Cycle 1(1): loaded http://localhost:50782/tests/dromaeo/cssquery-yui.html (next: http://localhost:50782/tests/dromaeo/cssquery-dojo.html) 12:20:29 INFO - PROCESS | 6404 | RSS: Main: 256462848 12:20:29 INFO - PROCESS | 6404 | 12:20:29 INFO - PROCESS | 6404 | __start_tp_report 12:20:29 INFO - PROCESS | 6404 | _x_x_mozilla_page_load 12:20:29 INFO - PROCESS | 6404 | _x_x_mozilla_page_load_details 12:20:29 INFO - PROCESS | 6404 | |i|pagename|runs| 12:20:29 INFO - PROCESS | 6404 | |0;dojo.html;2557.5422059300267;2620.855852928088;2628.5531459651856;2634.6443230163923;2640.630311756354;4269.039466120122;4346.1307738452315;4370.1915145697985;4373.956260437395;4393.34099885017;4379.474463064436;4413.337999300106;4441.511433742286;4473.463184417867;4504.1892459357305;4034.8184331705143;4066.3493840985448;4111.753294802306;4167.895802604944;4202.222588821062;4035.1929614077153;4125.958740412602;4152.56398078202;4168.7081904266715;4178.101708132751;4076.5515793262716;4093.774842383668;4105.404716316148;4130.153318569716;4141.772202528859;4111.218868414991;4117.91764164715;4118.979405102985;4120.361343991686;4150.481189851269;4057.411675307064;4096.5903409658795;4121.052158003676;4138.730982486129;4157.91684166318;4223.66210703143;4309.418228539138;4326.9567304326865;4329.025969156946;4384.539623339567;4690.906181876378;4728.148933192024;4729.905401891977;4733.479317275097;4774.73738944358;4738.123447162286;4744.16977029022;4746.691465054761;4748.857534273978;4794.9520504794855;4325.653947684178;4391.912161756747;4397.076613911083;4427.269500532376;4495.752733599618;4863.975680121647;4872.853814385503;4890.877728056827;4936.506349365107;4942.011597680478;4707.270373092176;4708.058388322349;4709.458412282563;4711.199096153662;4752.667313288037;4629.583337499641;4703.318018887242;4707.176244157259;4770.833020844254;4858.271259311132;4686.789094490756;4717.693349932243;4720.150372932836;4720.45714742809;4754.02542478791;4702.95297047032;4703.294505824154;4705.317728929286;4705.7647117644665;4745.667803253739;3838.6353296436796;3905.5508616508896;3918.549366822852;3962.32640451124;3974.721769476109;3544.5392099026963;3555.1467647764352;3558.0393293810525;3566.358055549974;3579.964200357963;4151.813168407429;4158.313878210122;4162.604552567501;4169.249535083653;4198.874033778991;4540.750258735801;4614.515475874985;4619.445666519972;4692.906141877143;4756.429228492603;4174.248635245685;4182.017225951899;4189.162167566499;4192.622663960258;4206.179794940019;4242.257604919188;4264.616184543406;4264.722793018444;4309.741415515079;4309.91380172401;4401.713888597295;4482.731036137842;4482.8879278017;4484.641228701631;4519.0961807638605;4788.11419887322;4804.567588917014;4806.062817750505;4808.35087263215;4845.1278769820365;4543.977280113579;4557.521460246759;4561.110583436198;4565.7717114144825;4591.449026116888;4566.657500687395;4655.86032419028;4668.906621867476;4669.673122881366;4724.314974328634;4791;4816.277558366273;4819.469858315512;4819.49395313487;4850.53919877611;4649.070185962753;4666.136764698542;4669.579737823612;4670.089332580114;4710.128626204163;4524.095180963886;4568.451785785727;4600.88497787558;4606.838760643362;4644.419447569054;4565.817367305403;4580.290055041474;4589.678722489393;4615.699979501322;4628.1669299525065;4649.744264065509;4682.906341873076;4689.179393606173;4692.085043416501;4733.029728905635;4331.523532411369;4418.536053714313;4421.336799480104;4447.310666846644;4533.6373090153365 12:20:29 INFO - PROCESS | 6404 | |1;ext.html;487.980480780769;519.8718780246863;535.1517844216916;541.7562097056323;546.2680008788224;24069.879650601746;24762.380940476498;24788.50422991539;31656;32062.839685801595;35666;36139.819300903524;36168.457473137925;36219.81890090553;36230.27539449209;7636.961815190916;7867.960660196691;7871.409644276673;7874.842503149934;7877.606119694021;7686.65410056546;7746.264104910025;7759.340456061242;7806.453548251625;7822.569758663271;7754.10827754807;7785.571793551352;7820.100688420847;7820.726274580391;7822.413319001098;7762.340201082915;7845.607719614025;7850.882236766453;7851.45039847211;7855.528668279864;7451.739189128354;7512.586807725627;7555.508891922007;7558.357539609085;7560.659770310294;35364;35814.462783058276;35845.64154358449;35880.461793073126;35884.46173307402;2747.6015977683123;2752.0230318237136;2790.330320723032;2798.552231642948;3137.984310078458;27498.587521186997;27536.862315688493;27731.86134069337;27849.303767405774;27877.442451151066;3135.608048993876;3154.495280755068;3179.952300715491;3187.9840600796847;3215.8713651453913;205620;206145;206510;206776;208559.95720021456;43668.344974825406;50679.23981140286;50986.74506627443;51005.74497127565;51011.489885101415;38666.613333866866;38720.6127938717;38909.41635875464;38946.6105338943;54594;12917.418716157796;13175.802362964563;13185.340732963505;13186.868131318755;13207.141535800334;9725.805483890425;9813.067758562926;9836.163926066365;9838.16375608067;9850.753731156778;15356.385744570316;15821.208939552977;15851;16924.746128808078;17168.31326746941;5685.573581981368;6932.688029038705;7005.579973817425;7135.322144396274;7175.712971481186;801.4470015689155;872.5419154943578;921.9677311294073;945.6217810865754;970.2916870684439;24583.38541536476;25480.8725956369;25610.615840762403;25701.3574660635;25756.3560910975;925.6019911438011;933.1275257634134;967.3615413826841;972.2027937091658;973.6251543155794;12029.218100823593;12227.388630568614;12230.388480576114;12243.632691019284;12272.693182670326;297319;300212;301812;302755;303098;41546.79226603908;42106.68413237301;42118.57881421208;42137.1572568553;42196.36705449421;1033.5968972100886;1120.56298043763;1205.8492688413949;1227.6623928419579;1247.0647014738945;25713.742862571136;27441.17676469709;27469.31326716848;27476.17571472859;27753;37271;37758.244835102596;37840;37907.81046094752;37939.81030094832;194142;195209;300527;304337;342388;28127.859360703067;28257.57613635756;28274.151775446768;28564.57153142746;28649.856750716113;36010.27979440449;36862.8156859214;36875.44686829646;37323;37358.62641373552;31321.45758614551;31401.685983139876;31596.210094747814;32511;32626.184345390604;32132.678673213904;32262.19344516406;32272.515912260864;32554;33249.335013300086;29477.26306842346;29866.70133298726;29901.850490747405;30198.09405717832;30207.395852082394;25027.624585631595;26050.73949260559;26877.462450751267;27082.458350833265;28884;22952.311430657108;23017.68907813805;23160.536789263784;23170;23278.76721232766 12:20:29 INFO - PROCESS | 6404 | |2;jquery.html;344.72422062350114;345.45590694655925;348.97382696297785;349.5333729471156;350.4830375196585;11698.298102113878;12044.096692748035;14002.859971400283;14035.5087571935;14844.999999999987;13650.317484125779;14141;14264.429422823074;15120.546383608482;15150.090994540335;4073.002114481956;4749.525047495249;4939.506049395068;4945.554900058994;4955.08330958772;4729.101470720552;4779.450363208223;4795.400574928134;4800.183968725325;4804.183288840888;4634.675572709912;4779.378680771495;4815.277708343759;4851.27230915362;4857.3685420895235;4711.905761884743;4820;4831.178699621073;4851.126797176506;4858.927116093261;4297.39836422901;4376.321670141133;4384.12317536494;4386.144701783153;4387.034852332482;17697.38059167923;17751.378701745376;17951.281948722037;17953.551161221076;18088.457346279632;1868.4301288107122;1881.1628825172804;1913.2251438167564;1951.219512195119;1968.1241847377923;9388.5447755598;11829.526818927232;12196.512139514409;12208.877911220863;12276.508939642403;1658.9751153732705;1724.2413338131307;1755.8858674186138;1774.9378771742927;1780.2078075256516;46117.538824611656;46307.30539041917;46927.76536117332;47376.526234737554;47465.76267118642;9068.637254509746;9249.213816825511;9373.671921482852;9399.57701903416;9464.574094165779;10474.947625261977;10801.83797243042;11114.944425277821;11955.880441195477;11988.100892433102;6584.8024559263295;6627.469802415795;6642.1033160523675;6652.234992975773;6721.798346049626;6224.62652240867;6249.999999999978;6278.717457714414;6391.488680905516;6409.391107844747;5490.094134467848;5533.170024496358;5538.169274608841;5544.306961629796;5572.944270557243;1677.9244933978;1679.5717092141426;1683.351909514821;1695.5761059735066;1710.9914450427916;826.1531929771911;863.2274114667338;913.2374467319862;918.4351623751345;964.4117088575963;14656.560303190709;14976.625584360478;15208.695826083416;15235.695286094216;15242.695146097016;812.5652775764937;847.3475423923544;872.8079822439054;918.1828172926101;957.5015101366339;7191.352778249878;8124.63439145228;8358.373122015873;8699.869501957475;8853.73438796837;407694;410200;411001;413110;432486;50529.747351263744;51734.63420485749;52357.476425236026;52938;53151.73424132932;867.7310033889514;890.8396488631979;1053.1259054984343;1085.3650614390513;1134.075728281448;13772.10481318711;14038.157710536992;14254.572362829133;14457.783133252799;14480.855191448372;26762.732372676805;27070.79177773163;27515.58726619062;27550.173494795188;28017.719822802326;34432.65567344295;34579.65420345865;34630.30739385148;34733;34921.47617785786;6452.516061295515;6637.601743895381;6661.866762664817;6712.6979285931275;6890.827729306607;9607.759806004906;9666.516674166123;9685.32202745801;10030.598776048877;10127.392356458637;7436.330730234305;8723.738287851374;8790.692325768567;8885.4668719877;8930.419522731001;7853.607319633881;8158.347332213528;8434.325253979545;8443.493390396596;8577.142285771373;8061.919380806352;8529.701460448854;8693.478391296543;8782.604782784661;8791.604377802887;6295.464885484785;6553.934460655523;6571.408573228432;6620.172478440195;6648.5678430901835;6934.375906168469;8860.778480538038;8984.550772461482;8997.955010224907;9129.45223286605 12:20:29 INFO - PROCESS | 6404 | |3;mootools.html;1234.000459627701;1355.7085226676265;1382.2812137688402;1486.9776953345702;1711.0247159119292;5968.313643930949;6798.150231221098;6896.275891031445;6898.3791458768765;6898.448124150069;6834.487413443987;7004;7005.684744186511;7016.543924644894;7023.578585284874;1741.6081381689146;1784.2060283173994;1785.4732853808093;2043.7343145391078;2074.8962551872346;1751.1506919144206;1759.6744602248625;2023.8077382648626;2075.8754474731563;2078.615456140611;2002.2991952816471;2006.7391239138965;2009.909554070063;2011.788762179972;2014;1955.139738515056;2033.877967321958;2033.918643254268;2034.5523984723336;2036.3076553971573;1997.980020199794;2012.4365177750253;2022.9494262643552;2057.845661575373;2059.5366042640285;7094.361507464353;7148.571085734872;7149.571025738473;7152.606606636633;7154.785356439315;3955.861544845917;4052.371882358239;4056.9594304056877;4057.8376864925367;4074.2055299216663;2612.4644447888136;2631.4868600622885;2656.1234792518617;2661.294756889426;2730.358365784039;769.0310209136472;782.1552723059083;788.0503992688854;828.1511450762956;828.411827602403;9567.186789122932;9568.378055426376;9569.760755981086;9578.808423831553;9586.233101351945;3765.6799172070682;3810.9809450952566;3825.9617403826164;3903.1217975955183;3903.512060992376;8203.876941845878;8207;8208.958955205306;8213.055498617616;8222.17778222173;4125.958740412558;4130.050088479667;4132.91734165321;4133.565975572522;4133.966508372907;3698.4822124902535;3727.5154229950476;3741.1021354874633;3749.7937613430977;3754.8310326035394;3256;3266.5263536787033;3284.3431313737346;3327.5341452196712;3333.383324085052;941.2328951904176;971.6502059258661;1059.6079450603172;1064.446487826326;1073.468633026641;902.9954850225707;917.3624331089962;918.2745630951607;920.8066306075799;1075.2419544221304;6309.14826498426;6366.904496432558;6373.426391624776;6374.107624932513;6374.107624932513;1026.2405819693522;1030.835066389374;1051.432226597644;1062.5537274344795;1066.8239740442896;4896.4124305083615;4967.329410529533;5012.298278241049;5024.120778863684;5042.823501177441;8306.958465207636;8603.440776349516;8711.738647840575;8756.51839148853;8764.824703505894;8289.253967142986;8427.199416055464;8447.662093516314;8589.44168629037;8614.440061396115;6789.15135608049;6790.151231096113;6862.107925969692;6866.656667166621;6868.072810170563;6230.470410015199;6281;6281.623102613858;6295.276043255084;6304.05439184126;7514.699412023677;7943.205679432011;7966.681332746625;8014.158513356247;8087.797805054921;7746.264104910025;7832.412569057229;7914.802129946797;7939.960300198693;7945.562994035384;5951.7619295227705;6068.7269072892705;6068.848278793065;6075.665838378932;6079.483243924316;6551.967240163769;6568.047633093271;6603.405693487609;6612.305707900601;6615.768448104293;5180.326557547494;6068.089786532056;6115.602485838406;6161.353057928853;6161.353057929032;6035.155078289131;6193.411625895533;6228.844278893064;6318.684065796784;6337.2395312562785;5830.7959221427045;5841.678707671119;5871.94128058714;5876.706164691834;5881.17663527098;5818.156367326798;5818.505427038749;5859.326177489644;5923.614965027259;5926.822195334147;5698.401667824819;5717.342505611908;5725.828225153252;5732.283464566929;5734.455226753452 12:20:29 INFO - PROCESS | 6404 | |4;prototype.html;300.73084589292586;305.64239839387915;306.09243592747504;306.5554945329273;309.1205520294761;5097.362829646294;5150.69095854249;5178.249153872686;5200.063988482072;5204;5133.153029750096;5135.229715542661;5142.7428628568605;5142.820001299955;5148.073346797575;3853.7687738735767;4082.652974497164;4085.8569950051756;4087.550369459357;4088.3049881520215;3940.6453419192267;3951.0714981979213;4022.913813270415;4049.02823322402;4049.5545489996075;3988.9800550997206;4013.799310034501;4018.819153138116;4023.9597604024025;4031.9596804032026;3825.2731980923536;3875.9031024224337;3895.2793733159456;4016.5380981187245;4019.4171845082446;3477.1828620274214;3497.6852083312624;3504.912377190565;3513.9297214055578;3515.5781306243157;4943.060818444484;4964.975175124101;4979.0788704089855;4980.626453016038;4981.900361992776;4561.064981678748;4596.402467679214;4596.747178905159;4597.586217240464;4602.447706275235;5305.920411193835;5374.516293533601;5412.972935135299;5420.268263784378;5428.077226871402;3837.9424308635394;3844.692424606025;3849;3850.788206648633;3857.768533887948;5680.6591604503865;5693.174489699012;5709.685967271798;5711.514521265697;5714.1428785682065;3971.2653159165648;3978.900527486778;3980.9402858957137;3981.880543583697;3989.082511022481;4013.177298653769;4108.055147316134;4118.6499147572795;4120.381942708617;4123.319652257344;4564.269716845355;4567.954320456753;4571;4573;4573.062522182944;5437.673739575638;5442.482964118402;5446.8910621787345;5448.482394172547;5449.972750136224;1436.2818590704649;1457.9416823326949;1458.0741229319246;1458.795768592398;1458.8322342930487;976.2523902453423;999.9600015999424;1004.9497525123714;1006.2453160129902;1008.369768894441;4829.806807727651;4832.830850920201;4833.854984350475;4839.7096174229655;4846.273059041101;5617.38208797032;5620.185073164368;5620.943790562042;5628.296462942132;5635.126555383922;4821.975890120527;4828.203346447796;4832.806687732522;4841.709497430095;4882.633802464829;2858.857057147134;2934.8385838779072;3021.3957208558377;3059.877604895824;3062.2038270049948;4963.478834722302;5345.9842629900195;5402.91895621566;5426.67439953604;5427.83716488506;5818.410807190844;5823.5923485355615;5860.882782344329;5863.794767183128;5866.941330586639;5399.541039011728;5409.486098820606;5413.215083812746;5414.566834653218;5414.675119492843;5574.832755017356;5716.256886604715;5717.113847353667;5720.885582288414;5726.055200891973;5573;5577.776888924398;5585.5252303553025;5587.106063029895;5589.10574308125;5405.945940540544;5410.83767486976;5413.133898576209;5416.918746218888;5419.701916394479;3817.217470418613;3818.4081467372603;3821.636944490269;3827.7129215308405;3835.2329534092737;5604.103343465026;5662.065759149694;5681.914771278517;5685.573581981285;5690.203371528072;5401.459854014567;5471.234027236111;5474.644148130518;5479.232907392889;5484.862878427912;5475;5481.369642491005;5486.039943010037;5486.231927530069;5488.862778430571;5182.559482443884;5330.8933821324135;5331.200319952039;5335.973320133375;5366.1145910925825;5472.562195024469;5477.917831232455;5500.257465242141;5546.58400619947;5553.333599968029;5371.167469042305;5383.623146379872;5385.784568617211;5387.084195686664;5387.973060134675 12:20:29 INFO - PROCESS | 6404 | |5;yui.html;621.8538643418793;691.0601581848682;694.8679750847339;710.9857802843942;747.0960138232738;11020.283681560693;13311.134776239538;13642.931785341085;13662.521811736578;13681.110727802687;12822.679433014157;12869.227846329226;12924.676883077927;12947.676308092303;12960.93519532401;759.9088109426876;782.5304817109717;782.6086956521739;782.6282515804976;783.1737516919648;602.7317843559617;612.70590116744;765.7281665008925;780.0288640642408;781.4803155901348;808.3533173461237;810.3233799777194;814.8451794159091;815.294770023928;815.4780940198278;619.0343064818896;625.7434451874709;802.2218448105328;803.7829785957788;806.8587997100514;591.0661155374498;602.8854517641678;604.9576529642927;605.201134502457;605.4157737783061;12084.154109212359;12167.391630418444;12173.939130304381;12176.330301833395;12184;11778.823317650242;12226.388680565937;12299;12382.938085309515;12470.75058498825;9553;9683.41899486033;9746.707598772047;9762.315363275156;9792.216622670241;3285.4250506161325;3315.651856555075;3348.1294863335706;3425.794452332843;3425.8972230833115;40279.59720402788;40680.79659601713;40699.186016279804;40788;40789.38815917764;9453.480058596842;9518.905325887474;9669.806603867883;9766.316357855025;9949.751256218653;16826.57933551671;16840.915795421188;16860.32558697663;16865.32538698463;16885.662286754196;6487.448566871869;6528.967355163194;6596.076549283104;6656.600603963778;6669.599824010478;3516.9472457913153;3573.6426357364057;3607.603163651996;3608.296382205497;3652.7808331500196;2577.1495406515805;2603.166986564319;2618.4501254736338;2619.567771317711;2623.3703911061207;480.2939678672346;482.80929033031754;484.09474283090844;486.18563905458217;490.74481269739533;469.90836786826924;560.7925067724968;581.9447152520504;598.4494265275956;602.9155918171459;7107.609081500567;7637.923620763832;7707.92292077072;7720.691172353043;7936.642851071716;471.7193270004342;578.8523926398825;587.8971180043475;607.6597105620866;627.9183706118267;3585.5338805955057;3597.640235976434;3635.236600313911;3748.250349930025;3907.9804600976813;45671.54328456739;45762.31356529655;46590;46864;46981.5301846984;38098.42852357217;39040.41439378355;39093.609063909564;39225;39371.80314098411;34880.30239395198;35107.64892351095;35384.64615353865;36766;36939.0765230866;8059.476134051268;8073.19268073188;8089.595520224083;8170.387220958571;8355.373346998878;28477.857610712643;28680.28299292451;29155.271118222216;29320.12039638814;29461.705382945896;35803.462948055276;37272.62727372692;37584.24831503409;37694.057648559006;37766.811165944;9830.213582913493;9945.104940555095;10068.748281292734;10105.39367637944;10171.440570768678;10937.343759374464;11029.393383363671;11155.330680159217;11212.887871121184;11367.48846301935;10652.89347106519;10752.08607268391;10897.78204435891;11140.665780026613;11507;9402.38884472507;9420.152186303265;9526.714198574055;9559.952200238955;9584.329096963145;8016.4388492807275;10148.13740832008;10167.510129042332;10334.793304134026;10347.27569070188;7886.526808391515;7918.762437126896;7926.127342013392;7997.680092796223;8107.270345668682;7413.2957369049855;7772.222777722182;7937.920620793949;8001.479903806234;8074.959625202071 12:20:29 INFO - PROCESS | 6404 | __end_tp_report 12:20:29 INFO - PROCESS | 6404 | __start_cc_report 12:20:29 INFO - PROCESS | 6404 | _x_x_mozilla_cycle_collect,924 12:20:29 INFO - PROCESS | 6404 | __end_cc_report 12:20:29 INFO - PROCESS | 6404 | __startTimestamp1452716429262__endTimestamp 12:20:29 INFO - PROCESS | 6404 | 12:20:29 INFO - PROCESS | 6404 | ------- Summary: start ------- 12:20:29 INFO - PROCESS | 6404 | Number of tests: 6 12:20:29 INFO - PROCESS | 6404 | 12:20:29 INFO - PROCESS | 6404 | [#0] dojo.html Cycles:165 Average:4395.84 Median:4504.19 stddev:438.92 (9.7%) stddev-sans-first:415.90 12:20:29 INFO - PROCESS | 6404 | Values: 2557.5 2620.9 2628.6 2634.6 2640.6 4269.0 4346.1 4370.2 4374.0 4393.3 4379.5 4413.3 4441.5 4473.5 4504.2 4034.8 4066.3 4111.8 4167.9 4202.2 4035.2 4126.0 4152.6 4168.7 4178.1 4076.6 4093.8 4105.4 4130.2 4141.8 4111.2 4117.9 4119.0 4120.4 4150.5 4057.4 4096.6 4121.1 4138.7 4157.9 4223.7 4309.4 4327.0 4329.0 4384.5 4690.9 4728.1 4729.9 4733.5 4774.7 4738.1 4744.2 4746.7 4748.9 4795.0 4325.7 4391.9 4397.1 4427.3 4495.8 4864.0 4872.9 4890.9 4936.5 4942.0 4707.3 4708.1 4709.5 4711.2 4752.7 4629.6 4703.3 4707.2 4770.8 4858.3 4686.8 4717.7 4720.2 4720.5 4754.0 4703.0 4703.3 4705.3 4705.8 4745.7 3838.6 3905.6 3918.5 3962.3 3974.7 3544.5 3555.1 3558.0 3566.4 3580.0 4151.8 4158.3 4162.6 4169.2 4198.9 4540.8 4614.5 4619.4 4692.9 4756.4 4174.2 4182.0 4189.2 4192.6 4206.2 4242.3 4264.6 4264.7 4309.7 4309.9 4401.7 4482.7 4482.9 4484.6 4519.1 4788.1 4804.6 4806.1 4808.4 4845.1 4544.0 4557.5 4561.1 4565.8 4591.4 4566.7 4655.9 4668.9 4669.7 4724.3 4791.0 4816.3 4819.5 4819.5 4850.5 4649.1 4666.1 4669.6 4670.1 4710.1 4524.1 4568.5 4600.9 4606.8 4644.4 4565.8 4580.3 4589.7 4615.7 4628.2 4649.7 4682.9 4689.2 4692.1 4733.0 4331.5 4418.5 4421.3 4447.3 4533.6 12:20:29 INFO - PROCESS | 6404 | 12:20:29 INFO - PROCESS | 6404 | [#1] ext.html Cycles:180 Average:40051.35 Median:32532.50 stddev:69152.05 (212.6%) stddev-sans-first:69282.24 12:20:29 INFO - PROCESS | 6404 | Values: 488.0 519.9 535.2 541.8 546.3 24069.9 24762.4 24788.5 31656.0 32062.8 35666.0 36139.8 36168.5 36219.8 36230.3 7637.0 7868.0 7871.4 7874.8 7877.6 7686.7 7746.3 7759.3 7806.5 7822.6 7754.1 7785.6 7820.1 7820.7 7822.4 7762.3 7845.6 7850.9 7851.5 7855.5 7451.7 7512.6 7555.5 7558.4 7560.7 35364.0 35814.5 35845.6 35880.5 35884.5 2747.6 2752.0 2790.3 2798.6 3138.0 27498.6 27536.9 27731.9 27849.3 27877.4 3135.6 3154.5 3180.0 3188.0 3215.9 205620.0 206145.0 206510.0 206776.0 208560.0 43668.3 50679.2 50986.7 51005.7 51011.5 38666.6 38720.6 38909.4 38946.6 54594.0 12917.4 13175.8 13185.3 13186.9 13207.1 9725.8 9813.1 9836.2 9838.2 9850.8 15356.4 15821.2 15851.0 16924.7 17168.3 5685.6 6932.7 7005.6 7135.3 7175.7 801.4 872.5 922.0 945.6 970.3 24583.4 25480.9 25610.6 25701.4 25756.4 925.6 933.1 967.4 972.2 973.6 12029.2 12227.4 12230.4 12243.6 12272.7 297319.0 300212.0 301812.0 302755.0 303098.0 41546.8 42106.7 42118.6 42137.2 42196.4 1033.6 1120.6 1205.8 1227.7 1247.1 25713.7 27441.2 27469.3 27476.2 27753.0 37271.0 37758.2 37840.0 37907.8 37939.8 194142.0 195209.0 300527.0 304337.0 342388.0 28127.9 28257.6 28274.2 28564.6 28649.9 36010.3 36862.8 36875.4 37323.0 37358.6 31321.5 31401.7 31596.2 32511.0 32626.2 32132.7 32262.2 32272.5 32554.0 33249.3 29477.3 29866.7 29901.9 30198.1 30207.4 25027.6 26050.7 26877.5 27082.5 28884.0 22952.3 23017.7 23160.5 23170.0 23278.8 12:20:29 INFO - PROCESS | 6404 | 12:20:29 INFO - PROCESS | 6404 | [#2] jquery.html Cycles:180 Average:22187.63 Median:4787.43 stddev:67606.78 (1412.2%) stddev-sans-first:67776.54 12:20:29 INFO - PROCESS | 6404 | Values: 344.7 345.5 349.0 349.5 350.5 11698.3 12044.1 14002.9 14035.5 14845.0 13650.3 14141.0 14264.4 15120.5 15150.1 4073.0 4749.5 4939.5 4945.6 4955.1 4729.1 4779.5 4795.4 4800.2 4804.2 4634.7 4779.4 4815.3 4851.3 4857.4 4711.9 4820.0 4831.2 4851.1 4858.9 4297.4 4376.3 4384.1 4386.1 4387.0 17697.4 17751.4 17951.3 17953.6 18088.5 1868.4 1881.2 1913.2 1951.2 1968.1 9388.5 11829.5 12196.5 12208.9 12276.5 1659.0 1724.2 1755.9 1774.9 1780.2 46117.5 46307.3 46927.8 47376.5 47465.8 9068.6 9249.2 9373.7 9399.6 9464.6 10474.9 10801.8 11114.9 11955.9 11988.1 6584.8 6627.5 6642.1 6652.2 6721.8 6224.6 6250.0 6278.7 6391.5 6409.4 5490.1 5533.2 5538.2 5544.3 5572.9 1677.9 1679.6 1683.4 1695.6 1711.0 826.2 863.2 913.2 918.4 964.4 14656.6 14976.6 15208.7 15235.7 15242.7 812.6 847.3 872.8 918.2 957.5 7191.4 8124.6 8358.4 8699.9 8853.7 407694.0 410200.0 411001.0 413110.0 432486.0 50529.7 51734.6 52357.5 52938.0 53151.7 867.7 890.8 1053.1 1085.4 1134.1 13772.1 14038.2 14254.6 14457.8 14480.9 26762.7 27070.8 27515.6 27550.2 28017.7 34432.7 34579.7 34630.3 34733.0 34921.5 6452.5 6637.6 6661.9 6712.7 6890.8 9607.8 9666.5 9685.3 10030.6 10127.4 7436.3 8723.7 8790.7 8885.5 8930.4 7853.6 8158.3 8434.3 8443.5 8577.1 8061.9 8529.7 8693.5 8782.6 8791.6 6295.5 6553.9 6571.4 6620.2 6648.6 6934.4 8860.8 8984.6 8998.0 9129.5 12:20:29 INFO - PROCESS | 6404 | 12:20:29 INFO - PROCESS | 6404 | [#3] mootools.html Cycles:180 Average:4861.67 Median:5960.04 stddev:2568.45 (43.1%) stddev-sans-first:2561.18 12:20:29 INFO - PROCESS | 6404 | Values: 1234.0 1355.7 1382.3 1487.0 1711.0 5968.3 6798.2 6896.3 6898.4 6898.4 6834.5 7004.0 7005.7 7016.5 7023.6 1741.6 1784.2 1785.5 2043.7 2074.9 1751.2 1759.7 2023.8 2075.9 2078.6 2002.3 2006.7 2009.9 2011.8 2014.0 1955.1 2033.9 2033.9 2034.6 2036.3 1998.0 2012.4 2022.9 2057.8 2059.5 7094.4 7148.6 7149.6 7152.6 7154.8 3955.9 4052.4 4057.0 4057.8 4074.2 2612.5 2631.5 2656.1 2661.3 2730.4 769.0 782.2 788.1 828.2 828.4 9567.2 9568.4 9569.8 9578.8 9586.2 3765.7 3811.0 3826.0 3903.1 3903.5 8203.9 8207.0 8209.0 8213.1 8222.2 4126.0 4130.1 4132.9 4133.6 4134.0 3698.5 3727.5 3741.1 3749.8 3754.8 3256.0 3266.5 3284.3 3327.5 3333.4 941.2 971.7 1059.6 1064.4 1073.5 903.0 917.4 918.3 920.8 1075.2 6309.1 6366.9 6373.4 6374.1 6374.1 1026.2 1030.8 1051.4 1062.6 1066.8 4896.4 4967.3 5012.3 5024.1 5042.8 8307.0 8603.4 8711.7 8756.5 8764.8 8289.3 8427.2 8447.7 8589.4 8614.4 6789.2 6790.2 6862.1 6866.7 6868.1 6230.5 6281.0 6281.6 6295.3 6304.1 7514.7 7943.2 7966.7 8014.2 8087.8 7746.3 7832.4 7914.8 7940.0 7945.6 5951.8 6068.7 6068.8 6075.7 6079.5 6552.0 6568.0 6603.4 6612.3 6615.8 5180.3 6068.1 6115.6 6161.4 6161.4 6035.2 6193.4 6228.8 6318.7 6337.2 5830.8 5841.7 5871.9 5876.7 5881.2 5818.2 5818.5 5859.3 5923.6 5926.8 5698.4 5717.3 5725.8 5732.3 5734.5 12:20:29 INFO - PROCESS | 6404 | 12:20:29 INFO - PROCESS | 6404 | [#4] prototype.html Cycles:180 Average:4536.85 Median:5134.19 stddev:1325.67 (25.8%) stddev-sans-first:1290.70 12:20:29 INFO - PROCESS | 6404 | Values: 300.7 305.6 306.1 306.6 309.1 5097.4 5150.7 5178.2 5200.1 5204.0 5133.2 5135.2 5142.7 5142.8 5148.1 3853.8 4082.7 4085.9 4087.6 4088.3 3940.6 3951.1 4022.9 4049.0 4049.6 3989.0 4013.8 4018.8 4024.0 4032.0 3825.3 3875.9 3895.3 4016.5 4019.4 3477.2 3497.7 3504.9 3513.9 3515.6 4943.1 4965.0 4979.1 4980.6 4981.9 4561.1 4596.4 4596.7 4597.6 4602.4 5305.9 5374.5 5413.0 5420.3 5428.1 3837.9 3844.7 3849.0 3850.8 3857.8 5680.7 5693.2 5709.7 5711.5 5714.1 3971.3 3978.9 3980.9 3981.9 3989.1 4013.2 4108.1 4118.6 4120.4 4123.3 4564.3 4568.0 4571.0 4573.0 4573.1 5437.7 5442.5 5446.9 5448.5 5450.0 1436.3 1457.9 1458.1 1458.8 1458.8 976.3 1000.0 1004.9 1006.2 1008.4 4829.8 4832.8 4833.9 4839.7 4846.3 5617.4 5620.2 5620.9 5628.3 5635.1 4822.0 4828.2 4832.8 4841.7 4882.6 2858.9 2934.8 3021.4 3059.9 3062.2 4963.5 5346.0 5402.9 5426.7 5427.8 5818.4 5823.6 5860.9 5863.8 5866.9 5399.5 5409.5 5413.2 5414.6 5414.7 5574.8 5716.3 5717.1 5720.9 5726.1 5573.0 5577.8 5585.5 5587.1 5589.1 5405.9 5410.8 5413.1 5416.9 5419.7 3817.2 3818.4 3821.6 3827.7 3835.2 5604.1 5662.1 5681.9 5685.6 5690.2 5401.5 5471.2 5474.6 5479.2 5484.9 5475.0 5481.4 5486.0 5486.2 5488.9 5182.6 5330.9 5331.2 5336.0 5366.1 5472.6 5477.9 5500.3 5546.6 5553.3 5371.2 5383.6 5385.8 5387.1 5388.0 12:20:29 INFO - PROCESS | 6404 | 12:20:29 INFO - PROCESS | 6404 | [#5] yui.html Cycles:180 Average:11762.92 Median:23666.95 stddev:12766.04 (53.9%) stddev-sans-first:12774.43 12:20:29 INFO - PROCESS | 6404 | Values: 621.9 691.1 694.9 711.0 747.1 11020.3 13311.1 13642.9 13662.5 13681.1 12822.7 12869.2 12924.7 12947.7 12960.9 759.9 782.5 782.6 782.6 783.2 602.7 612.7 765.7 780.0 781.5 808.4 810.3 814.8 815.3 815.5 619.0 625.7 802.2 803.8 806.9 591.1 602.9 605.0 605.2 605.4 12084.2 12167.4 12173.9 12176.3 12184.0 11778.8 12226.4 12299.0 12382.9 12470.8 9553.0 9683.4 9746.7 9762.3 9792.2 3285.4 3315.7 3348.1 3425.8 3425.9 40279.6 40680.8 40699.2 40788.0 40789.4 9453.5 9518.9 9669.8 9766.3 9949.8 16826.6 16840.9 16860.3 16865.3 16885.7 6487.4 6529.0 6596.1 6656.6 6669.6 3516.9 3573.6 3607.6 3608.3 3652.8 2577.1 2603.2 2618.5 2619.6 2623.4 480.3 482.8 484.1 486.2 490.7 469.9 560.8 581.9 598.4 602.9 7107.6 7637.9 7707.9 7720.7 7936.6 471.7 578.9 587.9 607.7 627.9 3585.5 3597.6 3635.2 3748.3 3908.0 45671.5 45762.3 46590.0 46864.0 46981.5 38098.4 39040.4 39093.6 39225.0 39371.8 34880.3 35107.6 35384.6 36766.0 36939.1 8059.5 8073.2 8089.6 8170.4 8355.4 28477.9 28680.3 29155.3 29320.1 29461.7 35803.5 37272.6 37584.2 37694.1 37766.8 9830.2 9945.1 10068.7 10105.4 10171.4 10937.3 11029.4 11155.3 11212.9 11367.5 10652.9 10752.1 10897.8 11140.7 11507.0 9402.4 9420.2 9526.7 9560.0 9584.3 8016.4 10148.1 10167.5 10334.8 10347.3 7886.5 7918.8 7926.1 7997.7 8107.3 7413.3 7772.2 7937.9 8001.5 8075.0 12:20:29 INFO - PROCESS | 6404 | -------- Summary: end -------- 12:20:29 INFO - PROCESS | 6404 | 12:20:30 INFO - TEST-INFO | 6404: exit 0 12:20:30 INFO - TEST-OK | dromaeo_css | took 1115937ms 12:20:30 INFO - TEST-START | kraken 12:20:30 INFO - operating with platform_type : linux_ 12:20:30 INFO - Initialising browser for kraken test... 12:20:30 INFO - TEST-INFO | started process 6590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPBapYv/profile http://localhost:50782/getInfo.html) 12:20:34 INFO - PROCESS | 6590 | __metrics Screen width/height:1600/1200 12:20:34 INFO - PROCESS | 6590 | colorDepth:24 12:20:34 INFO - PROCESS | 6590 | Browser inner width/height: 1024/697 12:20:34 INFO - PROCESS | 6590 | __metrics 12:20:34 INFO - PROCESS | 6590 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:20:34 INFO - PROCESS | 6590 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:20:35 INFO - TEST-INFO | 6590: exit 0 12:20:35 INFO - Browser initialized. 12:20:35 INFO - Running cycle 1/1 for kraken test... 12:20:35 INFO - TEST-INFO | started process 6672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPBapYv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:20:47 INFO - PROCESS | 6672 | RSS: Main: 149499904 12:20:47 INFO - PROCESS | 6672 | 12:20:50 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50782/tests/kraken/driver.html?testName=audio-beat-detection) 12:20:50 INFO - PROCESS | 6672 | RSS: Main: 187756544 12:20:50 INFO - PROCESS | 6672 | 12:20:53 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50782/tests/kraken/driver.html?testName=audio-dft) 12:20:54 INFO - PROCESS | 6672 | RSS: Main: 177078272 12:20:54 INFO - PROCESS | 6672 | 12:20:57 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50782/tests/kraken/driver.html?testName=audio-fft) 12:20:57 INFO - PROCESS | 6672 | RSS: Main: 164048896 12:20:57 INFO - PROCESS | 6672 | 12:20:59 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50782/tests/kraken/driver.html?testName=audio-oscillator) 12:21:00 INFO - PROCESS | 6672 | RSS: Main: 163848192 12:21:00 INFO - PROCESS | 6672 | 12:21:02 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50782/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:21:03 INFO - PROCESS | 6672 | RSS: Main: 165445632 12:21:03 INFO - PROCESS | 6672 | 12:21:06 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50782/tests/kraken/driver.html?testName=imaging-darkroom) 12:21:06 INFO - PROCESS | 6672 | RSS: Main: 165658624 12:21:06 INFO - PROCESS | 6672 | 12:21:10 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50782/tests/kraken/driver.html?testName=imaging-desaturate) 12:21:10 INFO - PROCESS | 6672 | RSS: Main: 165515264 12:21:10 INFO - PROCESS | 6672 | 12:21:13 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50782/tests/kraken/driver.html?testName=json-parse-financial) 12:21:14 INFO - PROCESS | 6672 | RSS: Main: 166359040 12:21:14 INFO - PROCESS | 6672 | 12:21:15 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50782/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:21:16 INFO - PROCESS | 6672 | RSS: Main: 176353280 12:21:16 INFO - PROCESS | 6672 | 12:21:18 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50782/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:21:18 INFO - PROCESS | 6672 | RSS: Main: 175853568 12:21:18 INFO - PROCESS | 6672 | 12:21:21 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50782/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:21:21 INFO - PROCESS | 6672 | RSS: Main: 184635392 12:21:21 INFO - PROCESS | 6672 | 12:21:24 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:21:24 INFO - PROCESS | 6672 | RSS: Main: 189304832 12:21:24 INFO - PROCESS | 6672 | 12:21:27 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:21:28 INFO - PROCESS | 6672 | RSS: Main: 187682816 12:21:28 INFO - PROCESS | 6672 | 12:21:29 INFO - PROCESS | 6672 | Cycle 1(1): loaded http://localhost:50782/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50782/tests/kraken/driver.html?testName=ai-astar) 12:21:30 INFO - PROCESS | 6672 | RSS: Main: 246104064 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | __start_tp_report 12:21:30 INFO - PROCESS | 6672 | _x_x_mozilla_page_load 12:21:30 INFO - PROCESS | 6672 | _x_x_mozilla_page_load_details 12:21:30 INFO - PROCESS | 6672 | |i|pagename|runs| 12:21:30 INFO - PROCESS | 6672 | |0;ai-astar;115;116;110;115;115;116;105;116;116;114 12:21:30 INFO - PROCESS | 6672 | |1;audio-beat-detection;155;139;154;165;142;161;155;130;171;129 12:21:30 INFO - PROCESS | 6672 | |2;audio-dft;162;162;162;161;161;163;164;161;160;161 12:21:30 INFO - PROCESS | 6672 | |3;audio-fft;79;73;93;89;72;72;72;118;92;73 12:21:30 INFO - PROCESS | 6672 | |4;audio-oscillator;98;97;133;98;97;97;134;97;97;148 12:21:30 INFO - PROCESS | 6672 | |5;imaging-gaussian-blur;109;110;109;110;110;109;110;109;110;109 12:21:30 INFO - PROCESS | 6672 | |6;imaging-darkroom;147;147;147;146;146;147;147;147;147;147 12:21:30 INFO - PROCESS | 6672 | |7;imaging-desaturate;96;96;96;96;96;95;96;96;98;95 12:21:30 INFO - PROCESS | 6672 | |8;json-parse-financial;68;69;68;68;68;68;68;77;68;66 12:21:30 INFO - PROCESS | 6672 | |9;json-stringify-tinderbox;66;67;67;67;67;67;68;67;68;68 12:21:30 INFO - PROCESS | 6672 | |10;stanford-crypto-aes;81;83;83;84;83;84;84;84;84;85 12:21:30 INFO - PROCESS | 6672 | |11;stanford-crypto-ccm;123;122;123;127;121;122;127;128;123;125 12:21:30 INFO - PROCESS | 6672 | |12;stanford-crypto-pbkdf2;148;140;150;147;162;142;150;157;146;151 12:21:30 INFO - PROCESS | 6672 | |13;stanford-crypto-sha256-iterative;71;71;70;70;70;71;71;69;69;72 12:21:30 INFO - PROCESS | 6672 | __end_tp_report 12:21:30 INFO - PROCESS | 6672 | __start_cc_report 12:21:30 INFO - PROCESS | 6672 | _x_x_mozilla_cycle_collect,1004 12:21:30 INFO - PROCESS | 6672 | __end_cc_report 12:21:30 INFO - PROCESS | 6672 | __startTimestamp1452716490082__endTimestamp 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | ------- Summary: start ------- 12:21:30 INFO - PROCESS | 6672 | Number of tests: 14 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.50 stddev:3.58 (3.1%) stddev-sans-first:3.77 12:21:30 INFO - PROCESS | 6672 | Values: 115.0 116.0 110.0 115.0 115.0 116.0 105.0 116.0 116.0 114.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#1] audio-beat-detection Cycles:10 Average:150.10 Median:155.00 stddev:14.45 (9.3%) stddev-sans-first:15.22 12:21:30 INFO - PROCESS | 6672 | Values: 155.0 139.0 154.0 165.0 142.0 161.0 155.0 130.0 171.0 129.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.16 (0.7%) stddev-sans-first:1.22 12:21:30 INFO - PROCESS | 6672 | Values: 162.0 162.0 162.0 161.0 161.0 163.0 164.0 161.0 160.0 161.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:14.98 (19.7%) stddev-sans-first:15.81 12:21:30 INFO - PROCESS | 6672 | Values: 79.0 73.0 93.0 89.0 72.0 72.0 72.0 118.0 92.0 73.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#4] audio-oscillator Cycles:10 Average:109.60 Median:97.00 stddev:20.22 (20.8%) stddev-sans-first:21.01 12:21:30 INFO - PROCESS | 6672 | Values: 98.0 97.0 133.0 98.0 97.0 97.0 134.0 97.0 97.0 148.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 12:21:30 INFO - PROCESS | 6672 | Values: 109.0 110.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 12:21:30 INFO - PROCESS | 6672 | Values: 147.0 147.0 147.0 146.0 146.0 147.0 147.0 147.0 147.0 147.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 12:21:30 INFO - PROCESS | 6672 | Values: 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 98.0 95.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#8] json-parse-financial Cycles:10 Average:68.80 Median:68.00 stddev:2.97 (4.4%) stddev-sans-first:3.14 12:21:30 INFO - PROCESS | 6672 | Values: 68.0 69.0 68.0 68.0 68.0 68.0 68.0 77.0 68.0 66.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#9] json-stringify-tinderbox Cycles:10 Average:67.20 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 12:21:30 INFO - PROCESS | 6672 | Values: 66.0 67.0 67.0 67.0 67.0 67.0 68.0 67.0 68.0 68.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.08 (1.3%) stddev-sans-first:0.67 12:21:30 INFO - PROCESS | 6672 | Values: 81.0 83.0 83.0 84.0 83.0 84.0 84.0 84.0 84.0 85.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#11] stanford-crypto-ccm Cycles:10 Average:124.10 Median:124.00 stddev:2.47 (2.0%) stddev-sans-first:2.59 12:21:30 INFO - PROCESS | 6672 | Values: 123.0 122.0 123.0 127.0 121.0 122.0 127.0 128.0 123.0 125.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.30 Median:150.00 stddev:6.52 (4.3%) stddev-sans-first:6.89 12:21:30 INFO - PROCESS | 6672 | Values: 148.0 140.0 150.0 147.0 162.0 142.0 150.0 157.0 146.0 151.0 12:21:30 INFO - PROCESS | 6672 | 12:21:30 INFO - PROCESS | 6672 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:71.00 stddev:0.97 (1.4%) stddev-sans-first:1.00 12:21:30 INFO - PROCESS | 6672 | Values: 71.0 71.0 70.0 70.0 70.0 71.0 71.0 69.0 69.0 72.0 12:21:30 INFO - PROCESS | 6672 | -------- Summary: end -------- 12:21:30 INFO - PROCESS | 6672 | 12:21:31 INFO - TEST-INFO | 6672: exit 0 12:21:31 INFO - TEST-OK | kraken | took 61017ms 12:21:31 INFO - TEST-START | v8_7 12:21:31 INFO - operating with platform_type : linux_ 12:21:31 INFO - Initialising browser for v8_7 test... 12:21:31 INFO - TEST-INFO | started process 6920 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaRLUjd/profile http://localhost:50782/getInfo.html) 12:21:35 INFO - PROCESS | 6920 | __metrics Screen width/height:1600/1200 12:21:35 INFO - PROCESS | 6920 | colorDepth:24 12:21:35 INFO - PROCESS | 6920 | Browser inner width/height: 1024/697 12:21:35 INFO - PROCESS | 6920 | __metrics 12:21:35 INFO - PROCESS | 6920 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 12:21:35 INFO - PROCESS | 6920 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:21:36 INFO - TEST-INFO | 6920: exit 0 12:21:36 INFO - Browser initialized. 12:21:36 INFO - Running cycle 1/1 for v8_7 test... 12:21:36 INFO - TEST-INFO | started process 7001 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaRLUjd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:21:48 INFO - PROCESS | 7001 | RSS: Main: 149438464 12:21:48 INFO - PROCESS | 7001 | 12:22:10 INFO - PROCESS | 7001 | Cycle 1(1): loaded http://localhost:50782/tests/v8_7/run.html (next: http://localhost:50782/tests/v8_7/run.html) 12:22:11 INFO - PROCESS | 7001 | RSS: Main: 449466368 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | __start_tp_report 12:22:11 INFO - PROCESS | 7001 | _x_x_mozilla_page_load 12:22:11 INFO - PROCESS | 7001 | _x_x_mozilla_page_load_details 12:22:11 INFO - PROCESS | 7001 | |i|pagename|runs| 12:22:11 INFO - PROCESS | 7001 | |0;Richards;168.23687752355318 12:22:11 INFO - PROCESS | 7001 | |1;DeltaBlue;188.11136192626034 12:22:11 INFO - PROCESS | 7001 | |2;Encrypt;279.3296089385475 12:22:11 INFO - PROCESS | 7001 | |3;Decrypt;5251.308900523561 12:22:11 INFO - PROCESS | 7001 | |4;RayTrace;1994.0239043824702 12:22:11 INFO - PROCESS | 7001 | |5;Earley;805.1529790660226 12:22:11 INFO - PROCESS | 7001 | |6;Boyer;12268.292682926829 12:22:11 INFO - PROCESS | 7001 | |7;RegExp;44847.82608695652 12:22:11 INFO - PROCESS | 7001 | |8;Splay;599.5232419547079 12:22:11 INFO - PROCESS | 7001 | |9;NavierStokes;4835.748792270531 12:22:11 INFO - PROCESS | 7001 | __end_tp_report 12:22:11 INFO - PROCESS | 7001 | __startTimestamp1452716531170__endTimestamp 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | ------- Summary: start ------- 12:22:11 INFO - PROCESS | 7001 | Number of tests: 10 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | [#0] Richards Cycles:1 Average:168.24 Median:168.24 stddev:0.00 (0.0%) 12:22:11 INFO - PROCESS | 7001 | Values: 168.2 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | [#1] DeltaBlue Cycles:1 Average:188.11 Median:188.11 stddev:0.00 (0.0%) 12:22:11 INFO - PROCESS | 7001 | Values: 188.1 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | [#2] Encrypt Cycles:1 Average:279.33 Median:279.33 stddev:0.00 (0.0%) 12:22:11 INFO - PROCESS | 7001 | Values: 279.3 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | [#3] Decrypt Cycles:1 Average:5251.31 Median:5251.31 stddev:0.00 (0.0%) 12:22:11 INFO - PROCESS | 7001 | Values: 5251.3 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | [#4] RayTrace Cycles:1 Average:1994.02 Median:1994.02 stddev:0.00 (0.0%) 12:22:11 INFO - PROCESS | 7001 | Values: 1994.0 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | [#5] Earley Cycles:1 Average:805.15 Median:805.15 stddev:0.00 (0.0%) 12:22:11 INFO - PROCESS | 7001 | Values: 805.2 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | [#6] Boyer Cycles:1 Average:12268.29 Median:12268.29 stddev:0.00 (0.0%) 12:22:11 INFO - PROCESS | 7001 | Values: 12268.3 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | [#7] RegExp Cycles:1 Average:44847.83 Median:44847.83 stddev:0.00 (0.0%) 12:22:11 INFO - PROCESS | 7001 | Values: 44847.8 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | [#8] Splay Cycles:1 Average:599.52 Median:599.52 stddev:0.00 (0.0%) 12:22:11 INFO - PROCESS | 7001 | Values: 599.5 12:22:11 INFO - PROCESS | 7001 | 12:22:11 INFO - PROCESS | 7001 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 12:22:11 INFO - PROCESS | 7001 | Values: 4835.7 12:22:11 INFO - PROCESS | 7001 | -------- Summary: end -------- 12:22:11 INFO - PROCESS | 7001 | 12:22:12 INFO - TEST-INFO | 7001: exit 0 12:22:12 INFO - TEST-OK | v8_7 | took 41062ms 12:22:12 INFO - SUITE-END | took 1218s 12:22:12 INFO - Completed test suite (00:20:18) 12:22:12 INFO - Working with test: dromaeo_css 12:22:12 INFO - Generating results file: dromaeo_css 12:22:12 INFO - Working with test: kraken 12:22:12 INFO - Generating results file: kraken 12:22:12 INFO - javascript benchmark 12:22:12 INFO - Working with test: v8_7 12:22:12 INFO - Generating results file: v8_7 12:22:12 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:22:12 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 12:22:12 INFO - process_Request line: dromaeo_css 5995.10 graph.html#tests=[[72,94,35]] 12:22:12 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:22:12 INFO - process_Request line: kraken 1534.10 graph.html#tests=[[232,94,35]] 12:22:12 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:22:12 INFO - process_Request line: v8_7 18734.33 graph.html#tests=[[230,94,35]] 12:22:12 INFO - RETURN: dromaeo_css: 5995.10 12:22:12 INFO - RETURN: kraken: 1534.10 12:22:12 INFO - RETURN: v8_7: 18734.33 12:22:12 INFO - javascript benchmark 12:22:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2557.5422059300267, 2620.855852928088, 2628.5531459651856, 2634.6443230163923, 2640.630311756354, 4269.039466120122, 4346.1307738452315, 4370.1915145697985, 4373.956260437395, 4393.34099885017, 4379.474463064436, 4413.337999300106, 4441.511433742286, 4473.463184417867, 4504.1892459357305, 4034.8184331705143, 4066.3493840985448, 4111.753294802306, 4167.895802604944, 4202.222588821062, 4035.1929614077153, 4125.958740412602, 4152.56398078202, 4168.7081904266715, 4178.101708132751, 4076.5515793262716, 4093.774842383668, 4105.404716316148, 4130.153318569716, 4141.772202528859, 4111.218868414991, 4117.91764164715, 4118.979405102985, 4120.361343991686, 4150.481189851269, 4057.411675307064, 4096.5903409658795, 4121.052158003676, 4138.730982486129, 4157.91684166318, 4223.66210703143, 4309.418228539138, 4326.9567304326865, 4329.025969156946, 4384.539623339567, 4690.906181876378, 4728.148933192024, 4729.905401891977, 4733.479317275097, 4774.73738944358, 4738.123447162286, 4744.16977029022, 4746.691465054761, 4748.857534273978, 4794.9520504794855, 4325.653947684178, 4391.912161756747, 4397.076613911083, 4427.269500532376, 4495.752733599618, 4863.975680121647, 4872.853814385503, 4890.877728056827, 4936.506349365107, 4942.011597680478, 4707.270373092176, 4708.058388322349, 4709.458412282563, 4711.199096153662, 4752.667313288037, 4629.583337499641, 4703.318018887242, 4707.176244157259, 4770.833020844254, 4858.271259311132, 4686.789094490756, 4717.693349932243, 4720.150372932836, 4720.45714742809, 4754.02542478791, 4702.95297047032, 4703.294505824154, 4705.317728929286, 4705.7647117644665, 4745.667803253739, 3838.6353296436796, 3905.5508616508896, 3918.549366822852, 3962.32640451124, 3974.721769476109, 3544.5392099026963, 3555.1467647764352, 3558.0393293810525, 3566.358055549974, 3579.964200357963, 4151.813168407429, 4158.313878210122, 4162.604552567501, 4169.249535083653, 4198.874033778991, 4540.750258735801, 4614.515475874985, 4619.445666519972, 4692.906141877143, 4756.429228492603, 4174.248635245685, 4182.017225951899, 4189.162167566499, 4192.622663960258, 4206.179794940019, 4242.257604919188, 4264.616184543406, 4264.722793018444, 4309.741415515079, 4309.91380172401, 4401.713888597295, 4482.731036137842, 4482.8879278017, 4484.641228701631, 4519.0961807638605, 4788.11419887322, 4804.567588917014, 4806.062817750505, 4808.35087263215, 4845.1278769820365, 4543.977280113579, 4557.521460246759, 4561.110583436198, 4565.7717114144825, 4591.449026116888, 4566.657500687395, 4655.86032419028, 4668.906621867476, 4669.673122881366, 4724.314974328634, 4791.0, 4816.277558366273, 4819.469858315512, 4819.49395313487, 4850.53919877611, 4649.070185962753, 4666.136764698542, 4669.579737823612, 4670.089332580114, 4710.128626204163, 4524.095180963886, 4568.451785785727, 4600.88497787558, 4606.838760643362, 4644.419447569054, 4565.817367305403, 4580.290055041474, 4589.678722489393, 4615.699979501322, 4628.1669299525065, 4649.744264065509, 4682.906341873076, 4689.179393606173, 4692.085043416501, 4733.029728905635, 4331.523532411369, 4418.536053714313, 4421.336799480104, 4447.310666846644, 4533.6373090153365], "unit": "score", "name": "dojo.html", "value": 4369.846722824521}, {"lowerIsBetter": false, "replicates": [487.980480780769, 519.8718780246863, 535.1517844216916, 541.7562097056323, 546.2680008788224, 24069.879650601746, 24762.380940476498, 24788.50422991539, 31656.0, 32062.839685801595, 35666.0, 36139.819300903524, 36168.457473137925, 36219.81890090553, 36230.27539449209, 7636.961815190916, 7867.960660196691, 7871.409644276673, 7874.842503149934, 7877.606119694021, 7686.65410056546, 7746.264104910025, 7759.340456061242, 7806.453548251625, 7822.569758663271, 7754.10827754807, 7785.571793551352, 7820.100688420847, 7820.726274580391, 7822.413319001098, 7762.340201082915, 7845.607719614025, 7850.882236766453, 7851.45039847211, 7855.528668279864, 7451.739189128354, 7512.586807725627, 7555.508891922007, 7558.357539609085, 7560.659770310294, 35364.0, 35814.462783058276, 35845.64154358449, 35880.461793073126, 35884.46173307402, 2747.6015977683123, 2752.0230318237136, 2790.330320723032, 2798.552231642948, 3137.984310078458, 27498.587521186997, 27536.862315688493, 27731.86134069337, 27849.303767405774, 27877.442451151066, 3135.608048993876, 3154.495280755068, 3179.952300715491, 3187.9840600796847, 3215.8713651453913, 205620.0, 206145.0, 206510.0, 206776.0, 208559.95720021456, 43668.344974825406, 50679.23981140286, 50986.74506627443, 51005.74497127565, 51011.489885101415, 38666.613333866866, 38720.6127938717, 38909.41635875464, 38946.6105338943, 54594.0, 12917.418716157796, 13175.802362964563, 13185.340732963505, 13186.868131318755, 13207.141535800334, 9725.805483890425, 9813.067758562926, 9836.163926066365, 9838.16375608067, 9850.753731156778, 15356.385744570316, 15821.208939552977, 15851.0, 16924.746128808078, 17168.31326746941, 5685.573581981368, 6932.688029038705, 7005.579973817425, 7135.322144396274, 7175.712971481186, 801.4470015689155, 872.5419154943578, 921.9677311294073, 945.6217810865754, 970.2916870684439, 24583.38541536476, 25480.8725956369, 25610.615840762403, 25701.3574660635, 25756.3560910975, 925.6019911438011, 933.1275257634134, 967.3615413826841, 972.2027937091658, 973.6251543155794, 12029.218100823593, 12227.388630568614, 12230.388480576114, 12243.632691019284, 12272.693182670326, 297319.0, 300212.0, 301812.0, 302755.0, 303098.0, 41546.79226603908, 42106.68413237301, 42118.57881421208, 42137.1572568553, 42196.36705449421, 1033.5968972100886, 1120.56298043763, 1205.8492688413949, 1227.6623928419579, 1247.0647014738945, 25713.742862571136, 27441.17676469709, 27469.31326716848, 27476.17571472859, 27753.0, 37271.0, 37758.244835102596, 37840.0, 37907.81046094752, 37939.81030094832, 194142.0, 195209.0, 300527.0, 304337.0, 342388.0, 28127.859360703067, 28257.57613635756, 28274.151775446768, 28564.57153142746, 28649.856750716113, 36010.27979440449, 36862.8156859214, 36875.44686829646, 37323.0, 37358.62641373552, 31321.45758614551, 31401.685983139876, 31596.210094747814, 32511.0, 32626.184345390604, 32132.678673213904, 32262.19344516406, 32272.515912260864, 32554.0, 33249.335013300086, 29477.26306842346, 29866.70133298726, 29901.850490747405, 30198.09405717832, 30207.395852082394, 25027.624585631595, 26050.73949260559, 26877.462450751267, 27082.458350833265, 28884.0, 22952.311430657108, 23017.68907813805, 23160.536789263784, 23170.0, 23278.76721232766], "unit": "score", "name": "ext.html", "value": 15888.782488734127}, {"lowerIsBetter": false, "replicates": [344.72422062350114, 345.45590694655925, 348.97382696297785, 349.5333729471156, 350.4830375196585, 11698.298102113878, 12044.096692748035, 14002.859971400283, 14035.5087571935, 14844.999999999987, 13650.317484125779, 14141.0, 14264.429422823074, 15120.546383608482, 15150.090994540335, 4073.002114481956, 4749.525047495249, 4939.506049395068, 4945.554900058994, 4955.08330958772, 4729.101470720552, 4779.450363208223, 4795.400574928134, 4800.183968725325, 4804.183288840888, 4634.675572709912, 4779.378680771495, 4815.277708343759, 4851.27230915362, 4857.3685420895235, 4711.905761884743, 4820.0, 4831.178699621073, 4851.126797176506, 4858.927116093261, 4297.39836422901, 4376.321670141133, 4384.12317536494, 4386.144701783153, 4387.034852332482, 17697.38059167923, 17751.378701745376, 17951.281948722037, 17953.551161221076, 18088.457346279632, 1868.4301288107122, 1881.1628825172804, 1913.2251438167564, 1951.219512195119, 1968.1241847377923, 9388.5447755598, 11829.526818927232, 12196.512139514409, 12208.877911220863, 12276.508939642403, 1658.9751153732705, 1724.2413338131307, 1755.8858674186138, 1774.9378771742927, 1780.2078075256516, 46117.538824611656, 46307.30539041917, 46927.76536117332, 47376.526234737554, 47465.76267118642, 9068.637254509746, 9249.213816825511, 9373.671921482852, 9399.57701903416, 9464.574094165779, 10474.947625261977, 10801.83797243042, 11114.944425277821, 11955.880441195477, 11988.100892433102, 6584.8024559263295, 6627.469802415795, 6642.1033160523675, 6652.234992975773, 6721.798346049626, 6224.62652240867, 6249.999999999978, 6278.717457714414, 6391.488680905516, 6409.391107844747, 5490.094134467848, 5533.170024496358, 5538.169274608841, 5544.306961629796, 5572.944270557243, 1677.9244933978, 1679.5717092141426, 1683.351909514821, 1695.5761059735066, 1710.9914450427916, 826.1531929771911, 863.2274114667338, 913.2374467319862, 918.4351623751345, 964.4117088575963, 14656.560303190709, 14976.625584360478, 15208.695826083416, 15235.695286094216, 15242.695146097016, 812.5652775764937, 847.3475423923544, 872.8079822439054, 918.1828172926101, 957.5015101366339, 7191.352778249878, 8124.63439145228, 8358.373122015873, 8699.869501957475, 8853.73438796837, 407694.0, 410200.0, 411001.0, 413110.0, 432486.0, 50529.747351263744, 51734.63420485749, 52357.476425236026, 52938.0, 53151.73424132932, 867.7310033889514, 890.8396488631979, 1053.1259054984343, 1085.3650614390513, 1134.075728281448, 13772.10481318711, 14038.157710536992, 14254.572362829133, 14457.783133252799, 14480.855191448372, 26762.732372676805, 27070.79177773163, 27515.58726619062, 27550.173494795188, 28017.719822802326, 34432.65567344295, 34579.65420345865, 34630.30739385148, 34733.0, 34921.47617785786, 6452.516061295515, 6637.601743895381, 6661.866762664817, 6712.6979285931275, 6890.827729306607, 9607.759806004906, 9666.516674166123, 9685.32202745801, 10030.598776048877, 10127.392356458637, 7436.330730234305, 8723.738287851374, 8790.692325768567, 8885.4668719877, 8930.419522731001, 7853.607319633881, 8158.347332213528, 8434.325253979545, 8443.493390396596, 8577.142285771373, 8061.919380806352, 8529.701460448854, 8693.478391296543, 8782.604782784661, 8791.604377802887, 6295.464885484785, 6553.934460655523, 6571.408573228432, 6620.172478440195, 6648.5678430901835, 6934.375906168469, 8860.778480538038, 8984.550772461482, 8997.955010224907, 9129.45223286605], "unit": "score", "name": "jquery.html", "value": 7318.728778564221}, {"lowerIsBetter": false, "replicates": [1234.000459627701, 1355.7085226676265, 1382.2812137688402, 1486.9776953345702, 1711.0247159119292, 5968.313643930949, 6798.150231221098, 6896.275891031445, 6898.3791458768765, 6898.448124150069, 6834.487413443987, 7004.0, 7005.684744186511, 7016.543924644894, 7023.578585284874, 1741.6081381689146, 1784.2060283173994, 1785.4732853808093, 2043.7343145391078, 2074.8962551872346, 1751.1506919144206, 1759.6744602248625, 2023.8077382648626, 2075.8754474731563, 2078.615456140611, 2002.2991952816471, 2006.7391239138965, 2009.909554070063, 2011.788762179972, 2014.0, 1955.139738515056, 2033.877967321958, 2033.918643254268, 2034.5523984723336, 2036.3076553971573, 1997.980020199794, 2012.4365177750253, 2022.9494262643552, 2057.845661575373, 2059.5366042640285, 7094.361507464353, 7148.571085734872, 7149.571025738473, 7152.606606636633, 7154.785356439315, 3955.861544845917, 4052.371882358239, 4056.9594304056877, 4057.8376864925367, 4074.2055299216663, 2612.4644447888136, 2631.4868600622885, 2656.1234792518617, 2661.294756889426, 2730.358365784039, 769.0310209136472, 782.1552723059083, 788.0503992688854, 828.1511450762956, 828.411827602403, 9567.186789122932, 9568.378055426376, 9569.760755981086, 9578.808423831553, 9586.233101351945, 3765.6799172070682, 3810.9809450952566, 3825.9617403826164, 3903.1217975955183, 3903.512060992376, 8203.876941845878, 8207.0, 8208.958955205306, 8213.055498617616, 8222.17778222173, 4125.958740412558, 4130.050088479667, 4132.91734165321, 4133.565975572522, 4133.966508372907, 3698.4822124902535, 3727.5154229950476, 3741.1021354874633, 3749.7937613430977, 3754.8310326035394, 3256.0, 3266.5263536787033, 3284.3431313737346, 3327.5341452196712, 3333.383324085052, 941.2328951904176, 971.6502059258661, 1059.6079450603172, 1064.446487826326, 1073.468633026641, 902.9954850225707, 917.3624331089962, 918.2745630951607, 920.8066306075799, 1075.2419544221304, 6309.14826498426, 6366.904496432558, 6373.426391624776, 6374.107624932513, 6374.107624932513, 1026.2405819693522, 1030.835066389374, 1051.432226597644, 1062.5537274344795, 1066.8239740442896, 4896.4124305083615, 4967.329410529533, 5012.298278241049, 5024.120778863684, 5042.823501177441, 8306.958465207636, 8603.440776349516, 8711.738647840575, 8756.51839148853, 8764.824703505894, 8289.253967142986, 8427.199416055464, 8447.662093516314, 8589.44168629037, 8614.440061396115, 6789.15135608049, 6790.151231096113, 6862.107925969692, 6866.656667166621, 6868.072810170563, 6230.470410015199, 6281.0, 6281.623102613858, 6295.276043255084, 6304.05439184126, 7514.699412023677, 7943.205679432011, 7966.681332746625, 8014.158513356247, 8087.797805054921, 7746.264104910025, 7832.412569057229, 7914.802129946797, 7939.960300198693, 7945.562994035384, 5951.7619295227705, 6068.7269072892705, 6068.848278793065, 6075.665838378932, 6079.483243924316, 6551.967240163769, 6568.047633093271, 6603.405693487609, 6612.305707900601, 6615.768448104293, 5180.326557547494, 6068.089786532056, 6115.602485838406, 6161.353057928853, 6161.353057929032, 6035.155078289131, 6193.411625895533, 6228.844278893064, 6318.684065796784, 6337.2395312562785, 5830.7959221427045, 5841.678707671119, 5871.94128058714, 5876.706164691834, 5881.17663527098, 5818.156367326798, 5818.505427038749, 5859.326177489644, 5923.614965027259, 5926.822195334147, 5698.401667824819, 5717.342505611908, 5725.828225153252, 5732.283464566929, 5734.455226753452], "unit": "score", "name": "mootools.html", "value": 3965.6212227841843}, {"lowerIsBetter": false, "replicates": [300.73084589292586, 305.64239839387915, 306.09243592747504, 306.5554945329273, 309.1205520294761, 5097.362829646294, 5150.69095854249, 5178.249153872686, 5200.063988482072, 5204.0, 5133.153029750096, 5135.229715542661, 5142.7428628568605, 5142.820001299955, 5148.073346797575, 3853.7687738735767, 4082.652974497164, 4085.8569950051756, 4087.550369459357, 4088.3049881520215, 3940.6453419192267, 3951.0714981979213, 4022.913813270415, 4049.02823322402, 4049.5545489996075, 3988.9800550997206, 4013.799310034501, 4018.819153138116, 4023.9597604024025, 4031.9596804032026, 3825.2731980923536, 3875.9031024224337, 3895.2793733159456, 4016.5380981187245, 4019.4171845082446, 3477.1828620274214, 3497.6852083312624, 3504.912377190565, 3513.9297214055578, 3515.5781306243157, 4943.060818444484, 4964.975175124101, 4979.0788704089855, 4980.626453016038, 4981.900361992776, 4561.064981678748, 4596.402467679214, 4596.747178905159, 4597.586217240464, 4602.447706275235, 5305.920411193835, 5374.516293533601, 5412.972935135299, 5420.268263784378, 5428.077226871402, 3837.9424308635394, 3844.692424606025, 3849.0, 3850.788206648633, 3857.768533887948, 5680.6591604503865, 5693.174489699012, 5709.685967271798, 5711.514521265697, 5714.1428785682065, 3971.2653159165648, 3978.900527486778, 3980.9402858957137, 3981.880543583697, 3989.082511022481, 4013.177298653769, 4108.055147316134, 4118.6499147572795, 4120.381942708617, 4123.319652257344, 4564.269716845355, 4567.954320456753, 4571.0, 4573.0, 4573.062522182944, 5437.673739575638, 5442.482964118402, 5446.8910621787345, 5448.482394172547, 5449.972750136224, 1436.2818590704649, 1457.9416823326949, 1458.0741229319246, 1458.795768592398, 1458.8322342930487, 976.2523902453423, 999.9600015999424, 1004.9497525123714, 1006.2453160129902, 1008.369768894441, 4829.806807727651, 4832.830850920201, 4833.854984350475, 4839.7096174229655, 4846.273059041101, 5617.38208797032, 5620.185073164368, 5620.943790562042, 5628.296462942132, 5635.126555383922, 4821.975890120527, 4828.203346447796, 4832.806687732522, 4841.709497430095, 4882.633802464829, 2858.857057147134, 2934.8385838779072, 3021.3957208558377, 3059.877604895824, 3062.2038270049948, 4963.478834722302, 5345.9842629900195, 5402.91895621566, 5426.67439953604, 5427.83716488506, 5818.410807190844, 5823.5923485355615, 5860.882782344329, 5863.794767183128, 5866.941330586639, 5399.541039011728, 5409.486098820606, 5413.215083812746, 5414.566834653218, 5414.675119492843, 5574.832755017356, 5716.256886604715, 5717.113847353667, 5720.885582288414, 5726.055200891973, 5573.0, 5577.776888924398, 5585.5252303553025, 5587.106063029895, 5589.10574308125, 5405.945940540544, 5410.83767486976, 5413.133898576209, 5416.918746218888, 5419.701916394479, 3817.217470418613, 3818.4081467372603, 3821.636944490269, 3827.7129215308405, 3835.2329534092737, 5604.103343465026, 5662.065759149694, 5681.914771278517, 5685.573581981285, 5690.203371528072, 5401.459854014567, 5471.234027236111, 5474.644148130518, 5479.232907392889, 5484.862878427912, 5475.0, 5481.369642491005, 5486.039943010037, 5486.231927530069, 5488.862778430571, 5182.559482443884, 5330.8933821324135, 5331.200319952039, 5335.973320133375, 5366.1145910925825, 5472.562195024469, 5477.917831232455, 5500.257465242141, 5546.58400619947, 5553.333599968029, 5371.167469042305, 5383.623146379872, 5385.784568617211, 5387.084195686664, 5387.973060134675], "unit": "score", "name": "prototype.html", "value": 4117.847869207008}, {"lowerIsBetter": false, "replicates": [621.8538643418793, 691.0601581848682, 694.8679750847339, 710.9857802843942, 747.0960138232738, 11020.283681560693, 13311.134776239538, 13642.931785341085, 13662.521811736578, 13681.110727802687, 12822.679433014157, 12869.227846329226, 12924.676883077927, 12947.676308092303, 12960.93519532401, 759.9088109426876, 782.5304817109717, 782.6086956521739, 782.6282515804976, 783.1737516919648, 602.7317843559617, 612.70590116744, 765.7281665008925, 780.0288640642408, 781.4803155901348, 808.3533173461237, 810.3233799777194, 814.8451794159091, 815.294770023928, 815.4780940198278, 619.0343064818896, 625.7434451874709, 802.2218448105328, 803.7829785957788, 806.8587997100514, 591.0661155374498, 602.8854517641678, 604.9576529642927, 605.201134502457, 605.4157737783061, 12084.154109212359, 12167.391630418444, 12173.939130304381, 12176.330301833395, 12184.0, 11778.823317650242, 12226.388680565937, 12299.0, 12382.938085309515, 12470.75058498825, 9553.0, 9683.41899486033, 9746.707598772047, 9762.315363275156, 9792.216622670241, 3285.4250506161325, 3315.651856555075, 3348.1294863335706, 3425.794452332843, 3425.8972230833115, 40279.59720402788, 40680.79659601713, 40699.186016279804, 40788.0, 40789.38815917764, 9453.480058596842, 9518.905325887474, 9669.806603867883, 9766.316357855025, 9949.751256218653, 16826.57933551671, 16840.915795421188, 16860.32558697663, 16865.32538698463, 16885.662286754196, 6487.448566871869, 6528.967355163194, 6596.076549283104, 6656.600603963778, 6669.599824010478, 3516.9472457913153, 3573.6426357364057, 3607.603163651996, 3608.296382205497, 3652.7808331500196, 2577.1495406515805, 2603.166986564319, 2618.4501254736338, 2619.567771317711, 2623.3703911061207, 480.2939678672346, 482.80929033031754, 484.09474283090844, 486.18563905458217, 490.74481269739533, 469.90836786826924, 560.7925067724968, 581.9447152520504, 598.4494265275956, 602.9155918171459, 7107.609081500567, 7637.923620763832, 7707.92292077072, 7720.691172353043, 7936.642851071716, 471.7193270004342, 578.8523926398825, 587.8971180043475, 607.6597105620866, 627.9183706118267, 3585.5338805955057, 3597.640235976434, 3635.236600313911, 3748.250349930025, 3907.9804600976813, 45671.54328456739, 45762.31356529655, 46590.0, 46864.0, 46981.5301846984, 38098.42852357217, 39040.41439378355, 39093.609063909564, 39225.0, 39371.80314098411, 34880.30239395198, 35107.64892351095, 35384.64615353865, 36766.0, 36939.0765230866, 8059.476134051268, 8073.19268073188, 8089.595520224083, 8170.387220958571, 8355.373346998878, 28477.857610712643, 28680.28299292451, 29155.271118222216, 29320.12039638814, 29461.705382945896, 35803.462948055276, 37272.62727372692, 37584.24831503409, 37694.057648559006, 37766.811165944, 9830.213582913493, 9945.104940555095, 10068.748281292734, 10105.39367637944, 10171.440570768678, 10937.343759374464, 11029.393383363671, 11155.330680159217, 11212.887871121184, 11367.48846301935, 10652.89347106519, 10752.08607268391, 10897.78204435891, 11140.665780026613, 11507.0, 9402.38884472507, 9420.152186303265, 9526.714198574055, 9559.952200238955, 9584.329096963145, 8016.4388492807275, 10148.13740832008, 10167.510129042332, 10334.793304134026, 10347.27569070188, 7886.526808391515, 7918.762437126896, 7926.127342013392, 7997.680092796223, 8107.270345668682, 7413.2957369049855, 7772.222777722182, 7937.920620793949, 8001.479903806234, 8074.959625202071], "unit": "score", "name": "yui.html", "value": 5594.499914425195}], "name": "dromaeo_css", "value": 5995.101590921677}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 116.0, 110.0, 115.0, 115.0, 116.0, 105.0, 116.0, 116.0, 114.0], "unit": "score", "name": "ai-astar", "value": 113.8}, {"lowerIsBetter": true, "replicates": [155.0, 139.0, 154.0, 165.0, 142.0, 161.0, 155.0, 130.0, 171.0, 129.0], "unit": "score", "name": "audio-beat-detection", "value": 150.1}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 161.0, 161.0, 163.0, 164.0, 161.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [79.0, 73.0, 93.0, 89.0, 72.0, 72.0, 72.0, 118.0, 92.0, 73.0], "unit": "score", "name": "audio-fft", "value": 83.3}, {"lowerIsBetter": true, "replicates": [98.0, 97.0, 133.0, 98.0, 97.0, 97.0, 134.0, 97.0, 97.0, 148.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, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 98.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 77.0, 68.0, 66.0], "unit": "score", "name": "json-parse-financial", "value": 68.8}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 67.0, 67.0, 67.0, 67.0, 68.0, 67.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.2}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 83.0, 84.0, 83.0, 84.0, 84.0, 84.0, 84.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [123.0, 122.0, 123.0, 127.0, 121.0, 122.0, 127.0, 128.0, 123.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.1}, {"lowerIsBetter": true, "replicates": [148.0, 140.0, 150.0, 147.0, 162.0, 142.0, 150.0, 157.0, 146.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.3}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 70.0, 70.0, 71.0, 71.0, 69.0, 69.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.4}], "name": "kraken", "value": 1534.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.23687752355318], "unit": "score", "name": "Richards", "value": 209.83508800000004}, {"lowerIsBetter": false, "replicates": [188.11136192626034], "unit": "score", "name": "DeltaBlue", "value": 351.483288}, {"lowerIsBetter": false, "replicates": [279.3296089385475], "unit": "score", "name": "Encrypt", "value": 952.9279799999998}, {"lowerIsBetter": false, "replicates": [5251.308900523561], "unit": "score", "name": "Decrypt", "value": 50.68850548354939}, {"lowerIsBetter": false, "replicates": [1994.0239043824702], "unit": "score", "name": "RayTrace", "value": 371.1033746253746}, {"lowerIsBetter": false, "replicates": [805.1529790660226], "unit": "score", "name": "Earley", "value": 827.747046}, {"lowerIsBetter": false, "replicates": [12268.292682926829], "unit": "score", "name": "Boyer", "value": 54.32402186878729}, {"lowerIsBetter": false, "replicates": [44847.82608695652], "unit": "score", "name": "RegExp", "value": 20.312801745031518}, {"lowerIsBetter": false, "replicates": [599.5232419547079], "unit": "score", "name": "Splay", "value": 135.92633996023864}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 18734.3264236171}]} 12:22:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "18734.33"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1534.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "5995.10"}}} 12:22:12 INFO - Return code: 0 12:22:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 12:22:12 INFO - # TBPL SUCCESS # 12:22:12 INFO - Running post-action listener: _resource_record_post_action 12:22:12 INFO - Running post-run listener: _resource_record_post_run 12:22:13 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 507805696; Read time: 0; Write time: 420532 12:22:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 204206080; Read time: 0; Write time: 155960 12:22:13 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 303599616; Read time: 0; Write time: 264572 12:22:13 INFO - Running post-run listener: _upload_blobber_files 12:22:13 INFO - Blob upload gear active. 12:22:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:22:13 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 12:22:13 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:22:13 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:22:14 INFO - (blobuploader) - INFO - Open directory for files ... 12:22:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:22:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:22:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:22:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:22:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:22:15 INFO - (blobuploader) - INFO - Done attempting. 12:22:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:22:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:22:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:22:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:22:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:22:16 INFO - (blobuploader) - INFO - Done attempting. 12:22:16 INFO - (blobuploader) - INFO - Iteration through files over. 12:22:16 INFO - Return code: 0 12:22:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:22:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:22:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8aac7d9972b4761137fc91881e0e3f7890993cd4e92672aec0e36fc42645ae7ae1bbe282dba8a678c13635b07b3cea089b528924c5c210c4bfc8e55e8cf974c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa0add7b24242557e5c18be29b343c20a30e2da579087ce17a9acf84e3c42d5840effa63c027b1a7494735ca920953a9d56f20ff736e42913a459b3858b199e8"} 12:22:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:22:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:22:16 INFO - Contents: 12:22:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8aac7d9972b4761137fc91881e0e3f7890993cd4e92672aec0e36fc42645ae7ae1bbe282dba8a678c13635b07b3cea089b528924c5c210c4bfc8e55e8cf974c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa0add7b24242557e5c18be29b343c20a30e2da579087ce17a9acf84e3c42d5840effa63c027b1a7494735ca920953a9d56f20ff736e42913a459b3858b199e8"} 12:22:16 INFO - Copying logs to upload dir... 12:22:16 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1297.865237 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 37 secs) (at 2016-01-13 12:22:15.650247) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 12:22:15.653945) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8aac7d9972b4761137fc91881e0e3f7890993cd4e92672aec0e36fc42645ae7ae1bbe282dba8a678c13635b07b3cea089b528924c5c210c4bfc8e55e8cf974c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa0add7b24242557e5c18be29b343c20a30e2da579087ce17a9acf84e3c42d5840effa63c027b1a7494735ca920953a9d56f20ff736e42913a459b3858b199e8"} build_url:https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011472 build_url: 'https://queue.taskcluster.net/v1/task/Hpz9JW9HQPCYchwXhgOlPg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f8aac7d9972b4761137fc91881e0e3f7890993cd4e92672aec0e36fc42645ae7ae1bbe282dba8a678c13635b07b3cea089b528924c5c210c4bfc8e55e8cf974c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fa0add7b24242557e5c18be29b343c20a30e2da579087ce17a9acf84e3c42d5840effa63c027b1a7494735ca920953a9d56f20ff736e42913a459b3858b199e8"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 12:22:15.678545) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 12:22:15.678858) ========= 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=5bd038846534b2fdfa68eeae000001e2-1452713393.461695-30015157 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004831 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 12:22:15.763524) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 12:22:15.763848) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 12:22:15.764142) ========= ========= Total master_lag: 0.23 =========