builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-021 starttime: 1470982524.48 results: success (0) buildid: 20160811203012 builduid: cd3f4a0b9f4043bb81e3a97ecc1f1c4a revision: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:24.476827) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:24.477261) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:24.477562) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:24.506155) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:24.506425) ========= 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=df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-11 23:15:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-08-11 23:15:24 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119015 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:24.639193) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:24.639579) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', '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=df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019902 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:24.689979) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 23:15:24.690331) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 6f2ba7787816fd01f77c30e3bdb68400db74bf0c --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 6f2ba7787816fd01f77c30e3bdb68400db74bf0c --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=df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-11 23:15:25,012 truncating revision to first 12 chars 2016-08-11 23:15:25,012 Setting DEBUG logging. 2016-08-11 23:15:25,012 attempt 1/10 2016-08-11 23:15:25,013 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/6f2ba7787816?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-11 23:15:26,052 unpacking tar archive at: fx-team-6f2ba7787816/testing/mozharness/ program finished with exit code 0 elapsedTime=1.367578 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-11 23:15:26.074549) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:26.075167) ========= script_repo_revision: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:26.076039) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:26.076662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-11 23:15:26.089381) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-11 23:15:26.089655) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:15:26 INFO - MultiFileLogger online at 20160811 23:15:26 in /builds/slave/test 23:15:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:15:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:15:26 INFO - {'append_to_log': False, 23:15:26 INFO - 'base_work_dir': '/builds/slave/test', 23:15:26 INFO - 'blob_upload_branch': 'Fx-Team', 23:15:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:15:26 INFO - 'branch': 'Fx-Team', 23:15:26 INFO - 'buildbot_json_path': 'buildprops.json', 23:15:26 INFO - 'config_files': ('talos/linux_config.py',), 23:15:26 INFO - 'default_actions': ('clobber', 23:15:26 INFO - 'read-buildbot-config', 23:15:26 INFO - 'download-and-extract', 23:15:26 INFO - 'populate-webroot', 23:15:26 INFO - 'create-virtualenv', 23:15:26 INFO - 'install', 23:15:26 INFO - 'run-tests'), 23:15:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:15:26 INFO - 'download_minidump_stackwalk': True, 23:15:26 INFO - 'download_symbols': 'ondemand', 23:15:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:15:26 INFO - 'tooltool.py': '/tools/tooltool.py', 23:15:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:15:26 INFO - '/tools/misc-python/virtualenv.py')}, 23:15:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:15:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:15:26 INFO - 'installer_path': 'installer.exe', 23:15:26 INFO - 'log_level': 'info', 23:15:26 INFO - 'log_name': 'talos', 23:15:26 INFO - 'log_to_console': True, 23:15:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:15:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:15:26 INFO - 'opt_config_files': (), 23:15:26 INFO - 'pip_index': False, 23:15:26 INFO - 'sps_profile': False, 23:15:26 INFO - 'sps_profile_interval': 0, 23:15:26 INFO - 'suite': 'dromaeojs-e10s', 23:15:26 INFO - 'system_bits': '32', 23:15:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:15:26 INFO - 'title': 'talos-linux64-ix-021', 23:15:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:15:26 INFO - 'use_talos_json': True, 23:15:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:15:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:15:26 INFO - 'work_dir': 'build'} 23:15:26 INFO - [mozharness: 2016-08-12 06:15:26.503125Z] Running clobber step. 23:15:26 INFO - Running pre-action listener: _resource_record_pre_action 23:15:26 INFO - Running main action method: clobber 23:15:26 INFO - rmtree: /builds/slave/test/build 23:15:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:15:26 INFO - Running post-action listener: _resource_record_post_action 23:15:26 INFO - [mozharness: 2016-08-12 06:15:26.966777Z] Finished clobber step (success) 23:15:26 INFO - [mozharness: 2016-08-12 06:15:26.966878Z] Running read-buildbot-config step. 23:15:26 INFO - Running pre-action listener: _resource_record_pre_action 23:15:26 INFO - Running main action method: read_buildbot_config 23:15:26 INFO - Using buildbot properties: 23:15:26 INFO - { 23:15:26 INFO - "project": "", 23:15:26 INFO - "product": "firefox", 23:15:26 INFO - "script_repo_revision": "production", 23:15:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:15:26 INFO - "repository": "", 23:15:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:15:26 INFO - "buildid": "20160811203012", 23:15:26 INFO - "pgo_build": "True", 23:15:26 INFO - "basedir": "/builds/slave/test", 23:15:26 INFO - "buildnumber": 669, 23:15:26 INFO - "slavename": "talos-linux64-ix-021", 23:15:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:15:26 INFO - "platform": "ubuntu64_hw", 23:15:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:15:26 INFO - "branch": "fx-team", 23:15:26 INFO - "repo_path": "integration/fx-team", 23:15:26 INFO - "revision": "6f2ba7787816fd01f77c30e3bdb68400db74bf0c", 23:15:26 INFO - "stage_platform": "linux64-pgo", 23:15:26 INFO - "builduid": "cd3f4a0b9f4043bb81e3a97ecc1f1c4a", 23:15:26 INFO - "slavebuilddir": "test" 23:15:26 INFO - } 23:15:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:15:26 INFO - Running post-action listener: _resource_record_post_action 23:15:26 INFO - [mozharness: 2016-08-12 06:15:26.969311Z] Finished read-buildbot-config step (success) 23:15:26 INFO - [mozharness: 2016-08-12 06:15:26.969420Z] Running download-and-extract step. 23:15:26 INFO - Running pre-action listener: _resource_record_pre_action 23:15:26 INFO - Running main action method: download_and_extract 23:15:26 INFO - mkdir: /builds/slave/test/build/tests 23:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:26 INFO - trying https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:15:26 INFO - Downloading https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:15:27 INFO - Downloaded 1361 bytes. 23:15:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:15:27 INFO - Using the following test package requirements: 23:15:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:15:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:15:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:15:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:27 INFO - u'jsshell-linux-x86_64.zip'], 23:15:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:15:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:15:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:15:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:15:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:15:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:15:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:15:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:15: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:27 INFO - trying https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:15:27 INFO - Downloading https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:15:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:15:28 INFO - Downloaded 21833162 bytes. 23:15:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:15:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:15:29 INFO - Return code: 0 23:15:29 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:15:29 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:29 INFO - trying https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:15:29 INFO - Downloading https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:15:30 INFO - Downloaded 21833162 bytes. 23:15:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:15:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:15:32 INFO - Return code: 0 23:15:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:32 INFO - trying https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:15:32 INFO - Downloading https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:15:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:15:33 INFO - Downloaded 14413719 bytes. 23:15:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:15:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:15:33 INFO - Return code: 0 23:15:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:33 INFO - trying https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:15:33 INFO - Downloading https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:15:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:15:34 INFO - Downloaded 59350629 bytes. 23:15:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:15:34 INFO - mkdir: /builds/slave/test/properties 23:15:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:15:34 INFO - Writing to file /builds/slave/test/properties/build_url 23:15:34 INFO - Contents: 23:15:34 INFO - build_url:https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:15:35 INFO - Running post-action listener: _resource_record_post_action 23:15:35 INFO - Running post-action listener: set_extra_try_arguments 23:15:35 INFO - [mozharness: 2016-08-12 06:15:35.048144Z] Finished download-and-extract step (success) 23:15:35 INFO - [mozharness: 2016-08-12 06:15:35.048376Z] Running populate-webroot step. 23:15:35 INFO - Running pre-action listener: _resource_record_pre_action 23:15:35 INFO - Running main action method: populate_webroot 23:15:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:15:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:15:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:15:35 INFO - '--tppagecycles', 23:15:35 INFO - '7'], 23:15:35 INFO - 'tests': ['tsvgm']}}, 23:15:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:15:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:15:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:15:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:15:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:35 INFO - 'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:15:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:15:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:35 INFO - 'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['damp', 'tps']}, 23:15:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:35 INFO - 'tests': ['damp', 'tps']}, 23:15:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['dromaeo_dom']}, 23:15:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:15:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['basic_compositor_video']}, 23:15:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:15:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['a11yr', 23:15:35 INFO - 'ts_paint', 23:15:35 INFO - 'tpaint', 23:15:35 INFO - 'sessionrestore', 23:15:35 INFO - 'sessionrestore_no_auto_restore', 23:15:35 INFO - 'tabpaint']}, 23:15:35 INFO - 'other-e10s': {'tests': ['a11yr', 23:15:35 INFO - 'ts_paint', 23:15:35 INFO - 'tpaint', 23:15:35 INFO - 'sessionrestore', 23:15:35 INFO - 'sessionrestore_no_auto_restore', 23:15:35 INFO - 'tabpaint']}, 23:15:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:15:35 INFO - 'ts_paint', 23:15:35 INFO - 'tpaint', 23:15:35 INFO - 'sessionrestore', 23:15:35 INFO - 'sessionrestore_no_auto_restore', 23:15:35 INFO - 'tabpaint']}, 23:15:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:15:35 INFO - 'ts_paint', 23:15:35 INFO - 'tpaint', 23:15:35 INFO - 'sessionrestore', 23:15:35 INFO - 'sessionrestore_no_auto_restore', 23:15:35 INFO - 'tabpaint']}, 23:15:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['a11yr', 23:15:35 INFO - 'ts_paint', 23:15:35 INFO - 'tpaint', 23:15:35 INFO - 'sessionrestore', 23:15:35 INFO - 'sessionrestore_no_auto_restore', 23:15:35 INFO - 'tabpaint']}, 23:15:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['a11yr', 23:15:35 INFO - 'ts_paint', 23:15:35 INFO - 'tpaint', 23:15:35 INFO - 'sessionrestore', 23:15:35 INFO - 'sessionrestore_no_auto_restore', 23:15:35 INFO - 'tabpaint']}, 23:15:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['tsvgx', 23:15:35 INFO - 'tsvgr_opacity', 23:15:35 INFO - 'tart', 23:15:35 INFO - 'tscrollx', 23:15:35 INFO - 'cart']}, 23:15:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:15:35 INFO - 'tsvgr_opacity', 23:15:35 INFO - 'tart', 23:15:35 INFO - 'tscrollx', 23:15:35 INFO - 'cart']}, 23:15:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:35 INFO - 'talos_options': ['--disable-e10s'], 23:15:35 INFO - 'tests': ['tp5o']}, 23:15:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:35 INFO - 'tests': ['tp5o']}, 23:15:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:35 INFO - 'talos_options': ['--disable-e10s', 23:15:35 INFO - '--xperf_path', 23:15:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:15:35 INFO - 'tests': ['tp5n']}, 23:15:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:15:35 INFO - 'talos_options': ['--xperf_path', 23:15:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:15:35 INFO - 'tests': ['tp5n']}}, 23:15:35 INFO - 'talos.zip': {'path': '', 23:15:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:15:35 INFO - Running post-action listener: _resource_record_post_action 23:15:35 INFO - [mozharness: 2016-08-12 06:15:35.067448Z] Finished populate-webroot step (success) 23:15:35 INFO - [mozharness: 2016-08-12 06:15:35.067537Z] Running create-virtualenv step. 23:15:35 INFO - Running pre-action listener: _resource_record_pre_action 23:15:35 INFO - Running main action method: create_virtualenv 23:15:35 INFO - Creating virtualenv /builds/slave/test/build/venv 23:15:35 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 23:15:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:15:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:15:35 INFO - Using real prefix '/usr' 23:15:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:15:36 INFO - Installing distribute.............................................................................................................................................................................................done. 23:15:38 INFO - Installing pip.................done. 23:15:38 INFO - Return code: 0 23:15:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x24ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, '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': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', '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 23:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 23:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 23:15:38 INFO - Using env: {'DISPLAY': ':0', 23:15:38 INFO - 'HOME': '/home/cltbld', 23:15:38 INFO - 'LANG': 'en_US.UTF-8', 23:15:38 INFO - 'LANGUAGE': 'en_US:en', 23:15:38 INFO - 'LOGNAME': 'cltbld', 23:15:38 INFO - 'MAIL': '/var/mail/cltbld', 23:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:38 INFO - 'MOZ_NO_REMOTE': '1', 23:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:38 INFO - 'NO_EM_RESTART': '1', 23:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:38 INFO - 'PWD': '/builds/slave/test', 23:15:38 INFO - 'SHELL': '/bin/bash', 23:15:38 INFO - 'SHLVL': '1', 23:15:38 INFO - 'TERM': 'linux', 23:15:38 INFO - 'TMOUT': '86400', 23:15:38 INFO - 'USER': 'cltbld', 23:15:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:38 INFO - '_': '/tools/buildbot/bin/python'} 23:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:38 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 23:15:38 INFO - Cleaning up... 23:15:38 INFO - Return code: 0 23:15:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, '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': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', '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 23:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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>=3.1.1'] in /builds/slave/test/build 23:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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>=3.1.1 23:15:38 INFO - Using env: {'DISPLAY': ':0', 23:15:38 INFO - 'HOME': '/home/cltbld', 23:15:38 INFO - 'LANG': 'en_US.UTF-8', 23:15:38 INFO - 'LANGUAGE': 'en_US:en', 23:15:38 INFO - 'LOGNAME': 'cltbld', 23:15:38 INFO - 'MAIL': '/var/mail/cltbld', 23:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:38 INFO - 'MOZ_NO_REMOTE': '1', 23:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:38 INFO - 'NO_EM_RESTART': '1', 23:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:38 INFO - 'PWD': '/builds/slave/test', 23:15:38 INFO - 'SHELL': '/bin/bash', 23:15:38 INFO - 'SHLVL': '1', 23:15:38 INFO - 'TERM': 'linux', 23:15:38 INFO - 'TMOUT': '86400', 23:15:38 INFO - 'USER': 'cltbld', 23:15:38 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:38 INFO - '_': '/tools/buildbot/bin/python'} 23:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:38 INFO - Downloading/unpacking psutil>=3.1.1 23:15:38 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 23:15:38 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 23:15:38 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 23:15:38 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 23:15:38 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 23:15:38 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 23:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:15:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:15:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:15:40 INFO - Installing collected packages: psutil 23:15:40 INFO - Running setup.py install for psutil 23:15:40 INFO - building 'psutil._psutil_linux' extension 23:15:40 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 23:15:40 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 23:15:40 INFO - building 'psutil._psutil_posix' extension 23:15:40 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 23:15:40 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 23:15:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:15:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:15:41 INFO - Successfully installed psutil 23:15:41 INFO - Cleaning up... 23:15:41 INFO - Return code: 0 23:15:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:15:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:41 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, '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': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', '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 23:15:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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.3'] in /builds/slave/test/build 23:15:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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.3 23:15:41 INFO - Using env: {'DISPLAY': ':0', 23:15:41 INFO - 'HOME': '/home/cltbld', 23:15:41 INFO - 'LANG': 'en_US.UTF-8', 23:15:41 INFO - 'LANGUAGE': 'en_US:en', 23:15:41 INFO - 'LOGNAME': 'cltbld', 23:15:41 INFO - 'MAIL': '/var/mail/cltbld', 23:15:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:41 INFO - 'MOZ_NO_REMOTE': '1', 23:15:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:41 INFO - 'NO_EM_RESTART': '1', 23:15:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:41 INFO - 'PWD': '/builds/slave/test', 23:15:41 INFO - 'SHELL': '/bin/bash', 23:15:41 INFO - 'SHLVL': '1', 23:15:41 INFO - 'TERM': 'linux', 23:15:41 INFO - 'TMOUT': '86400', 23:15:41 INFO - 'USER': 'cltbld', 23:15:41 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:15:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:41 INFO - '_': '/tools/buildbot/bin/python'} 23:15:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:15:41 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 23:15:41 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 23:15:41 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 23:15:41 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 23:15:41 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 23:15:41 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 23:15:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:15:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:15:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:15:43 INFO - Installing collected packages: mozsystemmonitor 23:15:43 INFO - Running setup.py install for mozsystemmonitor 23:15:43 INFO - Successfully installed mozsystemmonitor 23:15:43 INFO - Cleaning up... 23:15:43 INFO - Return code: 0 23:15:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, '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': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', '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 23:15:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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==2.5.1'] in /builds/slave/test/build 23:15:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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==2.5.1 23:15:43 INFO - Using env: {'DISPLAY': ':0', 23:15:43 INFO - 'HOME': '/home/cltbld', 23:15:43 INFO - 'LANG': 'en_US.UTF-8', 23:15:43 INFO - 'LANGUAGE': 'en_US:en', 23:15:43 INFO - 'LOGNAME': 'cltbld', 23:15:43 INFO - 'MAIL': '/var/mail/cltbld', 23:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:43 INFO - 'MOZ_NO_REMOTE': '1', 23:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:43 INFO - 'NO_EM_RESTART': '1', 23:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:43 INFO - 'PWD': '/builds/slave/test', 23:15:43 INFO - 'SHELL': '/bin/bash', 23:15:43 INFO - 'SHLVL': '1', 23:15:43 INFO - 'TERM': 'linux', 23:15:43 INFO - 'TMOUT': '86400', 23:15:43 INFO - 'USER': 'cltbld', 23:15:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:43 INFO - '_': '/tools/buildbot/bin/python'} 23:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:43 INFO - Downloading/unpacking jsonschema==2.5.1 23:15:43 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 23:15:43 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 23:15:43 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 23:15:43 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 23:15:43 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 23:15:43 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 23:15:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:15:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:15:45 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 23:15:45 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 23:15:45 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 23:15:45 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 23:15:45 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 23:15:45 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 23:15:45 INFO - Downloading functools32-3.2.3-2.tar.gz 23:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:15:45 INFO - warning: no files found matching '*.txt' 23:15:45 INFO - no previously-included directories found matching 'build' 23:15:45 INFO - no previously-included directories found matching 'dist' 23:15:45 INFO - no previously-included directories found matching '.git*' 23:15:45 INFO - Installing collected packages: jsonschema, functools32 23:15:45 INFO - Running setup.py install for functools32 23:15:45 INFO - warning: no files found matching '*.txt' 23:15:45 INFO - no previously-included directories found matching 'build' 23:15:45 INFO - no previously-included directories found matching 'dist' 23:15:45 INFO - no previously-included directories found matching '.git*' 23:15:45 INFO - Successfully installed jsonschema functools32 23:15:45 INFO - Cleaning up... 23:15:45 INFO - Return code: 0 23:15:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:15:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:45 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, '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': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', '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 23:15:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:15:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 functools32==3.2.3-2 23:15:45 INFO - Using env: {'DISPLAY': ':0', 23:15:45 INFO - 'HOME': '/home/cltbld', 23:15:45 INFO - 'LANG': 'en_US.UTF-8', 23:15:45 INFO - 'LANGUAGE': 'en_US:en', 23:15:45 INFO - 'LOGNAME': 'cltbld', 23:15:45 INFO - 'MAIL': '/var/mail/cltbld', 23:15:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:45 INFO - 'MOZ_NO_REMOTE': '1', 23:15:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:45 INFO - 'NO_EM_RESTART': '1', 23:15:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:45 INFO - 'PWD': '/builds/slave/test', 23:15:45 INFO - 'SHELL': '/bin/bash', 23:15:45 INFO - 'SHLVL': '1', 23:15:45 INFO - 'TERM': 'linux', 23:15:45 INFO - 'TMOUT': '86400', 23:15:45 INFO - 'USER': 'cltbld', 23:15:45 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:15:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:45 INFO - '_': '/tools/buildbot/bin/python'} 23:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:15:46 INFO - Cleaning up... 23:15:46 INFO - Return code: 0 23:15:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:15:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:46 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x24ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, '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': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', '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 23:15:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 23:15:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 23:15:46 INFO - Using env: {'DISPLAY': ':0', 23:15:46 INFO - 'HOME': '/home/cltbld', 23:15:46 INFO - 'LANG': 'en_US.UTF-8', 23:15:46 INFO - 'LANGUAGE': 'en_US:en', 23:15:46 INFO - 'LOGNAME': 'cltbld', 23:15:46 INFO - 'MAIL': '/var/mail/cltbld', 23:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:46 INFO - 'MOZ_NO_REMOTE': '1', 23:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:46 INFO - 'NO_EM_RESTART': '1', 23:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:46 INFO - 'PWD': '/builds/slave/test', 23:15:46 INFO - 'SHELL': '/bin/bash', 23:15:46 INFO - 'SHLVL': '1', 23:15:46 INFO - 'TERM': 'linux', 23:15:46 INFO - 'TMOUT': '86400', 23:15:46 INFO - 'USER': 'cltbld', 23:15:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:46 INFO - '_': '/tools/buildbot/bin/python'} 23:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:46 INFO - Downloading/unpacking blobuploader==1.2.4 23:15:46 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 23:15:46 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 23:15:46 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 23:15:46 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 23:15:46 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 23:15:46 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 23:15:48 INFO - Downloading blobuploader-1.2.4.tar.gz 23:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:15:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:15:48 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 23:15:48 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 23:15:48 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 23:15:48 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 23:15:48 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 23:15:48 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 23:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:15:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:15:48 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 23:15:48 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 23:15:48 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 23:15:48 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 23:15:48 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 23:15:48 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 23:15:48 INFO - Downloading docopt-0.6.1.tar.gz 23:15:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:15:48 INFO - Installing collected packages: blobuploader, requests, docopt 23:15:48 INFO - Running setup.py install for blobuploader 23:15:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:15:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:15:49 INFO - Running setup.py install for requests 23:15:49 INFO - Running setup.py install for docopt 23:15:49 INFO - Successfully installed blobuploader requests docopt 23:15:49 INFO - Cleaning up... 23:15:49 INFO - Return code: 0 23:15:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x24ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, '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': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', '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 23:15:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 23:15:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 23:15:49 INFO - Using env: {'DISPLAY': ':0', 23:15:49 INFO - 'HOME': '/home/cltbld', 23:15:49 INFO - 'LANG': 'en_US.UTF-8', 23:15:49 INFO - 'LANGUAGE': 'en_US:en', 23:15:49 INFO - 'LOGNAME': 'cltbld', 23:15:49 INFO - 'MAIL': '/var/mail/cltbld', 23:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:49 INFO - 'MOZ_NO_REMOTE': '1', 23:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:49 INFO - 'NO_EM_RESTART': '1', 23:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:49 INFO - 'PWD': '/builds/slave/test', 23:15:49 INFO - 'SHELL': '/bin/bash', 23:15:49 INFO - 'SHLVL': '1', 23:15:49 INFO - 'TERM': 'linux', 23:15:49 INFO - 'TMOUT': '86400', 23:15:49 INFO - 'USER': 'cltbld', 23:15:49 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:49 INFO - '_': '/tools/buildbot/bin/python'} 23:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:15:49 INFO - Running setup.py (path:/tmp/pip-97sbnZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:15:49 INFO - Running setup.py (path:/tmp/pip-4Y2g5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:15:49 INFO - Running setup.py (path:/tmp/pip-7Dg9bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:15:50 INFO - Running setup.py (path:/tmp/pip-Hh_9Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:15:50 INFO - Running setup.py (path:/tmp/pip-5SSBqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:15:50 INFO - Running setup.py (path:/tmp/pip-Uyfuu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:15:50 INFO - Running setup.py (path:/tmp/pip-C7ChRu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:15:50 INFO - Running setup.py (path:/tmp/pip-Nsaqdp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:15:50 INFO - Running setup.py (path:/tmp/pip-nvzi86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:15:50 INFO - Running setup.py (path:/tmp/pip-aFoggH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:15:50 INFO - Running setup.py (path:/tmp/pip-J6fR8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:15:50 INFO - Running setup.py (path:/tmp/pip-RfeNNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:15:50 INFO - Running setup.py (path:/tmp/pip-IUn0dU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:15:50 INFO - Running setup.py (path:/tmp/pip-ZQZOIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:50 INFO - Running setup.py (path:/tmp/pip-V7mI6P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:15:50 INFO - Running setup.py (path:/tmp/pip-I6IbEf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:15:50 INFO - Running setup.py (path:/tmp/pip-F0m7dT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:15:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:15:51 INFO - Running setup.py install for manifestparser 23:15:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:15:51 INFO - Running setup.py install for mozcrash 23:15:51 INFO - Running setup.py install for mozdebug 23:15:51 INFO - Running setup.py install for mozdevice 23:15:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:15:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:15:51 INFO - Running setup.py install for mozfile 23:15:51 INFO - Running setup.py install for mozhttpd 23:15:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:15:51 INFO - Running setup.py install for mozinfo 23:15:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:15:51 INFO - Running setup.py install for mozInstall 23:15:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:15:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:15:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:15:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:15:51 INFO - Running setup.py install for mozleak 23:15:51 INFO - Running setup.py install for mozlog 23:15:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:15:52 INFO - Running setup.py install for moznetwork 23:15:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:15:52 INFO - Running setup.py install for mozprocess 23:15:52 INFO - Running setup.py install for mozprofile 23:15:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:15:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:15:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:15:52 INFO - Running setup.py install for mozrunner 23:15:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:15:52 INFO - Running setup.py install for mozscreenshot 23:15:52 INFO - Running setup.py install for moztest 23:15:52 INFO - Running setup.py install for mozversion 23:15:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:15:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:15:52 INFO - Cleaning up... 23:15:52 INFO - Return code: 0 23:15:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x24ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, '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': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', '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 23:15:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 23:15:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 23:15:52 INFO - Using env: {'DISPLAY': ':0', 23:15:52 INFO - 'HOME': '/home/cltbld', 23:15:52 INFO - 'LANG': 'en_US.UTF-8', 23:15:52 INFO - 'LANGUAGE': 'en_US:en', 23:15:52 INFO - 'LOGNAME': 'cltbld', 23:15:52 INFO - 'MAIL': '/var/mail/cltbld', 23:15:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:52 INFO - 'MOZ_NO_REMOTE': '1', 23:15:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:52 INFO - 'NO_EM_RESTART': '1', 23:15:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:52 INFO - 'PWD': '/builds/slave/test', 23:15:52 INFO - 'SHELL': '/bin/bash', 23:15:52 INFO - 'SHLVL': '1', 23:15:52 INFO - 'TERM': 'linux', 23:15:52 INFO - 'TMOUT': '86400', 23:15:52 INFO - 'USER': 'cltbld', 23:15:52 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:15:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:52 INFO - '_': '/tools/buildbot/bin/python'} 23:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:15:53 INFO - Running setup.py (path:/tmp/pip-msuYgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:15:53 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:15:53 INFO - Running setup.py (path:/tmp/pip-PGziK2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:15:53 INFO - Running setup.py (path:/tmp/pip-9Du5Bs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:15:53 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:15:53 INFO - Running setup.py (path:/tmp/pip-QWGCVG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:15:53 INFO - Running setup.py (path:/tmp/pip-5FGR28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:15:53 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:15:53 INFO - Running setup.py (path:/tmp/pip-lLfyaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:15:53 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:15:53 INFO - Running setup.py (path:/tmp/pip-n9xCsG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:15:53 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:15:53 INFO - Running setup.py (path:/tmp/pip-WZNDHV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:15:53 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:15:53 INFO - Running setup.py (path:/tmp/pip-UFl673-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:15:53 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:15:53 INFO - Running setup.py (path:/tmp/pip-NNHnZk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:15:53 INFO - Running setup.py (path:/tmp/pip-KxJCW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:15:53 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:15:53 INFO - Running setup.py (path:/tmp/pip-515VbY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:15:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 23:15:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:15:53 INFO - Running setup.py (path:/tmp/pip-uN2GN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:15:54 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)) 23:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:15:54 INFO - Running setup.py (path:/tmp/pip-1lWGGc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 23:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:54 INFO - Running setup.py (path:/tmp/pip-LXP2lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:15:54 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)) 23:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:15:54 INFO - Running setup.py (path:/tmp/pip-Upp8Cs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:15:54 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)) 23:15:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:15:54 INFO - Running setup.py (path:/tmp/pip-tz1sT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:15:54 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)) 23:15:54 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:15:54 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 23:15:54 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)) 23:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 23:15:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:15:54 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 23:15:54 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 23:15:54 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 23:15:54 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 23:15:54 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 23:15:54 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 23:15:56 INFO - Downloading blessings-1.6.tar.gz 23:15:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:15:56 INFO - Installing collected packages: blessings 23:15:56 INFO - Running setup.py install for blessings 23:15:56 INFO - Successfully installed blessings 23:15:56 INFO - Cleaning up... 23:15:56 INFO - Return code: 0 23:15:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:15:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:15:56 INFO - Reading from file tmpfile_stdout 23:15:56 INFO - Current package versions: 23:15:56 INFO - argparse == 1.2.1 23:15:56 INFO - blessings == 1.6 23:15:56 INFO - blobuploader == 1.2.4 23:15:56 INFO - docopt == 0.6.1 23:15:56 INFO - functools32 == 3.2.3-2 23:15:56 INFO - jsonschema == 2.5.1 23:15:56 INFO - manifestparser == 1.1 23:15:56 INFO - mozInstall == 1.12 23:15:56 INFO - mozcrash == 0.17 23:15:56 INFO - mozdebug == 0.1 23:15:56 INFO - mozdevice == 0.48 23:15:56 INFO - mozfile == 1.2 23:15:56 INFO - mozhttpd == 0.7 23:15:56 INFO - mozinfo == 0.9 23:15:56 INFO - mozleak == 0.1 23:15:56 INFO - mozlog == 3.3 23:15:56 INFO - moznetwork == 0.27 23:15:56 INFO - mozprocess == 0.23 23:15:56 INFO - mozprofile == 0.28 23:15:56 INFO - mozrunner == 6.12 23:15:56 INFO - mozscreenshot == 0.1 23:15:56 INFO - mozsystemmonitor == 0.3 23:15:56 INFO - moztest == 0.7 23:15:56 INFO - mozversion == 1.4 23:15:56 INFO - psutil == 3.1.1 23:15:56 INFO - requests == 1.2.3 23:15:56 INFO - wsgiref == 0.1.2 23:15:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:15:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x24ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, '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': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', '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 23:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 23:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 23:15:56 INFO - Using env: {'DISPLAY': ':0', 23:15:56 INFO - 'HOME': '/home/cltbld', 23:15:56 INFO - 'LANG': 'en_US.UTF-8', 23:15:56 INFO - 'LANGUAGE': 'en_US:en', 23:15:56 INFO - 'LOGNAME': 'cltbld', 23:15:56 INFO - 'MAIL': '/var/mail/cltbld', 23:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:56 INFO - 'MOZ_NO_REMOTE': '1', 23:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:56 INFO - 'NO_EM_RESTART': '1', 23:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:56 INFO - 'PWD': '/builds/slave/test', 23:15:56 INFO - 'SHELL': '/bin/bash', 23:15:56 INFO - 'SHLVL': '1', 23:15:56 INFO - 'TERM': 'linux', 23:15:56 INFO - 'TMOUT': '86400', 23:15:56 INFO - 'USER': 'cltbld', 23:15:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:56 INFO - '_': '/tools/buildbot/bin/python'} 23:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:56 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)) 23:15:56 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)) 23:15:56 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)) 23:15:56 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)) 23:15:56 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)) 23:15:56 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)) 23:15:56 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)) 23:15:56 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)) 23:15:56 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)) 23:15:56 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)) 23:15:56 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)) 23:15:56 INFO - Cleaning up... 23:15:56 INFO - Return code: 0 23:15:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:15:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:56 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x24ab030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, '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': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', '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 23:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 23:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 23:15:56 INFO - Using env: {'DISPLAY': ':0', 23:15:56 INFO - 'HOME': '/home/cltbld', 23:15:56 INFO - 'LANG': 'en_US.UTF-8', 23:15:56 INFO - 'LANGUAGE': 'en_US:en', 23:15:56 INFO - 'LOGNAME': 'cltbld', 23:15:56 INFO - 'MAIL': '/var/mail/cltbld', 23:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:15:56 INFO - 'MOZ_NO_REMOTE': '1', 23:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:15:56 INFO - 'NO_EM_RESTART': '1', 23:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:15:56 INFO - 'PWD': '/builds/slave/test', 23:15:56 INFO - 'SHELL': '/bin/bash', 23:15:56 INFO - 'SHLVL': '1', 23:15:56 INFO - 'TERM': 'linux', 23:15:56 INFO - 'TMOUT': '86400', 23:15:56 INFO - 'USER': 'cltbld', 23:15:56 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:15:56 INFO - '_': '/tools/buildbot/bin/python'} 23:15:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:15:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:15:57 INFO - Cleaning up... 23:15:57 INFO - Return code: 0 23:15:57 INFO - Running post-action listener: _resource_record_post_action 23:15:57 INFO - Running post-action listener: _start_resource_monitoring 23:15:57 INFO - Starting resource monitoring. 23:15:57 INFO - [mozharness: 2016-08-12 06:15:57.143297Z] Finished create-virtualenv step (success) 23:15:57 INFO - [mozharness: 2016-08-12 06:15:57.143776Z] Running install step. 23:15:57 INFO - Running pre-action listener: _resource_record_pre_action 23:15:57 INFO - Running main action method: install 23:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:15:57 INFO - Reading from file tmpfile_stdout 23:15:57 INFO - Detecting whether we're running mozinstall >=1.0... 23:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:15:57 INFO - Reading from file tmpfile_stdout 23:15:57 INFO - Output received: 23:15:57 INFO - Usage: mozinstall [options] installer 23:15:57 INFO - Options: 23:15:57 INFO - -h, --help show this help message and exit 23:15:57 INFO - -d DEST, --destination=DEST 23:15:57 INFO - Directory to install application into. [default: 23:15:57 INFO - "/builds/slave/test"] 23:15:57 INFO - --app=APP Application being installed. [default: firefox] 23:15:57 INFO - mkdir: /builds/slave/test/build/application 23:15:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:15:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:16:14 INFO - Reading from file tmpfile_stdout 23:16:14 INFO - Output received: 23:16:14 INFO - /builds/slave/test/build/application/firefox/firefox 23:16:14 INFO - Running post-action listener: _resource_record_post_action 23:16:14 INFO - [mozharness: 2016-08-12 06:16:14.830474Z] Finished install step (success) 23:16:14 INFO - [mozharness: 2016-08-12 06:16:14.830721Z] Running run-tests step. 23:16:14 INFO - Running pre-action listener: _resource_record_pre_action 23:16:14 INFO - Running main action method: run_tests 23:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:16:14 INFO - Python 2.7.3 23:16:14 INFO - Return code: 0 23:16:14 INFO - grabbing minidump binary from tooltool 23:16:14 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:14 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x276a3b0>, '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 0x276b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x276b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:16:14 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 23:16:14 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 23:16:14 INFO - Calling ['/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'] with output_timeout 600 23:16:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:16:15 INFO - Return code: 0 23:16:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:16:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:16:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:16:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:16:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 23:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 23:16:15 INFO - Using env: {'DISPLAY': ':0', 23:16:15 INFO - 'HOME': '/home/cltbld', 23:16:15 INFO - 'LANG': 'en_US.UTF-8', 23:16:15 INFO - 'LANGUAGE': 'en_US:en', 23:16:15 INFO - 'LOGNAME': 'cltbld', 23:16:15 INFO - 'MAIL': '/var/mail/cltbld', 23:16:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:16:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:15 INFO - 'MOZ_NO_REMOTE': '1', 23:16:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:15 INFO - 'NO_EM_RESTART': '1', 23:16:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:15 INFO - 'PWD': '/builds/slave/test', 23:16:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:16:15 INFO - 'SHELL': '/bin/bash', 23:16:15 INFO - 'SHLVL': '1', 23:16:15 INFO - 'TERM': 'linux', 23:16:15 INFO - 'TMOUT': '86400', 23:16:15 INFO - 'USER': 'cltbld', 23:16:15 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368', 23:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:15 INFO - '_': '/tools/buildbot/bin/python'} 23:16:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 23:16:16 INFO - mozversion application_buildid: 20160811203012 23:16:16 INFO - mozversion application_changeset: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c 23:16:16 INFO - mozversion application_display_name: Nightly 23:16:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:16:16 INFO - mozversion application_name: Firefox 23:16:16 INFO - mozversion application_remotingname: firefox 23:16:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:16:16 INFO - mozversion application_vendor: Mozilla 23:16:16 INFO - mozversion application_version: 51.0a1 23:16:16 INFO - mozversion platform_buildid: 20160811203012 23:16:16 INFO - mozversion platform_changeset: 6f2ba7787816fd01f77c30e3bdb68400db74bf0c 23:16:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:16:16 INFO - mozversion platform_version: 51.0a1 23:16:16 INFO - using testdate: 1470982576 23:16:16 INFO - actual date: 1470982576 23:16:16 INFO - starting webserver on 'localhost:36927' 23:16:16 INFO - SUITE-START | Running 2 tests 23:16:16 INFO - TEST-START | dromaeo_css 23:16:16 INFO - operating with platform_type : linux_ 23:16:16 INFO - Initialising browser for dromaeo_css test... 23:16:16 INFO - TEST-INFO | started process 7549 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5hQg_X/profile http://localhost:36927/getInfo.html) 23:16:22 INFO - PROCESS | 7549 | __metrics Screen width/height:1600/1200 23:16:22 INFO - PROCESS | 7549 | colorDepth:24 23:16:22 INFO - PROCESS | 7549 | Browser inner width/height: 1024/697 23:16:22 INFO - PROCESS | 7549 | __metrics 23:16:23 ERROR - PROCESS | 7549 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 23:16:24 INFO - TEST-INFO | 7549: exit 0 23:16:24 INFO - Browser initialized. 23:16:24 INFO - Running cycle 1/1 for dromaeo_css test... 23:16:24 INFO - TEST-INFO | started process 7671 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5hQg_X/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:16:36 INFO - PROCESS | 7671 | RSS: Main: 162996224 23:16:36 INFO - PROCESS | 7671 | 23:17:25 INFO - PROCESS | 7671 | 1470982645637 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] 23:19:35 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36927/tests/dromaeo/cssquery-ext.html) 23:19:36 INFO - PROCESS | 7671 | RSS: Main: 166375424 23:19:36 INFO - PROCESS | 7671 | 23:22:39 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-ext.html (next: http://localhost:36927/tests/dromaeo/cssquery-jquery.html) 23:22:39 INFO - PROCESS | 7671 | RSS: Main: 164454400 23:22:39 INFO - PROCESS | 7671 | 23:25:41 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36927/tests/dromaeo/cssquery-mootools.html) 23:25:42 INFO - PROCESS | 7671 | RSS: Main: 168693760 23:25:42 INFO - PROCESS | 7671 | 23:28:43 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36927/tests/dromaeo/cssquery-prototype.html) 23:28:44 INFO - PROCESS | 7671 | RSS: Main: 163041280 23:28:44 INFO - PROCESS | 7671 | 23:31:47 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36927/tests/dromaeo/cssquery-yui.html) 23:31:47 INFO - PROCESS | 7671 | RSS: Main: 165818368 23:31:47 INFO - PROCESS | 7671 | 23:34:50 INFO - PROCESS | 7671 | Cycle 1(1): loaded http://localhost:36927/tests/dromaeo/cssquery-yui.html (next: http://localhost:36927/tests/dromaeo/cssquery-dojo.html) 23:34:50 INFO - PROCESS | 7671 | RSS: Main: 169345024 23:34:50 INFO - PROCESS | 7671 | 23:34:50 INFO - PROCESS | 7671 | __start_tp_report 23:34:50 INFO - PROCESS | 7671 | _x_x_mozilla_page_load 23:34:50 INFO - PROCESS | 7671 | _x_x_mozilla_page_load_details 23:34:50 INFO - PROCESS | 7671 | |i|pagename|runs| 23:34:50 INFO - PROCESS | 7671 | |0;dojo.html;3088.474959256926;3088.768342374322;3119.7192252697255;3128.4681604127295;3136.4354416205074;5422.105352616818;5444.50999410053;5451.454854514546;5480.561555075595;5505.834824955247;5476.151196564539;5540.030494663428;5544.889102217953;5563.332400111982;5584.5253153482;4926.0394223126505;5002.374703162105;5019.322391477159;5129.9230511542355;5165.6131731623955;5088.211327244265;5152.330197074375;5156.793728250866;5158.9742051289695;5170.327857378536;4908.410990681124;4931.90136197274;5011.974940125312;5021.824236151735;5065.037642847884;4979.97910428365;4984.825531106394;4987.775550100254;4999.850004499871;5035.244713292998;4939.950600493985;4959.603231741452;4985.52637499437;4996.100701873661;5037.5214354636255;5324.988252232102;5433.6196466247375;5453.509184173444;5468.316460442445;5529.391766905637;5837.737301821428;5849.473547380756;5857;5871.1193321001765;5884.176215329857;5903.970480147572;5908.14331921869;5908.615939963888;5914.142449344864;5928.97035514824;5338.62629615927;5462.317210348707;5496.6701997880655;5524.889502210013;5594.1888426177975;6081.422264884829;6082.209312789398;6100.542459315569;6114.57197996136;6125.081237814275;5822.592418530662;5828.12578113278;5841.912371314434;5843.941560584425;5849.941500585025;5734.111212762028;5774.82675519735;5835.387284335168;5847.26909136358;5924.822255332347;5830.562707796932;5872.29532456108;5885.146653735184;5891.116332550066;5894.351621321651;5823.4467725566;5854.619449735754;5856.1508581255475;5856.267966504187;5861.238039054895;4405.229084910192;4406.647468202536;4426.623736982328;4460.018795864905;4512.165249428866;3966.424868394067;3987.6809855211513;3996.4205190247253;4018.0758425562285;4023.195360927826;5583.357913839879;5583.916241256385;5586.748596313176;5587.636803607834;5593.216949627055;5778.942210577925;5815.389384114692;5832.475077243069;5852.209951656472;5901.734421951022;5588.217649528988;5600.215969764236;5631.18347839561;5638.520725738276;5640.379558248589;5054.721990290495;5074.949250507521;5084.7966081356335;5089.51649593288;5128.897422051538;5945.672987985616;5948.375420580864;5970.552208584287;6018.187544681412;6063.484603808549;5862.413758624103;5873.706314684334;5874.970625146847;5875.882482350415;5886.381929897299;5948.851278718067;5986.760529578768;5995.340512543704;6022.277326720821;6029.909551356821;5779.624324418899;5822.650640961556;5833.358330583547;5858.209141765807;5907.32065812437;5937.079752638348;5969.820905372846;5971.164037034731;5991.910121348271;6002.189704389852;5739.053056245672;5837.241158649348;5855;5857.121431785266;5863.706814659336;5770.653760774367;5796.304443466811;5818;5837.854053648693;5868.3251426086545;5802.071668533014;5810.854728631818;5823.18475413451;5828.883422331614;5848.0350742127075;5689.31728192603;5828.242328497268;5837.066069428871;5858.8242352729485;5878.2064421302575;5657.321121465286;5700.372958974593;5718.656880587178;5721.284839395075;5732.856678583069 23:34:50 INFO - PROCESS | 7671 | |1;ext.html;542.569807908366;570.592026700909;576.4149388370802;605.8667093239488;628.7453581299575;39557.60442395575;43378.349324760115;43470.56529434705;43680.34479482802;43686.12627747443;43386.566134338645;43947.56052439482;43955.34066988998;43968.78015609925;43986.34020489687;8796.032436432004;8902.955485222597;8913.910860891372;8982.595783189772;8983.416077954944;8854.07032261613;8892.73321800347;8912.376133670645;8915.866262006075;8920.73237802867;8843;8922.821543569125;8991.820163596723;8992.415492992966;9001.77495562613;8849.823003539925;8865.290776737846;8891.24424423928;8894.288456923496;8904.287656987457;8728.214460698504;8798.29613630908;8798.604062817189;8802.955985220096;8816;40870.182596347906;41435.37846932298;41533.584664153575;41613;41713.1657366851;2762.2541913683394;3316.286998295354;3362.2771104212466;3488.372093023255;3530.2409981853766;28619;30508;31643;32121.196970075936;32433.83783081093;4132.194222126656;4173.3114036184;4272.401863739079;4317.07182955666;4350.434443522322;317047;318959;320370;320524;320992;35475;35628.28743425117;35656.64343356585;35680.10799730028;35759.64240357563;36500.81749591235;36689.81655091707;36707;37366.62633373686;37851.810740946115;15881.28534215963;16032.438864639915;16079;16124.032558046554;16205.675886482204;11502.309861408343;11572.94213528927;11573;11587.768244635061;11619.477123529461;19281.710774338397;19346.516337091405;19368.225270989285;19420.126094325788;19484.07738839157;7054.6825392857445;7127.96436017827;7195.316444937723;7268.709251629875;7475.36459400957;941.4163218804385;988.3575675810637;1059.0196332857606;1085.777415629794;1112.7718817642365;32064.83967580147;32704.67295327016;32963.3407331852;33125.66874331274;33312.666873331444;1137.590467431724;1137.7440075982838;1145.2155273637584;1154.8556430446195;1182.9526818927147;16861.409850655415;16865.409710660315;17091.829081709024;17156.485305440856;17450.12749362552;587894;832812;851034;852472;856955;59741.103883441785;60451.09323360153;60547.69726151341;60693;61113.69443152756;1355.5526676196832;1373.7527245095778;1381.8410882748412;1387.3271463340272;1387.6947071644424;31895.68104318927;34423.483647744804;34734.65265347314;34801.47797783086;34802.82598586991;51038.74480627573;51451.485485146164;51499.742501287255;51548.48451515437;51586.48413515817;400230;402158;403222;403746;405028;28689.569656455587;29480;29514.409711806074;29635.851820740758;29814.701852981194;49267.50732492629;49656.75171624263;50037.499625003285;50917.49082509128;51703.22445163401;41354;42557.78721106375;43143;43202;44801.55198448104;42502.78748606237;42526.362104569074;43119.35320970251;43666.781666092735;44219.55780442154;42573.36139957965;42857.35713964231;44383.77808110939;44501.33248001347;44541.10917781561;34429.5241618598;37846;38179;38837;38889.416658750706;28644.713552864203;28745.56881646819;29109.7089029107;29311;29363.412731745673 23:34:50 INFO - PROCESS | 7671 | |2;jquery.html;381.7060863135386;390.96090390960927;403.7880112940706;406.7396866005757;420.5437100745693;13838.854977478482;18583.349582764607;19698.90150549249;20391.08240129194;20537.075831587597;19484.707729384034;19641.90179049106;19870.701939470884;20082.598348033032;20257.493562660904;5953.523718102563;5962.493188079007;6052.636841789485;6069.484093852028;6098.481629061513;5972.88054238915;5996.4902983246475;5996.700164991733;6011.218541589587;6033.185519954815;5895.469407753301;5967.880642387149;5985.88028239435;6017.849553761169;6019.067044608071;5872.9119063213875;5896.292444906596;5901.586888917777;5933.554983376264;5973.820785376424;5328.893422131575;5337.973310133463;5347.732613369355;5368.382635996872;5368.865778355534;15599.92200039004;22103.778962210334;22959.507632003868;23117.53764924709;24265.878670606533;2352.6118190498546;2400.8559486430872;2511.623256511538;2524.861132637704;2765.225736793701;10599.947000265027;10685.252032357737;10719.19606029551;10735;11402.144839137098;1841.5672317005492;1864.4313484387255;1895.7440745499318;1947.737055497504;1979.1094007696595;87501;89075;89590;91474.5426272871;92809.53595232048;11437.313761174357;11451.312921224753;11644.592439264754;11666.241694289844;11804.17370784054;16211.35154593803;16229.675406491804;16238.594035149215;16240.675186496204;16261.51215463538;7851.175626559129;8154.714584989497;8204.302634276033;8449.32405407566;8460.8730869037;7655.425843061793;7704.807379815437;7766;7981.960090199512;7992.280694737386;4833.32333473314;4856.490068542752;4885.780139893714;4927.334809800703;4945;2014.1943222711034;2052.209899188823;2071.440711008019;2102.16964299101;2114.09094089543;882.8896387951506;1000.7197984564334;1010.8584798128268;1025.789713108811;1080.5515710980012;20134.29529966444;21125.78874211269;21192.682109768364;21275.36173914785;21387;943.7734943613483;987.8172538080478;990.5988074829705;1034.7516596017051;1069.2889228663007;10153.695389138338;11221.66335009951;11226.607068752555;11464.942675286737;11503.482343294572;537987;548144;549424;554971;558797;89259;90558.09441905496;91085;93195.53402232945;93323;1033.7260625934134;1050.3067975136526;1070.6895000449938;1080.6163811846682;1082.1937656445841;18582.721259181395;19205.32781352702;19371.709424358927;19524.316648917218;19621;32811.50782738213;44939.55060449484;45463.09073818571;45595.77202113968;45999.77000114978;62776.37223627705;64554.35445645671;64685.67657161684;65385.34614653792;65848.67075664591;8859.468431894107;8884.822303554021;9156.359054866361;9166.22087122602;9322.813543728951;13534.058579068043;13654.180749155083;13723.931380343434;13792.379342929391;14171;11521;12028.63914082579;12203.450844711831;12598.496060157491;12601.495940162658;11457.713557161138;11899.524019039487;12084.45619947122;12298.877011229773;12409.689757756129;12451.501939922302;12482.687932801753;12511.311877846805;12545.811812822998;12642.810357844824;7814.257645523666;8381.706640267561;8875.28997680171;9156.26749860023;9189.540522973959;12112.939435302767;12246.632601021984;12277.508899643914;12286.38568071575;12333.444994975427 23:34:50 INFO - PROCESS | 7671 | |3;mootools.html;1506.8417816129306;1537.262114185191;1659.6847397879958;1758.507617866996;1810.3030333321676;7542.81142971426;8536.103709110539;8631.74104776856;9238.769030774225;9265.629374825015;8602.268807151384;8847.778805529864;8875.423097498659;8926.910730892689;8936.463812171274;2399.7240317363508;2448.5225381050614;2450.215930902112;2451.264620613809;2461.507698460306;2398.6162214045758;2417.178159425795;2445.608702607583;2454.4968281502247;2455.0302630460956;2387.5344307859973;2394.2577800881695;2408.5303365843665;2444.278937713379;2446.156076153733;2332.941676458085;2338.918137865175;2342.9882850585723;2371.1582388252095;2397.280815755284;2326.278853555403;2353.8352315337934;2357.4106473381653;2357.7877990980724;2366.325597204788;9060.229880460169;9067.319951003701;9080.818383632357;9110.180083792491;9148.634054637807;5349.4650534946195;5402.594805389572;5465.562754979592;5486.725663716798;5488.259085023511;3439.1574064354145;3446.569673585459;3487.5814902211896;3506.877259295938;3529.75291729579;1218.8842060004285;1236.9960663724823;1246;1262.1606631590073;1293.4890718166366;11883.465244064038;11967.1622986391;11971.700707482296;12031.157818952677;12119.091068169922;4420.425344705168;4703.2004559225015;4772.665913386029;4780.163471392562;4786.0667169901535;10147.441890695934;10180.23648226386;10194.031567001122;10200.132988696045;10233.334833235816;5243.737813109329;5268.078086334876;5287.07476191665;5304.946950530522;5310.256564081032;4287.721298115613;4867.099586576494;5002.124628190052;5099.745012749348;5131.79472821083;4065.016667158319;4135.421041054255;4141.233871733739;4164.8542301019925;4222.894427639334;1325.8796317112026;1375.3192169875977;1379.4413262628652;1380.5789234283438;1388;1009.6668099527138;1022.928395012342;1039.298473530364;1045.1586472889396;1045.2839804733783;6165.229346331708;6172.506199504029;6191.535634827406;6311.905321420182;6325.683715814283;471.7947692753663;474.7317765462503;475.9714417134983;479.7553247843625;489.4664815351284;4357.564243575617;4376.715513491613;4420.469543654782;4462;4465.955340446619;10218.233632477593;10589.682309530726;10715.624953126759;10737.78524429507;10752.247342686092;10878.782424351468;11249.325040497597;11255.099592032619;11261.549538018551;11265.94367028176;8384.203500667427;8546.188112129337;8574.82850343002;8579.798828164063;8620.353473489387;6173.536984726254;6428.839279018062;6443.226812782496;6444.645544495098;6561.540692151503;10287.43419111956;10429.895701043197;10440.63457778974;10518.211134165122;10627.468626568487;10795.40625265618;10839.729006774895;10864.239503234698;10882.61910833117;10932.234743568191;7365.963170184329;7449.8882516761205;7472.701091956478;7476.775696729107;7480.925190748023;8465.407421480437;8471.534065626449;8512.74461766148;8514.276286515715;8557.44376615518;7368.263173682589;7383.778486645409;7574.166841647304;7818.140004599603;7994.5203287802915;7460.66427010775;7637;7640.541567505968;7670.7698769037015;7705.1909549496495;7050.471214658818;7185.784426467214;7212.386947109554;7230.987661727468;7241.710331586678;5199.610029247746;5267.552258058108;5283.920741188962;5291.894162116659;5623.465770751772;5554.166874968625;5590.524805391425;5655.095184770417;5707.571932105026;5759.769609215585 23:34:50 INFO - PROCESS | 7671 | |4;prototype.html;320.1563879178364;333.7630282499425;339.09123548888965;340.2582370432457;342.45378621099337;5372.57019438445;5458.372287186975;5554.305711786027;5570.665760054395;5604.019296623085;5503.6147469677135;5547.029269877776;5608.831735047945;5641.251212124234;5665.433456654332;4406.339049142623;4408.14041261954;4413.823447062114;4426.424564806571;4426.490953540352;4060;4235.8093885775215;4305.67707421943;4446.3997360356425;4458.79935402906;4245.320748680212;4253.532111467736;4268.231718290706;4269.530351661315;4272.743635381871;4283;4284.721493102954;4288.63546598538;4292.077203401283;4295.3771703102875;3619.873304434332;3708.8331025103935;3736.5702944161226;3737.3085979093953;3761.962380376189;5395.5953303502;5414.729263536808;5495.368032676213;5499.945000549983;5513.669179849222;4885.8778530536665;4887.680326311875;4906.681065730716;4922.704637721748;4948.67833590819;5635.549156067505;5775.306963164448;5783.36856730191;5791.797287094973;5844.386339434341;3974.3044967130636;4013.618706222904;4028.738132021409;4039.8586049488126;4091.365838295069;5888.263967004167;6099.390060993909;6102.138847651465;6110.358412366726;6131.172291740647;4214;4218.6414154797185;4222.345536441856;4229.281022226229;4252.787360632018;4301.698881078294;4313.827446902152;4315.136972605492;4330.545292744279;4344.674149438804;4923.483034281349;4933.9013219736125;4950.653454258168;4964.453910069889;5002.774875130628;5654.9151762723595;5663.943360566342;5849.970750146307;5854.5901786875365;5894.612681863852;1430.9069910455787;1462.429652435551;1464.9633759156106;1468.2805425341505;1485.3093311609937;901.8151278987792;922.8292765838207;930.6184464369576;958.6596758150756;961.274237950343;4934.5805606523845;4948.678335908155;4962.826301079445;4987.875303117451;4996.625253106032;5228.55557277628;5233.874716935801;5247.475252474798;5247.973760131251;5266.34170728659;4844.515548445198;5016.899662006739;5024.924626130611;5034.860184421606;5036.32009678696;2783.371727539412;2785;2785.9860700696368;2787.212787212787;2814.6340975673033;5372.382176049804;5380.542653874464;5407.918881216785;5420.701861397661;5456.6903943053385;5120.897582048338;5219.530242278213;5280.841574752763;5302.197252934021;5325.520703136736;5346.492083252085;5346.812861549827;5401.945980540223;5402.9473347558505;5426.674399535961;5282.8943421132135;5308.840734777963;5311.336082989626;5329.866753331198;5333.719907222317;4835.371401717754;5126.820831208917;5150.97424512875;5168.433780691311;5198.870028249324;5360.731963401892;5362.919556206738;5387.2727181831515;5388.245645609696;5403.918941215964;3796.335641262823;3811.7903515306925;3835.980820095882;3848.3265428550453;3883.3980732986433;5028.429020658321;5218.469042514302;5237.816676416307;5843.94156058434;5893.616914900518;5852.356240813592;5855.3559108497175;5879.559033072451;5882.49998750111;5895.9115613266695;5881.147848159462;5928.132638218947;5940.881182376242;5956.702164891652;5958.778450417741;5672.829815105553;5844.3571207168025;5855.560832937632;5866.735996880066;5867.149263356704;5913.5564832636865;5914.166608351425;5919.230500034968;5922.763089476372;5941.37615550361;5623.100303951348;5641.379448260606;5758.078707406795;5764.769409223584;5812.604974805931 23:34:50 INFO - PROCESS | 7671 | |5;yui.html;765.3303359560384;767.7696690992705;784.9986850527715;839.617973821911;883.2095274729115;13712.24582647954;14620.4882829101;14671.559853204408;14815.629609259773;14872.702545949089;14760.409583616642;15289.923550382233;15440.61398465039;15473.226338683076;15538.456154034611;792.8612492813763;824.8391563645091;837;837.3636036612188;837.7403005068448;834.0825092398344;842.9578521073953;847.0428415890067;849.5539841583187;851.3572252949045;888.3026823943206;891.3270480787029;891.6299735609714;892.8214357128568;894.4320356573558;878.2973621103156;883.8585826267798;884.385352180235;886.3441053620306;888.4669198480924;652.8563715982476;653.0302500786329;653.1052458132389;653.6633633678659;653.9901901471482;13520.797188042186;13522.797158042637;13531.661708457268;13611.251381174032;13619.387127579283;15395.692086158215;15495.147766872817;15528.844711552852;15553.455629052929;15820.683586328325;13069.934650326783;13105.14816536922;13158.746681674918;13177.407016684176;13204.933975330061;3856.633619806114;3858.4212368145004;3919.6276353746634;3941.940870886939;4063.512378514597;92138;92259;92611;92845;94908;11950.462229199708;12054.698632534082;12061.819072713917;12137.575184868663;12285.815712764315;22799.544009119723;22899.31302060941;22973.310800675674;23110.3066907993;23153.768462315496;8597.957010214908;8608;8630.5253211074;8646.221840034426;8979.057198994142;4719.174144524694;4753.691010084333;4815.085133824562;4855.223164293696;4879.2925025871045;3403;3486.75592708513;3493.161641206092;3543.8759643412873;3544.362014837354;576.5042063825107;583.1194895707428;584.2871696530226;600.3516202501288;613.8250598579473;667.6346870649534;721.0950257426896;722.9385502232263;738.3908275672484;760.9771706848803;8999.550022498848;9139;9524.619015239452;9556.614290927915;9827.115559599528;555.4279092534696;561.3684604819578;681.3970632185005;704.242938840738;738.9298016688406;4420.336949457607;4753.762311884392;4804.879878003008;4808.855734327975;4853.95146048542;66843.33156668469;70148;70262.64868675623;70399.64800175966;90556.54721726349;62388;94990.52504737432;96576;96631.51684241534;97121;78880.21119788843;85988;87716;88022.55988720016;93150.53424732832;9933.65232216869;10224.846627300745;10692.786144277226;10713.89286107129;10737.409442480426;50094.24858627051;50264;51518;51701.22448163356;52926;77919.61040194763;79301;79525;79781.60109199416;80595.59702201451;13464.394102265225;13533.188008719508;13601.727965440437;13643.979893082469;13875.098118622258;15216.391344346544;15366.769498457308;15710.293036813142;16186.838131618533;16233.269502872636;14352.712945740817;14725.55823325302;15071.773923391378;15131.54605361841;15652.843471565138;13670.248136352597;13808.171509709047;14273.214973176575;14434.855651443351;14520.709585808014;14425.567232983027;14433.35049922777;14876.404943802127;15048.531613956236;15097.39610415615;10782.460876956278;10813.621523246964;10848.186386020921;11020.944895275472;11128;11035.779284414428;12049.397530123633;12172.39138043112;12310.630681079581;12325.445354958869 23:34:50 INFO - PROCESS | 7671 | __end_tp_report 23:34:50 INFO - PROCESS | 7671 | __start_cc_report 23:34:50 INFO - PROCESS | 7671 | _x_x_mozilla_cycle_collect,338 23:34:50 INFO - PROCESS | 7671 | __end_cc_report 23:34:50 INFO - PROCESS | 7671 | __startTimestamp1470983690864__endTimestamp 23:34:50 INFO - PROCESS | 7671 | 23:34:50 INFO - PROCESS | 7671 | ------- Summary: start ------- 23:34:50 INFO - PROCESS | 7671 | Number of tests: 6 23:34:50 INFO - PROCESS | 7671 | 23:34:50 INFO - PROCESS | 7671 | [#0] dojo.html Cycles:165 Average:5475.86 Median:5739.05 stddev:631.95 (11.0%) stddev-sans-first:605.50 23:34:50 INFO - PROCESS | 7671 | Values: 3088.5 3088.8 3119.7 3128.5 3136.4 5422.1 5444.5 5451.5 5480.6 5505.8 5476.2 5540.0 5544.9 5563.3 5584.5 4926.0 5002.4 5019.3 5129.9 5165.6 5088.2 5152.3 5156.8 5159.0 5170.3 4908.4 4931.9 5012.0 5021.8 5065.0 4980.0 4984.8 4987.8 4999.9 5035.2 4940.0 4959.6 4985.5 4996.1 5037.5 5325.0 5433.6 5453.5 5468.3 5529.4 5837.7 5849.5 5857.0 5871.1 5884.2 5904.0 5908.1 5908.6 5914.1 5929.0 5338.6 5462.3 5496.7 5524.9 5594.2 6081.4 6082.2 6100.5 6114.6 6125.1 5822.6 5828.1 5841.9 5843.9 5849.9 5734.1 5774.8 5835.4 5847.3 5924.8 5830.6 5872.3 5885.1 5891.1 5894.4 5823.4 5854.6 5856.2 5856.3 5861.2 4405.2 4406.6 4426.6 4460.0 4512.2 3966.4 3987.7 3996.4 4018.1 4023.2 5583.4 5583.9 5586.7 5587.6 5593.2 5778.9 5815.4 5832.5 5852.2 5901.7 5588.2 5600.2 5631.2 5638.5 5640.4 5054.7 5074.9 5084.8 5089.5 5128.9 5945.7 5948.4 5970.6 6018.2 6063.5 5862.4 5873.7 5875.0 5875.9 5886.4 5948.9 5986.8 5995.3 6022.3 6029.9 5779.6 5822.7 5833.4 5858.2 5907.3 5937.1 5969.8 5971.2 5991.9 6002.2 5739.1 5837.2 5855.0 5857.1 5863.7 5770.7 5796.3 5818.0 5837.9 5868.3 5802.1 5810.9 5823.2 5828.9 5848.0 5689.3 5828.2 5837.1 5858.8 5878.2 5657.3 5700.4 5718.7 5721.3 5732.9 23:34:50 INFO - PROCESS | 7671 | 23:34:50 INFO - PROCESS | 7671 | [#1] ext.html Cycles:180 Average:64811.40 Median:22743.10 stddev:148417.94 (652.6%) stddev-sans-first:148755.85 23:34:50 INFO - PROCESS | 7671 | Values: 542.6 570.6 576.4 605.9 628.7 39557.6 43378.3 43470.6 43680.3 43686.1 43386.6 43947.6 43955.3 43968.8 43986.3 8796.0 8903.0 8913.9 8982.6 8983.4 8854.1 8892.7 8912.4 8915.9 8920.7 8843.0 8922.8 8991.8 8992.4 9001.8 8849.8 8865.3 8891.2 8894.3 8904.3 8728.2 8798.3 8798.6 8803.0 8816.0 40870.2 41435.4 41533.6 41613.0 41713.2 2762.3 3316.3 3362.3 3488.4 3530.2 28619.0 30508.0 31643.0 32121.2 32433.8 4132.2 4173.3 4272.4 4317.1 4350.4 317047.0 318959.0 320370.0 320524.0 320992.0 35475.0 35628.3 35656.6 35680.1 35759.6 36500.8 36689.8 36707.0 37366.6 37851.8 15881.3 16032.4 16079.0 16124.0 16205.7 11502.3 11572.9 11573.0 11587.8 11619.5 19281.7 19346.5 19368.2 19420.1 19484.1 7054.7 7128.0 7195.3 7268.7 7475.4 941.4 988.4 1059.0 1085.8 1112.8 32064.8 32704.7 32963.3 33125.7 33312.7 1137.6 1137.7 1145.2 1154.9 1183.0 16861.4 16865.4 17091.8 17156.5 17450.1 587894.0 832812.0 851034.0 852472.0 856955.0 59741.1 60451.1 60547.7 60693.0 61113.7 1355.6 1373.8 1381.8 1387.3 1387.7 31895.7 34423.5 34734.7 34801.5 34802.8 51038.7 51451.5 51499.7 51548.5 51586.5 400230.0 402158.0 403222.0 403746.0 405028.0 28689.6 29480.0 29514.4 29635.9 29814.7 49267.5 49656.8 50037.5 50917.5 51703.2 41354.0 42557.8 43143.0 43202.0 44801.6 42502.8 42526.4 43119.4 43666.8 44219.6 42573.4 42857.4 44383.8 44501.3 44541.1 34429.5 37846.0 38179.0 38837.0 38889.4 28644.7 28745.6 29109.7 29311.0 29363.4 23:34:50 INFO - PROCESS | 7671 | 23:34:50 INFO - PROCESS | 7671 | [#2] jquery.html Cycles:180 Average:31386.11 Median:2376.73 stddev:90536.68 (3809.3%) stddev-sans-first:90760.73 23:34:50 INFO - PROCESS | 7671 | Values: 381.7 391.0 403.8 406.7 420.5 13838.9 18583.3 19698.9 20391.1 20537.1 19484.7 19641.9 19870.7 20082.6 20257.5 5953.5 5962.5 6052.6 6069.5 6098.5 5972.9 5996.5 5996.7 6011.2 6033.2 5895.5 5967.9 5985.9 6017.8 6019.1 5872.9 5896.3 5901.6 5933.6 5973.8 5328.9 5338.0 5347.7 5368.4 5368.9 15599.9 22103.8 22959.5 23117.5 24265.9 2352.6 2400.9 2511.6 2524.9 2765.2 10599.9 10685.3 10719.2 10735.0 11402.1 1841.6 1864.4 1895.7 1947.7 1979.1 87501.0 89075.0 89590.0 91474.5 92809.5 11437.3 11451.3 11644.6 11666.2 11804.2 16211.4 16229.7 16238.6 16240.7 16261.5 7851.2 8154.7 8204.3 8449.3 8460.9 7655.4 7704.8 7766.0 7982.0 7992.3 4833.3 4856.5 4885.8 4927.3 4945.0 2014.2 2052.2 2071.4 2102.2 2114.1 882.9 1000.7 1010.9 1025.8 1080.6 20134.3 21125.8 21192.7 21275.4 21387.0 943.8 987.8 990.6 1034.8 1069.3 10153.7 11221.7 11226.6 11464.9 11503.5 537987.0 548144.0 549424.0 554971.0 558797.0 89259.0 90558.1 91085.0 93195.5 93323.0 1033.7 1050.3 1070.7 1080.6 1082.2 18582.7 19205.3 19371.7 19524.3 19621.0 32811.5 44939.6 45463.1 45595.8 45999.8 62776.4 64554.4 64685.7 65385.3 65848.7 8859.5 8884.8 9156.4 9166.2 9322.8 13534.1 13654.2 13723.9 13792.4 14171.0 11521.0 12028.6 12203.5 12598.5 12601.5 11457.7 11899.5 12084.5 12298.9 12409.7 12451.5 12482.7 12511.3 12545.8 12642.8 7814.3 8381.7 8875.3 9156.3 9189.5 12112.9 12246.6 12277.5 12286.4 12333.4 23:34:50 INFO - PROCESS | 7671 | 23:34:50 INFO - PROCESS | 7671 | [#3] mootools.html Cycles:180 Average:5904.23 Median:4463.98 stddev:3306.27 (74.1%) stddev-sans-first:3299.03 23:34:50 INFO - PROCESS | 7671 | Values: 1506.8 1537.3 1659.7 1758.5 1810.3 7542.8 8536.1 8631.7 9238.8 9265.6 8602.3 8847.8 8875.4 8926.9 8936.5 2399.7 2448.5 2450.2 2451.3 2461.5 2398.6 2417.2 2445.6 2454.5 2455.0 2387.5 2394.3 2408.5 2444.3 2446.2 2332.9 2338.9 2343.0 2371.2 2397.3 2326.3 2353.8 2357.4 2357.8 2366.3 9060.2 9067.3 9080.8 9110.2 9148.6 5349.5 5402.6 5465.6 5486.7 5488.3 3439.2 3446.6 3487.6 3506.9 3529.8 1218.9 1237.0 1246.0 1262.2 1293.5 11883.5 11967.2 11971.7 12031.2 12119.1 4420.4 4703.2 4772.7 4780.2 4786.1 10147.4 10180.2 10194.0 10200.1 10233.3 5243.7 5268.1 5287.1 5304.9 5310.3 4287.7 4867.1 5002.1 5099.7 5131.8 4065.0 4135.4 4141.2 4164.9 4222.9 1325.9 1375.3 1379.4 1380.6 1388.0 1009.7 1022.9 1039.3 1045.2 1045.3 6165.2 6172.5 6191.5 6311.9 6325.7 471.8 474.7 476.0 479.8 489.5 4357.6 4376.7 4420.5 4462.0 4466.0 10218.2 10589.7 10715.6 10737.8 10752.2 10878.8 11249.3 11255.1 11261.5 11265.9 8384.2 8546.2 8574.8 8579.8 8620.4 6173.5 6428.8 6443.2 6444.6 6561.5 10287.4 10429.9 10440.6 10518.2 10627.5 10795.4 10839.7 10864.2 10882.6 10932.2 7366.0 7449.9 7472.7 7476.8 7480.9 8465.4 8471.5 8512.7 8514.3 8557.4 7368.3 7383.8 7574.2 7818.1 7994.5 7460.7 7637.0 7640.5 7670.8 7705.2 7050.5 7185.8 7212.4 7231.0 7241.7 5199.6 5267.6 5283.9 5291.9 5623.5 5554.2 5590.5 5655.1 5707.6 5759.8 23:34:50 INFO - PROCESS | 7671 | 23:34:50 INFO - PROCESS | 7671 | [#4] prototype.html Cycles:180 Average:4686.61 Median:5235.85 stddev:1368.15 (26.1%) stddev-sans-first:1332.16 23:34:50 INFO - PROCESS | 7671 | Values: 320.2 333.8 339.1 340.3 342.5 5372.6 5458.4 5554.3 5570.7 5604.0 5503.6 5547.0 5608.8 5641.3 5665.4 4406.3 4408.1 4413.8 4426.4 4426.5 4060.0 4235.8 4305.7 4446.4 4458.8 4245.3 4253.5 4268.2 4269.5 4272.7 4283.0 4284.7 4288.6 4292.1 4295.4 3619.9 3708.8 3736.6 3737.3 3762.0 5395.6 5414.7 5495.4 5499.9 5513.7 4885.9 4887.7 4906.7 4922.7 4948.7 5635.5 5775.3 5783.4 5791.8 5844.4 3974.3 4013.6 4028.7 4039.9 4091.4 5888.3 6099.4 6102.1 6110.4 6131.2 4214.0 4218.6 4222.3 4229.3 4252.8 4301.7 4313.8 4315.1 4330.5 4344.7 4923.5 4933.9 4950.7 4964.5 5002.8 5654.9 5663.9 5850.0 5854.6 5894.6 1430.9 1462.4 1465.0 1468.3 1485.3 901.8 922.8 930.6 958.7 961.3 4934.6 4948.7 4962.8 4987.9 4996.6 5228.6 5233.9 5247.5 5248.0 5266.3 4844.5 5016.9 5024.9 5034.9 5036.3 2783.4 2785.0 2786.0 2787.2 2814.6 5372.4 5380.5 5407.9 5420.7 5456.7 5120.9 5219.5 5280.8 5302.2 5325.5 5346.5 5346.8 5401.9 5402.9 5426.7 5282.9 5308.8 5311.3 5329.9 5333.7 4835.4 5126.8 5151.0 5168.4 5198.9 5360.7 5362.9 5387.3 5388.2 5403.9 3796.3 3811.8 3836.0 3848.3 3883.4 5028.4 5218.5 5237.8 5843.9 5893.6 5852.4 5855.4 5879.6 5882.5 5895.9 5881.1 5928.1 5940.9 5956.7 5958.8 5672.8 5844.4 5855.6 5866.7 5867.1 5913.6 5914.2 5919.2 5922.8 5941.4 5623.1 5641.4 5758.1 5764.8 5812.6 23:34:50 INFO - PROCESS | 7671 | 23:34:50 INFO - PROCESS | 7671 | [#5] yui.html Cycles:180 Average:20259.89 Median:4834.52 stddev:27697.32 (572.9%) stddev-sans-first:27736.34 23:34:50 INFO - PROCESS | 7671 | Values: 765.3 767.8 785.0 839.6 883.2 13712.2 14620.5 14671.6 14815.6 14872.7 14760.4 15289.9 15440.6 15473.2 15538.5 792.9 824.8 837.0 837.4 837.7 834.1 843.0 847.0 849.6 851.4 888.3 891.3 891.6 892.8 894.4 878.3 883.9 884.4 886.3 888.5 652.9 653.0 653.1 653.7 654.0 13520.8 13522.8 13531.7 13611.3 13619.4 15395.7 15495.1 15528.8 15553.5 15820.7 13069.9 13105.1 13158.7 13177.4 13204.9 3856.6 3858.4 3919.6 3941.9 4063.5 92138.0 92259.0 92611.0 92845.0 94908.0 11950.5 12054.7 12061.8 12137.6 12285.8 22799.5 22899.3 22973.3 23110.3 23153.8 8598.0 8608.0 8630.5 8646.2 8979.1 4719.2 4753.7 4815.1 4855.2 4879.3 3403.0 3486.8 3493.2 3543.9 3544.4 576.5 583.1 584.3 600.4 613.8 667.6 721.1 722.9 738.4 761.0 8999.6 9139.0 9524.6 9556.6 9827.1 555.4 561.4 681.4 704.2 738.9 4420.3 4753.8 4804.9 4808.9 4854.0 66843.3 70148.0 70262.6 70399.6 90556.5 62388.0 94990.5 96576.0 96631.5 97121.0 78880.2 85988.0 87716.0 88022.6 93150.5 9933.7 10224.8 10692.8 10713.9 10737.4 50094.2 50264.0 51518.0 51701.2 52926.0 77919.6 79301.0 79525.0 79781.6 80595.6 13464.4 13533.2 13601.7 13644.0 13875.1 15216.4 15366.8 15710.3 16186.8 16233.3 14352.7 14725.6 15071.8 15131.5 15652.8 13670.2 13808.2 14273.2 14434.9 14520.7 14425.6 14433.4 14876.4 15048.5 15097.4 10782.5 10813.6 10848.2 11020.9 11128.0 11035.8 12049.4 12172.4 12310.6 12325.4 23:34:50 INFO - PROCESS | 7671 | -------- Summary: end -------- 23:34:50 INFO - PROCESS | 7671 | 23:34:51 INFO - TEST-INFO | 7671: exit 0 23:34:51 INFO - TEST-OK | dromaeo_css | took 1115027ms 23:34:51 INFO - TEST-START | kraken 23:34:51 INFO - operating with platform_type : linux_ 23:34:51 INFO - Initialising browser for kraken test... 23:34:51 INFO - TEST-INFO | started process 7918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6byMtu/profile http://localhost:36927/getInfo.html) 23:34:57 INFO - PROCESS | 7918 | __metrics Screen width/height:1600/1200 23:34:57 INFO - PROCESS | 7918 | colorDepth:24 23:34:57 INFO - PROCESS | 7918 | Browser inner width/height: 1024/697 23:34:57 INFO - PROCESS | 7918 | __metrics 23:34:58 ERROR - PROCESS | 7918 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2983: TypeError: this.tabs is undefined 23:34:59 INFO - TEST-INFO | 7918: exit 0 23:34:59 INFO - Browser initialized. 23:34:59 INFO - Running cycle 1/1 for kraken test... 23:34:59 INFO - TEST-INFO | started process 8037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6byMtu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:35:10 INFO - PROCESS | 8037 | RSS: Main: 162934784 23:35:10 INFO - PROCESS | 8037 | 23:35:13 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36927/tests/kraken/driver.html?testName=audio-beat-detection) 23:35:14 INFO - PROCESS | 8037 | RSS: Main: 168099840 23:35:14 INFO - PROCESS | 8037 | 23:35:17 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36927/tests/kraken/driver.html?testName=audio-dft) 23:35:17 INFO - PROCESS | 8037 | RSS: Main: 166981632 23:35:17 INFO - PROCESS | 8037 | 23:35:20 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36927/tests/kraken/driver.html?testName=audio-fft) 23:35:21 INFO - PROCESS | 8037 | RSS: Main: 162717696 23:35:21 INFO - PROCESS | 8037 | 23:35:23 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36927/tests/kraken/driver.html?testName=audio-oscillator) 23:35:23 INFO - PROCESS | 8037 | RSS: Main: 163762176 23:35:23 INFO - PROCESS | 8037 | 23:35:26 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36927/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:35:26 INFO - PROCESS | 8037 | RSS: Main: 164036608 23:35:26 INFO - PROCESS | 8037 | 23:35:29 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36927/tests/kraken/driver.html?testName=imaging-darkroom) 23:35:30 INFO - PROCESS | 8037 | RSS: Main: 164237312 23:35:30 INFO - PROCESS | 8037 | 23:35:34 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36927/tests/kraken/driver.html?testName=imaging-desaturate) 23:35:34 INFO - PROCESS | 8037 | RSS: Main: 162209792 23:35:34 INFO - PROCESS | 8037 | 23:35:37 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36927/tests/kraken/driver.html?testName=json-parse-financial) 23:35:38 INFO - PROCESS | 8037 | RSS: Main: 163188736 23:35:38 INFO - PROCESS | 8037 | 23:35:39 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36927/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:35:40 INFO - PROCESS | 8037 | RSS: Main: 163696640 23:35:40 INFO - PROCESS | 8037 | 23:35:42 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:35:42 INFO - PROCESS | 8037 | RSS: Main: 163962880 23:35:42 INFO - PROCESS | 8037 | 23:35:44 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:35:45 INFO - PROCESS | 8037 | RSS: Main: 164216832 23:35:45 INFO - PROCESS | 8037 | 23:35:48 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:35:48 INFO - PROCESS | 8037 | RSS: Main: 164007936 23:35:48 INFO - PROCESS | 8037 | 23:35:51 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:35:52 INFO - PROCESS | 8037 | RSS: Main: 164397056 23:35:52 INFO - PROCESS | 8037 | 23:35:53 INFO - PROCESS | 8037 | Cycle 1(1): loaded http://localhost:36927/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36927/tests/kraken/driver.html?testName=ai-astar) 23:35:54 INFO - PROCESS | 8037 | RSS: Main: 165289984 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | __start_tp_report 23:35:54 INFO - PROCESS | 8037 | _x_x_mozilla_page_load 23:35:54 INFO - PROCESS | 8037 | _x_x_mozilla_page_load_details 23:35:54 INFO - PROCESS | 8037 | |i|pagename|runs| 23:35:54 INFO - PROCESS | 8037 | |0;ai-astar;105;115;107;112;114;113;113;112;111;112 23:35:54 INFO - PROCESS | 8037 | |1;audio-beat-detection;153;118;147;169;124;150;144;126;175;120 23:35:54 INFO - PROCESS | 8037 | |2;audio-dft;163;164;166;169;163;166;171;165;162;165 23:35:54 INFO - PROCESS | 8037 | |3;audio-fft;75;76;76;178;76;76;78;99;158;78 23:35:54 INFO - PROCESS | 8037 | |4;audio-oscillator;84;84;154;84;84;84;140;89;87;155 23:35:54 INFO - PROCESS | 8037 | |5;imaging-gaussian-blur;117;117;117;118;116;117;119;117;117;117 23:35:54 INFO - PROCESS | 8037 | |6;imaging-darkroom;150;148;148;148;147;147;146;148;147;154 23:35:54 INFO - PROCESS | 8037 | |7;imaging-desaturate;97;96;96;96;96;96;98;96;96;96 23:35:54 INFO - PROCESS | 8037 | |8;json-parse-financial;50;52;52;52;51;51;54;52;51;51 23:35:54 INFO - PROCESS | 8037 | |9;json-stringify-tinderbox;62;61;61;61;62;61;61;64;63;62 23:35:54 INFO - PROCESS | 8037 | |10;stanford-crypto-aes;76;79;78;76;76;77;76;75;81;82 23:35:54 INFO - PROCESS | 8037 | |11;stanford-crypto-ccm;134;135;124;130;145;141;123;136;140;129 23:35:54 INFO - PROCESS | 8037 | |12;stanford-crypto-pbkdf2;163;161;160;161;166;162;161;162;158;156 23:35:54 INFO - PROCESS | 8037 | |13;stanford-crypto-sha256-iterative;66;66;66;66;63;63;64;63;64;64 23:35:54 INFO - PROCESS | 8037 | __end_tp_report 23:35:54 INFO - PROCESS | 8037 | __start_cc_report 23:35:54 INFO - PROCESS | 8037 | _x_x_mozilla_cycle_collect,866 23:35:54 INFO - PROCESS | 8037 | __end_cc_report 23:35:54 INFO - PROCESS | 8037 | __startTimestamp1470983754124__endTimestamp 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | ------- Summary: start ------- 23:35:54 INFO - PROCESS | 8037 | Number of tests: 14 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.10 (2.8%) stddev-sans-first:2.26 23:35:54 INFO - PROCESS | 8037 | Values: 105.0 115.0 107.0 112.0 114.0 113.0 113.0 112.0 111.0 112.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:148.50 stddev:20.19 (13.6%) stddev-sans-first:21.06 23:35:54 INFO - PROCESS | 8037 | Values: 153.0 118.0 147.0 169.0 124.0 150.0 144.0 126.0 175.0 120.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.50 stddev:2.80 (1.7%) stddev-sans-first:2.83 23:35:54 INFO - PROCESS | 8037 | Values: 163.0 164.0 166.0 169.0 163.0 166.0 171.0 165.0 162.0 165.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#3] audio-fft Cycles:10 Average:97.00 Median:76.00 stddev:38.38 (50.5%) stddev-sans-first:39.87 23:35:54 INFO - PROCESS | 8037 | Values: 75.0 76.0 76.0 178.0 76.0 76.0 78.0 99.0 158.0 78.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#4] audio-oscillator Cycles:10 Average:104.50 Median:84.00 stddev:31.46 (37.5%) stddev-sans-first:32.48 23:35:54 INFO - PROCESS | 8037 | Values: 84.0 84.0 154.0 84.0 84.0 84.0 140.0 89.0 87.0 155.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 23:35:54 INFO - PROCESS | 8037 | Values: 117.0 117.0 117.0 118.0 116.0 117.0 119.0 117.0 117.0 117.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#6] imaging-darkroom Cycles:10 Average:148.30 Median:148.00 stddev:2.26 (1.5%) stddev-sans-first:2.32 23:35:54 INFO - PROCESS | 8037 | Values: 150.0 148.0 148.0 148.0 147.0 147.0 146.0 148.0 147.0 154.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 23:35:54 INFO - PROCESS | 8037 | Values: 97.0 96.0 96.0 96.0 96.0 96.0 98.0 96.0 96.0 96.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.07 (2.1%) stddev-sans-first:0.97 23:35:54 INFO - PROCESS | 8037 | Values: 50.0 52.0 52.0 52.0 51.0 51.0 54.0 52.0 51.0 51.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#9] json-stringify-tinderbox Cycles:10 Average:61.80 Median:62.00 stddev:1.03 (1.7%) stddev-sans-first:1.09 23:35:54 INFO - PROCESS | 8037 | Values: 62.0 61.0 61.0 61.0 62.0 61.0 61.0 64.0 63.0 62.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#10] stanford-crypto-aes Cycles:10 Average:77.60 Median:77.50 stddev:2.37 (3.1%) stddev-sans-first:2.44 23:35:54 INFO - PROCESS | 8037 | Values: 76.0 79.0 78.0 76.0 76.0 77.0 76.0 75.0 81.0 82.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#11] stanford-crypto-ccm Cycles:10 Average:133.70 Median:135.50 stddev:7.24 (5.3%) stddev-sans-first:7.68 23:35:54 INFO - PROCESS | 8037 | Values: 134.0 135.0 124.0 130.0 145.0 141.0 123.0 136.0 140.0 129.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.50 stddev:2.71 (1.7%) stddev-sans-first:2.77 23:35:54 INFO - PROCESS | 8037 | Values: 163.0 161.0 160.0 161.0 166.0 162.0 161.0 162.0 158.0 156.0 23:35:54 INFO - PROCESS | 8037 | 23:35:54 INFO - PROCESS | 8037 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.50 Median:65.00 stddev:1.35 (2.1%) stddev-sans-first:1.32 23:35:54 INFO - PROCESS | 8037 | Values: 66.0 66.0 66.0 66.0 63.0 63.0 64.0 63.0 64.0 64.0 23:35:54 INFO - PROCESS | 8037 | -------- Summary: end -------- 23:35:54 INFO - PROCESS | 8037 | 23:35:55 INFO - TEST-INFO | 8037: exit 0 23:35:55 INFO - TEST-OK | kraken | took 63430ms 23:35:55 INFO - SUITE-END | took 1178s 23:35:55 INFO - Completed test suite (00:19:38) 23:35:55 INFO - javascript benchmark 23:35:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7349.509248286216, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3088.474959256926, 3088.768342374322, 3119.7192252697255, 3128.4681604127295, 3136.4354416205074, 5422.105352616818, 5444.50999410053, 5451.454854514546, 5480.561555075595, 5505.834824955247, 5476.151196564539, 5540.030494663428, 5544.889102217953, 5563.332400111982, 5584.5253153482, 4926.0394223126505, 5002.374703162105, 5019.322391477159, 5129.9230511542355, 5165.6131731623955, 5088.211327244265, 5152.330197074375, 5156.793728250866, 5158.9742051289695, 5170.327857378536, 4908.410990681124, 4931.90136197274, 5011.974940125312, 5021.824236151735, 5065.037642847884, 4979.97910428365, 4984.825531106394, 4987.775550100254, 4999.850004499871, 5035.244713292998, 4939.950600493985, 4959.603231741452, 4985.52637499437, 4996.100701873661, 5037.5214354636255, 5324.988252232102, 5433.6196466247375, 5453.509184173444, 5468.316460442445, 5529.391766905637, 5837.737301821428, 5849.473547380756, 5857.0, 5871.1193321001765, 5884.176215329857, 5903.970480147572, 5908.14331921869, 5908.615939963888, 5914.142449344864, 5928.97035514824, 5338.62629615927, 5462.317210348707, 5496.6701997880655, 5524.889502210013, 5594.1888426177975, 6081.422264884829, 6082.209312789398, 6100.542459315569, 6114.57197996136, 6125.081237814275, 5822.592418530662, 5828.12578113278, 5841.912371314434, 5843.941560584425, 5849.941500585025, 5734.111212762028, 5774.82675519735, 5835.387284335168, 5847.26909136358, 5924.822255332347, 5830.562707796932, 5872.29532456108, 5885.146653735184, 5891.116332550066, 5894.351621321651, 5823.4467725566, 5854.619449735754, 5856.1508581255475, 5856.267966504187, 5861.238039054895, 4405.229084910192, 4406.647468202536, 4426.623736982328, 4460.018795864905, 4512.165249428866, 3966.424868394067, 3987.6809855211513, 3996.4205190247253, 4018.0758425562285, 4023.195360927826, 5583.357913839879, 5583.916241256385, 5586.748596313176, 5587.636803607834, 5593.216949627055, 5778.942210577925, 5815.389384114692, 5832.475077243069, 5852.209951656472, 5901.734421951022, 5588.217649528988, 5600.215969764236, 5631.18347839561, 5638.520725738276, 5640.379558248589, 5054.721990290495, 5074.949250507521, 5084.7966081356335, 5089.51649593288, 5128.897422051538, 5945.672987985616, 5948.375420580864, 5970.552208584287, 6018.187544681412, 6063.484603808549, 5862.413758624103, 5873.706314684334, 5874.970625146847, 5875.882482350415, 5886.381929897299, 5948.851278718067, 5986.760529578768, 5995.340512543704, 6022.277326720821, 6029.909551356821, 5779.624324418899, 5822.650640961556, 5833.358330583547, 5858.209141765807, 5907.32065812437, 5937.079752638348, 5969.820905372846, 5971.164037034731, 5991.910121348271, 6002.189704389852, 5739.053056245672, 5837.241158649348, 5855.0, 5857.121431785266, 5863.706814659336, 5770.653760774367, 5796.304443466811, 5818.0, 5837.854053648693, 5868.3251426086545, 5802.071668533014, 5810.854728631818, 5823.18475413451, 5828.883422331614, 5848.0350742127075, 5689.31728192603, 5828.242328497268, 5837.066069428871, 5858.8242352729485, 5878.2064421302575, 5657.321121465286, 5700.372958974593, 5718.656880587178, 5721.284839395075, 5732.856678583069], "value": 5431.710747249728, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.569807908366, 570.592026700909, 576.4149388370802, 605.8667093239488, 628.7453581299575, 39557.60442395575, 43378.349324760115, 43470.56529434705, 43680.34479482802, 43686.12627747443, 43386.566134338645, 43947.56052439482, 43955.34066988998, 43968.78015609925, 43986.34020489687, 8796.032436432004, 8902.955485222597, 8913.910860891372, 8982.595783189772, 8983.416077954944, 8854.07032261613, 8892.73321800347, 8912.376133670645, 8915.866262006075, 8920.73237802867, 8843.0, 8922.821543569125, 8991.820163596723, 8992.415492992966, 9001.77495562613, 8849.823003539925, 8865.290776737846, 8891.24424423928, 8894.288456923496, 8904.287656987457, 8728.214460698504, 8798.29613630908, 8798.604062817189, 8802.955985220096, 8816.0, 40870.182596347906, 41435.37846932298, 41533.584664153575, 41613.0, 41713.1657366851, 2762.2541913683394, 3316.286998295354, 3362.2771104212466, 3488.372093023255, 3530.2409981853766, 28619.0, 30508.0, 31643.0, 32121.196970075936, 32433.83783081093, 4132.194222126656, 4173.3114036184, 4272.401863739079, 4317.07182955666, 4350.434443522322, 317047.0, 318959.0, 320370.0, 320524.0, 320992.0, 35475.0, 35628.28743425117, 35656.64343356585, 35680.10799730028, 35759.64240357563, 36500.81749591235, 36689.81655091707, 36707.0, 37366.62633373686, 37851.810740946115, 15881.28534215963, 16032.438864639915, 16079.0, 16124.032558046554, 16205.675886482204, 11502.309861408343, 11572.94213528927, 11573.0, 11587.768244635061, 11619.477123529461, 19281.710774338397, 19346.516337091405, 19368.225270989285, 19420.126094325788, 19484.07738839157, 7054.6825392857445, 7127.96436017827, 7195.316444937723, 7268.709251629875, 7475.36459400957, 941.4163218804385, 988.3575675810637, 1059.0196332857606, 1085.777415629794, 1112.7718817642365, 32064.83967580147, 32704.67295327016, 32963.3407331852, 33125.66874331274, 33312.666873331444, 1137.590467431724, 1137.7440075982838, 1145.2155273637584, 1154.8556430446195, 1182.9526818927147, 16861.409850655415, 16865.409710660315, 17091.829081709024, 17156.485305440856, 17450.12749362552, 587894.0, 832812.0, 851034.0, 852472.0, 856955.0, 59741.103883441785, 60451.09323360153, 60547.69726151341, 60693.0, 61113.69443152756, 1355.5526676196832, 1373.7527245095778, 1381.8410882748412, 1387.3271463340272, 1387.6947071644424, 31895.68104318927, 34423.483647744804, 34734.65265347314, 34801.47797783086, 34802.82598586991, 51038.74480627573, 51451.485485146164, 51499.742501287255, 51548.48451515437, 51586.48413515817, 400230.0, 402158.0, 403222.0, 403746.0, 405028.0, 28689.569656455587, 29480.0, 29514.409711806074, 29635.851820740758, 29814.701852981194, 49267.50732492629, 49656.75171624263, 50037.499625003285, 50917.49082509128, 51703.22445163401, 41354.0, 42557.78721106375, 43143.0, 43202.0, 44801.55198448104, 42502.78748606237, 42526.362104569074, 43119.35320970251, 43666.781666092735, 44219.55780442154, 42573.36139957965, 42857.35713964231, 44383.77808110939, 44501.33248001347, 44541.10917781561, 34429.5241618598, 37846.0, 38179.0, 38837.0, 38889.416658750706, 28644.713552864203, 28745.56881646819, 29109.7089029107, 29311.0, 29363.412731745673], "value": 19823.26210874347, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.7060863135386, 390.96090390960927, 403.7880112940706, 406.7396866005757, 420.5437100745693, 13838.854977478482, 18583.349582764607, 19698.90150549249, 20391.08240129194, 20537.075831587597, 19484.707729384034, 19641.90179049106, 19870.701939470884, 20082.598348033032, 20257.493562660904, 5953.523718102563, 5962.493188079007, 6052.636841789485, 6069.484093852028, 6098.481629061513, 5972.88054238915, 5996.4902983246475, 5996.700164991733, 6011.218541589587, 6033.185519954815, 5895.469407753301, 5967.880642387149, 5985.88028239435, 6017.849553761169, 6019.067044608071, 5872.9119063213875, 5896.292444906596, 5901.586888917777, 5933.554983376264, 5973.820785376424, 5328.893422131575, 5337.973310133463, 5347.732613369355, 5368.382635996872, 5368.865778355534, 15599.92200039004, 22103.778962210334, 22959.507632003868, 23117.53764924709, 24265.878670606533, 2352.6118190498546, 2400.8559486430872, 2511.623256511538, 2524.861132637704, 2765.225736793701, 10599.947000265027, 10685.252032357737, 10719.19606029551, 10735.0, 11402.144839137098, 1841.5672317005492, 1864.4313484387255, 1895.7440745499318, 1947.737055497504, 1979.1094007696595, 87501.0, 89075.0, 89590.0, 91474.5426272871, 92809.53595232048, 11437.313761174357, 11451.312921224753, 11644.592439264754, 11666.241694289844, 11804.17370784054, 16211.35154593803, 16229.675406491804, 16238.594035149215, 16240.675186496204, 16261.51215463538, 7851.175626559129, 8154.714584989497, 8204.302634276033, 8449.32405407566, 8460.8730869037, 7655.425843061793, 7704.807379815437, 7766.0, 7981.960090199512, 7992.280694737386, 4833.32333473314, 4856.490068542752, 4885.780139893714, 4927.334809800703, 4945.0, 2014.1943222711034, 2052.209899188823, 2071.440711008019, 2102.16964299101, 2114.09094089543, 882.8896387951506, 1000.7197984564334, 1010.8584798128268, 1025.789713108811, 1080.5515710980012, 20134.29529966444, 21125.78874211269, 21192.682109768364, 21275.36173914785, 21387.0, 943.7734943613483, 987.8172538080478, 990.5988074829705, 1034.7516596017051, 1069.2889228663007, 10153.695389138338, 11221.66335009951, 11226.607068752555, 11464.942675286737, 11503.482343294572, 537987.0, 548144.0, 549424.0, 554971.0, 558797.0, 89259.0, 90558.09441905496, 91085.0, 93195.53402232945, 93323.0, 1033.7260625934134, 1050.3067975136526, 1070.6895000449938, 1080.6163811846682, 1082.1937656445841, 18582.721259181395, 19205.32781352702, 19371.709424358927, 19524.316648917218, 19621.0, 32811.50782738213, 44939.55060449484, 45463.09073818571, 45595.77202113968, 45999.77000114978, 62776.37223627705, 64554.35445645671, 64685.67657161684, 65385.34614653792, 65848.67075664591, 8859.468431894107, 8884.822303554021, 9156.359054866361, 9166.22087122602, 9322.813543728951, 13534.058579068043, 13654.180749155083, 13723.931380343434, 13792.379342929391, 14171.0, 11521.0, 12028.63914082579, 12203.450844711831, 12598.496060157491, 12601.495940162658, 11457.713557161138, 11899.524019039487, 12084.45619947122, 12298.877011229773, 12409.689757756129, 12451.501939922302, 12482.687932801753, 12511.311877846805, 12545.811812822998, 12642.810357844824, 7814.257645523666, 8381.706640267561, 8875.28997680171, 9156.26749860023, 9189.540522973959, 12112.939435302767, 12246.632601021984, 12277.508899643914, 12286.38568071575, 12333.444994975427], "value": 9572.35485471608, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1506.8417816129306, 1537.262114185191, 1659.6847397879958, 1758.507617866996, 1810.3030333321676, 7542.81142971426, 8536.103709110539, 8631.74104776856, 9238.769030774225, 9265.629374825015, 8602.268807151384, 8847.778805529864, 8875.423097498659, 8926.910730892689, 8936.463812171274, 2399.7240317363508, 2448.5225381050614, 2450.215930902112, 2451.264620613809, 2461.507698460306, 2398.6162214045758, 2417.178159425795, 2445.608702607583, 2454.4968281502247, 2455.0302630460956, 2387.5344307859973, 2394.2577800881695, 2408.5303365843665, 2444.278937713379, 2446.156076153733, 2332.941676458085, 2338.918137865175, 2342.9882850585723, 2371.1582388252095, 2397.280815755284, 2326.278853555403, 2353.8352315337934, 2357.4106473381653, 2357.7877990980724, 2366.325597204788, 9060.229880460169, 9067.319951003701, 9080.818383632357, 9110.180083792491, 9148.634054637807, 5349.4650534946195, 5402.594805389572, 5465.562754979592, 5486.725663716798, 5488.259085023511, 3439.1574064354145, 3446.569673585459, 3487.5814902211896, 3506.877259295938, 3529.75291729579, 1218.8842060004285, 1236.9960663724823, 1246.0, 1262.1606631590073, 1293.4890718166366, 11883.465244064038, 11967.1622986391, 11971.700707482296, 12031.157818952677, 12119.091068169922, 4420.425344705168, 4703.2004559225015, 4772.665913386029, 4780.163471392562, 4786.0667169901535, 10147.441890695934, 10180.23648226386, 10194.031567001122, 10200.132988696045, 10233.334833235816, 5243.737813109329, 5268.078086334876, 5287.07476191665, 5304.946950530522, 5310.256564081032, 4287.721298115613, 4867.099586576494, 5002.124628190052, 5099.745012749348, 5131.79472821083, 4065.016667158319, 4135.421041054255, 4141.233871733739, 4164.8542301019925, 4222.894427639334, 1325.8796317112026, 1375.3192169875977, 1379.4413262628652, 1380.5789234283438, 1388.0, 1009.6668099527138, 1022.928395012342, 1039.298473530364, 1045.1586472889396, 1045.2839804733783, 6165.229346331708, 6172.506199504029, 6191.535634827406, 6311.905321420182, 6325.683715814283, 471.7947692753663, 474.7317765462503, 475.9714417134983, 479.7553247843625, 489.4664815351284, 4357.564243575617, 4376.715513491613, 4420.469543654782, 4462.0, 4465.955340446619, 10218.233632477593, 10589.682309530726, 10715.624953126759, 10737.78524429507, 10752.247342686092, 10878.782424351468, 11249.325040497597, 11255.099592032619, 11261.549538018551, 11265.94367028176, 8384.203500667427, 8546.188112129337, 8574.82850343002, 8579.798828164063, 8620.353473489387, 6173.536984726254, 6428.839279018062, 6443.226812782496, 6444.645544495098, 6561.540692151503, 10287.43419111956, 10429.895701043197, 10440.63457778974, 10518.211134165122, 10627.468626568487, 10795.40625265618, 10839.729006774895, 10864.239503234698, 10882.61910833117, 10932.234743568191, 7365.963170184329, 7449.8882516761205, 7472.701091956478, 7476.775696729107, 7480.925190748023, 8465.407421480437, 8471.534065626449, 8512.74461766148, 8514.276286515715, 8557.44376615518, 7368.263173682589, 7383.778486645409, 7574.166841647304, 7818.140004599603, 7994.5203287802915, 7460.66427010775, 7637.0, 7640.541567505968, 7670.7698769037015, 7705.1909549496495, 7050.471214658818, 7185.784426467214, 7212.386947109554, 7230.987661727468, 7241.710331586678, 5199.610029247746, 5267.552258058108, 5283.920741188962, 5291.894162116659, 5623.465770751772, 5554.166874968625, 5590.524805391425, 5655.095184770417, 5707.571932105026, 5759.769609215585], "value": 4690.808533701964, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.1563879178364, 333.7630282499425, 339.09123548888965, 340.2582370432457, 342.45378621099337, 5372.57019438445, 5458.372287186975, 5554.305711786027, 5570.665760054395, 5604.019296623085, 5503.6147469677135, 5547.029269877776, 5608.831735047945, 5641.251212124234, 5665.433456654332, 4406.339049142623, 4408.14041261954, 4413.823447062114, 4426.424564806571, 4426.490953540352, 4060.0, 4235.8093885775215, 4305.67707421943, 4446.3997360356425, 4458.79935402906, 4245.320748680212, 4253.532111467736, 4268.231718290706, 4269.530351661315, 4272.743635381871, 4283.0, 4284.721493102954, 4288.63546598538, 4292.077203401283, 4295.3771703102875, 3619.873304434332, 3708.8331025103935, 3736.5702944161226, 3737.3085979093953, 3761.962380376189, 5395.5953303502, 5414.729263536808, 5495.368032676213, 5499.945000549983, 5513.669179849222, 4885.8778530536665, 4887.680326311875, 4906.681065730716, 4922.704637721748, 4948.67833590819, 5635.549156067505, 5775.306963164448, 5783.36856730191, 5791.797287094973, 5844.386339434341, 3974.3044967130636, 4013.618706222904, 4028.738132021409, 4039.8586049488126, 4091.365838295069, 5888.263967004167, 6099.390060993909, 6102.138847651465, 6110.358412366726, 6131.172291740647, 4214.0, 4218.6414154797185, 4222.345536441856, 4229.281022226229, 4252.787360632018, 4301.698881078294, 4313.827446902152, 4315.136972605492, 4330.545292744279, 4344.674149438804, 4923.483034281349, 4933.9013219736125, 4950.653454258168, 4964.453910069889, 5002.774875130628, 5654.9151762723595, 5663.943360566342, 5849.970750146307, 5854.5901786875365, 5894.612681863852, 1430.9069910455787, 1462.429652435551, 1464.9633759156106, 1468.2805425341505, 1485.3093311609937, 901.8151278987792, 922.8292765838207, 930.6184464369576, 958.6596758150756, 961.274237950343, 4934.5805606523845, 4948.678335908155, 4962.826301079445, 4987.875303117451, 4996.625253106032, 5228.55557277628, 5233.874716935801, 5247.475252474798, 5247.973760131251, 5266.34170728659, 4844.515548445198, 5016.899662006739, 5024.924626130611, 5034.860184421606, 5036.32009678696, 2783.371727539412, 2785.0, 2785.9860700696368, 2787.212787212787, 2814.6340975673033, 5372.382176049804, 5380.542653874464, 5407.918881216785, 5420.701861397661, 5456.6903943053385, 5120.897582048338, 5219.530242278213, 5280.841574752763, 5302.197252934021, 5325.520703136736, 5346.492083252085, 5346.812861549827, 5401.945980540223, 5402.9473347558505, 5426.674399535961, 5282.8943421132135, 5308.840734777963, 5311.336082989626, 5329.866753331198, 5333.719907222317, 4835.371401717754, 5126.820831208917, 5150.97424512875, 5168.433780691311, 5198.870028249324, 5360.731963401892, 5362.919556206738, 5387.2727181831515, 5388.245645609696, 5403.918941215964, 3796.335641262823, 3811.7903515306925, 3835.980820095882, 3848.3265428550453, 3883.3980732986433, 5028.429020658321, 5218.469042514302, 5237.816676416307, 5843.94156058434, 5893.616914900518, 5852.356240813592, 5855.3559108497175, 5879.559033072451, 5882.49998750111, 5895.9115613266695, 5881.147848159462, 5928.132638218947, 5940.881182376242, 5956.702164891652, 5958.778450417741, 5672.829815105553, 5844.3571207168025, 5855.560832937632, 5866.735996880066, 5867.149263356704, 5913.5564832636865, 5914.166608351425, 5919.230500034968, 5922.763089476372, 5941.37615550361, 5623.100303951348, 5641.379448260606, 5758.078707406795, 5764.769409223584, 5812.604974805931], "value": 4250.174489299646, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.3303359560384, 767.7696690992705, 784.9986850527715, 839.617973821911, 883.2095274729115, 13712.24582647954, 14620.4882829101, 14671.559853204408, 14815.629609259773, 14872.702545949089, 14760.409583616642, 15289.923550382233, 15440.61398465039, 15473.226338683076, 15538.456154034611, 792.8612492813763, 824.8391563645091, 837.0, 837.3636036612188, 837.7403005068448, 834.0825092398344, 842.9578521073953, 847.0428415890067, 849.5539841583187, 851.3572252949045, 888.3026823943206, 891.3270480787029, 891.6299735609714, 892.8214357128568, 894.4320356573558, 878.2973621103156, 883.8585826267798, 884.385352180235, 886.3441053620306, 888.4669198480924, 652.8563715982476, 653.0302500786329, 653.1052458132389, 653.6633633678659, 653.9901901471482, 13520.797188042186, 13522.797158042637, 13531.661708457268, 13611.251381174032, 13619.387127579283, 15395.692086158215, 15495.147766872817, 15528.844711552852, 15553.455629052929, 15820.683586328325, 13069.934650326783, 13105.14816536922, 13158.746681674918, 13177.407016684176, 13204.933975330061, 3856.633619806114, 3858.4212368145004, 3919.6276353746634, 3941.940870886939, 4063.512378514597, 92138.0, 92259.0, 92611.0, 92845.0, 94908.0, 11950.462229199708, 12054.698632534082, 12061.819072713917, 12137.575184868663, 12285.815712764315, 22799.544009119723, 22899.31302060941, 22973.310800675674, 23110.3066907993, 23153.768462315496, 8597.957010214908, 8608.0, 8630.5253211074, 8646.221840034426, 8979.057198994142, 4719.174144524694, 4753.691010084333, 4815.085133824562, 4855.223164293696, 4879.2925025871045, 3403.0, 3486.75592708513, 3493.161641206092, 3543.8759643412873, 3544.362014837354, 576.5042063825107, 583.1194895707428, 584.2871696530226, 600.3516202501288, 613.8250598579473, 667.6346870649534, 721.0950257426896, 722.9385502232263, 738.3908275672484, 760.9771706848803, 8999.550022498848, 9139.0, 9524.619015239452, 9556.614290927915, 9827.115559599528, 555.4279092534696, 561.3684604819578, 681.3970632185005, 704.242938840738, 738.9298016688406, 4420.336949457607, 4753.762311884392, 4804.879878003008, 4808.855734327975, 4853.95146048542, 66843.33156668469, 70148.0, 70262.64868675623, 70399.64800175966, 90556.54721726349, 62388.0, 94990.52504737432, 96576.0, 96631.51684241534, 97121.0, 78880.21119788843, 85988.0, 87716.0, 88022.55988720016, 93150.53424732832, 9933.65232216869, 10224.846627300745, 10692.786144277226, 10713.89286107129, 10737.409442480426, 50094.24858627051, 50264.0, 51518.0, 51701.22448163356, 52926.0, 77919.61040194763, 79301.0, 79525.0, 79781.60109199416, 80595.59702201451, 13464.394102265225, 13533.188008719508, 13601.727965440437, 13643.979893082469, 13875.098118622258, 15216.391344346544, 15366.769498457308, 15710.293036813142, 16186.838131618533, 16233.269502872636, 14352.712945740817, 14725.55823325302, 15071.773923391378, 15131.54605361841, 15652.843471565138, 13670.248136352597, 13808.171509709047, 14273.214973176575, 14434.855651443351, 14520.709585808014, 14425.567232983027, 14433.35049922777, 14876.404943802127, 15048.531613956236, 15097.39610415615, 10782.460876956278, 10813.621523246964, 10848.186386020921, 11020.944895275472, 11128.0, 11035.779284414428, 12049.397530123633, 12172.39138043112, 12310.630681079581, 12325.445354958869], "value": 7668.686057580129, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 107.0, 112.0, 114.0, 113.0, 113.0, 112.0, 111.0, 112.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 118.0, 147.0, 169.0, 124.0, 150.0, 144.0, 126.0, 175.0, 120.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 166.0, 169.0, 163.0, 166.0, 171.0, 165.0, 162.0, 165.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 178.0, 76.0, 76.0, 78.0, 99.0, 158.0, 78.0], "value": 97.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 154.0, 84.0, 84.0, 84.0, 140.0, 89.0, 87.0, 155.0], "value": 104.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 116.0, 117.0, 119.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 148.0, 148.0, 148.0, 147.0, 147.0, 146.0, 148.0, 147.0, 154.0], "value": 148.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 52.0, 52.0, 51.0, 51.0, 54.0, 52.0, 51.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 64.0, 63.0, 62.0], "value": 61.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 79.0, 78.0, 76.0, 76.0, 77.0, 76.0, 75.0, 81.0, 82.0], "value": 77.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 124.0, 130.0, 145.0, 141.0, 123.0, 136.0, 140.0, 129.0], "value": 133.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 166.0, 162.0, 161.0, 162.0, 158.0, 156.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 63.0, 63.0, 64.0, 63.0, 64.0, 64.0], "value": 64.5, "unit": "score"}]}]} 23:35:55 INFO - Return code: 0 23:35:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:35:55 ERROR - # TBPL SUCCESS # 23:35:55 INFO - Running post-action listener: _resource_record_post_action 23:35:55 INFO - [mozharness: 2016-08-12 06:35:55.410951Z] Finished run-tests step (success) 23:35:55 INFO - Running post-run listener: _resource_record_post_run 23:35:55 INFO - Total resource usage - Wall time: 1198s; CPU: 14.0%; Read bytes: 4096; Write bytes: 555073536; Read time: 16; Write time: 2264640 23:35:55 INFO - TinderboxPrint: CPU usage
13.6% 23:35:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 23:35:55 INFO - TinderboxPrint: I/O write bytes / time
555,073,536 / 2,264,640 23:35:55 INFO - TinderboxPrint: CPU idle
8,255.0 (86.4%) 23:35:55 INFO - TinderboxPrint: CPU user
1,220.8 (12.8%) 23:35:55 INFO - TinderboxPrint: Swap in / out
0 / 0 23:35:55 INFO - install - Wall time: 18s; CPU: 20.0%; Read bytes: 0; Write bytes: 235540480; Read time: 0; Write time: 1157776 23:35:55 INFO - run-tests - Wall time: 1181s; CPU: 14.0%; Read bytes: 4096; Write bytes: 295960576; Read time: 16; Write time: 855640 23:35:56 INFO - Running post-run listener: _upload_blobber_files 23:35:56 INFO - Blob upload gear active. 23:35:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:35:56 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 23:35:56 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:35:56 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:35:56 INFO - (blobuploader) - INFO - Open directory for files ... 23:35:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:35:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:35:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:36:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:01 INFO - (blobuploader) - INFO - Done attempting. 23:36:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:36:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:36:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:02 INFO - (blobuploader) - INFO - Done attempting. 23:36:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:36:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:36:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:36:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:36:03 INFO - (blobuploader) - INFO - Done attempting. 23:36:03 INFO - (blobuploader) - INFO - Iteration through files over. 23:36:03 INFO - Return code: 0 23:36:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:36:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:36:03 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1652938b188d56afa16598af368bebf70f46c2ea51ab65331988642d2d7b1162d729b9cbd3399c360f2ad366fc54efa7aa4d43f326c69b9d28c3256885e281c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6550cdbd883438c881f1253d25053d75adc09de1dfae65fe8101c64df4bd0c04c0e2ffe9538d911ea0c6357cb5d9bc068cf3fc08952cd0dcf8bd07aea56818b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff038c60e24e55799f40a84defab91806bf60dfa0fb47ba14b6a884725ba6cc2fd42affcc4faf751fd670362761946563e9acb2c3b53b54694899a879d1be796"} 23:36:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:36:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:36:03 INFO - Contents: 23:36:03 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1652938b188d56afa16598af368bebf70f46c2ea51ab65331988642d2d7b1162d729b9cbd3399c360f2ad366fc54efa7aa4d43f326c69b9d28c3256885e281c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6550cdbd883438c881f1253d25053d75adc09de1dfae65fe8101c64df4bd0c04c0e2ffe9538d911ea0c6357cb5d9bc068cf3fc08952cd0dcf8bd07aea56818b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff038c60e24e55799f40a84defab91806bf60dfa0fb47ba14b6a884725ba6cc2fd42affcc4faf751fd670362761946563e9acb2c3b53b54694899a879d1be796"} 23:36:03 INFO - Running post-run listener: copy_logs_to_upload_dir 23:36:03 INFO - Copying logs to upload dir... 23:36:03 INFO - mkdir: /builds/slave/test/build/upload/logs 23:36:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.897510 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-08-11 23:36:03.001020) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 23:36:03.004655) ========= 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=df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368 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/sha512/1652938b188d56afa16598af368bebf70f46c2ea51ab65331988642d2d7b1162d729b9cbd3399c360f2ad366fc54efa7aa4d43f326c69b9d28c3256885e281c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6550cdbd883438c881f1253d25053d75adc09de1dfae65fe8101c64df4bd0c04c0e2ffe9538d911ea0c6357cb5d9bc068cf3fc08952cd0dcf8bd07aea56818b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff038c60e24e55799f40a84defab91806bf60dfa0fb47ba14b6a884725ba6cc2fd42affcc4faf751fd670362761946563e9acb2c3b53b54694899a879d1be796"} build_url:https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011215 build_url: 'https://queue.taskcluster.net/v1/task/B0lIsAr4QtqXUxLgMKyZKg/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1652938b188d56afa16598af368bebf70f46c2ea51ab65331988642d2d7b1162d729b9cbd3399c360f2ad366fc54efa7aa4d43f326c69b9d28c3256885e281c0", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6550cdbd883438c881f1253d25053d75adc09de1dfae65fe8101c64df4bd0c04c0e2ffe9538d911ea0c6357cb5d9bc068cf3fc08952cd0dcf8bd07aea56818b3", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ff038c60e24e55799f40a84defab91806bf60dfa0fb47ba14b6a884725ba6cc2fd42affcc4faf751fd670362761946563e9acb2c3b53b54694899a879d1be796"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-11 23:36:03.030658) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:36:03.030983) ========= 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=df17445c3590ff7897617a0e00000225-1470981579.642274-1355519368 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004529 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-11 23:36:03.113053) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 23:36:03.113376) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-11 23:36:03.113672) ========= ========= Total master_lag: 0.17 =========