builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1452686910.03 results: success (0) buildid: 20160113025531 builduid: 8f2f96f2c9ba478fac06725aae4429b9 revision: da1d2c63b0686a11be1b14c6e1f76a4875bb0e64 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.027952) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.028345) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.028618) ========= 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=4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006315 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.070300) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.070581) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.143415) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.143677) ========= 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=4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004607 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.196022) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.196303) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.196623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.196887) ========= 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=4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 04:08:30-- 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% 47.1M=0s 2016-01-13 04:08:30 (47.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100500 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.310100) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.310396) ========= 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=4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022540 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:30.359404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 04:08:30.359701) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev da1d2c63b0686a11be1b14c6e1f76a4875bb0e64 --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 da1d2c63b0686a11be1b14c6e1f76a4875bb0e64 --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=4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 04:08:30,375 truncating revision to first 12 chars 2016-01-13 04:08:30,375 Setting DEBUG logging. 2016-01-13 04:08:30,375 attempt 1/10 2016-01-13 04:08:30,375 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/da1d2c63b068?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 04:08:31,171 unpacking tar archive at: mozilla-central-da1d2c63b068/testing/mozharness/ program finished with exit code 0 elapsedTime=1.111134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-13 04:08:31.483522) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:31.483847) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:31.491330) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:31.491613) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 04:08:31.492024) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-01-13 04:08:31.492337) ========= /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=4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:31 INFO - MultiFileLogger online at 20160113 04:08:31 in /builds/slave/test 04:08:31 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 04:08:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:31 INFO - {'append_to_log': False, 04:08:31 INFO - 'base_work_dir': '/builds/slave/test', 04:08:31 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:08:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:31 INFO - 'branch': 'Firefox-Non-PGO', 04:08:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:31 INFO - 'config_files': ('talos/linux_config.py',), 04:08:31 INFO - 'default_actions': ('clobber', 04:08:31 INFO - 'read-buildbot-config', 04:08:31 INFO - 'download-and-extract', 04:08:31 INFO - 'populate-webroot', 04:08:31 INFO - 'create-virtualenv', 04:08:31 INFO - 'install', 04:08:31 INFO - 'run-tests'), 04:08:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:31 INFO - 'download_minidump_stackwalk': True, 04:08:31 INFO - 'download_symbols': 'ondemand', 04:08:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:31 INFO - 'installer_path': 'installer.exe', 04:08:31 INFO - 'log_level': 'info', 04:08:31 INFO - 'log_name': 'talos', 04:08:31 INFO - 'log_to_console': True, 04:08:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:31 INFO - 'opt_config_files': (), 04:08:31 INFO - 'pip_index': False, 04:08:31 INFO - 'sps_profile': False, 04:08:31 INFO - 'sps_profile_interval': 0, 04:08:31 INFO - 'suite': 'dromaeojs-e10s', 04:08:31 INFO - 'system_bits': '32', 04:08:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:31 INFO - 'title': 'talos-linux64-ix-024', 04:08:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:31 INFO - 'use_talos_json': True, 04:08:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:31 INFO - 'work_dir': 'build'} 04:08:31 INFO - ##### 04:08:31 INFO - ##### Running clobber step. 04:08:31 INFO - ##### 04:08:31 INFO - Running pre-action listener: _resource_record_pre_action 04:08:31 INFO - Running main action method: clobber 04:08:31 INFO - rmtree: /builds/slave/test/build 04:08:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:32 INFO - Running post-action listener: _resource_record_post_action 04:08:32 INFO - ##### 04:08:32 INFO - ##### Running read-buildbot-config step. 04:08:32 INFO - ##### 04:08:32 INFO - Running pre-action listener: _resource_record_pre_action 04:08:32 INFO - Running main action method: read_buildbot_config 04:08:32 INFO - Using buildbot properties: 04:08:32 INFO - { 04:08:32 INFO - "project": "", 04:08:32 INFO - "product": "firefox", 04:08:32 INFO - "script_repo_revision": "production", 04:08:32 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:08:32 INFO - "repository": "", 04:08:32 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:08:32 INFO - "buildid": "20160113025531", 04:08:32 INFO - "pgo_build": "False", 04:08:32 INFO - "basedir": "/builds/slave/test", 04:08:32 INFO - "buildnumber": 206, 04:08:32 INFO - "slavename": "talos-linux64-ix-024", 04:08:32 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:08:32 INFO - "platform": "ubuntu64_hw", 04:08:32 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:08:32 INFO - "branch": "mozilla-central", 04:08:32 INFO - "repo_path": "mozilla-central", 04:08:32 INFO - "revision": "da1d2c63b0686a11be1b14c6e1f76a4875bb0e64", 04:08:32 INFO - "stage_platform": "linux64", 04:08:32 INFO - "builduid": "8f2f96f2c9ba478fac06725aae4429b9", 04:08:32 INFO - "slavebuilddir": "test" 04:08:32 INFO - } 04:08:32 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 04:08:32 INFO - Running post-action listener: _resource_record_post_action 04:08:32 INFO - ##### 04:08:32 INFO - ##### Running download-and-extract step. 04:08:32 INFO - ##### 04:08:32 INFO - Running pre-action listener: _resource_record_pre_action 04:08:32 INFO - Running main action method: download_and_extract 04:08:32 INFO - mkdir: /builds/slave/test/build/tests 04:08:32 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')]} 04:08:32 INFO - https://queue.taskcluster.net/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:08:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/test_packages.json 04:08:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/test_packages.json 04:08:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:08:34 INFO - Downloaded 1302 bytes. 04:08:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:08:34 INFO - Using the following test package requirements: 04:08:34 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:34 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:34 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:34 INFO - u'jsshell-linux-x86_64.zip'], 04:08:34 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:34 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:34 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:08:34 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:08:34 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:34 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:34 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:34 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:34 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:34 INFO - https://queue.taskcluster.net/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/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 04:08:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/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 04:08:39 INFO - Downloaded 22758579 bytes. 04:08:39 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 04:08:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:39 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 04:08:40 INFO - Return code: 0 04:08:40 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 04:08:40 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')]} 04:08:40 INFO - https://queue.taskcluster.net/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/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 04:08:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/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 04:08:49 INFO - Downloaded 22758579 bytes. 04:08:49 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 04:08:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 04:08:49 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 04:08:50 INFO - Return code: 0 04:08:50 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')]} 04:08:50 INFO - https://queue.taskcluster.net/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:08:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/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 04:08:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/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 04:08:52 INFO - Downloaded 11132285 bytes. 04:08:52 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 04:08:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:52 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 04:08:52 INFO - Return code: 0 04:08:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:52 INFO - https://queue.taskcluster.net/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:08:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:08:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:08:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/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 04:08:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZhxHAglTTOaiBRLijcD9Eg/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 04:08:58 INFO - Downloaded 53859585 bytes. 04:08:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:08:58 INFO - mkdir: /builds/slave/test/properties 04:08:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:58 INFO - Contents: 04:08:58 INFO - build_url:https://queue.taskcluster.net/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 04:08:58 INFO - Running post-action listener: _resource_record_post_action 04:08:58 INFO - Running post-action listener: set_extra_try_arguments 04:08:58 INFO - ##### 04:08:58 INFO - ##### Running populate-webroot step. 04:08:58 INFO - ##### 04:08:58 INFO - Running pre-action listener: _resource_record_pre_action 04:08:58 INFO - Running main action method: populate_webroot 04:08:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:58 INFO - '--tppagecycles', 04:08:58 INFO - '7'], 04:08:58 INFO - 'tests': ['tsvgm']}}, 04:08:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:08:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:08:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:08:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:08:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:58 INFO - 'talos_options': ['--e10s'], 04:08:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:58 INFO - 'tests': ['damp', 'tps']}, 04:08:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:58 INFO - 'talos_options': ['--e10s'], 04:08:58 INFO - 'tests': ['damp', 'tps']}, 04:08:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:08:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:58 INFO - 'other': {'tests': ['a11yr', 04:08:58 INFO - 'ts_paint', 04:08:58 INFO - 'tpaint', 04:08:58 INFO - 'sessionrestore', 04:08:58 INFO - 'sessionrestore_no_auto_restore']}, 04:08:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:08:58 INFO - 'tests': ['a11yr', 04:08:58 INFO - 'ts_paint', 04:08:58 INFO - 'tpaint', 04:08:58 INFO - 'sessionrestore', 04:08:58 INFO - 'sessionrestore_no_auto_restore']}, 04:08:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:08:58 INFO - 'tests': ['a11yr', 04:08:58 INFO - 'ts_paint', 04:08:58 INFO - 'tpaint', 04:08:58 INFO - 'sessionrestore', 04:08:58 INFO - 'sessionrestore_no_auto_restore']}, 04:08:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:08:58 INFO - 'tests': ['a11yr', 04:08:58 INFO - 'ts_paint', 04:08:58 INFO - 'tpaint', 04:08:58 INFO - 'sessionrestore', 04:08:58 INFO - 'sessionrestore_no_auto_restore']}, 04:08:58 INFO - 'other_l64': {'tests': ['a11yr', 04:08:58 INFO - 'ts_paint', 04:08:58 INFO - 'tpaint', 04:08:58 INFO - 'sessionrestore', 04:08:58 INFO - 'sessionrestore_no_auto_restore']}, 04:08:58 INFO - 'other_nol64': {'tests': ['a11yr', 04:08:58 INFO - 'ts_paint', 04:08:58 INFO - 'tpaint', 04:08:58 INFO - 'sessionrestore', 04:08:58 INFO - 'sessionrestore_no_auto_restore']}, 04:08:58 INFO - 'svgr': {'tests': ['tsvgx', 04:08:58 INFO - 'tsvgr_opacity', 04:08:58 INFO - 'tart', 04:08:58 INFO - 'tscrollx', 04:08:58 INFO - 'cart']}, 04:08:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:08:58 INFO - 'tests': ['tsvgx', 04:08:58 INFO - 'tsvgr_opacity', 04:08:58 INFO - 'tart', 04:08:58 INFO - 'tscrollx', 04:08:58 INFO - 'cart']}, 04:08:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:58 INFO - 'tests': ['tp5o']}, 04:08:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:58 INFO - 'talos_options': ['--e10s'], 04:08:58 INFO - 'tests': ['tp5o']}, 04:08:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:58 INFO - 'talos_options': ['--xperf_path', 04:08:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:58 INFO - 'tests': ['tp5n']}, 04:08:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:58 INFO - 'talos_options': ['--e10s', 04:08:58 INFO - '--xperf_path', 04:08:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:58 INFO - 'tests': ['tp5n']}}, 04:08:58 INFO - 'talos.zip': {'path': '', 04:08:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:58 INFO - Running post-action listener: _resource_record_post_action 04:08:58 INFO - ##### 04:08:58 INFO - ##### Running create-virtualenv step. 04:08:58 INFO - ##### 04:08:58 INFO - Running pre-action listener: _resource_record_pre_action 04:08:58 INFO - Running main action method: create_virtualenv 04:08:58 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:58 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 04:08:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:58 INFO - Using real prefix '/usr' 04:08:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:58 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:00 INFO - Installing pip.................done. 04:09:00 INFO - Return code: 0 04:09:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f770d74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169f3d0>, '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 0x160aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b360>, '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': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', '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 04:09:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:09:00 INFO - Using env: {'DISPLAY': ':0', 04:09:00 INFO - 'HOME': '/home/cltbld', 04:09:00 INFO - 'LANG': 'en_US.UTF-8', 04:09:00 INFO - 'LANGUAGE': 'en_US:en', 04:09:00 INFO - 'LOGNAME': 'cltbld', 04:09:00 INFO - 'MAIL': '/var/mail/cltbld', 04:09:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:00 INFO - 'MOZ_NO_REMOTE': '1', 04:09:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:00 INFO - 'NO_EM_RESTART': '1', 04:09:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:00 INFO - 'PWD': '/builds/slave/test', 04:09:00 INFO - 'SHELL': '/bin/bash', 04:09:00 INFO - 'SHLVL': '1', 04:09:00 INFO - 'TERM': 'linux', 04:09:00 INFO - 'TMOUT': '86400', 04:09:00 INFO - 'USER': 'cltbld', 04:09:00 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', 04:09:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:00 INFO - '_': '/tools/buildbot/bin/python'} 04:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:01 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 04:09:01 INFO - Cleaning up... 04:09:01 INFO - Return code: 0 04:09:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:09:01 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')]} 04:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:01 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')]} 04:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:01 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 0x7f770d74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169f3d0>, '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 0x160aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b360>, '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': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', '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 04:09:01 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 04:09:01 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 04:09:01 INFO - Using env: {'DISPLAY': ':0', 04:09:01 INFO - 'HOME': '/home/cltbld', 04:09:01 INFO - 'LANG': 'en_US.UTF-8', 04:09:01 INFO - 'LANGUAGE': 'en_US:en', 04:09:01 INFO - 'LOGNAME': 'cltbld', 04:09:01 INFO - 'MAIL': '/var/mail/cltbld', 04:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:01 INFO - 'MOZ_NO_REMOTE': '1', 04:09:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:01 INFO - 'NO_EM_RESTART': '1', 04:09:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:01 INFO - 'PWD': '/builds/slave/test', 04:09:01 INFO - 'SHELL': '/bin/bash', 04:09:01 INFO - 'SHLVL': '1', 04:09:01 INFO - 'TERM': 'linux', 04:09:01 INFO - 'TMOUT': '86400', 04:09:01 INFO - 'USER': 'cltbld', 04:09:01 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', 04:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:01 INFO - '_': '/tools/buildbot/bin/python'} 04:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:01 INFO - Downloading/unpacking psutil>=0.7.1 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:01 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 04:09:03 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:09:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:09:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:03 INFO - Installing collected packages: psutil 04:09:03 INFO - Running setup.py install for psutil 04:09:03 INFO - building 'psutil._psutil_linux' extension 04:09:03 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 04:09:03 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 04:09:03 INFO - building 'psutil._psutil_posix' extension 04:09:03 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 04:09:03 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 04:09:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:03 INFO - Successfully installed psutil 04:09:03 INFO - Cleaning up... 04:09:03 INFO - Return code: 0 04:09:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:03 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 0x7f770d74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169f3d0>, '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 0x160aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b360>, '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': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', '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 04:09:03 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 04:09:03 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 04:09:03 INFO - Using env: {'DISPLAY': ':0', 04:09:03 INFO - 'HOME': '/home/cltbld', 04:09:03 INFO - 'LANG': 'en_US.UTF-8', 04:09:03 INFO - 'LANGUAGE': 'en_US:en', 04:09:03 INFO - 'LOGNAME': 'cltbld', 04:09:03 INFO - 'MAIL': '/var/mail/cltbld', 04:09:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:03 INFO - 'MOZ_NO_REMOTE': '1', 04:09:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:03 INFO - 'NO_EM_RESTART': '1', 04:09:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:03 INFO - 'PWD': '/builds/slave/test', 04:09:03 INFO - 'SHELL': '/bin/bash', 04:09:03 INFO - 'SHLVL': '1', 04:09:03 INFO - 'TERM': 'linux', 04:09:03 INFO - 'TMOUT': '86400', 04:09:03 INFO - 'USER': 'cltbld', 04:09:03 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', 04:09:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:03 INFO - '_': '/tools/buildbot/bin/python'} 04:09:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:03 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:09:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:09:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:09:05 INFO - Installing collected packages: mozsystemmonitor 04:09:05 INFO - Running setup.py install for mozsystemmonitor 04:09:06 INFO - Successfully installed mozsystemmonitor 04:09:06 INFO - Cleaning up... 04:09:06 INFO - Return code: 0 04:09:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f770d74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169f3d0>, '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 0x160aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b360>, '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': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', '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 04:09:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:09:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:09:06 INFO - Using env: {'DISPLAY': ':0', 04:09:06 INFO - 'HOME': '/home/cltbld', 04:09:06 INFO - 'LANG': 'en_US.UTF-8', 04:09:06 INFO - 'LANGUAGE': 'en_US:en', 04:09:06 INFO - 'LOGNAME': 'cltbld', 04:09:06 INFO - 'MAIL': '/var/mail/cltbld', 04:09:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:06 INFO - 'MOZ_NO_REMOTE': '1', 04:09:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:06 INFO - 'NO_EM_RESTART': '1', 04:09:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:06 INFO - 'PWD': '/builds/slave/test', 04:09:06 INFO - 'SHELL': '/bin/bash', 04:09:06 INFO - 'SHLVL': '1', 04:09:06 INFO - 'TERM': 'linux', 04:09:06 INFO - 'TMOUT': '86400', 04:09:06 INFO - 'USER': 'cltbld', 04:09:06 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', 04:09:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:06 INFO - '_': '/tools/buildbot/bin/python'} 04:09:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:06 INFO - Downloading/unpacking blobuploader==1.2.4 04:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:09:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:09 INFO - Downloading docopt-0.6.1.tar.gz 04:09:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:09:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:09 INFO - Running setup.py install for blobuploader 04:09:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:09 INFO - Running setup.py install for requests 04:09:09 INFO - Running setup.py install for docopt 04:09:09 INFO - Successfully installed blobuploader requests docopt 04:09:09 INFO - Cleaning up... 04:09:09 INFO - Return code: 0 04:09:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:09 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')]} 04:09:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:09 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')]} 04:09:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:09 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 0x7f770d74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169f3d0>, '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 0x160aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b360>, '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': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', '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 04:09:09 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 04:09:09 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 04:09:09 INFO - Using env: {'DISPLAY': ':0', 04:09:09 INFO - 'HOME': '/home/cltbld', 04:09:09 INFO - 'LANG': 'en_US.UTF-8', 04:09:09 INFO - 'LANGUAGE': 'en_US:en', 04:09:09 INFO - 'LOGNAME': 'cltbld', 04:09:09 INFO - 'MAIL': '/var/mail/cltbld', 04:09:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:09 INFO - 'MOZ_NO_REMOTE': '1', 04:09:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:09 INFO - 'NO_EM_RESTART': '1', 04:09:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:09 INFO - 'PWD': '/builds/slave/test', 04:09:09 INFO - 'SHELL': '/bin/bash', 04:09:09 INFO - 'SHLVL': '1', 04:09:09 INFO - 'TERM': 'linux', 04:09:09 INFO - 'TMOUT': '86400', 04:09:09 INFO - 'USER': 'cltbld', 04:09:09 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', 04:09:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:09 INFO - '_': '/tools/buildbot/bin/python'} 04:09:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:10 INFO - Running setup.py (path:/tmp/pip-VOzocx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:10 INFO - Running setup.py (path:/tmp/pip-AIiXKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:10 INFO - Running setup.py (path:/tmp/pip-JbY0nm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:10 INFO - Running setup.py (path:/tmp/pip-FAGm7L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:10 INFO - Running setup.py (path:/tmp/pip-DFxKLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:10 INFO - Running setup.py (path:/tmp/pip-84bCOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:10 INFO - Running setup.py (path:/tmp/pip-U37myY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:10 INFO - Running setup.py (path:/tmp/pip-7y_ao2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:10 INFO - Running setup.py (path:/tmp/pip-OoN8Mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:10 INFO - Running setup.py (path:/tmp/pip-rOp0fz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:10 INFO - Running setup.py (path:/tmp/pip-tBaUaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:10 INFO - Running setup.py (path:/tmp/pip-s53zym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:10 INFO - Running setup.py (path:/tmp/pip-ge7hoY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:10 INFO - Running setup.py (path:/tmp/pip-iWKMGd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:11 INFO - Running setup.py (path:/tmp/pip-0fbRHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:11 INFO - Running setup.py (path:/tmp/pip-5EDvGK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:11 INFO - Running setup.py (path:/tmp/pip-6tHCKL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:11 INFO - Running setup.py install for manifestparser 04:09:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:11 INFO - Running setup.py install for mozcrash 04:09:11 INFO - Running setup.py install for mozdebug 04:09:11 INFO - Running setup.py install for mozdevice 04:09:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:11 INFO - Running setup.py install for mozfile 04:09:11 INFO - Running setup.py install for mozhttpd 04:09:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:11 INFO - Running setup.py install for mozinfo 04:09:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:11 INFO - Running setup.py install for mozInstall 04:09:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:12 INFO - Running setup.py install for mozleak 04:09:12 INFO - Running setup.py install for mozlog 04:09:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:12 INFO - Running setup.py install for moznetwork 04:09:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:12 INFO - Running setup.py install for mozprocess 04:09:12 INFO - Running setup.py install for mozprofile 04:09:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:12 INFO - Running setup.py install for mozrunner 04:09:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:12 INFO - Running setup.py install for mozscreenshot 04:09:12 INFO - Running setup.py install for moztest 04:09:12 INFO - Running setup.py install for mozversion 04:09:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:13 INFO - Cleaning up... 04:09:13 INFO - Return code: 0 04:09:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f770d74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169f3d0>, '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 0x160aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b360>, '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': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', '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 04:09:13 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 04:09:13 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 04:09:13 INFO - Using env: {'DISPLAY': ':0', 04:09:13 INFO - 'HOME': '/home/cltbld', 04:09:13 INFO - 'LANG': 'en_US.UTF-8', 04:09:13 INFO - 'LANGUAGE': 'en_US:en', 04:09:13 INFO - 'LOGNAME': 'cltbld', 04:09:13 INFO - 'MAIL': '/var/mail/cltbld', 04:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:13 INFO - 'MOZ_NO_REMOTE': '1', 04:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:13 INFO - 'NO_EM_RESTART': '1', 04:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:13 INFO - 'PWD': '/builds/slave/test', 04:09:13 INFO - 'SHELL': '/bin/bash', 04:09:13 INFO - 'SHLVL': '1', 04:09:13 INFO - 'TERM': 'linux', 04:09:13 INFO - 'TMOUT': '86400', 04:09:13 INFO - 'USER': 'cltbld', 04:09:13 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', 04:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:13 INFO - '_': '/tools/buildbot/bin/python'} 04:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:13 INFO - Running setup.py (path:/tmp/pip-GZnpXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:13 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)) 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:13 INFO - Running setup.py (path:/tmp/pip-IgKr44-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:13 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)) 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:13 INFO - Running setup.py (path:/tmp/pip-hegvr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:13 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)) 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:13 INFO - Running setup.py (path:/tmp/pip-v1ZxxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:13 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)) 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:13 INFO - Running setup.py (path:/tmp/pip-VbDuZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:13 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)) 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:13 INFO - Running setup.py (path:/tmp/pip-ebNSEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:13 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)) 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:13 INFO - Running setup.py (path:/tmp/pip-SY71av-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:13 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)) 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:13 INFO - Running setup.py (path:/tmp/pip-0M1_W5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:13 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)) 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:13 INFO - Running setup.py (path:/tmp/pip-0pYeyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:13 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)) 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:13 INFO - Running setup.py (path:/tmp/pip-OEr1eN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:13 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)) 04:09:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:13 INFO - Running setup.py (path:/tmp/pip-hBZbDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:14 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)) 04:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:14 INFO - Running setup.py (path:/tmp/pip-ZIgGcn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:14 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)) 04:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:14 INFO - Running setup.py (path:/tmp/pip-m3FUzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:14 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)) 04:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:14 INFO - Running setup.py (path:/tmp/pip-NDT53X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:14 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)) 04:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:14 INFO - Running setup.py (path:/tmp/pip-VJwPn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:14 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)) 04:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:14 INFO - Running setup.py (path:/tmp/pip-Hd2cFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:14 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)) 04:09:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:14 INFO - Running setup.py (path:/tmp/pip-G9cJN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:14 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)) 04:09:14 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)) 04:09:14 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)) 04:09:14 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)) 04:09:14 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)) 04:09:14 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)) 04:09:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:16 INFO - Downloading blessings-1.5.1.tar.gz 04:09:16 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 04:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:16 INFO - Installing collected packages: blessings 04:09:16 INFO - Running setup.py install for blessings 04:09:16 INFO - Successfully installed blessings 04:09:16 INFO - Cleaning up... 04:09:16 INFO - Return code: 0 04:09:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:16 INFO - Reading from file tmpfile_stdout 04:09:16 INFO - Current package versions: 04:09:16 INFO - argparse == 1.2.1 04:09:16 INFO - blessings == 1.5.1 04:09:16 INFO - blobuploader == 1.2.4 04:09:16 INFO - docopt == 0.6.1 04:09:16 INFO - manifestparser == 1.1 04:09:16 INFO - mozInstall == 1.12 04:09:16 INFO - mozcrash == 0.16 04:09:16 INFO - mozdebug == 0.1 04:09:16 INFO - mozdevice == 0.47 04:09:16 INFO - mozfile == 1.2 04:09:16 INFO - mozhttpd == 0.7 04:09:16 INFO - mozinfo == 0.9 04:09:16 INFO - mozleak == 0.1 04:09:16 INFO - mozlog == 3.1 04:09:16 INFO - moznetwork == 0.27 04:09:16 INFO - mozprocess == 0.22 04:09:16 INFO - mozprofile == 0.28 04:09:16 INFO - mozrunner == 6.11 04:09:16 INFO - mozscreenshot == 0.1 04:09:16 INFO - mozsystemmonitor == 0.0 04:09:16 INFO - moztest == 0.7 04:09:16 INFO - mozversion == 1.4 04:09:16 INFO - psutil == 3.1.1 04:09:16 INFO - requests == 1.2.3 04:09:16 INFO - wsgiref == 0.1.2 04:09:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f770d74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169f3d0>, '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 0x160aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b360>, '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': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', '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 04:09:16 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 04:09:16 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 04:09:16 INFO - Using env: {'DISPLAY': ':0', 04:09:16 INFO - 'HOME': '/home/cltbld', 04:09:16 INFO - 'LANG': 'en_US.UTF-8', 04:09:16 INFO - 'LANGUAGE': 'en_US:en', 04:09:16 INFO - 'LOGNAME': 'cltbld', 04:09:16 INFO - 'MAIL': '/var/mail/cltbld', 04:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:16 INFO - 'MOZ_NO_REMOTE': '1', 04:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:16 INFO - 'NO_EM_RESTART': '1', 04:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:16 INFO - 'PWD': '/builds/slave/test', 04:09:16 INFO - 'SHELL': '/bin/bash', 04:09:16 INFO - 'SHLVL': '1', 04:09:16 INFO - 'TERM': 'linux', 04:09:16 INFO - 'TMOUT': '86400', 04:09:16 INFO - 'USER': 'cltbld', 04:09:16 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', 04:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:16 INFO - '_': '/tools/buildbot/bin/python'} 04:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:16 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)) 04:09:16 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)) 04:09:16 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)) 04:09:16 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)) 04:09:16 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)) 04:09:16 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)) 04:09:16 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)) 04:09:16 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)) 04:09:16 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)) 04:09:16 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)) 04:09:16 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)) 04:09:16 INFO - Cleaning up... 04:09:16 INFO - Return code: 0 04:09:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f770d74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169f3d0>, '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 0x160aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b360>, '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': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', '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 04:09:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:09:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:09:16 INFO - Using env: {'DISPLAY': ':0', 04:09:16 INFO - 'HOME': '/home/cltbld', 04:09:16 INFO - 'LANG': 'en_US.UTF-8', 04:09:16 INFO - 'LANGUAGE': 'en_US:en', 04:09:16 INFO - 'LOGNAME': 'cltbld', 04:09:16 INFO - 'MAIL': '/var/mail/cltbld', 04:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:16 INFO - 'MOZ_NO_REMOTE': '1', 04:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:16 INFO - 'NO_EM_RESTART': '1', 04:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:16 INFO - 'PWD': '/builds/slave/test', 04:09:16 INFO - 'SHELL': '/bin/bash', 04:09:16 INFO - 'SHLVL': '1', 04:09:16 INFO - 'TERM': 'linux', 04:09:16 INFO - 'TMOUT': '86400', 04:09:16 INFO - 'USER': 'cltbld', 04:09:16 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', 04:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:16 INFO - '_': '/tools/buildbot/bin/python'} 04:09:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:17 INFO - Downloading/unpacking jsonschema 04:09:17 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 04:09:17 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 04:09:17 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 04:09:17 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 04:09:17 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 04:09:17 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 04:09:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:18 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 04:09:18 INFO - Downloading/unpacking functools32 (from jsonschema) 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09:18 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:19 INFO - warning: no files found matching '*.txt' 04:09:19 INFO - no previously-included directories found matching 'build' 04:09:19 INFO - no previously-included directories found matching 'dist' 04:09:19 INFO - no previously-included directories found matching '.git*' 04:09:19 INFO - Installing collected packages: jsonschema, functools32 04:09:19 INFO - Running setup.py install for functools32 04:09:19 INFO - warning: no files found matching '*.txt' 04:09:19 INFO - no previously-included directories found matching 'build' 04:09:19 INFO - no previously-included directories found matching 'dist' 04:09:19 INFO - no previously-included directories found matching '.git*' 04:09:19 INFO - Successfully installed jsonschema functools32 04:09:19 INFO - Cleaning up... 04:09:19 INFO - Return code: 0 04:09:19 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f770d74ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x153d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x160cdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x169f3d0>, '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 0x160aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b360>, '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': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', '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 04:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:09:19 INFO - Using env: {'DISPLAY': ':0', 04:09:19 INFO - 'HOME': '/home/cltbld', 04:09:19 INFO - 'LANG': 'en_US.UTF-8', 04:09:19 INFO - 'LANGUAGE': 'en_US:en', 04:09:19 INFO - 'LOGNAME': 'cltbld', 04:09:19 INFO - 'MAIL': '/var/mail/cltbld', 04:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:19 INFO - 'MOZ_NO_REMOTE': '1', 04:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:19 INFO - 'NO_EM_RESTART': '1', 04:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:19 INFO - 'PWD': '/builds/slave/test', 04:09:19 INFO - 'SHELL': '/bin/bash', 04:09:19 INFO - 'SHLVL': '1', 04:09:19 INFO - 'TERM': 'linux', 04:09:19 INFO - 'TMOUT': '86400', 04:09:19 INFO - 'USER': 'cltbld', 04:09:19 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', 04:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:19 INFO - '_': '/tools/buildbot/bin/python'} 04:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:19 INFO - Downloading/unpacking flake8 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09:21 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:09:21 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 04:09:21 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:21 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:09:21 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 04:09:21 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:21 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 04:09:21 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:09:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:21 INFO - no previously-included directories found matching 'docs/_build' 04:09:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:09:21 INFO - Running setup.py install for pep8 04:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:09:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:09:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:09:21 INFO - no previously-included directories found matching 'docs/_build' 04:09:22 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:09:22 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:09:22 INFO - Cleaning up... 04:09:22 INFO - Return code: 0 04:09:22 INFO - Running post-action listener: _resource_record_post_action 04:09:22 INFO - Running post-action listener: _start_resource_monitoring 04:09:22 INFO - Starting resource monitoring. 04:09:22 INFO - ##### 04:09:22 INFO - ##### Running install step. 04:09:22 INFO - ##### 04:09:22 INFO - Running pre-action listener: _resource_record_pre_action 04:09:22 INFO - Running main action method: install 04:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:22 INFO - Reading from file tmpfile_stdout 04:09:22 INFO - Detecting whether we're running mozinstall >=1.0... 04:09:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:09:22 INFO - Reading from file tmpfile_stdout 04:09:22 INFO - Output received: 04:09:22 INFO - Usage: mozinstall [options] installer 04:09:22 INFO - Options: 04:09:22 INFO - -h, --help show this help message and exit 04:09:22 INFO - -d DEST, --destination=DEST 04:09:22 INFO - Directory to install application into. [default: 04:09:22 INFO - "/builds/slave/test"] 04:09:22 INFO - --app=APP Application being installed. [default: firefox] 04:09:22 INFO - mkdir: /builds/slave/test/build/application 04:09:22 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'] 04:09:22 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 04:09:38 INFO - Reading from file tmpfile_stdout 04:09:38 INFO - Output received: 04:09:38 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:38 INFO - Running post-action listener: _resource_record_post_action 04:09:38 INFO - ##### 04:09:38 INFO - ##### Running run-tests step. 04:09:38 INFO - ##### 04:09:38 INFO - Running pre-action listener: _resource_record_pre_action 04:09:38 INFO - Running main action method: run_tests 04:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:38 INFO - Python 2.7.3 04:09:38 INFO - Return code: 0 04:09:38 INFO - grabbing minidump binary from tooltool 04:09:38 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')]} 04:09:38 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 0x169f3d0>, '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 0x160aed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x160b360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:38 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 04:09:38 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 04:09:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:38 INFO - Return code: 0 04:09:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:09:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:09:39 INFO - Return code: 0 04:09:39 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/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:09:39 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/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --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 04:09:39 INFO - Using env: {'DISPLAY': ':0', 04:09:39 INFO - 'HOME': '/home/cltbld', 04:09:39 INFO - 'LANG': 'en_US.UTF-8', 04:09:39 INFO - 'LANGUAGE': 'en_US:en', 04:09:39 INFO - 'LOGNAME': 'cltbld', 04:09:39 INFO - 'MAIL': '/var/mail/cltbld', 04:09:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:39 INFO - 'MOZ_NO_REMOTE': '1', 04:09:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:39 INFO - 'NO_EM_RESTART': '1', 04:09:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:39 INFO - 'PWD': '/builds/slave/test', 04:09:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:39 INFO - 'SHELL': '/bin/bash', 04:09:39 INFO - 'SHLVL': '1', 04:09:39 INFO - 'TERM': 'linux', 04:09:39 INFO - 'TMOUT': '86400', 04:09:39 INFO - 'USER': 'cltbld', 04:09:39 INFO - 'XDG_SESSION_COOKIE': '4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369', 04:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:39 INFO - '_': '/tools/buildbot/bin/python'} 04:09:39 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/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--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 04:09:39 INFO - mozversion application_buildid: 20160113025531 04:09:39 INFO - mozversion application_changeset: da1d2c63b0686a11be1b14c6e1f76a4875bb0e64 04:09:39 INFO - mozversion application_display_name: Nightly 04:09:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:39 INFO - mozversion application_name: Firefox 04:09:39 INFO - mozversion application_remotingname: firefox 04:09:39 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:09:39 INFO - mozversion application_vendor: Mozilla 04:09:39 INFO - mozversion application_version: 46.0a1 04:09:39 INFO - mozversion platform_buildid: 20160113025531 04:09:39 INFO - mozversion platform_changeset: da1d2c63b0686a11be1b14c6e1f76a4875bb0e64 04:09:39 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:09:39 INFO - mozversion platform_version: 46.0a1 04:09:39 INFO - using testdate: 1452686979 04:09:39 INFO - actual date: 1452686979 04:09:39 INFO - starting webserver on 'localhost:36461' 04:09:39 INFO - SUITE-START | Running 3 tests 04:09:39 INFO - TEST-START | dromaeo_css 04:09:39 INFO - operating with platform_type : linux_ 04:09:39 INFO - Initialising browser for dromaeo_css test... 04:09:39 INFO - TEST-INFO | started process 23524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpekiNv7/profile http://localhost:36461/getInfo.html) 04:09:43 INFO - PROCESS | 23524 | 04:09:43 INFO - PROCESS | 23524 | (process:23604): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:09:44 INFO - PROCESS | 23524 | __metrics Screen width/height:1600/1200 04:09:44 INFO - PROCESS | 23524 | colorDepth:24 04:09:44 INFO - PROCESS | 23524 | Browser inner width/height: 1024/697 04:09:44 INFO - PROCESS | 23524 | __metrics 04:09:44 INFO - PROCESS | 23524 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:09:45 INFO - TEST-INFO | 23524: exit 0 04:09:45 INFO - Browser initialized. 04:09:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:45 INFO - TEST-INFO | started process 23653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpekiNv7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:46 INFO - PROCESS | 23653 | 04:09:46 INFO - PROCESS | 23653 | (process:23709): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:09:57 INFO - PROCESS | 23653 | RSS: Main: 150126592 04:09:57 INFO - PROCESS | 23653 | 04:10:46 INFO - PROCESS | 23653 | 1452687046807 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] 04:12:58 INFO - PROCESS | 23653 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36461/tests/dromaeo/cssquery-ext.html) 04:12:59 INFO - PROCESS | 23653 | RSS: Main: 153964544 04:12:59 INFO - PROCESS | 23653 | 04:16:01 INFO - PROCESS | 23653 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-ext.html (next: http://localhost:36461/tests/dromaeo/cssquery-jquery.html) 04:16:02 INFO - PROCESS | 23653 | RSS: Main: 151207936 04:16:02 INFO - PROCESS | 23653 | 04:19:04 INFO - PROCESS | 23653 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36461/tests/dromaeo/cssquery-mootools.html) 04:19:04 INFO - PROCESS | 23653 | RSS: Main: 151478272 04:19:04 INFO - PROCESS | 23653 | 04:22:06 INFO - PROCESS | 23653 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36461/tests/dromaeo/cssquery-prototype.html) 04:22:06 INFO - PROCESS | 23653 | RSS: Main: 150646784 04:22:06 INFO - PROCESS | 23653 | 04:25:09 INFO - PROCESS | 23653 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36461/tests/dromaeo/cssquery-yui.html) 04:25:10 INFO - PROCESS | 23653 | RSS: Main: 151527424 04:25:10 INFO - PROCESS | 23653 | 04:28:12 INFO - PROCESS | 23653 | Cycle 1(1): loaded http://localhost:36461/tests/dromaeo/cssquery-yui.html (next: http://localhost:36461/tests/dromaeo/cssquery-dojo.html) 04:28:12 INFO - PROCESS | 23653 | RSS: Main: 153296896 04:28:12 INFO - PROCESS | 23653 | 04:28:12 INFO - PROCESS | 23653 | __start_tp_report 04:28:12 INFO - PROCESS | 23653 | _x_x_mozilla_page_load 04:28:12 INFO - PROCESS | 23653 | _x_x_mozilla_page_load_details 04:28:12 INFO - PROCESS | 23653 | |i|pagename|runs| 04:28:12 INFO - PROCESS | 23653 | |0;dojo.html;2610.6997695265045;2635.8418494890298;2679.3837417393997;2682.9865850670744;2697.0560303893635;4508.233600287951;4511.097780443916;4568.314752787083;4585.908281834366;4607.58531732144;4535.863924082275;4574.725516469014;4610.170169369512;4668.183067963101;4675.947911719862;4118.670506359484;4215.957840421587;4264.189803937257;4282.229198744232;4329.826806927735;4293.141371725667;4305.24658184818;4341.522432532434;4348.152110338485;4369.672274579403;4101.979490102545;4190.078182799779;4207.221663992172;4250.851220207278;4264.850730224427;4230.894227644303;4248.362745588156;4261.701680882339;4278.614924656796;4280.486341638992;4092.3043082675717;4221.5567365426805;4224.387463817729;4240.257954857888;4263.275243208662;4412.294032954744;4489.551044895517;4514.503404625489;4517.59341659249;4553.043860789238;4937.654364194508;4955.702657840541;4958.677685950438;4959.900801983977;4977.178765503688;4808.687435316693;4896.094222568836;4961.404631444214;4972.651914365996;5026.070177017264;4530.320451932236;4537.069900670354;4559.156556037111;4568.063546972862;4573.199690054227;5059.671121377099;5068.23976403535;5080.390353157571;5095.923561146586;5103.081445339874;4752.524747525289;4819.469858315582;4830.203016502308;4862.465128835825;4869.9513004870205;4921.409430868319;4925.990172014728;4943.1596628573225;4950.3069570260195;4973.030259099513;4869.257845273995;4869.391326084239;4871.707697538159;4879.707217566957;4918.213085906238;4727.550882666142;4766.261229509431;4796.25658023007;4854.466008739036;4896.681715688469;4054.4526488923616;4063.349864021742;4066.694997875112;4068.9796551017057;4087.5299340576216;3604.8377822998027;3614.548181477315;3635.527381440396;3642.2897534980953;3647.398179300386;4212.768297743653;4271.402003719481;4272;4309.332053531708;4338.327559228324;4914.164592019365;4940.110780059552;4952.603791696728;4955.231939049453;4986.626003049786;4202.600752928467;4276.358546218092;4286.699931004862;4286.742795432284;4321.58944900234;4297.699161058758;4339.978300108479;4391.626711729475;4396.692231543761;4421.911561768811;4640.512746161605;4644.256918892961;4649.209634362099;4691.554302341272;4692.906141877212;4822.276658501253;4894.2658601210105;4895.779689913891;4907.043126590281;4911.214205727067;4651.162790697707;4662.836800711959;4669.696469729457;4696.38946936896;4732.5030871759345;4846.248831431134;4861.927071093865;4881.633877459276;4889.095517329305;4890.462049174659;4848.5636292733825;4933.605311574994;4956.008798240294;4975.253711943237;5032.6980381177245;4775.928361074517;4799.136155492045;4808.110499557593;4820.108279968217;4829.73436460998;4746.620270378292;4747.264174053027;4772.761361931959;4794.30482580017;4848.393950756155;4595.770211489479;4640.83757068501;4676.532346765296;4702.365180700562;4712.905741885212;4761.76191190446;4771.117343291502;4781.211100168573;4796.35249241348;4822.204336284473;4640.025594625166;4663.370444989883;4663.696859704109;4671.43942726875;4692.225782745809 04:28:12 INFO - PROCESS | 23653 | |1;ext.html;498.0561835322065;504.10521324648744;505.11100463184783;505.6132058974885;521.9295395121659;35461.290774184534;36190.81904590477;36205;36311.4553281701;36450.45324320137;39598.80200599;40088;40148.79925600368;40342.79828600853;40486.59513404872;7743.457957942946;7875.684972601089;7929.5242285463055;7936.047674279094;7955.920440795576;7795.14253432122;7962.203779622049;7962.880556791623;7968.04383473981;7968.840623187532;7962.084360298553;8054.114047454805;8063.15336889624;8066.395020373466;8068.435209535335;7849.45053846231;7926.286634202949;7929.4052946028705;7950.801229969239;7956.443048986574;7618.123915749704;7704.26809453101;7729.497582657109;7750.922490775077;7766.262205090507;33181;33396.83301583477;33427.331453371036;33559.49660755091;33588.16029599255;2197.494576247456;2520.3195137313005;2550.1074623881677;2712.905048323319;2718.1573712149097;28089.438211235865;28778.28054298659;28944.42111157786;29215;30120.8493957531;3249.1877030742316;3280.376728421616;3282.606087269543;3307.884224052171;3383.7969721816526;207144;209002;209239;209635;209890.75273118142;48700;50416.747916260916;63578;65254;65296.34703652903;62418.687906560175;62720.686396568635;63018.36981630217;63199.04810470845;63360.68319658464;13503.12229705066;13587.728245435233;13600.591982240549;13668.31658417095;13694.794578081337;10197.643082492077;10270.897291027144;10327.380357178594;10330.845037324447;10371.325863818827;19887.900560497106;20257.290994815405;20394.59210815805;20562.074706638236;20601.175952961712;8178.754637360888;8451.830963380698;8594.914050859412;8609.655613775503;8650.87023694645;743.9888401673979;760.8097975506123;787.8030492376906;801.2028032107974;852.3692467573951;22660.773392266197;22831.429214269778;27215;28923.56614650782;29268;877.1579283887539;886.7162507997378;903.643060990918;921.2629896083107;963.7349728824629;12028.939855300667;12161.756764864653;12186.51253949832;12217.816732749016;12357.567485137977;332152;333187;334207;336894;337838;46456;46849.29726054112;47067.293990590166;47237;47410.762946185045;1144.9313041217554;1156.9942150289194;1167.7897978363806;1176.758764453285;1189.3577468167266;25225.87387063053;25614.23157305284;25663.615045774703;25794.61308080343;25925.22224333273;38823.805880970416;39563;39713.00717482086;39878.60121398865;39985.80007100062;248491;250378;250509;250697;251411;28728.425431491672;38287;38861.05694715196;39042.41436378514;39156;33088.66911330856;34451.82774086113;34480.65519344775;41307.7934610325;42587.5741242596;33145.50281745824;33599.66400336063;34398.14004649904;34533;34791;29971.100866974026;30143.698563014965;30498.542521862633;30508.694913051473;30533.54199687051;31115;31362.372752545278;31427;34340.313193735485;35241.64758352384;26160.34599135037;27354.316142096606;27398.452030959666;27910.72089279081;29932.551011734406;23366.299011029696;23391;23421.297361079196;23522.29433117009;23523.647145292492 04:28:12 INFO - PROCESS | 23653 | |2;jquery.html;343.93465241604093;344.3440246330739;351.8698081709767;352.4959308189289;359.99640003599956;14584.70830583389;14768.483103091394;15048.623784405396;15540.53378398647;16331.510054698363;9885;10187.388756674605;12179.695507612314;15221.695566088672;15249.39002439901;4502.662300327472;4703.6237101032;4705.788239529229;5107.38711354638;5353.973230133844;5276.841694749144;5325.467453254663;5348.411674715778;5349.063913815086;5354.705491197982;4962.305277261186;5164.251183578379;5189.117849965496;5192.169252919533;5487.5609951203805;5124.4106927703415;5127.256547800566;5137.383513978347;5154.793808247666;5174.793008279683;4737.407824021997;4932.2108462646165;4935.851924442237;4949.925751113737;4950.405951285833;11309.264897781617;11429.257098288585;16729.414470493597;18238.544036399064;18343.81656183448;1686.966260674792;1716.150505499773;1764.303100275384;1779.9555011124826;1796.4520821149545;8385.329173666092;8436.957815210884;8813;9004.369694121415;9182.586783594754;1624.951251462458;1660.6761681472117;1700.047973135036;1711.4266720648598;1751.5883767314672;47426.52573474256;51162.23256651116;51908;51939.22091168635;52159.73920130375;9746.853797193047;9813.607455701693;9855.90144098564;9900.207983361313;9906.851397229048;12259.877401226053;12265.877341226653;12288.692782680326;12328.260304381765;12410.255384676948;6785.389314961677;6941.167059952838;6969;6986.008987438556;7014.684339204748;6591;6613.966930165318;6624.867502650017;6671.266160722316;6683.198016237985;4176.477940257468;4184.4141820145205;4185.58144185579;4212.326027835532;4241.830326786956;1740.1473278093642;1804.864635152369;1807.150639199574;1816.0647266657681;1837.9431826699433;758.9734359297508;836.272442974616;887.4675194883148;916.0564618443015;952.5951470624957;13993.230372329619;14062.367193476319;14295;14436.783448248285;14604.269786510631;790.2887401338841;833.2833762963846;883.969061082859;925.3430064654036;940.3135710930922;8536.530490822941;8882.689105881263;9062.546872656341;9295.395799273025;9350.485723285148;524154;530397;530793;548018;548034;65178.67410663011;66457.33542664608;67180.6640966792;67227;67664.6616766913;1093.3822390349585;1108.4845546820768;1112.7329440934118;1121.8541589593137;1125.2685754259796;13210.735785284432;13744.106633068819;13892.88856891426;14051;14138.929305353407;28324;28616.284592885346;28748.281292967844;29228.26929326784;29648;31223.063308100795;31543.369132617678;31636.841815790773;31668.683313167494;32725;6825.2151002633345;6972.302769722987;7076.716931322895;7251.963740181265;7315.780526584211;8647.351448641502;8974.326925480746;9782.706518804447;10049.447280399649;10226.539805708611;5373.146264538728;7682.308592226726;8473.576321183793;8545.359098067545;8583.313334933315;2583.4316450380884;3163.098516922666;5994.400559944145;8564;8715.694950676696;8717.520536370306;8740.562971851508;8836.823263534821;8860.246879015098;8864.556772161237;6693.933060669526;6927.480438967198;6936.0636314096955;6937.722491100501;7011.368976792113;7165.319294666998;8639.568021598769;8709.433886797338;8804.163604457566;8804.515751633722 04:28:12 INFO - PROCESS | 23653 | |3;mootools.html;1369.5959691890894;1369.7602919489086;1502.6168327076593;1750.9912450437762;1771.024678540053;6350.237971443422;6502.414782669559;7397.371223446007;7578.848423031536;7592.772216833497;7088.113985751781;7229.445669181125;7295.8540829183385;7296.598687072209;7325.853482930338;2134.5197330600645;2184.661377486484;2185.7814218578173;2186.7157269554937;2187.7812218778154;2132.1791110422523;2146.914123435061;2156.0513374115417;2159.9568008639817;2160.4274867160216;2170.8046275835172;2170.8697478151284;2180.2260197629853;2183.5632873425297;2222.088943533152;2211.1818627107914;2219.123446238743;2225.944351391212;2229.1194977983605;2230.4423894026495;2120.957580848374;2130.5525839573706;2138.4119367173994;2141.7001619773246;2142.7535833379206;7313.744018959364;7317.085364329459;7377.59423231722;7377.963110184414;7380.225076366958;4323.978380108111;4438.866833994985;4440.378347031418;4446.688731788776;4448.621867141297;2869.827810331366;2882.2362074050393;2934.501134807088;2947.9263018424494;2948.764098872085;883.3860466975455;889.8477813460058;901.5537309032005;920.4293338130402;926.583037633061;10402.427866467342;10441.68674939753;10562.894371056345;10565.788684226349;10569.73575660607;4178.143480586473;4256.106217694257;4256.851010214627;4264.360345948071;4277.294246449301;8885.866711999326;8926.821463570823;8927.598258078402;8940.374173807772;8950.597223124974;4514.119746649438;4515.435570553681;4516.909661806745;4524.343970124313;4535.31970204472;3455.0844026333043;3515.244222492125;3854.9036274093373;4070.409790580349;4072.53165885921;3575.213453040327;3609.7473176877893;3621.728370372233;3625.057485053905;3659.341318562631;1146.266389510714;1157.4849192109598;1164.394514852272;1169.3977601535216;1169.4678921090883;1117.0560876059717;1117.1007339091946;1118.4799068433217;1120.9719757005978;1154.4574050196395;6807.863842723118;6809.489288303298;6825.1127353443735;6841.3842754152365;6845.0759147514445;430.66838534328394;435.4513313225359;437.0930319586806;439.59337612708117;442.3166208208326;5277.551408130352;5290.68255904647;5297.417284098746;5319.308489896366;5319.654222475527;8929.285657147413;9114.316426268057;9237.3533852631;9354.812903741888;9406.200472959876;9253.259739220846;9284.814303713887;9330.720078397659;9331.300152488455;9364.344495885223;6966;7011.719531218796;7056.188538318159;7251.202367739545;7261.491695581364;6673.366030227121;6741.629210393476;6773.322667733384;6774.830629234309;6814.625195614289;8013.077693661118;8133.389995750224;8140.83718325642;8213.096559378344;8288.336933045463;8186.7953301167945;8537.890074290302;8563.95718021406;8573.485590864568;8623.65505379803;5422.8644283891645;6296.653684047421;6374.745010199726;6441.291457939529;6541.280459149585;6751.426128778912;6778.7288508459105;6784.219814721173;6805.761798337035;6831.385175334244;6425.935740642533;6519.445847103049;6615.6030638161865;6685.064091027163;6709.959956206796;6244.063390491463;6295.338989406229;6391.58454700443;6398.424141827258;6409.935900640934;6559.639219842955;6639.734410623714;6649.501287403367;6660.800175994728;6662.866742665216;6122.571420000557;6168.074788781719;6170.475509581735;6193.6903154841175;6197.318294987638;6142.2629284484365;6171;6214.782482613087;6221.657808820377;6223.533235007302 04:28:12 INFO - PROCESS | 23653 | |4;prototype.html;304.5523081070826;309.2238481411656;311.7350252285556;319.64040454488685;324.4954096380128;5496.148097044955;5651.152327150924;5677.261955945732;5681.517071048956;5687.431256874311;5490.56075513959;5510.669359838413;5515;5532.059549876531;5532.612717109804;4129.525104612978;4223.936640950388;4269.978650106761;4284.207421627001;4297;4228.112096459748;4230.069384735353;4230.7038507304505;4243.215005224028;4281.764502952336;4239.745615263078;4241.0669652676515;4241.597048280424;4242.321228603424;4253.553376895427;4208.0531880326835;4213.91572168558;4227.112306415641;4243.830246790125;4248.766317852517;3551.8756843510355;3671.9816400918094;3701.5373078365205;3705.6664900159117;3707.0361705956375;5209.6874187548865;5282.286891269706;5289.3123893893935;5340.371186788028;5341.359036915556;4788.880277993043;4880.975595122001;4882.170031094723;4883.706977581356;4897.755112244374;5810.767569297223;5840.182374467578;5845.181674565564;5851.975904216745;5853.5902486825935;3909.5113110861143;4004.599540046001;4012.3179059559943;4017.678585713136;4027.8590249341423;6079.361667024988;6118.388161183935;6131.110988906628;6136.110264011738;6161.6303021818385;4035.6569691575955;4058.939115913264;4059.0258337998666;4060.3097473428998;4063.045184381668;4082.591740825894;4104.445899803488;4112.177564487115;4129.236091323115;4133.194027164674;4588.655850811202;4751.837913749305;4777.641676874248;4783.1390349736685;4785.9042819144115;5786.479216870502;5816.970915145397;5817.680027598522;5825;5831.3877042910735;1456.8980171388114;1485.442958890416;1487.7470829958934;1488.471592584617;1488.5311126995177;978.9461579613047;1006.5219020965129;1014.2899970021015;1015.664830605913;1017.0795430135739;5078.923816142761;5107.310513080686;5108.846734597893;5121.769520371592;5123.743812809419;6049;6066.75732970685;6069.0592958091565;6069.817905462844;6070.544709146831;5082.110630639697;5108.131617625013;5110.8466745997675;5110.897782044338;5120.7951681933055;3198.072558957876;3237.239248776583;3256.5929258842643;3281.261716113855;3287.408266512003;5602.411746766612;5704.401037891044;5711.8000869969355;5714.342850572154;5777.711114444261;6299.244090709052;6310.305866354697;6313.526485513513;6317.96841015792;6321.936780632227;5734.111212761862;5739.885202295931;5768.077107662838;5769.567282453832;5779.162021506858;5945.762169513171;6071.089336599545;6094.14681944537;6099.84750381244;6105.694715264308;5970;5970.791022314198;5972.8805423892145;5973.253343332083;5973.611715238496;5728.828135155952;5754.3670196277535;5777.364489906191;5787.884242315046;5793.304803423448;4120.175964806991;4162.14675991415;4167.395727619539;4174.540800512002;4181.059261666101;5946.940530594812;6117.663528505975;6123.693815309128;6128.479079278133;6130.754769809158;5879.323877753942;5887;5894.557908156819;5902.085176797603;5916.881662366814;5872.354041055566;5880.558958078076;5891.705414729332;5895.174675545512;5900.852478688067;5610.803621873215;5747.224124743273;5752.6836024019085;5760.683162426107;5762.962666720031;5849.181114643869;5916.526677865846;5931.169636251015;5937.614055086578;5942.138389933349;5709.543236540983;5725.370209276893;5751.856203594776;5755.251817263897;5764.481196692318 04:28:12 INFO - PROCESS | 23653 | |5;yui.html;595.1964847455935;626.2203556572067;630.5901164243244;702.1328659106007;722.9047992291679;10862.185336099794;10959.452027398638;11000.339979601209;11048.508451359074;11071;12714.98280137589;13052.086353955227;13069.934650326735;13101.803472947913;13120.934395328033;726.5858460677402;739.7041183526578;740.3632875726871;741.3513175971025;773.9961300193492;790.3242727468019;792.0851416613791;793.7658390774707;795.2802713544252;795.5425630262594;811.180707485441;816.5549775372407;818.7461886815076;819.7909533069089;819.8442295963748;809.1625167951142;811.4765975945512;812.358236992775;812.5368539932241;812.9918700813005;604.9183360246354;606.5663050918614;608.333874407523;608.8356143841182;610.3164455809522;12477.937610311981;12509.249445033236;12518.874811251862;12519.56181533642;12535.498580056787;11330.660080197607;11369.2609980351;11570.884291157065;11590.420478976102;11931.821022684666;9144.8628270576;9175.678851240174;9218.492982885939;9219.723408297694;9277.396969196981;3230.5800245967876;3235.902922912316;3240.7083362497488;3299.406106900757;3363.1423986883433;39699.20601587952;39867.99999999971;40464;40590.39114413286;40624.59375406238;9112.726618201465;9159.084091590788;9207.677731279373;9313.161815436642;9346.15884570392;15860.127692976766;15993.680126397407;16043.037417754973;16052.919735401249;16072.678546429006;5971.5222782177325;6093.573449858467;6126.479249263863;6175.84560385994;6233.781817636361;3474.756767026284;3552.6980206682206;3578.5526809148855;3619.077135330474;3751.0809851586537;2694.6362241097595;2750.1612008337247;2756.1731480556155;2760.6748760594623;2763.544015237463;499.16639212515184;501.4459022779849;504.66187654271727;507.12014654574284;512.0961502947301;437.2763077107392;456.32463953348565;515.3094852897136;613.9065785670841;630.1021045010841;7187.353138217585;7513.543769865813;7583.27958843909;7690.769276921701;7700.306972372513;467.70300858954806;517.4437479709328;528.5084871069865;529.761607276727;602.8975074237391;3565.2512972275595;3590.1563132663805;3665.4501824726503;3750.3249415105543;3814.3515602347666;46049;46091.76954115275;46307.53692463099;46503.76748116238;46535;42046.36930446046;42868;43039.784801075795;43105.13789724251;43118.78440607777;37870.810645947146;37942;38324.425133623015;38607.42088868669;39005;7381.483296169431;7478.813029674084;7550.697972081055;7572.8485430292185;7603.429742769204;29098.127056188347;29437;29692;29910;30704.999999999105;35409.468857967666;36819.81590092032;37114.44328335023;37381.813090934374;37515.6248437523;9980.750481238027;10069.144122749649;10248.48757562104;10261.692149235534;10488.580456781643;11287.43562821872;11315.943420282845;11346.149038821955;11374.431278435879;11455.427228638702;9642;9665.130138287588;9711.125998660154;9793.167580755431;9919.40483570988;9926.205903527556;10241.948790256001;10701.411422371844;10801.891981080404;10815.35107893529;7924.167962363868;8083.820390576727;8130.796730081559;8360.372972027244;8367.246947774729;8719.694810681596;8853.867191992254;8928.86606700887;8950.955245223733;8967.865482017645;8113.472624279403;8557.871631925402;8644.827103458021;8729.693477072778;8760.649574017223 04:28:12 INFO - PROCESS | 23653 | __end_tp_report 04:28:12 INFO - PROCESS | 23653 | __start_cc_report 04:28:12 INFO - PROCESS | 23653 | _x_x_mozilla_cycle_collect,316 04:28:12 INFO - PROCESS | 23653 | __end_cc_report 04:28:12 INFO - PROCESS | 23653 | __startTimestamp1452688092866__endTimestamp 04:28:12 INFO - PROCESS | 23653 | 04:28:12 INFO - PROCESS | 23653 | ------- Summary: start ------- 04:28:12 INFO - PROCESS | 23653 | Number of tests: 6 04:28:12 INFO - PROCESS | 23653 | 04:28:12 INFO - PROCESS | 23653 | [#0] dojo.html Cycles:165 Average:4542.20 Median:4663.70 stddev:465.93 (10.0%) stddev-sans-first:442.04 04:28:12 INFO - PROCESS | 23653 | Values: 2610.7 2635.8 2679.4 2683.0 2697.1 4508.2 4511.1 4568.3 4585.9 4607.6 4535.9 4574.7 4610.2 4668.2 4675.9 4118.7 4216.0 4264.2 4282.2 4329.8 4293.1 4305.2 4341.5 4348.2 4369.7 4102.0 4190.1 4207.2 4250.9 4264.9 4230.9 4248.4 4261.7 4278.6 4280.5 4092.3 4221.6 4224.4 4240.3 4263.3 4412.3 4489.6 4514.5 4517.6 4553.0 4937.7 4955.7 4958.7 4959.9 4977.2 4808.7 4896.1 4961.4 4972.7 5026.1 4530.3 4537.1 4559.2 4568.1 4573.2 5059.7 5068.2 5080.4 5095.9 5103.1 4752.5 4819.5 4830.2 4862.5 4870.0 4921.4 4926.0 4943.2 4950.3 4973.0 4869.3 4869.4 4871.7 4879.7 4918.2 4727.6 4766.3 4796.3 4854.5 4896.7 4054.5 4063.3 4066.7 4069.0 4087.5 3604.8 3614.5 3635.5 3642.3 3647.4 4212.8 4271.4 4272.0 4309.3 4338.3 4914.2 4940.1 4952.6 4955.2 4986.6 4202.6 4276.4 4286.7 4286.7 4321.6 4297.7 4340.0 4391.6 4396.7 4421.9 4640.5 4644.3 4649.2 4691.6 4692.9 4822.3 4894.3 4895.8 4907.0 4911.2 4651.2 4662.8 4669.7 4696.4 4732.5 4846.2 4861.9 4881.6 4889.1 4890.5 4848.6 4933.6 4956.0 4975.3 5032.7 4775.9 4799.1 4808.1 4820.1 4829.7 4746.6 4747.3 4772.8 4794.3 4848.4 4595.8 4640.8 4676.5 4702.4 4712.9 4761.8 4771.1 4781.2 4796.4 4822.2 4640.0 4663.4 4663.7 4671.4 4692.2 04:28:12 INFO - PROCESS | 23653 | 04:28:12 INFO - PROCESS | 23653 | [#1] ext.html Cycles:180 Average:42467.61 Median:170610.90 stddev:70809.09 (41.5%) stddev-sans-first:70937.61 04:28:12 INFO - PROCESS | 23653 | Values: 498.1 504.1 505.1 505.6 521.9 35461.3 36190.8 36205.0 36311.5 36450.5 39598.8 40088.0 40148.8 40342.8 40486.6 7743.5 7875.7 7929.5 7936.0 7955.9 7795.1 7962.2 7962.9 7968.0 7968.8 7962.1 8054.1 8063.2 8066.4 8068.4 7849.5 7926.3 7929.4 7950.8 7956.4 7618.1 7704.3 7729.5 7750.9 7766.3 33181.0 33396.8 33427.3 33559.5 33588.2 2197.5 2520.3 2550.1 2712.9 2718.2 28089.4 28778.3 28944.4 29215.0 30120.8 3249.2 3280.4 3282.6 3307.9 3383.8 207144.0 209002.0 209239.0 209635.0 209890.8 48700.0 50416.7 63578.0 65254.0 65296.3 62418.7 62720.7 63018.4 63199.0 63360.7 13503.1 13587.7 13600.6 13668.3 13694.8 10197.6 10270.9 10327.4 10330.8 10371.3 19887.9 20257.3 20394.6 20562.1 20601.2 8178.8 8451.8 8594.9 8609.7 8650.9 744.0 760.8 787.8 801.2 852.4 22660.8 22831.4 27215.0 28923.6 29268.0 877.2 886.7 903.6 921.3 963.7 12028.9 12161.8 12186.5 12217.8 12357.6 332152.0 333187.0 334207.0 336894.0 337838.0 46456.0 46849.3 47067.3 47237.0 47410.8 1144.9 1157.0 1167.8 1176.8 1189.4 25225.9 25614.2 25663.6 25794.6 25925.2 38823.8 39563.0 39713.0 39878.6 39985.8 248491.0 250378.0 250509.0 250697.0 251411.0 28728.4 38287.0 38861.1 39042.4 39156.0 33088.7 34451.8 34480.7 41307.8 42587.6 33145.5 33599.7 34398.1 34533.0 34791.0 29971.1 30143.7 30498.5 30508.7 30533.5 31115.0 31362.4 31427.0 34340.3 35241.6 26160.3 27354.3 27398.5 27910.7 29932.6 23366.3 23391.0 23421.3 23522.3 23523.6 04:28:12 INFO - PROCESS | 23653 | 04:28:12 INFO - PROCESS | 23653 | [#2] jquery.html Cycles:180 Average:25878.23 Median:5181.96 stddev:87582.54 (1690.1%) stddev-sans-first:87807.24 04:28:12 INFO - PROCESS | 23653 | Values: 343.9 344.3 351.9 352.5 360.0 14584.7 14768.5 15048.6 15540.5 16331.5 9885.0 10187.4 12179.7 15221.7 15249.4 4502.7 4703.6 4705.8 5107.4 5354.0 5276.8 5325.5 5348.4 5349.1 5354.7 4962.3 5164.3 5189.1 5192.2 5487.6 5124.4 5127.3 5137.4 5154.8 5174.8 4737.4 4932.2 4935.9 4949.9 4950.4 11309.3 11429.3 16729.4 18238.5 18343.8 1687.0 1716.2 1764.3 1780.0 1796.5 8385.3 8437.0 8813.0 9004.4 9182.6 1625.0 1660.7 1700.0 1711.4 1751.6 47426.5 51162.2 51908.0 51939.2 52159.7 9746.9 9813.6 9855.9 9900.2 9906.9 12259.9 12265.9 12288.7 12328.3 12410.3 6785.4 6941.2 6969.0 6986.0 7014.7 6591.0 6614.0 6624.9 6671.3 6683.2 4176.5 4184.4 4185.6 4212.3 4241.8 1740.1 1804.9 1807.2 1816.1 1837.9 759.0 836.3 887.5 916.1 952.6 13993.2 14062.4 14295.0 14436.8 14604.3 790.3 833.3 884.0 925.3 940.3 8536.5 8882.7 9062.5 9295.4 9350.5 524154.0 530397.0 530793.0 548018.0 548034.0 65178.7 66457.3 67180.7 67227.0 67664.7 1093.4 1108.5 1112.7 1121.9 1125.3 13210.7 13744.1 13892.9 14051.0 14138.9 28324.0 28616.3 28748.3 29228.3 29648.0 31223.1 31543.4 31636.8 31668.7 32725.0 6825.2 6972.3 7076.7 7252.0 7315.8 8647.4 8974.3 9782.7 10049.4 10226.5 5373.1 7682.3 8473.6 8545.4 8583.3 2583.4 3163.1 5994.4 8564.0 8715.7 8717.5 8740.6 8836.8 8860.2 8864.6 6693.9 6927.5 6936.1 6937.7 7011.4 7165.3 8639.6 8709.4 8804.2 8804.5 04:28:12 INFO - PROCESS | 23653 | 04:28:12 INFO - PROCESS | 23653 | [#3] mootools.html Cycles:180 Average:5188.87 Median:6182.35 stddev:2756.68 (44.6%) stddev-sans-first:2749.47 04:28:12 INFO - PROCESS | 23653 | Values: 1369.6 1369.8 1502.6 1751.0 1771.0 6350.2 6502.4 7397.4 7578.8 7592.8 7088.1 7229.4 7295.9 7296.6 7325.9 2134.5 2184.7 2185.8 2186.7 2187.8 2132.2 2146.9 2156.1 2160.0 2160.4 2170.8 2170.9 2180.2 2183.6 2222.1 2211.2 2219.1 2225.9 2229.1 2230.4 2121.0 2130.6 2138.4 2141.7 2142.8 7313.7 7317.1 7377.6 7378.0 7380.2 4324.0 4438.9 4440.4 4446.7 4448.6 2869.8 2882.2 2934.5 2947.9 2948.8 883.4 889.8 901.6 920.4 926.6 10402.4 10441.7 10562.9 10565.8 10569.7 4178.1 4256.1 4256.9 4264.4 4277.3 8885.9 8926.8 8927.6 8940.4 8950.6 4514.1 4515.4 4516.9 4524.3 4535.3 3455.1 3515.2 3854.9 4070.4 4072.5 3575.2 3609.7 3621.7 3625.1 3659.3 1146.3 1157.5 1164.4 1169.4 1169.5 1117.1 1117.1 1118.5 1121.0 1154.5 6807.9 6809.5 6825.1 6841.4 6845.1 430.7 435.5 437.1 439.6 442.3 5277.6 5290.7 5297.4 5319.3 5319.7 8929.3 9114.3 9237.4 9354.8 9406.2 9253.3 9284.8 9330.7 9331.3 9364.3 6966.0 7011.7 7056.2 7251.2 7261.5 6673.4 6741.6 6773.3 6774.8 6814.6 8013.1 8133.4 8140.8 8213.1 8288.3 8186.8 8537.9 8564.0 8573.5 8623.7 5422.9 6296.7 6374.7 6441.3 6541.3 6751.4 6778.7 6784.2 6805.8 6831.4 6425.9 6519.4 6615.6 6685.1 6710.0 6244.1 6295.3 6391.6 6398.4 6409.9 6559.6 6639.7 6649.5 6660.8 6662.9 6122.6 6168.1 6170.5 6193.7 6197.3 6142.3 6171.0 6214.8 6221.7 6223.5 04:28:12 INFO - PROCESS | 23653 | 04:28:12 INFO - PROCESS | 23653 | [#4] prototype.html Cycles:180 Average:4831.85 Median:5503.41 stddev:1444.04 (26.2%) stddev-sans-first:1407.54 04:28:12 INFO - PROCESS | 23653 | Values: 304.6 309.2 311.7 319.6 324.5 5496.1 5651.2 5677.3 5681.5 5687.4 5490.6 5510.7 5515.0 5532.1 5532.6 4129.5 4223.9 4270.0 4284.2 4297.0 4228.1 4230.1 4230.7 4243.2 4281.8 4239.7 4241.1 4241.6 4242.3 4253.6 4208.1 4213.9 4227.1 4243.8 4248.8 3551.9 3672.0 3701.5 3705.7 3707.0 5209.7 5282.3 5289.3 5340.4 5341.4 4788.9 4881.0 4882.2 4883.7 4897.8 5810.8 5840.2 5845.2 5852.0 5853.6 3909.5 4004.6 4012.3 4017.7 4027.9 6079.4 6118.4 6131.1 6136.1 6161.6 4035.7 4058.9 4059.0 4060.3 4063.0 4082.6 4104.4 4112.2 4129.2 4133.2 4588.7 4751.8 4777.6 4783.1 4785.9 5786.5 5817.0 5817.7 5825.0 5831.4 1456.9 1485.4 1487.7 1488.5 1488.5 978.9 1006.5 1014.3 1015.7 1017.1 5078.9 5107.3 5108.8 5121.8 5123.7 6049.0 6066.8 6069.1 6069.8 6070.5 5082.1 5108.1 5110.8 5110.9 5120.8 3198.1 3237.2 3256.6 3281.3 3287.4 5602.4 5704.4 5711.8 5714.3 5777.7 6299.2 6310.3 6313.5 6318.0 6321.9 5734.1 5739.9 5768.1 5769.6 5779.2 5945.8 6071.1 6094.1 6099.8 6105.7 5970.0 5970.8 5972.9 5973.3 5973.6 5728.8 5754.4 5777.4 5787.9 5793.3 4120.2 4162.1 4167.4 4174.5 4181.1 5946.9 6117.7 6123.7 6128.5 6130.8 5879.3 5887.0 5894.6 5902.1 5916.9 5872.4 5880.6 5891.7 5895.2 5900.9 5610.8 5747.2 5752.7 5760.7 5763.0 5849.2 5916.5 5931.2 5937.6 5942.1 5709.5 5725.4 5751.9 5755.3 5764.5 04:28:12 INFO - PROCESS | 23653 | 04:28:12 INFO - PROCESS | 23653 | [#5] yui.html Cycles:180 Average:11798.50 Median:483.43 stddev:13124.60 (2714.9%) stddev-sans-first:13134.45 04:28:12 INFO - PROCESS | 23653 | Values: 595.2 626.2 630.6 702.1 722.9 10862.2 10959.5 11000.3 11048.5 11071.0 12715.0 13052.1 13069.9 13101.8 13120.9 726.6 739.7 740.4 741.4 774.0 790.3 792.1 793.8 795.3 795.5 811.2 816.6 818.7 819.8 819.8 809.2 811.5 812.4 812.5 813.0 604.9 606.6 608.3 608.8 610.3 12477.9 12509.2 12518.9 12519.6 12535.5 11330.7 11369.3 11570.9 11590.4 11931.8 9144.9 9175.7 9218.5 9219.7 9277.4 3230.6 3235.9 3240.7 3299.4 3363.1 39699.2 39868.0 40464.0 40590.4 40624.6 9112.7 9159.1 9207.7 9313.2 9346.2 15860.1 15993.7 16043.0 16052.9 16072.7 5971.5 6093.6 6126.5 6175.8 6233.8 3474.8 3552.7 3578.6 3619.1 3751.1 2694.6 2750.2 2756.2 2760.7 2763.5 499.2 501.4 504.7 507.1 512.1 437.3 456.3 515.3 613.9 630.1 7187.4 7513.5 7583.3 7690.8 7700.3 467.7 517.4 528.5 529.8 602.9 3565.3 3590.2 3665.5 3750.3 3814.4 46049.0 46091.8 46307.5 46503.8 46535.0 42046.4 42868.0 43039.8 43105.1 43118.8 37870.8 37942.0 38324.4 38607.4 39005.0 7381.5 7478.8 7550.7 7572.8 7603.4 29098.1 29437.0 29692.0 29910.0 30705.0 35409.5 36819.8 37114.4 37381.8 37515.6 9980.8 10069.1 10248.5 10261.7 10488.6 11287.4 11315.9 11346.1 11374.4 11455.4 9642.0 9665.1 9711.1 9793.2 9919.4 9926.2 10241.9 10701.4 10801.9 10815.4 7924.2 8083.8 8130.8 8360.4 8367.2 8719.7 8853.9 8928.9 8951.0 8967.9 8113.5 8557.9 8644.8 8729.7 8760.6 04:28:12 INFO - PROCESS | 23653 | -------- Summary: end -------- 04:28:12 INFO - PROCESS | 23653 | 04:28:13 INFO - TEST-INFO | 23653: exit 0 04:28:13 INFO - TEST-OK | dromaeo_css | took 1114322ms 04:28:13 INFO - TEST-START | kraken 04:28:13 INFO - operating with platform_type : linux_ 04:28:13 INFO - Initialising browser for kraken test... 04:28:13 INFO - TEST-INFO | started process 23885 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN2rlIb/profile http://localhost:36461/getInfo.html) 04:28:17 INFO - PROCESS | 23885 | 04:28:17 INFO - PROCESS | 23885 | (process:23958): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:28:18 INFO - PROCESS | 23885 | __metrics Screen width/height:1600/1200 04:28:18 INFO - PROCESS | 23885 | colorDepth:24 04:28:18 INFO - PROCESS | 23885 | Browser inner width/height: 1024/697 04:28:18 INFO - PROCESS | 23885 | __metrics 04:28:18 INFO - PROCESS | 23885 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:28:19 INFO - TEST-INFO | 23885: exit 0 04:28:19 INFO - Browser initialized. 04:28:19 INFO - Running cycle 1/1 for kraken test... 04:28:19 INFO - TEST-INFO | started process 24007 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN2rlIb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:20 INFO - PROCESS | 24007 | 04:28:20 INFO - PROCESS | 24007 | (process:24064): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:28:31 INFO - PROCESS | 24007 | RSS: Main: 149794816 04:28:31 INFO - PROCESS | 24007 | 04:28:33 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36461/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:34 INFO - PROCESS | 24007 | RSS: Main: 148795392 04:28:34 INFO - PROCESS | 24007 | 04:28:37 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36461/tests/kraken/driver.html?testName=audio-dft) 04:28:37 INFO - PROCESS | 24007 | RSS: Main: 150728704 04:28:37 INFO - PROCESS | 24007 | 04:28:40 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36461/tests/kraken/driver.html?testName=audio-fft) 04:28:41 INFO - PROCESS | 24007 | RSS: Main: 146161664 04:28:41 INFO - PROCESS | 24007 | 04:28:43 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36461/tests/kraken/driver.html?testName=audio-oscillator) 04:28:44 INFO - PROCESS | 24007 | RSS: Main: 146448384 04:28:44 INFO - PROCESS | 24007 | 04:28:46 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36461/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:47 INFO - PROCESS | 24007 | RSS: Main: 146845696 04:28:47 INFO - PROCESS | 24007 | 04:28:50 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36461/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:50 INFO - PROCESS | 24007 | RSS: Main: 147972096 04:28:50 INFO - PROCESS | 24007 | 04:28:54 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36461/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:54 INFO - PROCESS | 24007 | RSS: Main: 147001344 04:28:54 INFO - PROCESS | 24007 | 04:28:57 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36461/tests/kraken/driver.html?testName=json-parse-financial) 04:28:58 INFO - PROCESS | 24007 | RSS: Main: 146137088 04:28:58 INFO - PROCESS | 24007 | 04:29:00 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36461/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:00 INFO - PROCESS | 24007 | RSS: Main: 148488192 04:29:00 INFO - PROCESS | 24007 | 04:29:02 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:03 INFO - PROCESS | 24007 | RSS: Main: 147677184 04:29:03 INFO - PROCESS | 24007 | 04:29:05 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:05 INFO - PROCESS | 24007 | RSS: Main: 148086784 04:29:05 INFO - PROCESS | 24007 | 04:29:08 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:09 INFO - PROCESS | 24007 | RSS: Main: 148750336 04:29:09 INFO - PROCESS | 24007 | 04:29:11 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:12 INFO - PROCESS | 24007 | RSS: Main: 148029440 04:29:12 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | Cycle 1(1): loaded http://localhost:36461/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36461/tests/kraken/driver.html?testName=ai-astar) 04:29:14 INFO - PROCESS | 24007 | RSS: Main: 147693568 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | __start_tp_report 04:29:14 INFO - PROCESS | 24007 | _x_x_mozilla_page_load 04:29:14 INFO - PROCESS | 24007 | _x_x_mozilla_page_load_details 04:29:14 INFO - PROCESS | 24007 | |i|pagename|runs| 04:29:14 INFO - PROCESS | 24007 | |0;ai-astar;113;110;114;114;115;125;115;113;114;114 04:29:14 INFO - PROCESS | 24007 | |1;audio-beat-detection;149;132;154;170;143;161;164;144;166;141 04:29:14 INFO - PROCESS | 24007 | |2;audio-dft;162;163;163;161;165;164;168;165;163;162 04:29:14 INFO - PROCESS | 24007 | |3;audio-fft;73;74;73;74;74;75;139;73;72;72 04:29:14 INFO - PROCESS | 24007 | |4;audio-oscillator;97;97;133;98;98;97;136;98;98;129 04:29:14 INFO - PROCESS | 24007 | |5;imaging-gaussian-blur;110;110;110;111;112;109;111;110;109;109 04:29:14 INFO - PROCESS | 24007 | |6;imaging-darkroom;148;148;147;148;148;148;148;148;149;148 04:29:14 INFO - PROCESS | 24007 | |7;imaging-desaturate;96;97;96;97;97;97;97;98;96;101 04:29:14 INFO - PROCESS | 24007 | |8;json-parse-financial;71;71;71;70;74;71;70;70;68;69 04:29:14 INFO - PROCESS | 24007 | |9;json-stringify-tinderbox;67;68;73;68;74;68;68;69;68;68 04:29:14 INFO - PROCESS | 24007 | |10;stanford-crypto-aes;85;93;86;87;84;84;83;84;84;83 04:29:14 INFO - PROCESS | 24007 | |11;stanford-crypto-ccm;136;122;125;134;127;130;129;130;123;136 04:29:14 INFO - PROCESS | 24007 | |12;stanford-crypto-pbkdf2;138;148;148;141;143;139;147;146;146;149 04:29:14 INFO - PROCESS | 24007 | |13;stanford-crypto-sha256-iterative;75;71;69;72;71;70;69;70;71;70 04:29:14 INFO - PROCESS | 24007 | __end_tp_report 04:29:14 INFO - PROCESS | 24007 | __start_cc_report 04:29:14 INFO - PROCESS | 24007 | _x_x_mozilla_cycle_collect,810 04:29:14 INFO - PROCESS | 24007 | __end_cc_report 04:29:14 INFO - PROCESS | 24007 | __startTimestamp1452688154346__endTimestamp 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | ------- Summary: start ------- 04:29:14 INFO - PROCESS | 24007 | Number of tests: 14 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.00 stddev:3.89 (3.4%) stddev-sans-first:4.08 04:29:14 INFO - PROCESS | 24007 | Values: 113.0 110.0 114.0 114.0 115.0 125.0 115.0 113.0 114.0 114.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#1] audio-beat-detection Cycles:10 Average:152.40 Median:157.50 stddev:12.57 (8.0%) stddev-sans-first:13.27 04:29:14 INFO - PROCESS | 24007 | Values: 149.0 132.0 154.0 170.0 143.0 161.0 164.0 144.0 166.0 141.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.50 stddev:2.01 (1.2%) stddev-sans-first:2.05 04:29:14 INFO - PROCESS | 24007 | Values: 162.0 163.0 163.0 161.0 165.0 164.0 168.0 165.0 163.0 162.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#3] audio-fft Cycles:10 Average:79.90 Median:73.50 stddev:20.79 (28.3%) stddev-sans-first:21.90 04:29:14 INFO - PROCESS | 24007 | Values: 73.0 74.0 73.0 74.0 74.0 75.0 139.0 73.0 72.0 72.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#4] audio-oscillator Cycles:10 Average:108.10 Median:97.50 stddev:17.04 (17.5%) stddev-sans-first:17.59 04:29:14 INFO - PROCESS | 24007 | Values: 97.0 97.0 133.0 98.0 98.0 97.0 136.0 98.0 98.0 129.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.99 (0.9%) stddev-sans-first:1.05 04:29:14 INFO - PROCESS | 24007 | Values: 110.0 110.0 110.0 111.0 112.0 109.0 111.0 110.0 109.0 109.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 04:29:14 INFO - PROCESS | 24007 | Values: 148.0 148.0 147.0 148.0 148.0 148.0 148.0 148.0 149.0 148.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:97.00 stddev:1.48 (1.5%) stddev-sans-first:1.50 04:29:14 INFO - PROCESS | 24007 | Values: 96.0 97.0 96.0 97.0 97.0 97.0 97.0 98.0 96.0 101.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#8] json-parse-financial Cycles:10 Average:70.50 Median:71.00 stddev:1.58 (2.2%) stddev-sans-first:1.67 04:29:14 INFO - PROCESS | 24007 | Values: 71.0 71.0 71.0 70.0 74.0 71.0 70.0 70.0 68.0 69.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:68.00 stddev:2.38 (3.5%) stddev-sans-first:2.40 04:29:14 INFO - PROCESS | 24007 | Values: 67.0 68.0 73.0 68.0 74.0 68.0 68.0 69.0 68.0 68.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:84.50 stddev:2.98 (3.5%) stddev-sans-first:3.16 04:29:14 INFO - PROCESS | 24007 | Values: 85.0 93.0 86.0 87.0 84.0 84.0 83.0 84.0 84.0 83.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:130.00 stddev:5.05 (3.9%) stddev-sans-first:4.72 04:29:14 INFO - PROCESS | 24007 | Values: 136.0 122.0 125.0 134.0 127.0 130.0 129.0 130.0 123.0 136.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.50 Median:146.50 stddev:3.98 (2.7%) stddev-sans-first:3.46 04:29:14 INFO - PROCESS | 24007 | Values: 138.0 148.0 148.0 141.0 143.0 139.0 147.0 146.0 146.0 149.0 04:29:14 INFO - PROCESS | 24007 | 04:29:14 INFO - PROCESS | 24007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.80 Median:71.00 stddev:1.75 (2.5%) stddev-sans-first:1.00 04:29:14 INFO - PROCESS | 24007 | Values: 75.0 71.0 69.0 72.0 71.0 70.0 69.0 70.0 71.0 70.0 04:29:14 INFO - PROCESS | 24007 | -------- Summary: end -------- 04:29:14 INFO - PROCESS | 24007 | 04:29:15 INFO - TEST-INFO | 24007: exit 0 04:29:15 INFO - TEST-OK | kraken | took 61771ms 04:29:15 INFO - TEST-START | v8_7 04:29:15 INFO - operating with platform_type : linux_ 04:29:15 INFO - Initialising browser for v8_7 test... 04:29:15 INFO - TEST-INFO | started process 24293 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNp5SQb/profile http://localhost:36461/getInfo.html) 04:29:19 INFO - PROCESS | 24293 | 04:29:19 INFO - PROCESS | 24293 | (process:24362): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:29:20 INFO - PROCESS | 24293 | __metrics Screen width/height:1600/1200 04:29:20 INFO - PROCESS | 24293 | colorDepth:24 04:29:20 INFO - PROCESS | 24293 | Browser inner width/height: 1024/697 04:29:20 INFO - PROCESS | 24293 | __metrics 04:29:20 INFO - PROCESS | 24293 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:29:21 INFO - TEST-INFO | 24293: exit 0 04:29:21 INFO - Browser initialized. 04:29:21 INFO - Running cycle 1/1 for v8_7 test... 04:29:21 INFO - TEST-INFO | started process 24411 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNp5SQb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:22 INFO - PROCESS | 24411 | 04:29:22 INFO - PROCESS | 24411 | (process:24472): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:29:33 INFO - PROCESS | 24411 | RSS: Main: 149323776 04:29:33 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | Cycle 1(1): loaded http://localhost:36461/tests/v8_7/run.html (next: http://localhost:36461/tests/v8_7/run.html) 04:29:55 INFO - PROCESS | 24411 | RSS: Main: 145338368 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | __start_tp_report 04:29:55 INFO - PROCESS | 24411 | _x_x_mozilla_page_load 04:29:55 INFO - PROCESS | 24411 | _x_x_mozilla_page_load_details 04:29:55 INFO - PROCESS | 24411 | |i|pagename|runs| 04:29:55 INFO - PROCESS | 24411 | |0;Richards;167.50418760469012 04:29:55 INFO - PROCESS | 24411 | |1;DeltaBlue;186.53236336504384 04:29:55 INFO - PROCESS | 24411 | |2;Encrypt;278.39643652561244 04:29:55 INFO - PROCESS | 24411 | |3;Decrypt;5229.166666666667 04:29:55 INFO - PROCESS | 24411 | |4;RayTrace;1061.5711252653928 04:29:55 INFO - PROCESS | 24411 | |5;Earley;709.2198581560284 04:29:55 INFO - PROCESS | 24411 | |6;Boyer;12382.716049382716 04:29:55 INFO - PROCESS | 24411 | |7;RegExp;43063.82978723404 04:29:55 INFO - PROCESS | 24411 | |8;Splay;611.8220597196831 04:29:55 INFO - PROCESS | 24411 | |9;NavierStokes;4835.748792270531 04:29:55 INFO - PROCESS | 24411 | __end_tp_report 04:29:55 INFO - PROCESS | 24411 | __startTimestamp1452688195876__endTimestamp 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | ------- Summary: start ------- 04:29:55 INFO - PROCESS | 24411 | Number of tests: 10 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | [#0] Richards Cycles:1 Average:167.50 Median:167.50 stddev:0.00 (0.0%) 04:29:55 INFO - PROCESS | 24411 | Values: 167.5 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | [#1] DeltaBlue Cycles:1 Average:186.53 Median:186.53 stddev:0.00 (0.0%) 04:29:55 INFO - PROCESS | 24411 | Values: 186.5 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | [#2] Encrypt Cycles:1 Average:278.40 Median:278.40 stddev:0.00 (0.0%) 04:29:55 INFO - PROCESS | 24411 | Values: 278.4 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 04:29:55 INFO - PROCESS | 24411 | Values: 5229.2 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | [#4] RayTrace Cycles:1 Average:1061.57 Median:1061.57 stddev:0.00 (0.0%) 04:29:55 INFO - PROCESS | 24411 | Values: 1061.6 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | [#5] Earley Cycles:1 Average:709.22 Median:709.22 stddev:0.00 (0.0%) 04:29:55 INFO - PROCESS | 24411 | Values: 709.2 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | [#6] Boyer Cycles:1 Average:12382.72 Median:12382.72 stddev:0.00 (0.0%) 04:29:55 INFO - PROCESS | 24411 | Values: 12382.7 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | [#7] RegExp Cycles:1 Average:43063.83 Median:43063.83 stddev:0.00 (0.0%) 04:29:55 INFO - PROCESS | 24411 | Values: 43063.8 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | [#8] Splay Cycles:1 Average:611.82 Median:611.82 stddev:0.00 (0.0%) 04:29:55 INFO - PROCESS | 24411 | Values: 611.8 04:29:55 INFO - PROCESS | 24411 | 04:29:55 INFO - PROCESS | 24411 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 04:29:55 INFO - PROCESS | 24411 | Values: 4835.7 04:29:55 INFO - PROCESS | 24411 | -------- Summary: end -------- 04:29:55 INFO - PROCESS | 24411 | 04:29:56 INFO - TEST-INFO | 24411: exit 0 04:29:56 INFO - TEST-OK | v8_7 | took 41431ms 04:29:56 INFO - SUITE-END | took 1217s 04:29:56 INFO - Completed test suite (00:20:17) 04:29:56 INFO - Working with test: dromaeo_css 04:29:56 INFO - Generating results file: dromaeo_css 04:29:56 INFO - Working with test: kraken 04:29:56 INFO - Generating results file: kraken 04:29:56 INFO - javascript benchmark 04:29:56 INFO - Working with test: v8_7 04:29:56 INFO - Generating results file: v8_7 04:29:56 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:56 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:29:56 INFO - process_Request line: dromaeo_css 6188.25 graph.html#tests=[[72,94,43]] 04:29:56 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:57 INFO - process_Request line: kraken 1543.40 graph.html#tests=[[232,94,43]] 04:29:57 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:29:57 INFO - process_Request line: v8_7 20273.54 graph.html#tests=[[230,94,43]] 04:29:57 INFO - RETURN: dromaeo_css: 6188.25 04:29:57 INFO - RETURN: kraken: 1543.40 04:29:57 INFO - RETURN: v8_7: 20273.54 04:29:57 INFO - javascript benchmark 04:29:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2610.6997695265045, 2635.8418494890298, 2679.3837417393997, 2682.9865850670744, 2697.0560303893635, 4508.233600287951, 4511.097780443916, 4568.314752787083, 4585.908281834366, 4607.58531732144, 4535.863924082275, 4574.725516469014, 4610.170169369512, 4668.183067963101, 4675.947911719862, 4118.670506359484, 4215.957840421587, 4264.189803937257, 4282.229198744232, 4329.826806927735, 4293.141371725667, 4305.24658184818, 4341.522432532434, 4348.152110338485, 4369.672274579403, 4101.979490102545, 4190.078182799779, 4207.221663992172, 4250.851220207278, 4264.850730224427, 4230.894227644303, 4248.362745588156, 4261.701680882339, 4278.614924656796, 4280.486341638992, 4092.3043082675717, 4221.5567365426805, 4224.387463817729, 4240.257954857888, 4263.275243208662, 4412.294032954744, 4489.551044895517, 4514.503404625489, 4517.59341659249, 4553.043860789238, 4937.654364194508, 4955.702657840541, 4958.677685950438, 4959.900801983977, 4977.178765503688, 4808.687435316693, 4896.094222568836, 4961.404631444214, 4972.651914365996, 5026.070177017264, 4530.320451932236, 4537.069900670354, 4559.156556037111, 4568.063546972862, 4573.199690054227, 5059.671121377099, 5068.23976403535, 5080.390353157571, 5095.923561146586, 5103.081445339874, 4752.524747525289, 4819.469858315582, 4830.203016502308, 4862.465128835825, 4869.9513004870205, 4921.409430868319, 4925.990172014728, 4943.1596628573225, 4950.3069570260195, 4973.030259099513, 4869.257845273995, 4869.391326084239, 4871.707697538159, 4879.707217566957, 4918.213085906238, 4727.550882666142, 4766.261229509431, 4796.25658023007, 4854.466008739036, 4896.681715688469, 4054.4526488923616, 4063.349864021742, 4066.694997875112, 4068.9796551017057, 4087.5299340576216, 3604.8377822998027, 3614.548181477315, 3635.527381440396, 3642.2897534980953, 3647.398179300386, 4212.768297743653, 4271.402003719481, 4272.0, 4309.332053531708, 4338.327559228324, 4914.164592019365, 4940.110780059552, 4952.603791696728, 4955.231939049453, 4986.626003049786, 4202.600752928467, 4276.358546218092, 4286.699931004862, 4286.742795432284, 4321.58944900234, 4297.699161058758, 4339.978300108479, 4391.626711729475, 4396.692231543761, 4421.911561768811, 4640.512746161605, 4644.256918892961, 4649.209634362099, 4691.554302341272, 4692.906141877212, 4822.276658501253, 4894.2658601210105, 4895.779689913891, 4907.043126590281, 4911.214205727067, 4651.162790697707, 4662.836800711959, 4669.696469729457, 4696.38946936896, 4732.5030871759345, 4846.248831431134, 4861.927071093865, 4881.633877459276, 4889.095517329305, 4890.462049174659, 4848.5636292733825, 4933.605311574994, 4956.008798240294, 4975.253711943237, 5032.6980381177245, 4775.928361074517, 4799.136155492045, 4808.110499557593, 4820.108279968217, 4829.73436460998, 4746.620270378292, 4747.264174053027, 4772.761361931959, 4794.30482580017, 4848.393950756155, 4595.770211489479, 4640.83757068501, 4676.532346765296, 4702.365180700562, 4712.905741885212, 4761.76191190446, 4771.117343291502, 4781.211100168573, 4796.35249241348, 4822.204336284473, 4640.025594625166, 4663.370444989883, 4663.696859704109, 4671.43942726875, 4692.225782745809], "unit": "score", "name": "dojo.html", "value": 4513.660631961638}, {"lowerIsBetter": false, "replicates": [498.0561835322065, 504.10521324648744, 505.11100463184783, 505.6132058974885, 521.9295395121659, 35461.290774184534, 36190.81904590477, 36205.0, 36311.4553281701, 36450.45324320137, 39598.80200599, 40088.0, 40148.79925600368, 40342.79828600853, 40486.59513404872, 7743.457957942946, 7875.684972601089, 7929.5242285463055, 7936.047674279094, 7955.920440795576, 7795.14253432122, 7962.203779622049, 7962.880556791623, 7968.04383473981, 7968.840623187532, 7962.084360298553, 8054.114047454805, 8063.15336889624, 8066.395020373466, 8068.435209535335, 7849.45053846231, 7926.286634202949, 7929.4052946028705, 7950.801229969239, 7956.443048986574, 7618.123915749704, 7704.26809453101, 7729.497582657109, 7750.922490775077, 7766.262205090507, 33181.0, 33396.83301583477, 33427.331453371036, 33559.49660755091, 33588.16029599255, 2197.494576247456, 2520.3195137313005, 2550.1074623881677, 2712.905048323319, 2718.1573712149097, 28089.438211235865, 28778.28054298659, 28944.42111157786, 29215.0, 30120.8493957531, 3249.1877030742316, 3280.376728421616, 3282.606087269543, 3307.884224052171, 3383.7969721816526, 207144.0, 209002.0, 209239.0, 209635.0, 209890.75273118142, 48700.0, 50416.747916260916, 63578.0, 65254.0, 65296.34703652903, 62418.687906560175, 62720.686396568635, 63018.36981630217, 63199.04810470845, 63360.68319658464, 13503.12229705066, 13587.728245435233, 13600.591982240549, 13668.31658417095, 13694.794578081337, 10197.643082492077, 10270.897291027144, 10327.380357178594, 10330.845037324447, 10371.325863818827, 19887.900560497106, 20257.290994815405, 20394.59210815805, 20562.074706638236, 20601.175952961712, 8178.754637360888, 8451.830963380698, 8594.914050859412, 8609.655613775503, 8650.87023694645, 743.9888401673979, 760.8097975506123, 787.8030492376906, 801.2028032107974, 852.3692467573951, 22660.773392266197, 22831.429214269778, 27215.0, 28923.56614650782, 29268.0, 877.1579283887539, 886.7162507997378, 903.643060990918, 921.2629896083107, 963.7349728824629, 12028.939855300667, 12161.756764864653, 12186.51253949832, 12217.816732749016, 12357.567485137977, 332152.0, 333187.0, 334207.0, 336894.0, 337838.0, 46456.0, 46849.29726054112, 47067.293990590166, 47237.0, 47410.762946185045, 1144.9313041217554, 1156.9942150289194, 1167.7897978363806, 1176.758764453285, 1189.3577468167266, 25225.87387063053, 25614.23157305284, 25663.615045774703, 25794.61308080343, 25925.22224333273, 38823.805880970416, 39563.0, 39713.00717482086, 39878.60121398865, 39985.80007100062, 248491.0, 250378.0, 250509.0, 250697.0, 251411.0, 28728.425431491672, 38287.0, 38861.05694715196, 39042.41436378514, 39156.0, 33088.66911330856, 34451.82774086113, 34480.65519344775, 41307.7934610325, 42587.5741242596, 33145.50281745824, 33599.66400336063, 34398.14004649904, 34533.0, 34791.0, 29971.100866974026, 30143.698563014965, 30498.542521862633, 30508.694913051473, 30533.54199687051, 31115.0, 31362.372752545278, 31427.0, 34340.313193735485, 35241.64758352384, 26160.34599135037, 27354.316142096606, 27398.452030959666, 27910.72089279081, 29932.551011734406, 23366.299011029696, 23391.0, 23421.297361079196, 23522.29433117009, 23523.647145292492], "unit": "score", "name": "ext.html", "value": 16731.175106830357}, {"lowerIsBetter": false, "replicates": [343.93465241604093, 344.3440246330739, 351.8698081709767, 352.4959308189289, 359.99640003599956, 14584.70830583389, 14768.483103091394, 15048.623784405396, 15540.53378398647, 16331.510054698363, 9885.0, 10187.388756674605, 12179.695507612314, 15221.695566088672, 15249.39002439901, 4502.662300327472, 4703.6237101032, 4705.788239529229, 5107.38711354638, 5353.973230133844, 5276.841694749144, 5325.467453254663, 5348.411674715778, 5349.063913815086, 5354.705491197982, 4962.305277261186, 5164.251183578379, 5189.117849965496, 5192.169252919533, 5487.5609951203805, 5124.4106927703415, 5127.256547800566, 5137.383513978347, 5154.793808247666, 5174.793008279683, 4737.407824021997, 4932.2108462646165, 4935.851924442237, 4949.925751113737, 4950.405951285833, 11309.264897781617, 11429.257098288585, 16729.414470493597, 18238.544036399064, 18343.81656183448, 1686.966260674792, 1716.150505499773, 1764.303100275384, 1779.9555011124826, 1796.4520821149545, 8385.329173666092, 8436.957815210884, 8813.0, 9004.369694121415, 9182.586783594754, 1624.951251462458, 1660.6761681472117, 1700.047973135036, 1711.4266720648598, 1751.5883767314672, 47426.52573474256, 51162.23256651116, 51908.0, 51939.22091168635, 52159.73920130375, 9746.853797193047, 9813.607455701693, 9855.90144098564, 9900.207983361313, 9906.851397229048, 12259.877401226053, 12265.877341226653, 12288.692782680326, 12328.260304381765, 12410.255384676948, 6785.389314961677, 6941.167059952838, 6969.0, 6986.008987438556, 7014.684339204748, 6591.0, 6613.966930165318, 6624.867502650017, 6671.266160722316, 6683.198016237985, 4176.477940257468, 4184.4141820145205, 4185.58144185579, 4212.326027835532, 4241.830326786956, 1740.1473278093642, 1804.864635152369, 1807.150639199574, 1816.0647266657681, 1837.9431826699433, 758.9734359297508, 836.272442974616, 887.4675194883148, 916.0564618443015, 952.5951470624957, 13993.230372329619, 14062.367193476319, 14295.0, 14436.783448248285, 14604.269786510631, 790.2887401338841, 833.2833762963846, 883.969061082859, 925.3430064654036, 940.3135710930922, 8536.530490822941, 8882.689105881263, 9062.546872656341, 9295.395799273025, 9350.485723285148, 524154.0, 530397.0, 530793.0, 548018.0, 548034.0, 65178.67410663011, 66457.33542664608, 67180.6640966792, 67227.0, 67664.6616766913, 1093.3822390349585, 1108.4845546820768, 1112.7329440934118, 1121.8541589593137, 1125.2685754259796, 13210.735785284432, 13744.106633068819, 13892.88856891426, 14051.0, 14138.929305353407, 28324.0, 28616.284592885346, 28748.281292967844, 29228.26929326784, 29648.0, 31223.063308100795, 31543.369132617678, 31636.841815790773, 31668.683313167494, 32725.0, 6825.2151002633345, 6972.302769722987, 7076.716931322895, 7251.963740181265, 7315.780526584211, 8647.351448641502, 8974.326925480746, 9782.706518804447, 10049.447280399649, 10226.539805708611, 5373.146264538728, 7682.308592226726, 8473.576321183793, 8545.359098067545, 8583.313334933315, 2583.4316450380884, 3163.098516922666, 5994.400559944145, 8564.0, 8715.694950676696, 8717.520536370306, 8740.562971851508, 8836.823263534821, 8860.246879015098, 8864.556772161237, 6693.933060669526, 6927.480438967198, 6936.0636314096955, 6937.722491100501, 7011.368976792113, 7165.319294666998, 8639.568021598769, 8709.433886797338, 8804.163604457566, 8804.515751633722], "unit": "score", "name": "jquery.html", "value": 7344.767613154788}, {"lowerIsBetter": false, "replicates": [1369.5959691890894, 1369.7602919489086, 1502.6168327076593, 1750.9912450437762, 1771.024678540053, 6350.237971443422, 6502.414782669559, 7397.371223446007, 7578.848423031536, 7592.772216833497, 7088.113985751781, 7229.445669181125, 7295.8540829183385, 7296.598687072209, 7325.853482930338, 2134.5197330600645, 2184.661377486484, 2185.7814218578173, 2186.7157269554937, 2187.7812218778154, 2132.1791110422523, 2146.914123435061, 2156.0513374115417, 2159.9568008639817, 2160.4274867160216, 2170.8046275835172, 2170.8697478151284, 2180.2260197629853, 2183.5632873425297, 2222.088943533152, 2211.1818627107914, 2219.123446238743, 2225.944351391212, 2229.1194977983605, 2230.4423894026495, 2120.957580848374, 2130.5525839573706, 2138.4119367173994, 2141.7001619773246, 2142.7535833379206, 7313.744018959364, 7317.085364329459, 7377.59423231722, 7377.963110184414, 7380.225076366958, 4323.978380108111, 4438.866833994985, 4440.378347031418, 4446.688731788776, 4448.621867141297, 2869.827810331366, 2882.2362074050393, 2934.501134807088, 2947.9263018424494, 2948.764098872085, 883.3860466975455, 889.8477813460058, 901.5537309032005, 920.4293338130402, 926.583037633061, 10402.427866467342, 10441.68674939753, 10562.894371056345, 10565.788684226349, 10569.73575660607, 4178.143480586473, 4256.106217694257, 4256.851010214627, 4264.360345948071, 4277.294246449301, 8885.866711999326, 8926.821463570823, 8927.598258078402, 8940.374173807772, 8950.597223124974, 4514.119746649438, 4515.435570553681, 4516.909661806745, 4524.343970124313, 4535.31970204472, 3455.0844026333043, 3515.244222492125, 3854.9036274093373, 4070.409790580349, 4072.53165885921, 3575.213453040327, 3609.7473176877893, 3621.728370372233, 3625.057485053905, 3659.341318562631, 1146.266389510714, 1157.4849192109598, 1164.394514852272, 1169.3977601535216, 1169.4678921090883, 1117.0560876059717, 1117.1007339091946, 1118.4799068433217, 1120.9719757005978, 1154.4574050196395, 6807.863842723118, 6809.489288303298, 6825.1127353443735, 6841.3842754152365, 6845.0759147514445, 430.66838534328394, 435.4513313225359, 437.0930319586806, 439.59337612708117, 442.3166208208326, 5277.551408130352, 5290.68255904647, 5297.417284098746, 5319.308489896366, 5319.654222475527, 8929.285657147413, 9114.316426268057, 9237.3533852631, 9354.812903741888, 9406.200472959876, 9253.259739220846, 9284.814303713887, 9330.720078397659, 9331.300152488455, 9364.344495885223, 6966.0, 7011.719531218796, 7056.188538318159, 7251.202367739545, 7261.491695581364, 6673.366030227121, 6741.629210393476, 6773.322667733384, 6774.830629234309, 6814.625195614289, 8013.077693661118, 8133.389995750224, 8140.83718325642, 8213.096559378344, 8288.336933045463, 8186.7953301167945, 8537.890074290302, 8563.95718021406, 8573.485590864568, 8623.65505379803, 5422.8644283891645, 6296.653684047421, 6374.745010199726, 6441.291457939529, 6541.280459149585, 6751.426128778912, 6778.7288508459105, 6784.219814721173, 6805.761798337035, 6831.385175334244, 6425.935740642533, 6519.445847103049, 6615.6030638161865, 6685.064091027163, 6709.959956206796, 6244.063390491463, 6295.338989406229, 6391.58454700443, 6398.424141827258, 6409.935900640934, 6559.639219842955, 6639.734410623714, 6649.501287403367, 6660.800175994728, 6662.866742665216, 6122.571420000557, 6168.074788781719, 6170.475509581735, 6193.6903154841175, 6197.318294987638, 6142.2629284484365, 6171.0, 6214.782482613087, 6221.657808820377, 6223.533235007302], "unit": "score", "name": "mootools.html", "value": 4173.406189963523}, {"lowerIsBetter": false, "replicates": [304.5523081070826, 309.2238481411656, 311.7350252285556, 319.64040454488685, 324.4954096380128, 5496.148097044955, 5651.152327150924, 5677.261955945732, 5681.517071048956, 5687.431256874311, 5490.56075513959, 5510.669359838413, 5515.0, 5532.059549876531, 5532.612717109804, 4129.525104612978, 4223.936640950388, 4269.978650106761, 4284.207421627001, 4297.0, 4228.112096459748, 4230.069384735353, 4230.7038507304505, 4243.215005224028, 4281.764502952336, 4239.745615263078, 4241.0669652676515, 4241.597048280424, 4242.321228603424, 4253.553376895427, 4208.0531880326835, 4213.91572168558, 4227.112306415641, 4243.830246790125, 4248.766317852517, 3551.8756843510355, 3671.9816400918094, 3701.5373078365205, 3705.6664900159117, 3707.0361705956375, 5209.6874187548865, 5282.286891269706, 5289.3123893893935, 5340.371186788028, 5341.359036915556, 4788.880277993043, 4880.975595122001, 4882.170031094723, 4883.706977581356, 4897.755112244374, 5810.767569297223, 5840.182374467578, 5845.181674565564, 5851.975904216745, 5853.5902486825935, 3909.5113110861143, 4004.599540046001, 4012.3179059559943, 4017.678585713136, 4027.8590249341423, 6079.361667024988, 6118.388161183935, 6131.110988906628, 6136.110264011738, 6161.6303021818385, 4035.6569691575955, 4058.939115913264, 4059.0258337998666, 4060.3097473428998, 4063.045184381668, 4082.591740825894, 4104.445899803488, 4112.177564487115, 4129.236091323115, 4133.194027164674, 4588.655850811202, 4751.837913749305, 4777.641676874248, 4783.1390349736685, 4785.9042819144115, 5786.479216870502, 5816.970915145397, 5817.680027598522, 5825.0, 5831.3877042910735, 1456.8980171388114, 1485.442958890416, 1487.7470829958934, 1488.471592584617, 1488.5311126995177, 978.9461579613047, 1006.5219020965129, 1014.2899970021015, 1015.664830605913, 1017.0795430135739, 5078.923816142761, 5107.310513080686, 5108.846734597893, 5121.769520371592, 5123.743812809419, 6049.0, 6066.75732970685, 6069.0592958091565, 6069.817905462844, 6070.544709146831, 5082.110630639697, 5108.131617625013, 5110.8466745997675, 5110.897782044338, 5120.7951681933055, 3198.072558957876, 3237.239248776583, 3256.5929258842643, 3281.261716113855, 3287.408266512003, 5602.411746766612, 5704.401037891044, 5711.8000869969355, 5714.342850572154, 5777.711114444261, 6299.244090709052, 6310.305866354697, 6313.526485513513, 6317.96841015792, 6321.936780632227, 5734.111212761862, 5739.885202295931, 5768.077107662838, 5769.567282453832, 5779.162021506858, 5945.762169513171, 6071.089336599545, 6094.14681944537, 6099.84750381244, 6105.694715264308, 5970.0, 5970.791022314198, 5972.8805423892145, 5973.253343332083, 5973.611715238496, 5728.828135155952, 5754.3670196277535, 5777.364489906191, 5787.884242315046, 5793.304803423448, 4120.175964806991, 4162.14675991415, 4167.395727619539, 4174.540800512002, 4181.059261666101, 5946.940530594812, 6117.663528505975, 6123.693815309128, 6128.479079278133, 6130.754769809158, 5879.323877753942, 5887.0, 5894.557908156819, 5902.085176797603, 5916.881662366814, 5872.354041055566, 5880.558958078076, 5891.705414729332, 5895.174675545512, 5900.852478688067, 5610.803621873215, 5747.224124743273, 5752.6836024019085, 5760.683162426107, 5762.962666720031, 5849.181114643869, 5916.526677865846, 5931.169636251015, 5937.614055086578, 5942.138389933349, 5709.543236540983, 5725.370209276893, 5751.856203594776, 5755.251817263897, 5764.481196692318], "unit": "score", "name": "prototype.html", "value": 4367.148960302844}, {"lowerIsBetter": false, "replicates": [595.1964847455935, 626.2203556572067, 630.5901164243244, 702.1328659106007, 722.9047992291679, 10862.185336099794, 10959.452027398638, 11000.339979601209, 11048.508451359074, 11071.0, 12714.98280137589, 13052.086353955227, 13069.934650326735, 13101.803472947913, 13120.934395328033, 726.5858460677402, 739.7041183526578, 740.3632875726871, 741.3513175971025, 773.9961300193492, 790.3242727468019, 792.0851416613791, 793.7658390774707, 795.2802713544252, 795.5425630262594, 811.180707485441, 816.5549775372407, 818.7461886815076, 819.7909533069089, 819.8442295963748, 809.1625167951142, 811.4765975945512, 812.358236992775, 812.5368539932241, 812.9918700813005, 604.9183360246354, 606.5663050918614, 608.333874407523, 608.8356143841182, 610.3164455809522, 12477.937610311981, 12509.249445033236, 12518.874811251862, 12519.56181533642, 12535.498580056787, 11330.660080197607, 11369.2609980351, 11570.884291157065, 11590.420478976102, 11931.821022684666, 9144.8628270576, 9175.678851240174, 9218.492982885939, 9219.723408297694, 9277.396969196981, 3230.5800245967876, 3235.902922912316, 3240.7083362497488, 3299.406106900757, 3363.1423986883433, 39699.20601587952, 39867.99999999971, 40464.0, 40590.39114413286, 40624.59375406238, 9112.726618201465, 9159.084091590788, 9207.677731279373, 9313.161815436642, 9346.15884570392, 15860.127692976766, 15993.680126397407, 16043.037417754973, 16052.919735401249, 16072.678546429006, 5971.5222782177325, 6093.573449858467, 6126.479249263863, 6175.84560385994, 6233.781817636361, 3474.756767026284, 3552.6980206682206, 3578.5526809148855, 3619.077135330474, 3751.0809851586537, 2694.6362241097595, 2750.1612008337247, 2756.1731480556155, 2760.6748760594623, 2763.544015237463, 499.16639212515184, 501.4459022779849, 504.66187654271727, 507.12014654574284, 512.0961502947301, 437.2763077107392, 456.32463953348565, 515.3094852897136, 613.9065785670841, 630.1021045010841, 7187.353138217585, 7513.543769865813, 7583.27958843909, 7690.769276921701, 7700.306972372513, 467.70300858954806, 517.4437479709328, 528.5084871069865, 529.761607276727, 602.8975074237391, 3565.2512972275595, 3590.1563132663805, 3665.4501824726503, 3750.3249415105543, 3814.3515602347666, 46049.0, 46091.76954115275, 46307.53692463099, 46503.76748116238, 46535.0, 42046.36930446046, 42868.0, 43039.784801075795, 43105.13789724251, 43118.78440607777, 37870.810645947146, 37942.0, 38324.425133623015, 38607.42088868669, 39005.0, 7381.483296169431, 7478.813029674084, 7550.697972081055, 7572.8485430292185, 7603.429742769204, 29098.127056188347, 29437.0, 29692.0, 29910.0, 30704.999999999105, 35409.468857967666, 36819.81590092032, 37114.44328335023, 37381.813090934374, 37515.6248437523, 9980.750481238027, 10069.144122749649, 10248.48757562104, 10261.692149235534, 10488.580456781643, 11287.43562821872, 11315.943420282845, 11346.149038821955, 11374.431278435879, 11455.427228638702, 9642.0, 9665.130138287588, 9711.125998660154, 9793.167580755431, 9919.40483570988, 9926.205903527556, 10241.948790256001, 10701.411422371844, 10801.891981080404, 10815.35107893529, 7924.167962363868, 8083.820390576727, 8130.796730081559, 8360.372972027244, 8367.246947774729, 8719.694810681596, 8853.867191992254, 8928.86606700887, 8950.955245223733, 8967.865482017645, 8113.472624279403, 8557.871631925402, 8644.827103458021, 8729.693477072778, 8760.649574017223], "unit": "score", "name": "yui.html", "value": 5554.451118257584}], "name": "dromaeo_css", "value": 6188.245297828151}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 110.0, 114.0, 114.0, 115.0, 125.0, 115.0, 113.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [149.0, 132.0, 154.0, 170.0, 143.0, 161.0, 164.0, 144.0, 166.0, 141.0], "unit": "score", "name": "audio-beat-detection", "value": 152.4}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 161.0, 165.0, 164.0, 168.0, 165.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 163.6}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 73.0, 74.0, 74.0, 75.0, 139.0, 73.0, 72.0, 72.0], "unit": "score", "name": "audio-fft", "value": 79.9}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 133.0, 98.0, 98.0, 97.0, 136.0, 98.0, 98.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 108.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 112.0, 109.0, 111.0, 110.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 148.0, 147.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 96.0, 97.0, 97.0, 97.0, 97.0, 98.0, 96.0, 101.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 71.0, 70.0, 74.0, 71.0, 70.0, 70.0, 68.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 73.0, 68.0, 74.0, 68.0, 68.0, 69.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.1}, {"lowerIsBetter": true, "replicates": [85.0, 93.0, 86.0, 87.0, 84.0, 84.0, 83.0, 84.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [136.0, 122.0, 125.0, 134.0, 127.0, 130.0, 129.0, 130.0, 123.0, 136.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.2}, {"lowerIsBetter": true, "replicates": [138.0, 148.0, 148.0, 141.0, 143.0, 139.0, 147.0, 146.0, 146.0, 149.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.5}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 69.0, 72.0, 71.0, 70.0, 69.0, 70.0, 71.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.8}], "name": "kraken", "value": 1543.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.50418760469012], "unit": "score", "name": "Richards", "value": 210.75293999999994}, {"lowerIsBetter": false, "replicates": [186.53236336504384], "unit": "score", "name": "DeltaBlue", "value": 354.4585980000001}, {"lowerIsBetter": false, "replicates": [278.39643652561244], "unit": "score", "name": "Encrypt", "value": 956.1221520000003}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1061.5711252653928], "unit": "score", "name": "RayTrace", "value": 697.0696380000003}, {"lowerIsBetter": false, "replicates": [709.2198581560284], "unit": "score", "name": "Earley", "value": 939.71283}, {"lowerIsBetter": false, "replicates": [12382.716049382716], "unit": "score", "name": "Boyer", "value": 53.822036889332054}, {"lowerIsBetter": false, "replicates": [43063.82978723404], "unit": "score", "name": "RegExp", "value": 21.154295948616586}, {"lowerIsBetter": false, "replicates": [611.8220597196831], "unit": "score", "name": "Splay", "value": 133.19395517928285}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20273.53742543736}]} 04:29:57 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "20273.54"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1543.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6188.25"}}} 04:29:57 INFO - Return code: 0 04:29:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:57 INFO - # TBPL SUCCESS # 04:29:57 INFO - Running post-action listener: _resource_record_post_action 04:29:57 INFO - Running post-run listener: _resource_record_post_run 04:29:58 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 36864; Write bytes: 311947264; Read time: 28; Write time: 151868 04:29:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5537792; Read time: 0; Write time: 388 04:29:58 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 36864; Write bytes: 306409472; Read time: 28; Write time: 151480 04:29:58 INFO - Running post-run listener: _upload_blobber_files 04:29:58 INFO - Blob upload gear active. 04:29:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:29:58 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 04:29:58 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'] 04:29:58 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 04:29:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:29:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:29:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:29:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:59 INFO - (blobuploader) - INFO - Done attempting. 04:29:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:29:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:30:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:00 INFO - (blobuploader) - INFO - Done attempting. 04:30:00 INFO - (blobuploader) - INFO - Iteration through files over. 04:30:00 INFO - Return code: 0 04:30:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:30:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:30:00 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45051ee14baa500317178385a091e010026b58613817753aecfa2a775e8263969e2b54f7897a13ff4fea565ef3e368d12f534068032cf8578197124f88ea5b1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15ea8843f4ee708544c516db8ee94050fa76d528d217c3f9d81ff450f8588600b5ca5ed0cb3c62c571b58d798392d8af2ee3f7b733f6f8796df2484372464082"} 04:30:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:30:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:30:00 INFO - Contents: 04:30:00 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/45051ee14baa500317178385a091e010026b58613817753aecfa2a775e8263969e2b54f7897a13ff4fea565ef3e368d12f534068032cf8578197124f88ea5b1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15ea8843f4ee708544c516db8ee94050fa76d528d217c3f9d81ff450f8588600b5ca5ed0cb3c62c571b58d798392d8af2ee3f7b733f6f8796df2484372464082"} 04:30:00 INFO - Copying logs to upload dir... 04:30:00 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1289.100861 ========= master_lag: 4.28 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 33 secs) (at 2016-01-13 04:30:04.874290) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 04:30:04.877490) ========= 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=4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369 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/45051ee14baa500317178385a091e010026b58613817753aecfa2a775e8263969e2b54f7897a13ff4fea565ef3e368d12f534068032cf8578197124f88ea5b1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15ea8843f4ee708544c516db8ee94050fa76d528d217c3f9d81ff450f8588600b5ca5ed0cb3c62c571b58d798392d8af2ee3f7b733f6f8796df2484372464082"} build_url:https://queue.taskcluster.net/v1/task/ZhxHAglTTOaiBRLijcD9Eg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011226 build_url: 'https://queue.taskcluster.net/v1/task/ZhxHAglTTOaiBRLijcD9Eg/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/45051ee14baa500317178385a091e010026b58613817753aecfa2a775e8263969e2b54f7897a13ff4fea565ef3e368d12f534068032cf8578197124f88ea5b1a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/15ea8843f4ee708544c516db8ee94050fa76d528d217c3f9d81ff450f8588600b5ca5ed0cb3c62c571b58d798392d8af2ee3f7b733f6f8796df2484372464082"}' ========= master_lag: 0.15 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 04:30:05.042845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:30:05.043177) ========= 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=4dd8011cc2821079d74a932a000001ae-1452686842.832962-73768369 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.01 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 04:30:05.058858) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 04:30:05.059165) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 04:30:05.059430) ========= ========= Total master_lag: 4.58 =========