builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1452589319.66 results: success (0) buildid: 20160112000155 builduid: e20b98c114e7409e9f36d0c6e6cefb96 revision: 536e50802a026c22ffd1e8bfdaabc26b81c778a5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.660432) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.661161) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.661679) ========= 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=82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006262 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.685438) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.685734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.700628) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.701124) ========= 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=82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.753095) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.753615) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.754187) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.754672) ========= 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=82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-12 01:02:00-- 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% 223M=0s 2016-01-12 01:02:00 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103417 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.941475) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.941788) ========= 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=82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016478 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.970116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:01:59.970454) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 536e50802a026c22ffd1e8bfdaabc26b81c778a5 --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 536e50802a026c22ffd1e8bfdaabc26b81c778a5 --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=82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-12 01:02:00,864 truncating revision to first 12 chars 2016-01-12 01:02:00,864 Setting DEBUG logging. 2016-01-12 01:02:00,865 attempt 1/10 2016-01-12 01:02:00,865 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/536e50802a02?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-12 01:02:01,353 unpacking tar archive at: fx-team-536e50802a02/testing/mozharness/ program finished with exit code 0 elapsedTime=0.792815 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:02:00.776248) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 01:02:00.776587) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-12 01:02:00.784773) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 01:02:00.785038) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-12 01:02:00.785450) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-12 01:02:00.785742) ========= /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=82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:02:01 INFO - MultiFileLogger online at 20160112 01:02:01 in /builds/slave/test 01:02:01 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:02:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:02:01 INFO - {'append_to_log': False, 01:02:01 INFO - 'base_work_dir': '/builds/slave/test', 01:02:01 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:02:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:02:01 INFO - 'branch': 'Fx-Team-Non-PGO', 01:02:01 INFO - 'buildbot_json_path': 'buildprops.json', 01:02:01 INFO - 'config_files': ('talos/linux_config.py',), 01:02:01 INFO - 'default_actions': ('clobber', 01:02:01 INFO - 'read-buildbot-config', 01:02:01 INFO - 'download-and-extract', 01:02:01 INFO - 'populate-webroot', 01:02:01 INFO - 'create-virtualenv', 01:02:01 INFO - 'install', 01:02:01 INFO - 'run-tests'), 01:02:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:02:01 INFO - 'download_minidump_stackwalk': True, 01:02:01 INFO - 'download_symbols': 'ondemand', 01:02:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:02:01 INFO - 'tooltool.py': '/tools/tooltool.py', 01:02:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:02:01 INFO - '/tools/misc-python/virtualenv.py')}, 01:02:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:02:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:02:01 INFO - 'installer_path': 'installer.exe', 01:02:01 INFO - 'log_level': 'info', 01:02:01 INFO - 'log_name': 'talos', 01:02:01 INFO - 'log_to_console': True, 01:02:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:02:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:02:01 INFO - 'opt_config_files': (), 01:02:01 INFO - 'pip_index': False, 01:02:01 INFO - 'sps_profile': False, 01:02:01 INFO - 'sps_profile_interval': 0, 01:02:01 INFO - 'suite': 'dromaeojs-e10s', 01:02:01 INFO - 'system_bits': '32', 01:02:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:02:01 INFO - 'title': 'talos-linux64-ix-055', 01:02:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:02:01 INFO - 'use_talos_json': True, 01:02:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:02:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:02:01 INFO - 'work_dir': 'build'} 01:02:01 INFO - ##### 01:02:01 INFO - ##### Running clobber step. 01:02:01 INFO - ##### 01:02:01 INFO - Running pre-action listener: _resource_record_pre_action 01:02:01 INFO - Running main action method: clobber 01:02:01 INFO - rmtree: /builds/slave/test/build 01:02:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:02:02 INFO - Running post-action listener: _resource_record_post_action 01:02:02 INFO - ##### 01:02:02 INFO - ##### Running read-buildbot-config step. 01:02:02 INFO - ##### 01:02:02 INFO - Running pre-action listener: _resource_record_pre_action 01:02:02 INFO - Running main action method: read_buildbot_config 01:02:02 INFO - Using buildbot properties: 01:02:02 INFO - { 01:02:02 INFO - "project": "", 01:02:02 INFO - "product": "firefox", 01:02:02 INFO - "script_repo_revision": "production", 01:02:02 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:02:02 INFO - "repository": "", 01:02:02 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:02:02 INFO - "buildid": "20160112000155", 01:02:02 INFO - "pgo_build": "False", 01:02:02 INFO - "basedir": "/builds/slave/test", 01:02:02 INFO - "buildnumber": 674, 01:02:02 INFO - "slavename": "talos-linux64-ix-055", 01:02:02 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 01:02:02 INFO - "platform": "ubuntu64_hw", 01:02:02 INFO - "scheduler": "tests-fx-team-linux64-talos", 01:02:02 INFO - "branch": "fx-team", 01:02:02 INFO - "repo_path": "integration/fx-team", 01:02:02 INFO - "revision": "536e50802a026c22ffd1e8bfdaabc26b81c778a5", 01:02:02 INFO - "stage_platform": "linux64", 01:02:02 INFO - "builduid": "e20b98c114e7409e9f36d0c6e6cefb96", 01:02:02 INFO - "slavebuilddir": "test" 01:02:02 INFO - } 01:02:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 01:02:02 INFO - Running post-action listener: _resource_record_post_action 01:02:02 INFO - ##### 01:02:02 INFO - ##### Running download-and-extract step. 01:02:02 INFO - ##### 01:02:02 INFO - Running pre-action listener: _resource_record_pre_action 01:02:02 INFO - Running main action method: download_and_extract 01:02:02 INFO - mkdir: /builds/slave/test/build/tests 01:02:02 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:02:02 INFO - https://queue.taskcluster.net/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 01:02:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/test_packages.json 01:02:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/test_packages.json 01:02:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 01:02:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 01:02:04 INFO - Downloaded 1302 bytes. 01:02:04 INFO - Reading from file /builds/slave/test/build/test_packages.json 01:02:04 INFO - Using the following test package requirements: 01:02:04 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:02:04 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:02:04 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:04 INFO - u'jsshell-linux-x86_64.zip'], 01:02:04 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:02:04 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:02:04 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:02:04 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:02:04 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:02:04 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 01:02:04 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 01:02:04 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:02:04 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:02: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:02:04 INFO - https://queue.taskcluster.net/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:02:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:02:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:02:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/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:02:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/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:02:06 INFO - Downloaded 22756958 bytes. 01:02:06 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:02:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:02:06 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:02:07 INFO - Return code: 0 01:02:07 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:02: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:02:07 INFO - https://queue.taskcluster.net/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:02:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:02:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:02:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/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:02:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/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:02:10 INFO - Downloaded 22756958 bytes. 01:02:10 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:02:10 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 01:02:10 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:02:11 INFO - Return code: 0 01:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:11 INFO - https://queue.taskcluster.net/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:02:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:02:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:02:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/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:02:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/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:02:13 INFO - Downloaded 11132285 bytes. 01:02:13 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:02:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 01:02:13 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:02:13 INFO - Return code: 0 01:02:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:13 INFO - https://queue.taskcluster.net/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:02:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:02:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:02:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/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:02:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dYjvUOI-Q6iBvQTGauweAg/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:02:16 INFO - Downloaded 53752321 bytes. 01:02:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:02:16 INFO - mkdir: /builds/slave/test/properties 01:02:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:02:16 INFO - Writing to file /builds/slave/test/properties/build_url 01:02:16 INFO - Contents: 01:02:16 INFO - build_url:https://queue.taskcluster.net/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 01:02:16 INFO - Running post-action listener: _resource_record_post_action 01:02:16 INFO - Running post-action listener: set_extra_try_arguments 01:02:16 INFO - ##### 01:02:16 INFO - ##### Running populate-webroot step. 01:02:16 INFO - ##### 01:02:16 INFO - Running pre-action listener: _resource_record_pre_action 01:02:16 INFO - Running main action method: populate_webroot 01:02:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:02:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:02:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:02:16 INFO - '--tppagecycles', 01:02:16 INFO - '7'], 01:02:16 INFO - 'tests': ['tsvgm']}}, 01:02:16 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 01:02:16 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 01:02:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:02:16 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:02:16 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 01:02:16 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 01:02:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:02:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:16 INFO - 'talos_options': ['--e10s'], 01:02:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:02:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:16 INFO - 'tests': ['damp', 'tps']}, 01:02:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:16 INFO - 'talos_options': ['--e10s'], 01:02:16 INFO - 'tests': ['damp', 'tps']}, 01:02:16 INFO - 'g3': {'tests': ['dromaeo_dom']}, 01:02:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:02:16 INFO - 'other': {'tests': ['a11yr', 01:02:16 INFO - 'ts_paint', 01:02:16 INFO - 'tpaint', 01:02:16 INFO - 'sessionrestore', 01:02:16 INFO - 'sessionrestore_no_auto_restore']}, 01:02:16 INFO - 'other-e10s': {'talos_options': ['--e10s'], 01:02:16 INFO - 'tests': ['a11yr', 01:02:16 INFO - 'ts_paint', 01:02:16 INFO - 'tpaint', 01:02:16 INFO - 'sessionrestore', 01:02:16 INFO - 'sessionrestore_no_auto_restore']}, 01:02:16 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 01:02:16 INFO - 'tests': ['a11yr', 01:02:16 INFO - 'ts_paint', 01:02:16 INFO - 'tpaint', 01:02:16 INFO - 'sessionrestore', 01:02:16 INFO - 'sessionrestore_no_auto_restore']}, 01:02:16 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 01:02:16 INFO - 'tests': ['a11yr', 01:02:16 INFO - 'ts_paint', 01:02:16 INFO - 'tpaint', 01:02:16 INFO - 'sessionrestore', 01:02:16 INFO - 'sessionrestore_no_auto_restore']}, 01:02:16 INFO - 'other_l64': {'tests': ['a11yr', 01:02:16 INFO - 'ts_paint', 01:02:16 INFO - 'tpaint', 01:02:16 INFO - 'sessionrestore', 01:02:16 INFO - 'sessionrestore_no_auto_restore']}, 01:02:16 INFO - 'other_nol64': {'tests': ['a11yr', 01:02:16 INFO - 'ts_paint', 01:02:16 INFO - 'tpaint', 01:02:16 INFO - 'sessionrestore', 01:02:16 INFO - 'sessionrestore_no_auto_restore']}, 01:02:16 INFO - 'svgr': {'tests': ['tsvgx', 01:02:16 INFO - 'tsvgr_opacity', 01:02:16 INFO - 'tart', 01:02:16 INFO - 'tscrollx', 01:02:16 INFO - 'cart']}, 01:02:16 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 01:02:16 INFO - 'tests': ['tsvgx', 01:02:16 INFO - 'tsvgr_opacity', 01:02:16 INFO - 'tart', 01:02:16 INFO - 'tscrollx', 01:02:16 INFO - 'cart']}, 01:02:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:16 INFO - 'tests': ['tp5o']}, 01:02:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:16 INFO - 'talos_options': ['--e10s'], 01:02:16 INFO - 'tests': ['tp5o']}, 01:02:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:16 INFO - 'talos_options': ['--xperf_path', 01:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:02:16 INFO - 'tests': ['tp5n']}, 01:02:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:02:16 INFO - 'talos_options': ['--e10s', 01:02:16 INFO - '--xperf_path', 01:02:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:02:16 INFO - 'tests': ['tp5n']}}, 01:02:16 INFO - 'talos.zip': {'path': '', 01:02:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:02:16 INFO - Running post-action listener: _resource_record_post_action 01:02:16 INFO - ##### 01:02:16 INFO - ##### Running create-virtualenv step. 01:02:16 INFO - ##### 01:02:16 INFO - Running pre-action listener: _resource_record_pre_action 01:02:16 INFO - Running main action method: create_virtualenv 01:02:16 INFO - Creating virtualenv /builds/slave/test/build/venv 01:02:16 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:02:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:02:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:02:16 INFO - Using real prefix '/usr' 01:02:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:02:17 INFO - Installing distribute.............................................................................................................................................................................................done. 01:02:19 INFO - Installing pip.................done. 01:02:19 INFO - Return code: 0 01:02:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9794acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2715dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a83d0>, '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 0x2713ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2714360>, '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': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', '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:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:02:19 INFO - Using env: {'DISPLAY': ':0', 01:02:19 INFO - 'HOME': '/home/cltbld', 01:02:19 INFO - 'LANG': 'en_US.UTF-8', 01:02:19 INFO - 'LANGUAGE': 'en_US:en', 01:02:19 INFO - 'LOGNAME': 'cltbld', 01:02:19 INFO - 'MAIL': '/var/mail/cltbld', 01:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:19 INFO - 'MOZ_NO_REMOTE': '1', 01:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:19 INFO - 'NO_EM_RESTART': '1', 01:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:19 INFO - 'PWD': '/builds/slave/test', 01:02:19 INFO - 'SHELL': '/bin/bash', 01:02:19 INFO - 'SHLVL': '1', 01:02:19 INFO - 'TERM': 'linux', 01:02:19 INFO - 'TMOUT': '86400', 01:02:19 INFO - 'USER': 'cltbld', 01:02:19 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', 01:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:19 INFO - '_': '/tools/buildbot/bin/python'} 01:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:19 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:02:19 INFO - Cleaning up... 01:02:19 INFO - Return code: 0 01:02:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd9794acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2715dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a83d0>, '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 0x2713ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2714360>, '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': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', '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:02:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:02:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:02:19 INFO - Using env: {'DISPLAY': ':0', 01:02:19 INFO - 'HOME': '/home/cltbld', 01:02:19 INFO - 'LANG': 'en_US.UTF-8', 01:02:19 INFO - 'LANGUAGE': 'en_US:en', 01:02:19 INFO - 'LOGNAME': 'cltbld', 01:02:19 INFO - 'MAIL': '/var/mail/cltbld', 01:02:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:19 INFO - 'MOZ_NO_REMOTE': '1', 01:02:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:19 INFO - 'NO_EM_RESTART': '1', 01:02:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:19 INFO - 'PWD': '/builds/slave/test', 01:02:19 INFO - 'SHELL': '/bin/bash', 01:02:19 INFO - 'SHLVL': '1', 01:02:19 INFO - 'TERM': 'linux', 01:02:19 INFO - 'TMOUT': '86400', 01:02:19 INFO - 'USER': 'cltbld', 01:02:19 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', 01:02:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:19 INFO - '_': '/tools/buildbot/bin/python'} 01:02:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:19 INFO - Downloading/unpacking psutil>=0.7.1 01:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:21 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 01:02:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 01:02:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:02:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:02:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:02:21 INFO - Installing collected packages: psutil 01:02:21 INFO - Running setup.py install for psutil 01:02:21 INFO - building 'psutil._psutil_linux' extension 01:02:21 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:02:21 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:02:21 INFO - building 'psutil._psutil_posix' extension 01:02:21 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:02:21 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:02:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:02:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:02:22 INFO - Successfully installed psutil 01:02:22 INFO - Cleaning up... 01:02:22 INFO - Return code: 0 01:02:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:02:22 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:02:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:22 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:02:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:22 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 0x7fd9794acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2715dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a83d0>, '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 0x2713ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2714360>, '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': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', '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:02:22 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:02:22 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:02:22 INFO - Using env: {'DISPLAY': ':0', 01:02:22 INFO - 'HOME': '/home/cltbld', 01:02:22 INFO - 'LANG': 'en_US.UTF-8', 01:02:22 INFO - 'LANGUAGE': 'en_US:en', 01:02:22 INFO - 'LOGNAME': 'cltbld', 01:02:22 INFO - 'MAIL': '/var/mail/cltbld', 01:02:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:22 INFO - 'MOZ_NO_REMOTE': '1', 01:02:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:22 INFO - 'NO_EM_RESTART': '1', 01:02:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:22 INFO - 'PWD': '/builds/slave/test', 01:02:22 INFO - 'SHELL': '/bin/bash', 01:02:22 INFO - 'SHLVL': '1', 01:02:22 INFO - 'TERM': 'linux', 01:02:22 INFO - 'TMOUT': '86400', 01:02:22 INFO - 'USER': 'cltbld', 01:02:22 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', 01:02:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:22 INFO - '_': '/tools/buildbot/bin/python'} 01:02:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:22 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:02:22 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:02:22 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:02:22 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:02:22 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:02:22 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:02:22 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:02:23 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:02:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 01:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:02:24 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:02:24 INFO - Installing collected packages: mozsystemmonitor 01:02:24 INFO - Running setup.py install for mozsystemmonitor 01:02:24 INFO - Successfully installed mozsystemmonitor 01:02:24 INFO - Cleaning up... 01:02:24 INFO - Return code: 0 01:02:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7fd9794acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2715dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a83d0>, '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 0x2713ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2714360>, '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': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', '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:02:24 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:02:24 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:02:24 INFO - Using env: {'DISPLAY': ':0', 01:02:24 INFO - 'HOME': '/home/cltbld', 01:02:24 INFO - 'LANG': 'en_US.UTF-8', 01:02:24 INFO - 'LANGUAGE': 'en_US:en', 01:02:24 INFO - 'LOGNAME': 'cltbld', 01:02:24 INFO - 'MAIL': '/var/mail/cltbld', 01:02:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:24 INFO - 'MOZ_NO_REMOTE': '1', 01:02:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:24 INFO - 'NO_EM_RESTART': '1', 01:02:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:24 INFO - 'PWD': '/builds/slave/test', 01:02:24 INFO - 'SHELL': '/bin/bash', 01:02:24 INFO - 'SHLVL': '1', 01:02:24 INFO - 'TERM': 'linux', 01:02:24 INFO - 'TMOUT': '86400', 01:02:24 INFO - 'USER': 'cltbld', 01:02:24 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', 01:02:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:24 INFO - '_': '/tools/buildbot/bin/python'} 01:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:24 INFO - Downloading/unpacking blobuploader==1.2.4 01:02:24 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:02:24 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:02:24 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:02:24 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:02:24 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:02:24 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:02:26 INFO - Downloading blobuploader-1.2.4.tar.gz 01:02:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 01:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:02:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:02:26 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:02:26 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:02:26 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:02:26 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:02:26 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:02:26 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:02:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 01:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:02:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:02:26 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:02:26 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:02:26 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:02:26 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:02:26 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:02:26 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:02:26 INFO - Downloading docopt-0.6.1.tar.gz 01:02:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 01:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:02:26 INFO - Installing collected packages: blobuploader, requests, docopt 01:02:26 INFO - Running setup.py install for blobuploader 01:02:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:02:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:02:27 INFO - Running setup.py install for requests 01:02:27 INFO - Running setup.py install for docopt 01:02:27 INFO - Successfully installed blobuploader requests docopt 01:02:27 INFO - Cleaning up... 01:02:27 INFO - Return code: 0 01:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:27 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 0x7fd9794acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2715dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a83d0>, '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 0x2713ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2714360>, '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': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', '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:02:27 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:02:27 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:02:27 INFO - Using env: {'DISPLAY': ':0', 01:02:27 INFO - 'HOME': '/home/cltbld', 01:02:27 INFO - 'LANG': 'en_US.UTF-8', 01:02:27 INFO - 'LANGUAGE': 'en_US:en', 01:02:27 INFO - 'LOGNAME': 'cltbld', 01:02:27 INFO - 'MAIL': '/var/mail/cltbld', 01:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:27 INFO - 'MOZ_NO_REMOTE': '1', 01:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:27 INFO - 'NO_EM_RESTART': '1', 01:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:27 INFO - 'PWD': '/builds/slave/test', 01:02:27 INFO - 'SHELL': '/bin/bash', 01:02:27 INFO - 'SHLVL': '1', 01:02:27 INFO - 'TERM': 'linux', 01:02:27 INFO - 'TMOUT': '86400', 01:02:27 INFO - 'USER': 'cltbld', 01:02:27 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', 01:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:27 INFO - '_': '/tools/buildbot/bin/python'} 01:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:02:27 INFO - Running setup.py (path:/tmp/pip-1Ri9cI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:02:27 INFO - Running setup.py (path:/tmp/pip-ahhbmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:02:27 INFO - Running setup.py (path:/tmp/pip-4Ln8pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:02:27 INFO - Running setup.py (path:/tmp/pip-J8pCrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:02:28 INFO - Running setup.py (path:/tmp/pip-7vf6RQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:02:28 INFO - Running setup.py (path:/tmp/pip-17vheN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:02:28 INFO - Running setup.py (path:/tmp/pip-Dlfquq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:02:28 INFO - Running setup.py (path:/tmp/pip-LeuYnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:02:28 INFO - Running setup.py (path:/tmp/pip-JDRdvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:02:28 INFO - Running setup.py (path:/tmp/pip-a5bJds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:02:28 INFO - Running setup.py (path:/tmp/pip-aThhYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:02:28 INFO - Running setup.py (path:/tmp/pip-miq2u1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:02:28 INFO - Running setup.py (path:/tmp/pip-yfUR3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:02:28 INFO - Running setup.py (path:/tmp/pip-dZgmqm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:02:28 INFO - Running setup.py (path:/tmp/pip-g5qEz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:02:28 INFO - Running setup.py (path:/tmp/pip-KUL_rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:02:28 INFO - Running setup.py (path:/tmp/pip-2Wuup2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:02:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:02:28 INFO - Running setup.py install for manifestparser 01:02:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:02:29 INFO - Running setup.py install for mozcrash 01:02:29 INFO - Running setup.py install for mozdebug 01:02:29 INFO - Running setup.py install for mozdevice 01:02:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:02:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:02:29 INFO - Running setup.py install for mozfile 01:02:29 INFO - Running setup.py install for mozhttpd 01:02:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:02:29 INFO - Running setup.py install for mozinfo 01:02:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:02:29 INFO - Running setup.py install for mozInstall 01:02:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:02:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:02:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:02:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:02:29 INFO - Running setup.py install for mozleak 01:02:29 INFO - Running setup.py install for mozlog 01:02:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:02:30 INFO - Running setup.py install for moznetwork 01:02:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:02:30 INFO - Running setup.py install for mozprocess 01:02:30 INFO - Running setup.py install for mozprofile 01:02:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:02:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:02:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:02:30 INFO - Running setup.py install for mozrunner 01:02:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:02:30 INFO - Running setup.py install for mozscreenshot 01:02:30 INFO - Running setup.py install for moztest 01:02:30 INFO - Running setup.py install for mozversion 01:02:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:02:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:02:30 INFO - Cleaning up... 01:02:30 INFO - Return code: 0 01:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fd9794acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2715dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a83d0>, '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 0x2713ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2714360>, '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': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', '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:02:30 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:02:30 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:02:30 INFO - Using env: {'DISPLAY': ':0', 01:02:30 INFO - 'HOME': '/home/cltbld', 01:02:30 INFO - 'LANG': 'en_US.UTF-8', 01:02:30 INFO - 'LANGUAGE': 'en_US:en', 01:02:30 INFO - 'LOGNAME': 'cltbld', 01:02:30 INFO - 'MAIL': '/var/mail/cltbld', 01:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:30 INFO - 'MOZ_NO_REMOTE': '1', 01:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:30 INFO - 'NO_EM_RESTART': '1', 01:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:30 INFO - 'PWD': '/builds/slave/test', 01:02:30 INFO - 'SHELL': '/bin/bash', 01:02:30 INFO - 'SHLVL': '1', 01:02:30 INFO - 'TERM': 'linux', 01:02:30 INFO - 'TMOUT': '86400', 01:02:30 INFO - 'USER': 'cltbld', 01:02:30 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', 01:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:30 INFO - '_': '/tools/buildbot/bin/python'} 01:02:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:02:30 INFO - Running setup.py (path:/tmp/pip-iAxoNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:02:31 INFO - Running setup.py (path:/tmp/pip-p3moxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:02:31 INFO - Running setup.py (path:/tmp/pip-ajKK2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:02:31 INFO - Running setup.py (path:/tmp/pip-lyhj3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:02:31 INFO - Running setup.py (path:/tmp/pip-WdPeg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:02:31 INFO - Running setup.py (path:/tmp/pip-j8kI5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:02:31 INFO - Running setup.py (path:/tmp/pip-dG5Yqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:02:31 INFO - Running setup.py (path:/tmp/pip-0IepGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:02:31 INFO - Running setup.py (path:/tmp/pip-KxpCv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:02:31 INFO - Running setup.py (path:/tmp/pip-COlCbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:02:31 INFO - Running setup.py (path:/tmp/pip-H8Sxdf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:02:31 INFO - Running setup.py (path:/tmp/pip-w3ciyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:02:31 INFO - Running setup.py (path:/tmp/pip-vNqdL7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:02:31 INFO - Running setup.py (path:/tmp/pip-8zlUXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:02:31 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:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:02:31 INFO - Running setup.py (path:/tmp/pip-B2hNLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:02:32 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:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:02:32 INFO - Running setup.py (path:/tmp/pip-mIzMPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:02:32 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:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:02:32 INFO - Running setup.py (path:/tmp/pip-IlEfSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:02:32 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:02:32 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:02:32 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:02:32 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:02:32 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:02:32 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:02:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:33 INFO - Downloading blessings-1.5.1.tar.gz 01:02:34 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:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:02:34 INFO - Installing collected packages: blessings 01:02:34 INFO - Running setup.py install for blessings 01:02:34 INFO - Successfully installed blessings 01:02:34 INFO - Cleaning up... 01:02:34 INFO - Return code: 0 01:02:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:02:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:02:34 INFO - Reading from file tmpfile_stdout 01:02:34 INFO - Current package versions: 01:02:34 INFO - argparse == 1.2.1 01:02:34 INFO - blessings == 1.5.1 01:02:34 INFO - blobuploader == 1.2.4 01:02:34 INFO - docopt == 0.6.1 01:02:34 INFO - manifestparser == 1.1 01:02:34 INFO - mozInstall == 1.12 01:02:34 INFO - mozcrash == 0.16 01:02:34 INFO - mozdebug == 0.1 01:02:34 INFO - mozdevice == 0.47 01:02:34 INFO - mozfile == 1.2 01:02:34 INFO - mozhttpd == 0.7 01:02:34 INFO - mozinfo == 0.9 01:02:34 INFO - mozleak == 0.1 01:02:34 INFO - mozlog == 3.1 01:02:34 INFO - moznetwork == 0.27 01:02:34 INFO - mozprocess == 0.22 01:02:34 INFO - mozprofile == 0.28 01:02:34 INFO - mozrunner == 6.11 01:02:34 INFO - mozscreenshot == 0.1 01:02:34 INFO - mozsystemmonitor == 0.0 01:02:34 INFO - moztest == 0.7 01:02:34 INFO - mozversion == 1.4 01:02:34 INFO - psutil == 3.1.1 01:02:34 INFO - requests == 1.2.3 01:02:34 INFO - wsgiref == 0.1.2 01:02:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fd9794acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2715dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a83d0>, '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 0x2713ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2714360>, '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': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', '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:02:34 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:02:34 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:02:34 INFO - Using env: {'DISPLAY': ':0', 01:02:34 INFO - 'HOME': '/home/cltbld', 01:02:34 INFO - 'LANG': 'en_US.UTF-8', 01:02:34 INFO - 'LANGUAGE': 'en_US:en', 01:02:34 INFO - 'LOGNAME': 'cltbld', 01:02:34 INFO - 'MAIL': '/var/mail/cltbld', 01:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:34 INFO - 'MOZ_NO_REMOTE': '1', 01:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:34 INFO - 'NO_EM_RESTART': '1', 01:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:34 INFO - 'PWD': '/builds/slave/test', 01:02:34 INFO - 'SHELL': '/bin/bash', 01:02:34 INFO - 'SHLVL': '1', 01:02:34 INFO - 'TERM': 'linux', 01:02:34 INFO - 'TMOUT': '86400', 01:02:34 INFO - 'USER': 'cltbld', 01:02:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', 01:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:34 INFO - '_': '/tools/buildbot/bin/python'} 01:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:34 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:02:34 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:02:34 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:02:34 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:02:34 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:02:34 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:02:34 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:02:34 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:02:34 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:02:34 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:02:34 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:02:34 INFO - Cleaning up... 01:02:34 INFO - Return code: 0 01:02:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd9794acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2715dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a83d0>, '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 0x2713ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2714360>, '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': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', '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:02:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:02:34 INFO - Using env: {'DISPLAY': ':0', 01:02:34 INFO - 'HOME': '/home/cltbld', 01:02:34 INFO - 'LANG': 'en_US.UTF-8', 01:02:34 INFO - 'LANGUAGE': 'en_US:en', 01:02:34 INFO - 'LOGNAME': 'cltbld', 01:02:34 INFO - 'MAIL': '/var/mail/cltbld', 01:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:34 INFO - 'MOZ_NO_REMOTE': '1', 01:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:34 INFO - 'NO_EM_RESTART': '1', 01:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:34 INFO - 'PWD': '/builds/slave/test', 01:02:34 INFO - 'SHELL': '/bin/bash', 01:02:34 INFO - 'SHLVL': '1', 01:02:34 INFO - 'TERM': 'linux', 01:02:34 INFO - 'TMOUT': '86400', 01:02:34 INFO - 'USER': 'cltbld', 01:02:34 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', 01:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:34 INFO - '_': '/tools/buildbot/bin/python'} 01:02:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:34 INFO - Downloading/unpacking jsonschema 01:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:02:36 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:02:36 INFO - Downloading/unpacking functools32 (from jsonschema) 01:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:02:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:02:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:02:36 INFO - Downloading functools32-3.2.3-2.tar.gz 01:02:36 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:02:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:02:36 INFO - warning: no files found matching '*.txt' 01:02:36 INFO - no previously-included directories found matching 'build' 01:02:36 INFO - no previously-included directories found matching 'dist' 01:02:36 INFO - no previously-included directories found matching '.git*' 01:02:36 INFO - Installing collected packages: jsonschema, functools32 01:02:36 INFO - Running setup.py install for functools32 01:02:37 INFO - warning: no files found matching '*.txt' 01:02:37 INFO - no previously-included directories found matching 'build' 01:02:37 INFO - no previously-included directories found matching 'dist' 01:02:37 INFO - no previously-included directories found matching '.git*' 01:02:37 INFO - Successfully installed jsonschema functools32 01:02:37 INFO - Cleaning up... 01:02:37 INFO - Return code: 0 01:02:37 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:02:37 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:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:37 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:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:02:37 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 0x7fd9794acf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26468a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2715dd0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27a83d0>, '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 0x2713ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2714360>, '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': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', '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:02:37 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:02:37 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:02:37 INFO - Using env: {'DISPLAY': ':0', 01:02:37 INFO - 'HOME': '/home/cltbld', 01:02:37 INFO - 'LANG': 'en_US.UTF-8', 01:02:37 INFO - 'LANGUAGE': 'en_US:en', 01:02:37 INFO - 'LOGNAME': 'cltbld', 01:02:37 INFO - 'MAIL': '/var/mail/cltbld', 01:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:37 INFO - 'MOZ_NO_REMOTE': '1', 01:02:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:37 INFO - 'NO_EM_RESTART': '1', 01:02:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:37 INFO - 'PWD': '/builds/slave/test', 01:02:37 INFO - 'SHELL': '/bin/bash', 01:02:37 INFO - 'SHLVL': '1', 01:02:37 INFO - 'TERM': 'linux', 01:02:37 INFO - 'TMOUT': '86400', 01:02:37 INFO - 'USER': 'cltbld', 01:02:37 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', 01:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:37 INFO - '_': '/tools/buildbot/bin/python'} 01:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:02:37 INFO - Downloading/unpacking flake8 01:02:37 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:02:37 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:02:37 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:02:37 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:02:37 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:02:37 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:02:39 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:02:39 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:02:39 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:02:39 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:02:39 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:02:39 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:02:39 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:02:39 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:02:39 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:02:39 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:02:39 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:02:39 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:02:39 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:02:39 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:02:39 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:02:39 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:02:39 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:02:39 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:02:39 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:02:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:02:39 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:02:39 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:02:39 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:02:39 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:02:39 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:02:39 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:02:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 01:02:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:02:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:02:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:02:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:02:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:02:39 INFO - no previously-included directories found matching 'docs/_build' 01:02:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:02:39 INFO - Running setup.py install for pep8 01:02:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:02:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:02:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:02:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:02:39 INFO - no previously-included directories found matching 'docs/_build' 01:02:39 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:02:39 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:02:39 INFO - Cleaning up... 01:02:40 INFO - Return code: 0 01:02:40 INFO - Running post-action listener: _resource_record_post_action 01:02:40 INFO - Running post-action listener: _start_resource_monitoring 01:02:40 INFO - Starting resource monitoring. 01:02:40 INFO - ##### 01:02:40 INFO - ##### Running install step. 01:02:40 INFO - ##### 01:02:40 INFO - Running pre-action listener: _resource_record_pre_action 01:02:40 INFO - Running main action method: install 01:02:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:02:40 INFO - Reading from file tmpfile_stdout 01:02:40 INFO - Detecting whether we're running mozinstall >=1.0... 01:02:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:02:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:02:40 INFO - Reading from file tmpfile_stdout 01:02:40 INFO - Output received: 01:02:40 INFO - Usage: mozinstall [options] installer 01:02:40 INFO - Options: 01:02:40 INFO - -h, --help show this help message and exit 01:02:40 INFO - -d DEST, --destination=DEST 01:02:40 INFO - Directory to install application into. [default: 01:02:40 INFO - "/builds/slave/test"] 01:02:40 INFO - --app=APP Application being installed. [default: firefox] 01:02:40 INFO - mkdir: /builds/slave/test/build/application 01:02:40 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:02:40 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:02:55 INFO - Reading from file tmpfile_stdout 01:02:55 INFO - Output received: 01:02:55 INFO - /builds/slave/test/build/application/firefox/firefox 01:02:55 INFO - Running post-action listener: _resource_record_post_action 01:02:55 INFO - ##### 01:02:55 INFO - ##### Running run-tests step. 01:02:55 INFO - ##### 01:02:55 INFO - Running pre-action listener: _resource_record_pre_action 01:02:55 INFO - Running main action method: run_tests 01:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:02:55 INFO - Python 2.7.3 01:02:55 INFO - Return code: 0 01:02:55 INFO - grabbing minidump binary from tooltool 01:02:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:02:55 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 0x27a83d0>, '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 0x2713ed0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2714360>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:02:55 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:02:55 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:02:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:02:56 INFO - Return code: 0 01:02:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:02:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:02:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:02:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:02:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:02:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:02:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:02:56 INFO - Return code: 0 01:02:56 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/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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:02:56 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/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --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:02:56 INFO - Using env: {'DISPLAY': ':0', 01:02:56 INFO - 'HOME': '/home/cltbld', 01:02:56 INFO - 'LANG': 'en_US.UTF-8', 01:02:56 INFO - 'LANGUAGE': 'en_US:en', 01:02:56 INFO - 'LOGNAME': 'cltbld', 01:02:56 INFO - 'MAIL': '/var/mail/cltbld', 01:02:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:02:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:02:56 INFO - 'MOZ_NO_REMOTE': '1', 01:02:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:02:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:02:56 INFO - 'NO_EM_RESTART': '1', 01:02:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:02:56 INFO - 'PWD': '/builds/slave/test', 01:02:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:02:56 INFO - 'SHELL': '/bin/bash', 01:02:56 INFO - 'SHLVL': '1', 01:02:56 INFO - 'TERM': 'linux', 01:02:56 INFO - 'TMOUT': '86400', 01:02:56 INFO - 'USER': 'cltbld', 01:02:56 INFO - 'XDG_SESSION_COOKIE': '82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268', 01:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:02:56 INFO - '_': '/tools/buildbot/bin/python'} 01:02:56 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/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--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:02:57 INFO - mozversion application_buildid: 20160112000155 01:02:57 INFO - mozversion application_changeset: 536e50802a026c22ffd1e8bfdaabc26b81c778a5 01:02:57 INFO - mozversion application_display_name: Nightly 01:02:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:02:57 INFO - mozversion application_name: Firefox 01:02:57 INFO - mozversion application_remotingname: firefox 01:02:57 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:02:57 INFO - mozversion application_vendor: Mozilla 01:02:57 INFO - mozversion application_version: 46.0a1 01:02:57 INFO - mozversion platform_buildid: 20160112000155 01:02:57 INFO - mozversion platform_changeset: 536e50802a026c22ffd1e8bfdaabc26b81c778a5 01:02:57 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:02:57 INFO - mozversion platform_version: 46.0a1 01:02:57 INFO - using testdate: 1452589377 01:02:57 INFO - actual date: 1452589377 01:02:57 INFO - starting webserver on 'localhost:58467' 01:02:57 INFO - SUITE-START | Running 3 tests 01:02:57 INFO - TEST-START | dromaeo_css 01:02:57 INFO - operating with platform_type : linux_ 01:02:57 INFO - Initialising browser for dromaeo_css test... 01:02:57 INFO - TEST-INFO | started process 27771 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiVP02q/profile http://localhost:58467/getInfo.html) 01:03:00 INFO - PROCESS | 27771 | 01:03:00 INFO - PROCESS | 27771 | (process:27853): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:03:01 INFO - PROCESS | 27771 | __metrics Screen width/height:1600/1200 01:03:01 INFO - PROCESS | 27771 | colorDepth:24 01:03:01 INFO - PROCESS | 27771 | Browser inner width/height: 1024/697 01:03:01 INFO - PROCESS | 27771 | __metrics 01:03:01 INFO - PROCESS | 27771 | 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:03:02 INFO - TEST-INFO | 27771: exit 0 01:03:02 INFO - Browser initialized. 01:03:02 INFO - Running cycle 1/1 for dromaeo_css test... 01:03:02 INFO - TEST-INFO | started process 27902 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpiVP02q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:03:04 INFO - PROCESS | 27902 | 01:03:04 INFO - PROCESS | 27902 | (process:27959): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:03:14 INFO - PROCESS | 27902 | RSS: Main: 150245376 01:03:14 INFO - PROCESS | 27902 | 01:04:04 INFO - PROCESS | 27902 | 1452589444381 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:06:16 INFO - PROCESS | 27902 | Cycle 1(1): loaded http://localhost:58467/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58467/tests/dromaeo/cssquery-ext.html) 01:06:17 INFO - PROCESS | 27902 | RSS: Main: 152965120 01:06:17 INFO - PROCESS | 27902 | 01:09:19 INFO - PROCESS | 27902 | Cycle 1(1): loaded http://localhost:58467/tests/dromaeo/cssquery-ext.html (next: http://localhost:58467/tests/dromaeo/cssquery-jquery.html) 01:09:19 INFO - PROCESS | 27902 | RSS: Main: 151375872 01:09:19 INFO - PROCESS | 27902 | 01:12:21 INFO - PROCESS | 27902 | Cycle 1(1): loaded http://localhost:58467/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58467/tests/dromaeo/cssquery-mootools.html) 01:12:22 INFO - PROCESS | 27902 | RSS: Main: 152121344 01:12:22 INFO - PROCESS | 27902 | 01:15:24 INFO - PROCESS | 27902 | Cycle 1(1): loaded http://localhost:58467/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58467/tests/dromaeo/cssquery-prototype.html) 01:15:24 INFO - PROCESS | 27902 | RSS: Main: 150626304 01:15:24 INFO - PROCESS | 27902 | 01:18:27 INFO - PROCESS | 27902 | Cycle 1(1): loaded http://localhost:58467/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58467/tests/dromaeo/cssquery-yui.html) 01:18:27 INFO - PROCESS | 27902 | RSS: Main: 151580672 01:18:27 INFO - PROCESS | 27902 | 01:21:30 INFO - PROCESS | 27902 | Cycle 1(1): loaded http://localhost:58467/tests/dromaeo/cssquery-yui.html (next: http://localhost:58467/tests/dromaeo/cssquery-dojo.html) 01:21:30 INFO - PROCESS | 27902 | RSS: Main: 153886720 01:21:30 INFO - PROCESS | 27902 | 01:21:30 INFO - PROCESS | 27902 | __start_tp_report 01:21:30 INFO - PROCESS | 27902 | _x_x_mozilla_page_load 01:21:30 INFO - PROCESS | 27902 | _x_x_mozilla_page_load_details 01:21:30 INFO - PROCESS | 27902 | |i|pagename|runs| 01:21:30 INFO - PROCESS | 27902 | |0;dojo.html;2630.1057640402264;2676.7858571314296;2691.9192424227267;2705.080272707279;2725.5775354820003;4496.123255965088;4626.560476754703;4678.298255261709;4697;4702.8589142325745;4521.276595744682;4531.63746900248;4636.51316611756;4761.69049011814;4768.141734487791;4339.305711086219;4424.491183513889;4466.798994045275;4478.193925093482;4525.841595544157;4368.737875727466;4406.889827754299;4407.735535867842;4419.867403977886;4508.504064552896;4208.242516347056;4284.592963668447;4301.913961720779;4319.524852266248;4328.458942632171;4367.366731823868;4371.759553224571;4374.58441448062;4381.342798580206;4395.780210989437;4327.2643650579475;4355.651547876162;4358.411614432042;4368.803403846835;4405.207062728708;4431.357453169305;4526.456825180966;4557.794899229542;4628.745419001953;4658.767061646938;5027.849164525033;5031.84904452867;5035.370578677665;5054.368203974504;5075.111855425323;5053.343065401475;5054.039732450822;5058.190689489701;5064.290999260106;5093.18509038552;4503.909921801578;4620.584147426681;4621.098885717252;4698.976505117521;4738.526147385234;5096.133657278272;5131.7690703918415;5134.87162820925;5146.897062058738;5165.457626949192;4701.811927522929;4927.039227350704;4940.258961155855;4947.925781113287;4993.076280888047;4965.776540055634;4973.577245934136;5025.045241404122;5083.974580127076;5094;4974.527419895104;4990.750462476862;4992.301077849104;4997.625178111583;5051.646384753032;4752.572268495852;4961.107000739901;4971.900561988812;4973.651844370932;5023;4099.528554216244;4179.1014931789205;4213.852515161954;4242.342436922282;4282.48610166782;3717.20080182762;3720.069982504374;3722.664960153599;3730;3762.9247415051545;4221.957780422218;4319.956800432018;4356.629686476622;4360.563943605677;4385.101054283864;5000.2749601307605;5064.645474816801;5080.822171223989;5087.949120508748;5111.182210846247;4346.478422589246;4357.455318085239;4362.8036738346855;4382.53983331752;4421.40311058003;4343.630791382705;4473.575010374009;4488.4613846338;4558.452985641744;4570.063137056895;4788.401449818773;4788.61691064721;4789.688670236424;4801.063792560417;4802.567768900815;4994.200927851526;5016.398032236155;5033.622478314214;5037.496250375079;5092.159793634009;4632.2819962905805;4725.881852953704;4753.786079626356;4762.452317983476;4850.53919877611;4944.085344211332;4947.975260123821;4978.925316120189;4980.252962055721;4991.326170966873;5040.647154699136;5046.798128074836;5050.545450909436;5052.59579233653;5081.110805609078;4730.550597693214;4866.197077482176;4877.268409738567;4929.482404347636;4993.201087825931;4877.048975449753;4910.950890491193;4926.236433352836;4933.358663373882;4967.3045773591;4803;4817.975910120427;4818.807247710192;4819.734914579732;4822.541858523435;4731.645126615449;4815.903681926412;4855.393075865517;4915.901681966412;4945.332380128637;4824.662273640812;4826.903461930812;4828.444728856227;4846.80612775485;4886.804527818847 01:21:30 INFO - PROCESS | 27902 | |1;ext.html;469.50701763148686;470.1748431502713;474.8884012257119;494.7105943023331;502.4272329544322;24518.387040324;24974.625380619305;31769.841150794244;32310.707571697163;32418;35341.64658353416;35768;35849.2830143397;35978.280434391294;35990.820045899796;7447.85104297915;7604.049493813273;7618.162002179756;7620.390368770485;7622.809429764273;7395.260473952616;7475.514091584057;7541.095068591777;7559.395248380117;7565.243475652445;7535.171131175566;7605.049368828896;7609.6575654095695;7627.199144089874;7631.771046868603;7493.850122997564;7494.587797671126;7566.508176968479;7574.31831135195;7575.318221360077;7489.101307843093;7620.390368770485;7622.123455802598;7633.923660763432;7651.387888968925;36084.27831443356;36496.452553211726;36553.81723091394;36615.63384366149;36776.264474710355;2721.1972468121953;2806.2843974786297;2973.405318936221;3495.7727747696317;3501.2647344057777;26130.86934565334;27574;27603.585946210824;27643.170704878685;28068.719312806814;3405.1827561385335;3411.727061835047;3415.9146021349416;3440.2431465077643;3557.3063252665484;211705;213794;213947;214253;217048.99999999843;35032.12419689528;57386;58772.4122758767;58796;58827.11759323614;51587;51949.22076168861;51961.220581691305;52505.2124218137;52615.473845261826;13336.866631333756;13405.128666636638;13446.596602101952;13481.393337299649;13529.797053044213;9833.065858743408;10016.549255283384;10188.134008609202;10221.642242521624;10337;17469.563260918323;17725;17784.911075444797;17806.287748490173;17848.196831142628;7138.928610713826;7282.526635768658;7328.267173282736;7348.485606007635;7395.778126656209;754.5962909843207;833.4874052457695;892.9821403571892;942.5711301357866;980.9950950245203;21507.56984860294;22011;22105.66841497379;22106.005229764698;22198.223062192745;933.6172169410509;942.5193151492651;973.4840534516718;1026.312370711625;1051.8842927277992;12108.455119519644;12169.330686812133;12172.939135304267;12225.08311876595;12271.447784849703;261016;264796;266405.66797166277;267127;268017;44697.776511117234;44909;45037.77481112573;45039.774801125786;45069.774651126536;1166.3876464855848;1186.6202815099257;1199.760047990423;1200.5137919142762;1207.7886369885234;22738.31785046451;22805.771942280364;22922.885385572965;22983.310500685006;23195;33426.832865836484;33789.66210337865;33933.32133357369;33951.49072763861;34071.48892766561;247970;250720;251317;251495;251664;27490.725092748817;27854.303642408293;28377.574336384558;28562.42875142444;28640.570391444562;31574.842125789222;32085;32271.838640806647;32620;32711.18222044468;27915.860420697765;27921.44157116887;28319;28481.572776408786;28810.567841481974;27326.45347093087;27494.312642184104;27954.70311977463;28166.2958426041;28168.43663126767;30645.08064758061;30660.846695766377;30894.38211235808;30949.381012380076;31088.378232435676;34755.30489390249;34822;35273.823630881685;35864.64135358613;37103.62896371002;25537;26381.60427593626;26676.866615666797;27143.321416964733;28099.71900280971 01:21:30 INFO - PROCESS | 27902 | |2;jquery.html;330.1926789000892;332.3552308521468;333.97662163648545;334.90120414477724;341.5781509835351;10017.398956062641;10150.13723833475;10450.3207291526;14338.426462941483;14679;16055.431131019039;16386;16606.83393166068;16743.16284185792;17026.404075857346;5234.450382709818;5564.916526252109;5572.331320241577;5586.35756887959;5593.496585307322;4525.275955847065;5465.890682186354;5543.584231182657;5595.244641973322;5606.411326810667;5498.395176530578;5523.309586301712;5524.8342549723575;5554.91667624986;5558.471945165203;5342.626016178869;5497.092979658351;5578.888422231573;5580.079286917654;5613.522850557708;5173.715445650488;5337.332833395825;5348.197770334442;5383.596230282745;5388.649737767033;19566.51083722904;20266.189352425885;20351.49121271965;20444.182232710675;20464.181432742673;1804.9639007219914;1837.7702787151607;1876.315144972089;1952.746143001415;2071.8964051797348;12907.548235811702;13147;13182;13368.33158342079;13491.460341586324;1882.8117188281199;1888.490107670935;1898.2795603045586;1936.8353689936373;1987.125664707524;53235.733821331036;54630;54638;54661.72669136669;56198.71900640512;14225.78661320081;14529.709405812036;14595.270236488133;14624.926875365554;14671.413143474141;17828.732569011474;20398.28605998783;20499.4875128123;21731.782682173292;21772.455688607595;6636.900446493307;6871;6950.478714096463;6962.303769623099;7945.920540794518;6549.181352330958;6571.211454625475;6626.138601981712;6760.526763126632;6804.795856124225;4198.307279298881;4249.532551419341;4254.064105896698;4264.232438161099;4267.487901451846;1724.741288806689;1771.973420398695;1777;1826.2968757028639;1826.7351234070986;774.5778550689887;835.2357592802517;858.6479543387181;865.1046167217027;935.3265648732902;14699.485518006819;14931.70136597262;14935.327910243848;15043;15444;871.808202195516;887.6582515731361;916.862470629411;957.2916042128775;972.4651441707033;6186.443220110122;8587.871181932276;8655.610497527627;8783.780405489786;8807.955960220157;401587;403479;405518;405581;424192;54242.728786355816;57237.71381143151;57941;57991.4200857986;58725.706371467866;1059.4173204737363;1089.716673664837;1095.1950316517352;1099.3568762273999;1099.5272033025876;13586.79619805684;14064.437422502986;14394.928025359806;14492.637684057561;14700.264986750406;25942.48115037651;29676.55485167681;30253.848730756206;30260.84869575726;30789.23026924255;35742.4638630426;36301.636983629825;37243.25513489769;37262;37489.437658435694;6218.502519798315;6352.333005034405;6356.237251529846;6390.233172019387;6554.016897465418;7574.772756817304;9354.53227338644;9466;9555.952220238854;9706.077922597342;8101.554414507259;8217.2604465596;8238.794030149294;8305.792355191168;8361.533347662333;7803.609819509115;8282.50304981703;8307.460015098999;8571.22858942698;8693.695720649746;7765.456418050908;8210.507369557845;8338.666453341799;8353.791155221168;8392.748217553482;6433.324500927335;6469.223693156851;6492.350764923659;6519.348065193442;6589.439897608757;6975.337342952412;8145.551994640352;8158.224968627971;8259.876101858357;8511.74464766058 01:21:30 INFO - PROCESS | 27902 | |3;mootools.html;1404.789281607759;1428.9785653215201;1529.6099494628868;1730.2732852202073;1751.7547543343926;6310.747570097191;6436.613803171813;7188.568685878851;7348.742794002204;7355;7098.85802283954;7223.277672232774;7284.854302913952;7286.56280623163;7292.4530660200435;2123.62836503612;2156.040561949933;2157.072458842697;2158.028887000856;2161.027537608075;2133.455968727972;2143.7534683511362;2197.9450513737124;2199.967000494994;2204.5039866030097;2103.5056761661;2131.7868213178635;2135.2099723102397;2143.3248526714115;2154.601398741238;2143.5498545305504;2160.1467420368945;2166.5450255446376;2172.532905425325;2174.804267615906;2148.7206663133693;2164.5238047629496;2170.913163473459;2175.793299636532;2180.8364372672113;7382.151052628963;7447.664855081534;7448.702051917917;7450.105987281507;7461.440391970624;4315.244832154361;4405.052913623586;4417.2269852775635;4441.311596702516;4444.333349997494;2773.847438390888;2775.2090654163467;2846.0607999360163;2848.700886406939;2860.8140470869535;838.224642205957;875.5447167472942;882.1795729971125;890.9198172164472;908.681961313535;10303.948480257552;10346.482675866251;10389.324693894872;10395.116415104725;10475.685729428129;4024.0744628735556;4038.9596104038583;4109.97945010279;4148.875533733993;4151.543330233671;8907.242884354773;8919.821603568022;8949.10508949113;8950.820983580292;8956.68651597204;4484.282514797616;4513.300438432048;4524.959259370363;4526.072155208174;4530.433695788027;3340.5657264555452;3420.1620602952435;3828.2917660232947;3992.321305378093;4025.376066709665;3312.0560640217423;3328.384248913959;3332.6334103248623;3351.178961154484;3358.3954888120375;1075.3386667199616;1093.1418836213534;1099.3019432660158;1099.598646494024;1105.4086063955906;888.6223355074068;909.1681111782644;1176.394157009141;1184.8400465937161;1197.455157903152;6782.1861376635115;6852.143482064742;6871.587704737632;6875.278095799869;6882.827929301808;1057.4078516030893;1061.877884043345;1065.2756125834508;1067.508945884886;1092.1754075672816;5196.870078248074;5234.214867769789;5262.789488420421;5263.210518422267;5270.868228294324;8987.955060224656;9111.772205694911;9312.953435232781;9417.246620270362;9482.288828337902;9212.677556285631;9219.44683319003;9234.353595248269;9246.537673116318;9273.072692730673;6754.966225168842;6896.2069362023;6907.412869906114;7133.964330178316;7203.639818009078;6762.8647427052165;6849.863002740017;6886.69009894566;6902.689378978059;6909.378155965987;7664.425168112302;8009.959950200212;8038.155993620586;8065.354771618374;8073.19268073188;8048.919510805052;8158.632861521364;8194.590270486571;8302.294304983903;8325.583720814057;5630.211770352236;5781.306243250837;6350.460210882126;6433.839154021187;6570.967145164243;6629.635370054693;6776.491763117688;6800.353966373186;6819.352161544645;6823.658817059028;6223.128761973418;6232.127502149793;6307.716152773044;6384.265809431789;6426.228852537725;6196.256449226122;6268.498520118288;6304.7162877671535;6381.8723625528155;6406.903896441464;6070.150178974859;6083.756649733961;6140.201773769381;6277.089821975879;6277.246730392199;6149;6150.723217455135;6169.96915015422;6203.410675985774;6215.378462153749;5873.911891321719;5897.351291358033;5907.881842363215;5941.7623295067715;6000.729967151576 01:21:30 INFO - PROCESS | 27902 | |4;prototype.html;317.88079470198676;320.4008504097338;325.83870983862994;328.7008821972006;332.10828924338153;5557.193911978608;5577.135543990688;5579.135234038726;5640.407757185498;5720.399358067395;5577.972110139453;5589.105743081108;5597.468240517154;5611.2144299798065;5612.775488980446;4342.609165175134;4350.956490435086;4356.564343565634;4360.716553424033;4361.084172323815;4363.934540981872;4366.4978527469275;4371.584699453562;4375.278079116942;4385.122975404915;4221.472315960505;4300.3764454154125;4323.351497275403;4324.567543245682;4325.935110973338;4309.396684464177;4319.978400108011;4320.049589090395;4325.718828276168;4329.913401731964;3726.9440958385376;3734.439834024891;3736.0286325555553;3745.793981331026;3753.0992561784974;5393.649412788156;5394.6493477924205;5408.13469844823;5408.188771684239;5412.485813847678;4767.8569642910425;4966.975165124151;4970.403551573834;4978.203487442028;4993.176125939216;5692.715364231772;5766.0774276116035;5803.100519419497;5860.06239001762;5861.296644402656;3992.4210989406374;4019.718619696622;4019.8995025124314;4020.155767288873;4025.0339918419368;6110.816675499742;6197.473214776749;6197.504199664016;6199.411055949678;6199.783007594712;4061.7156799023783;4170.35359519275;4171.374293855946;4173;4175.770332631673;4230.788460576959;4231.661467082626;4243.618074373321;4245.469316335458;4298.312270036841;4865.416150062015;4923.556879880828;4936.531029552187;4944.25836124577;4947.703137811743;5915.053591425351;5932.525397968152;5933;5943.70281485924;5945.940540594539;1453.941842326295;1491.2618253964356;1530.8928375013866;1536.377767004365;1537.5848520899517;1007.773251018515;1008.8297574813181;1011.7723512209694;1017.4810846468206;1021.7905329407454;5056.519630635084;5064.696118232918;5122.743862806845;5125.513076257749;5130.846074617767;6082.635041897501;6086.117512960596;6091.939080609137;6096.542759293071;6105.450509454082;5110.233464980282;5110.6678065926335;5115.462876397999;5115.846524604268;5129.153689641242;3234.2884565395575;3241.36793325304;3282.179455136216;3310.8841190558214;3314.6022477302395;5673.716314184274;5745.1382292656435;5748.971255143698;5749.281339832521;5750.281214848144;6196.690165491707;6225.595336303126;6238.1890354254565;6241.563090583615;6255.061740738925;5646.491815736521;5724.742386592613;5729.4843464088435;5735.340435849847;5799.2750906136735;6151.907721384272;6165.260168779775;6183.474404675653;6188.44304012641;6206.472449841814;5969.492593129459;5999.250093738283;6024.246969128859;6026.849328766641;6032.125341825323;5689.34572524165;5820.447057529528;5824.650520968756;5825.79609713658;5858.004139296415;4151.066010147692;4187.37189421577;4200.9369859452745;4204.411382406527;4210.494740631144;6177.876442471215;6178;6190.690465476618;6191.4118158774845;6202.658853762906;5939.643621382731;5948.73230704628;5961.4038596140035;5963;5963.493103086286;5739.311282646109;5919.644821310735;5944.821655350346;5962.07587823888;5966;5824.21373114641;5831.183634291117;5833.0667093266575;5852.4440178183;5861.677607731615;6002.939970600238;6011.789587364421;6013.218281623361;6019.668918209541;6021.909671354845;5714.114312281603;5807.651540907559;5838.416158384128;5838.912416313844;5853.09277062056 01:21:30 INFO - PROCESS | 27902 | |5;yui.html;619.8667286533395;653.7352372289224;696.3176087434314;711.6299524247391;773.7833406646139;10915.781684366319;10991.230613857033;11005.504752286146;11023.669289921305;11052.944735276322;12097.516099356037;12589.811152832715;12784;12803.103782735212;12872.163309384883;621.6239175298947;785.8978332816725;799.3724925933144;800.1678254615193;800.3557136505111;618.072890664004;791.4894892794144;808.1151139502235;810.0603300171801;811.9350451963858;837.271573730852;837.4556538250156;846.4371193156575;852.1265702654766;852.1819053708448;833.0669649992018;834.0366876257932;835.7910522369408;839.0141583639199;844.7592436155666;618.2519151826295;618.7617767159676;619.9256089269317;621.552482212806;622.7882519943241;11791.11566632506;11906.821397679041;11947.462364193632;11961.162718609701;12002.939985300105;11053.392063436508;11350.602728904449;11418.371989540572;11463.36951467669;12004.759904801942;8811.383203175781;8900;9051.637934482613;9101.226395756303;9105.31710121737;3135.843207839599;3147.8583463743958;3201.8719251230154;3206;3220.066180807563;37869.05327366838;38338.233235335414;38384.23231535382;38539.42190867139;38561.61438385608;8800.691975780817;8967.327450441244;8979.910200898039;9013.77465563353;9172.174504294646;15792;15880.364785408685;15907.284172212278;15915.681686366208;15922.363105475883;6166.167567378347;6195.783147589903;6199.814005579839;6210.4100110489435;6238.625682459067;3511.9122021949142;3563.928721425557;3573.1960308930284;3602.5676918769914;3678.2459595782802;2657.070025491101;2687.3013016615428;2688.274165975176;2691.838489690625;2703.391736859191;469.4812232483125;475.764496574198;476.1548251852989;486.46520228678577;490.0175148826651;443.9223135951196;492.308306828906;500.6745615349979;516.4138702572607;564.1819361925225;6924.169099708067;6967.756128535579;7112.92887071133;7116.750913717995;7180.389666878374;440.41204991336286;469.8003348576841;507.2695318741001;549.4779959038929;574.5403677058337;3309.9007029788663;3375.7130643895543;3559.5728512578658;3692.51997240357;3695.796731179757;39008.2198356037;39184.804075980006;39274.80362598169;39294.803525982185;39378.21243575113;36216.81891590525;36356.81821590875;36553.08617284589;36680.266394671955;36695.26609467796;32633.836830815693;32906.50640240398;33102.50346244808;33424.49863252053;34205.315893682484;7332.193458719643;7347.963260183665;7520.962395187989;7584.165741768291;7602.835463258742;29881.103566893027;29893.551596726502;30187.547186792654;30295;30596.08211753651;34235.65764342325;34519.30961380809;34876.30247394987;37525.249495009404;37607.24785504329;9577.856332155163;9851.704448866545;9894.752631184278;10410.791784164427;10438.895611043792;10466.581336746445;10698.358098514114;11039.116870650489;11225.550977960791;11402.087832973508;9191.678291259774;9580.76048098803;9957.253206009724;10252.948735256574;10281.12610428122;9917.65288214909;9995.650152244636;10010.549525271235;10226.28416010872;10342;9093.636254550009;9293.72118836436;9328.95335523318;9542.666006689733;10019.148372388137;8052.5571093590415;8242.793930151794;8315.875261871197;8332.750017499484;8640.740777776677;7929.603519823871;8366.16338366183;8394.958025209835;8827.249683776694;9082.54587270647 01:21:30 INFO - PROCESS | 27902 | __end_tp_report 01:21:30 INFO - PROCESS | 27902 | __start_cc_report 01:21:30 INFO - PROCESS | 27902 | _x_x_mozilla_cycle_collect,327 01:21:30 INFO - PROCESS | 27902 | __end_cc_report 01:21:30 INFO - PROCESS | 27902 | __startTimestamp1452590490791__endTimestamp 01:21:30 INFO - PROCESS | 27902 | 01:21:30 INFO - PROCESS | 27902 | ------- Summary: start ------- 01:21:30 INFO - PROCESS | 27902 | Number of tests: 6 01:21:30 INFO - PROCESS | 27902 | 01:21:30 INFO - PROCESS | 27902 | [#0] dojo.html Cycles:165 Average:4644.94 Median:4768.14 stddev:475.75 (10.0%) stddev-sans-first:450.19 01:21:30 INFO - PROCESS | 27902 | Values: 2630.1 2676.8 2691.9 2705.1 2725.6 4496.1 4626.6 4678.3 4697.0 4702.9 4521.3 4531.6 4636.5 4761.7 4768.1 4339.3 4424.5 4466.8 4478.2 4525.8 4368.7 4406.9 4407.7 4419.9 4508.5 4208.2 4284.6 4301.9 4319.5 4328.5 4367.4 4371.8 4374.6 4381.3 4395.8 4327.3 4355.7 4358.4 4368.8 4405.2 4431.4 4526.5 4557.8 4628.7 4658.8 5027.8 5031.8 5035.4 5054.4 5075.1 5053.3 5054.0 5058.2 5064.3 5093.2 4503.9 4620.6 4621.1 4699.0 4738.5 5096.1 5131.8 5134.9 5146.9 5165.5 4701.8 4927.0 4940.3 4947.9 4993.1 4965.8 4973.6 5025.0 5084.0 5094.0 4974.5 4990.8 4992.3 4997.6 5051.6 4752.6 4961.1 4971.9 4973.7 5023.0 4099.5 4179.1 4213.9 4242.3 4282.5 3717.2 3720.1 3722.7 3730.0 3762.9 4222.0 4320.0 4356.6 4360.6 4385.1 5000.3 5064.6 5080.8 5087.9 5111.2 4346.5 4357.5 4362.8 4382.5 4421.4 4343.6 4473.6 4488.5 4558.5 4570.1 4788.4 4788.6 4789.7 4801.1 4802.6 4994.2 5016.4 5033.6 5037.5 5092.2 4632.3 4725.9 4753.8 4762.5 4850.5 4944.1 4948.0 4978.9 4980.3 4991.3 5040.6 5046.8 5050.5 5052.6 5081.1 4730.6 4866.2 4877.3 4929.5 4993.2 4877.0 4911.0 4926.2 4933.4 4967.3 4803.0 4818.0 4818.8 4819.7 4822.5 4731.6 4815.9 4855.4 4915.9 4945.3 4824.7 4826.9 4828.4 4846.8 4886.8 01:21:30 INFO - PROCESS | 27902 | 01:21:30 INFO - PROCESS | 27902 | [#1] ext.html Cycles:180 Average:39087.79 Median:32364.35 stddev:63798.71 (197.1%) stddev-sans-first:63911.79 01:21:30 INFO - PROCESS | 27902 | Values: 469.5 470.2 474.9 494.7 502.4 24518.4 24974.6 31769.8 32310.7 32418.0 35341.6 35768.0 35849.3 35978.3 35990.8 7447.9 7604.0 7618.2 7620.4 7622.8 7395.3 7475.5 7541.1 7559.4 7565.2 7535.2 7605.0 7609.7 7627.2 7631.8 7493.9 7494.6 7566.5 7574.3 7575.3 7489.1 7620.4 7622.1 7633.9 7651.4 36084.3 36496.5 36553.8 36615.6 36776.3 2721.2 2806.3 2973.4 3495.8 3501.3 26130.9 27574.0 27603.6 27643.2 28068.7 3405.2 3411.7 3415.9 3440.2 3557.3 211705.0 213794.0 213947.0 214253.0 217049.0 35032.1 57386.0 58772.4 58796.0 58827.1 51587.0 51949.2 51961.2 52505.2 52615.5 13336.9 13405.1 13446.6 13481.4 13529.8 9833.1 10016.5 10188.1 10221.6 10337.0 17469.6 17725.0 17784.9 17806.3 17848.2 7138.9 7282.5 7328.3 7348.5 7395.8 754.6 833.5 893.0 942.6 981.0 21507.6 22011.0 22105.7 22106.0 22198.2 933.6 942.5 973.5 1026.3 1051.9 12108.5 12169.3 12172.9 12225.1 12271.4 261016.0 264796.0 266405.7 267127.0 268017.0 44697.8 44909.0 45037.8 45039.8 45069.8 1166.4 1186.6 1199.8 1200.5 1207.8 22738.3 22805.8 22922.9 22983.3 23195.0 33426.8 33789.7 33933.3 33951.5 34071.5 247970.0 250720.0 251317.0 251495.0 251664.0 27490.7 27854.3 28377.6 28562.4 28640.6 31574.8 32085.0 32271.8 32620.0 32711.2 27915.9 27921.4 28319.0 28481.6 28810.6 27326.5 27494.3 27954.7 28166.3 28168.4 30645.1 30660.8 30894.4 30949.4 31088.4 34755.3 34822.0 35273.8 35864.6 37103.6 25537.0 26381.6 26676.9 27143.3 28099.7 01:21:30 INFO - PROCESS | 27902 | 01:21:30 INFO - PROCESS | 27902 | [#2] jquery.html Cycles:180 Average:23038.01 Median:5345.41 stddev:66604.75 (1246.0%) stddev-sans-first:66769.77 01:21:30 INFO - PROCESS | 27902 | Values: 330.2 332.4 334.0 334.9 341.6 10017.4 10150.1 10450.3 14338.4 14679.0 16055.4 16386.0 16606.8 16743.2 17026.4 5234.5 5564.9 5572.3 5586.4 5593.5 4525.3 5465.9 5543.6 5595.2 5606.4 5498.4 5523.3 5524.8 5554.9 5558.5 5342.6 5497.1 5578.9 5580.1 5613.5 5173.7 5337.3 5348.2 5383.6 5388.6 19566.5 20266.2 20351.5 20444.2 20464.2 1805.0 1837.8 1876.3 1952.7 2071.9 12907.5 13147.0 13182.0 13368.3 13491.5 1882.8 1888.5 1898.3 1936.8 1987.1 53235.7 54630.0 54638.0 54661.7 56198.7 14225.8 14529.7 14595.3 14624.9 14671.4 17828.7 20398.3 20499.5 21731.8 21772.5 6636.9 6871.0 6950.5 6962.3 7945.9 6549.2 6571.2 6626.1 6760.5 6804.8 4198.3 4249.5 4254.1 4264.2 4267.5 1724.7 1772.0 1777.0 1826.3 1826.7 774.6 835.2 858.6 865.1 935.3 14699.5 14931.7 14935.3 15043.0 15444.0 871.8 887.7 916.9 957.3 972.5 6186.4 8587.9 8655.6 8783.8 8808.0 401587.0 403479.0 405518.0 405581.0 424192.0 54242.7 57237.7 57941.0 57991.4 58725.7 1059.4 1089.7 1095.2 1099.4 1099.5 13586.8 14064.4 14394.9 14492.6 14700.3 25942.5 29676.6 30253.8 30260.8 30789.2 35742.5 36301.6 37243.3 37262.0 37489.4 6218.5 6352.3 6356.2 6390.2 6554.0 7574.8 9354.5 9466.0 9556.0 9706.1 8101.6 8217.3 8238.8 8305.8 8361.5 7803.6 8282.5 8307.5 8571.2 8693.7 7765.5 8210.5 8338.7 8353.8 8392.7 6433.3 6469.2 6492.4 6519.3 6589.4 6975.3 8145.6 8158.2 8259.9 8511.7 01:21:30 INFO - PROCESS | 27902 | 01:21:30 INFO - PROCESS | 27902 | [#3] mootools.html Cycles:180 Average:5131.34 Median:6076.95 stddev:2708.26 (44.6%) stddev-sans-first:2701.38 01:21:30 INFO - PROCESS | 27902 | Values: 1404.8 1429.0 1529.6 1730.3 1751.8 6310.7 6436.6 7188.6 7348.7 7355.0 7098.9 7223.3 7284.9 7286.6 7292.5 2123.6 2156.0 2157.1 2158.0 2161.0 2133.5 2143.8 2197.9 2200.0 2204.5 2103.5 2131.8 2135.2 2143.3 2154.6 2143.5 2160.1 2166.5 2172.5 2174.8 2148.7 2164.5 2170.9 2175.8 2180.8 7382.2 7447.7 7448.7 7450.1 7461.4 4315.2 4405.1 4417.2 4441.3 4444.3 2773.8 2775.2 2846.1 2848.7 2860.8 838.2 875.5 882.2 890.9 908.7 10303.9 10346.5 10389.3 10395.1 10475.7 4024.1 4039.0 4110.0 4148.9 4151.5 8907.2 8919.8 8949.1 8950.8 8956.7 4484.3 4513.3 4525.0 4526.1 4530.4 3340.6 3420.2 3828.3 3992.3 4025.4 3312.1 3328.4 3332.6 3351.2 3358.4 1075.3 1093.1 1099.3 1099.6 1105.4 888.6 909.2 1176.4 1184.8 1197.5 6782.2 6852.1 6871.6 6875.3 6882.8 1057.4 1061.9 1065.3 1067.5 1092.2 5196.9 5234.2 5262.8 5263.2 5270.9 8988.0 9111.8 9313.0 9417.2 9482.3 9212.7 9219.4 9234.4 9246.5 9273.1 6755.0 6896.2 6907.4 7134.0 7203.6 6762.9 6849.9 6886.7 6902.7 6909.4 7664.4 8010.0 8038.2 8065.4 8073.2 8048.9 8158.6 8194.6 8302.3 8325.6 5630.2 5781.3 6350.5 6433.8 6571.0 6629.6 6776.5 6800.4 6819.4 6823.7 6223.1 6232.1 6307.7 6384.3 6426.2 6196.3 6268.5 6304.7 6381.9 6406.9 6070.2 6083.8 6140.2 6277.1 6277.2 6149.0 6150.7 6170.0 6203.4 6215.4 5873.9 5897.4 5907.9 5941.8 6000.7 01:21:30 INFO - PROCESS | 27902 | 01:21:30 INFO - PROCESS | 27902 | [#4] prototype.html Cycles:180 Average:4886.48 Median:5567.16 stddev:1446.84 (26.0%) stddev-sans-first:1409.68 01:21:30 INFO - PROCESS | 27902 | Values: 317.9 320.4 325.8 328.7 332.1 5557.2 5577.1 5579.1 5640.4 5720.4 5578.0 5589.1 5597.5 5611.2 5612.8 4342.6 4351.0 4356.6 4360.7 4361.1 4363.9 4366.5 4371.6 4375.3 4385.1 4221.5 4300.4 4323.4 4324.6 4325.9 4309.4 4320.0 4320.0 4325.7 4329.9 3726.9 3734.4 3736.0 3745.8 3753.1 5393.6 5394.6 5408.1 5408.2 5412.5 4767.9 4967.0 4970.4 4978.2 4993.2 5692.7 5766.1 5803.1 5860.1 5861.3 3992.4 4019.7 4019.9 4020.2 4025.0 6110.8 6197.5 6197.5 6199.4 6199.8 4061.7 4170.4 4171.4 4173.0 4175.8 4230.8 4231.7 4243.6 4245.5 4298.3 4865.4 4923.6 4936.5 4944.3 4947.7 5915.1 5932.5 5933.0 5943.7 5945.9 1453.9 1491.3 1530.9 1536.4 1537.6 1007.8 1008.8 1011.8 1017.5 1021.8 5056.5 5064.7 5122.7 5125.5 5130.8 6082.6 6086.1 6091.9 6096.5 6105.5 5110.2 5110.7 5115.5 5115.8 5129.2 3234.3 3241.4 3282.2 3310.9 3314.6 5673.7 5745.1 5749.0 5749.3 5750.3 6196.7 6225.6 6238.2 6241.6 6255.1 5646.5 5724.7 5729.5 5735.3 5799.3 6151.9 6165.3 6183.5 6188.4 6206.5 5969.5 5999.3 6024.2 6026.8 6032.1 5689.3 5820.4 5824.7 5825.8 5858.0 4151.1 4187.4 4200.9 4204.4 4210.5 6177.9 6178.0 6190.7 6191.4 6202.7 5939.6 5948.7 5961.4 5963.0 5963.5 5739.3 5919.6 5944.8 5962.1 5966.0 5824.2 5831.2 5833.1 5852.4 5861.7 6002.9 6011.8 6013.2 6019.7 6021.9 5714.1 5807.7 5838.4 5838.9 5853.1 01:21:30 INFO - PROCESS | 27902 | 01:21:30 INFO - PROCESS | 27902 | [#5] yui.html Cycles:180 Average:11141.58 Median:469.64 stddev:11794.67 (2511.4%) stddev-sans-first:11801.28 01:21:30 INFO - PROCESS | 27902 | Values: 619.9 653.7 696.3 711.6 773.8 10915.8 10991.2 11005.5 11023.7 11052.9 12097.5 12589.8 12784.0 12803.1 12872.2 621.6 785.9 799.4 800.2 800.4 618.1 791.5 808.1 810.1 811.9 837.3 837.5 846.4 852.1 852.2 833.1 834.0 835.8 839.0 844.8 618.3 618.8 619.9 621.6 622.8 11791.1 11906.8 11947.5 11961.2 12002.9 11053.4 11350.6 11418.4 11463.4 12004.8 8811.4 8900.0 9051.6 9101.2 9105.3 3135.8 3147.9 3201.9 3206.0 3220.1 37869.1 38338.2 38384.2 38539.4 38561.6 8800.7 8967.3 8979.9 9013.8 9172.2 15792.0 15880.4 15907.3 15915.7 15922.4 6166.2 6195.8 6199.8 6210.4 6238.6 3511.9 3563.9 3573.2 3602.6 3678.2 2657.1 2687.3 2688.3 2691.8 2703.4 469.5 475.8 476.2 486.5 490.0 443.9 492.3 500.7 516.4 564.2 6924.2 6967.8 7112.9 7116.8 7180.4 440.4 469.8 507.3 549.5 574.5 3309.9 3375.7 3559.6 3692.5 3695.8 39008.2 39184.8 39274.8 39294.8 39378.2 36216.8 36356.8 36553.1 36680.3 36695.3 32633.8 32906.5 33102.5 33424.5 34205.3 7332.2 7348.0 7521.0 7584.2 7602.8 29881.1 29893.6 30187.5 30295.0 30596.1 34235.7 34519.3 34876.3 37525.2 37607.2 9577.9 9851.7 9894.8 10410.8 10438.9 10466.6 10698.4 11039.1 11225.6 11402.1 9191.7 9580.8 9957.3 10252.9 10281.1 9917.7 9995.7 10010.5 10226.3 10342.0 9093.6 9293.7 9329.0 9542.7 10019.1 8052.6 8242.8 8315.9 8332.8 8640.7 7929.6 8366.2 8395.0 8827.2 9082.5 01:21:30 INFO - PROCESS | 27902 | -------- Summary: end -------- 01:21:30 INFO - PROCESS | 27902 | 01:21:31 INFO - TEST-INFO | 27902: exit 0 01:21:31 INFO - TEST-OK | dromaeo_css | took 1114319ms 01:21:31 INFO - TEST-START | kraken 01:21:31 INFO - operating with platform_type : linux_ 01:21:31 INFO - Initialising browser for kraken test... 01:21:31 INFO - TEST-INFO | started process 28139 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAoHa3g/profile http://localhost:58467/getInfo.html) 01:21:35 INFO - PROCESS | 28139 | 01:21:35 INFO - PROCESS | 28139 | (process:28212): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:21:35 INFO - PROCESS | 28139 | __metrics Screen width/height:1600/1200 01:21:35 INFO - PROCESS | 28139 | colorDepth:24 01:21:35 INFO - PROCESS | 28139 | Browser inner width/height: 1024/697 01:21:35 INFO - PROCESS | 28139 | __metrics 01:21:36 INFO - PROCESS | 28139 | 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:21:36 INFO - TEST-INFO | 28139: exit 0 01:21:36 INFO - Browser initialized. 01:21:36 INFO - Running cycle 1/1 for kraken test... 01:21:36 INFO - TEST-INFO | started process 28261 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAoHa3g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:21:38 INFO - PROCESS | 28261 | 01:21:38 INFO - PROCESS | 28261 | (process:28317): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:21:48 INFO - PROCESS | 28261 | RSS: Main: 150544384 01:21:48 INFO - PROCESS | 28261 | 01:21:51 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58467/tests/kraken/driver.html?testName=audio-beat-detection) 01:21:52 INFO - PROCESS | 28261 | RSS: Main: 149893120 01:21:52 INFO - PROCESS | 28261 | 01:21:54 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58467/tests/kraken/driver.html?testName=audio-dft) 01:21:55 INFO - PROCESS | 28261 | RSS: Main: 150769664 01:21:55 INFO - PROCESS | 28261 | 01:21:58 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58467/tests/kraken/driver.html?testName=audio-fft) 01:21:59 INFO - PROCESS | 28261 | RSS: Main: 147341312 01:21:59 INFO - PROCESS | 28261 | 01:22:01 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58467/tests/kraken/driver.html?testName=audio-oscillator) 01:22:01 INFO - PROCESS | 28261 | RSS: Main: 146067456 01:22:01 INFO - PROCESS | 28261 | 01:22:04 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58467/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:22:04 INFO - PROCESS | 28261 | RSS: Main: 146952192 01:22:04 INFO - PROCESS | 28261 | 01:22:07 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58467/tests/kraken/driver.html?testName=imaging-darkroom) 01:22:08 INFO - PROCESS | 28261 | RSS: Main: 146927616 01:22:08 INFO - PROCESS | 28261 | 01:22:11 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58467/tests/kraken/driver.html?testName=imaging-desaturate) 01:22:12 INFO - PROCESS | 28261 | RSS: Main: 148078592 01:22:12 INFO - PROCESS | 28261 | 01:22:15 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58467/tests/kraken/driver.html?testName=json-parse-financial) 01:22:15 INFO - PROCESS | 28261 | RSS: Main: 148303872 01:22:15 INFO - PROCESS | 28261 | 01:22:17 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58467/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:22:18 INFO - PROCESS | 28261 | RSS: Main: 148586496 01:22:18 INFO - PROCESS | 28261 | 01:22:20 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58467/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:22:20 INFO - PROCESS | 28261 | RSS: Main: 148692992 01:22:20 INFO - PROCESS | 28261 | 01:22:22 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58467/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:22:23 INFO - PROCESS | 28261 | RSS: Main: 148688896 01:22:23 INFO - PROCESS | 28261 | 01:22:26 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58467/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:22:26 INFO - PROCESS | 28261 | RSS: Main: 148709376 01:22:26 INFO - PROCESS | 28261 | 01:22:29 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58467/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:22:29 INFO - PROCESS | 28261 | RSS: Main: 148885504 01:22:29 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | Cycle 1(1): loaded http://localhost:58467/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58467/tests/kraken/driver.html?testName=ai-astar) 01:22:31 INFO - PROCESS | 28261 | RSS: Main: 149934080 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | __start_tp_report 01:22:31 INFO - PROCESS | 28261 | _x_x_mozilla_page_load 01:22:31 INFO - PROCESS | 28261 | _x_x_mozilla_page_load_details 01:22:31 INFO - PROCESS | 28261 | |i|pagename|runs| 01:22:31 INFO - PROCESS | 28261 | |0;ai-astar;113;111;114;114;114;124;114;115;114;114 01:22:31 INFO - PROCESS | 28261 | |1;audio-beat-detection;157;131;156;175;139;165;168;140;165;133 01:22:31 INFO - PROCESS | 28261 | |2;audio-dft;162;163;163;163;167;169;164;164;166;164 01:22:31 INFO - PROCESS | 28261 | |3;audio-fft;74;75;72;74;144;72;72;72;74;90 01:22:31 INFO - PROCESS | 28261 | |4;audio-oscillator;98;106;137;97;103;97;139;97;97;130 01:22:31 INFO - PROCESS | 28261 | |5;imaging-gaussian-blur;110;110;110;109;109;109;111;110;111;111 01:22:31 INFO - PROCESS | 28261 | |6;imaging-darkroom;147;149;147;148;149;148;148;148;147;148 01:22:31 INFO - PROCESS | 28261 | |7;imaging-desaturate;96;96;96;96;96;96;95;96;95;95 01:22:31 INFO - PROCESS | 28261 | |8;json-parse-financial;71;70;71;69;70;70;70;71;72;69 01:22:31 INFO - PROCESS | 28261 | |9;json-stringify-tinderbox;68;67;67;69;67;68;68;68;68;67 01:22:31 INFO - PROCESS | 28261 | |10;stanford-crypto-aes;83;84;84;84;84;92;85;84;86;91 01:22:31 INFO - PROCESS | 28261 | |11;stanford-crypto-ccm;129;121;125;132;125;124;135;137;121;128 01:22:31 INFO - PROCESS | 28261 | |12;stanford-crypto-pbkdf2;139;152;150;153;151;137;150;148;156;141 01:22:31 INFO - PROCESS | 28261 | |13;stanford-crypto-sha256-iterative;71;71;75;72;71;74;71;71;71;72 01:22:31 INFO - PROCESS | 28261 | __end_tp_report 01:22:31 INFO - PROCESS | 28261 | __start_cc_report 01:22:31 INFO - PROCESS | 28261 | _x_x_mozilla_cycle_collect,824 01:22:31 INFO - PROCESS | 28261 | __end_cc_report 01:22:31 INFO - PROCESS | 28261 | __startTimestamp1452590551868__endTimestamp 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | ------- Summary: start ------- 01:22:31 INFO - PROCESS | 28261 | Number of tests: 14 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#0] ai-astar Cycles:10 Average:114.70 Median:114.00 stddev:3.43 (3.0%) stddev-sans-first:3.59 01:22:31 INFO - PROCESS | 28261 | Values: 113.0 111.0 114.0 114.0 114.0 124.0 114.0 115.0 114.0 114.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#1] audio-beat-detection Cycles:10 Average:152.90 Median:161.00 stddev:15.88 (9.9%) stddev-sans-first:16.78 01:22:31 INFO - PROCESS | 28261 | Values: 157.0 131.0 156.0 175.0 139.0 165.0 168.0 140.0 165.0 133.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#2] audio-dft Cycles:10 Average:164.50 Median:164.00 stddev:2.17 (1.3%) stddev-sans-first:2.11 01:22:31 INFO - PROCESS | 28261 | Values: 162.0 163.0 163.0 163.0 167.0 169.0 164.0 164.0 166.0 164.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#3] audio-fft Cycles:10 Average:81.90 Median:74.00 stddev:22.48 (30.4%) stddev-sans-first:23.66 01:22:31 INFO - PROCESS | 28261 | Values: 74.0 75.0 72.0 74.0 144.0 72.0 72.0 72.0 74.0 90.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:97.00 stddev:17.81 (18.4%) stddev-sans-first:18.34 01:22:31 INFO - PROCESS | 28261 | Values: 98.0 106.0 137.0 97.0 103.0 97.0 139.0 97.0 97.0 130.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#5] imaging-gaussian-blur Cycles:10 Average:110.00 Median:110.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 01:22:31 INFO - PROCESS | 28261 | Values: 110.0 110.0 110.0 109.0 109.0 109.0 111.0 110.0 111.0 111.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 01:22:31 INFO - PROCESS | 28261 | Values: 147.0 149.0 147.0 148.0 149.0 148.0 148.0 148.0 147.0 148.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 01:22:31 INFO - PROCESS | 28261 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#8] json-parse-financial Cycles:10 Average:70.30 Median:70.50 stddev:0.95 (1.3%) stddev-sans-first:0.97 01:22:31 INFO - PROCESS | 28261 | Values: 71.0 70.0 71.0 69.0 70.0 70.0 70.0 71.0 72.0 69.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:22:31 INFO - PROCESS | 28261 | Values: 68.0 67.0 67.0 69.0 67.0 68.0 68.0 68.0 68.0 67.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:84.50 stddev:3.16 (3.7%) stddev-sans-first:3.20 01:22:31 INFO - PROCESS | 28261 | Values: 83.0 84.0 84.0 84.0 84.0 92.0 85.0 84.0 86.0 91.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#11] stanford-crypto-ccm Cycles:10 Average:127.70 Median:128.50 stddev:5.56 (4.3%) stddev-sans-first:5.88 01:22:31 INFO - PROCESS | 28261 | Values: 129.0 121.0 125.0 132.0 125.0 124.0 135.0 137.0 121.0 128.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.70 Median:150.50 stddev:6.43 (4.3%) stddev-sans-first:6.00 01:22:31 INFO - PROCESS | 28261 | Values: 139.0 152.0 150.0 153.0 151.0 137.0 150.0 148.0 156.0 141.0 01:22:31 INFO - PROCESS | 28261 | 01:22:31 INFO - PROCESS | 28261 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:71.50 stddev:1.45 (2.0%) stddev-sans-first:1.50 01:22:31 INFO - PROCESS | 28261 | Values: 71.0 71.0 75.0 72.0 71.0 74.0 71.0 71.0 71.0 72.0 01:22:31 INFO - PROCESS | 28261 | -------- Summary: end -------- 01:22:31 INFO - PROCESS | 28261 | 01:22:32 INFO - TEST-INFO | 28261: exit 0 01:22:32 INFO - TEST-OK | kraken | took 61365ms 01:22:32 INFO - TEST-START | v8_7 01:22:32 INFO - operating with platform_type : linux_ 01:22:32 INFO - Initialising browser for v8_7 test... 01:22:32 INFO - TEST-INFO | started process 28546 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7HwrmJ/profile http://localhost:58467/getInfo.html) 01:22:36 INFO - PROCESS | 28546 | 01:22:36 INFO - PROCESS | 28546 | (process:28618): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:22:37 INFO - PROCESS | 28546 | __metrics Screen width/height:1600/1200 01:22:37 INFO - PROCESS | 28546 | colorDepth:24 01:22:37 INFO - PROCESS | 28546 | Browser inner width/height: 1024/697 01:22:37 INFO - PROCESS | 28546 | __metrics 01:22:37 INFO - PROCESS | 28546 | 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:22:38 INFO - TEST-INFO | 28546: exit 0 01:22:38 INFO - Browser initialized. 01:22:38 INFO - Running cycle 1/1 for v8_7 test... 01:22:38 INFO - TEST-INFO | started process 28667 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7HwrmJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:22:39 INFO - PROCESS | 28667 | 01:22:39 INFO - PROCESS | 28667 | (process:28726): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 01:22:50 INFO - PROCESS | 28667 | RSS: Main: 150614016 01:22:50 INFO - PROCESS | 28667 | 01:23:12 INFO - PROCESS | 28667 | Cycle 1(1): loaded http://localhost:58467/tests/v8_7/run.html (next: http://localhost:58467/tests/v8_7/run.html) 01:23:13 INFO - PROCESS | 28667 | RSS: Main: 145915904 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | __start_tp_report 01:23:13 INFO - PROCESS | 28667 | _x_x_mozilla_page_load 01:23:13 INFO - PROCESS | 28667 | _x_x_mozilla_page_load_details 01:23:13 INFO - PROCESS | 28667 | |i|pagename|runs| 01:23:13 INFO - PROCESS | 28667 | |0;Richards;167.16817118020728 01:23:13 INFO - PROCESS | 28667 | |1;DeltaBlue;187.02075930428276 01:23:13 INFO - PROCESS | 28667 | |2;Encrypt;279.09572983533354 01:23:13 INFO - PROCESS | 28667 | |3;Decrypt;5273.684210526316 01:23:13 INFO - PROCESS | 28667 | |4;RayTrace;1068.3760683760684 01:23:13 INFO - PROCESS | 28667 | |5;Earley;734.7538574577517 01:23:13 INFO - PROCESS | 28667 | |6;Boyer;12683.54430379747 01:23:13 INFO - PROCESS | 28667 | |7;RegExp;42916.666666666664 01:23:13 INFO - PROCESS | 28667 | |8;Splay;619.9628022318661 01:23:13 INFO - PROCESS | 28667 | |9;NavierStokes;4826.923076923077 01:23:13 INFO - PROCESS | 28667 | __end_tp_report 01:23:13 INFO - PROCESS | 28667 | __startTimestamp1452590593216__endTimestamp 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | ------- Summary: start ------- 01:23:13 INFO - PROCESS | 28667 | Number of tests: 10 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | [#0] Richards Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 01:23:13 INFO - PROCESS | 28667 | Values: 167.2 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | [#1] DeltaBlue Cycles:1 Average:187.02 Median:187.02 stddev:0.00 (0.0%) 01:23:13 INFO - PROCESS | 28667 | Values: 187.0 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | [#2] Encrypt Cycles:1 Average:279.10 Median:279.10 stddev:0.00 (0.0%) 01:23:13 INFO - PROCESS | 28667 | Values: 279.1 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | [#3] Decrypt Cycles:1 Average:5273.68 Median:5273.68 stddev:0.00 (0.0%) 01:23:13 INFO - PROCESS | 28667 | Values: 5273.7 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | [#4] RayTrace Cycles:1 Average:1068.38 Median:1068.38 stddev:0.00 (0.0%) 01:23:13 INFO - PROCESS | 28667 | Values: 1068.4 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | [#5] Earley Cycles:1 Average:734.75 Median:734.75 stddev:0.00 (0.0%) 01:23:13 INFO - PROCESS | 28667 | Values: 734.8 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | [#6] Boyer Cycles:1 Average:12683.54 Median:12683.54 stddev:0.00 (0.0%) 01:23:13 INFO - PROCESS | 28667 | Values: 12683.5 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | [#7] RegExp Cycles:1 Average:42916.67 Median:42916.67 stddev:0.00 (0.0%) 01:23:13 INFO - PROCESS | 28667 | Values: 42916.7 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | [#8] Splay Cycles:1 Average:619.96 Median:619.96 stddev:0.00 (0.0%) 01:23:13 INFO - PROCESS | 28667 | Values: 620.0 01:23:13 INFO - PROCESS | 28667 | 01:23:13 INFO - PROCESS | 28667 | [#9] NavierStokes Cycles:1 Average:4826.92 Median:4826.92 stddev:0.00 (0.0%) 01:23:13 INFO - PROCESS | 28667 | Values: 4826.9 01:23:13 INFO - PROCESS | 28667 | -------- Summary: end -------- 01:23:13 INFO - PROCESS | 28667 | 01:23:14 INFO - TEST-INFO | 28667: exit 0 01:23:14 INFO - TEST-OK | v8_7 | took 41308ms 01:23:14 INFO - SUITE-END | took 1216s 01:23:14 INFO - Completed test suite (00:20:17) 01:23:14 INFO - Working with test: dromaeo_css 01:23:14 INFO - Generating results file: dromaeo_css 01:23:14 INFO - Working with test: kraken 01:23:14 INFO - Generating results file: kraken 01:23:14 INFO - javascript benchmark 01:23:14 INFO - Working with test: v8_7 01:23:14 INFO - Generating results file: v8_7 01:23:14 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:23:14 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 01:23:14 INFO - process_Request line: dromaeo_css 6216.80 graph.html#tests=[[72,132,43]] 01:23:14 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:23:14 INFO - process_Request line: kraken 1548.70 graph.html#tests=[[232,132,43]] 01:23:14 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:23:14 INFO - process_Request line: v8_7 20101.64 graph.html#tests=[[230,132,43]] 01:23:14 INFO - RETURN: dromaeo_css: 6216.80 01:23:14 INFO - RETURN: kraken: 1548.70 01:23:14 INFO - RETURN: v8_7: 20101.64 01:23:14 INFO - javascript benchmark 01:23:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2630.1057640402264, 2676.7858571314296, 2691.9192424227267, 2705.080272707279, 2725.5775354820003, 4496.123255965088, 4626.560476754703, 4678.298255261709, 4697.0, 4702.8589142325745, 4521.276595744682, 4531.63746900248, 4636.51316611756, 4761.69049011814, 4768.141734487791, 4339.305711086219, 4424.491183513889, 4466.798994045275, 4478.193925093482, 4525.841595544157, 4368.737875727466, 4406.889827754299, 4407.735535867842, 4419.867403977886, 4508.504064552896, 4208.242516347056, 4284.592963668447, 4301.913961720779, 4319.524852266248, 4328.458942632171, 4367.366731823868, 4371.759553224571, 4374.58441448062, 4381.342798580206, 4395.780210989437, 4327.2643650579475, 4355.651547876162, 4358.411614432042, 4368.803403846835, 4405.207062728708, 4431.357453169305, 4526.456825180966, 4557.794899229542, 4628.745419001953, 4658.767061646938, 5027.849164525033, 5031.84904452867, 5035.370578677665, 5054.368203974504, 5075.111855425323, 5053.343065401475, 5054.039732450822, 5058.190689489701, 5064.290999260106, 5093.18509038552, 4503.909921801578, 4620.584147426681, 4621.098885717252, 4698.976505117521, 4738.526147385234, 5096.133657278272, 5131.7690703918415, 5134.87162820925, 5146.897062058738, 5165.457626949192, 4701.811927522929, 4927.039227350704, 4940.258961155855, 4947.925781113287, 4993.076280888047, 4965.776540055634, 4973.577245934136, 5025.045241404122, 5083.974580127076, 5094.0, 4974.527419895104, 4990.750462476862, 4992.301077849104, 4997.625178111583, 5051.646384753032, 4752.572268495852, 4961.107000739901, 4971.900561988812, 4973.651844370932, 5023.0, 4099.528554216244, 4179.1014931789205, 4213.852515161954, 4242.342436922282, 4282.48610166782, 3717.20080182762, 3720.069982504374, 3722.664960153599, 3730.0, 3762.9247415051545, 4221.957780422218, 4319.956800432018, 4356.629686476622, 4360.563943605677, 4385.101054283864, 5000.2749601307605, 5064.645474816801, 5080.822171223989, 5087.949120508748, 5111.182210846247, 4346.478422589246, 4357.455318085239, 4362.8036738346855, 4382.53983331752, 4421.40311058003, 4343.630791382705, 4473.575010374009, 4488.4613846338, 4558.452985641744, 4570.063137056895, 4788.401449818773, 4788.61691064721, 4789.688670236424, 4801.063792560417, 4802.567768900815, 4994.200927851526, 5016.398032236155, 5033.622478314214, 5037.496250375079, 5092.159793634009, 4632.2819962905805, 4725.881852953704, 4753.786079626356, 4762.452317983476, 4850.53919877611, 4944.085344211332, 4947.975260123821, 4978.925316120189, 4980.252962055721, 4991.326170966873, 5040.647154699136, 5046.798128074836, 5050.545450909436, 5052.59579233653, 5081.110805609078, 4730.550597693214, 4866.197077482176, 4877.268409738567, 4929.482404347636, 4993.201087825931, 4877.048975449753, 4910.950890491193, 4926.236433352836, 4933.358663373882, 4967.3045773591, 4803.0, 4817.975910120427, 4818.807247710192, 4819.734914579732, 4822.541858523435, 4731.645126615449, 4815.903681926412, 4855.393075865517, 4915.901681966412, 4945.332380128637, 4824.662273640812, 4826.903461930812, 4828.444728856227, 4846.80612775485, 4886.804527818847], "unit": "score", "name": "dojo.html", "value": 4615.697088014995}, {"lowerIsBetter": false, "replicates": [469.50701763148686, 470.1748431502713, 474.8884012257119, 494.7105943023331, 502.4272329544322, 24518.387040324, 24974.625380619305, 31769.841150794244, 32310.707571697163, 32418.0, 35341.64658353416, 35768.0, 35849.2830143397, 35978.280434391294, 35990.820045899796, 7447.85104297915, 7604.049493813273, 7618.162002179756, 7620.390368770485, 7622.809429764273, 7395.260473952616, 7475.514091584057, 7541.095068591777, 7559.395248380117, 7565.243475652445, 7535.171131175566, 7605.049368828896, 7609.6575654095695, 7627.199144089874, 7631.771046868603, 7493.850122997564, 7494.587797671126, 7566.508176968479, 7574.31831135195, 7575.318221360077, 7489.101307843093, 7620.390368770485, 7622.123455802598, 7633.923660763432, 7651.387888968925, 36084.27831443356, 36496.452553211726, 36553.81723091394, 36615.63384366149, 36776.264474710355, 2721.1972468121953, 2806.2843974786297, 2973.405318936221, 3495.7727747696317, 3501.2647344057777, 26130.86934565334, 27574.0, 27603.585946210824, 27643.170704878685, 28068.719312806814, 3405.1827561385335, 3411.727061835047, 3415.9146021349416, 3440.2431465077643, 3557.3063252665484, 211705.0, 213794.0, 213947.0, 214253.0, 217048.99999999843, 35032.12419689528, 57386.0, 58772.4122758767, 58796.0, 58827.11759323614, 51587.0, 51949.22076168861, 51961.220581691305, 52505.2124218137, 52615.473845261826, 13336.866631333756, 13405.128666636638, 13446.596602101952, 13481.393337299649, 13529.797053044213, 9833.065858743408, 10016.549255283384, 10188.134008609202, 10221.642242521624, 10337.0, 17469.563260918323, 17725.0, 17784.911075444797, 17806.287748490173, 17848.196831142628, 7138.928610713826, 7282.526635768658, 7328.267173282736, 7348.485606007635, 7395.778126656209, 754.5962909843207, 833.4874052457695, 892.9821403571892, 942.5711301357866, 980.9950950245203, 21507.56984860294, 22011.0, 22105.66841497379, 22106.005229764698, 22198.223062192745, 933.6172169410509, 942.5193151492651, 973.4840534516718, 1026.312370711625, 1051.8842927277992, 12108.455119519644, 12169.330686812133, 12172.939135304267, 12225.08311876595, 12271.447784849703, 261016.0, 264796.0, 266405.66797166277, 267127.0, 268017.0, 44697.776511117234, 44909.0, 45037.77481112573, 45039.774801125786, 45069.774651126536, 1166.3876464855848, 1186.6202815099257, 1199.760047990423, 1200.5137919142762, 1207.7886369885234, 22738.31785046451, 22805.771942280364, 22922.885385572965, 22983.310500685006, 23195.0, 33426.832865836484, 33789.66210337865, 33933.32133357369, 33951.49072763861, 34071.48892766561, 247970.0, 250720.0, 251317.0, 251495.0, 251664.0, 27490.725092748817, 27854.303642408293, 28377.574336384558, 28562.42875142444, 28640.570391444562, 31574.842125789222, 32085.0, 32271.838640806647, 32620.0, 32711.18222044468, 27915.860420697765, 27921.44157116887, 28319.0, 28481.572776408786, 28810.567841481974, 27326.45347093087, 27494.312642184104, 27954.70311977463, 28166.2958426041, 28168.43663126767, 30645.08064758061, 30660.846695766377, 30894.38211235808, 30949.381012380076, 31088.378232435676, 34755.30489390249, 34822.0, 35273.823630881685, 35864.64135358613, 37103.62896371002, 25537.0, 26381.60427593626, 26676.866615666797, 27143.321416964733, 28099.71900280971], "unit": "score", "name": "ext.html", "value": 15933.11465418644}, {"lowerIsBetter": false, "replicates": [330.1926789000892, 332.3552308521468, 333.97662163648545, 334.90120414477724, 341.5781509835351, 10017.398956062641, 10150.13723833475, 10450.3207291526, 14338.426462941483, 14679.0, 16055.431131019039, 16386.0, 16606.83393166068, 16743.16284185792, 17026.404075857346, 5234.450382709818, 5564.916526252109, 5572.331320241577, 5586.35756887959, 5593.496585307322, 4525.275955847065, 5465.890682186354, 5543.584231182657, 5595.244641973322, 5606.411326810667, 5498.395176530578, 5523.309586301712, 5524.8342549723575, 5554.91667624986, 5558.471945165203, 5342.626016178869, 5497.092979658351, 5578.888422231573, 5580.079286917654, 5613.522850557708, 5173.715445650488, 5337.332833395825, 5348.197770334442, 5383.596230282745, 5388.649737767033, 19566.51083722904, 20266.189352425885, 20351.49121271965, 20444.182232710675, 20464.181432742673, 1804.9639007219914, 1837.7702787151607, 1876.315144972089, 1952.746143001415, 2071.8964051797348, 12907.548235811702, 13147.0, 13182.0, 13368.33158342079, 13491.460341586324, 1882.8117188281199, 1888.490107670935, 1898.2795603045586, 1936.8353689936373, 1987.125664707524, 53235.733821331036, 54630.0, 54638.0, 54661.72669136669, 56198.71900640512, 14225.78661320081, 14529.709405812036, 14595.270236488133, 14624.926875365554, 14671.413143474141, 17828.732569011474, 20398.28605998783, 20499.4875128123, 21731.782682173292, 21772.455688607595, 6636.900446493307, 6871.0, 6950.478714096463, 6962.303769623099, 7945.920540794518, 6549.181352330958, 6571.211454625475, 6626.138601981712, 6760.526763126632, 6804.795856124225, 4198.307279298881, 4249.532551419341, 4254.064105896698, 4264.232438161099, 4267.487901451846, 1724.741288806689, 1771.973420398695, 1777.0, 1826.2968757028639, 1826.7351234070986, 774.5778550689887, 835.2357592802517, 858.6479543387181, 865.1046167217027, 935.3265648732902, 14699.485518006819, 14931.70136597262, 14935.327910243848, 15043.0, 15444.0, 871.808202195516, 887.6582515731361, 916.862470629411, 957.2916042128775, 972.4651441707033, 6186.443220110122, 8587.871181932276, 8655.610497527627, 8783.780405489786, 8807.955960220157, 401587.0, 403479.0, 405518.0, 405581.0, 424192.0, 54242.728786355816, 57237.71381143151, 57941.0, 57991.4200857986, 58725.706371467866, 1059.4173204737363, 1089.716673664837, 1095.1950316517352, 1099.3568762273999, 1099.5272033025876, 13586.79619805684, 14064.437422502986, 14394.928025359806, 14492.637684057561, 14700.264986750406, 25942.48115037651, 29676.55485167681, 30253.848730756206, 30260.84869575726, 30789.23026924255, 35742.4638630426, 36301.636983629825, 37243.25513489769, 37262.0, 37489.437658435694, 6218.502519798315, 6352.333005034405, 6356.237251529846, 6390.233172019387, 6554.016897465418, 7574.772756817304, 9354.53227338644, 9466.0, 9555.952220238854, 9706.077922597342, 8101.554414507259, 8217.2604465596, 8238.794030149294, 8305.792355191168, 8361.533347662333, 7803.609819509115, 8282.50304981703, 8307.460015098999, 8571.22858942698, 8693.695720649746, 7765.456418050908, 8210.507369557845, 8338.666453341799, 8353.791155221168, 8392.748217553482, 6433.324500927335, 6469.223693156851, 6492.350764923659, 6519.348065193442, 6589.439897608757, 6975.337342952412, 8145.551994640352, 8158.224968627971, 8259.876101858357, 8511.74464766058], "unit": "score", "name": "jquery.html", "value": 7777.4726330307585}, {"lowerIsBetter": false, "replicates": [1404.789281607759, 1428.9785653215201, 1529.6099494628868, 1730.2732852202073, 1751.7547543343926, 6310.747570097191, 6436.613803171813, 7188.568685878851, 7348.742794002204, 7355.0, 7098.85802283954, 7223.277672232774, 7284.854302913952, 7286.56280623163, 7292.4530660200435, 2123.62836503612, 2156.040561949933, 2157.072458842697, 2158.028887000856, 2161.027537608075, 2133.455968727972, 2143.7534683511362, 2197.9450513737124, 2199.967000494994, 2204.5039866030097, 2103.5056761661, 2131.7868213178635, 2135.2099723102397, 2143.3248526714115, 2154.601398741238, 2143.5498545305504, 2160.1467420368945, 2166.5450255446376, 2172.532905425325, 2174.804267615906, 2148.7206663133693, 2164.5238047629496, 2170.913163473459, 2175.793299636532, 2180.8364372672113, 7382.151052628963, 7447.664855081534, 7448.702051917917, 7450.105987281507, 7461.440391970624, 4315.244832154361, 4405.052913623586, 4417.2269852775635, 4441.311596702516, 4444.333349997494, 2773.847438390888, 2775.2090654163467, 2846.0607999360163, 2848.700886406939, 2860.8140470869535, 838.224642205957, 875.5447167472942, 882.1795729971125, 890.9198172164472, 908.681961313535, 10303.948480257552, 10346.482675866251, 10389.324693894872, 10395.116415104725, 10475.685729428129, 4024.0744628735556, 4038.9596104038583, 4109.97945010279, 4148.875533733993, 4151.543330233671, 8907.242884354773, 8919.821603568022, 8949.10508949113, 8950.820983580292, 8956.68651597204, 4484.282514797616, 4513.300438432048, 4524.959259370363, 4526.072155208174, 4530.433695788027, 3340.5657264555452, 3420.1620602952435, 3828.2917660232947, 3992.321305378093, 4025.376066709665, 3312.0560640217423, 3328.384248913959, 3332.6334103248623, 3351.178961154484, 3358.3954888120375, 1075.3386667199616, 1093.1418836213534, 1099.3019432660158, 1099.598646494024, 1105.4086063955906, 888.6223355074068, 909.1681111782644, 1176.394157009141, 1184.8400465937161, 1197.455157903152, 6782.1861376635115, 6852.143482064742, 6871.587704737632, 6875.278095799869, 6882.827929301808, 1057.4078516030893, 1061.877884043345, 1065.2756125834508, 1067.508945884886, 1092.1754075672816, 5196.870078248074, 5234.214867769789, 5262.789488420421, 5263.210518422267, 5270.868228294324, 8987.955060224656, 9111.772205694911, 9312.953435232781, 9417.246620270362, 9482.288828337902, 9212.677556285631, 9219.44683319003, 9234.353595248269, 9246.537673116318, 9273.072692730673, 6754.966225168842, 6896.2069362023, 6907.412869906114, 7133.964330178316, 7203.639818009078, 6762.8647427052165, 6849.863002740017, 6886.69009894566, 6902.689378978059, 6909.378155965987, 7664.425168112302, 8009.959950200212, 8038.155993620586, 8065.354771618374, 8073.19268073188, 8048.919510805052, 8158.632861521364, 8194.590270486571, 8302.294304983903, 8325.583720814057, 5630.211770352236, 5781.306243250837, 6350.460210882126, 6433.839154021187, 6570.967145164243, 6629.635370054693, 6776.491763117688, 6800.353966373186, 6819.352161544645, 6823.658817059028, 6223.128761973418, 6232.127502149793, 6307.716152773044, 6384.265809431789, 6426.228852537725, 6196.256449226122, 6268.498520118288, 6304.7162877671535, 6381.8723625528155, 6406.903896441464, 6070.150178974859, 6083.756649733961, 6140.201773769381, 6277.089821975879, 6277.246730392199, 6149.0, 6150.723217455135, 6169.96915015422, 6203.410675985774, 6215.378462153749, 5873.911891321719, 5897.351291358033, 5907.881842363215, 5941.7623295067715, 6000.729967151576], "unit": "score", "name": "mootools.html", "value": 4206.6547398571465}, {"lowerIsBetter": false, "replicates": [317.88079470198676, 320.4008504097338, 325.83870983862994, 328.7008821972006, 332.10828924338153, 5557.193911978608, 5577.135543990688, 5579.135234038726, 5640.407757185498, 5720.399358067395, 5577.972110139453, 5589.105743081108, 5597.468240517154, 5611.2144299798065, 5612.775488980446, 4342.609165175134, 4350.956490435086, 4356.564343565634, 4360.716553424033, 4361.084172323815, 4363.934540981872, 4366.4978527469275, 4371.584699453562, 4375.278079116942, 4385.122975404915, 4221.472315960505, 4300.3764454154125, 4323.351497275403, 4324.567543245682, 4325.935110973338, 4309.396684464177, 4319.978400108011, 4320.049589090395, 4325.718828276168, 4329.913401731964, 3726.9440958385376, 3734.439834024891, 3736.0286325555553, 3745.793981331026, 3753.0992561784974, 5393.649412788156, 5394.6493477924205, 5408.13469844823, 5408.188771684239, 5412.485813847678, 4767.8569642910425, 4966.975165124151, 4970.403551573834, 4978.203487442028, 4993.176125939216, 5692.715364231772, 5766.0774276116035, 5803.100519419497, 5860.06239001762, 5861.296644402656, 3992.4210989406374, 4019.718619696622, 4019.8995025124314, 4020.155767288873, 4025.0339918419368, 6110.816675499742, 6197.473214776749, 6197.504199664016, 6199.411055949678, 6199.783007594712, 4061.7156799023783, 4170.35359519275, 4171.374293855946, 4173.0, 4175.770332631673, 4230.788460576959, 4231.661467082626, 4243.618074373321, 4245.469316335458, 4298.312270036841, 4865.416150062015, 4923.556879880828, 4936.531029552187, 4944.25836124577, 4947.703137811743, 5915.053591425351, 5932.525397968152, 5933.0, 5943.70281485924, 5945.940540594539, 1453.941842326295, 1491.2618253964356, 1530.8928375013866, 1536.377767004365, 1537.5848520899517, 1007.773251018515, 1008.8297574813181, 1011.7723512209694, 1017.4810846468206, 1021.7905329407454, 5056.519630635084, 5064.696118232918, 5122.743862806845, 5125.513076257749, 5130.846074617767, 6082.635041897501, 6086.117512960596, 6091.939080609137, 6096.542759293071, 6105.450509454082, 5110.233464980282, 5110.6678065926335, 5115.462876397999, 5115.846524604268, 5129.153689641242, 3234.2884565395575, 3241.36793325304, 3282.179455136216, 3310.8841190558214, 3314.6022477302395, 5673.716314184274, 5745.1382292656435, 5748.971255143698, 5749.281339832521, 5750.281214848144, 6196.690165491707, 6225.595336303126, 6238.1890354254565, 6241.563090583615, 6255.061740738925, 5646.491815736521, 5724.742386592613, 5729.4843464088435, 5735.340435849847, 5799.2750906136735, 6151.907721384272, 6165.260168779775, 6183.474404675653, 6188.44304012641, 6206.472449841814, 5969.492593129459, 5999.250093738283, 6024.246969128859, 6026.849328766641, 6032.125341825323, 5689.34572524165, 5820.447057529528, 5824.650520968756, 5825.79609713658, 5858.004139296415, 4151.066010147692, 4187.37189421577, 4200.9369859452745, 4204.411382406527, 4210.494740631144, 6177.876442471215, 6178.0, 6190.690465476618, 6191.4118158774845, 6202.658853762906, 5939.643621382731, 5948.73230704628, 5961.4038596140035, 5963.0, 5963.493103086286, 5739.311282646109, 5919.644821310735, 5944.821655350346, 5962.07587823888, 5966.0, 5824.21373114641, 5831.183634291117, 5833.0667093266575, 5852.4440178183, 5861.677607731615, 6002.939970600238, 6011.789587364421, 6013.218281623361, 6019.668918209541, 6021.909671354845, 5714.114312281603, 5807.651540907559, 5838.416158384128, 5838.912416313844, 5853.09277062056], "unit": "score", "name": "prototype.html", "value": 4422.474871359101}, {"lowerIsBetter": false, "replicates": [619.8667286533395, 653.7352372289224, 696.3176087434314, 711.6299524247391, 773.7833406646139, 10915.781684366319, 10991.230613857033, 11005.504752286146, 11023.669289921305, 11052.944735276322, 12097.516099356037, 12589.811152832715, 12784.0, 12803.103782735212, 12872.163309384883, 621.6239175298947, 785.8978332816725, 799.3724925933144, 800.1678254615193, 800.3557136505111, 618.072890664004, 791.4894892794144, 808.1151139502235, 810.0603300171801, 811.9350451963858, 837.271573730852, 837.4556538250156, 846.4371193156575, 852.1265702654766, 852.1819053708448, 833.0669649992018, 834.0366876257932, 835.7910522369408, 839.0141583639199, 844.7592436155666, 618.2519151826295, 618.7617767159676, 619.9256089269317, 621.552482212806, 622.7882519943241, 11791.11566632506, 11906.821397679041, 11947.462364193632, 11961.162718609701, 12002.939985300105, 11053.392063436508, 11350.602728904449, 11418.371989540572, 11463.36951467669, 12004.759904801942, 8811.383203175781, 8900.0, 9051.637934482613, 9101.226395756303, 9105.31710121737, 3135.843207839599, 3147.8583463743958, 3201.8719251230154, 3206.0, 3220.066180807563, 37869.05327366838, 38338.233235335414, 38384.23231535382, 38539.42190867139, 38561.61438385608, 8800.691975780817, 8967.327450441244, 8979.910200898039, 9013.77465563353, 9172.174504294646, 15792.0, 15880.364785408685, 15907.284172212278, 15915.681686366208, 15922.363105475883, 6166.167567378347, 6195.783147589903, 6199.814005579839, 6210.4100110489435, 6238.625682459067, 3511.9122021949142, 3563.928721425557, 3573.1960308930284, 3602.5676918769914, 3678.2459595782802, 2657.070025491101, 2687.3013016615428, 2688.274165975176, 2691.838489690625, 2703.391736859191, 469.4812232483125, 475.764496574198, 476.1548251852989, 486.46520228678577, 490.0175148826651, 443.9223135951196, 492.308306828906, 500.6745615349979, 516.4138702572607, 564.1819361925225, 6924.169099708067, 6967.756128535579, 7112.92887071133, 7116.750913717995, 7180.389666878374, 440.41204991336286, 469.8003348576841, 507.2695318741001, 549.4779959038929, 574.5403677058337, 3309.9007029788663, 3375.7130643895543, 3559.5728512578658, 3692.51997240357, 3695.796731179757, 39008.2198356037, 39184.804075980006, 39274.80362598169, 39294.803525982185, 39378.21243575113, 36216.81891590525, 36356.81821590875, 36553.08617284589, 36680.266394671955, 36695.26609467796, 32633.836830815693, 32906.50640240398, 33102.50346244808, 33424.49863252053, 34205.315893682484, 7332.193458719643, 7347.963260183665, 7520.962395187989, 7584.165741768291, 7602.835463258742, 29881.103566893027, 29893.551596726502, 30187.547186792654, 30295.0, 30596.08211753651, 34235.65764342325, 34519.30961380809, 34876.30247394987, 37525.249495009404, 37607.24785504329, 9577.856332155163, 9851.704448866545, 9894.752631184278, 10410.791784164427, 10438.895611043792, 10466.581336746445, 10698.358098514114, 11039.116870650489, 11225.550977960791, 11402.087832973508, 9191.678291259774, 9580.76048098803, 9957.253206009724, 10252.948735256574, 10281.12610428122, 9917.65288214909, 9995.650152244636, 10010.549525271235, 10226.28416010872, 10342.0, 9093.636254550009, 9293.72118836436, 9328.95335523318, 9542.666006689733, 10019.148372388137, 8052.5571093590415, 8242.793930151794, 8315.875261871197, 8332.750017499484, 8640.740777776677, 7929.603519823871, 8366.16338366183, 8394.958025209835, 8827.249683776694, 9082.54587270647], "unit": "score", "name": "yui.html", "value": 5424.788934898149}], "name": "dromaeo_css", "value": 6216.799311847407}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 111.0, 114.0, 114.0, 114.0, 124.0, 114.0, 115.0, 114.0, 114.0], "unit": "score", "name": "ai-astar", "value": 114.7}, {"lowerIsBetter": true, "replicates": [157.0, 131.0, 156.0, 175.0, 139.0, 165.0, 168.0, 140.0, 165.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 152.9}, {"lowerIsBetter": true, "replicates": [162.0, 163.0, 163.0, 163.0, 167.0, 169.0, 164.0, 164.0, 166.0, 164.0], "unit": "score", "name": "audio-dft", "value": 164.5}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 72.0, 74.0, 144.0, 72.0, 72.0, 72.0, 74.0, 90.0], "unit": "score", "name": "audio-fft", "value": 81.9}, {"lowerIsBetter": true, "replicates": [98.0, 106.0, 137.0, 97.0, 103.0, 97.0, 139.0, 97.0, 97.0, 130.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 109.0, 109.0, 111.0, 110.0, 111.0, 111.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.0}, {"lowerIsBetter": true, "replicates": [147.0, 149.0, 147.0, 148.0, 149.0, 148.0, 148.0, 148.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 71.0, 69.0, 70.0, 70.0, 70.0, 71.0, 72.0, 69.0], "unit": "score", "name": "json-parse-financial", "value": 70.3}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 69.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 84.0, 84.0, 92.0, 85.0, 84.0, 86.0, 91.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [129.0, 121.0, 125.0, 132.0, 125.0, 124.0, 135.0, 137.0, 121.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.7}, {"lowerIsBetter": true, "replicates": [139.0, 152.0, 150.0, 153.0, 151.0, 137.0, 150.0, 148.0, 156.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.7}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 75.0, 72.0, 71.0, 74.0, 71.0, 71.0, 71.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 71.9}], "name": "kraken", "value": 1548.7000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "Richards", "value": 211.17656399999993}, {"lowerIsBetter": false, "replicates": [187.02075930428276], "unit": "score", "name": "DeltaBlue", "value": 353.5329460000002}, {"lowerIsBetter": false, "replicates": [279.09572983533354], "unit": "score", "name": "Encrypt", "value": 953.7265229999995}, {"lowerIsBetter": false, "replicates": [5273.684210526316], "unit": "score", "name": "Decrypt", "value": 50.47344311377245}, {"lowerIsBetter": false, "replicates": [1068.3760683760684], "unit": "score", "name": "RayTrace", "value": 692.6297040000002}, {"lowerIsBetter": false, "replicates": [734.7538574577517], "unit": "score", "name": "Earley", "value": 907.0561430000002}, {"lowerIsBetter": false, "replicates": [12683.54430379747], "unit": "score", "name": "Boyer", "value": 52.545486027944136}, {"lowerIsBetter": false, "replicates": [42916.666666666664], "unit": "score", "name": "RegExp", "value": 21.22683495145631}, {"lowerIsBetter": false, "replicates": [619.9628022318661], "unit": "score", "name": "Splay", "value": 131.44498299999998}, {"lowerIsBetter": false, "replicates": [4826.923076923077], "unit": "score", "name": "NavierStokes", "value": 307.4422310756973}], "name": "v8_7", "value": 20101.640765482025}]} 01:23:14 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "20101.64"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1548.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6216.80"}}} 01:23:14 INFO - Return code: 0 01:23:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:23:14 INFO - # TBPL SUCCESS # 01:23:14 INFO - Running post-action listener: _resource_record_post_action 01:23:14 INFO - Running post-run listener: _resource_record_post_run 01:23:15 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 541650944; Read time: 0; Write time: 431020 01:23:15 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 230944768; Read time: 0; Write time: 258868 01:23:15 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 310706176; Read time: 0; Write time: 172152 01:23:15 INFO - Running post-run listener: _upload_blobber_files 01:23:15 INFO - Blob upload gear active. 01:23:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:23:15 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:23:15 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:23:15 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:23:15 INFO - (blobuploader) - INFO - Open directory for files ... 01:23:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:23:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:23:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:23:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:23:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:23:16 INFO - (blobuploader) - INFO - Done attempting. 01:23:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:23:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:23:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:23:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:23:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:23:17 INFO - (blobuploader) - INFO - Done attempting. 01:23:17 INFO - (blobuploader) - INFO - Iteration through files over. 01:23:17 INFO - Return code: 0 01:23:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:23:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:23:17 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bbb8e8def4bf6553da2e6c319d67b21cb33d54e9e7e8e833d2683e99d137597b9fa4f5d8e7fecb21f84933e8128d57c5e8ca9e1c6ae1deebb3787be7eaff32f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8945b2ababab974a25ea24cbe7c973b9921126fc98bbf1addda014ab66833f5631df75b682ddbcb52d171c23e6001030801fe1bb37599c53d9eb83494f3a7f3c"} 01:23:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:23:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:23:17 INFO - Contents: 01:23:17 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/bbb8e8def4bf6553da2e6c319d67b21cb33d54e9e7e8e833d2683e99d137597b9fa4f5d8e7fecb21f84933e8128d57c5e8ca9e1c6ae1deebb3787be7eaff32f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8945b2ababab974a25ea24cbe7c973b9921126fc98bbf1addda014ab66833f5631df75b682ddbcb52d171c23e6001030801fe1bb37599c53d9eb83494f3a7f3c"} 01:23:17 INFO - Copying logs to upload dir... 01:23:17 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.076872 ========= master_lag: 0.63 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2016-01-12 01:23:17.492434) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 01:23:17.500143) ========= 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=82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268 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/bbb8e8def4bf6553da2e6c319d67b21cb33d54e9e7e8e833d2683e99d137597b9fa4f5d8e7fecb21f84933e8128d57c5e8ca9e1c6ae1deebb3787be7eaff32f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8945b2ababab974a25ea24cbe7c973b9921126fc98bbf1addda014ab66833f5631df75b682ddbcb52d171c23e6001030801fe1bb37599c53d9eb83494f3a7f3c"} build_url:https://queue.taskcluster.net/v1/task/dYjvUOI-Q6iBvQTGauweAg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011257 build_url: 'https://queue.taskcluster.net/v1/task/dYjvUOI-Q6iBvQTGauweAg/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/bbb8e8def4bf6553da2e6c319d67b21cb33d54e9e7e8e833d2683e99d137597b9fa4f5d8e7fecb21f84933e8128d57c5e8ca9e1c6ae1deebb3787be7eaff32f3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8945b2ababab974a25ea24cbe7c973b9921126fc98bbf1addda014ab66833f5631df75b682ddbcb52d171c23e6001030801fe1bb37599c53d9eb83494f3a7f3c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-12 01:23:17.528279) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:23:17.528717) ========= 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=82e07478c745e68b1fe4678a000001bc-1452589319.763225-2093991268 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004586 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-12 01:23:17.578591) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 01:23:17.578954) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-12 01:23:17.992538) ========= ========= Total master_lag: 0.87 =========