builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-026 starttime: 1452474230.68 results: success (0) buildid: 20160110153932 builduid: b69db17e8fc84f1da6bbdc525acdd750 revision: acc35c2f2e1f9d62ea4dd5790678b08225bb1f9d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.682072) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.682722) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.683067) ========= 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=41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006100 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.707119) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.707467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.722218) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.722614) ========= 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=41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018015 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.772169) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.772520) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.772956) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:50.773275) ========= 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=41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-10 17:03:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-10 17:03:50 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.218720 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:51.004829) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:51.005204) ========= 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=41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.078484 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:51.094283) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:51.094685) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev acc35c2f2e1f9d62ea4dd5790678b08225bb1f9d --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 acc35c2f2e1f9d62ea4dd5790678b08225bb1f9d --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=41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-10 17:03:51,145 truncating revision to first 12 chars 2016-01-10 17:03:51,146 Setting DEBUG logging. 2016-01-10 17:03:51,146 attempt 1/10 2016-01-10 17:03:51,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/acc35c2f2e1f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-10 17:03:51,437 unpacking tar archive at: mozilla-central-acc35c2f2e1f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.687881 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:51.796622) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:51.797014) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:51.805251) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:51.805614) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-10 17:03:51.806135) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-10 17:03:51.806479) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:03:52 INFO - MultiFileLogger online at 20160110 17:03:52 in /builds/slave/test 17:03:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 17:03:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:03:52 INFO - {'append_to_log': False, 17:03:52 INFO - 'base_work_dir': '/builds/slave/test', 17:03:52 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 17:03:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:03:52 INFO - 'branch': 'Firefox-Non-PGO', 17:03:52 INFO - 'buildbot_json_path': 'buildprops.json', 17:03:52 INFO - 'config_files': ('talos/linux_config.py',), 17:03:52 INFO - 'default_actions': ('clobber', 17:03:52 INFO - 'read-buildbot-config', 17:03:52 INFO - 'download-and-extract', 17:03:52 INFO - 'populate-webroot', 17:03:52 INFO - 'create-virtualenv', 17:03:52 INFO - 'install', 17:03:52 INFO - 'run-tests'), 17:03:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:03:52 INFO - 'download_minidump_stackwalk': True, 17:03:52 INFO - 'download_symbols': 'ondemand', 17:03:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:03:52 INFO - 'tooltool.py': '/tools/tooltool.py', 17:03:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:03:52 INFO - '/tools/misc-python/virtualenv.py')}, 17:03:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:03:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:03:52 INFO - 'installer_path': 'installer.exe', 17:03:52 INFO - 'log_level': 'info', 17:03:52 INFO - 'log_name': 'talos', 17:03:52 INFO - 'log_to_console': True, 17:03:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:03:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:03:52 INFO - 'opt_config_files': (), 17:03:52 INFO - 'pip_index': False, 17:03:52 INFO - 'sps_profile': False, 17:03:52 INFO - 'sps_profile_interval': 0, 17:03:52 INFO - 'suite': 'dromaeojs-e10s', 17:03:52 INFO - 'system_bits': '32', 17:03:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:03:52 INFO - 'title': 'talos-linux64-ix-026', 17:03:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:03:52 INFO - 'use_talos_json': True, 17:03:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:03:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:03:52 INFO - 'work_dir': 'build'} 17:03:52 INFO - ##### 17:03:52 INFO - ##### Running clobber step. 17:03:52 INFO - ##### 17:03:52 INFO - Running pre-action listener: _resource_record_pre_action 17:03:52 INFO - Running main action method: clobber 17:03:52 INFO - rmtree: /builds/slave/test/build 17:03:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:03:53 INFO - Running post-action listener: _resource_record_post_action 17:03:53 INFO - ##### 17:03:53 INFO - ##### Running read-buildbot-config step. 17:03:53 INFO - ##### 17:03:53 INFO - Running pre-action listener: _resource_record_pre_action 17:03:53 INFO - Running main action method: read_buildbot_config 17:03:53 INFO - Using buildbot properties: 17:03:53 INFO - { 17:03:53 INFO - "project": "", 17:03:53 INFO - "product": "firefox", 17:03:53 INFO - "script_repo_revision": "production", 17:03:53 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 17:03:53 INFO - "repository": "", 17:03:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 17:03:53 INFO - "buildid": "20160110153932", 17:03:53 INFO - "pgo_build": "False", 17:03:53 INFO - "basedir": "/builds/slave/test", 17:03:53 INFO - "buildnumber": 202, 17:03:53 INFO - "slavename": "talos-linux64-ix-026", 17:03:53 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 17:03:53 INFO - "platform": "ubuntu64_hw", 17:03:53 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 17:03:53 INFO - "branch": "mozilla-central", 17:03:53 INFO - "repo_path": "mozilla-central", 17:03:53 INFO - "revision": "acc35c2f2e1f9d62ea4dd5790678b08225bb1f9d", 17:03:53 INFO - "stage_platform": "linux64", 17:03:53 INFO - "builduid": "b69db17e8fc84f1da6bbdc525acdd750", 17:03:53 INFO - "slavebuilddir": "test" 17:03:53 INFO - } 17:03:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 17:03:53 INFO - Running post-action listener: _resource_record_post_action 17:03:53 INFO - ##### 17:03:53 INFO - ##### Running download-and-extract step. 17:03:53 INFO - ##### 17:03:53 INFO - Running pre-action listener: _resource_record_pre_action 17:03:53 INFO - Running main action method: download_and_extract 17:03:53 INFO - mkdir: /builds/slave/test/build/tests 17:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:53 INFO - https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:03:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/test_packages.json 17:03:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/test_packages.json 17:03:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:03:53 INFO - Downloaded 1302 bytes. 17:03:53 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:03:53 INFO - Using the following test package requirements: 17:03:53 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:53 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:03:53 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:53 INFO - u'jsshell-linux-x86_64.zip'], 17:03:53 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:03:53 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:53 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:03:53 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:03:53 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:03:53 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 17:03:53 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 17:03:53 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:03:53 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:03:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:03:53 INFO - https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/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 17:03:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/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 17:03:56 INFO - Downloaded 22761285 bytes. 17:03:56 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 17:03:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:56 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 17:03:57 INFO - Return code: 0 17:03:57 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 17:03:57 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')]} 17:03:57 INFO - https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:03:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/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 17:03:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/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 17:03:59 INFO - Downloaded 22761285 bytes. 17:03: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 17:03:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 17:03: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 17:04:00 INFO - Return code: 0 17:04: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')]} 17:04:00 INFO - https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:04:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/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 17:04:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/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 17:04:02 INFO - Downloaded 11132285 bytes. 17:04:02 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 17:04:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 17:04:02 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 17:04:03 INFO - Return code: 0 17:04:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:03 INFO - https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:04:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/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 17:04:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwXgVq2kR1y_65mzGz2JWg/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 17:04:05 INFO - Downloaded 54050111 bytes. 17:04:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:05 INFO - mkdir: /builds/slave/test/properties 17:04:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:04:05 INFO - Writing to file /builds/slave/test/properties/build_url 17:04:05 INFO - Contents: 17:04:05 INFO - build_url:https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 17:04:05 INFO - Running post-action listener: _resource_record_post_action 17:04:05 INFO - Running post-action listener: set_extra_try_arguments 17:04:05 INFO - ##### 17:04:05 INFO - ##### Running populate-webroot step. 17:04:05 INFO - ##### 17:04:05 INFO - Running pre-action listener: _resource_record_pre_action 17:04:05 INFO - Running main action method: populate_webroot 17:04:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:04:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:04:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:04:05 INFO - '--tppagecycles', 17:04:05 INFO - '7'], 17:04:05 INFO - 'tests': ['tsvgm']}}, 17:04:05 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:04:05 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:04:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:04:05 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:05 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:04:05 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:04:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:05 INFO - 'talos_options': ['--e10s'], 17:04:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:04:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:05 INFO - 'tests': ['damp', 'tps']}, 17:04:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:05 INFO - 'talos_options': ['--e10s'], 17:04:05 INFO - 'tests': ['damp', 'tps']}, 17:04:05 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:04:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:04:05 INFO - 'other': {'tests': ['a11yr', 17:04:05 INFO - 'ts_paint', 17:04:05 INFO - 'tpaint', 17:04:05 INFO - 'sessionrestore', 17:04:05 INFO - 'sessionrestore_no_auto_restore']}, 17:04:05 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:04:05 INFO - 'tests': ['a11yr', 17:04:05 INFO - 'ts_paint', 17:04:05 INFO - 'tpaint', 17:04:05 INFO - 'sessionrestore', 17:04:05 INFO - 'sessionrestore_no_auto_restore']}, 17:04:05 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:04:05 INFO - 'tests': ['a11yr', 17:04:05 INFO - 'ts_paint', 17:04:05 INFO - 'tpaint', 17:04:05 INFO - 'sessionrestore', 17:04:05 INFO - 'sessionrestore_no_auto_restore']}, 17:04:05 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:04:05 INFO - 'tests': ['a11yr', 17:04:05 INFO - 'ts_paint', 17:04:05 INFO - 'tpaint', 17:04:05 INFO - 'sessionrestore', 17:04:05 INFO - 'sessionrestore_no_auto_restore']}, 17:04:05 INFO - 'other_l64': {'tests': ['a11yr', 17:04:05 INFO - 'ts_paint', 17:04:05 INFO - 'tpaint', 17:04:05 INFO - 'sessionrestore', 17:04:05 INFO - 'sessionrestore_no_auto_restore']}, 17:04:05 INFO - 'other_nol64': {'tests': ['a11yr', 17:04:05 INFO - 'ts_paint', 17:04:05 INFO - 'tpaint', 17:04:05 INFO - 'sessionrestore', 17:04:05 INFO - 'sessionrestore_no_auto_restore']}, 17:04:05 INFO - 'svgr': {'tests': ['tsvgx', 17:04:05 INFO - 'tsvgr_opacity', 17:04:05 INFO - 'tart', 17:04:05 INFO - 'tscrollx', 17:04:05 INFO - 'cart']}, 17:04:05 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:04:05 INFO - 'tests': ['tsvgx', 17:04:05 INFO - 'tsvgr_opacity', 17:04:05 INFO - 'tart', 17:04:05 INFO - 'tscrollx', 17:04:05 INFO - 'cart']}, 17:04:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:05 INFO - 'tests': ['tp5o']}, 17:04:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:05 INFO - 'talos_options': ['--e10s'], 17:04:05 INFO - 'tests': ['tp5o']}, 17:04:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:05 INFO - 'talos_options': ['--xperf_path', 17:04:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:05 INFO - 'tests': ['tp5n']}, 17:04:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:04:05 INFO - 'talos_options': ['--e10s', 17:04:05 INFO - '--xperf_path', 17:04:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:04:05 INFO - 'tests': ['tp5n']}}, 17:04:05 INFO - 'talos.zip': {'path': '', 17:04:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:04:05 INFO - Running post-action listener: _resource_record_post_action 17:04:05 INFO - ##### 17:04:05 INFO - ##### Running create-virtualenv step. 17:04:05 INFO - ##### 17:04:05 INFO - Running pre-action listener: _resource_record_pre_action 17:04:05 INFO - Running main action method: create_virtualenv 17:04:05 INFO - Creating virtualenv /builds/slave/test/build/venv 17:04:05 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 17:04:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:04:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:04:06 INFO - Using real prefix '/usr' 17:04:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:04:08 INFO - Installing distribute.............................................................................................................................................................................................done. 17:04:11 INFO - Installing pip.................done. 17:04:11 INFO - Return code: 0 17:04:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:04:11 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')]} 17:04:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 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')]} 17:04:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:11 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 0x7f1d169b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b13d0>, '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 0x181ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d360>, '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': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', '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 17:04:11 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 17:04:11 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 17:04:11 INFO - Using env: {'DISPLAY': ':0', 17:04:11 INFO - 'HOME': '/home/cltbld', 17:04:11 INFO - 'LANG': 'en_US.UTF-8', 17:04:11 INFO - 'LANGUAGE': 'en_US:en', 17:04:11 INFO - 'LOGNAME': 'cltbld', 17:04:11 INFO - 'MAIL': '/var/mail/cltbld', 17:04:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:11 INFO - 'MOZ_NO_REMOTE': '1', 17:04:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:11 INFO - 'NO_EM_RESTART': '1', 17:04:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:11 INFO - 'PWD': '/builds/slave/test', 17:04:11 INFO - 'SHELL': '/bin/bash', 17:04:11 INFO - 'SHLVL': '1', 17:04:11 INFO - 'TERM': 'linux', 17:04:11 INFO - 'TMOUT': '86400', 17:04:11 INFO - 'USER': 'cltbld', 17:04:11 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', 17:04:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:11 INFO - '_': '/tools/buildbot/bin/python'} 17:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:12 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 17:04:12 INFO - Cleaning up... 17:04:12 INFO - Return code: 0 17:04:12 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1d169b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b13d0>, '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 0x181ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d360>, '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': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', '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 17:04:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 17:04:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 17:04:12 INFO - Using env: {'DISPLAY': ':0', 17:04:12 INFO - 'HOME': '/home/cltbld', 17:04:12 INFO - 'LANG': 'en_US.UTF-8', 17:04:12 INFO - 'LANGUAGE': 'en_US:en', 17:04:12 INFO - 'LOGNAME': 'cltbld', 17:04:12 INFO - 'MAIL': '/var/mail/cltbld', 17:04:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:12 INFO - 'MOZ_NO_REMOTE': '1', 17:04:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:12 INFO - 'NO_EM_RESTART': '1', 17:04:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:12 INFO - 'PWD': '/builds/slave/test', 17:04:12 INFO - 'SHELL': '/bin/bash', 17:04:12 INFO - 'SHLVL': '1', 17:04:12 INFO - 'TERM': 'linux', 17:04:12 INFO - 'TMOUT': '86400', 17:04:12 INFO - 'USER': 'cltbld', 17:04:12 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', 17:04:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:12 INFO - '_': '/tools/buildbot/bin/python'} 17:04:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:12 INFO - Downloading/unpacking psutil>=0.7.1 17:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:14 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:04:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:04:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:04:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:14 INFO - Installing collected packages: psutil 17:04:14 INFO - Running setup.py install for psutil 17:04:14 INFO - building 'psutil._psutil_linux' extension 17:04:14 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 17:04:15 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 17:04:15 INFO - building 'psutil._psutil_posix' extension 17:04:15 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 17:04:15 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 17:04:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:04:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:04:15 INFO - Successfully installed psutil 17:04:15 INFO - Cleaning up... 17:04:15 INFO - Return code: 0 17:04:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:04:15 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')]} 17:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:15 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')]} 17:04:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:15 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 0x7f1d169b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b13d0>, '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 0x181ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d360>, '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': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', '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 17:04:15 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 17:04:15 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 17:04:15 INFO - Using env: {'DISPLAY': ':0', 17:04:15 INFO - 'HOME': '/home/cltbld', 17:04:15 INFO - 'LANG': 'en_US.UTF-8', 17:04:15 INFO - 'LANGUAGE': 'en_US:en', 17:04:15 INFO - 'LOGNAME': 'cltbld', 17:04:15 INFO - 'MAIL': '/var/mail/cltbld', 17:04:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:15 INFO - 'MOZ_NO_REMOTE': '1', 17:04:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:15 INFO - 'NO_EM_RESTART': '1', 17:04:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:15 INFO - 'PWD': '/builds/slave/test', 17:04:15 INFO - 'SHELL': '/bin/bash', 17:04:15 INFO - 'SHLVL': '1', 17:04:15 INFO - 'TERM': 'linux', 17:04:15 INFO - 'TMOUT': '86400', 17:04:15 INFO - 'USER': 'cltbld', 17:04:15 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', 17:04:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:15 INFO - '_': '/tools/buildbot/bin/python'} 17:04:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:04:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:04:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:04:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 17:04:17 INFO - Installing collected packages: mozsystemmonitor 17:04:17 INFO - Running setup.py install for mozsystemmonitor 17:04:17 INFO - Successfully installed mozsystemmonitor 17:04:17 INFO - Cleaning up... 17:04:17 INFO - Return code: 0 17:04:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1d169b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b13d0>, '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 0x181ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d360>, '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': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', '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 17:04:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:04:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:04:17 INFO - Using env: {'DISPLAY': ':0', 17:04:17 INFO - 'HOME': '/home/cltbld', 17:04:17 INFO - 'LANG': 'en_US.UTF-8', 17:04:17 INFO - 'LANGUAGE': 'en_US:en', 17:04:17 INFO - 'LOGNAME': 'cltbld', 17:04:17 INFO - 'MAIL': '/var/mail/cltbld', 17:04:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:17 INFO - 'MOZ_NO_REMOTE': '1', 17:04:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:17 INFO - 'NO_EM_RESTART': '1', 17:04:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:17 INFO - 'PWD': '/builds/slave/test', 17:04:17 INFO - 'SHELL': '/bin/bash', 17:04:17 INFO - 'SHLVL': '1', 17:04:17 INFO - 'TERM': 'linux', 17:04:17 INFO - 'TMOUT': '86400', 17:04:17 INFO - 'USER': 'cltbld', 17:04:17 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', 17:04:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:17 INFO - '_': '/tools/buildbot/bin/python'} 17:04:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:18 INFO - Downloading/unpacking blobuploader==1.2.4 17:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:19 INFO - Downloading blobuploader-1.2.4.tar.gz 17:04:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:04:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:04:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04: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 17:04:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:04:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:04:20 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 17:04:20 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 17:04:20 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 17:04:20 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 17:04:20 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 17:04:20 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 17:04:20 INFO - Downloading docopt-0.6.1.tar.gz 17:04:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:04:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:04:20 INFO - Installing collected packages: blobuploader, requests, docopt 17:04:20 INFO - Running setup.py install for blobuploader 17:04:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:04:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:04:20 INFO - Running setup.py install for requests 17:04:20 INFO - Running setup.py install for docopt 17:04:20 INFO - Successfully installed blobuploader requests docopt 17:04:20 INFO - Cleaning up... 17:04:21 INFO - Return code: 0 17:04:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:21 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 0x7f1d169b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b13d0>, '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 0x181ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d360>, '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': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', '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 17:04:21 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 17:04:21 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 17:04:21 INFO - Using env: {'DISPLAY': ':0', 17:04:21 INFO - 'HOME': '/home/cltbld', 17:04:21 INFO - 'LANG': 'en_US.UTF-8', 17:04:21 INFO - 'LANGUAGE': 'en_US:en', 17:04:21 INFO - 'LOGNAME': 'cltbld', 17:04:21 INFO - 'MAIL': '/var/mail/cltbld', 17:04:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:21 INFO - 'MOZ_NO_REMOTE': '1', 17:04:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:21 INFO - 'NO_EM_RESTART': '1', 17:04:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:21 INFO - 'PWD': '/builds/slave/test', 17:04:21 INFO - 'SHELL': '/bin/bash', 17:04:21 INFO - 'SHLVL': '1', 17:04:21 INFO - 'TERM': 'linux', 17:04:21 INFO - 'TMOUT': '86400', 17:04:21 INFO - 'USER': 'cltbld', 17:04:21 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', 17:04:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:21 INFO - '_': '/tools/buildbot/bin/python'} 17:04:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:21 INFO - Running setup.py (path:/tmp/pip-EM6wzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:21 INFO - Running setup.py (path:/tmp/pip-jvQ9zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:21 INFO - Running setup.py (path:/tmp/pip-ROerRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:21 INFO - Running setup.py (path:/tmp/pip-3pNaa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:21 INFO - Running setup.py (path:/tmp/pip-qZCBld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:21 INFO - Running setup.py (path:/tmp/pip-w43Iqz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:21 INFO - Running setup.py (path:/tmp/pip-dKaW9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:21 INFO - Running setup.py (path:/tmp/pip-XH6PBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:21 INFO - Running setup.py (path:/tmp/pip-fYuHrh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:21 INFO - Running setup.py (path:/tmp/pip-oQCvzr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:21 INFO - Running setup.py (path:/tmp/pip-pV9AiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:22 INFO - Running setup.py (path:/tmp/pip-2G3F1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:22 INFO - Running setup.py (path:/tmp/pip-W39rBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:22 INFO - Running setup.py (path:/tmp/pip-IyLFFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:22 INFO - Running setup.py (path:/tmp/pip-KadVU5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:22 INFO - Running setup.py (path:/tmp/pip-28hLxu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:22 INFO - Running setup.py (path:/tmp/pip-Qvxqqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:04:22 INFO - Running setup.py install for manifestparser 17:04:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:04:22 INFO - Running setup.py install for mozcrash 17:04:22 INFO - Running setup.py install for mozdebug 17:04:22 INFO - Running setup.py install for mozdevice 17:04:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:04:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:04:22 INFO - Running setup.py install for mozfile 17:04:22 INFO - Running setup.py install for mozhttpd 17:04:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Running setup.py install for mozinfo 17:04:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Running setup.py install for mozInstall 17:04:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Running setup.py install for mozleak 17:04:23 INFO - Running setup.py install for mozlog 17:04:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Running setup.py install for moznetwork 17:04:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Running setup.py install for mozprocess 17:04:23 INFO - Running setup.py install for mozprofile 17:04:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Running setup.py install for mozrunner 17:04:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:04:23 INFO - Running setup.py install for mozscreenshot 17:04:24 INFO - Running setup.py install for moztest 17:04:24 INFO - Running setup.py install for mozversion 17:04:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:04:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:04:24 INFO - Cleaning up... 17:04:24 INFO - Return code: 0 17:04:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:24 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 0x7f1d169b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b13d0>, '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 0x181ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d360>, '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': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', '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 17:04:24 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 17:04:24 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 17:04:24 INFO - Using env: {'DISPLAY': ':0', 17:04:24 INFO - 'HOME': '/home/cltbld', 17:04:24 INFO - 'LANG': 'en_US.UTF-8', 17:04:24 INFO - 'LANGUAGE': 'en_US:en', 17:04:24 INFO - 'LOGNAME': 'cltbld', 17:04:24 INFO - 'MAIL': '/var/mail/cltbld', 17:04:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:24 INFO - 'MOZ_NO_REMOTE': '1', 17:04:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:24 INFO - 'NO_EM_RESTART': '1', 17:04:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:24 INFO - 'PWD': '/builds/slave/test', 17:04:24 INFO - 'SHELL': '/bin/bash', 17:04:24 INFO - 'SHLVL': '1', 17:04:24 INFO - 'TERM': 'linux', 17:04:24 INFO - 'TMOUT': '86400', 17:04:24 INFO - 'USER': 'cltbld', 17:04:24 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', 17:04:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:24 INFO - '_': '/tools/buildbot/bin/python'} 17:04:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:04:24 INFO - Running setup.py (path:/tmp/pip-BlF24m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:04:24 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)) 17:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:04:24 INFO - Running setup.py (path:/tmp/pip-mvLmew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:04:24 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)) 17:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:04:24 INFO - Running setup.py (path:/tmp/pip-ETplb3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:04:24 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)) 17:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:04:24 INFO - Running setup.py (path:/tmp/pip-5iW28K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:04:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:04:24 INFO - Running setup.py (path:/tmp/pip-Umdf3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:04:24 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)) 17:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:04:24 INFO - Running setup.py (path:/tmp/pip-__LRzN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:04:24 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)) 17:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:04:24 INFO - Running setup.py (path:/tmp/pip-_OhlHz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:04:24 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)) 17:04:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:04:24 INFO - Running setup.py (path:/tmp/pip-p7up78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:04:25 INFO - Running setup.py (path:/tmp/pip-S8ue2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:04:25 INFO - Running setup.py (path:/tmp/pip-7Orsml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:04:25 INFO - Running setup.py (path:/tmp/pip-OyVwjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:04:25 INFO - Running setup.py (path:/tmp/pip-ZjhIGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:04:25 INFO - Running setup.py (path:/tmp/pip-PRubt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:04:25 INFO - Running setup.py (path:/tmp/pip-xngl0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:25 INFO - Running setup.py (path:/tmp/pip-hAEe8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:04:25 INFO - Running setup.py (path:/tmp/pip-Rp1vva-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:04:25 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)) 17:04:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:04:25 INFO - Running setup.py (path:/tmp/pip-om5NUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:04:25 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)) 17:04:25 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)) 17:04:25 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)) 17:04:25 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)) 17:04:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 17:04:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:25 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 17:04:27 INFO - Downloading blessings-1.5.1.tar.gz 17:04:27 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 17:04:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:04:27 INFO - Installing collected packages: blessings 17:04:27 INFO - Running setup.py install for blessings 17:04:27 INFO - Successfully installed blessings 17:04:27 INFO - Cleaning up... 17:04:27 INFO - Return code: 0 17:04:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:04:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:27 INFO - Reading from file tmpfile_stdout 17:04:27 INFO - Current package versions: 17:04:27 INFO - argparse == 1.2.1 17:04:27 INFO - blessings == 1.5.1 17:04:27 INFO - blobuploader == 1.2.4 17:04:27 INFO - docopt == 0.6.1 17:04:27 INFO - manifestparser == 1.1 17:04:27 INFO - mozInstall == 1.12 17:04:27 INFO - mozcrash == 0.16 17:04:27 INFO - mozdebug == 0.1 17:04:27 INFO - mozdevice == 0.47 17:04:27 INFO - mozfile == 1.2 17:04:27 INFO - mozhttpd == 0.7 17:04:27 INFO - mozinfo == 0.9 17:04:27 INFO - mozleak == 0.1 17:04:27 INFO - mozlog == 3.1 17:04:27 INFO - moznetwork == 0.27 17:04:27 INFO - mozprocess == 0.22 17:04:27 INFO - mozprofile == 0.28 17:04:27 INFO - mozrunner == 6.11 17:04:27 INFO - mozscreenshot == 0.1 17:04:27 INFO - mozsystemmonitor == 0.0 17:04:27 INFO - moztest == 0.7 17:04:27 INFO - mozversion == 1.4 17:04:27 INFO - psutil == 3.1.1 17:04:27 INFO - requests == 1.2.3 17:04:27 INFO - wsgiref == 0.1.2 17:04:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:04: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')]} 17:04:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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')]} 17:04:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04: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/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 0x7f1d169b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b13d0>, '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 0x181ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d360>, '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': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', '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 17:04: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/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 17:04: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/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 17:04:27 INFO - Using env: {'DISPLAY': ':0', 17:04:27 INFO - 'HOME': '/home/cltbld', 17:04:27 INFO - 'LANG': 'en_US.UTF-8', 17:04:27 INFO - 'LANGUAGE': 'en_US:en', 17:04:27 INFO - 'LOGNAME': 'cltbld', 17:04:27 INFO - 'MAIL': '/var/mail/cltbld', 17:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:27 INFO - 'MOZ_NO_REMOTE': '1', 17:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:27 INFO - 'NO_EM_RESTART': '1', 17:04:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:27 INFO - 'PWD': '/builds/slave/test', 17:04:27 INFO - 'SHELL': '/bin/bash', 17:04:27 INFO - 'SHLVL': '1', 17:04:27 INFO - 'TERM': 'linux', 17:04:27 INFO - 'TMOUT': '86400', 17:04:27 INFO - 'USER': 'cltbld', 17:04:27 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', 17:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:27 INFO - '_': '/tools/buildbot/bin/python'} 17:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:28 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)) 17:04:28 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)) 17:04:28 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)) 17:04:28 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)) 17:04:28 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)) 17:04:28 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)) 17:04:28 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)) 17:04:28 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)) 17:04:28 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)) 17:04:28 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)) 17:04:28 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)) 17:04:28 INFO - Cleaning up... 17:04:28 INFO - Return code: 0 17:04:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:04:28 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')]} 17:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:28 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')]} 17:04:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:28 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 0x7f1d169b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b13d0>, '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 0x181ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d360>, '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': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', '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 17:04:28 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 17:04:28 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 17:04:28 INFO - Using env: {'DISPLAY': ':0', 17:04:28 INFO - 'HOME': '/home/cltbld', 17:04:28 INFO - 'LANG': 'en_US.UTF-8', 17:04:28 INFO - 'LANGUAGE': 'en_US:en', 17:04:28 INFO - 'LOGNAME': 'cltbld', 17:04:28 INFO - 'MAIL': '/var/mail/cltbld', 17:04:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:28 INFO - 'MOZ_NO_REMOTE': '1', 17:04:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:28 INFO - 'NO_EM_RESTART': '1', 17:04:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:28 INFO - 'PWD': '/builds/slave/test', 17:04:28 INFO - 'SHELL': '/bin/bash', 17:04:28 INFO - 'SHLVL': '1', 17:04:28 INFO - 'TERM': 'linux', 17:04:28 INFO - 'TMOUT': '86400', 17:04:28 INFO - 'USER': 'cltbld', 17:04:28 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', 17:04:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:28 INFO - '_': '/tools/buildbot/bin/python'} 17:04:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:28 INFO - Downloading/unpacking jsonschema 17:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:04:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:04:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:04:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:04:30 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 17:04:30 INFO - Downloading/unpacking functools32 (from jsonschema) 17:04:30 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 17:04:30 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 17:04:30 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 17:04:30 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 17:04:30 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 17:04:30 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 17:04:30 INFO - Downloading functools32-3.2.3-2.tar.gz 17:04:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 17:04:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:04:30 INFO - warning: no files found matching '*.txt' 17:04:30 INFO - no previously-included directories found matching 'build' 17:04:30 INFO - no previously-included directories found matching 'dist' 17:04:30 INFO - no previously-included directories found matching '.git*' 17:04:30 INFO - Installing collected packages: jsonschema, functools32 17:04:30 INFO - Running setup.py install for functools32 17:04:30 INFO - warning: no files found matching '*.txt' 17:04:30 INFO - no previously-included directories found matching 'build' 17:04:30 INFO - no previously-included directories found matching 'dist' 17:04:30 INFO - no previously-included directories found matching '.git*' 17:04:30 INFO - Successfully installed jsonschema functools32 17:04:30 INFO - Cleaning up... 17:04:30 INFO - Return code: 0 17:04:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 17:04:30 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')]} 17:04:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:04:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:30 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')]} 17:04:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:04:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:04:30 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 0x7f1d169b6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x174f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x181edd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18b13d0>, '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 0x181ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d360>, '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': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', '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 17:04:30 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 17:04:30 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 17:04:30 INFO - Using env: {'DISPLAY': ':0', 17:04:30 INFO - 'HOME': '/home/cltbld', 17:04:30 INFO - 'LANG': 'en_US.UTF-8', 17:04:30 INFO - 'LANGUAGE': 'en_US:en', 17:04:30 INFO - 'LOGNAME': 'cltbld', 17:04:30 INFO - 'MAIL': '/var/mail/cltbld', 17:04:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:30 INFO - 'MOZ_NO_REMOTE': '1', 17:04:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:30 INFO - 'NO_EM_RESTART': '1', 17:04:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:30 INFO - 'PWD': '/builds/slave/test', 17:04:30 INFO - 'SHELL': '/bin/bash', 17:04:30 INFO - 'SHLVL': '1', 17:04:30 INFO - 'TERM': 'linux', 17:04:30 INFO - 'TMOUT': '86400', 17:04:30 INFO - 'USER': 'cltbld', 17:04:30 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', 17:04:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:30 INFO - '_': '/tools/buildbot/bin/python'} 17:04:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:04:30 INFO - Downloading/unpacking flake8 17:04:30 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 17:04:30 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 17:04:30 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 17:04:30 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 17:04:30 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 17:04:30 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 17:04:32 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 17:04:32 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 17:04:32 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 17:04:32 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 17:04:32 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 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 17:04:32 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 17:04:33 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 17:04:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 17:04:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:33 INFO - no previously-included directories found matching 'docs/_build' 17:04:33 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 17:04:33 INFO - Running setup.py install for pep8 17:04:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 17:04:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 17:04:33 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 17:04:33 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 17:04:33 INFO - no previously-included directories found matching 'docs/_build' 17:04:33 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 17:04:33 INFO - Successfully installed flake8 mccabe pyflakes pep8 17:04:33 INFO - Cleaning up... 17:04:33 INFO - Return code: 0 17:04:33 INFO - Running post-action listener: _resource_record_post_action 17:04:33 INFO - Running post-action listener: _start_resource_monitoring 17:04:33 INFO - Starting resource monitoring. 17:04:33 INFO - ##### 17:04:33 INFO - ##### Running install step. 17:04:33 INFO - ##### 17:04:33 INFO - Running pre-action listener: _resource_record_pre_action 17:04:33 INFO - Running main action method: install 17:04:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:04:33 INFO - Reading from file tmpfile_stdout 17:04:33 INFO - Detecting whether we're running mozinstall >=1.0... 17:04:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:04:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:04:33 INFO - Reading from file tmpfile_stdout 17:04:33 INFO - Output received: 17:04:33 INFO - Usage: mozinstall [options] installer 17:04:33 INFO - Options: 17:04:33 INFO - -h, --help show this help message and exit 17:04:33 INFO - -d DEST, --destination=DEST 17:04:33 INFO - Directory to install application into. [default: 17:04:33 INFO - "/builds/slave/test"] 17:04:33 INFO - --app=APP Application being installed. [default: firefox] 17:04:33 INFO - mkdir: /builds/slave/test/build/application 17:04:33 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'] 17:04:33 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 17:04:49 INFO - Reading from file tmpfile_stdout 17:04:49 INFO - Output received: 17:04:49 INFO - /builds/slave/test/build/application/firefox/firefox 17:04:49 INFO - Running post-action listener: _resource_record_post_action 17:04:49 INFO - ##### 17:04:49 INFO - ##### Running run-tests step. 17:04:49 INFO - ##### 17:04:49 INFO - Running pre-action listener: _resource_record_pre_action 17:04:49 INFO - Running main action method: run_tests 17:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:04:49 INFO - Python 2.7.3 17:04:49 INFO - Return code: 0 17:04:49 INFO - grabbing minidump binary from tooltool 17:04:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:04:49 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 0x18b13d0>, '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 0x181ced0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x181d360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:04:49 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 17:04:49 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 17:04:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:04:49 INFO - Return code: 0 17:04:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:04:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:04:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:04:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:04:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:04:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 17:04:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 17:04:50 INFO - Return code: 0 17:04:50 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 17:04:50 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-026 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 17:04:50 INFO - Using env: {'DISPLAY': ':0', 17:04:50 INFO - 'HOME': '/home/cltbld', 17:04:50 INFO - 'LANG': 'en_US.UTF-8', 17:04:50 INFO - 'LANGUAGE': 'en_US:en', 17:04:50 INFO - 'LOGNAME': 'cltbld', 17:04:50 INFO - 'MAIL': '/var/mail/cltbld', 17:04:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:04:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:04:50 INFO - 'MOZ_NO_REMOTE': '1', 17:04:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:04:50 INFO - 'NO_EM_RESTART': '1', 17:04:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:04:50 INFO - 'PWD': '/builds/slave/test', 17:04:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:04:50 INFO - 'SHELL': '/bin/bash', 17:04:50 INFO - 'SHLVL': '1', 17:04:50 INFO - 'TERM': 'linux', 17:04:50 INFO - 'TMOUT': '86400', 17:04:50 INFO - 'USER': 'cltbld', 17:04:50 INFO - 'XDG_SESSION_COOKIE': '41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556', 17:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:04:50 INFO - '_': '/tools/buildbot/bin/python'} 17:04:50 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-026', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 17:04:50 INFO - mozversion application_buildid: 20160110153932 17:04:50 INFO - mozversion application_changeset: acc35c2f2e1f9d62ea4dd5790678b08225bb1f9d 17:04:50 INFO - mozversion application_display_name: Nightly 17:04:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:04:50 INFO - mozversion application_name: Firefox 17:04:50 INFO - mozversion application_remotingname: firefox 17:04:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:04:50 INFO - mozversion application_vendor: Mozilla 17:04:50 INFO - mozversion application_version: 46.0a1 17:04:50 INFO - mozversion platform_buildid: 20160110153932 17:04:50 INFO - mozversion platform_changeset: acc35c2f2e1f9d62ea4dd5790678b08225bb1f9d 17:04:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:04:50 INFO - mozversion platform_version: 46.0a1 17:04:50 INFO - using testdate: 1452474290 17:04:50 INFO - actual date: 1452474290 17:04:50 INFO - starting webserver on 'localhost:57181' 17:04:50 INFO - SUITE-START | Running 3 tests 17:04:50 INFO - TEST-START | dromaeo_css 17:04:50 INFO - operating with platform_type : linux_ 17:04:50 INFO - Initialising browser for dromaeo_css test... 17:04:50 INFO - TEST-INFO | started process 3319 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqXT7kC/profile http://localhost:57181/getInfo.html) 17:04:57 INFO - PROCESS | 3319 | 17:04:57 INFO - PROCESS | 3319 | (process:3407): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:04:57 INFO - PROCESS | 3319 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 17:04:58 INFO - PROCESS | 3319 | __metrics Screen width/height:1600/1200 17:04:58 INFO - PROCESS | 3319 | colorDepth:24 17:04:58 INFO - PROCESS | 3319 | Browser inner width/height: 1024/697 17:04:58 INFO - PROCESS | 3319 | __metrics 17:04:58 INFO - PROCESS | 3319 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:04:59 INFO - TEST-INFO | 3319: exit 0 17:04:59 INFO - Browser initialized. 17:04:59 INFO - Running cycle 1/1 for dromaeo_css test... 17:04:59 INFO - TEST-INFO | started process 3456 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqXT7kC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:05:01 INFO - PROCESS | 3456 | 17:05:01 INFO - PROCESS | 3456 | (process:3514): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:05:11 INFO - PROCESS | 3456 | RSS: Main: 150306816 17:05:11 INFO - PROCESS | 3456 | 17:06:01 INFO - PROCESS | 3456 | 1452474361207 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] 17:08:12 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:57181/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57181/tests/dromaeo/cssquery-ext.html) 17:08:14 INFO - PROCESS | 3456 | RSS: Main: 154304512 17:08:14 INFO - PROCESS | 3456 | 17:11:16 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:57181/tests/dromaeo/cssquery-ext.html (next: http://localhost:57181/tests/dromaeo/cssquery-jquery.html) 17:11:16 INFO - PROCESS | 3456 | RSS: Main: 152690688 17:11:16 INFO - PROCESS | 3456 | 17:14:18 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:57181/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57181/tests/dromaeo/cssquery-mootools.html) 17:14:19 INFO - PROCESS | 3456 | RSS: Main: 153100288 17:14:19 INFO - PROCESS | 3456 | 17:17:21 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:57181/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57181/tests/dromaeo/cssquery-prototype.html) 17:17:21 INFO - PROCESS | 3456 | RSS: Main: 152469504 17:17:21 INFO - PROCESS | 3456 | 17:20:24 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:57181/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57181/tests/dromaeo/cssquery-yui.html) 17:20:25 INFO - PROCESS | 3456 | RSS: Main: 153366528 17:20:25 INFO - PROCESS | 3456 | 17:23:27 INFO - PROCESS | 3456 | Cycle 1(1): loaded http://localhost:57181/tests/dromaeo/cssquery-yui.html (next: http://localhost:57181/tests/dromaeo/cssquery-dojo.html) 17:23:27 INFO - PROCESS | 3456 | RSS: Main: 155414528 17:23:27 INFO - PROCESS | 3456 | 17:23:27 INFO - PROCESS | 3456 | __start_tp_report 17:23:27 INFO - PROCESS | 3456 | _x_x_mozilla_page_load 17:23:27 INFO - PROCESS | 3456 | _x_x_mozilla_page_load_details 17:23:27 INFO - PROCESS | 3456 | |i|pagename|runs| 17:23:27 INFO - PROCESS | 3456 | |0;dojo.html;2591.92224233273;2647.4969755746397;2676.4245687177267;2681.9865900670507;2695.9191224263272;4333.414988976488;4527.071950250199;4612.930806037908;4619.260918253076;4657.813687452502;4432.335149727543;4461.977690111545;4576.427946506687;4638.814447422107;4646.907061858761;4234.618884300412;4274.123804620045;4324.437823082995;4330.06903515744;4348.239058164809;4226.323788193889;4233.301505251629;4305.806238719265;4311.82752689892;4327.848525301615;4088.2028004539125;4160.83356665733;4203.55862634422;4225.598568136023;4230.196262710076;4248.022954720401;4250.3836943643;4257.97871010646;4261.339492378686;4301.354796780477;4193.811278492475;4213.91572168558;4222.387753775716;4225.429567008446;4235.703500754948;4290.914181716379;4375.737455752633;4476.418065651477;4507.706999045052;4590.334401511762;4878.463369029404;4910.852674419773;4918.360613120307;4931.852044438672;4977.328060711794;4923.990581930696;4935.2843837643695;4951.653384263103;4954.851354459372;4993.750312484398;4386.583274588909;4489.393931819162;4517.796699148546;4591.977040114778;4624.237000894882;5003.699778013331;5019.121653710586;5035.118854200574;5043.773030213649;5083.61872859537;4542.318652202196;4744.430668319824;4795.256735206049;4809.591184749265;4812.903741925142;4816.807327706852;4853.12643724126;4876.609871210295;4880.511948805091;4883.487233840467;4840.467548569654;4927.975360123177;4939.185034469272;4947.307376967227;4956.231784073474;4872.3909511311085;4879.292502587176;4886.364772579542;4902.362692849907;4950.77721502526;3994.400839874042;4087.5094988600963;4087.6116768906904;4176.310908700091;4217.135487225111;3647.3799454092336;3647.85408583659;3682.5396825396824;3695.722820788452;3707.1102935295335;4234.047339348622;4234.978825105916;4280.871573852789;4284.378765079046;4337.175936572041;4713.2458806590785;4790.808367665324;4791.6406269529925;4870.391201099863;4931.506849315111;4221.91556168881;4247.830086796494;4259.5527469615245;4259.9787001065415;4294.463192100988;4404.691671583022;4405.405270288534;4425.070735145656;4431.645468362523;4454.554544545585;4463.598276155161;4553.430821147423;4633.629309655152;4707.364505791675;4733.597644200281;4897.289892965428;4899.314096026488;4934.851954441372;4973.055119527278;4982.900341993212;4481.865544033684;4671.089137618132;4674.485806561208;4692.038132182963;4723.14983302995;4744.976275118603;4795.736234506996;4868.269759536098;4873.439554451142;4900.8774780630765;4893.266010098514;4914.975425122851;4927.088488629472;4980.750962451935;5000.548305735296;4559.589636932692;4656.650751193606;4735.408073990751;4749.715017098985;4814.8796280093275;4620.168369693488;4705.458872229738;4730;4743.573078422821;4785.090832741768;4596.4714057883775;4621.260598304255;4630.652701047502;4639.976800116113;4648.953510464852;4554.043650833362;4654.86035418938;4754.21555443348;4760.881192919592;4798.784054717616;4565.6119229865835;4620.676552641283;4625.514320996247;4647.9767601161775;4691.460482044608 17:23:27 INFO - PROCESS | 3456 | |1;ext.html;468.26482422596536;475.2965610895874;495.45994865596504;495.7595566150417;505.19421522671325;31631.209219769487;32432;32456.350872982526;32500.349993000127;32507.83746081266;35230.11924701884;36226.63773362266;36338.45492317617;36407;36431.63568364316;7550.5847178405165;7683.884741728879;7754.991851059354;7756.495827771205;7763.767086987399;7570.583617901013;7590.203028681992;7609.619519024027;7614.162442131389;7615.961920190419;7767.883481747778;7864.213578642147;7916.208379162066;7954;7976;7814.1013783415065;7887.171846956073;7899.565523896184;7899.763007109796;7912.683492660287;7638.5798781067015;7832.608369581498;7835.138134805167;7854.175311592315;7871.21287871214;36099.819500902326;36434;36478;36481;36495.63504364949;2990;3012.894548690785;3022.6826183250882;3055.434744572239;3060.32672811981;27766.861165694245;27974.160775176777;28124;28353.574696379572;28548.857255713796;3205.4550726376574;3241.0439614964866;3277.9344413111844;3292.1769557610596;3293.324868401996;210595;211079;211487;211989;212776;47171.29243061357;54068.45931540634;54314.45685543094;54742.72628636911;54919.97940113332;41524.37713434301;57855.55361116006;59346.703266484255;59399;59486.70256648689;12613.684657883443;12897.548585799452;12905.451345838559;12908.35458227085;12951.481940722453;9353.158215760614;9364.719058428258;9384.95307523458;9488.335816492918;9500.287478439006;17431.912840435718;17622.207000685;17688.9115554424;17800.109994500224;18559.164837582342;7024.489734707063;7152.17749958751;7177.856442871113;7230.2046774854725;7288.708451661874;806.766037849029;831.1190138453138;838.890944177253;873.6854732296368;966.1401352796017;25056.624150637756;25088.37279068038;25454.236372908843;25870.353241169123;25975.350616234744;948.9775066413357;960.5533426956499;976.6776963601994;991.509202944547;1037.4864442101057;13304.935605151564;13311.33443327849;13636.65908352299;13645.38595763193;13653.04428690002;246058;251652;252099;252233;254795;44457;45113.548864510936;45258.77370613126;45359.31961020587;45433.54566454293;1181.2735167871697;1218.2873019283818;1218.8963938065365;1229.0843321725372;1230.7784598772128;24716.50566988686;24967.50064998726;25098.247052588453;25163.622545661463;25165;40233.79883100566;40434.59565404426;40618.79690601528;40877;41008.79495602503;232865;236553;237871;238096;239188;28489.581250250103;28508;28597.28506787347;29127.85436072806;29759;35251.589936402255;35473.467897981034;36189.63810361863;36484.63515364812;36642.8167859159;29974.70025299719;31326.420522656183;31439.84280078585;31805.522917156723;31876.04371868755;30209.244768880955;31046.534301985037;31259.374812504077;31543.684563154075;31803.522947156274;31216.687833121377;31902.68097318997;32895.67104328926;33696.326073478886;33702.66297336995;23286;24598.508029838944;26122.477550448504;26993.865030674722;29552.408951820413;21095.57808843845;21362.359129226148;21385.78614213838;21608.567828643652;21764.12943482243 17:23:27 INFO - PROCESS | 3456 | |2;jquery.html;334.8426239667356;335.6861334652102;337;338.9322135572883;340.4399762390867;14324.928375358135;14722.926385368059;14748.041377310481;14924.328405221764;15280.923595382008;9863.802723945535;10102.343347682396;12432.067594930393;15181.392744290215;15216.239188040608;4519.79660915258;4553.567411095941;4705.600023997964;4720.268358404453;4732.858014259577;4634.258518637019;4775.164346239411;4779.378680771495;4782.187028205213;4782.7608619569055;4573;4763.642726795504;4925.655204135712;5159.793608255665;5160.612954028444;5023.7236951967625;5040.991801639669;5071.087204303224;5129.512696293846;5328.17413300939;5133.127368347353;5133.12736834739;5134.204198349262;5137.614678899097;5154.793808247666;11252.268602540891;15942.840571594252;16607.91696041524;16728.330866765315;16800.243989020524;1781.340903865565;1835.5135888989428;1836.091134888239;1839.7056470964715;1848.2052717331542;8954.283657307466;8976.8653470198;11023;11144.219904606682;11560.421978901022;1824.6989246774267;1901.4675890750611;1918.7505624268756;2004.1081718635214;2052.404802607242;40940.1811963762;42442.36336454956;42994;43025.35461968073;43534.564654353686;9128.497932613636;9325.393849399767;9359.532023398939;9384.390014649027;9435.528223588793;11700.414979251003;11794.46924888365;11819.172657913863;11847.88152118485;11882.584109556125;6428.550001499943;6661.700223489955;6688.4649228061635;6751.932480675228;6828.2488926218075;6280.591761535486;6330.272018717815;6382.6170429774365;6401.807945761635;6473.417392434703;4067.877963661095;4133.793310334471;4143.233501802176;4158;4175.039740859558;1608.951731448035;1679.8404151605578;1713.7686412334424;1766.6555021770632;1774.9911250443924;843.0810416645763;867.7657032601288;873.6243415331469;898.4025622960788;973.8253540621314;13845.792313115311;13983.440662373594;14742.262886855615;15121.395144194328;15246.23768811555;865.5196366016795;880.0935036911991;907.3331101640289;917.2707697380598;917.8990311065777;8684.696035638848;8840.24857887074;8849.4247873888;8857;8959.148880856308;409172;412098;412787;416047;418841;58427;60015.399846001856;62481.68759156175;62509.12253691478;63852.36147638464;970.1414248390225;982.6118683120128;985.9802803944025;990.5393991793707;991.0981007283337;12864.485420583072;13547.458101676217;13648.727025459633;13742.862571374159;13803.861961380659;27898.860505697343;28365.71634283631;28848.42303153883;29145.397003165028;29259;36612.26775464529;37002.62997369992;37115.6288437123;37221.441678375384;39262.4110638335;6510.47916166715;6696.799096027127;6714.597124172566;6913.516053876381;7074.540154889915;8824.294056475339;9522.809543808946;10068.798624027624;10268.332558383681;10273.486325683836;8066.274035336848;8252.587370631565;8428.789280268042;8540.701075462577;8594.742157735278;8521.573921304034;8544.658213671384;8977.730668079706;8991.235744961752;9044.41211321262;8563.186497282748;8867.290616750774;8911.108889111038;8924.330675199515;9152.496612686366;6753.5610185339765;6806.18325800907;6914.965425172842;6918.377346038881;7000.579965202104;8129.309008734087;8152.633131509215;8170.142135075732;8278.71024514139;8373.874391884005 17:23:27 INFO - PROCESS | 3456 | |3;mootools.html;1419.1910610951757;1424.8361438434576;1571.3086242053496;1705.795304563451;1755.1662960093956;6114.908276375858;6247.0317100849325;7264.200937896834;7446;7467.663955122012;6834.974753786934;6973.546719463231;7017.859642807153;7055.506114571969;7060.940858871159;2105.652567326389;2122.628540005493;2132.3070002249256;2133.4986278224683;2137.561799831031;2087.9582408351826;2093.0581238442687;2108.7891210878943;2110.2086717480943;2114.5876554071883;2042.5914817036578;2049.467138543974;2058.6294466995937;2068.338131797825;2112.2818241797786;2115.397111823123;2118.66101423773;2119.1099738109956;2120.9151633934625;2121.448423409909;2060.124447109972;2106.315447479575;2106.631339515594;2107.873527588334;2112.1656945506593;7635.618219089023;7655.617219139021;7655.693772249103;7659.234076592352;7694.807629809299;4248.575142485726;4348.065165989327;4353.891152721176;4358.302671572533;4365.083332500179;2811.9156425307274;2847.2597124747713;2938.500454922647;2940.3531223130876;2945.9263518412213;946.9621215151386;986.1075726467486;994.3387647214594;997.7810540737756;1013.5388398278766;10505.737356566071;10533.525991330409;10554.947225263824;10561.894381056169;10574.312669676523;4024.436578878959;4047.959520404758;4070.1249231414795;4074.5110586729784;4099.098198396348;8872.624743164819;8915.955420222987;8964.058773828785;8971;8980.101989800967;4247.702660813775;4251.723637963522;4276.102018576134;4281.507626622916;4289.206496798102;3281.2945216778508;3389.796612203276;3811.6760075393904;3845.6731177850197;3881.7476864003747;3389.881354152642;3430.8456119474686;3447.6897079262485;3455.2398472336045;3469.3755124077907;1067.7597540553313;1087.842262871895;1092.9672109836717;1100.2958106811648;1102.2780079048237;938.3619138985418;943.2783920300975;945.9195968342768;993.4883534979491;1233.5374234662002;6918.962155676689;6921.688524016431;6932.688029038705;6945.340192681788;7144.24985376528;445.03427562190126;446.0677184684026;447.1459512331496;449.51227917708997;461.0732427820106;5524.66851988882;5530.474604912527;5600.047991841397;5616.073347897633;5625.859353516113;9103.317251206186;9322.440653560809;9410.058994100673;9410.670626528039;9435.386699864486;9226.90773092274;9243.352965292364;9257.398269112486;9262.490563019099;9315.068493150766;6734.966325168441;6918.515703900679;6928.826779330557;6942.062821519131;7025.5784652919965;6734.898976515454;6739.5619284746335;6770.2891196425635;6772.729090836311;6838.794836154923;7856.921430785847;8019.719309824128;8033.839323213386;8041.276285134132;8045.678172873019;8116.147804480444;8173.632186551738;8232.876506852523;8241.79395515117;8285.751427457186;6045.576809623284;6165.815025549241;6170.228721409824;6492.28584855656;6704.061431399706;6423.132877061536;6461.966085426309;6489.675516224264;6494.383033611799;6517.055027020961;6072.240969878765;6194.101855231056;6206.038064100072;6248.468880145057;6298.11826344303;5928.614640048383;6078.787242446493;6084.39156084388;6147.047207682816;6152;6039.124326972652;6091.664958427329;6130.049842274455;6139.9079013813935;6140.969295153495;5828.912566311594;5861.706914654165;5872.119182122716;5872.706364681834;5880.617759845596;5999.670018149044;6032.577719559764;6034.758609655564;6048.455638992512;6059.303180134341 17:23:27 INFO - PROCESS | 3456 | |4;prototype.html;304.33047295948916;316.6342873980553;320.16596765426067;321.17458132599216;321.4936475051794;5393.352797664281;5525.254090697755;5632.26780518532;5643.2099506069135;5711.086226203808;5536.335639723229;5551.195076713874;5584.86037849053;5594.524465420434;5599.692016939067;4141.295979683461;4267.658587313008;4276.315789473685;4277.272863613193;4283.20760659279;4257.723247988886;4263.850765223217;4267.1252393259465;4268.701190916637;4278.529361770203;4198.6011328923705;4236.216299984498;4244.957550424502;4256.638185754199;4258.44640196774;4242.300020496615;4251.4260574822465;4260.020195355086;4271.743695378287;4273.18809426208;3630.6006339302658;3724.2365315110337;3730.123420996064;3736.346139425617;3739.9065023374633;5214.45248248936;5309.575233981311;5322.2548843161985;5326.733663316857;5355.491228333302;4811.374521312207;4819.397575303087;4819.614430845559;4831.22700367943;4833.589144922651;5817.331006934214;5817.970910145422;5823.621464604787;5843.620164689281;5856;3889.649931506178;3968.206358728237;3968.761874287552;3999.8200080996135;4021.577734337882;6038.1848450459065;6079.513638908877;6107.26712794463;6109.908351374733;6137.4476297133915;4108.548059713429;4111.465509483748;4112.527059388209;4115.1975364803575;4119.752814831119;4172.916541669149;4173.582641735863;4174.436451079066;4182.665386769051;4185.330347144442;4473.108100112429;4697.201475749131;4815.3499277597775;4816.8795780105775;4835.782389792468;5640.887182256414;5778.046622307356;5840.094785308284;5841.41585841421;5842.737076831468;1474.6018574984694;1498.5504348695347;1499.65507933176;1499.6925630245773;1500.647347873249;983.3165949665057;998.7752755629925;998.9950050249702;1009.4246279620693;1016.893226211252;5019.52314530119;5062.493750624908;5089.083964886282;5092.0579692756955;5094.7962081516325;6042.516598672096;6043.848903777441;6048.848778780478;6054.39456054391;6079.848003799941;5051.646384753032;5059.494050594984;5060.063888180698;5063;5080.491950804964;3212.823294718813;3253.560769296162;3260.722838558749;3286.7370610351113;3301.4882693182594;5669.31968163823;5685.516731077904;5686.2039314496005;5693.629914055573;5712.657240565496;6141.355157708465;6162.784302549389;6180.536459765535;6202.728440669652;6205.81382558524;5549.500544950974;5653.717314134276;5677.489025987681;5686.459786320293;5691.459311365331;6007.12896629995;6045.21412216409;6045.516358691382;6048.395160483917;6052.66710330936;5896;5912.793052243151;5915.053591425351;5923.052311630118;5926.881462370815;5652.236948011966;5679.943200567942;5680.261565996394;5703.429657034263;5716.085426331767;4003.839846406111;4085.264652362603;4096.09885825118;4098.713090083785;4104.52797928242;5909.143174239625;6025.156478092983;6029.366916473882;6034.698265086816;6112.358202388685;5821.388754180919;5847.327557330961;5848.064309710426;5861.853453663522;5870.26621672291;5859.5019423349495;5870.647761134345;5871.412858714265;5874.118882167709;5879.764809407747;5593.804216852391;5718.056520674042;5718.228039214653;5733.082706766897;5734.283214598176;5848.883022339614;5898.882022359615;5900.557458190567;5900.937831190427;5905.291365036223;5756;5757.280339957505;5757.395473475225;5759.769609215585;5760.567957403296 17:23:27 INFO - PROCESS | 3456 | |5;yui.html;690.6167077272115;722.1442590530222;741.3031750154855;769;773.4392565390096;10717.732056698576;10894.564217431292;10899.782004359928;10909.18181136415;10910.781784364317;10433.113185379232;10541.578336866516;10560.577576896934;10572.471376431167;10585.994330538606;746.0972223609439;757.5530437042144;758.9506682065648;759.4190444310079;760.281533950417;607.565590602719;616.374380004296;766.3103207113587;787.6101329841707;789.2147313423152;812.2608426332039;818.4598165210962;820.4789958376414;822.0710597025353;823.5058964621239;811.6225954930956;814.4339683919678;817.1256755271861;817.9836403271961;820.3601191071004;600.5945986459122;600.942910423509;607.5716619783042;610.8961476548998;611.2390074357409;10706.678799635945;10714.46427678613;10732.248742588023;10758.515866785936;10826.945865270702;11585.131115166312;11592.884071159266;11851.940740296242;12055.33695646739;12164.756704865942;9451;9451.763705907339;9459.858102128474;9486.9525652372;9557.808843823084;3127.2807254331406;3251.1872031992;3269.558609587699;3293.357795229931;3353.7987720736833;36840.81579592112;37040.25919481595;37132;37135.628643713484;37222.255554888754;8990;9303.162715355651;9327.720168394959;9427.90572094284;9568.09103135201;16314.510564683078;16375.590610234602;16408.26162822676;16438.342466301216;16460.506184814476;6479.870402591921;6498.350164983463;6586.934130658728;6693.866122677519;6765.221999470124;3728.5771223595384;3739.5886452490204;3749.4563288323584;3758.041699366644;3783.848646054182;2611.4515951649987;2631.1711810779543;2633.8814753336146;2637.1956553251443;2641.088824355594;472.832144588673;488.5480930139607;491.2116053733777;511.744127936032;512.50799232737;570.5521165884761;572.3589579670712;604.7671646416161;618.3551752338757;659.3406593406594;7739.496932699357;8430.704925327584;8488.108748581433;8787.824243515222;8934.463932164092;474.309879125871;515.9509846564571;521.8956208758264;607.6414915199965;627.1502114634695;3485.860565577399;3682.4844521766972;3771.8114094295724;3773.9433908491396;3826.253880493333;45036;45437;45569.54430455653;45576;47550;41571;41942;42033.159336813704;42148.789256053526;43117;37642.058948527054;37988;38725.41911871268;38935;39143.217135657695;7482.176960534446;7516.661750221362;7556.319931206218;7558.206388329147;7558.58427786477;29532.704672952994;29681;29782.255443613216;29836.85081574665;30455;35873.28253434865;36050.4592431119;36052.639473604926;36525.81737091298;37147;9516.762080948032;9552.092551207625;9682.46746428925;9763.316567840184;9984.850227246452;10933.83599246028;10966.890331096587;11058.944705276423;11120.2181720637;11291.491882865126;10207.081362677394;10329.380237185793;10336;10354.792904141725;10367.792644147226;10022.098011179029;10078.445685487368;10143.137833284254;10161.288709790244;10173.949130254301;10328.431936243578;10401.427921464392;10418.426986515815;10434.37393756377;10531.78936421252;8500.36247281444;8793.956030220064;8862.42394244372;8930.330225233003;9051.773705657411;9136.771580710536;9270.53647317618;9277.621102352874;9278.304127190353;9463.195628371666 17:23:27 INFO - PROCESS | 3456 | __end_tp_report 17:23:27 INFO - PROCESS | 3456 | __start_cc_report 17:23:27 INFO - PROCESS | 3456 | _x_x_mozilla_cycle_collect,332 17:23:27 INFO - PROCESS | 3456 | __end_cc_report 17:23:27 INFO - PROCESS | 3456 | __startTimestamp1452475407637__endTimestamp 17:23:27 INFO - PROCESS | 3456 | 17:23:27 INFO - PROCESS | 3456 | ------- Summary: start ------- 17:23:27 INFO - PROCESS | 3456 | Number of tests: 6 17:23:27 INFO - PROCESS | 3456 | 17:23:27 INFO - PROCESS | 3456 | [#0] dojo.html Cycles:165 Average:4522.53 Median:4624.24 stddev:454.42 (9.8%) stddev-sans-first:429.83 17:23:27 INFO - PROCESS | 3456 | Values: 2591.9 2647.5 2676.4 2682.0 2695.9 4333.4 4527.1 4612.9 4619.3 4657.8 4432.3 4462.0 4576.4 4638.8 4646.9 4234.6 4274.1 4324.4 4330.1 4348.2 4226.3 4233.3 4305.8 4311.8 4327.8 4088.2 4160.8 4203.6 4225.6 4230.2 4248.0 4250.4 4258.0 4261.3 4301.4 4193.8 4213.9 4222.4 4225.4 4235.7 4290.9 4375.7 4476.4 4507.7 4590.3 4878.5 4910.9 4918.4 4931.9 4977.3 4924.0 4935.3 4951.7 4954.9 4993.8 4386.6 4489.4 4517.8 4592.0 4624.2 5003.7 5019.1 5035.1 5043.8 5083.6 4542.3 4744.4 4795.3 4809.6 4812.9 4816.8 4853.1 4876.6 4880.5 4883.5 4840.5 4928.0 4939.2 4947.3 4956.2 4872.4 4879.3 4886.4 4902.4 4950.8 3994.4 4087.5 4087.6 4176.3 4217.1 3647.4 3647.9 3682.5 3695.7 3707.1 4234.0 4235.0 4280.9 4284.4 4337.2 4713.2 4790.8 4791.6 4870.4 4931.5 4221.9 4247.8 4259.6 4260.0 4294.5 4404.7 4405.4 4425.1 4431.6 4454.6 4463.6 4553.4 4633.6 4707.4 4733.6 4897.3 4899.3 4934.9 4973.1 4982.9 4481.9 4671.1 4674.5 4692.0 4723.1 4745.0 4795.7 4868.3 4873.4 4900.9 4893.3 4915.0 4927.1 4980.8 5000.5 4559.6 4656.7 4735.4 4749.7 4814.9 4620.2 4705.5 4730.0 4743.6 4785.1 4596.5 4621.3 4630.7 4640.0 4649.0 4554.0 4654.9 4754.2 4760.9 4798.8 4565.6 4620.7 4625.5 4648.0 4691.5 17:23:27 INFO - PROCESS | 3456 | 17:23:27 INFO - PROCESS | 3456 | [#1] ext.html Cycles:180 Average:38744.20 Median:18086.80 stddev:60921.87 (336.8%) stddev-sans-first:61024.98 17:23:27 INFO - PROCESS | 3456 | Values: 468.3 475.3 495.5 495.8 505.2 31631.2 32432.0 32456.4 32500.3 32507.8 35230.1 36226.6 36338.5 36407.0 36431.6 7550.6 7683.9 7755.0 7756.5 7763.8 7570.6 7590.2 7609.6 7614.2 7616.0 7767.9 7864.2 7916.2 7954.0 7976.0 7814.1 7887.2 7899.6 7899.8 7912.7 7638.6 7832.6 7835.1 7854.2 7871.2 36099.8 36434.0 36478.0 36481.0 36495.6 2990.0 3012.9 3022.7 3055.4 3060.3 27766.9 27974.2 28124.0 28353.6 28548.9 3205.5 3241.0 3277.9 3292.2 3293.3 210595.0 211079.0 211487.0 211989.0 212776.0 47171.3 54068.5 54314.5 54742.7 54920.0 41524.4 57855.6 59346.7 59399.0 59486.7 12613.7 12897.5 12905.5 12908.4 12951.5 9353.2 9364.7 9385.0 9488.3 9500.3 17431.9 17622.2 17688.9 17800.1 18559.2 7024.5 7152.2 7177.9 7230.2 7288.7 806.8 831.1 838.9 873.7 966.1 25056.6 25088.4 25454.2 25870.4 25975.4 949.0 960.6 976.7 991.5 1037.5 13304.9 13311.3 13636.7 13645.4 13653.0 246058.0 251652.0 252099.0 252233.0 254795.0 44457.0 45113.5 45258.8 45359.3 45433.5 1181.3 1218.3 1218.9 1229.1 1230.8 24716.5 24967.5 25098.2 25163.6 25165.0 40233.8 40434.6 40618.8 40877.0 41008.8 232865.0 236553.0 237871.0 238096.0 239188.0 28489.6 28508.0 28597.3 29127.9 29759.0 35251.6 35473.5 36189.6 36484.6 36642.8 29974.7 31326.4 31439.8 31805.5 31876.0 30209.2 31046.5 31259.4 31543.7 31803.5 31216.7 31902.7 32895.7 33696.3 33702.7 23286.0 24598.5 26122.5 26993.9 29552.4 21095.6 21362.4 21385.8 21608.6 21764.1 17:23:27 INFO - PROCESS | 3456 | 17:23:27 INFO - PROCESS | 3456 | [#2] jquery.html Cycles:180 Average:22314.15 Median:4782.47 stddev:67535.30 (1412.1%) stddev-sans-first:67704.59 17:23:27 INFO - PROCESS | 3456 | Values: 334.8 335.7 337.0 338.9 340.4 14324.9 14722.9 14748.0 14924.3 15280.9 9863.8 10102.3 12432.1 15181.4 15216.2 4519.8 4553.6 4705.6 4720.3 4732.9 4634.3 4775.2 4779.4 4782.2 4782.8 4573.0 4763.6 4925.7 5159.8 5160.6 5023.7 5041.0 5071.1 5129.5 5328.2 5133.1 5133.1 5134.2 5137.6 5154.8 11252.3 15942.8 16607.9 16728.3 16800.2 1781.3 1835.5 1836.1 1839.7 1848.2 8954.3 8976.9 11023.0 11144.2 11560.4 1824.7 1901.5 1918.8 2004.1 2052.4 40940.2 42442.4 42994.0 43025.4 43534.6 9128.5 9325.4 9359.5 9384.4 9435.5 11700.4 11794.5 11819.2 11847.9 11882.6 6428.6 6661.7 6688.5 6751.9 6828.2 6280.6 6330.3 6382.6 6401.8 6473.4 4067.9 4133.8 4143.2 4158.0 4175.0 1609.0 1679.8 1713.8 1766.7 1775.0 843.1 867.8 873.6 898.4 973.8 13845.8 13983.4 14742.3 15121.4 15246.2 865.5 880.1 907.3 917.3 917.9 8684.7 8840.2 8849.4 8857.0 8959.1 409172.0 412098.0 412787.0 416047.0 418841.0 58427.0 60015.4 62481.7 62509.1 63852.4 970.1 982.6 986.0 990.5 991.1 12864.5 13547.5 13648.7 13742.9 13803.9 27898.9 28365.7 28848.4 29145.4 29259.0 36612.3 37002.6 37115.6 37221.4 39262.4 6510.5 6696.8 6714.6 6913.5 7074.5 8824.3 9522.8 10068.8 10268.3 10273.5 8066.3 8252.6 8428.8 8540.7 8594.7 8521.6 8544.7 8977.7 8991.2 9044.4 8563.2 8867.3 8911.1 8924.3 9152.5 6753.6 6806.2 6915.0 6918.4 7000.6 8129.3 8152.6 8170.1 8278.7 8373.9 17:23:27 INFO - PROCESS | 3456 | 17:23:27 INFO - PROCESS | 3456 | [#3] mootools.html Cycles:180 Average:5095.47 Median:6036.94 stddev:2747.95 (45.5%) stddev-sans-first:2741.77 17:23:27 INFO - PROCESS | 3456 | Values: 1419.2 1424.8 1571.3 1705.8 1755.2 6114.9 6247.0 7264.2 7446.0 7467.7 6835.0 6973.5 7017.9 7055.5 7060.9 2105.7 2122.6 2132.3 2133.5 2137.6 2088.0 2093.1 2108.8 2110.2 2114.6 2042.6 2049.5 2058.6 2068.3 2112.3 2115.4 2118.7 2119.1 2120.9 2121.4 2060.1 2106.3 2106.6 2107.9 2112.2 7635.6 7655.6 7655.7 7659.2 7694.8 4248.6 4348.1 4353.9 4358.3 4365.1 2811.9 2847.3 2938.5 2940.4 2945.9 947.0 986.1 994.3 997.8 1013.5 10505.7 10533.5 10554.9 10561.9 10574.3 4024.4 4048.0 4070.1 4074.5 4099.1 8872.6 8916.0 8964.1 8971.0 8980.1 4247.7 4251.7 4276.1 4281.5 4289.2 3281.3 3389.8 3811.7 3845.7 3881.7 3389.9 3430.8 3447.7 3455.2 3469.4 1067.8 1087.8 1093.0 1100.3 1102.3 938.4 943.3 945.9 993.5 1233.5 6919.0 6921.7 6932.7 6945.3 7144.2 445.0 446.1 447.1 449.5 461.1 5524.7 5530.5 5600.0 5616.1 5625.9 9103.3 9322.4 9410.1 9410.7 9435.4 9226.9 9243.4 9257.4 9262.5 9315.1 6735.0 6918.5 6928.8 6942.1 7025.6 6734.9 6739.6 6770.3 6772.7 6838.8 7856.9 8019.7 8033.8 8041.3 8045.7 8116.1 8173.6 8232.9 8241.8 8285.8 6045.6 6165.8 6170.2 6492.3 6704.1 6423.1 6462.0 6489.7 6494.4 6517.1 6072.2 6194.1 6206.0 6248.5 6298.1 5928.6 6078.8 6084.4 6147.0 6152.0 6039.1 6091.7 6130.0 6139.9 6141.0 5828.9 5861.7 5872.1 5872.7 5880.6 5999.7 6032.6 6034.8 6048.5 6059.3 17:23:27 INFO - PROCESS | 3456 | 17:23:27 INFO - PROCESS | 3456 | [#4] prototype.html Cycles:180 Average:4814.12 Median:5550.35 stddev:1426.65 (25.7%) stddev-sans-first:1389.92 17:23:27 INFO - PROCESS | 3456 | Values: 304.3 316.6 320.2 321.2 321.5 5393.4 5525.3 5632.3 5643.2 5711.1 5536.3 5551.2 5584.9 5594.5 5599.7 4141.3 4267.7 4276.3 4277.3 4283.2 4257.7 4263.9 4267.1 4268.7 4278.5 4198.6 4236.2 4245.0 4256.6 4258.4 4242.3 4251.4 4260.0 4271.7 4273.2 3630.6 3724.2 3730.1 3736.3 3739.9 5214.5 5309.6 5322.3 5326.7 5355.5 4811.4 4819.4 4819.6 4831.2 4833.6 5817.3 5818.0 5823.6 5843.6 5856.0 3889.6 3968.2 3968.8 3999.8 4021.6 6038.2 6079.5 6107.3 6109.9 6137.4 4108.5 4111.5 4112.5 4115.2 4119.8 4172.9 4173.6 4174.4 4182.7 4185.3 4473.1 4697.2 4815.3 4816.9 4835.8 5640.9 5778.0 5840.1 5841.4 5842.7 1474.6 1498.6 1499.7 1499.7 1500.6 983.3 998.8 999.0 1009.4 1016.9 5019.5 5062.5 5089.1 5092.1 5094.8 6042.5 6043.8 6048.8 6054.4 6079.8 5051.6 5059.5 5060.1 5063.0 5080.5 3212.8 3253.6 3260.7 3286.7 3301.5 5669.3 5685.5 5686.2 5693.6 5712.7 6141.4 6162.8 6180.5 6202.7 6205.8 5549.5 5653.7 5677.5 5686.5 5691.5 6007.1 6045.2 6045.5 6048.4 6052.7 5896.0 5912.8 5915.1 5923.1 5926.9 5652.2 5679.9 5680.3 5703.4 5716.1 4003.8 4085.3 4096.1 4098.7 4104.5 5909.1 6025.2 6029.4 6034.7 6112.4 5821.4 5847.3 5848.1 5861.9 5870.3 5859.5 5870.6 5871.4 5874.1 5879.8 5593.8 5718.1 5718.2 5733.1 5734.3 5848.9 5898.9 5900.6 5900.9 5905.3 5756.0 5757.3 5757.4 5759.8 5760.6 17:23:27 INFO - PROCESS | 3456 | 17:23:27 INFO - PROCESS | 3456 | [#5] yui.html Cycles:180 Average:11687.86 Median:45236.50 stddev:12816.69 (28.3%) stddev-sans-first:12826.04 17:23:27 INFO - PROCESS | 3456 | Values: 690.6 722.1 741.3 769.0 773.4 10717.7 10894.6 10899.8 10909.2 10910.8 10433.1 10541.6 10560.6 10572.5 10586.0 746.1 757.6 759.0 759.4 760.3 607.6 616.4 766.3 787.6 789.2 812.3 818.5 820.5 822.1 823.5 811.6 814.4 817.1 818.0 820.4 600.6 600.9 607.6 610.9 611.2 10706.7 10714.5 10732.2 10758.5 10826.9 11585.1 11592.9 11851.9 12055.3 12164.8 9451.0 9451.8 9459.9 9487.0 9557.8 3127.3 3251.2 3269.6 3293.4 3353.8 36840.8 37040.3 37132.0 37135.6 37222.3 8990.0 9303.2 9327.7 9427.9 9568.1 16314.5 16375.6 16408.3 16438.3 16460.5 6479.9 6498.4 6586.9 6693.9 6765.2 3728.6 3739.6 3749.5 3758.0 3783.8 2611.5 2631.2 2633.9 2637.2 2641.1 472.8 488.5 491.2 511.7 512.5 570.6 572.4 604.8 618.4 659.3 7739.5 8430.7 8488.1 8787.8 8934.5 474.3 516.0 521.9 607.6 627.2 3485.9 3682.5 3771.8 3773.9 3826.3 45036.0 45437.0 45569.5 45576.0 47550.0 41571.0 41942.0 42033.2 42148.8 43117.0 37642.1 37988.0 38725.4 38935.0 39143.2 7482.2 7516.7 7556.3 7558.2 7558.6 29532.7 29681.0 29782.3 29836.9 30455.0 35873.3 36050.5 36052.6 36525.8 37147.0 9516.8 9552.1 9682.5 9763.3 9984.9 10933.8 10966.9 11058.9 11120.2 11291.5 10207.1 10329.4 10336.0 10354.8 10367.8 10022.1 10078.4 10143.1 10161.3 10173.9 10328.4 10401.4 10418.4 10434.4 10531.8 8500.4 8794.0 8862.4 8930.3 9051.8 9136.8 9270.5 9277.6 9278.3 9463.2 17:23:27 INFO - PROCESS | 3456 | -------- Summary: end -------- 17:23:27 INFO - PROCESS | 3456 | 17:23:28 INFO - TEST-INFO | 3456: exit 0 17:23:28 INFO - TEST-OK | dromaeo_css | took 1117658ms 17:23:28 INFO - TEST-START | kraken 17:23:28 INFO - operating with platform_type : linux_ 17:23:28 INFO - Initialising browser for kraken test... 17:23:28 INFO - TEST-INFO | started process 3699 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGsMpQi/profile http://localhost:57181/getInfo.html) 17:23:32 INFO - PROCESS | 3699 | 17:23:32 INFO - PROCESS | 3699 | (process:3769): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:23:32 INFO - PROCESS | 3699 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 17:23:33 INFO - PROCESS | 3699 | __metrics Screen width/height:1600/1200 17:23:33 INFO - PROCESS | 3699 | colorDepth:24 17:23:33 INFO - PROCESS | 3699 | Browser inner width/height: 1024/697 17:23:33 INFO - PROCESS | 3699 | __metrics 17:23:33 INFO - PROCESS | 3699 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:23:34 INFO - TEST-INFO | 3699: exit 0 17:23:34 INFO - Browser initialized. 17:23:34 INFO - Running cycle 1/1 for kraken test... 17:23:34 INFO - TEST-INFO | started process 3818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGsMpQi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:23:35 INFO - PROCESS | 3818 | 17:23:35 INFO - PROCESS | 3818 | (process:3873): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:23:46 INFO - PROCESS | 3818 | RSS: Main: 150994944 17:23:46 INFO - PROCESS | 3818 | 17:23:48 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57181/tests/kraken/driver.html?testName=audio-beat-detection) 17:23:49 INFO - PROCESS | 3818 | RSS: Main: 151941120 17:23:49 INFO - PROCESS | 3818 | 17:23:52 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57181/tests/kraken/driver.html?testName=audio-dft) 17:23:52 INFO - PROCESS | 3818 | RSS: Main: 152367104 17:23:52 INFO - PROCESS | 3818 | 17:23:55 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57181/tests/kraken/driver.html?testName=audio-fft) 17:23:56 INFO - PROCESS | 3818 | RSS: Main: 146837504 17:23:56 INFO - PROCESS | 3818 | 17:23:58 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57181/tests/kraken/driver.html?testName=audio-oscillator) 17:23:58 INFO - PROCESS | 3818 | RSS: Main: 147791872 17:23:58 INFO - PROCESS | 3818 | 17:24:01 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57181/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:24:01 INFO - PROCESS | 3818 | RSS: Main: 147857408 17:24:01 INFO - PROCESS | 3818 | 17:24:04 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57181/tests/kraken/driver.html?testName=imaging-darkroom) 17:24:05 INFO - PROCESS | 3818 | RSS: Main: 146804736 17:24:05 INFO - PROCESS | 3818 | 17:24:08 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57181/tests/kraken/driver.html?testName=imaging-desaturate) 17:24:09 INFO - PROCESS | 3818 | RSS: Main: 146677760 17:24:09 INFO - PROCESS | 3818 | 17:24:12 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57181/tests/kraken/driver.html?testName=json-parse-financial) 17:24:12 INFO - PROCESS | 3818 | RSS: Main: 146415616 17:24:12 INFO - PROCESS | 3818 | 17:24:14 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57181/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:24:15 INFO - PROCESS | 3818 | RSS: Main: 149434368 17:24:15 INFO - PROCESS | 3818 | 17:24:17 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57181/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:24:17 INFO - PROCESS | 3818 | RSS: Main: 149917696 17:24:17 INFO - PROCESS | 3818 | 17:24:20 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57181/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:24:21 INFO - PROCESS | 3818 | RSS: Main: 149331968 17:24:21 INFO - PROCESS | 3818 | 17:24:23 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:24:24 INFO - PROCESS | 3818 | RSS: Main: 149106688 17:24:24 INFO - PROCESS | 3818 | 17:24:26 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:24:27 INFO - PROCESS | 3818 | RSS: Main: 148246528 17:24:27 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | Cycle 1(1): loaded http://localhost:57181/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57181/tests/kraken/driver.html?testName=ai-astar) 17:24:29 INFO - PROCESS | 3818 | RSS: Main: 150089728 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | __start_tp_report 17:24:29 INFO - PROCESS | 3818 | _x_x_mozilla_page_load 17:24:29 INFO - PROCESS | 3818 | _x_x_mozilla_page_load_details 17:24:29 INFO - PROCESS | 3818 | |i|pagename|runs| 17:24:29 INFO - PROCESS | 3818 | |0;ai-astar;114;110;114;115;114;126;114;112;114;114 17:24:29 INFO - PROCESS | 3818 | |1;audio-beat-detection;158;132;151;166;138;162;158;140;173;133 17:24:29 INFO - PROCESS | 3818 | |2;audio-dft;171;163;162;162;162;164;169;162;164;161 17:24:29 INFO - PROCESS | 3818 | |3;audio-fft;76;73;74;74;142;72;72;72;72;96 17:24:29 INFO - PROCESS | 3818 | |4;audio-oscillator;97;98;133;98;98;98;133;99;97;130 17:24:29 INFO - PROCESS | 3818 | |5;imaging-gaussian-blur;110;110;109;110;111;109;110;109;110;109 17:24:29 INFO - PROCESS | 3818 | |6;imaging-darkroom;148;148;147;148;148;149;149;149;149;148 17:24:29 INFO - PROCESS | 3818 | |7;imaging-desaturate;96;97;96;96;96;96;96;98;96;96 17:24:29 INFO - PROCESS | 3818 | |8;json-parse-financial;70;74;72;71;72;70;72;72;69;74 17:24:29 INFO - PROCESS | 3818 | |9;json-stringify-tinderbox;68;72;68;68;69;68;73;70;69;69 17:24:29 INFO - PROCESS | 3818 | |10;stanford-crypto-aes;82;85;88;84;83;84;83;83;88;89 17:24:29 INFO - PROCESS | 3818 | |11;stanford-crypto-ccm;129;125;121;129;124;132;124;133;133;127 17:24:29 INFO - PROCESS | 3818 | |12;stanford-crypto-pbkdf2;135;148;154;147;153;142;138;153;146;137 17:24:29 INFO - PROCESS | 3818 | |13;stanford-crypto-sha256-iterative;74;72;73;74;72;71;70;71;72;74 17:24:29 INFO - PROCESS | 3818 | __end_tp_report 17:24:29 INFO - PROCESS | 3818 | __start_cc_report 17:24:29 INFO - PROCESS | 3818 | _x_x_mozilla_cycle_collect,786 17:24:29 INFO - PROCESS | 3818 | __end_cc_report 17:24:29 INFO - PROCESS | 3818 | __startTimestamp1452475469483__endTimestamp 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | ------- Summary: start ------- 17:24:29 INFO - PROCESS | 3818 | Number of tests: 14 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.00 stddev:4.22 (3.7%) stddev-sans-first:4.47 17:24:29 INFO - PROCESS | 3818 | Values: 114.0 110.0 114.0 115.0 114.0 126.0 114.0 112.0 114.0 114.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#1] audio-beat-detection Cycles:10 Average:151.10 Median:158.00 stddev:14.54 (9.2%) stddev-sans-first:15.21 17:24:29 INFO - PROCESS | 3818 | Values: 158.0 132.0 151.0 166.0 138.0 162.0 158.0 140.0 173.0 133.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.33 (2.0%) stddev-sans-first:2.39 17:24:29 INFO - PROCESS | 3818 | Values: 171.0 163.0 162.0 162.0 162.0 164.0 169.0 162.0 164.0 161.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#3] audio-fft Cycles:10 Average:82.30 Median:73.50 stddev:22.21 (30.2%) stddev-sans-first:23.44 17:24:29 INFO - PROCESS | 3818 | Values: 76.0 73.0 74.0 74.0 142.0 72.0 72.0 72.0 72.0 96.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:98.00 stddev:16.52 (16.9%) stddev-sans-first:17.03 17:24:29 INFO - PROCESS | 3818 | Values: 97.0 98.0 133.0 98.0 98.0 98.0 133.0 99.0 97.0 130.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 17:24:29 INFO - PROCESS | 3818 | Values: 110.0 110.0 109.0 110.0 111.0 109.0 110.0 109.0 110.0 109.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 17:24:29 INFO - PROCESS | 3818 | Values: 148.0 148.0 147.0 148.0 148.0 149.0 149.0 149.0 149.0 148.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 17:24:29 INFO - PROCESS | 3818 | Values: 96.0 97.0 96.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#8] json-parse-financial Cycles:10 Average:71.60 Median:72.00 stddev:1.65 (2.3%) stddev-sans-first:1.64 17:24:29 INFO - PROCESS | 3818 | Values: 70.0 74.0 72.0 71.0 72.0 70.0 72.0 72.0 69.0 74.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:1.78 (2.6%) stddev-sans-first:1.81 17:24:29 INFO - PROCESS | 3818 | Values: 68.0 72.0 68.0 68.0 69.0 68.0 73.0 70.0 69.0 69.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:2.51 (3.0%) stddev-sans-first:2.44 17:24:29 INFO - PROCESS | 3818 | Values: 82.0 85.0 88.0 84.0 83.0 84.0 83.0 83.0 88.0 89.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:129.00 stddev:4.19 (3.2%) stddev-sans-first:4.42 17:24:29 INFO - PROCESS | 3818 | Values: 129.0 125.0 121.0 129.0 124.0 132.0 124.0 133.0 133.0 127.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.30 Median:147.50 stddev:7.02 (4.8%) stddev-sans-first:6.39 17:24:29 INFO - PROCESS | 3818 | Values: 135.0 148.0 154.0 147.0 153.0 142.0 138.0 153.0 146.0 137.0 17:24:29 INFO - PROCESS | 3818 | 17:24:29 INFO - PROCESS | 3818 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:1.42 (2.0%) stddev-sans-first:1.36 17:24:29 INFO - PROCESS | 3818 | Values: 74.0 72.0 73.0 74.0 72.0 71.0 70.0 71.0 72.0 74.0 17:24:29 INFO - PROCESS | 3818 | -------- Summary: end -------- 17:24:29 INFO - PROCESS | 3818 | 17:24:30 INFO - TEST-INFO | 3818: exit 0 17:24:30 INFO - TEST-OK | kraken | took 62098ms 17:24:30 INFO - TEST-START | v8_7 17:24:30 INFO - operating with platform_type : linux_ 17:24:30 INFO - Initialising browser for v8_7 test... 17:24:30 INFO - TEST-INFO | started process 4102 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUwfvNX/profile http://localhost:57181/getInfo.html) 17:24:34 INFO - PROCESS | 4102 | 17:24:34 INFO - PROCESS | 4102 | (process:4174): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:24:34 INFO - PROCESS | 4102 | JavaScript warning: resource://gre/modules/TelemetrySession.jsm, line 1783: unreachable code after return statement 17:24:34 INFO - PROCESS | 4102 | __metrics Screen width/height:1600/1200 17:24:34 INFO - PROCESS | 4102 | colorDepth:24 17:24:34 INFO - PROCESS | 4102 | Browser inner width/height: 1024/697 17:24:34 INFO - PROCESS | 4102 | __metrics 17:24:35 INFO - PROCESS | 4102 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 17:24:36 INFO - TEST-INFO | 4102: exit 0 17:24:36 INFO - Browser initialized. 17:24:36 INFO - Running cycle 1/1 for v8_7 test... 17:24:36 INFO - TEST-INFO | started process 4223 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUwfvNX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:24:37 INFO - PROCESS | 4223 | 17:24:37 INFO - PROCESS | 4223 | (process:4281): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 17:24:48 INFO - PROCESS | 4223 | RSS: Main: 150532096 17:24:48 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | Cycle 1(1): loaded http://localhost:57181/tests/v8_7/run.html (next: http://localhost:57181/tests/v8_7/run.html) 17:25:10 INFO - PROCESS | 4223 | RSS: Main: 146264064 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | __start_tp_report 17:25:10 INFO - PROCESS | 4223 | _x_x_mozilla_page_load 17:25:10 INFO - PROCESS | 4223 | _x_x_mozilla_page_load_details 17:25:10 INFO - PROCESS | 4223 | |i|pagename|runs| 17:25:10 INFO - PROCESS | 4223 | |0;Richards;167.64459346186086 17:25:10 INFO - PROCESS | 4223 | |1;DeltaBlue;185.6665428889714 17:25:10 INFO - PROCESS | 4223 | |2;Encrypt;277.700638711469 17:25:10 INFO - PROCESS | 4223 | |3;Decrypt;5175.257731958763 17:25:10 INFO - PROCESS | 4223 | |4;RayTrace;1082.2510822510822 17:25:10 INFO - PROCESS | 4223 | |5;Earley;718.3908045977012 17:25:10 INFO - PROCESS | 4223 | |6;Boyer;12543.20987654321 17:25:10 INFO - PROCESS | 4223 | |7;RegExp;42893.617021276594 17:25:10 INFO - PROCESS | 4223 | |8;Splay;619.9628022318661 17:25:10 INFO - PROCESS | 4223 | |9;NavierStokes;4826.923076923077 17:25:10 INFO - PROCESS | 4223 | __end_tp_report 17:25:10 INFO - PROCESS | 4223 | __startTimestamp1452475510802__endTimestamp 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | ------- Summary: start ------- 17:25:10 INFO - PROCESS | 4223 | Number of tests: 10 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | [#0] Richards Cycles:1 Average:167.64 Median:167.64 stddev:0.00 (0.0%) 17:25:10 INFO - PROCESS | 4223 | Values: 167.6 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | [#1] DeltaBlue Cycles:1 Average:185.67 Median:185.67 stddev:0.00 (0.0%) 17:25:10 INFO - PROCESS | 4223 | Values: 185.7 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | [#2] Encrypt Cycles:1 Average:277.70 Median:277.70 stddev:0.00 (0.0%) 17:25:10 INFO - PROCESS | 4223 | Values: 277.7 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 17:25:10 INFO - PROCESS | 4223 | Values: 5175.3 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | [#4] RayTrace Cycles:1 Average:1082.25 Median:1082.25 stddev:0.00 (0.0%) 17:25:10 INFO - PROCESS | 4223 | Values: 1082.3 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | [#5] Earley Cycles:1 Average:718.39 Median:718.39 stddev:0.00 (0.0%) 17:25:10 INFO - PROCESS | 4223 | Values: 718.4 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | [#6] Boyer Cycles:1 Average:12543.21 Median:12543.21 stddev:0.00 (0.0%) 17:25:10 INFO - PROCESS | 4223 | Values: 12543.2 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | [#7] RegExp Cycles:1 Average:42893.62 Median:42893.62 stddev:0.00 (0.0%) 17:25:10 INFO - PROCESS | 4223 | Values: 42893.6 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | [#8] Splay Cycles:1 Average:619.96 Median:619.96 stddev:0.00 (0.0%) 17:25:10 INFO - PROCESS | 4223 | Values: 620.0 17:25:10 INFO - PROCESS | 4223 | 17:25:10 INFO - PROCESS | 4223 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 17:25:10 INFO - PROCESS | 4223 | Values: 4826.9 17:25:10 INFO - PROCESS | 4223 | -------- Summary: end -------- 17:25:10 INFO - PROCESS | 4223 | 17:25:11 INFO - TEST-INFO | 4223: exit 0 17:25:11 INFO - TEST-OK | v8_7 | took 41261ms 17:25:11 INFO - SUITE-END | took 1221s 17:25:11 INFO - Completed test suite (00:20:21) 17:25:11 INFO - Working with test: dromaeo_css 17:25:11 INFO - Generating results file: dromaeo_css 17:25:11 INFO - Working with test: kraken 17:25:11 INFO - Generating results file: kraken 17:25:11 INFO - javascript benchmark 17:25:11 INFO - Working with test: v8_7 17:25:11 INFO - Generating results file: v8_7 17:25:11 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 17:25:11 INFO - process_Request line: dromaeo_css 6125.53 graph.html#tests=[[72,94,43]] 17:25:11 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:12 INFO - process_Request line: kraken 1545.70 graph.html#tests=[[232,94,43]] 17:25:12 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:25:12 INFO - process_Request line: v8_7 20200.76 graph.html#tests=[[230,94,43]] 17:25:12 INFO - RETURN: dromaeo_css: 6125.53 17:25:12 INFO - RETURN: kraken: 1545.70 17:25:12 INFO - RETURN: v8_7: 20200.76 17:25:12 INFO - javascript benchmark 17:25:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2591.92224233273, 2647.4969755746397, 2676.4245687177267, 2681.9865900670507, 2695.9191224263272, 4333.414988976488, 4527.071950250199, 4612.930806037908, 4619.260918253076, 4657.813687452502, 4432.335149727543, 4461.977690111545, 4576.427946506687, 4638.814447422107, 4646.907061858761, 4234.618884300412, 4274.123804620045, 4324.437823082995, 4330.06903515744, 4348.239058164809, 4226.323788193889, 4233.301505251629, 4305.806238719265, 4311.82752689892, 4327.848525301615, 4088.2028004539125, 4160.83356665733, 4203.55862634422, 4225.598568136023, 4230.196262710076, 4248.022954720401, 4250.3836943643, 4257.97871010646, 4261.339492378686, 4301.354796780477, 4193.811278492475, 4213.91572168558, 4222.387753775716, 4225.429567008446, 4235.703500754948, 4290.914181716379, 4375.737455752633, 4476.418065651477, 4507.706999045052, 4590.334401511762, 4878.463369029404, 4910.852674419773, 4918.360613120307, 4931.852044438672, 4977.328060711794, 4923.990581930696, 4935.2843837643695, 4951.653384263103, 4954.851354459372, 4993.750312484398, 4386.583274588909, 4489.393931819162, 4517.796699148546, 4591.977040114778, 4624.237000894882, 5003.699778013331, 5019.121653710586, 5035.118854200574, 5043.773030213649, 5083.61872859537, 4542.318652202196, 4744.430668319824, 4795.256735206049, 4809.591184749265, 4812.903741925142, 4816.807327706852, 4853.12643724126, 4876.609871210295, 4880.511948805091, 4883.487233840467, 4840.467548569654, 4927.975360123177, 4939.185034469272, 4947.307376967227, 4956.231784073474, 4872.3909511311085, 4879.292502587176, 4886.364772579542, 4902.362692849907, 4950.77721502526, 3994.400839874042, 4087.5094988600963, 4087.6116768906904, 4176.310908700091, 4217.135487225111, 3647.3799454092336, 3647.85408583659, 3682.5396825396824, 3695.722820788452, 3707.1102935295335, 4234.047339348622, 4234.978825105916, 4280.871573852789, 4284.378765079046, 4337.175936572041, 4713.2458806590785, 4790.808367665324, 4791.6406269529925, 4870.391201099863, 4931.506849315111, 4221.91556168881, 4247.830086796494, 4259.5527469615245, 4259.9787001065415, 4294.463192100988, 4404.691671583022, 4405.405270288534, 4425.070735145656, 4431.645468362523, 4454.554544545585, 4463.598276155161, 4553.430821147423, 4633.629309655152, 4707.364505791675, 4733.597644200281, 4897.289892965428, 4899.314096026488, 4934.851954441372, 4973.055119527278, 4982.900341993212, 4481.865544033684, 4671.089137618132, 4674.485806561208, 4692.038132182963, 4723.14983302995, 4744.976275118603, 4795.736234506996, 4868.269759536098, 4873.439554451142, 4900.8774780630765, 4893.266010098514, 4914.975425122851, 4927.088488629472, 4980.750962451935, 5000.548305735296, 4559.589636932692, 4656.650751193606, 4735.408073990751, 4749.715017098985, 4814.8796280093275, 4620.168369693488, 4705.458872229738, 4730.0, 4743.573078422821, 4785.090832741768, 4596.4714057883775, 4621.260598304255, 4630.652701047502, 4639.976800116113, 4648.953510464852, 4554.043650833362, 4654.86035418938, 4754.21555443348, 4760.881192919592, 4798.784054717616, 4565.6119229865835, 4620.676552641283, 4625.514320996247, 4647.9767601161775, 4691.460482044608], "unit": "score", "name": "dojo.html", "value": 4495.502828449479}, {"lowerIsBetter": false, "replicates": [468.26482422596536, 475.2965610895874, 495.45994865596504, 495.7595566150417, 505.19421522671325, 31631.209219769487, 32432.0, 32456.350872982526, 32500.349993000127, 32507.83746081266, 35230.11924701884, 36226.63773362266, 36338.45492317617, 36407.0, 36431.63568364316, 7550.5847178405165, 7683.884741728879, 7754.991851059354, 7756.495827771205, 7763.767086987399, 7570.583617901013, 7590.203028681992, 7609.619519024027, 7614.162442131389, 7615.961920190419, 7767.883481747778, 7864.213578642147, 7916.208379162066, 7954.0, 7976.0, 7814.1013783415065, 7887.171846956073, 7899.565523896184, 7899.763007109796, 7912.683492660287, 7638.5798781067015, 7832.608369581498, 7835.138134805167, 7854.175311592315, 7871.21287871214, 36099.819500902326, 36434.0, 36478.0, 36481.0, 36495.63504364949, 2990.0, 3012.894548690785, 3022.6826183250882, 3055.434744572239, 3060.32672811981, 27766.861165694245, 27974.160775176777, 28124.0, 28353.574696379572, 28548.857255713796, 3205.4550726376574, 3241.0439614964866, 3277.9344413111844, 3292.1769557610596, 3293.324868401996, 210595.0, 211079.0, 211487.0, 211989.0, 212776.0, 47171.29243061357, 54068.45931540634, 54314.45685543094, 54742.72628636911, 54919.97940113332, 41524.37713434301, 57855.55361116006, 59346.703266484255, 59399.0, 59486.70256648689, 12613.684657883443, 12897.548585799452, 12905.451345838559, 12908.35458227085, 12951.481940722453, 9353.158215760614, 9364.719058428258, 9384.95307523458, 9488.335816492918, 9500.287478439006, 17431.912840435718, 17622.207000685, 17688.9115554424, 17800.109994500224, 18559.164837582342, 7024.489734707063, 7152.17749958751, 7177.856442871113, 7230.2046774854725, 7288.708451661874, 806.766037849029, 831.1190138453138, 838.890944177253, 873.6854732296368, 966.1401352796017, 25056.624150637756, 25088.37279068038, 25454.236372908843, 25870.353241169123, 25975.350616234744, 948.9775066413357, 960.5533426956499, 976.6776963601994, 991.509202944547, 1037.4864442101057, 13304.935605151564, 13311.33443327849, 13636.65908352299, 13645.38595763193, 13653.04428690002, 246058.0, 251652.0, 252099.0, 252233.0, 254795.0, 44457.0, 45113.548864510936, 45258.77370613126, 45359.31961020587, 45433.54566454293, 1181.2735167871697, 1218.2873019283818, 1218.8963938065365, 1229.0843321725372, 1230.7784598772128, 24716.50566988686, 24967.50064998726, 25098.247052588453, 25163.622545661463, 25165.0, 40233.79883100566, 40434.59565404426, 40618.79690601528, 40877.0, 41008.79495602503, 232865.0, 236553.0, 237871.0, 238096.0, 239188.0, 28489.581250250103, 28508.0, 28597.28506787347, 29127.85436072806, 29759.0, 35251.589936402255, 35473.467897981034, 36189.63810361863, 36484.63515364812, 36642.8167859159, 29974.70025299719, 31326.420522656183, 31439.84280078585, 31805.522917156723, 31876.04371868755, 30209.244768880955, 31046.534301985037, 31259.374812504077, 31543.684563154075, 31803.522947156274, 31216.687833121377, 31902.68097318997, 32895.67104328926, 33696.326073478886, 33702.66297336995, 23286.0, 24598.508029838944, 26122.477550448504, 26993.865030674722, 29552.408951820413, 21095.57808843845, 21362.359129226148, 21385.78614213838, 21608.567828643652, 21764.12943482243], "unit": "score", "name": "ext.html", "value": 16111.79877028403}, {"lowerIsBetter": false, "replicates": [334.8426239667356, 335.6861334652102, 337.0, 338.9322135572883, 340.4399762390867, 14324.928375358135, 14722.926385368059, 14748.041377310481, 14924.328405221764, 15280.923595382008, 9863.802723945535, 10102.343347682396, 12432.067594930393, 15181.392744290215, 15216.239188040608, 4519.79660915258, 4553.567411095941, 4705.600023997964, 4720.268358404453, 4732.858014259577, 4634.258518637019, 4775.164346239411, 4779.378680771495, 4782.187028205213, 4782.7608619569055, 4573.0, 4763.642726795504, 4925.655204135712, 5159.793608255665, 5160.612954028444, 5023.7236951967625, 5040.991801639669, 5071.087204303224, 5129.512696293846, 5328.17413300939, 5133.127368347353, 5133.12736834739, 5134.204198349262, 5137.614678899097, 5154.793808247666, 11252.268602540891, 15942.840571594252, 16607.91696041524, 16728.330866765315, 16800.243989020524, 1781.340903865565, 1835.5135888989428, 1836.091134888239, 1839.7056470964715, 1848.2052717331542, 8954.283657307466, 8976.8653470198, 11023.0, 11144.219904606682, 11560.421978901022, 1824.6989246774267, 1901.4675890750611, 1918.7505624268756, 2004.1081718635214, 2052.404802607242, 40940.1811963762, 42442.36336454956, 42994.0, 43025.35461968073, 43534.564654353686, 9128.497932613636, 9325.393849399767, 9359.532023398939, 9384.390014649027, 9435.528223588793, 11700.414979251003, 11794.46924888365, 11819.172657913863, 11847.88152118485, 11882.584109556125, 6428.550001499943, 6661.700223489955, 6688.4649228061635, 6751.932480675228, 6828.2488926218075, 6280.591761535486, 6330.272018717815, 6382.6170429774365, 6401.807945761635, 6473.417392434703, 4067.877963661095, 4133.793310334471, 4143.233501802176, 4158.0, 4175.039740859558, 1608.951731448035, 1679.8404151605578, 1713.7686412334424, 1766.6555021770632, 1774.9911250443924, 843.0810416645763, 867.7657032601288, 873.6243415331469, 898.4025622960788, 973.8253540621314, 13845.792313115311, 13983.440662373594, 14742.262886855615, 15121.395144194328, 15246.23768811555, 865.5196366016795, 880.0935036911991, 907.3331101640289, 917.2707697380598, 917.8990311065777, 8684.696035638848, 8840.24857887074, 8849.4247873888, 8857.0, 8959.148880856308, 409172.0, 412098.0, 412787.0, 416047.0, 418841.0, 58427.0, 60015.399846001856, 62481.68759156175, 62509.12253691478, 63852.36147638464, 970.1414248390225, 982.6118683120128, 985.9802803944025, 990.5393991793707, 991.0981007283337, 12864.485420583072, 13547.458101676217, 13648.727025459633, 13742.862571374159, 13803.861961380659, 27898.860505697343, 28365.71634283631, 28848.42303153883, 29145.397003165028, 29259.0, 36612.26775464529, 37002.62997369992, 37115.6288437123, 37221.441678375384, 39262.4110638335, 6510.47916166715, 6696.799096027127, 6714.597124172566, 6913.516053876381, 7074.540154889915, 8824.294056475339, 9522.809543808946, 10068.798624027624, 10268.332558383681, 10273.486325683836, 8066.274035336848, 8252.587370631565, 8428.789280268042, 8540.701075462577, 8594.742157735278, 8521.573921304034, 8544.658213671384, 8977.730668079706, 8991.235744961752, 9044.41211321262, 8563.186497282748, 8867.290616750774, 8911.108889111038, 8924.330675199515, 9152.496612686366, 6753.5610185339765, 6806.18325800907, 6914.965425172842, 6918.377346038881, 7000.579965202104, 8129.309008734087, 8152.633131509215, 8170.142135075732, 8278.71024514139, 8373.874391884005], "unit": "score", "name": "jquery.html", "value": 7320.69950570163}, {"lowerIsBetter": false, "replicates": [1419.1910610951757, 1424.8361438434576, 1571.3086242053496, 1705.795304563451, 1755.1662960093956, 6114.908276375858, 6247.0317100849325, 7264.200937896834, 7446.0, 7467.663955122012, 6834.974753786934, 6973.546719463231, 7017.859642807153, 7055.506114571969, 7060.940858871159, 2105.652567326389, 2122.628540005493, 2132.3070002249256, 2133.4986278224683, 2137.561799831031, 2087.9582408351826, 2093.0581238442687, 2108.7891210878943, 2110.2086717480943, 2114.5876554071883, 2042.5914817036578, 2049.467138543974, 2058.6294466995937, 2068.338131797825, 2112.2818241797786, 2115.397111823123, 2118.66101423773, 2119.1099738109956, 2120.9151633934625, 2121.448423409909, 2060.124447109972, 2106.315447479575, 2106.631339515594, 2107.873527588334, 2112.1656945506593, 7635.618219089023, 7655.617219139021, 7655.693772249103, 7659.234076592352, 7694.807629809299, 4248.575142485726, 4348.065165989327, 4353.891152721176, 4358.302671572533, 4365.083332500179, 2811.9156425307274, 2847.2597124747713, 2938.500454922647, 2940.3531223130876, 2945.9263518412213, 946.9621215151386, 986.1075726467486, 994.3387647214594, 997.7810540737756, 1013.5388398278766, 10505.737356566071, 10533.525991330409, 10554.947225263824, 10561.894381056169, 10574.312669676523, 4024.436578878959, 4047.959520404758, 4070.1249231414795, 4074.5110586729784, 4099.098198396348, 8872.624743164819, 8915.955420222987, 8964.058773828785, 8971.0, 8980.101989800967, 4247.702660813775, 4251.723637963522, 4276.102018576134, 4281.507626622916, 4289.206496798102, 3281.2945216778508, 3389.796612203276, 3811.6760075393904, 3845.6731177850197, 3881.7476864003747, 3389.881354152642, 3430.8456119474686, 3447.6897079262485, 3455.2398472336045, 3469.3755124077907, 1067.7597540553313, 1087.842262871895, 1092.9672109836717, 1100.2958106811648, 1102.2780079048237, 938.3619138985418, 943.2783920300975, 945.9195968342768, 993.4883534979491, 1233.5374234662002, 6918.962155676689, 6921.688524016431, 6932.688029038705, 6945.340192681788, 7144.24985376528, 445.03427562190126, 446.0677184684026, 447.1459512331496, 449.51227917708997, 461.0732427820106, 5524.66851988882, 5530.474604912527, 5600.047991841397, 5616.073347897633, 5625.859353516113, 9103.317251206186, 9322.440653560809, 9410.058994100673, 9410.670626528039, 9435.386699864486, 9226.90773092274, 9243.352965292364, 9257.398269112486, 9262.490563019099, 9315.068493150766, 6734.966325168441, 6918.515703900679, 6928.826779330557, 6942.062821519131, 7025.5784652919965, 6734.898976515454, 6739.5619284746335, 6770.2891196425635, 6772.729090836311, 6838.794836154923, 7856.921430785847, 8019.719309824128, 8033.839323213386, 8041.276285134132, 8045.678172873019, 8116.147804480444, 8173.632186551738, 8232.876506852523, 8241.79395515117, 8285.751427457186, 6045.576809623284, 6165.815025549241, 6170.228721409824, 6492.28584855656, 6704.061431399706, 6423.132877061536, 6461.966085426309, 6489.675516224264, 6494.383033611799, 6517.055027020961, 6072.240969878765, 6194.101855231056, 6206.038064100072, 6248.468880145057, 6298.11826344303, 5928.614640048383, 6078.787242446493, 6084.39156084388, 6147.047207682816, 6152.0, 6039.124326972652, 6091.664958427329, 6130.049842274455, 6139.9079013813935, 6140.969295153495, 5828.912566311594, 5861.706914654165, 5872.119182122716, 5872.706364681834, 5880.617759845596, 5999.670018149044, 6032.577719559764, 6034.758609655564, 6048.455638992512, 6059.303180134341], "unit": "score", "name": "mootools.html", "value": 4089.0003190869184}, {"lowerIsBetter": false, "replicates": [304.33047295948916, 316.6342873980553, 320.16596765426067, 321.17458132599216, 321.4936475051794, 5393.352797664281, 5525.254090697755, 5632.26780518532, 5643.2099506069135, 5711.086226203808, 5536.335639723229, 5551.195076713874, 5584.86037849053, 5594.524465420434, 5599.692016939067, 4141.295979683461, 4267.658587313008, 4276.315789473685, 4277.272863613193, 4283.20760659279, 4257.723247988886, 4263.850765223217, 4267.1252393259465, 4268.701190916637, 4278.529361770203, 4198.6011328923705, 4236.216299984498, 4244.957550424502, 4256.638185754199, 4258.44640196774, 4242.300020496615, 4251.4260574822465, 4260.020195355086, 4271.743695378287, 4273.18809426208, 3630.6006339302658, 3724.2365315110337, 3730.123420996064, 3736.346139425617, 3739.9065023374633, 5214.45248248936, 5309.575233981311, 5322.2548843161985, 5326.733663316857, 5355.491228333302, 4811.374521312207, 4819.397575303087, 4819.614430845559, 4831.22700367943, 4833.589144922651, 5817.331006934214, 5817.970910145422, 5823.621464604787, 5843.620164689281, 5856.0, 3889.649931506178, 3968.206358728237, 3968.761874287552, 3999.8200080996135, 4021.577734337882, 6038.1848450459065, 6079.513638908877, 6107.26712794463, 6109.908351374733, 6137.4476297133915, 4108.548059713429, 4111.465509483748, 4112.527059388209, 4115.1975364803575, 4119.752814831119, 4172.916541669149, 4173.582641735863, 4174.436451079066, 4182.665386769051, 4185.330347144442, 4473.108100112429, 4697.201475749131, 4815.3499277597775, 4816.8795780105775, 4835.782389792468, 5640.887182256414, 5778.046622307356, 5840.094785308284, 5841.41585841421, 5842.737076831468, 1474.6018574984694, 1498.5504348695347, 1499.65507933176, 1499.6925630245773, 1500.647347873249, 983.3165949665057, 998.7752755629925, 998.9950050249702, 1009.4246279620693, 1016.893226211252, 5019.52314530119, 5062.493750624908, 5089.083964886282, 5092.0579692756955, 5094.7962081516325, 6042.516598672096, 6043.848903777441, 6048.848778780478, 6054.39456054391, 6079.848003799941, 5051.646384753032, 5059.494050594984, 5060.063888180698, 5063.0, 5080.491950804964, 3212.823294718813, 3253.560769296162, 3260.722838558749, 3286.7370610351113, 3301.4882693182594, 5669.31968163823, 5685.516731077904, 5686.2039314496005, 5693.629914055573, 5712.657240565496, 6141.355157708465, 6162.784302549389, 6180.536459765535, 6202.728440669652, 6205.81382558524, 5549.500544950974, 5653.717314134276, 5677.489025987681, 5686.459786320293, 5691.459311365331, 6007.12896629995, 6045.21412216409, 6045.516358691382, 6048.395160483917, 6052.66710330936, 5896.0, 5912.793052243151, 5915.053591425351, 5923.052311630118, 5926.881462370815, 5652.236948011966, 5679.943200567942, 5680.261565996394, 5703.429657034263, 5716.085426331767, 4003.839846406111, 4085.264652362603, 4096.09885825118, 4098.713090083785, 4104.52797928242, 5909.143174239625, 6025.156478092983, 6029.366916473882, 6034.698265086816, 6112.358202388685, 5821.388754180919, 5847.327557330961, 5848.064309710426, 5861.853453663522, 5870.26621672291, 5859.5019423349495, 5870.647761134345, 5871.412858714265, 5874.118882167709, 5879.764809407747, 5593.804216852391, 5718.056520674042, 5718.228039214653, 5733.082706766897, 5734.283214598176, 5848.883022339614, 5898.882022359615, 5900.557458190567, 5900.937831190427, 5905.291365036223, 5756.0, 5757.280339957505, 5757.395473475225, 5759.769609215585, 5760.567957403296], "unit": "score", "name": "prototype.html", "value": 4356.294413167296}, {"lowerIsBetter": false, "replicates": [690.6167077272115, 722.1442590530222, 741.3031750154855, 769.0, 773.4392565390096, 10717.732056698576, 10894.564217431292, 10899.782004359928, 10909.18181136415, 10910.781784364317, 10433.113185379232, 10541.578336866516, 10560.577576896934, 10572.471376431167, 10585.994330538606, 746.0972223609439, 757.5530437042144, 758.9506682065648, 759.4190444310079, 760.281533950417, 607.565590602719, 616.374380004296, 766.3103207113587, 787.6101329841707, 789.2147313423152, 812.2608426332039, 818.4598165210962, 820.4789958376414, 822.0710597025353, 823.5058964621239, 811.6225954930956, 814.4339683919678, 817.1256755271861, 817.9836403271961, 820.3601191071004, 600.5945986459122, 600.942910423509, 607.5716619783042, 610.8961476548998, 611.2390074357409, 10706.678799635945, 10714.46427678613, 10732.248742588023, 10758.515866785936, 10826.945865270702, 11585.131115166312, 11592.884071159266, 11851.940740296242, 12055.33695646739, 12164.756704865942, 9451.0, 9451.763705907339, 9459.858102128474, 9486.9525652372, 9557.808843823084, 3127.2807254331406, 3251.1872031992, 3269.558609587699, 3293.357795229931, 3353.7987720736833, 36840.81579592112, 37040.25919481595, 37132.0, 37135.628643713484, 37222.255554888754, 8990.0, 9303.162715355651, 9327.720168394959, 9427.90572094284, 9568.09103135201, 16314.510564683078, 16375.590610234602, 16408.26162822676, 16438.342466301216, 16460.506184814476, 6479.870402591921, 6498.350164983463, 6586.934130658728, 6693.866122677519, 6765.221999470124, 3728.5771223595384, 3739.5886452490204, 3749.4563288323584, 3758.041699366644, 3783.848646054182, 2611.4515951649987, 2631.1711810779543, 2633.8814753336146, 2637.1956553251443, 2641.088824355594, 472.832144588673, 488.5480930139607, 491.2116053733777, 511.744127936032, 512.50799232737, 570.5521165884761, 572.3589579670712, 604.7671646416161, 618.3551752338757, 659.3406593406594, 7739.496932699357, 8430.704925327584, 8488.108748581433, 8787.824243515222, 8934.463932164092, 474.309879125871, 515.9509846564571, 521.8956208758264, 607.6414915199965, 627.1502114634695, 3485.860565577399, 3682.4844521766972, 3771.8114094295724, 3773.9433908491396, 3826.253880493333, 45036.0, 45437.0, 45569.54430455653, 45576.0, 47550.0, 41571.0, 41942.0, 42033.159336813704, 42148.789256053526, 43117.0, 37642.058948527054, 37988.0, 38725.41911871268, 38935.0, 39143.217135657695, 7482.176960534446, 7516.661750221362, 7556.319931206218, 7558.206388329147, 7558.58427786477, 29532.704672952994, 29681.0, 29782.255443613216, 29836.85081574665, 30455.0, 35873.28253434865, 36050.4592431119, 36052.639473604926, 36525.81737091298, 37147.0, 9516.762080948032, 9552.092551207625, 9682.46746428925, 9763.316567840184, 9984.850227246452, 10933.83599246028, 10966.890331096587, 11058.944705276423, 11120.2181720637, 11291.491882865126, 10207.081362677394, 10329.380237185793, 10336.0, 10354.792904141725, 10367.792644147226, 10022.098011179029, 10078.445685487368, 10143.137833284254, 10161.288709790244, 10173.949130254301, 10328.431936243578, 10401.427921464392, 10418.426986515815, 10434.37393756377, 10531.78936421252, 8500.36247281444, 8793.956030220064, 8862.42394244372, 8930.330225233003, 9051.773705657411, 9136.771580710536, 9270.53647317618, 9277.621102352874, 9278.304127190353, 9463.195628371666], "unit": "score", "name": "yui.html", "value": 5592.602510461387}], "name": "dromaeo_css", "value": 6125.535212136327}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 114.0, 115.0, 114.0, 126.0, 114.0, 112.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [158.0, 132.0, 151.0, 166.0, 138.0, 162.0, 158.0, 140.0, 173.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.1}, {"lowerIsBetter": true, "replicates": [171.0, 163.0, 162.0, 162.0, 162.0, 164.0, 169.0, 162.0, 164.0, 161.0], "unit": "score", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [76.0, 73.0, 74.0, 74.0, 142.0, 72.0, 72.0, 72.0, 72.0, 96.0], "unit": "score", "name": "audio-fft", "value": 82.3}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 133.0, 98.0, 98.0, 98.0, 133.0, 99.0, 97.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 111.0, 109.0, 110.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 149.0, 149.0, 149.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [70.0, 74.0, 72.0, 71.0, 72.0, 70.0, 72.0, 72.0, 69.0, 74.0], "unit": "score", "name": "json-parse-financial", "value": 71.6}, {"lowerIsBetter": true, "replicates": [68.0, 72.0, 68.0, 68.0, 69.0, 68.0, 73.0, 70.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [82.0, 85.0, 88.0, 84.0, 83.0, 84.0, 83.0, 83.0, 88.0, 89.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [129.0, 125.0, 121.0, 129.0, 124.0, 132.0, 124.0, 133.0, 133.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [135.0, 148.0, 154.0, 147.0, 153.0, 142.0, 138.0, 153.0, 146.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.3}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 73.0, 74.0, 72.0, 71.0, 70.0, 71.0, 72.0, 74.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.3}], "name": "kraken", "value": 1545.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.64459346186086], "unit": "score", "name": "Richards", "value": 210.57643000000002}, {"lowerIsBetter": false, "replicates": [185.6665428889714], "unit": "score", "name": "DeltaBlue", "value": 356.111548}, {"lowerIsBetter": false, "replicates": [277.700638711469], "unit": "score", "name": "Encrypt", "value": 958.5177809999998}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1082.2510822510822], "unit": "score", "name": "RayTrace", "value": 683.7498360000003}, {"lowerIsBetter": false, "replicates": [718.3908045977012], "unit": "score", "name": "Earley", "value": 927.7164960000002}, {"lowerIsBetter": false, "replicates": [12543.20987654321], "unit": "score", "name": "Boyer", "value": 53.133369094488174}, {"lowerIsBetter": false, "replicates": [42893.617021276594], "unit": "score", "name": "RegExp", "value": 21.238241567460335}, {"lowerIsBetter": false, "replicates": [619.9628022318661], "unit": "score", "name": "Splay", "value": 131.44498299999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20200.755515098168}]} 17:25:12 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20200.76"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1545.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6125.53"}}} 17:25:12 INFO - Return code: 0 17:25:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:25:12 INFO - # TBPL SUCCESS # 17:25:12 INFO - Running post-action listener: _resource_record_post_action 17:25:12 INFO - Running post-run listener: _resource_record_post_run 17:25:13 INFO - Total resource usage - Wall time: 1238s; CPU: 13.0%; Read bytes: 10678272; Write bytes: 459702272; Read time: 4128; Write time: 392488 17:25:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 17330176; Read time: 0; Write time: 34000 17:25:13 INFO - run-tests - Wall time: 1223s; CPU: 13.0%; Read bytes: 10678272; Write bytes: 442372096; Read time: 4128; Write time: 358488 17:25:13 INFO - Running post-run listener: _upload_blobber_files 17:25:13 INFO - Blob upload gear active. 17:25:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:25: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 17:25: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'] 17:25: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 17:25:13 INFO - (blobuploader) - INFO - Open directory for files ... 17:25:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:25:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:25:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:14 INFO - (blobuploader) - INFO - Done attempting. 17:25:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:25:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:25:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:25:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:25:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:25:15 INFO - (blobuploader) - INFO - Done attempting. 17:25:15 INFO - (blobuploader) - INFO - Iteration through files over. 17:25:15 INFO - Return code: 0 17:25:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:25:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:25:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36c305dcc920f94fe6ed1ebfbea0fac938aef495908686f85dac94ef381f5ab5809f2ee370042b534a9cf970fbf5b6e7a6cf8bd55e9ec984858cf28dd19dcac6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9967469fe76f75d5b465bda6e563247900649bf6265c2990b496a3843ccc7225fe400bdbed1fcc84e7f66926f3eb408da6db0e98c2d04ad7f07151e720e0bc6f"} 17:25:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:25:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:25:15 INFO - Contents: 17:25:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36c305dcc920f94fe6ed1ebfbea0fac938aef495908686f85dac94ef381f5ab5809f2ee370042b534a9cf970fbf5b6e7a6cf8bd55e9ec984858cf28dd19dcac6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9967469fe76f75d5b465bda6e563247900649bf6265c2990b496a3843ccc7225fe400bdbed1fcc84e7f66926f3eb408da6db0e98c2d04ad7f07151e720e0bc6f"} 17:25:15 INFO - Copying logs to upload dir... 17:25:15 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1283.610837 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 23 secs) (at 2016-01-10 17:25:15.439885) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 17:25:15.443301) ========= 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=41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36c305dcc920f94fe6ed1ebfbea0fac938aef495908686f85dac94ef381f5ab5809f2ee370042b534a9cf970fbf5b6e7a6cf8bd55e9ec984858cf28dd19dcac6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9967469fe76f75d5b465bda6e563247900649bf6265c2990b496a3843ccc7225fe400bdbed1fcc84e7f66926f3eb408da6db0e98c2d04ad7f07151e720e0bc6f"} build_url:https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011133 build_url: 'https://queue.taskcluster.net/v1/task/PwXgVq2kR1y_65mzGz2JWg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/36c305dcc920f94fe6ed1ebfbea0fac938aef495908686f85dac94ef381f5ab5809f2ee370042b534a9cf970fbf5b6e7a6cf8bd55e9ec984858cf28dd19dcac6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9967469fe76f75d5b465bda6e563247900649bf6265c2990b496a3843ccc7225fe400bdbed1fcc84e7f66926f3eb408da6db0e98c2d04ad7f07151e720e0bc6f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-10 17:25:15.469124) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:25:15.469504) ========= 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=41bf3e9aed84707956354da8000001c5-1452474228.242657-426010556 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-10 17:25:15.558132) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 17:25:15.558946) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-10 17:25:15.559730) ========= ========= Total master_lag: 0.21 =========