builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-003 starttime: 1452677369.06 results: success (0) buildid: 20160113010530 builduid: d4c03f23a8284a7cb57dfb0e92ea652b revision: eb992ed0700f1b223a62c2dd1f39d7d79ff1c90d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.058076) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.058566) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.058865) ========= 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=7de08804244eb36560b44971000001c3-1452675945.364079-490770854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006510 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.087803) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.088404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.127692) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.127991) ========= 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=7de08804244eb36560b44971000001c3-1452675945.364079-490770854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004638 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.184172) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.184454) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.184830) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.185098) ========= 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=7de08804244eb36560b44971000001c3-1452675945.364079-490770854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-13 01:29:29-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-01-13 01:29:30 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103994 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.301711) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.302028) ========= 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=7de08804244eb36560b44971000001c3-1452675945.364079-490770854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020549 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.351292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.351695) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev eb992ed0700f1b223a62c2dd1f39d7d79ff1c90d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev eb992ed0700f1b223a62c2dd1f39d7d79ff1c90d --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=7de08804244eb36560b44971000001c3-1452675945.364079-490770854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-13 01:29:30,167 truncating revision to first 12 chars 2016-01-13 01:29:30,167 Setting DEBUG logging. 2016-01-13 01:29:30,167 attempt 1/10 2016-01-13 01:29:30,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/eb992ed0700f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-13 01:29:30,450 unpacking tar archive at: fx-team-eb992ed0700f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.568266 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.933301) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.933673) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.943347) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.943680) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-13 01:29:29.944138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-13 01:29:29.944457) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1452675945.364079-490770854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:29:30 INFO - MultiFileLogger online at 20160113 01:29:30 in /builds/slave/test 01:29:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:29:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:29:30 INFO - {'append_to_log': False, 01:29:30 INFO - 'base_work_dir': '/builds/slave/test', 01:29:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:29:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:29:30 INFO - 'branch': 'Fx-Team-Non-PGO', 01:29:30 INFO - 'buildbot_json_path': 'buildprops.json', 01:29:30 INFO - 'config_files': ('talos/linux_config.py',), 01:29:30 INFO - 'default_actions': ('clobber', 01:29:30 INFO - 'read-buildbot-config', 01:29:30 INFO - 'download-and-extract', 01:29:30 INFO - 'populate-webroot', 01:29:30 INFO - 'create-virtualenv', 01:29:30 INFO - 'install', 01:29:30 INFO - 'run-tests'), 01:29:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:29:30 INFO - 'download_minidump_stackwalk': True, 01:29:30 INFO - 'download_symbols': 'ondemand', 01:29:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:29:30 INFO - 'tooltool.py': '/tools/tooltool.py', 01:29:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:29:30 INFO - '/tools/misc-python/virtualenv.py')}, 01:29:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:29:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:29:30 INFO - 'installer_path': 'installer.exe', 01:29:30 INFO - 'log_level': 'info', 01:29:30 INFO - 'log_name': 'talos', 01:29:30 INFO - 'log_to_console': True, 01:29:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:29:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:29:30 INFO - 'opt_config_files': (), 01:29:30 INFO - 'pip_index': False, 01:29:30 INFO - 'sps_profile': False, 01:29:30 INFO - 'sps_profile_interval': 0, 01:29:30 INFO - 'suite': 'dromaeojs-e10s', 01:29:30 INFO - 'system_bits': '32', 01:29:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:29:30 INFO - 'title': 'talos-linux64-ix-003', 01:29:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:29:30 INFO - 'use_talos_json': True, 01:29:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:29:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:29:30 INFO - 'work_dir': 'build'} 01:29:30 INFO - ##### 01:29:30 INFO - ##### Running clobber step. 01:29:30 INFO - ##### 01:29:30 INFO - Running pre-action listener: _resource_record_pre_action 01:29:30 INFO - Running main action method: clobber 01:29:30 INFO - rmtree: /builds/slave/test/build 01:29:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:29:31 INFO - Running post-action listener: _resource_record_post_action 01:29:31 INFO - ##### 01:29:31 INFO - ##### Running read-buildbot-config step. 01:29:31 INFO - ##### 01:29:31 INFO - Running pre-action listener: _resource_record_pre_action 01:29:31 INFO - Running main action method: read_buildbot_config 01:29:31 INFO - Using buildbot properties: 01:29:31 INFO - { 01:29:31 INFO - "project": "", 01:29:31 INFO - "product": "firefox", 01:29:31 INFO - "script_repo_revision": "production", 01:29:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:29:31 INFO - "repository": "", 01:29:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:29:31 INFO - "buildid": "20160113010530", 01:29:31 INFO - "pgo_build": "False", 01:29:31 INFO - "basedir": "/builds/slave/test", 01:29:31 INFO - "buildnumber": 681, 01:29:31 INFO - "slavename": "talos-linux64-ix-003", 01:29:31 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:29:31 INFO - "platform": "ubuntu64_hw", 01:29:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:29:31 INFO - "branch": "fx-team", 01:29:31 INFO - "repo_path": "integration/fx-team", 01:29:31 INFO - "revision": "eb992ed0700f1b223a62c2dd1f39d7d79ff1c90d", 01:29:31 INFO - "stage_platform": "linux64", 01:29:31 INFO - "builduid": "d4c03f23a8284a7cb57dfb0e92ea652b", 01:29:31 INFO - "slavebuilddir": "test" 01:29:31 INFO - } 01:29:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:29:31 INFO - Running post-action listener: _resource_record_post_action 01:29:31 INFO - ##### 01:29:31 INFO - ##### Running download-and-extract step. 01:29:31 INFO - ##### 01:29:31 INFO - Running pre-action listener: _resource_record_pre_action 01:29:31 INFO - Running main action method: download_and_extract 01:29:31 INFO - mkdir: /builds/slave/test/build/tests 01:29:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:31 INFO - https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:29:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/test_packages.json 01:29:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/test_packages.json 01:29:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:29:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:29:33 INFO - Downloaded 1302 bytes. 01:29:33 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:29:33 INFO - Using the following test package requirements: 01:29:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:29:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:29:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:29:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:29:33 INFO - u'jsshell-linux-x86_64.zip'], 01:29:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:29:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:29:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:29:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:29:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:29:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:29:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:29:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:29:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:29:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:29:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:29:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:29:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:29:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:33 INFO - https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:29:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:29:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:29:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/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 01:29:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/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 01:29:37 INFO - Downloaded 22759275 bytes. 01:29:37 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 01:29:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:29:37 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 01:29:38 INFO - Return code: 0 01:29:38 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 01:29: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')]} 01:29:38 INFO - https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:29:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:29:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:29:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/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 01:29:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/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 01:29:40 INFO - Downloaded 22759275 bytes. 01:29:40 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 01:29:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:29:40 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 01:29:42 INFO - Return code: 0 01:29:42 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')]} 01:29:42 INFO - https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:29:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:29:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:29:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/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 01:29:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/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 01:29:44 INFO - Downloaded 11132285 bytes. 01:29:44 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 01:29:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:29:44 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 01:29:44 INFO - Return code: 0 01:29:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:44 INFO - https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:29:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:29:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:29:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/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 01:29:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WGxwc6AcT-q1eusaWSaV4g/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 01:29:47 INFO - Downloaded 53856548 bytes. 01:29:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:29:47 INFO - mkdir: /builds/slave/test/properties 01:29:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:29:47 INFO - Writing to file /builds/slave/test/properties/build_url 01:29:47 INFO - Contents: 01:29:47 INFO - build_url:https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:29:47 INFO - Running post-action listener: _resource_record_post_action 01:29:47 INFO - Running post-action listener: set_extra_try_arguments 01:29:47 INFO - ##### 01:29:47 INFO - ##### Running populate-webroot step. 01:29:47 INFO - ##### 01:29:47 INFO - Running pre-action listener: _resource_record_pre_action 01:29:47 INFO - Running main action method: populate_webroot 01:29:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:29:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:29:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:29:47 INFO - '--tppagecycles', 01:29:47 INFO - '7'], 01:29:47 INFO - 'tests': ['tsvgm']}}, 01:29:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:29:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:29:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:29:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:29:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:29:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:29:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:29:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:29:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:29:47 INFO - 'talos_options': ['--e10s'], 01:29:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:29:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:29:47 INFO - 'tests': ['damp', 'tps']}, 01:29:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:29:47 INFO - 'talos_options': ['--e10s'], 01:29:47 INFO - 'tests': ['damp', 'tps']}, 01:29:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:29:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:29:47 INFO - 'other': {'tests': ['a11yr', 01:29:47 INFO - 'ts_paint', 01:29:47 INFO - 'tpaint', 01:29:47 INFO - 'sessionrestore', 01:29:47 INFO - 'sessionrestore_no_auto_restore']}, 01:29:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:29:47 INFO - 'tests': ['a11yr', 01:29:47 INFO - 'ts_paint', 01:29:47 INFO - 'tpaint', 01:29:47 INFO - 'sessionrestore', 01:29:47 INFO - 'sessionrestore_no_auto_restore']}, 01:29:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:29:47 INFO - 'tests': ['a11yr', 01:29:47 INFO - 'ts_paint', 01:29:47 INFO - 'tpaint', 01:29:47 INFO - 'sessionrestore', 01:29:47 INFO - 'sessionrestore_no_auto_restore']}, 01:29:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:29:47 INFO - 'tests': ['a11yr', 01:29:47 INFO - 'ts_paint', 01:29:47 INFO - 'tpaint', 01:29:47 INFO - 'sessionrestore', 01:29:47 INFO - 'sessionrestore_no_auto_restore']}, 01:29:47 INFO - 'other_l64': {'tests': ['a11yr', 01:29:47 INFO - 'ts_paint', 01:29:47 INFO - 'tpaint', 01:29:47 INFO - 'sessionrestore', 01:29:47 INFO - 'sessionrestore_no_auto_restore']}, 01:29:47 INFO - 'other_nol64': {'tests': ['a11yr', 01:29:47 INFO - 'ts_paint', 01:29:47 INFO - 'tpaint', 01:29:47 INFO - 'sessionrestore', 01:29:47 INFO - 'sessionrestore_no_auto_restore']}, 01:29:47 INFO - 'svgr': {'tests': ['tsvgx', 01:29:47 INFO - 'tsvgr_opacity', 01:29:47 INFO - 'tart', 01:29:47 INFO - 'tscrollx', 01:29:47 INFO - 'cart']}, 01:29:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:29:47 INFO - 'tests': ['tsvgx', 01:29:47 INFO - 'tsvgr_opacity', 01:29:47 INFO - 'tart', 01:29:47 INFO - 'tscrollx', 01:29:47 INFO - 'cart']}, 01:29:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:29:47 INFO - 'tests': ['tp5o']}, 01:29:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:29:47 INFO - 'talos_options': ['--e10s'], 01:29:47 INFO - 'tests': ['tp5o']}, 01:29:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:29:47 INFO - 'talos_options': ['--xperf_path', 01:29:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:29:47 INFO - 'tests': ['tp5n']}, 01:29:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:29:47 INFO - 'talos_options': ['--e10s', 01:29:47 INFO - '--xperf_path', 01:29:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:29:47 INFO - 'tests': ['tp5n']}}, 01:29:47 INFO - 'talos.zip': {'path': '', 01:29:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:29:47 INFO - Running post-action listener: _resource_record_post_action 01:29:47 INFO - ##### 01:29:47 INFO - ##### Running create-virtualenv step. 01:29:47 INFO - ##### 01:29:47 INFO - Running pre-action listener: _resource_record_pre_action 01:29:47 INFO - Running main action method: create_virtualenv 01:29:47 INFO - Creating virtualenv /builds/slave/test/build/venv 01:29:47 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 01:29:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:29:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:29:47 INFO - Using real prefix '/usr' 01:29:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:29:47 INFO - Installing distribute.............................................................................................................................................................................................done. 01:29:49 INFO - Installing pip.................done. 01:29:49 INFO - Return code: 0 01:29:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:29:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:29:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:49 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 0x7fcdc7db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e3d0>, '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 0x18d9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18da360>, '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': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', '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 01:29:49 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 01:29:49 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 01:29:49 INFO - Using env: {'DISPLAY': ':0', 01:29:49 INFO - 'HOME': '/home/cltbld', 01:29:49 INFO - 'LANG': 'en_US.UTF-8', 01:29:49 INFO - 'LANGUAGE': 'en_US:en', 01:29:49 INFO - 'LOGNAME': 'cltbld', 01:29:49 INFO - 'MAIL': '/var/mail/cltbld', 01:29:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:49 INFO - 'MOZ_NO_REMOTE': '1', 01:29:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:29:49 INFO - 'NO_EM_RESTART': '1', 01:29:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:29:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:49 INFO - 'PWD': '/builds/slave/test', 01:29:49 INFO - 'SHELL': '/bin/bash', 01:29:49 INFO - 'SHLVL': '1', 01:29:49 INFO - 'TERM': 'linux', 01:29:49 INFO - 'TMOUT': '86400', 01:29:49 INFO - 'USER': 'cltbld', 01:29:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', 01:29:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:49 INFO - '_': '/tools/buildbot/bin/python'} 01:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:29:50 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 01:29:50 INFO - Cleaning up... 01:29:50 INFO - Return code: 0 01:29:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:29: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')]} 01:29:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:29:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29: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')]} 01:29:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:29:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:50 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 0x7fcdc7db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e3d0>, '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 0x18d9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18da360>, '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': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', '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 01:29:50 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 01:29:50 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 01:29:50 INFO - Using env: {'DISPLAY': ':0', 01:29:50 INFO - 'HOME': '/home/cltbld', 01:29:50 INFO - 'LANG': 'en_US.UTF-8', 01:29:50 INFO - 'LANGUAGE': 'en_US:en', 01:29:50 INFO - 'LOGNAME': 'cltbld', 01:29:50 INFO - 'MAIL': '/var/mail/cltbld', 01:29:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:50 INFO - 'MOZ_NO_REMOTE': '1', 01:29:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:29:50 INFO - 'NO_EM_RESTART': '1', 01:29:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:29:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:50 INFO - 'PWD': '/builds/slave/test', 01:29:50 INFO - 'SHELL': '/bin/bash', 01:29:50 INFO - 'SHLVL': '1', 01:29:50 INFO - 'TERM': 'linux', 01:29:50 INFO - 'TMOUT': '86400', 01:29:50 INFO - 'USER': 'cltbld', 01:29:50 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', 01:29:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:50 INFO - '_': '/tools/buildbot/bin/python'} 01:29:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:29:50 INFO - Downloading/unpacking psutil>=0.7.1 01:29:50 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 01:29:50 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 01:29:50 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 01:29:50 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 01:29:50 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 01:29:50 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 01:29:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:29:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:29:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:29:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:29:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:29:52 INFO - Installing collected packages: psutil 01:29:52 INFO - Running setup.py install for psutil 01:29:52 INFO - building 'psutil._psutil_linux' extension 01:29:52 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 01:29:52 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 01:29:52 INFO - building 'psutil._psutil_posix' extension 01:29:52 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 01:29:52 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 01:29:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:29:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:29:52 INFO - Successfully installed psutil 01:29:52 INFO - Cleaning up... 01:29:52 INFO - Return code: 0 01:29:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:29: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')]} 01:29:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:29:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29: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')]} 01:29:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:29:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:52 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 0x7fcdc7db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e3d0>, '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 0x18d9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18da360>, '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': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', '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 01:29:52 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 01:29:52 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 01:29:52 INFO - Using env: {'DISPLAY': ':0', 01:29:52 INFO - 'HOME': '/home/cltbld', 01:29:52 INFO - 'LANG': 'en_US.UTF-8', 01:29:52 INFO - 'LANGUAGE': 'en_US:en', 01:29:52 INFO - 'LOGNAME': 'cltbld', 01:29:52 INFO - 'MAIL': '/var/mail/cltbld', 01:29:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:52 INFO - 'MOZ_NO_REMOTE': '1', 01:29:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:29:52 INFO - 'NO_EM_RESTART': '1', 01:29:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:29:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:52 INFO - 'PWD': '/builds/slave/test', 01:29:52 INFO - 'SHELL': '/bin/bash', 01:29:52 INFO - 'SHLVL': '1', 01:29:52 INFO - 'TERM': 'linux', 01:29:52 INFO - 'TMOUT': '86400', 01:29:52 INFO - 'USER': 'cltbld', 01:29:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', 01:29:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:52 INFO - '_': '/tools/buildbot/bin/python'} 01:29:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:29:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:29:52 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 01:29:52 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 01:29:52 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 01:29:52 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 01:29:52 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 01:29:52 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 01:29:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:29:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:29:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:29:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:29:54 INFO - Installing collected packages: mozsystemmonitor 01:29:54 INFO - Running setup.py install for mozsystemmonitor 01:29:54 INFO - Successfully installed mozsystemmonitor 01:29:54 INFO - Cleaning up... 01:29:54 INFO - Return code: 0 01:29:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:29:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:29:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:54 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 0x7fcdc7db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e3d0>, '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 0x18d9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18da360>, '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': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', '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 01:29:54 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 01:29:54 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 01:29:54 INFO - Using env: {'DISPLAY': ':0', 01:29:54 INFO - 'HOME': '/home/cltbld', 01:29:54 INFO - 'LANG': 'en_US.UTF-8', 01:29:54 INFO - 'LANGUAGE': 'en_US:en', 01:29:54 INFO - 'LOGNAME': 'cltbld', 01:29:54 INFO - 'MAIL': '/var/mail/cltbld', 01:29:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:54 INFO - 'MOZ_NO_REMOTE': '1', 01:29:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:29:54 INFO - 'NO_EM_RESTART': '1', 01:29:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:29:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:54 INFO - 'PWD': '/builds/slave/test', 01:29:54 INFO - 'SHELL': '/bin/bash', 01:29:54 INFO - 'SHLVL': '1', 01:29:54 INFO - 'TERM': 'linux', 01:29:54 INFO - 'TMOUT': '86400', 01:29:54 INFO - 'USER': 'cltbld', 01:29:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', 01:29:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:54 INFO - '_': '/tools/buildbot/bin/python'} 01:29:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:29:55 INFO - Downloading/unpacking blobuploader==1.2.4 01:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:29:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:29:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:29:56 INFO - Downloading blobuploader-1.2.4.tar.gz 01:29:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:29:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:29:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:29:56 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 01:29:56 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 01:29:56 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 01:29:56 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 01:29:56 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 01:29:56 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 01:29:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:29:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:29:57 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 01:29:57 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 01:29:57 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 01:29:57 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 01:29:57 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 01:29:57 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 01:29:57 INFO - Downloading docopt-0.6.1.tar.gz 01:29:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:29:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:29:57 INFO - Installing collected packages: blobuploader, requests, docopt 01:29:57 INFO - Running setup.py install for blobuploader 01:29:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:29:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:29:57 INFO - Running setup.py install for requests 01:29:57 INFO - Running setup.py install for docopt 01:29:57 INFO - Successfully installed blobuploader requests docopt 01:29:57 INFO - Cleaning up... 01:29:58 INFO - Return code: 0 01:29:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:29:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:29:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:29:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:29:58 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 0x7fcdc7db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e3d0>, '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 0x18d9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18da360>, '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': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', '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 01:29:58 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 01:29:58 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 01:29:58 INFO - Using env: {'DISPLAY': ':0', 01:29:58 INFO - 'HOME': '/home/cltbld', 01:29:58 INFO - 'LANG': 'en_US.UTF-8', 01:29:58 INFO - 'LANGUAGE': 'en_US:en', 01:29:58 INFO - 'LOGNAME': 'cltbld', 01:29:58 INFO - 'MAIL': '/var/mail/cltbld', 01:29:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:29:58 INFO - 'MOZ_NO_REMOTE': '1', 01:29:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:29:58 INFO - 'NO_EM_RESTART': '1', 01:29:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:29:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:29:58 INFO - 'PWD': '/builds/slave/test', 01:29:58 INFO - 'SHELL': '/bin/bash', 01:29:58 INFO - 'SHLVL': '1', 01:29:58 INFO - 'TERM': 'linux', 01:29:58 INFO - 'TMOUT': '86400', 01:29:58 INFO - 'USER': 'cltbld', 01:29:58 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', 01:29:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:29:58 INFO - '_': '/tools/buildbot/bin/python'} 01:29:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:29:58 INFO - Running setup.py (path:/tmp/pip-O66rIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:29:58 INFO - Running setup.py (path:/tmp/pip-dn8RlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:29:58 INFO - Running setup.py (path:/tmp/pip-8aHvf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:29:58 INFO - Running setup.py (path:/tmp/pip-VMUHeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:29:58 INFO - Running setup.py (path:/tmp/pip-ULq554-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:29:58 INFO - Running setup.py (path:/tmp/pip-DhAMqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:29:58 INFO - Running setup.py (path:/tmp/pip-Z9R_PP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:29:58 INFO - Running setup.py (path:/tmp/pip-BpvQCY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:29:58 INFO - Running setup.py (path:/tmp/pip-5h0UoP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:29:58 INFO - Running setup.py (path:/tmp/pip-kKXi3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:29:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:29:58 INFO - Running setup.py (path:/tmp/pip-WS_fPp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:29:59 INFO - Running setup.py (path:/tmp/pip-J_C1FG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:29:59 INFO - Running setup.py (path:/tmp/pip-B91SNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:29:59 INFO - Running setup.py (path:/tmp/pip-gecEKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:29:59 INFO - Running setup.py (path:/tmp/pip-cWqhbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:29:59 INFO - Running setup.py (path:/tmp/pip-EIn3w1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:29:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:29:59 INFO - Running setup.py (path:/tmp/pip-0iSEfo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:29:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:29:59 INFO - Running setup.py install for manifestparser 01:29:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:29:59 INFO - Running setup.py install for mozcrash 01:29:59 INFO - Running setup.py install for mozdebug 01:29:59 INFO - Running setup.py install for mozdevice 01:29:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:29:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:29:59 INFO - Running setup.py install for mozfile 01:29:59 INFO - Running setup.py install for mozhttpd 01:30:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Running setup.py install for mozinfo 01:30:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Running setup.py install for mozInstall 01:30:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Running setup.py install for mozleak 01:30:00 INFO - Running setup.py install for mozlog 01:30:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Running setup.py install for moznetwork 01:30:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Running setup.py install for mozprocess 01:30:00 INFO - Running setup.py install for mozprofile 01:30:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Running setup.py install for mozrunner 01:30:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:30:00 INFO - Running setup.py install for mozscreenshot 01:30:01 INFO - Running setup.py install for moztest 01:30:01 INFO - Running setup.py install for mozversion 01:30:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:30:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:30:01 INFO - Cleaning up... 01:30:01 INFO - Return code: 0 01:30:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:30: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')]} 01:30:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30: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')]} 01:30:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30: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', '-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 0x7fcdc7db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e3d0>, '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 0x18d9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18da360>, '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': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', '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 01:30:01 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 01:30:01 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 01:30:01 INFO - Using env: {'DISPLAY': ':0', 01:30:01 INFO - 'HOME': '/home/cltbld', 01:30:01 INFO - 'LANG': 'en_US.UTF-8', 01:30:01 INFO - 'LANGUAGE': 'en_US:en', 01:30:01 INFO - 'LOGNAME': 'cltbld', 01:30:01 INFO - 'MAIL': '/var/mail/cltbld', 01:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:01 INFO - 'MOZ_NO_REMOTE': '1', 01:30:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:30:01 INFO - 'NO_EM_RESTART': '1', 01:30:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:01 INFO - 'PWD': '/builds/slave/test', 01:30:01 INFO - 'SHELL': '/bin/bash', 01:30:01 INFO - 'SHLVL': '1', 01:30:01 INFO - 'TERM': 'linux', 01:30:01 INFO - 'TMOUT': '86400', 01:30:01 INFO - 'USER': 'cltbld', 01:30:01 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', 01:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:01 INFO - '_': '/tools/buildbot/bin/python'} 01:30:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:30:01 INFO - Running setup.py (path:/tmp/pip-8BzJpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:30:01 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)) 01:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:30:01 INFO - Running setup.py (path:/tmp/pip-0cvfOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:30:01 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)) 01:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:30:01 INFO - Running setup.py (path:/tmp/pip-sEW9NE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:30:01 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)) 01:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:30:01 INFO - Running setup.py (path:/tmp/pip-dJLcap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:30:01 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)) 01:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:30:01 INFO - Running setup.py (path:/tmp/pip-RQG0Ki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:30:01 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)) 01:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:30:01 INFO - Running setup.py (path:/tmp/pip-97KICa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:30:01 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)) 01:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:30:01 INFO - Running setup.py (path:/tmp/pip-eAcypI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:30:01 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)) 01:30:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:30:01 INFO - Running setup.py (path:/tmp/pip-36y20h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:30:02 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)) 01:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:30:02 INFO - Running setup.py (path:/tmp/pip-_lA5vW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:30:02 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)) 01:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:30:02 INFO - Running setup.py (path:/tmp/pip-0q2Lws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:30:02 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)) 01:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:30:02 INFO - Running setup.py (path:/tmp/pip-wJ9mp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:30:02 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)) 01:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:30:02 INFO - Running setup.py (path:/tmp/pip-BbXi9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:30:02 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)) 01:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:30:02 INFO - Running setup.py (path:/tmp/pip-Cf3uKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:30:02 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)) 01:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:30:02 INFO - Running setup.py (path:/tmp/pip-M_iL_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:30:02 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)) 01:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:30:02 INFO - Running setup.py (path:/tmp/pip-V72ITU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:30:02 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)) 01:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:30:02 INFO - Running setup.py (path:/tmp/pip-yy79iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:30:02 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)) 01:30:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:30:02 INFO - Running setup.py (path:/tmp/pip-Lu7SsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:30:02 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)) 01:30:02 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)) 01:30:02 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)) 01:30:02 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)) 01:30:02 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)) 01:30:02 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)) 01:30:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:30:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:30:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:30:04 INFO - Downloading blessings-1.5.1.tar.gz 01:30:04 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 01:30:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:30:04 INFO - Installing collected packages: blessings 01:30:04 INFO - Running setup.py install for blessings 01:30:04 INFO - Successfully installed blessings 01:30:04 INFO - Cleaning up... 01:30:04 INFO - Return code: 0 01:30:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:30:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:30:04 INFO - Reading from file tmpfile_stdout 01:30:04 INFO - Current package versions: 01:30:04 INFO - argparse == 1.2.1 01:30:04 INFO - blessings == 1.5.1 01:30:04 INFO - blobuploader == 1.2.4 01:30:04 INFO - docopt == 0.6.1 01:30:04 INFO - manifestparser == 1.1 01:30:04 INFO - mozInstall == 1.12 01:30:04 INFO - mozcrash == 0.16 01:30:04 INFO - mozdebug == 0.1 01:30:04 INFO - mozdevice == 0.47 01:30:04 INFO - mozfile == 1.2 01:30:04 INFO - mozhttpd == 0.7 01:30:04 INFO - mozinfo == 0.9 01:30:04 INFO - mozleak == 0.1 01:30:04 INFO - mozlog == 3.1 01:30:04 INFO - moznetwork == 0.27 01:30:04 INFO - mozprocess == 0.22 01:30:04 INFO - mozprofile == 0.28 01:30:04 INFO - mozrunner == 6.11 01:30:04 INFO - mozscreenshot == 0.1 01:30:04 INFO - mozsystemmonitor == 0.0 01:30:04 INFO - moztest == 0.7 01:30:04 INFO - mozversion == 1.4 01:30:04 INFO - psutil == 3.1.1 01:30:04 INFO - requests == 1.2.3 01:30:04 INFO - wsgiref == 0.1.2 01:30:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:30:04 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')]} 01:30:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:04 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')]} 01:30:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:04 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 0x7fcdc7db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e3d0>, '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 0x18d9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18da360>, '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': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', '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 01:30:04 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 01:30:04 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 01:30:04 INFO - Using env: {'DISPLAY': ':0', 01:30:04 INFO - 'HOME': '/home/cltbld', 01:30:04 INFO - 'LANG': 'en_US.UTF-8', 01:30:04 INFO - 'LANGUAGE': 'en_US:en', 01:30:04 INFO - 'LOGNAME': 'cltbld', 01:30:04 INFO - 'MAIL': '/var/mail/cltbld', 01:30:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:04 INFO - 'MOZ_NO_REMOTE': '1', 01:30:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:30:04 INFO - 'NO_EM_RESTART': '1', 01:30:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:30:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:04 INFO - 'PWD': '/builds/slave/test', 01:30:04 INFO - 'SHELL': '/bin/bash', 01:30:04 INFO - 'SHLVL': '1', 01:30:04 INFO - 'TERM': 'linux', 01:30:04 INFO - 'TMOUT': '86400', 01:30:04 INFO - 'USER': 'cltbld', 01:30:04 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', 01:30:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:04 INFO - '_': '/tools/buildbot/bin/python'} 01:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:05 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)) 01:30:05 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)) 01:30:05 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)) 01:30:05 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)) 01:30:05 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)) 01:30:05 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)) 01:30:05 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)) 01:30:05 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)) 01:30:05 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)) 01:30:05 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)) 01:30:05 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)) 01:30:05 INFO - Cleaning up... 01:30:05 INFO - Return code: 0 01:30:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:05 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 0x7fcdc7db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e3d0>, '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 0x18d9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18da360>, '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': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', '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 01:30:05 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 01:30:05 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 01:30:05 INFO - Using env: {'DISPLAY': ':0', 01:30:05 INFO - 'HOME': '/home/cltbld', 01:30:05 INFO - 'LANG': 'en_US.UTF-8', 01:30:05 INFO - 'LANGUAGE': 'en_US:en', 01:30:05 INFO - 'LOGNAME': 'cltbld', 01:30:05 INFO - 'MAIL': '/var/mail/cltbld', 01:30:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:05 INFO - 'MOZ_NO_REMOTE': '1', 01:30:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:30:05 INFO - 'NO_EM_RESTART': '1', 01:30:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:30:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:05 INFO - 'PWD': '/builds/slave/test', 01:30:05 INFO - 'SHELL': '/bin/bash', 01:30:05 INFO - 'SHLVL': '1', 01:30:05 INFO - 'TERM': 'linux', 01:30:05 INFO - 'TMOUT': '86400', 01:30:05 INFO - 'USER': 'cltbld', 01:30:05 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', 01:30:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:05 INFO - '_': '/tools/buildbot/bin/python'} 01:30:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:05 INFO - Downloading/unpacking jsonschema 01:30:05 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 01:30:05 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 01:30:05 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 01:30:05 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 01:30:05 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 01:30:05 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 01:30:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:30:07 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 01:30:07 INFO - Downloading/unpacking functools32 (from jsonschema) 01:30:07 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 01:30:07 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 01:30:07 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 01:30:07 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 01:30:07 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 01:30:07 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 01:30:07 INFO - Downloading functools32-3.2.3-2.tar.gz 01:30:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 01:30:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:30:07 INFO - warning: no files found matching '*.txt' 01:30:07 INFO - no previously-included directories found matching 'build' 01:30:07 INFO - no previously-included directories found matching 'dist' 01:30:07 INFO - no previously-included directories found matching '.git*' 01:30:07 INFO - Installing collected packages: jsonschema, functools32 01:30:07 INFO - Running setup.py install for functools32 01:30:07 INFO - warning: no files found matching '*.txt' 01:30:07 INFO - no previously-included directories found matching 'build' 01:30:07 INFO - no previously-included directories found matching 'dist' 01:30:07 INFO - no previously-included directories found matching '.git*' 01:30:07 INFO - Successfully installed jsonschema functools32 01:30:07 INFO - Cleaning up... 01:30:07 INFO - Return code: 0 01:30:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:30:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:30:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:30:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:30:07 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 0x7fcdc7db9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18dbdd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x196e3d0>, '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 0x18d9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18da360>, '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': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', '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 01:30:07 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 01:30:07 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 01:30:07 INFO - Using env: {'DISPLAY': ':0', 01:30:07 INFO - 'HOME': '/home/cltbld', 01:30:07 INFO - 'LANG': 'en_US.UTF-8', 01:30:07 INFO - 'LANGUAGE': 'en_US:en', 01:30:07 INFO - 'LOGNAME': 'cltbld', 01:30:07 INFO - 'MAIL': '/var/mail/cltbld', 01:30:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:07 INFO - 'MOZ_NO_REMOTE': '1', 01:30:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:30:07 INFO - 'NO_EM_RESTART': '1', 01:30:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:30:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:07 INFO - 'PWD': '/builds/slave/test', 01:30:07 INFO - 'SHELL': '/bin/bash', 01:30:07 INFO - 'SHLVL': '1', 01:30:07 INFO - 'TERM': 'linux', 01:30:07 INFO - 'TMOUT': '86400', 01:30:07 INFO - 'USER': 'cltbld', 01:30:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', 01:30:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:07 INFO - '_': '/tools/buildbot/bin/python'} 01:30:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:30:07 INFO - Downloading/unpacking flake8 01:30:07 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 01:30:07 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 01:30:07 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 01:30:07 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 01:30:07 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 01:30:07 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 01:30:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:30:09 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 01:30:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:30:09 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 01:30:09 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 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 01:30:09 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 01:30:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:30:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:30:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:30:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:30:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:30:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:30:10 INFO - no previously-included directories found matching 'docs/_build' 01:30:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:30:10 INFO - Running setup.py install for pep8 01:30:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:30:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:30:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:30:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:30:10 INFO - no previously-included directories found matching 'docs/_build' 01:30:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:30:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:30:10 INFO - Cleaning up... 01:30:10 INFO - Return code: 0 01:30:10 INFO - Running post-action listener: _resource_record_post_action 01:30:10 INFO - Running post-action listener: _start_resource_monitoring 01:30:10 INFO - Starting resource monitoring. 01:30:10 INFO - ##### 01:30:10 INFO - ##### Running install step. 01:30:10 INFO - ##### 01:30:10 INFO - Running pre-action listener: _resource_record_pre_action 01:30:10 INFO - Running main action method: install 01:30:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:30:10 INFO - Reading from file tmpfile_stdout 01:30:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:30:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:30:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:30:10 INFO - Reading from file tmpfile_stdout 01:30:10 INFO - Output received: 01:30:10 INFO - Usage: mozinstall [options] installer 01:30:10 INFO - Options: 01:30:10 INFO - -h, --help show this help message and exit 01:30:10 INFO - -d DEST, --destination=DEST 01:30:10 INFO - Directory to install application into. [default: 01:30:10 INFO - "/builds/slave/test"] 01:30:10 INFO - --app=APP Application being installed. [default: firefox] 01:30:10 INFO - mkdir: /builds/slave/test/build/application 01:30:10 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'] 01:30:10 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 01:30:26 INFO - Reading from file tmpfile_stdout 01:30:26 INFO - Output received: 01:30:26 INFO - /builds/slave/test/build/application/firefox/firefox 01:30:26 INFO - Running post-action listener: _resource_record_post_action 01:30:26 INFO - ##### 01:30:26 INFO - ##### Running run-tests step. 01:30:26 INFO - ##### 01:30:26 INFO - Running pre-action listener: _resource_record_pre_action 01:30:26 INFO - Running main action method: run_tests 01:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:30:26 INFO - Python 2.7.3 01:30:26 INFO - Return code: 0 01:30:26 INFO - grabbing minidump binary from tooltool 01:30:26 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')]} 01:30:26 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 0x196e3d0>, '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 0x18d9ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18da360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:30:26 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 01:30:26 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 01:30:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:30:26 INFO - Return code: 0 01:30:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:30:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:30:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:30:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:30:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:30:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:30:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:30:27 INFO - Return code: 0 01:30:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 01:30:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 01:30:27 INFO - Using env: {'DISPLAY': ':0', 01:30:27 INFO - 'HOME': '/home/cltbld', 01:30:27 INFO - 'LANG': 'en_US.UTF-8', 01:30:27 INFO - 'LANGUAGE': 'en_US:en', 01:30:27 INFO - 'LOGNAME': 'cltbld', 01:30:27 INFO - 'MAIL': '/var/mail/cltbld', 01:30:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:30:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:30:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:30:27 INFO - 'MOZ_NO_REMOTE': '1', 01:30:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:30:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:30:27 INFO - 'NO_EM_RESTART': '1', 01:30:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:30:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:30:27 INFO - 'PWD': '/builds/slave/test', 01:30:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:30:27 INFO - 'SHELL': '/bin/bash', 01:30:27 INFO - 'SHLVL': '1', 01:30:27 INFO - 'TERM': 'linux', 01:30:27 INFO - 'TMOUT': '86400', 01:30:27 INFO - 'USER': 'cltbld', 01:30:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1452675945.364079-490770854', 01:30:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:30:27 INFO - '_': '/tools/buildbot/bin/python'} 01:30:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 01:30:27 INFO - mozversion application_buildid: 20160113010530 01:30:27 INFO - mozversion application_changeset: eb992ed0700f1b223a62c2dd1f39d7d79ff1c90d 01:30:27 INFO - mozversion application_display_name: Nightly 01:30:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:30:27 INFO - mozversion application_name: Firefox 01:30:27 INFO - mozversion application_remotingname: firefox 01:30:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:30:27 INFO - mozversion application_vendor: Mozilla 01:30:27 INFO - mozversion application_version: 46.0a1 01:30:27 INFO - mozversion platform_buildid: 20160113010530 01:30:27 INFO - mozversion platform_changeset: eb992ed0700f1b223a62c2dd1f39d7d79ff1c90d 01:30:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:30:27 INFO - mozversion platform_version: 46.0a1 01:30:27 INFO - using testdate: 1452677427 01:30:27 INFO - actual date: 1452677427 01:30:27 INFO - starting webserver on 'localhost:40809' 01:30:27 INFO - SUITE-START | Running 3 tests 01:30:27 INFO - TEST-START | dromaeo_css 01:30:27 INFO - operating with platform_type : linux_ 01:30:27 INFO - Initialising browser for dromaeo_css test... 01:30:27 INFO - TEST-INFO | started process 3465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6dU3S0/profile http://localhost:40809/getInfo.html) 01:30:31 INFO - PROCESS | 3465 | 01:30:31 INFO - PROCESS | 3465 | (process:3550): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:30:32 INFO - PROCESS | 3465 | __metrics Screen width/height:1600/1200 01:30:32 INFO - PROCESS | 3465 | colorDepth:24 01:30:32 INFO - PROCESS | 3465 | Browser inner width/height: 1024/697 01:30:32 INFO - PROCESS | 3465 | __metrics 01:30:32 INFO - PROCESS | 3465 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:30:33 INFO - TEST-INFO | 3465: exit 0 01:30:33 INFO - Browser initialized. 01:30:33 INFO - Running cycle 1/1 for dromaeo_css test... 01:30:33 INFO - TEST-INFO | started process 3599 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6dU3S0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:30:35 INFO - PROCESS | 3599 | 01:30:35 INFO - PROCESS | 3599 | (process:3654): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:30:45 INFO - PROCESS | 3599 | RSS: Main: 149909504 01:30:45 INFO - PROCESS | 3599 | 01:31:35 INFO - PROCESS | 3599 | 1452677495561 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] 01:33:47 INFO - PROCESS | 3599 | Cycle 1(1): loaded http://localhost:40809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40809/tests/dromaeo/cssquery-ext.html) 01:33:48 INFO - PROCESS | 3599 | RSS: Main: 153206784 01:33:48 INFO - PROCESS | 3599 | 01:36:50 INFO - PROCESS | 3599 | Cycle 1(1): loaded http://localhost:40809/tests/dromaeo/cssquery-ext.html (next: http://localhost:40809/tests/dromaeo/cssquery-jquery.html) 01:36:50 INFO - PROCESS | 3599 | RSS: Main: 151117824 01:36:50 INFO - PROCESS | 3599 | 01:39:52 INFO - PROCESS | 3599 | Cycle 1(1): loaded http://localhost:40809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40809/tests/dromaeo/cssquery-mootools.html) 01:39:53 INFO - PROCESS | 3599 | RSS: Main: 150986752 01:39:53 INFO - PROCESS | 3599 | 01:42:55 INFO - PROCESS | 3599 | Cycle 1(1): loaded http://localhost:40809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40809/tests/dromaeo/cssquery-prototype.html) 01:42:55 INFO - PROCESS | 3599 | RSS: Main: 150446080 01:42:55 INFO - PROCESS | 3599 | 01:45:58 INFO - PROCESS | 3599 | Cycle 1(1): loaded http://localhost:40809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40809/tests/dromaeo/cssquery-yui.html) 01:45:59 INFO - PROCESS | 3599 | RSS: Main: 150769664 01:45:59 INFO - PROCESS | 3599 | 01:49:01 INFO - PROCESS | 3599 | Cycle 1(1): loaded http://localhost:40809/tests/dromaeo/cssquery-yui.html (next: http://localhost:40809/tests/dromaeo/cssquery-dojo.html) 01:49:01 INFO - PROCESS | 3599 | RSS: Main: 153206784 01:49:01 INFO - PROCESS | 3599 | 01:49:01 INFO - PROCESS | 3599 | __start_tp_report 01:49:01 INFO - PROCESS | 3599 | _x_x_mozilla_page_load 01:49:01 INFO - PROCESS | 3599 | _x_x_mozilla_page_load_details 01:49:01 INFO - PROCESS | 3599 | |i|pagename|runs| 01:49:01 INFO - PROCESS | 3599 | |0;dojo.html;2609.960850587241;2641.0756235317654;2669.5728683410657;2688.7848972082234;2691.1388355726162;4441.866743997677;4528.886777830552;4560.817567297312;4569.451665800105;4578.816847326108;4470.994026344071;4533.863984080474;4538.7503687297185;4563.178627846986;4587.977060114703;4165;4165.354370072643;4187.371894215877;4243.702940794145;4244.427002354673;4040.3333449980864;4140.792960351985;4191.0360617058095;4220.556841531641;4228.090960443504;4084.979575102135;4148.170365926797;4157.708960372775;4159.459270294872;4180.393842892763;4126.958730412687;4134.462519872427;4135.110951145488;4143.958560414418;4178.791060446965;4021;4097.610726980932;4118.794060297003;4120.62914337708;4139.668826493873;4364.345348197764;4454.688171827974;4459.0413061191675;4465.620422264112;4482.462104547442;4876.561109500162;4881.951180488185;4893.143699852547;4901.338319326881;4927.7926907907795;4770.260609605517;4851.10254602896;4855.902881942377;4912.312276281324;4934.185859333242;4473.530279320689;4522.434695663075;4542.454905411306;4550.476695180097;4619.145458090264;5008.69947803133;5029.874253143701;5038.949610503848;5043.5712964398435;5081.923771143436;4588.334691469719;4702.694324868872;4792.065547218259;4814.855554333376;4838.177509823338;4746.38297021385;4845.709257444564;4854.320395144682;4859.392575928009;4866.270059491105;4757.35775670287;4759.119562880878;4778.784954677048;4784.545468180518;4799.856004319876;4743.5967942724565;4744.335792988984;4759.524047595212;4760.071786001766;4792.496787837296;3918.2163567286657;3989.341758609855;4016.3975403689096;4038.838446462167;4132.483439570054;3534.9646503534636;3542.840572174207;3575.213453040327;3581.283743251308;3582.194006348551;4175.498940127204;4182.498100227992;4184.853530126431;4203.243416185116;4231.513375961742;4722.268048452495;4813.4945830687275;4871.050145221719;4872.902541949141;4964.255361695702;4228.809703563347;4252.128313695685;4261.147770445923;4264.87205383839;4302.161078589707;4139.8965025874595;4338.522762496123;4345.739255644608;4361.520232774392;4385.188740083095;4594.425696787902;4611.700239484423;4664.883377915579;4676.251799712029;4712.670113092187;4877.244027175793;4887.877803054952;4892.339534162985;4898.4121905371585;4898.436679781871;4448.266036104006;4528.41130653013;4635.6986795858165;4639.930401043919;4679.3448917150945;4749.026449577759;4775.2598347256235;4782.7847746850775;4855.223164293696;4862.149123903232;4918.754062296943;4923.729194894315;4944.3572335596145;4947.851564453073;4995.600351971761;4776.42682878043;4781.569658730731;4783.617310615073;4790.7365094920115;4829.5653391194965;4607.032523170172;4676.906461870675;4698.929516057194;4716.787744551572;4740.928886066781;4594.88512787183;4602.470715867584;4620.699654522446;4632.907341853212;4691.7184968901975;4589.65577581676;4754.144254034307;4761.333413322069;4765.0469906019625;4811.206150985188;4607.907841843212;4630.884227894329;4643.2802915548145;4649.767511624473;4702.15361234981 01:49:01 INFO - PROCESS | 3599 | |1;ext.html;487.7414970065864;487.83901312566854;490.79631952739607;515.8684535443462;517.8839600660575;32278.19304517388;33232.33535329295;33255;33363.833180834095;33397.83301083491;36896.26207475855;37277.25445491095;37400.81299593498;37505.062373440676;37594;7612.429067819908;7749.535027898316;7785.260400261995;7785.299323060924;7795.8440831183625;7531.6610752516;7580.772576822704;7628.542287462742;7818.218178182165;7820.257075577811;7703;7847;7859.410544209179;7880.448368614199;7881.566513841736;7743.845123097534;7780.416468764865;7794.727184548542;7813.9609301953415;7834.33408160307;7703.075630924269;7818.921810781876;7875.4487185897015;7886.093099293597;7904.0910295315625;36638.81680591607;37147.62852371496;37236;37260.25479490422;37432.43851342232;2685.060228919882;2696.110283606405;2719.1162872066657;2751.697313295536;2930.4139172165437;27653.585196222073;28146.577801333;28181.85909070462;28285.858570707016;29104.854475727487;3490.703290220334;3503.1242189452637;3507.6316986716283;3549.4853246279404;3587.0852932502044;215232;215460;216191;216912;217771;41687;42879.785601071795;52893.471065289625;53171.73414132982;55612.72193639006;50156;50165.24752128721;50268.74865625649;50271;50530;12299.569515066929;12482;12499.750004999849;12524.373781310898;12526.937365313297;9200.769980750534;9251.583678734472;9284.582193801296;9289.72130836076;9297.256219502424;18257.45227643173;18685.626287474173;19070.713939290923;19257.614847702967;19327.323543676186;7152.249013853574;7524.473286869976;7546.773596792105;7555.622218889143;7575.924240757632;845.7166849105496;856.7472595584318;886.5318793281788;959.3859929645033;963.205355581648;25531.61702574463;25649.48701025969;25736.74263257381;25768.613470797955;25864.612030819553;895.8163576466809;910.9089091090971;917.8302014127274;1016.8627235323285;1032.4631191780381;13123.409351764098;13499.460021599223;13511.189328640314;13571.457141714222;13824.447022119204;270350;273795;274236;274630;274962;45287.547124528995;45424.3186352205;45532.77233613811;45631.54368456273;45675.314870276976;1201.0211677482823;1201.0631707268344;1215.5198696514826;1216.5863606373875;1220.6399112261904;24490.265292041266;24787.50424991454;25143.371415714755;25209.621855672547;25409.49181016406;39773.80113099416;39995.800021000876;40230.19539609133;40256.1948761029;40344.982750862924;241118;244010;244104;246076;246252;27264.591031134947;27655.585166222925;27850.30374240579;27896;29368.706312936596;36186.09534761547;36262.63737362698;36570.26859462849;36821.013371424204;37315;30374.240643984078;31064.844675776476;31112.22219444532;31232.531512027792;31253.531197031607;31415.84292078525;32202.35595288034;32303.192420189684;32351;32399.35201296008;31872.521912170872;32361.676383235867;32475.18812029718;32496.67503325031;32511.51232731558;27490.450190995667;28862.278443039093;29922.850385748803;31872.681273186972;32732.672673272962;23075.88462057679;23098.30705078783;23133.768662313163;23177.88411057934;23241.883790580938 01:49:01 INFO - PROCESS | 3599 | |2;jquery.html;333.3167007634349;338.5209927951948;344.8603315657159;344.9327381160674;347.33485375505876;14470.131792092481;14578.416863325467;15132.697346053099;15231.390744370212;15897.1256580888;9324.160825525702;9581.664641737541;11264.774704505904;14488.782668259984;14589.489367872127;4376.956230437702;4518.751468669222;4551.908961820762;4568.360429539867;4924.876878078041;4968.254761785725;5033.446320904697;5033.5721463675445;5037.017781532602;5045.974770126162;3325.8669653213965;3510.8420121094614;5002.649814512985;5022.899542009158;5150.510701483372;5286.629935904488;5306.3632364116165;5309.230161626542;5329.600279978998;5335.413104558495;5017.322661440695;5154.742262886878;5195.584353251731;5195.636305458619;5197.740112994373;11651.475683594259;11678.890505401972;18057.09714514269;18511.259549618;18588.44234672962;1725.887817291872;1803.666321730484;1805.7381679656507;1810.9456716298532;1910.703840904662;8900.688475903313;9023.639054437816;9032.458052516804;9396.34225604208;12215.572454964034;1658.4692898272438;1690.138029604898;1703.872209584286;1724.1896308735;1731.9220635071451;44900.3264951026;46361.536384636056;47203.29195062077;49738;50239.74880125612;8903.688370907117;9229.723108306762;9485.90514094864;9497.477638729937;9547.188488978376;11980.88019119815;11999.280043197436;12017.939910300393;12028.15802893789;12044.578439754741;6366.076918846741;6409.134766806515;6414.454771344394;6430.7749228776765;6464.191976003;5964.284285885721;6049.939500605025;6075.605085669417;6107.908381374283;6111.266648002268;4110.876673699794;4169;4207.453031105937;4211.768352740567;4230.323148296257;1706.5136436115647;1714.28857024336;1717.7165767648198;1723.93966211182;1739.6694628020637;713.3615414204362;806.2154044729045;823.0822632764424;910.6539514984396;933.9866245124116;10022.098011179029;10483.108935740394;14172.291385430688;14807.70384592302;14808.555743327717;388.93388124018986;402.4185052598966;406.9430279760836;413.171590960123;426.0222788699941;4695.882602934886;4962.776675049631;5554.666719996813;5663.773449061991;5752.7698892043845;414353;448878;459392;462517;463278;64150;64869.67565162144;64991.35008649948;65638;65857;458.6033081384645;459.9839005634787;467.3317156466218;467.47409164689725;467.53246753246754;9570.377925434825;9634.277429192978;9666.130048295687;9683.66107186245;9961.50192490387;29470.263243419085;30279.09162725122;31175.84412077925;31480.212994675316;31663.52504712385;40203.79898100491;40485.79757101196;40530.39204411877;40583.59416405916;40939;6445.677716114082;6612.140421745143;6714.496412768965;6726.529142959946;6932.549384290005;9405.75538850627;9808.80382392334;10101;10254.6410875619;10307.690769276935;8002.359811214972;8065.758027259191;8363.665453381796;8373;8499.405041647025;8825.602847871989;8902.465852048897;8981.191692747683;9161.404508706913;9507.429554226768;8391.874121888299;8638.870416943877;8787.165219304155;8823.382363234512;8840.602172902363;6570.8028759137305;6755.189377274758;6765.661716914233;6773.153355830521;6807.863842723217;7065.540739851893;8645.827083458422;8715.869261961203;8966.372353935161;8986.370954033155 01:49:01 INFO - PROCESS | 3599 | |3;mootools.html;1227.269774484182;1270.3140304235712;1271.3516106785537;1664.101385251964;1699.4986478988696;6171.3211546729935;6318.557700960934;7115.6442177891095;7299.1605965314;7338.816529586763;6702.96648516758;6841.760538381158;6883.793486195422;6916.965415172917;6935.341142591458;2122.5118222808765;2142.860714053589;2144.281665642012;2148.967765483519;2162.2107930605293;2040.1635329514902;2068.596623658387;2084.9270275540357;2087.0608226298227;2090.362439455965;2074.7925207479207;2078.7817279185692;2087.1547023455523;2096.140582361232;2160.3950893749775;2123.74515058194;2142.6678864775986;2144.592527419793;2150.9462263443384;2156.35309407178;2110.0399318310133;2166.447555873258;2168.533765240465;2170.2078741259484;2173.2936795541355;7285.6721447534455;7312.488125831194;7316.743913962986;7328.963355183243;7333.779986600411;4222.1555688862045;4372.803223854934;4374.081442896995;4379.671524635665;4379.693421460499;2762.944741105187;2801.6217810595717;2807.9719202807914;2809.8033137680372;2813.268550176969;845.4758050009034;858.2104463893234;864.6714248585561;882.3162049411693;886.933479988997;9885.555150018194;9894.158996485306;9902.950485247527;9903.851442228372;9957.65148219816;4040.131371755028;4075.633193012643;4149.958500415018;4160.54234034256;4165.8333666653;8420.873686894702;8441.113683063313;8467.576621168917;8510.872336914952;8527.872081918777;4311.849085282063;4331.956680433155;4353.477582690098;4393.538678438782;4399.076193999232;3343.648916863743;3445.7243420526297;3794.146317078635;3967.5238971323624;3968.1071758854027;3416.265502916885;3417.1457135716073;3432.090496018557;3437.2094418283937;3446.6897979181995;1092.956281748737;1112.1325366214367;1112.449337577904;1116.1294190531398;1131.9320840749417;1091.0998426298177;1091.2415870969758;1108.2242430298822;1140.3044143072718;1197.3474456421272;6542.7710030149665;6571.901421478682;6607.438367738796;6628.867422651617;6631.502637302222;435.938968544404;440.45383724181784;443.0629219201366;444.46885971264027;445.3720254441287;4773.64197685175;4787.593054590329;4789.928151077736;4824.831130910401;4831.299461578052;8636.0500344962;8800.603972821238;8933.910660893438;9032.45805251687;9122.680706175252;9034.051424600453;9062.592183351633;9074.637014519478;9115.270778337717;9123.771905702279;6707.932920670828;6868.896966545506;6870.416014638811;6889.689963951534;6907.516473846883;6610.438112760469;6624.403803657694;6648.667566621746;6648.767293144717;6655.467562594884;7873.488223265698;8033.156518565466;8039.83920321602;8076.676932922617;8170.182981701782;8148;8244.093149753402;8405.705800297204;8410.705625303084;8419.8737018946;5560.304961879765;5683.77264909399;5923.881522369615;6258.718357674006;6312.4634406076;6409.0066039763915;6463.7737679181;6490.383413575702;6491.675416229265;6496.0580715795;6130.448259656652;6158.168647232746;6198.81403557894;6224.62652240867;6336.9049464259;6146;6202.906956395748;6227.097070924781;6252.968735156295;6306.432421082125;6367.9044814328745;6394.1687580614225;6417.839554011187;6418.935810641834;6433.903491447539;5780.450857168562;5786.07422812348;5799.8550036249435;5820.0396934507025;5821.94178058231;5799.82600521985;6021.819345419644;6077.392260773887;6095;6095.2685677718955 01:49:01 INFO - PROCESS | 3599 | |4;prototype.html;296.1603853076528;305.4669601545302;308.77613730045715;314.85988735012927;319.63401904819;5539;5553.444655534445;5557.083081291592;5684.5452363810955;5722.170285308628;5486.862828429281;5533.6403133796275;5560.833175004756;5566;5566.582506312023;4087.3255912774507;4209.894752631178;4213.936790948138;4217.768022758754;4222.831086756526;4222.725522841021;4224.97887510562;4225.577442255781;4235.872923812275;4241.893952651178;4182.05903671673;4182.372644103393;4189.560096189902;4193.937090943638;4195;4176.415301857712;4184.414182014505;4185.727927684691;4188.1204946961025;4196.706230563862;3536.381133301662;3656.4149736042104;3658.1220507078374;3660.9267814643827;3663.084228942764;5175.456577059392;5303.867403314909;5318.840434786963;5336.30628018359;5346.27825243591;4752.310914917318;4756.191447453906;4758.547937945889;4764.285357196413;4770.904581908342;5753.395893431171;5773.336066352339;5785.1611516329895;5790.88418231633;5794.710264486759;3783.6783873370796;3817.7029544455118;3878.1855810279876;3882.8058597070317;3895.357266051098;6020.6989650517735;6091.025435930274;6093.055576385623;6098.054801505774;6102.755889764404;3993.880183594497;4006.6994975376965;4008.7995600219874;4010.8195131219163;4012.197560487914;4084.9795751021647;4086.4891888513935;4089.672826173899;4091.7135800494275;4092.3043082676018;4697.718136911796;4731.503192164773;4736.1474934511425;4736.360591320127;4736.715797052188;5510.559155267569;5753.453421924911;5754.136879468113;5754.338251101093;5754.798582049608;1435.2464955898238;1468.7723402872573;1469.889758268134;1470.375090586518;1470.808794856683;952.7094236257869;977.8239916815041;991.108002797488;992.2359782967075;1001.2040427859869;5020.7740651670765;5055.6713813602;5075.061113693979;5077.365329333833;5093.363329583802;5981.581289309706;6035.366286539938;6036.728347224385;6042.0332746760305;6042.486388657014;5088.898222035538;5091.898162036812;5093.719845408538;5093.745312734422;5096.643234973516;3165.572647692578;3220.178854392115;3252.1706964723844;3257.8696852126122;3264.6408895021527;5592.5246354059545;5669.744861481243;5671.489565939085;5673.432656734376;5680;6248.375162483715;6265.185525881698;6289.559730818799;6294.433500984934;6295.464885484694;5751.194832723422;5756.395578464201;5756.5682573807135;5758.3090029196765;5763.9249870045915;6031.969840150771;6057.697115144137;6058.5758996871555;6083.057126145454;6096.8780624388155;5777.62445441045;5956.761729530944;5968.403159683997;5978.8206353809455;5982.700864956648;5702.37273899879;5728.742206600629;5765.365809761007;5767.884642307046;5778.219940308173;4027.496562929634;4076.3681629347498;4077.103037331782;4077.7757223353;4079.7960101995377;5944.405559444021;6050.2437195350585;6054.303755068047;6087.147799308189;6097.054956481752;5847.152162936435;5876.031529437686;5877.911831322448;5880.470757631833;5882;5842.036064049385;5857.58996870215;5858.736356863866;5858.974679430998;5869.090291004901;5528.861778455571;5678.77284908599;5704.971475142764;5712.02895507773;5728.828135155952;5816.912746308724;5889.352171261244;5895.64626122434;5903.2916050072545;5907.85230369227;5721.570882183936;5730.770769169353;5740.770369185353;5740.856478588069;5742.1673857289625 01:49:01 INFO - PROCESS | 3599 | |5;yui.html;666.1240468783551;720.3121019426449;743.1862110988468;778.4628606261679;783.4280974888328;11173.385463799488;11458.598949036785;11460.083193344533;11469.885301146986;11502.367369794658;10841.403722795243;10876.075533579635;10877.238593298473;10881.782364352708;10883.1837612179;604.2567641800588;625.462102591773;763.912150102737;770.5184259837602;778.3967425245423;780.3484090784202;783.2832957843566;783.4241832253289;786.1705900275207;788.5584072919155;818.9754307370788;821.3880658909121;823.127484866041;823.1521532821204;824.1840577827937;808.7007807111347;808.9352851771844;813.4184058398245;814.3444527155638;818.4884447220487;606.4541912278941;609.1593600830869;609.8658295175054;611.0315150486484;611.8684482836167;11669.883301167049;11738.295702257892;11743.647690569296;11748.353840538766;11807.468663910058;10870.18473614482;11099.38953357565;11573.36346500942;11975.94012029943;12109.818352724717;10381.948090259575;10541.73645658857;10609.575616975311;10696.304740191863;10941.905809418995;3228.564143840575;3264.836758162106;3265.297960938386;3283.950740738891;3363.6636336366414;35277.647223527696;35366;35453.468197977054;35499;35580.99999999974;8852.159044890725;9056.456612603133;9185.35702500832;9222.86165707515;9303.34876558648;15902.68194636124;15911.840881591268;15912.52262432129;15929.840701593068;15952;6462.838429039218;6498.870022599616;6538.215414150332;6588.044733513614;6629.635370054597;3687.465317528997;3704.388775851954;3709.684676802502;3720.739548231598;3739.364308067635;2563.9743602563735;2584.4831033793316;2585.3665851866413;2590.6502622145767;2595.9740402596112;483.6469377354551;495.92561115832916;496.35226030030435;497.2615665736379;503.21498462398773;605.8031139879557;612.7732738886551;614.3641331222163;619.0930287129377;651.1535004494139;7278.344948954619;7550.272856395349;7628.732994345171;7734.690612375554;7920.287174154354;433.08186644314253;483.62519047738283;489.18306428264884;490.97299648519675;505.1283453566413;3508.1755787389943;3546.690770713595;3548.769329993542;3594.4788005739542;3598.9100272493397;46047.309290360674;46086;46155.53844461512;46248.768756156;46272;41056;41678;41689.791551042654;41956.16087678229;42002.369964450554;38011;38807.41788873113;38890;39412.21175576472;39510.01224969399;7105.431565474853;7398.297161769623;7496.1754207038275;7574.166841647525;7616.629006778833;28549.714502854706;29201;29202;29287;29730.702692972794;33902.152446189044;34442.311153777286;34485.827570861984;37719.434208486346;37918.81040594779;8996.59515321799;9069.863952040856;9106.772330691785;9159.267258619428;9474.95262523683;9472.289578281794;9662.565184566853;9707.223422126353;9784.951075244579;9992.900070999487;9319.720408387759;9353.204977576983;9358.672446464341;9369.484678342757;9389.436633801994;8783.736487905373;8792.856928599242;8858.335624828034;8910.509921954355;8920.197182253369;9054.958679751913;9075.818483630159;9211.907880921373;9251.814963700823;9263.907360926305;7263;7466.365358944333;7484.43866709988;7511.8497630046;7798.33714134305;7844.568548729874;8128.146544612967;8358.414910956175;8562.657493700182;8608.139186081342 01:49:01 INFO - PROCESS | 3599 | __end_tp_report 01:49:01 INFO - PROCESS | 3599 | __start_cc_report 01:49:01 INFO - PROCESS | 3599 | _x_x_mozilla_cycle_collect,324 01:49:01 INFO - PROCESS | 3599 | __end_cc_report 01:49:01 INFO - PROCESS | 3599 | __startTimestamp1452678541720__endTimestamp 01:49:01 INFO - PROCESS | 3599 | 01:49:01 INFO - PROCESS | 3599 | ------- Summary: start ------- 01:49:01 INFO - PROCESS | 3599 | Number of tests: 6 01:49:01 INFO - PROCESS | 3599 | 01:49:01 INFO - PROCESS | 3599 | [#0] dojo.html Cycles:165 Average:4483.96 Median:4607.91 stddev:464.54 (10.1%) stddev-sans-first:442.09 01:49:01 INFO - PROCESS | 3599 | Values: 2610.0 2641.1 2669.6 2688.8 2691.1 4441.9 4528.9 4560.8 4569.5 4578.8 4471.0 4533.9 4538.8 4563.2 4588.0 4165.0 4165.4 4187.4 4243.7 4244.4 4040.3 4140.8 4191.0 4220.6 4228.1 4085.0 4148.2 4157.7 4159.5 4180.4 4127.0 4134.5 4135.1 4144.0 4178.8 4021.0 4097.6 4118.8 4120.6 4139.7 4364.3 4454.7 4459.0 4465.6 4482.5 4876.6 4882.0 4893.1 4901.3 4927.8 4770.3 4851.1 4855.9 4912.3 4934.2 4473.5 4522.4 4542.5 4550.5 4619.1 5008.7 5029.9 5038.9 5043.6 5081.9 4588.3 4702.7 4792.1 4814.9 4838.2 4746.4 4845.7 4854.3 4859.4 4866.3 4757.4 4759.1 4778.8 4784.5 4799.9 4743.6 4744.3 4759.5 4760.1 4792.5 3918.2 3989.3 4016.4 4038.8 4132.5 3535.0 3542.8 3575.2 3581.3 3582.2 4175.5 4182.5 4184.9 4203.2 4231.5 4722.3 4813.5 4871.1 4872.9 4964.3 4228.8 4252.1 4261.1 4264.9 4302.2 4139.9 4338.5 4345.7 4361.5 4385.2 4594.4 4611.7 4664.9 4676.3 4712.7 4877.2 4887.9 4892.3 4898.4 4898.4 4448.3 4528.4 4635.7 4639.9 4679.3 4749.0 4775.3 4782.8 4855.2 4862.1 4918.8 4923.7 4944.4 4947.9 4995.6 4776.4 4781.6 4783.6 4790.7 4829.6 4607.0 4676.9 4698.9 4716.8 4740.9 4594.9 4602.5 4620.7 4632.9 4691.7 4589.7 4754.1 4761.3 4765.0 4811.2 4607.9 4630.9 4643.3 4649.8 4702.2 01:49:01 INFO - PROCESS | 3599 | 01:49:01 INFO - PROCESS | 3599 | [#1] ext.html Cycles:180 Average:39715.71 Median:33380.83 stddev:64070.79 (191.9%) stddev-sans-first:64182.82 01:49:01 INFO - PROCESS | 3599 | Values: 487.7 487.8 490.8 515.9 517.9 32278.2 33232.3 33255.0 33363.8 33397.8 36896.3 37277.3 37400.8 37505.1 37594.0 7612.4 7749.5 7785.3 7785.3 7795.8 7531.7 7580.8 7628.5 7818.2 7820.3 7703.0 7847.0 7859.4 7880.4 7881.6 7743.8 7780.4 7794.7 7814.0 7834.3 7703.1 7818.9 7875.4 7886.1 7904.1 36638.8 37147.6 37236.0 37260.3 37432.4 2685.1 2696.1 2719.1 2751.7 2930.4 27653.6 28146.6 28181.9 28285.9 29104.9 3490.7 3503.1 3507.6 3549.5 3587.1 215232.0 215460.0 216191.0 216912.0 217771.0 41687.0 42879.8 52893.5 53171.7 55612.7 50156.0 50165.2 50268.7 50271.0 50530.0 12299.6 12482.0 12499.8 12524.4 12526.9 9200.8 9251.6 9284.6 9289.7 9297.3 18257.5 18685.6 19070.7 19257.6 19327.3 7152.2 7524.5 7546.8 7555.6 7575.9 845.7 856.7 886.5 959.4 963.2 25531.6 25649.5 25736.7 25768.6 25864.6 895.8 910.9 917.8 1016.9 1032.5 13123.4 13499.5 13511.2 13571.5 13824.4 270350.0 273795.0 274236.0 274630.0 274962.0 45287.5 45424.3 45532.8 45631.5 45675.3 1201.0 1201.1 1215.5 1216.6 1220.6 24490.3 24787.5 25143.4 25209.6 25409.5 39773.8 39995.8 40230.2 40256.2 40345.0 241118.0 244010.0 244104.0 246076.0 246252.0 27264.6 27655.6 27850.3 27896.0 29368.7 36186.1 36262.6 36570.3 36821.0 37315.0 30374.2 31064.8 31112.2 31232.5 31253.5 31415.8 32202.4 32303.2 32351.0 32399.4 31872.5 32361.7 32475.2 32496.7 32511.5 27490.5 28862.3 29922.9 31872.7 32732.7 23075.9 23098.3 23133.8 23177.9 23241.9 01:49:01 INFO - PROCESS | 3599 | 01:49:01 INFO - PROCESS | 3599 | [#2] jquery.html Cycles:180 Average:23381.33 Median:27370.32 stddev:73604.33 (268.9%) stddev-sans-first:73790.46 01:49:01 INFO - PROCESS | 3599 | Values: 333.3 338.5 344.9 344.9 347.3 14470.1 14578.4 15132.7 15231.4 15897.1 9324.2 9581.7 11264.8 14488.8 14589.5 4377.0 4518.8 4551.9 4568.4 4924.9 4968.3 5033.4 5033.6 5037.0 5046.0 3325.9 3510.8 5002.6 5022.9 5150.5 5286.6 5306.4 5309.2 5329.6 5335.4 5017.3 5154.7 5195.6 5195.6 5197.7 11651.5 11678.9 18057.1 18511.3 18588.4 1725.9 1803.7 1805.7 1810.9 1910.7 8900.7 9023.6 9032.5 9396.3 12215.6 1658.5 1690.1 1703.9 1724.2 1731.9 44900.3 46361.5 47203.3 49738.0 50239.7 8903.7 9229.7 9485.9 9497.5 9547.2 11980.9 11999.3 12017.9 12028.2 12044.6 6366.1 6409.1 6414.5 6430.8 6464.2 5964.3 6049.9 6075.6 6107.9 6111.3 4110.9 4169.0 4207.5 4211.8 4230.3 1706.5 1714.3 1717.7 1723.9 1739.7 713.4 806.2 823.1 910.7 934.0 10022.1 10483.1 14172.3 14807.7 14808.6 388.9 402.4 406.9 413.2 426.0 4695.9 4962.8 5554.7 5663.8 5752.8 414353.0 448878.0 459392.0 462517.0 463278.0 64150.0 64869.7 64991.4 65638.0 65857.0 458.6 460.0 467.3 467.5 467.5 9570.4 9634.3 9666.1 9683.7 9961.5 29470.3 30279.1 31175.8 31480.2 31663.5 40203.8 40485.8 40530.4 40583.6 40939.0 6445.7 6612.1 6714.5 6726.5 6932.5 9405.8 9808.8 10101.0 10254.6 10307.7 8002.4 8065.8 8363.7 8373.0 8499.4 8825.6 8902.5 8981.2 9161.4 9507.4 8391.9 8638.9 8787.2 8823.4 8840.6 6570.8 6755.2 6765.7 6773.2 6807.9 7065.5 8645.8 8715.9 8966.4 8986.4 01:49:01 INFO - PROCESS | 3599 | 01:49:01 INFO - PROCESS | 3599 | [#3] mootools.html Cycles:180 Average:5001.90 Median:6086.20 stddev:2654.40 (43.6%) stddev-sans-first:2646.68 01:49:01 INFO - PROCESS | 3599 | Values: 1227.3 1270.3 1271.4 1664.1 1699.5 6171.3 6318.6 7115.6 7299.2 7338.8 6703.0 6841.8 6883.8 6917.0 6935.3 2122.5 2142.9 2144.3 2149.0 2162.2 2040.2 2068.6 2084.9 2087.1 2090.4 2074.8 2078.8 2087.2 2096.1 2160.4 2123.7 2142.7 2144.6 2150.9 2156.4 2110.0 2166.4 2168.5 2170.2 2173.3 7285.7 7312.5 7316.7 7329.0 7333.8 4222.2 4372.8 4374.1 4379.7 4379.7 2762.9 2801.6 2808.0 2809.8 2813.3 845.5 858.2 864.7 882.3 886.9 9885.6 9894.2 9903.0 9903.9 9957.7 4040.1 4075.6 4150.0 4160.5 4165.8 8420.9 8441.1 8467.6 8510.9 8527.9 4311.8 4332.0 4353.5 4393.5 4399.1 3343.6 3445.7 3794.1 3967.5 3968.1 3416.3 3417.1 3432.1 3437.2 3446.7 1093.0 1112.1 1112.4 1116.1 1131.9 1091.1 1091.2 1108.2 1140.3 1197.3 6542.8 6571.9 6607.4 6628.9 6631.5 435.9 440.5 443.1 444.5 445.4 4773.6 4787.6 4789.9 4824.8 4831.3 8636.1 8800.6 8933.9 9032.5 9122.7 9034.1 9062.6 9074.6 9115.3 9123.8 6707.9 6868.9 6870.4 6889.7 6907.5 6610.4 6624.4 6648.7 6648.8 6655.5 7873.5 8033.2 8039.8 8076.7 8170.2 8148.0 8244.1 8405.7 8410.7 8419.9 5560.3 5683.8 5923.9 6258.7 6312.5 6409.0 6463.8 6490.4 6491.7 6496.1 6130.4 6158.2 6198.8 6224.6 6336.9 6146.0 6202.9 6227.1 6253.0 6306.4 6367.9 6394.2 6417.8 6418.9 6433.9 5780.5 5786.1 5799.9 5820.0 5821.9 5799.8 6021.8 6077.4 6095.0 6095.3 01:49:01 INFO - PROCESS | 3599 | 01:49:01 INFO - PROCESS | 3599 | [#4] prototype.html Cycles:180 Average:4795.20 Median:5546.22 stddev:1443.09 (26.0%) stddev-sans-first:1407.07 01:49:01 INFO - PROCESS | 3599 | Values: 296.2 305.5 308.8 314.9 319.6 5539.0 5553.4 5557.1 5684.5 5722.2 5486.9 5533.6 5560.8 5566.0 5566.6 4087.3 4209.9 4213.9 4217.8 4222.8 4222.7 4225.0 4225.6 4235.9 4241.9 4182.1 4182.4 4189.6 4193.9 4195.0 4176.4 4184.4 4185.7 4188.1 4196.7 3536.4 3656.4 3658.1 3660.9 3663.1 5175.5 5303.9 5318.8 5336.3 5346.3 4752.3 4756.2 4758.5 4764.3 4770.9 5753.4 5773.3 5785.2 5790.9 5794.7 3783.7 3817.7 3878.2 3882.8 3895.4 6020.7 6091.0 6093.1 6098.1 6102.8 3993.9 4006.7 4008.8 4010.8 4012.2 4085.0 4086.5 4089.7 4091.7 4092.3 4697.7 4731.5 4736.1 4736.4 4736.7 5510.6 5753.5 5754.1 5754.3 5754.8 1435.2 1468.8 1469.9 1470.4 1470.8 952.7 977.8 991.1 992.2 1001.2 5020.8 5055.7 5075.1 5077.4 5093.4 5981.6 6035.4 6036.7 6042.0 6042.5 5088.9 5091.9 5093.7 5093.7 5096.6 3165.6 3220.2 3252.2 3257.9 3264.6 5592.5 5669.7 5671.5 5673.4 5680.0 6248.4 6265.2 6289.6 6294.4 6295.5 5751.2 5756.4 5756.6 5758.3 5763.9 6032.0 6057.7 6058.6 6083.1 6096.9 5777.6 5956.8 5968.4 5978.8 5982.7 5702.4 5728.7 5765.4 5767.9 5778.2 4027.5 4076.4 4077.1 4077.8 4079.8 5944.4 6050.2 6054.3 6087.1 6097.1 5847.2 5876.0 5877.9 5880.5 5882.0 5842.0 5857.6 5858.7 5859.0 5869.1 5528.9 5678.8 5705.0 5712.0 5728.8 5816.9 5889.4 5895.6 5903.3 5907.9 5721.6 5730.8 5740.8 5740.9 5742.2 01:49:01 INFO - PROCESS | 3599 | 01:49:01 INFO - PROCESS | 3599 | [#5] yui.html Cycles:180 Average:11422.41 Median:605.03 stddev:12727.78 (2103.7%) stddev-sans-first:12737.85 01:49:01 INFO - PROCESS | 3599 | Values: 666.1 720.3 743.2 778.5 783.4 11173.4 11458.6 11460.1 11469.9 11502.4 10841.4 10876.1 10877.2 10881.8 10883.2 604.3 625.5 763.9 770.5 778.4 780.3 783.3 783.4 786.2 788.6 819.0 821.4 823.1 823.2 824.2 808.7 808.9 813.4 814.3 818.5 606.5 609.2 609.9 611.0 611.9 11669.9 11738.3 11743.6 11748.4 11807.5 10870.2 11099.4 11573.4 11975.9 12109.8 10381.9 10541.7 10609.6 10696.3 10941.9 3228.6 3264.8 3265.3 3284.0 3363.7 35277.6 35366.0 35453.5 35499.0 35581.0 8852.2 9056.5 9185.4 9222.9 9303.3 15902.7 15911.8 15912.5 15929.8 15952.0 6462.8 6498.9 6538.2 6588.0 6629.6 3687.5 3704.4 3709.7 3720.7 3739.4 2564.0 2584.5 2585.4 2590.7 2596.0 483.6 495.9 496.4 497.3 503.2 605.8 612.8 614.4 619.1 651.2 7278.3 7550.3 7628.7 7734.7 7920.3 433.1 483.6 489.2 491.0 505.1 3508.2 3546.7 3548.8 3594.5 3598.9 46047.3 46086.0 46155.5 46248.8 46272.0 41056.0 41678.0 41689.8 41956.2 42002.4 38011.0 38807.4 38890.0 39412.2 39510.0 7105.4 7398.3 7496.2 7574.2 7616.6 28549.7 29201.0 29202.0 29287.0 29730.7 33902.2 34442.3 34485.8 37719.4 37918.8 8996.6 9069.9 9106.8 9159.3 9475.0 9472.3 9662.6 9707.2 9785.0 9992.9 9319.7 9353.2 9358.7 9369.5 9389.4 8783.7 8792.9 8858.3 8910.5 8920.2 9055.0 9075.8 9211.9 9251.8 9263.9 7263.0 7466.4 7484.4 7511.8 7798.3 7844.6 8128.1 8358.4 8562.7 8608.1 01:49:01 INFO - PROCESS | 3599 | -------- Summary: end -------- 01:49:01 INFO - PROCESS | 3599 | 01:49:02 INFO - TEST-INFO | 3599: exit 0 01:49:02 INFO - TEST-OK | dromaeo_css | took 1114698ms 01:49:02 INFO - TEST-START | kraken 01:49:02 INFO - operating with platform_type : linux_ 01:49:02 INFO - Initialising browser for kraken test... 01:49:02 INFO - TEST-INFO | started process 3836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprtEAXX/profile http://localhost:40809/getInfo.html) 01:49:06 INFO - PROCESS | 3836 | 01:49:06 INFO - PROCESS | 3836 | (process:3908): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:49:07 INFO - PROCESS | 3836 | __metrics Screen width/height:1600/1200 01:49:07 INFO - PROCESS | 3836 | colorDepth:24 01:49:07 INFO - PROCESS | 3836 | Browser inner width/height: 1024/697 01:49:07 INFO - PROCESS | 3836 | __metrics 01:49:07 INFO - PROCESS | 3836 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:49:08 INFO - TEST-INFO | 3836: exit 0 01:49:08 INFO - Browser initialized. 01:49:08 INFO - Running cycle 1/1 for kraken test... 01:49:08 INFO - TEST-INFO | started process 3957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprtEAXX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:49:09 INFO - PROCESS | 3957 | 01:49:09 INFO - PROCESS | 3957 | (process:4014): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:49:20 INFO - PROCESS | 3957 | RSS: Main: 150614016 01:49:20 INFO - PROCESS | 3957 | 01:49:23 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40809/tests/kraken/driver.html?testName=audio-beat-detection) 01:49:23 INFO - PROCESS | 3957 | RSS: Main: 150237184 01:49:23 INFO - PROCESS | 3957 | 01:49:26 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40809/tests/kraken/driver.html?testName=audio-dft) 01:49:27 INFO - PROCESS | 3957 | RSS: Main: 150671360 01:49:27 INFO - PROCESS | 3957 | 01:49:29 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40809/tests/kraken/driver.html?testName=audio-fft) 01:49:30 INFO - PROCESS | 3957 | RSS: Main: 147169280 01:49:30 INFO - PROCESS | 3957 | 01:49:32 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40809/tests/kraken/driver.html?testName=audio-oscillator) 01:49:33 INFO - PROCESS | 3957 | RSS: Main: 146665472 01:49:33 INFO - PROCESS | 3957 | 01:49:35 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:49:36 INFO - PROCESS | 3957 | RSS: Main: 147095552 01:49:36 INFO - PROCESS | 3957 | 01:49:39 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40809/tests/kraken/driver.html?testName=imaging-darkroom) 01:49:39 INFO - PROCESS | 3957 | RSS: Main: 148213760 01:49:39 INFO - PROCESS | 3957 | 01:49:43 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40809/tests/kraken/driver.html?testName=imaging-desaturate) 01:49:43 INFO - PROCESS | 3957 | RSS: Main: 149319680 01:49:43 INFO - PROCESS | 3957 | 01:49:46 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40809/tests/kraken/driver.html?testName=json-parse-financial) 01:49:47 INFO - PROCESS | 3957 | RSS: Main: 147230720 01:49:47 INFO - PROCESS | 3957 | 01:49:49 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:49:49 INFO - PROCESS | 3957 | RSS: Main: 148480000 01:49:49 INFO - PROCESS | 3957 | 01:49:51 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40809/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:49:52 INFO - PROCESS | 3957 | RSS: Main: 148496384 01:49:52 INFO - PROCESS | 3957 | 01:49:54 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:49:54 INFO - PROCESS | 3957 | RSS: Main: 149528576 01:49:54 INFO - PROCESS | 3957 | 01:49:57 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:49:58 INFO - PROCESS | 3957 | RSS: Main: 149979136 01:49:58 INFO - PROCESS | 3957 | 01:50:00 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:50:01 INFO - PROCESS | 3957 | RSS: Main: 148926464 01:50:01 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | Cycle 1(1): loaded http://localhost:40809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40809/tests/kraken/driver.html?testName=ai-astar) 01:50:03 INFO - PROCESS | 3957 | RSS: Main: 150183936 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | __start_tp_report 01:50:03 INFO - PROCESS | 3957 | _x_x_mozilla_page_load 01:50:03 INFO - PROCESS | 3957 | _x_x_mozilla_page_load_details 01:50:03 INFO - PROCESS | 3957 | |i|pagename|runs| 01:50:03 INFO - PROCESS | 3957 | |0;ai-astar;114;108;113;114;114;123;116;114;115;113 01:50:03 INFO - PROCESS | 3957 | |1;audio-beat-detection;153;134;152;182;130;153;174;142;175;133 01:50:03 INFO - PROCESS | 3957 | |2;audio-dft;162;162;163;161;169;166;167;161;165;165 01:50:03 INFO - PROCESS | 3957 | |3;audio-fft;75;77;73;74;141;73;79;72;73;151 01:50:03 INFO - PROCESS | 3957 | |4;audio-oscillator;97;97;131;97;98;98;141;98;97;128 01:50:03 INFO - PROCESS | 3957 | |5;imaging-gaussian-blur;109;111;109;110;113;110;110;109;110;110 01:50:03 INFO - PROCESS | 3957 | |6;imaging-darkroom;148;149;149;149;149;148;148;148;147;148 01:50:03 INFO - PROCESS | 3957 | |7;imaging-desaturate;96;97;95;96;96;96;96;97;97;96 01:50:03 INFO - PROCESS | 3957 | |8;json-parse-financial;70;71;70;70;70;72;71;78;68;70 01:50:03 INFO - PROCESS | 3957 | |9;json-stringify-tinderbox;67;68;70;67;73;68;67;68;68;68 01:50:03 INFO - PROCESS | 3957 | |10;stanford-crypto-aes;83;83;86;87;85;83;84;83;85;83 01:50:03 INFO - PROCESS | 3957 | |11;stanford-crypto-ccm;134;142;127;121;123;130;131;126;133;124 01:50:03 INFO - PROCESS | 3957 | |12;stanford-crypto-pbkdf2;138;161;135;138;145;135;159;146;147;151 01:50:03 INFO - PROCESS | 3957 | |13;stanford-crypto-sha256-iterative;72;72;70;71;73;70;69;70;70;69 01:50:03 INFO - PROCESS | 3957 | __end_tp_report 01:50:03 INFO - PROCESS | 3957 | __start_cc_report 01:50:03 INFO - PROCESS | 3957 | _x_x_mozilla_cycle_collect,806 01:50:03 INFO - PROCESS | 3957 | __end_cc_report 01:50:03 INFO - PROCESS | 3957 | __startTimestamp1452678603447__endTimestamp 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | ------- Summary: start ------- 01:50:03 INFO - PROCESS | 3957 | Number of tests: 14 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:3.69 (3.2%) stddev-sans-first:3.91 01:50:03 INFO - PROCESS | 3957 | Values: 114.0 108.0 113.0 114.0 114.0 123.0 116.0 114.0 115.0 113.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#1] audio-beat-detection Cycles:10 Average:152.80 Median:153.00 stddev:18.79 (12.3%) stddev-sans-first:19.93 01:50:03 INFO - PROCESS | 3957 | Values: 153.0 134.0 152.0 182.0 130.0 153.0 174.0 142.0 175.0 133.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#2] audio-dft Cycles:10 Average:164.10 Median:165.00 stddev:2.73 (1.7%) stddev-sans-first:2.78 01:50:03 INFO - PROCESS | 3957 | Values: 162.0 162.0 163.0 161.0 169.0 166.0 167.0 161.0 165.0 165.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#3] audio-fft Cycles:10 Average:88.80 Median:73.50 stddev:30.31 (41.2%) stddev-sans-first:31.74 01:50:03 INFO - PROCESS | 3957 | Values: 75.0 77.0 73.0 74.0 141.0 73.0 79.0 72.0 73.0 151.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#4] audio-oscillator Cycles:10 Average:108.20 Median:97.00 stddev:17.64 (18.2%) stddev-sans-first:18.24 01:50:03 INFO - PROCESS | 3957 | Values: 97.0 97.0 131.0 97.0 98.0 98.0 141.0 98.0 97.0 128.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:1.20 (1.1%) stddev-sans-first:1.20 01:50:03 INFO - PROCESS | 3957 | Values: 109.0 111.0 109.0 110.0 113.0 110.0 110.0 109.0 110.0 110.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.50 stddev:0.67 (0.5%) stddev-sans-first:0.71 01:50:03 INFO - PROCESS | 3957 | Values: 148.0 149.0 149.0 149.0 149.0 148.0 148.0 148.0 147.0 148.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 01:50:03 INFO - PROCESS | 3957 | Values: 96.0 97.0 95.0 96.0 96.0 96.0 96.0 97.0 97.0 96.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#8] json-parse-financial Cycles:10 Average:71.00 Median:70.50 stddev:2.67 (3.8%) stddev-sans-first:2.80 01:50:03 INFO - PROCESS | 3957 | Values: 70.0 71.0 70.0 70.0 70.0 72.0 71.0 78.0 68.0 70.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:1.84 (2.7%) stddev-sans-first:1.88 01:50:03 INFO - PROCESS | 3957 | Values: 67.0 68.0 70.0 67.0 73.0 68.0 67.0 68.0 68.0 68.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:1.48 (1.7%) stddev-sans-first:1.50 01:50:03 INFO - PROCESS | 3957 | Values: 83.0 83.0 86.0 87.0 85.0 83.0 84.0 83.0 85.0 83.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#11] stanford-crypto-ccm Cycles:10 Average:129.10 Median:130.50 stddev:6.26 (4.8%) stddev-sans-first:6.39 01:50:03 INFO - PROCESS | 3957 | Values: 134.0 142.0 127.0 121.0 123.0 130.0 131.0 126.0 133.0 124.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:146.50 stddev:9.36 (6.4%) stddev-sans-first:9.53 01:50:03 INFO - PROCESS | 3957 | Values: 138.0 161.0 135.0 138.0 145.0 135.0 159.0 146.0 147.0 151.0 01:50:03 INFO - PROCESS | 3957 | 01:50:03 INFO - PROCESS | 3957 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:70.50 stddev:1.35 (1.9%) stddev-sans-first:1.33 01:50:03 INFO - PROCESS | 3957 | Values: 72.0 72.0 70.0 71.0 73.0 70.0 69.0 70.0 70.0 69.0 01:50:03 INFO - PROCESS | 3957 | -------- Summary: end -------- 01:50:03 INFO - PROCESS | 3957 | 01:50:04 INFO - TEST-INFO | 3957: exit 0 01:50:04 INFO - TEST-OK | kraken | took 62001ms 01:50:04 INFO - TEST-START | v8_7 01:50:04 INFO - operating with platform_type : linux_ 01:50:04 INFO - Initialising browser for v8_7 test... 01:50:04 INFO - TEST-INFO | started process 4243 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppiZwXW/profile http://localhost:40809/getInfo.html) 01:50:08 INFO - PROCESS | 4243 | 01:50:08 INFO - PROCESS | 4243 | (process:4316): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:50:09 INFO - PROCESS | 4243 | __metrics Screen width/height:1600/1200 01:50:09 INFO - PROCESS | 4243 | colorDepth:24 01:50:09 INFO - PROCESS | 4243 | Browser inner width/height: 1024/697 01:50:09 INFO - PROCESS | 4243 | __metrics 01:50:09 INFO - PROCESS | 4243 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 01:50:10 INFO - TEST-INFO | 4243: exit 0 01:50:10 INFO - Browser initialized. 01:50:10 INFO - Running cycle 1/1 for v8_7 test... 01:50:10 INFO - TEST-INFO | started process 4365 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppiZwXW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:50:12 INFO - PROCESS | 4365 | 01:50:12 INFO - PROCESS | 4365 | (process:4425): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:50:22 INFO - PROCESS | 4365 | RSS: Main: 149991424 01:50:22 INFO - PROCESS | 4365 | 01:50:44 INFO - PROCESS | 4365 | Cycle 1(1): loaded http://localhost:40809/tests/v8_7/run.html (next: http://localhost:40809/tests/v8_7/run.html) 01:50:45 INFO - PROCESS | 4365 | RSS: Main: 145715200 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | __start_tp_report 01:50:45 INFO - PROCESS | 4365 | _x_x_mozilla_page_load 01:50:45 INFO - PROCESS | 4365 | _x_x_mozilla_page_load_details 01:50:45 INFO - PROCESS | 4365 | |i|pagename|runs| 01:50:45 INFO - PROCESS | 4365 | |0;Richards;166.58337497917708 01:50:45 INFO - PROCESS | 4365 | |1;DeltaBlue;186.46280067126608 01:50:45 INFO - PROCESS | 4365 | |2;Encrypt;278.00945232137894 01:50:45 INFO - PROCESS | 4365 | |3;Decrypt;5291.005291005291 01:50:45 INFO - PROCESS | 4365 | |4;RayTrace;1077.502691065662 01:50:45 INFO - PROCESS | 4365 | |5;Earley;713.7758743754462 01:50:45 INFO - PROCESS | 4365 | |6;Boyer;12292.682926829268 01:50:45 INFO - PROCESS | 4365 | |7;RegExp;43782.608695652176 01:50:45 INFO - PROCESS | 4365 | |8;Splay;600.9529481834426 01:50:45 INFO - PROCESS | 4365 | |9;NavierStokes;4840.579710144928 01:50:45 INFO - PROCESS | 4365 | __end_tp_report 01:50:45 INFO - PROCESS | 4365 | __startTimestamp1452678645176__endTimestamp 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | ------- Summary: start ------- 01:50:45 INFO - PROCESS | 4365 | Number of tests: 10 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | [#0] Richards Cycles:1 Average:166.58 Median:166.58 stddev:0.00 (0.0%) 01:50:45 INFO - PROCESS | 4365 | Values: 166.6 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | [#1] DeltaBlue Cycles:1 Average:186.46 Median:186.46 stddev:0.00 (0.0%) 01:50:45 INFO - PROCESS | 4365 | Values: 186.5 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 01:50:45 INFO - PROCESS | 4365 | Values: 278.0 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | [#3] Decrypt Cycles:1 Average:5291.01 Median:5291.01 stddev:0.00 (0.0%) 01:50:45 INFO - PROCESS | 4365 | Values: 5291.0 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | [#4] RayTrace Cycles:1 Average:1077.50 Median:1077.50 stddev:0.00 (0.0%) 01:50:45 INFO - PROCESS | 4365 | Values: 1077.5 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | [#5] Earley Cycles:1 Average:713.78 Median:713.78 stddev:0.00 (0.0%) 01:50:45 INFO - PROCESS | 4365 | Values: 713.8 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | [#6] Boyer Cycles:1 Average:12292.68 Median:12292.68 stddev:0.00 (0.0%) 01:50:45 INFO - PROCESS | 4365 | Values: 12292.7 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | [#7] RegExp Cycles:1 Average:43782.61 Median:43782.61 stddev:0.00 (0.0%) 01:50:45 INFO - PROCESS | 4365 | Values: 43782.6 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | [#8] Splay Cycles:1 Average:600.95 Median:600.95 stddev:0.00 (0.0%) 01:50:45 INFO - PROCESS | 4365 | Values: 601.0 01:50:45 INFO - PROCESS | 4365 | 01:50:45 INFO - PROCESS | 4365 | [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 01:50:45 INFO - PROCESS | 4365 | Values: 4840.6 01:50:45 INFO - PROCESS | 4365 | -------- Summary: end -------- 01:50:45 INFO - PROCESS | 4365 | 01:50:46 INFO - TEST-INFO | 4365: exit 0 01:50:46 INFO - TEST-OK | v8_7 | took 41660ms 01:50:46 INFO - SUITE-END | took 1218s 01:50:46 INFO - Completed test suite (00:20:18) 01:50:46 INFO - Working with test: dromaeo_css 01:50:46 INFO - Generating results file: dromaeo_css 01:50:46 INFO - Working with test: kraken 01:50:46 INFO - Generating results file: kraken 01:50:46 INFO - javascript benchmark 01:50:46 INFO - Working with test: v8_7 01:50:46 INFO - Generating results file: v8_7 01:50:46 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:50:46 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 01:50:46 INFO - process_Request line: dromaeo_css 6009.22 graph.html#tests=[[72,132,43]] 01:50:46 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:50:46 INFO - process_Request line: kraken 1551.70 graph.html#tests=[[232,132,43]] 01:50:46 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:50:46 INFO - process_Request line: v8_7 20238.14 graph.html#tests=[[230,132,43]] 01:50:46 INFO - RETURN: dromaeo_css: 6009.22 01:50:46 INFO - RETURN: kraken: 1551.70 01:50:46 INFO - RETURN: v8_7: 20238.14 01:50:46 INFO - javascript benchmark 01:50:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2609.960850587241, 2641.0756235317654, 2669.5728683410657, 2688.7848972082234, 2691.1388355726162, 4441.866743997677, 4528.886777830552, 4560.817567297312, 4569.451665800105, 4578.816847326108, 4470.994026344071, 4533.863984080474, 4538.7503687297185, 4563.178627846986, 4587.977060114703, 4165.0, 4165.354370072643, 4187.371894215877, 4243.702940794145, 4244.427002354673, 4040.3333449980864, 4140.792960351985, 4191.0360617058095, 4220.556841531641, 4228.090960443504, 4084.979575102135, 4148.170365926797, 4157.708960372775, 4159.459270294872, 4180.393842892763, 4126.958730412687, 4134.462519872427, 4135.110951145488, 4143.958560414418, 4178.791060446965, 4021.0, 4097.610726980932, 4118.794060297003, 4120.62914337708, 4139.668826493873, 4364.345348197764, 4454.688171827974, 4459.0413061191675, 4465.620422264112, 4482.462104547442, 4876.561109500162, 4881.951180488185, 4893.143699852547, 4901.338319326881, 4927.7926907907795, 4770.260609605517, 4851.10254602896, 4855.902881942377, 4912.312276281324, 4934.185859333242, 4473.530279320689, 4522.434695663075, 4542.454905411306, 4550.476695180097, 4619.145458090264, 5008.69947803133, 5029.874253143701, 5038.949610503848, 5043.5712964398435, 5081.923771143436, 4588.334691469719, 4702.694324868872, 4792.065547218259, 4814.855554333376, 4838.177509823338, 4746.38297021385, 4845.709257444564, 4854.320395144682, 4859.392575928009, 4866.270059491105, 4757.35775670287, 4759.119562880878, 4778.784954677048, 4784.545468180518, 4799.856004319876, 4743.5967942724565, 4744.335792988984, 4759.524047595212, 4760.071786001766, 4792.496787837296, 3918.2163567286657, 3989.341758609855, 4016.3975403689096, 4038.838446462167, 4132.483439570054, 3534.9646503534636, 3542.840572174207, 3575.213453040327, 3581.283743251308, 3582.194006348551, 4175.498940127204, 4182.498100227992, 4184.853530126431, 4203.243416185116, 4231.513375961742, 4722.268048452495, 4813.4945830687275, 4871.050145221719, 4872.902541949141, 4964.255361695702, 4228.809703563347, 4252.128313695685, 4261.147770445923, 4264.87205383839, 4302.161078589707, 4139.8965025874595, 4338.522762496123, 4345.739255644608, 4361.520232774392, 4385.188740083095, 4594.425696787902, 4611.700239484423, 4664.883377915579, 4676.251799712029, 4712.670113092187, 4877.244027175793, 4887.877803054952, 4892.339534162985, 4898.4121905371585, 4898.436679781871, 4448.266036104006, 4528.41130653013, 4635.6986795858165, 4639.930401043919, 4679.3448917150945, 4749.026449577759, 4775.2598347256235, 4782.7847746850775, 4855.223164293696, 4862.149123903232, 4918.754062296943, 4923.729194894315, 4944.3572335596145, 4947.851564453073, 4995.600351971761, 4776.42682878043, 4781.569658730731, 4783.617310615073, 4790.7365094920115, 4829.5653391194965, 4607.032523170172, 4676.906461870675, 4698.929516057194, 4716.787744551572, 4740.928886066781, 4594.88512787183, 4602.470715867584, 4620.699654522446, 4632.907341853212, 4691.7184968901975, 4589.65577581676, 4754.144254034307, 4761.333413322069, 4765.0469906019625, 4811.206150985188, 4607.907841843212, 4630.884227894329, 4643.2802915548145, 4649.767511624473, 4702.15361234981], "unit": "score", "name": "dojo.html", "value": 4455.657550806435}, {"lowerIsBetter": false, "replicates": [487.7414970065864, 487.83901312566854, 490.79631952739607, 515.8684535443462, 517.8839600660575, 32278.19304517388, 33232.33535329295, 33255.0, 33363.833180834095, 33397.83301083491, 36896.26207475855, 37277.25445491095, 37400.81299593498, 37505.062373440676, 37594.0, 7612.429067819908, 7749.535027898316, 7785.260400261995, 7785.299323060924, 7795.8440831183625, 7531.6610752516, 7580.772576822704, 7628.542287462742, 7818.218178182165, 7820.257075577811, 7703.0, 7847.0, 7859.410544209179, 7880.448368614199, 7881.566513841736, 7743.845123097534, 7780.416468764865, 7794.727184548542, 7813.9609301953415, 7834.33408160307, 7703.075630924269, 7818.921810781876, 7875.4487185897015, 7886.093099293597, 7904.0910295315625, 36638.81680591607, 37147.62852371496, 37236.0, 37260.25479490422, 37432.43851342232, 2685.060228919882, 2696.110283606405, 2719.1162872066657, 2751.697313295536, 2930.4139172165437, 27653.585196222073, 28146.577801333, 28181.85909070462, 28285.858570707016, 29104.854475727487, 3490.703290220334, 3503.1242189452637, 3507.6316986716283, 3549.4853246279404, 3587.0852932502044, 215232.0, 215460.0, 216191.0, 216912.0, 217771.0, 41687.0, 42879.785601071795, 52893.471065289625, 53171.73414132982, 55612.72193639006, 50156.0, 50165.24752128721, 50268.74865625649, 50271.0, 50530.0, 12299.569515066929, 12482.0, 12499.750004999849, 12524.373781310898, 12526.937365313297, 9200.769980750534, 9251.583678734472, 9284.582193801296, 9289.72130836076, 9297.256219502424, 18257.45227643173, 18685.626287474173, 19070.713939290923, 19257.614847702967, 19327.323543676186, 7152.249013853574, 7524.473286869976, 7546.773596792105, 7555.622218889143, 7575.924240757632, 845.7166849105496, 856.7472595584318, 886.5318793281788, 959.3859929645033, 963.205355581648, 25531.61702574463, 25649.48701025969, 25736.74263257381, 25768.613470797955, 25864.612030819553, 895.8163576466809, 910.9089091090971, 917.8302014127274, 1016.8627235323285, 1032.4631191780381, 13123.409351764098, 13499.460021599223, 13511.189328640314, 13571.457141714222, 13824.447022119204, 270350.0, 273795.0, 274236.0, 274630.0, 274962.0, 45287.547124528995, 45424.3186352205, 45532.77233613811, 45631.54368456273, 45675.314870276976, 1201.0211677482823, 1201.0631707268344, 1215.5198696514826, 1216.5863606373875, 1220.6399112261904, 24490.265292041266, 24787.50424991454, 25143.371415714755, 25209.621855672547, 25409.49181016406, 39773.80113099416, 39995.800021000876, 40230.19539609133, 40256.1948761029, 40344.982750862924, 241118.0, 244010.0, 244104.0, 246076.0, 246252.0, 27264.591031134947, 27655.585166222925, 27850.30374240579, 27896.0, 29368.706312936596, 36186.09534761547, 36262.63737362698, 36570.26859462849, 36821.013371424204, 37315.0, 30374.240643984078, 31064.844675776476, 31112.22219444532, 31232.531512027792, 31253.531197031607, 31415.84292078525, 32202.35595288034, 32303.192420189684, 32351.0, 32399.35201296008, 31872.521912170872, 32361.676383235867, 32475.18812029718, 32496.67503325031, 32511.51232731558, 27490.450190995667, 28862.278443039093, 29922.850385748803, 31872.681273186972, 32732.672673272962, 23075.88462057679, 23098.30705078783, 23133.768662313163, 23177.88411057934, 23241.883790580938], "unit": "score", "name": "ext.html", "value": 16265.087316555017}, {"lowerIsBetter": false, "replicates": [333.3167007634349, 338.5209927951948, 344.8603315657159, 344.9327381160674, 347.33485375505876, 14470.131792092481, 14578.416863325467, 15132.697346053099, 15231.390744370212, 15897.1256580888, 9324.160825525702, 9581.664641737541, 11264.774704505904, 14488.782668259984, 14589.489367872127, 4376.956230437702, 4518.751468669222, 4551.908961820762, 4568.360429539867, 4924.876878078041, 4968.254761785725, 5033.446320904697, 5033.5721463675445, 5037.017781532602, 5045.974770126162, 3325.8669653213965, 3510.8420121094614, 5002.649814512985, 5022.899542009158, 5150.510701483372, 5286.629935904488, 5306.3632364116165, 5309.230161626542, 5329.600279978998, 5335.413104558495, 5017.322661440695, 5154.742262886878, 5195.584353251731, 5195.636305458619, 5197.740112994373, 11651.475683594259, 11678.890505401972, 18057.09714514269, 18511.259549618, 18588.44234672962, 1725.887817291872, 1803.666321730484, 1805.7381679656507, 1810.9456716298532, 1910.703840904662, 8900.688475903313, 9023.639054437816, 9032.458052516804, 9396.34225604208, 12215.572454964034, 1658.4692898272438, 1690.138029604898, 1703.872209584286, 1724.1896308735, 1731.9220635071451, 44900.3264951026, 46361.536384636056, 47203.29195062077, 49738.0, 50239.74880125612, 8903.688370907117, 9229.723108306762, 9485.90514094864, 9497.477638729937, 9547.188488978376, 11980.88019119815, 11999.280043197436, 12017.939910300393, 12028.15802893789, 12044.578439754741, 6366.076918846741, 6409.134766806515, 6414.454771344394, 6430.7749228776765, 6464.191976003, 5964.284285885721, 6049.939500605025, 6075.605085669417, 6107.908381374283, 6111.266648002268, 4110.876673699794, 4169.0, 4207.453031105937, 4211.768352740567, 4230.323148296257, 1706.5136436115647, 1714.28857024336, 1717.7165767648198, 1723.93966211182, 1739.6694628020637, 713.3615414204362, 806.2154044729045, 823.0822632764424, 910.6539514984396, 933.9866245124116, 10022.098011179029, 10483.108935740394, 14172.291385430688, 14807.70384592302, 14808.555743327717, 388.93388124018986, 402.4185052598966, 406.9430279760836, 413.171590960123, 426.0222788699941, 4695.882602934886, 4962.776675049631, 5554.666719996813, 5663.773449061991, 5752.7698892043845, 414353.0, 448878.0, 459392.0, 462517.0, 463278.0, 64150.0, 64869.67565162144, 64991.35008649948, 65638.0, 65857.0, 458.6033081384645, 459.9839005634787, 467.3317156466218, 467.47409164689725, 467.53246753246754, 9570.377925434825, 9634.277429192978, 9666.130048295687, 9683.66107186245, 9961.50192490387, 29470.263243419085, 30279.09162725122, 31175.84412077925, 31480.212994675316, 31663.52504712385, 40203.79898100491, 40485.79757101196, 40530.39204411877, 40583.59416405916, 40939.0, 6445.677716114082, 6612.140421745143, 6714.496412768965, 6726.529142959946, 6932.549384290005, 9405.75538850627, 9808.80382392334, 10101.0, 10254.6410875619, 10307.690769276935, 8002.359811214972, 8065.758027259191, 8363.665453381796, 8373.0, 8499.405041647025, 8825.602847871989, 8902.465852048897, 8981.191692747683, 9161.404508706913, 9507.429554226768, 8391.874121888299, 8638.870416943877, 8787.165219304155, 8823.382363234512, 8840.602172902363, 6570.8028759137305, 6755.189377274758, 6765.661716914233, 6773.153355830521, 6807.863842723217, 7065.540739851893, 8645.827083458422, 8715.869261961203, 8966.372353935161, 8986.370954033155], "unit": "score", "name": "jquery.html", "value": 6839.455877351624}, {"lowerIsBetter": false, "replicates": [1227.269774484182, 1270.3140304235712, 1271.3516106785537, 1664.101385251964, 1699.4986478988696, 6171.3211546729935, 6318.557700960934, 7115.6442177891095, 7299.1605965314, 7338.816529586763, 6702.96648516758, 6841.760538381158, 6883.793486195422, 6916.965415172917, 6935.341142591458, 2122.5118222808765, 2142.860714053589, 2144.281665642012, 2148.967765483519, 2162.2107930605293, 2040.1635329514902, 2068.596623658387, 2084.9270275540357, 2087.0608226298227, 2090.362439455965, 2074.7925207479207, 2078.7817279185692, 2087.1547023455523, 2096.140582361232, 2160.3950893749775, 2123.74515058194, 2142.6678864775986, 2144.592527419793, 2150.9462263443384, 2156.35309407178, 2110.0399318310133, 2166.447555873258, 2168.533765240465, 2170.2078741259484, 2173.2936795541355, 7285.6721447534455, 7312.488125831194, 7316.743913962986, 7328.963355183243, 7333.779986600411, 4222.1555688862045, 4372.803223854934, 4374.081442896995, 4379.671524635665, 4379.693421460499, 2762.944741105187, 2801.6217810595717, 2807.9719202807914, 2809.8033137680372, 2813.268550176969, 845.4758050009034, 858.2104463893234, 864.6714248585561, 882.3162049411693, 886.933479988997, 9885.555150018194, 9894.158996485306, 9902.950485247527, 9903.851442228372, 9957.65148219816, 4040.131371755028, 4075.633193012643, 4149.958500415018, 4160.54234034256, 4165.8333666653, 8420.873686894702, 8441.113683063313, 8467.576621168917, 8510.872336914952, 8527.872081918777, 4311.849085282063, 4331.956680433155, 4353.477582690098, 4393.538678438782, 4399.076193999232, 3343.648916863743, 3445.7243420526297, 3794.146317078635, 3967.5238971323624, 3968.1071758854027, 3416.265502916885, 3417.1457135716073, 3432.090496018557, 3437.2094418283937, 3446.6897979181995, 1092.956281748737, 1112.1325366214367, 1112.449337577904, 1116.1294190531398, 1131.9320840749417, 1091.0998426298177, 1091.2415870969758, 1108.2242430298822, 1140.3044143072718, 1197.3474456421272, 6542.7710030149665, 6571.901421478682, 6607.438367738796, 6628.867422651617, 6631.502637302222, 435.938968544404, 440.45383724181784, 443.0629219201366, 444.46885971264027, 445.3720254441287, 4773.64197685175, 4787.593054590329, 4789.928151077736, 4824.831130910401, 4831.299461578052, 8636.0500344962, 8800.603972821238, 8933.910660893438, 9032.45805251687, 9122.680706175252, 9034.051424600453, 9062.592183351633, 9074.637014519478, 9115.270778337717, 9123.771905702279, 6707.932920670828, 6868.896966545506, 6870.416014638811, 6889.689963951534, 6907.516473846883, 6610.438112760469, 6624.403803657694, 6648.667566621746, 6648.767293144717, 6655.467562594884, 7873.488223265698, 8033.156518565466, 8039.83920321602, 8076.676932922617, 8170.182981701782, 8148.0, 8244.093149753402, 8405.705800297204, 8410.705625303084, 8419.8737018946, 5560.304961879765, 5683.77264909399, 5923.881522369615, 6258.718357674006, 6312.4634406076, 6409.0066039763915, 6463.7737679181, 6490.383413575702, 6491.675416229265, 6496.0580715795, 6130.448259656652, 6158.168647232746, 6198.81403557894, 6224.62652240867, 6336.9049464259, 6146.0, 6202.906956395748, 6227.097070924781, 6252.968735156295, 6306.432421082125, 6367.9044814328745, 6394.1687580614225, 6417.839554011187, 6418.935810641834, 6433.903491447539, 5780.450857168562, 5786.07422812348, 5799.8550036249435, 5820.0396934507025, 5821.94178058231, 5799.82600521985, 6021.819345419644, 6077.392260773887, 6095.0, 6095.2685677718955], "unit": "score", "name": "mootools.html", "value": 4029.7148968879737}, {"lowerIsBetter": false, "replicates": [296.1603853076528, 305.4669601545302, 308.77613730045715, 314.85988735012927, 319.63401904819, 5539.0, 5553.444655534445, 5557.083081291592, 5684.5452363810955, 5722.170285308628, 5486.862828429281, 5533.6403133796275, 5560.833175004756, 5566.0, 5566.582506312023, 4087.3255912774507, 4209.894752631178, 4213.936790948138, 4217.768022758754, 4222.831086756526, 4222.725522841021, 4224.97887510562, 4225.577442255781, 4235.872923812275, 4241.893952651178, 4182.05903671673, 4182.372644103393, 4189.560096189902, 4193.937090943638, 4195.0, 4176.415301857712, 4184.414182014505, 4185.727927684691, 4188.1204946961025, 4196.706230563862, 3536.381133301662, 3656.4149736042104, 3658.1220507078374, 3660.9267814643827, 3663.084228942764, 5175.456577059392, 5303.867403314909, 5318.840434786963, 5336.30628018359, 5346.27825243591, 4752.310914917318, 4756.191447453906, 4758.547937945889, 4764.285357196413, 4770.904581908342, 5753.395893431171, 5773.336066352339, 5785.1611516329895, 5790.88418231633, 5794.710264486759, 3783.6783873370796, 3817.7029544455118, 3878.1855810279876, 3882.8058597070317, 3895.357266051098, 6020.6989650517735, 6091.025435930274, 6093.055576385623, 6098.054801505774, 6102.755889764404, 3993.880183594497, 4006.6994975376965, 4008.7995600219874, 4010.8195131219163, 4012.197560487914, 4084.9795751021647, 4086.4891888513935, 4089.672826173899, 4091.7135800494275, 4092.3043082676018, 4697.718136911796, 4731.503192164773, 4736.1474934511425, 4736.360591320127, 4736.715797052188, 5510.559155267569, 5753.453421924911, 5754.136879468113, 5754.338251101093, 5754.798582049608, 1435.2464955898238, 1468.7723402872573, 1469.889758268134, 1470.375090586518, 1470.808794856683, 952.7094236257869, 977.8239916815041, 991.108002797488, 992.2359782967075, 1001.2040427859869, 5020.7740651670765, 5055.6713813602, 5075.061113693979, 5077.365329333833, 5093.363329583802, 5981.581289309706, 6035.366286539938, 6036.728347224385, 6042.0332746760305, 6042.486388657014, 5088.898222035538, 5091.898162036812, 5093.719845408538, 5093.745312734422, 5096.643234973516, 3165.572647692578, 3220.178854392115, 3252.1706964723844, 3257.8696852126122, 3264.6408895021527, 5592.5246354059545, 5669.744861481243, 5671.489565939085, 5673.432656734376, 5680.0, 6248.375162483715, 6265.185525881698, 6289.559730818799, 6294.433500984934, 6295.464885484694, 5751.194832723422, 5756.395578464201, 5756.5682573807135, 5758.3090029196765, 5763.9249870045915, 6031.969840150771, 6057.697115144137, 6058.5758996871555, 6083.057126145454, 6096.8780624388155, 5777.62445441045, 5956.761729530944, 5968.403159683997, 5978.8206353809455, 5982.700864956648, 5702.37273899879, 5728.742206600629, 5765.365809761007, 5767.884642307046, 5778.219940308173, 4027.496562929634, 4076.3681629347498, 4077.103037331782, 4077.7757223353, 4079.7960101995377, 5944.405559444021, 6050.2437195350585, 6054.303755068047, 6087.147799308189, 6097.054956481752, 5847.152162936435, 5876.031529437686, 5877.911831322448, 5880.470757631833, 5882.0, 5842.036064049385, 5857.58996870215, 5858.736356863866, 5858.974679430998, 5869.090291004901, 5528.861778455571, 5678.77284908599, 5704.971475142764, 5712.02895507773, 5728.828135155952, 5816.912746308724, 5889.352171261244, 5895.64626122434, 5903.2916050072545, 5907.85230369227, 5721.570882183936, 5730.770769169353, 5740.770369185353, 5740.856478588069, 5742.1673857289625], "unit": "score", "name": "prototype.html", "value": 4329.032343027329}, {"lowerIsBetter": false, "replicates": [666.1240468783551, 720.3121019426449, 743.1862110988468, 778.4628606261679, 783.4280974888328, 11173.385463799488, 11458.598949036785, 11460.083193344533, 11469.885301146986, 11502.367369794658, 10841.403722795243, 10876.075533579635, 10877.238593298473, 10881.782364352708, 10883.1837612179, 604.2567641800588, 625.462102591773, 763.912150102737, 770.5184259837602, 778.3967425245423, 780.3484090784202, 783.2832957843566, 783.4241832253289, 786.1705900275207, 788.5584072919155, 818.9754307370788, 821.3880658909121, 823.127484866041, 823.1521532821204, 824.1840577827937, 808.7007807111347, 808.9352851771844, 813.4184058398245, 814.3444527155638, 818.4884447220487, 606.4541912278941, 609.1593600830869, 609.8658295175054, 611.0315150486484, 611.8684482836167, 11669.883301167049, 11738.295702257892, 11743.647690569296, 11748.353840538766, 11807.468663910058, 10870.18473614482, 11099.38953357565, 11573.36346500942, 11975.94012029943, 12109.818352724717, 10381.948090259575, 10541.73645658857, 10609.575616975311, 10696.304740191863, 10941.905809418995, 3228.564143840575, 3264.836758162106, 3265.297960938386, 3283.950740738891, 3363.6636336366414, 35277.647223527696, 35366.0, 35453.468197977054, 35499.0, 35580.99999999974, 8852.159044890725, 9056.456612603133, 9185.35702500832, 9222.86165707515, 9303.34876558648, 15902.68194636124, 15911.840881591268, 15912.52262432129, 15929.840701593068, 15952.0, 6462.838429039218, 6498.870022599616, 6538.215414150332, 6588.044733513614, 6629.635370054597, 3687.465317528997, 3704.388775851954, 3709.684676802502, 3720.739548231598, 3739.364308067635, 2563.9743602563735, 2584.4831033793316, 2585.3665851866413, 2590.6502622145767, 2595.9740402596112, 483.6469377354551, 495.92561115832916, 496.35226030030435, 497.2615665736379, 503.21498462398773, 605.8031139879557, 612.7732738886551, 614.3641331222163, 619.0930287129377, 651.1535004494139, 7278.344948954619, 7550.272856395349, 7628.732994345171, 7734.690612375554, 7920.287174154354, 433.08186644314253, 483.62519047738283, 489.18306428264884, 490.97299648519675, 505.1283453566413, 3508.1755787389943, 3546.690770713595, 3548.769329993542, 3594.4788005739542, 3598.9100272493397, 46047.309290360674, 46086.0, 46155.53844461512, 46248.768756156, 46272.0, 41056.0, 41678.0, 41689.791551042654, 41956.16087678229, 42002.369964450554, 38011.0, 38807.41788873113, 38890.0, 39412.21175576472, 39510.01224969399, 7105.431565474853, 7398.297161769623, 7496.1754207038275, 7574.166841647525, 7616.629006778833, 28549.714502854706, 29201.0, 29202.0, 29287.0, 29730.702692972794, 33902.152446189044, 34442.311153777286, 34485.827570861984, 37719.434208486346, 37918.81040594779, 8996.59515321799, 9069.863952040856, 9106.772330691785, 9159.267258619428, 9474.95262523683, 9472.289578281794, 9662.565184566853, 9707.223422126353, 9784.951075244579, 9992.900070999487, 9319.720408387759, 9353.204977576983, 9358.672446464341, 9369.484678342757, 9389.436633801994, 8783.736487905373, 8792.856928599242, 8858.335624828034, 8910.509921954355, 8920.197182253369, 9054.958679751913, 9075.818483630159, 9211.907880921373, 9251.814963700823, 9263.907360926305, 7263.0, 7466.365358944333, 7484.43866709988, 7511.8497630046, 7798.33714134305, 7844.568548729874, 8128.146544612967, 8358.414910956175, 8562.657493700182, 8608.139186081342], "unit": "score", "name": "yui.html", "value": 5445.1660908738}], "name": "dromaeo_css", "value": 6009.218376015458}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 108.0, 113.0, 114.0, 114.0, 123.0, 116.0, 114.0, 115.0, 113.0], "unit": "score", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [153.0, 134.0, 152.0, 182.0, 130.0, 153.0, 174.0, 142.0, 175.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 152.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 163.0, 161.0, 169.0, 166.0, 167.0, 161.0, 165.0, 165.0], "unit": "score", "name": "audio-dft", "value": 164.1}, {"lowerIsBetter": true, "replicates": [75.0, 77.0, 73.0, 74.0, 141.0, 73.0, 79.0, 72.0, 73.0, 151.0], "unit": "score", "name": "audio-fft", "value": 88.8}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 131.0, 97.0, 98.0, 98.0, 141.0, 98.0, 97.0, 128.0], "unit": "score", "name": "audio-oscillator", "value": 108.2}, {"lowerIsBetter": true, "replicates": [109.0, 111.0, 109.0, 110.0, 113.0, 110.0, 110.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [148.0, 149.0, 149.0, 149.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 148.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.2}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 70.0, 70.0, 72.0, 71.0, 78.0, 68.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 71.0}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 70.0, 67.0, 73.0, 68.0, 67.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 83.0, 86.0, 87.0, 85.0, 83.0, 84.0, 83.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [134.0, 142.0, 127.0, 121.0, 123.0, 130.0, 131.0, 126.0, 133.0, 124.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.1}, {"lowerIsBetter": true, "replicates": [138.0, 161.0, 135.0, 138.0, 145.0, 135.0, 159.0, 146.0, 147.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 70.0, 71.0, 73.0, 70.0, 69.0, 70.0, 70.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1551.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.58337497917708], "unit": "score", "name": "Richards", "value": 211.91790600000007}, {"lowerIsBetter": false, "replicates": [186.46280067126608], "unit": "score", "name": "DeltaBlue", "value": 354.59083400000003}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5291.005291005291], "unit": "score", "name": "Decrypt", "value": 50.30820900000001}, {"lowerIsBetter": false, "replicates": [1077.502691065662], "unit": "score", "name": "RayTrace", "value": 686.7630179820178}, {"lowerIsBetter": false, "replicates": [713.7758743754462], "unit": "score", "name": "Earley", "value": 933.7146630000002}, {"lowerIsBetter": false, "replicates": [12292.682926829268], "unit": "score", "name": "Boyer", "value": 54.21623611111113}, {"lowerIsBetter": false, "replicates": [43782.608695652176], "unit": "score", "name": "RegExp", "value": 20.80700595829197}, {"lowerIsBetter": false, "replicates": [600.9529481834426], "unit": "score", "name": "Splay", "value": 135.60296233894945}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 20238.138950626035}]} 01:50:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20238.14"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1551.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6009.22"}}} 01:50:46 INFO - Return code: 0 01:50:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:50:46 INFO - # TBPL SUCCESS # 01:50:46 INFO - Running post-action listener: _resource_record_post_action 01:50:46 INFO - Running post-run listener: _resource_record_post_run 01:50:47 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 0; Write bytes: 539279360; Read time: 0; Write time: 419616 01:50:47 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 231112704; Read time: 0; Write time: 212124 01:50:47 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 307302400; Read time: 0; Write time: 207484 01:50:47 INFO - Running post-run listener: _upload_blobber_files 01:50:47 INFO - Blob upload gear active. 01:50:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:50:47 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 01:50:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:50:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:50:48 INFO - (blobuploader) - INFO - Open directory for files ... 01:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:50:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:50:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:50:49 INFO - (blobuploader) - INFO - Done attempting. 01:50:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:50:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:50:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:50:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:50:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:50:50 INFO - (blobuploader) - INFO - Done attempting. 01:50:50 INFO - (blobuploader) - INFO - Iteration through files over. 01:50:50 INFO - Return code: 0 01:50:50 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:50:50 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:50:50 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/160abcf59ad32397211e9a542a3efa10765d477c04b75fe353b853ce0e40df1e858b934d7952e2ba07eb5603c8530337f5460c90f9c22988be6246bc7e38712d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d8bcbb98fc860e7cc587f1323231b7e193a34a81cc58b6ce0f225c5e1b440bdc2ab93bb0e51ce0c1ac2bca5baf2451d3de7bd94414b9d4201a47e939f707f6a"} 01:50:50 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:50:50 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:50:50 INFO - Contents: 01:50:50 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/160abcf59ad32397211e9a542a3efa10765d477c04b75fe353b853ce0e40df1e858b934d7952e2ba07eb5603c8530337f5460c90f9c22988be6246bc7e38712d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d8bcbb98fc860e7cc587f1323231b7e193a34a81cc58b6ce0f225c5e1b440bdc2ab93bb0e51ce0c1ac2bca5baf2451d3de7bd94414b9d4201a47e939f707f6a"} 01:50:50 INFO - Copying logs to upload dir... 01:50:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.469648 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-01-13 01:50:49.433222) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 01:50:49.437163) ========= 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=7de08804244eb36560b44971000001c3-1452675945.364079-490770854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/160abcf59ad32397211e9a542a3efa10765d477c04b75fe353b853ce0e40df1e858b934d7952e2ba07eb5603c8530337f5460c90f9c22988be6246bc7e38712d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d8bcbb98fc860e7cc587f1323231b7e193a34a81cc58b6ce0f225c5e1b440bdc2ab93bb0e51ce0c1ac2bca5baf2451d3de7bd94414b9d4201a47e939f707f6a"} build_url:https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011447 build_url: 'https://queue.taskcluster.net/v1/task/WGxwc6AcT-q1eusaWSaV4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/160abcf59ad32397211e9a542a3efa10765d477c04b75fe353b853ce0e40df1e858b934d7952e2ba07eb5603c8530337f5460c90f9c22988be6246bc7e38712d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/3d8bcbb98fc860e7cc587f1323231b7e193a34a81cc58b6ce0f225c5e1b440bdc2ab93bb0e51ce0c1ac2bca5baf2451d3de7bd94414b9d4201a47e939f707f6a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-13 01:50:49.463237) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:50:49.463669) ========= 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=7de08804244eb36560b44971000001c3-1452675945.364079-490770854 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004759 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-13 01:50:49.546386) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 01:50:49.546793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-13 01:50:49.547241) ========= ========= Total master_lag: 0.24 =========