builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1469129690.19 results: success (0) buildid: 20160721083037 builduid: 4990d6435e6d4ffd826392cf6e9b3247 revision: f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:50.192997) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:50.193428) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:50.193731) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:50.205012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:50.205287) ========= 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=00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 12:34:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 34.3M=0s 2016-07-21 12:34:50 (34.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.111880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:50.328349) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:50.328637) ========= 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=00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018790 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:50.377927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 12:34:50.378254) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf --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 f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf --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=00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 12:34:50,397 truncating revision to first 12 chars 2016-07-21 12:34:50,397 Setting DEBUG logging. 2016-07-21 12:34:50,397 attempt 1/10 2016-07-21 12:34:50,397 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f5154aaeaec4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 12:34:51,599 unpacking tar archive at: fx-team-f5154aaeaec4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.627746 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-21 12:34:52.019357) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:52.019664) ========= script_repo_revision: f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:52.020042) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:52.020305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 12:34:52.031187) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-21 12:34:52.031469) ========= /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=00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:34:52 INFO - MultiFileLogger online at 20160721 12:34:52 in /builds/slave/test 12:34:52 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 12:34:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:34:52 INFO - {'append_to_log': False, 12:34:52 INFO - 'base_work_dir': '/builds/slave/test', 12:34:52 INFO - 'blob_upload_branch': 'Fx-Team', 12:34:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:34:52 INFO - 'branch': 'Fx-Team', 12:34:52 INFO - 'buildbot_json_path': 'buildprops.json', 12:34:52 INFO - 'config_files': ('talos/linux_config.py',), 12:34:52 INFO - 'default_actions': ('clobber', 12:34:52 INFO - 'read-buildbot-config', 12:34:52 INFO - 'download-and-extract', 12:34:52 INFO - 'populate-webroot', 12:34:52 INFO - 'create-virtualenv', 12:34:52 INFO - 'install', 12:34:52 INFO - 'run-tests'), 12:34:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:34:52 INFO - 'download_minidump_stackwalk': True, 12:34:52 INFO - 'download_symbols': 'ondemand', 12:34:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:34:52 INFO - 'tooltool.py': '/tools/tooltool.py', 12:34:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:34:52 INFO - '/tools/misc-python/virtualenv.py')}, 12:34:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:34:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:34:52 INFO - 'installer_path': 'installer.exe', 12:34:52 INFO - 'log_level': 'info', 12:34:52 INFO - 'log_name': 'talos', 12:34:52 INFO - 'log_to_console': True, 12:34:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:34:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:34:52 INFO - 'opt_config_files': (), 12:34:52 INFO - 'pip_index': False, 12:34:52 INFO - 'sps_profile': False, 12:34:52 INFO - 'sps_profile_interval': 0, 12:34:52 INFO - 'suite': 'dromaeojs-e10s', 12:34:52 INFO - 'system_bits': '32', 12:34:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:34:52 INFO - 'title': 'talos-linux64-ix-016', 12:34:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:34:52 INFO - 'use_talos_json': True, 12:34:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:34:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:34:52 INFO - 'work_dir': 'build'} 12:34:52 INFO - [mozharness: 2016-07-21 19:34:52.149255Z] Running clobber step. 12:34:52 INFO - Running pre-action listener: _resource_record_pre_action 12:34:52 INFO - Running main action method: clobber 12:34:52 INFO - rmtree: /builds/slave/test/build 12:34:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:34:52 INFO - Running post-action listener: _resource_record_post_action 12:34:52 INFO - [mozharness: 2016-07-21 19:34:52.615263Z] Finished clobber step (success) 12:34:52 INFO - [mozharness: 2016-07-21 19:34:52.615364Z] Running read-buildbot-config step. 12:34:52 INFO - Running pre-action listener: _resource_record_pre_action 12:34:52 INFO - Running main action method: read_buildbot_config 12:34:52 INFO - Using buildbot properties: 12:34:52 INFO - { 12:34:52 INFO - "project": "", 12:34:52 INFO - "product": "firefox", 12:34:52 INFO - "script_repo_revision": "production", 12:34:52 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:34:52 INFO - "repository": "", 12:34:52 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:34:52 INFO - "buildid": "20160721083037", 12:34:52 INFO - "pgo_build": "True", 12:34:52 INFO - "basedir": "/builds/slave/test", 12:34:52 INFO - "buildnumber": 962, 12:34:52 INFO - "slavename": "talos-linux64-ix-016", 12:34:52 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:34:52 INFO - "platform": "ubuntu64_hw", 12:34:52 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:34:52 INFO - "branch": "fx-team", 12:34:52 INFO - "repo_path": "integration/fx-team", 12:34:52 INFO - "revision": "f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf", 12:34:52 INFO - "stage_platform": "linux64-pgo", 12:34:52 INFO - "builduid": "4990d6435e6d4ffd826392cf6e9b3247", 12:34:52 INFO - "slavebuilddir": "test" 12:34:52 INFO - } 12:34:52 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 12:34:52 INFO - Running post-action listener: _resource_record_post_action 12:34:52 INFO - [mozharness: 2016-07-21 19:34:52.617781Z] Finished read-buildbot-config step (success) 12:34:52 INFO - [mozharness: 2016-07-21 19:34:52.617870Z] Running download-and-extract step. 12:34:52 INFO - Running pre-action listener: _resource_record_pre_action 12:34:52 INFO - Running main action method: download_and_extract 12:34:52 INFO - mkdir: /builds/slave/test/build/tests 12:34:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:52 INFO - https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 12:34:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:34:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:34:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:34:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:34:54 INFO - Downloaded 1361 bytes. 12:34:54 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 12:34:54 INFO - Using the following test package requirements: 12:34:54 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:34:54 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:34:54 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:34:54 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:54 INFO - u'jsshell-linux-x86_64.zip'], 12:34:54 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:34:54 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 12:34:54 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:34:54 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:34:54 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:34:54 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 12:34:54 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:34:54 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:34:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:54 INFO - https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:34:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:34:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:34:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:34:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:34:55 INFO - Downloaded 24306908 bytes. 12:34:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:34:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:34:56 INFO - Return code: 0 12:34:56 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:34: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:56 INFO - https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:34:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:34:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:34:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 12:34:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:34:58 INFO - Downloaded 24306908 bytes. 12:34:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:34:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 12:34:59 INFO - Return code: 0 12:34:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:34:59 INFO - https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:34:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:34:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:34:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 12:34:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:35:01 INFO - Downloaded 14403317 bytes. 12:35:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 12:35:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 12:35:01 INFO - Return code: 0 12:35:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:01 INFO - https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:35:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:35:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:35:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:35:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:35:06 INFO - Downloaded 60857818 bytes. 12:35:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:35:06 INFO - mkdir: /builds/slave/test/properties 12:35:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:35:06 INFO - Writing to file /builds/slave/test/properties/build_url 12:35:06 INFO - Contents: 12:35:06 INFO - build_url:https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 12:35:07 INFO - Running post-action listener: _resource_record_post_action 12:35:07 INFO - Running post-action listener: set_extra_try_arguments 12:35:07 INFO - [mozharness: 2016-07-21 19:35:07.348817Z] Finished download-and-extract step (success) 12:35:07 INFO - [mozharness: 2016-07-21 19:35:07.349051Z] Running populate-webroot step. 12:35:07 INFO - Running pre-action listener: _resource_record_pre_action 12:35:07 INFO - Running main action method: populate_webroot 12:35:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:35:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:35:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:35:07 INFO - '--tppagecycles', 12:35:07 INFO - '7'], 12:35:07 INFO - 'tests': ['tsvgm']}}, 12:35:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:35:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:35:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:35:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:35:07 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:07 INFO - 'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:35:07 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:35:07 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:07 INFO - 'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['damp', 'tps']}, 12:35:07 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:07 INFO - 'tests': ['damp', 'tps']}, 12:35:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['dromaeo_dom']}, 12:35:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:35:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['basic_compositor_video']}, 12:35:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:35:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['a11yr', 12:35:07 INFO - 'ts_paint', 12:35:07 INFO - 'tpaint', 12:35:07 INFO - 'sessionrestore', 12:35:07 INFO - 'sessionrestore_no_auto_restore', 12:35:07 INFO - 'tabpaint']}, 12:35:07 INFO - 'other-e10s': {'tests': ['a11yr', 12:35:07 INFO - 'ts_paint', 12:35:07 INFO - 'tpaint', 12:35:07 INFO - 'sessionrestore', 12:35:07 INFO - 'sessionrestore_no_auto_restore', 12:35:07 INFO - 'tabpaint']}, 12:35:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:35:07 INFO - 'ts_paint', 12:35:07 INFO - 'tpaint', 12:35:07 INFO - 'sessionrestore', 12:35:07 INFO - 'sessionrestore_no_auto_restore', 12:35:07 INFO - 'tabpaint']}, 12:35:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:35:07 INFO - 'ts_paint', 12:35:07 INFO - 'tpaint', 12:35:07 INFO - 'sessionrestore', 12:35:07 INFO - 'sessionrestore_no_auto_restore', 12:35:07 INFO - 'tabpaint']}, 12:35:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['a11yr', 12:35:07 INFO - 'ts_paint', 12:35:07 INFO - 'tpaint', 12:35:07 INFO - 'sessionrestore', 12:35:07 INFO - 'sessionrestore_no_auto_restore', 12:35:07 INFO - 'tabpaint']}, 12:35:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['a11yr', 12:35:07 INFO - 'ts_paint', 12:35:07 INFO - 'tpaint', 12:35:07 INFO - 'sessionrestore', 12:35:07 INFO - 'sessionrestore_no_auto_restore', 12:35:07 INFO - 'tabpaint']}, 12:35:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['tsvgx', 12:35:07 INFO - 'tsvgr_opacity', 12:35:07 INFO - 'tart', 12:35:07 INFO - 'tscrollx', 12:35:07 INFO - 'cart']}, 12:35:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:35:07 INFO - 'tsvgr_opacity', 12:35:07 INFO - 'tart', 12:35:07 INFO - 'tscrollx', 12:35:07 INFO - 'cart']}, 12:35:07 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:07 INFO - 'talos_options': ['--disable-e10s'], 12:35:07 INFO - 'tests': ['tp5o']}, 12:35:07 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:07 INFO - 'tests': ['tp5o']}, 12:35:07 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:07 INFO - 'talos_options': ['--disable-e10s', 12:35:07 INFO - '--xperf_path', 12:35:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:35:07 INFO - 'tests': ['tp5n']}, 12:35:07 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:35:07 INFO - 'talos_options': ['--xperf_path', 12:35:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:35:07 INFO - 'tests': ['tp5n']}}, 12:35:07 INFO - 'talos.zip': {'path': '', 12:35:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:35:07 INFO - Running post-action listener: _resource_record_post_action 12:35:07 INFO - [mozharness: 2016-07-21 19:35:07.365090Z] Finished populate-webroot step (success) 12:35:07 INFO - [mozharness: 2016-07-21 19:35:07.365178Z] Running create-virtualenv step. 12:35:07 INFO - Running pre-action listener: _resource_record_pre_action 12:35:07 INFO - Running main action method: create_virtualenv 12:35:07 INFO - Creating virtualenv /builds/slave/test/build/venv 12:35:07 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 12:35:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:35:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:35:07 INFO - Using real prefix '/usr' 12:35:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:35:07 INFO - Installing distribute.............................................................................................................................................................................................done. 12:35:09 INFO - Installing pip.................done. 12:35:09 INFO - Return code: 0 12:35:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:09 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 0xd8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d3b0>, '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 0x104e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e740>, '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': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', '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 12:35:09 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 12:35:09 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 12:35:09 INFO - Using env: {'DISPLAY': ':0', 12:35:09 INFO - 'HOME': '/home/cltbld', 12:35:09 INFO - 'LANG': 'en_US.UTF-8', 12:35:09 INFO - 'LANGUAGE': 'en_US:en', 12:35:09 INFO - 'LOGNAME': 'cltbld', 12:35:09 INFO - 'MAIL': '/var/mail/cltbld', 12:35:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:09 INFO - 'MOZ_NO_REMOTE': '1', 12:35:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:09 INFO - 'NO_EM_RESTART': '1', 12:35:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:09 INFO - 'PWD': '/builds/slave/test', 12:35:09 INFO - 'SHELL': '/bin/bash', 12:35:09 INFO - 'SHLVL': '1', 12:35:09 INFO - 'TERM': 'linux', 12:35:09 INFO - 'TMOUT': '86400', 12:35:09 INFO - 'USER': 'cltbld', 12:35:09 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', 12:35:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:09 INFO - '_': '/tools/buildbot/bin/python'} 12:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:10 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 12:35:10 INFO - Cleaning up... 12:35:10 INFO - Return code: 0 12:35:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:10 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 0xd8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d3b0>, '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 0x104e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e740>, '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': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', '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 12:35:10 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 12:35:10 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 12:35:10 INFO - Using env: {'DISPLAY': ':0', 12:35:10 INFO - 'HOME': '/home/cltbld', 12:35:10 INFO - 'LANG': 'en_US.UTF-8', 12:35:10 INFO - 'LANGUAGE': 'en_US:en', 12:35:10 INFO - 'LOGNAME': 'cltbld', 12:35:10 INFO - 'MAIL': '/var/mail/cltbld', 12:35:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:10 INFO - 'MOZ_NO_REMOTE': '1', 12:35:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:10 INFO - 'NO_EM_RESTART': '1', 12:35:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:10 INFO - 'PWD': '/builds/slave/test', 12:35:10 INFO - 'SHELL': '/bin/bash', 12:35:10 INFO - 'SHLVL': '1', 12:35:10 INFO - 'TERM': 'linux', 12:35:10 INFO - 'TMOUT': '86400', 12:35:10 INFO - 'USER': 'cltbld', 12:35:10 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', 12:35:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:10 INFO - '_': '/tools/buildbot/bin/python'} 12:35:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:10 INFO - Downloading/unpacking psutil>=3.1.1 12:35:10 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 12:35:10 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 12:35:10 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 12:35:10 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 12:35:10 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 12:35:10 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 12:35:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:35:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:35:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:35:12 INFO - Installing collected packages: psutil 12:35:12 INFO - Running setup.py install for psutil 12:35:12 INFO - building 'psutil._psutil_linux' extension 12:35:12 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 12:35:12 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 12:35:12 INFO - building 'psutil._psutil_posix' extension 12:35:12 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 12:35:12 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 12:35:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:35:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:35:12 INFO - Successfully installed psutil 12:35:12 INFO - Cleaning up... 12:35:12 INFO - Return code: 0 12:35:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:12 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 0xd8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d3b0>, '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 0x104e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e740>, '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': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', '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 12:35:12 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 12:35:12 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 12:35:12 INFO - Using env: {'DISPLAY': ':0', 12:35:12 INFO - 'HOME': '/home/cltbld', 12:35:12 INFO - 'LANG': 'en_US.UTF-8', 12:35:12 INFO - 'LANGUAGE': 'en_US:en', 12:35:12 INFO - 'LOGNAME': 'cltbld', 12:35:12 INFO - 'MAIL': '/var/mail/cltbld', 12:35:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:12 INFO - 'MOZ_NO_REMOTE': '1', 12:35:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:12 INFO - 'NO_EM_RESTART': '1', 12:35:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:12 INFO - 'PWD': '/builds/slave/test', 12:35:12 INFO - 'SHELL': '/bin/bash', 12:35:12 INFO - 'SHLVL': '1', 12:35:12 INFO - 'TERM': 'linux', 12:35:12 INFO - 'TMOUT': '86400', 12:35:12 INFO - 'USER': 'cltbld', 12:35:12 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', 12:35:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:12 INFO - '_': '/tools/buildbot/bin/python'} 12:35:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:35:13 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 12:35:13 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 12:35:13 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 12:35:13 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 12:35:13 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 12:35:13 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 12:35:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:35:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:35:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:35:15 INFO - Installing collected packages: mozsystemmonitor 12:35:15 INFO - Running setup.py install for mozsystemmonitor 12:35:15 INFO - Successfully installed mozsystemmonitor 12:35:15 INFO - Cleaning up... 12:35:15 INFO - Return code: 0 12:35:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:15 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 0xd8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d3b0>, '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 0x104e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e740>, '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': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', '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 12:35:15 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 12:35:15 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 12:35:15 INFO - Using env: {'DISPLAY': ':0', 12:35:15 INFO - 'HOME': '/home/cltbld', 12:35:15 INFO - 'LANG': 'en_US.UTF-8', 12:35:15 INFO - 'LANGUAGE': 'en_US:en', 12:35:15 INFO - 'LOGNAME': 'cltbld', 12:35:15 INFO - 'MAIL': '/var/mail/cltbld', 12:35:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:15 INFO - 'MOZ_NO_REMOTE': '1', 12:35:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:15 INFO - 'NO_EM_RESTART': '1', 12:35:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:15 INFO - 'PWD': '/builds/slave/test', 12:35:15 INFO - 'SHELL': '/bin/bash', 12:35:15 INFO - 'SHLVL': '1', 12:35:15 INFO - 'TERM': 'linux', 12:35:15 INFO - 'TMOUT': '86400', 12:35:15 INFO - 'USER': 'cltbld', 12:35:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', 12:35:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:15 INFO - '_': '/tools/buildbot/bin/python'} 12:35:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:15 INFO - Downloading/unpacking jsonschema==2.5.1 12:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:35:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:17 INFO - Downloading functools32-3.2.3-2.tar.gz 12:35:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:35:17 INFO - warning: no files found matching '*.txt' 12:35:17 INFO - no previously-included directories found matching 'build' 12:35:17 INFO - no previously-included directories found matching 'dist' 12:35:17 INFO - no previously-included directories found matching '.git*' 12:35:17 INFO - Installing collected packages: jsonschema, functools32 12:35:17 INFO - Running setup.py install for functools32 12:35:17 INFO - warning: no files found matching '*.txt' 12:35:17 INFO - no previously-included directories found matching 'build' 12:35:17 INFO - no previously-included directories found matching 'dist' 12:35:17 INFO - no previously-included directories found matching '.git*' 12:35:17 INFO - Successfully installed jsonschema functools32 12:35:17 INFO - Cleaning up... 12:35:17 INFO - Return code: 0 12:35:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:17 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 0xd8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d3b0>, '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 0x104e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e740>, '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': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', '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 12:35:17 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 12:35:17 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 12:35:17 INFO - Using env: {'DISPLAY': ':0', 12:35:17 INFO - 'HOME': '/home/cltbld', 12:35:17 INFO - 'LANG': 'en_US.UTF-8', 12:35:17 INFO - 'LANGUAGE': 'en_US:en', 12:35:17 INFO - 'LOGNAME': 'cltbld', 12:35:17 INFO - 'MAIL': '/var/mail/cltbld', 12:35:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:17 INFO - 'MOZ_NO_REMOTE': '1', 12:35:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:17 INFO - 'NO_EM_RESTART': '1', 12:35:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:17 INFO - 'PWD': '/builds/slave/test', 12:35:17 INFO - 'SHELL': '/bin/bash', 12:35:17 INFO - 'SHLVL': '1', 12:35:17 INFO - 'TERM': 'linux', 12:35:17 INFO - 'TMOUT': '86400', 12:35:17 INFO - 'USER': 'cltbld', 12:35:17 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', 12:35:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:17 INFO - '_': '/tools/buildbot/bin/python'} 12:35:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:18 INFO - Downloading/unpacking blobuploader==1.2.4 12:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:20 INFO - Downloading blobuploader-1.2.4.tar.gz 12:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:35:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:35:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:20 INFO - Downloading docopt-0.6.1.tar.gz 12:35:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:35:20 INFO - Installing collected packages: blobuploader, requests, docopt 12:35:20 INFO - Running setup.py install for blobuploader 12:35:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:35:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:35:20 INFO - Running setup.py install for requests 12:35:21 INFO - Running setup.py install for docopt 12:35:21 INFO - Successfully installed blobuploader requests docopt 12:35:21 INFO - Cleaning up... 12:35:21 INFO - Return code: 0 12:35:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:21 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 0xd8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d3b0>, '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 0x104e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e740>, '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': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', '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 12:35:21 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 12:35:21 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 12:35:21 INFO - Using env: {'DISPLAY': ':0', 12:35:21 INFO - 'HOME': '/home/cltbld', 12:35:21 INFO - 'LANG': 'en_US.UTF-8', 12:35:21 INFO - 'LANGUAGE': 'en_US:en', 12:35:21 INFO - 'LOGNAME': 'cltbld', 12:35:21 INFO - 'MAIL': '/var/mail/cltbld', 12:35:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:21 INFO - 'MOZ_NO_REMOTE': '1', 12:35:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:21 INFO - 'NO_EM_RESTART': '1', 12:35:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:21 INFO - 'PWD': '/builds/slave/test', 12:35:21 INFO - 'SHELL': '/bin/bash', 12:35:21 INFO - 'SHLVL': '1', 12:35:21 INFO - 'TERM': 'linux', 12:35:21 INFO - 'TMOUT': '86400', 12:35:21 INFO - 'USER': 'cltbld', 12:35:21 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', 12:35:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:21 INFO - '_': '/tools/buildbot/bin/python'} 12:35:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:21 INFO - Running setup.py (path:/tmp/pip-qyXlij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:21 INFO - Running setup.py (path:/tmp/pip-7OD0Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:21 INFO - Running setup.py (path:/tmp/pip-Q26aEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:21 INFO - Running setup.py (path:/tmp/pip-jqtF3O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:21 INFO - Running setup.py (path:/tmp/pip-Kwnxzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:22 INFO - Running setup.py (path:/tmp/pip-BQDAxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:22 INFO - Running setup.py (path:/tmp/pip-WStrXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:22 INFO - Running setup.py (path:/tmp/pip-B2Am8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:22 INFO - Running setup.py (path:/tmp/pip-C6ASDS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:22 INFO - Running setup.py (path:/tmp/pip-03qsok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:22 INFO - Running setup.py (path:/tmp/pip-Sru0ll-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:22 INFO - Running setup.py (path:/tmp/pip-FPpFSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:22 INFO - Running setup.py (path:/tmp/pip-f6iG73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:22 INFO - Running setup.py (path:/tmp/pip-JC_ZvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:22 INFO - Running setup.py (path:/tmp/pip-h9nfWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:22 INFO - Running setup.py (path:/tmp/pip-9dLSd3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:22 INFO - Running setup.py (path:/tmp/pip-U1MicB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:35:22 INFO - Running setup.py install for manifestparser 12:35:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:35:22 INFO - Running setup.py install for mozcrash 12:35:23 INFO - Running setup.py install for mozdebug 12:35:23 INFO - Running setup.py install for mozdevice 12:35:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:35:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:35:23 INFO - Running setup.py install for mozfile 12:35:23 INFO - Running setup.py install for mozhttpd 12:35:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:35:23 INFO - Running setup.py install for mozinfo 12:35:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:35:23 INFO - Running setup.py install for mozInstall 12:35:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:35:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:35:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:35:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:35:23 INFO - Running setup.py install for mozleak 12:35:23 INFO - Running setup.py install for mozlog 12:35:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:35:23 INFO - Running setup.py install for moznetwork 12:35:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:35:24 INFO - Running setup.py install for mozprocess 12:35:24 INFO - Running setup.py install for mozprofile 12:35:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:35:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:35:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:35:24 INFO - Running setup.py install for mozrunner 12:35:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:35:24 INFO - Running setup.py install for mozscreenshot 12:35:24 INFO - Running setup.py install for moztest 12:35:24 INFO - Running setup.py install for mozversion 12:35:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:35:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:35:24 INFO - Cleaning up... 12:35:24 INFO - Return code: 0 12:35:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:24 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 0xd8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d3b0>, '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 0x104e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e740>, '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': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', '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 12:35:24 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 12:35:24 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 12:35:24 INFO - Using env: {'DISPLAY': ':0', 12:35:24 INFO - 'HOME': '/home/cltbld', 12:35:24 INFO - 'LANG': 'en_US.UTF-8', 12:35:24 INFO - 'LANGUAGE': 'en_US:en', 12:35:24 INFO - 'LOGNAME': 'cltbld', 12:35:24 INFO - 'MAIL': '/var/mail/cltbld', 12:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:24 INFO - 'MOZ_NO_REMOTE': '1', 12:35:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:24 INFO - 'NO_EM_RESTART': '1', 12:35:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:24 INFO - 'PWD': '/builds/slave/test', 12:35:24 INFO - 'SHELL': '/bin/bash', 12:35:24 INFO - 'SHLVL': '1', 12:35:24 INFO - 'TERM': 'linux', 12:35:24 INFO - 'TMOUT': '86400', 12:35:24 INFO - 'USER': 'cltbld', 12:35:24 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', 12:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:24 INFO - '_': '/tools/buildbot/bin/python'} 12:35:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:35:24 INFO - Running setup.py (path:/tmp/pip-MxSREb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:35:24 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:35:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:35:25 INFO - Running setup.py (path:/tmp/pip-zxPXUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:35:25 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)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:35:25 INFO - Running setup.py (path:/tmp/pip-UK8F8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:35:25 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)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:35:25 INFO - Running setup.py (path:/tmp/pip-d2vRBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:35:25 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)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:35:25 INFO - Running setup.py (path:/tmp/pip-9wG75g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:35:25 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)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:35:25 INFO - Running setup.py (path:/tmp/pip-wMwV8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:35:25 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)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:35:25 INFO - Running setup.py (path:/tmp/pip-DhKnum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:35:25 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)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:35:25 INFO - Running setup.py (path:/tmp/pip-0Mllym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:35:25 INFO - Running setup.py (path:/tmp/pip-hn6eJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:35:25 INFO - Running setup.py (path:/tmp/pip-8rG3y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:35:25 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)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:35:25 INFO - Running setup.py (path:/tmp/pip-LRdatq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:35:25 INFO - Running setup.py (path:/tmp/pip-KNwWro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:35:25 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)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:35:25 INFO - Running setup.py (path:/tmp/pip-6AX9cl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:35:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:35:25 INFO - Running setup.py (path:/tmp/pip-llUUx_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:35:25 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)) 12:35:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:25 INFO - Running setup.py (path:/tmp/pip-qOqmLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:35:26 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)) 12:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:35:26 INFO - Running setup.py (path:/tmp/pip-CbmuX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:35:26 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)) 12:35:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:35:26 INFO - Running setup.py (path:/tmp/pip-r0y9UO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:35:26 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)) 12:35:26 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)) 12:35:26 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)) 12:35:26 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)) 12:35:26 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)) 12:35:26 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)) 12:35:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:35:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:35:28 INFO - Downloading blessings-1.6.tar.gz 12:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:35:28 INFO - Installing collected packages: blessings 12:35:28 INFO - Running setup.py install for blessings 12:35:28 INFO - Successfully installed blessings 12:35:28 INFO - Cleaning up... 12:35:28 INFO - Return code: 0 12:35:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:35:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:28 INFO - Reading from file tmpfile_stdout 12:35:28 INFO - Current package versions: 12:35:28 INFO - argparse == 1.2.1 12:35:28 INFO - blessings == 1.6 12:35:28 INFO - blobuploader == 1.2.4 12:35:28 INFO - docopt == 0.6.1 12:35:28 INFO - functools32 == 3.2.3-2 12:35:28 INFO - jsonschema == 2.5.1 12:35:28 INFO - manifestparser == 1.1 12:35:28 INFO - mozInstall == 1.12 12:35:28 INFO - mozcrash == 0.17 12:35:28 INFO - mozdebug == 0.1 12:35:28 INFO - mozdevice == 0.48 12:35:28 INFO - mozfile == 1.2 12:35:28 INFO - mozhttpd == 0.7 12:35:28 INFO - mozinfo == 0.9 12:35:28 INFO - mozleak == 0.1 12:35:28 INFO - mozlog == 3.3 12:35:28 INFO - moznetwork == 0.27 12:35:28 INFO - mozprocess == 0.23 12:35:28 INFO - mozprofile == 0.28 12:35:28 INFO - mozrunner == 6.12 12:35:28 INFO - mozscreenshot == 0.1 12:35:28 INFO - mozsystemmonitor == 0.3 12:35:28 INFO - moztest == 0.7 12:35:28 INFO - mozversion == 1.4 12:35:28 INFO - psutil == 3.1.1 12:35:28 INFO - requests == 1.2.3 12:35:28 INFO - wsgiref == 0.1.2 12:35:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:28 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 0xd8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d3b0>, '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 0x104e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e740>, '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': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', '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 12:35:28 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 12:35:28 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 12:35:28 INFO - Using env: {'DISPLAY': ':0', 12:35:28 INFO - 'HOME': '/home/cltbld', 12:35:28 INFO - 'LANG': 'en_US.UTF-8', 12:35:28 INFO - 'LANGUAGE': 'en_US:en', 12:35:28 INFO - 'LOGNAME': 'cltbld', 12:35:28 INFO - 'MAIL': '/var/mail/cltbld', 12:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:28 INFO - 'MOZ_NO_REMOTE': '1', 12:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:28 INFO - 'NO_EM_RESTART': '1', 12:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:28 INFO - 'PWD': '/builds/slave/test', 12:35:28 INFO - 'SHELL': '/bin/bash', 12:35:28 INFO - 'SHLVL': '1', 12:35:28 INFO - 'TERM': 'linux', 12:35:28 INFO - 'TMOUT': '86400', 12:35:28 INFO - 'USER': 'cltbld', 12:35:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', 12:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:28 INFO - '_': '/tools/buildbot/bin/python'} 12:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:35:28 INFO - Cleaning up... 12:35:28 INFO - Return code: 0 12:35:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:28 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 0xd8e030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d3b0>, '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 0x104e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e740>, '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': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', '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 12:35:28 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 12:35:28 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 12:35:28 INFO - Using env: {'DISPLAY': ':0', 12:35:28 INFO - 'HOME': '/home/cltbld', 12:35:28 INFO - 'LANG': 'en_US.UTF-8', 12:35:28 INFO - 'LANGUAGE': 'en_US:en', 12:35:28 INFO - 'LOGNAME': 'cltbld', 12:35:28 INFO - 'MAIL': '/var/mail/cltbld', 12:35:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:28 INFO - 'MOZ_NO_REMOTE': '1', 12:35:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:28 INFO - 'NO_EM_RESTART': '1', 12:35:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:28 INFO - 'PWD': '/builds/slave/test', 12:35:28 INFO - 'SHELL': '/bin/bash', 12:35:28 INFO - 'SHLVL': '1', 12:35:28 INFO - 'TERM': 'linux', 12:35:28 INFO - 'TMOUT': '86400', 12:35:28 INFO - 'USER': 'cltbld', 12:35:28 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', 12:35:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:28 INFO - '_': '/tools/buildbot/bin/python'} 12:35:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:35:28 INFO - Cleaning up... 12:35:28 INFO - Return code: 0 12:35:28 INFO - Running post-action listener: _resource_record_post_action 12:35:28 INFO - Running post-action listener: _start_resource_monitoring 12:35:28 INFO - Starting resource monitoring. 12:35:28 INFO - [mozharness: 2016-07-21 19:35:28.981540Z] Finished create-virtualenv step (success) 12:35:28 INFO - [mozharness: 2016-07-21 19:35:28.982025Z] Running install step. 12:35:28 INFO - Running pre-action listener: _resource_record_pre_action 12:35:28 INFO - Running main action method: install 12:35:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:29 INFO - Reading from file tmpfile_stdout 12:35:29 INFO - Detecting whether we're running mozinstall >=1.0... 12:35:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:35:29 INFO - Reading from file tmpfile_stdout 12:35:29 INFO - Output received: 12:35:29 INFO - Usage: mozinstall [options] installer 12:35:29 INFO - Options: 12:35:29 INFO - -h, --help show this help message and exit 12:35:29 INFO - -d DEST, --destination=DEST 12:35:29 INFO - Directory to install application into. [default: 12:35:29 INFO - "/builds/slave/test"] 12:35:29 INFO - --app=APP Application being installed. [default: firefox] 12:35:29 INFO - mkdir: /builds/slave/test/build/application 12:35:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:35:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:35:46 INFO - Reading from file tmpfile_stdout 12:35:46 INFO - Output received: 12:35:46 INFO - /builds/slave/test/build/application/firefox/firefox 12:35:46 INFO - Running post-action listener: _resource_record_post_action 12:35:46 INFO - [mozharness: 2016-07-21 19:35:46.494037Z] Finished install step (success) 12:35:46 INFO - [mozharness: 2016-07-21 19:35:46.494313Z] Running run-tests step. 12:35:46 INFO - Running pre-action listener: _resource_record_pre_action 12:35:46 INFO - Running main action method: run_tests 12:35:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:35:46 INFO - Python 2.7.3 12:35:46 INFO - Return code: 0 12:35:46 INFO - grabbing minidump binary from tooltool 12:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:46 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 0x104d3b0>, '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 0x104e2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104e740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:35:46 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 12:35:46 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 12:35:46 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 12:35:46 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:35:46 INFO - Return code: 0 12:35:46 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:35:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:35:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:35:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:35:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:35:46 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/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 12:35:46 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/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 12:35:46 INFO - Using env: {'DISPLAY': ':0', 12:35:46 INFO - 'HOME': '/home/cltbld', 12:35:46 INFO - 'LANG': 'en_US.UTF-8', 12:35:46 INFO - 'LANGUAGE': 'en_US:en', 12:35:46 INFO - 'LOGNAME': 'cltbld', 12:35:46 INFO - 'MAIL': '/var/mail/cltbld', 12:35:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:35:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:46 INFO - 'MOZ_NO_REMOTE': '1', 12:35:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:35:46 INFO - 'NO_EM_RESTART': '1', 12:35:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:46 INFO - 'PWD': '/builds/slave/test', 12:35:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:35:46 INFO - 'SHELL': '/bin/bash', 12:35:46 INFO - 'SHLVL': '1', 12:35:46 INFO - 'TERM': 'linux', 12:35:46 INFO - 'TMOUT': '86400', 12:35:46 INFO - 'USER': 'cltbld', 12:35:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292', 12:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:46 INFO - '_': '/tools/buildbot/bin/python'} 12:35:46 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/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 12:35:46 INFO - mozversion application_buildid: 20160721083037 12:35:46 INFO - mozversion application_changeset: f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf 12:35:46 INFO - mozversion application_display_name: Nightly 12:35:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:35:46 INFO - mozversion application_name: Firefox 12:35:46 INFO - mozversion application_remotingname: firefox 12:35:46 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 12:35:46 INFO - mozversion application_vendor: Mozilla 12:35:46 INFO - mozversion application_version: 50.0a1 12:35:46 INFO - mozversion platform_buildid: 20160721083037 12:35:46 INFO - mozversion platform_changeset: f5154aaeaec4546dd04c66ac61a0d0ee69f4dfdf 12:35:46 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 12:35:46 INFO - mozversion platform_version: 50.0a1 12:35:46 INFO - using testdate: 1469129746 12:35:46 INFO - actual date: 1469129746 12:35:46 INFO - starting webserver on 'localhost:51648' 12:35:46 INFO - SUITE-START | Running 2 tests 12:35:46 INFO - TEST-START | dromaeo_css 12:35:46 INFO - operating with platform_type : linux_ 12:35:46 INFO - Initialising browser for dromaeo_css test... 12:35:46 INFO - TEST-INFO | started process 18526 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzon3d/profile http://localhost:51648/getInfo.html) 12:35:49 INFO - PROCESS | 18526 | JavaScript error: , line 0: uncaught exception: undefined 12:35:51 INFO - PROCESS | 18526 | __metrics Screen width/height:1600/1200 12:35:51 INFO - PROCESS | 18526 | colorDepth:24 12:35:51 INFO - PROCESS | 18526 | Browser inner width/height: 1024/697 12:35:51 INFO - PROCESS | 18526 | __metrics 12:35:51 ERROR - PROCESS | 18526 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:35:52 INFO - TEST-INFO | 18526: exit 0 12:35:52 INFO - Browser initialized. 12:35:52 INFO - Running cycle 1/1 for dromaeo_css test... 12:35:52 INFO - TEST-INFO | started process 18645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPzon3d/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:36:04 INFO - PROCESS | 18645 | RSS: Main: 168112128 12:36:04 INFO - PROCESS | 18645 | 12:36:54 INFO - PROCESS | 18645 | 1469129814150 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] 12:39:02 INFO - PROCESS | 18645 | Cycle 1(1): loaded http://localhost:51648/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51648/tests/dromaeo/cssquery-ext.html) 12:39:03 INFO - PROCESS | 18645 | RSS: Main: 172425216 12:39:03 INFO - PROCESS | 18645 | 12:42:06 INFO - PROCESS | 18645 | Cycle 1(1): loaded http://localhost:51648/tests/dromaeo/cssquery-ext.html (next: http://localhost:51648/tests/dromaeo/cssquery-jquery.html) 12:42:06 INFO - PROCESS | 18645 | RSS: Main: 170246144 12:42:06 INFO - PROCESS | 18645 | 12:45:08 INFO - PROCESS | 18645 | Cycle 1(1): loaded http://localhost:51648/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51648/tests/dromaeo/cssquery-mootools.html) 12:45:09 INFO - PROCESS | 18645 | RSS: Main: 173699072 12:45:09 INFO - PROCESS | 18645 | 12:48:11 INFO - PROCESS | 18645 | Cycle 1(1): loaded http://localhost:51648/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51648/tests/dromaeo/cssquery-prototype.html) 12:48:11 INFO - PROCESS | 18645 | RSS: Main: 168120320 12:48:11 INFO - PROCESS | 18645 | 12:51:14 INFO - PROCESS | 18645 | Cycle 1(1): loaded http://localhost:51648/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51648/tests/dromaeo/cssquery-yui.html) 12:51:14 INFO - PROCESS | 18645 | RSS: Main: 169975808 12:51:14 INFO - PROCESS | 18645 | 12:54:17 INFO - PROCESS | 18645 | Cycle 1(1): loaded http://localhost:51648/tests/dromaeo/cssquery-yui.html (next: http://localhost:51648/tests/dromaeo/cssquery-dojo.html) 12:54:18 INFO - PROCESS | 18645 | RSS: Main: 173314048 12:54:18 INFO - PROCESS | 18645 | 12:54:18 INFO - PROCESS | 18645 | __start_tp_report 12:54:18 INFO - PROCESS | 18645 | _x_x_mozilla_page_load 12:54:18 INFO - PROCESS | 18645 | _x_x_mozilla_page_load_details 12:54:18 INFO - PROCESS | 18645 | |i|pagename|runs| 12:54:18 INFO - PROCESS | 18645 | |0;dojo.html;3111.051129405531;3115.4080724662326;3132.3422081362914;3143.057082875137;3143.4027534768393;5414.458554144589;5449.100898351772;5495.725213739312;5599.789660629339;5605.047141985862;5409;5474.562035037197;5526.253955715977;5538.584606154534;5635.774569017234;4927.802887884489;4952.87617809554;5085.516875896802;5104.84685459435;5114.514121158484;4958.553730164284;5227.73861306935;5227.764750586232;5231.293775340338;5233.398159211702;4951.876203094916;4969.304297398367;5070.416902056274;5092.898142037176;5160.767765450545;5034.219695947134;5038.974805125951;5042.596592272646;5057.645964782467;5087.669301495428;4941.061198372297;5003.949960500421;5009.574186194178;5030.094582975063;5067.138586440314;5344.144936810092;5427.267318911936;5484.204790305424;5505.917411238835;5550.500454959033;5897.380775018604;5903.704814759288;5905.527557795366;5937.2578427696535;5981.850453738648;5949.762009519614;5951.434613711691;5954.612950158225;5967.373425790316;5980.1328807323125;5457.372402173722;5471.534919531845;5497.8075767347955;5510.1459273812625;5517.44825517445;6118.284172697598;6123.201770564325;6131.564631961449;6133.76314253068;6135.416406698499;5867.354590994987;5871.530277577784;5874.676892770939;5884.32330282023;5914.585978981516;5611.298587676541;5842.737076831553;5883.7058147092475;5948.940510594925;5978.073398623221;5741.5119714824705;5840.2991641003355;5890.617109887844;5928.347881733092;5943.851403714942;5912.083627037816;5963.075723262815;5981.3719559445635;5988;5992;4377.671674624416;4510.345999830006;4520.434945631796;4524.208263553931;4564.79458424365;3909.58949310324;3911.198204368098;3929.8821035368983;3948.9605103949166;3981.6217459341315;5534.833954981357;5540.418256083134;5543.752655652446;5599.860003499945;5650.689212093293;5745.683987380734;5825.38833422493;5889.146073819272;5889.764409423661;5894.204282421904;5588.469095435927;5652.0674088774895;5652.63257888236;5753.769849206069;5772.278465191851;5099.158638824552;5127.102757017507;5142.948570514322;5146.356705411824;5147.845564633067;5863.208466857005;6188.628682279078;6195;6212.4408803207925;6241.563090583706;5925.585209035412;5954.583179177589;5964.135200395832;6005.129256257731;6055.666938318434;6146.508279337553;6152.230971128609;6152.507799376129;6154.723037463235;6161.168242287234;5720.685362305113;5831.125331200354;5885.588008839341;5890.558208134321;5891.911621325769;5855.2095467113095;5910.586258962004;5924.170616113834;5982.222311099529;6018.8796224074395;5793.507551857971;5798.449147330997;5801.564882633735;5810.76756929735;5818.069108942549;5738.5696072795545;5770.221020162225;5777.971110144423;5780.277465316835;5784.971075144597;5573.164025396223;5618.971905140448;5735.71321433935;5832.795852145155;5841.532677385884;5805.593608447537;5831.7375718093635;5916.142159386951;5944.4352786485215;5958.1658567801405;5697.4302569742695;5791.710414479175;5812.360640329476;5817.563682723728;5821.70891455417 12:54:18 INFO - PROCESS | 18645 | |1;ext.html;539.6094833099158;587.0255376075714;591.0956236957454;601.6330038676407;613.8066509049652;38629.42055869161;42835.78582107093;42945.570544294584;43129.35305970413;43341.133177336436;43222.78388608061;43699.12601747971;43845.78077109618;43967;44059;8885.489466790661;8959.955200224022;9003.5048072356;9020.594073266719;9037.367384283103;8913.465192088495;8972.775680608005;8975;8997.235235005033;9001.414908030956;8957.95521022394;9035.277177825757;9038.412503187272;9044.14080662336;9064.546772661373;8919.598618062202;8958.641654333818;8995.370324077285;9015.098490150966;9036.231920286751;8807.427517211361;8854;8870.778230544223;8895.510746908918;8932.419392739515;41429.585704142875;41712.374314385306;41764.582354176375;41807.163856723;41933;3380.509826075205;3583.4624806279267;3594.8382322795273;3648.0515066082744;3986.142979259473;32650.836745816356;32682.182945426553;33141.83429082839;33170.33659326824;33370.83314583436;4029.959700402988;4095.28332541804;4193;4228.217779710732;4260.1905637929;238656;239188;240411;240638;241259;33992.32015359679;56939.14591281134;57088.42911570914;57283;57459.425405746246;36678.449823252675;36682.44976325304;36979.81510092432;37150.25699485995;37210.813945930095;15527.611809704847;15541.766873496907;15561.066336019874;15581.220938953235;15603.063816171067;13353.998450116085;13568.525101621395;13575.932120339532;13587.116837405538;13629.931850340685;8229.423940324119;8307.750767476986;8342.874856877152;8382.622781974826;8433.915660843313;3245.789023713451;3251.7886337387995;3265.1837040739815;3268.3984847425068;3283.113559338965;1043.767050171983;1052.7947050325267;1057.1701214546545;1060.7083052160563;1166.4809159923752;32798.3440331192;33463.832680836924;33749.66250337514;33966.49050264248;34236.486452703226;1089.6730980705756;1109.5007246738999;1113.9554417823358;1118.6140781430393;1171.8359429679851;16322.169632336683;17905.576333568213;17933.282668693108;19029.858208507532;19435.22259109648;550106;550905;555483;558924;560922;60584.394156057875;60772.69613651904;60792.39207607867;61063.69468152631;61177.38822611806;1343.2612063365111;1350.1021820489461;1389.4581113365796;1392.3873495661674;1397.4829313154198;30024.549631755977;33343.333133337685;33955;34199.57541377278;34315.65684343124;52598.21102683539;53098.20352694635;53117.7344113277;53310;53317.733411332694;488913;490635;490654;492131;494294;27854.86068111455;28047.488657485963;28379.716202838532;28429.857850710614;28499.715002850535;46559.301610475195;47236.527634723214;48536.27195591998;48651.5134848647;48665;40442.39336409897;41593.58406416018;41665;41792.37311440392;42987.3551896728;40730.79634601808;40960.59664387818;41686.50793650794;42218;42218.78890605527;35811.64188358083;40589.79705101455;40772.388414174406;41240.1751964965;41849.1630167401;34417.82791086029;36828.26343473169;37068;37570.436443452825;37605;28054.57918131189;28103.578446322914;28240.85879570589;28347.716522834507;28424.28939276452 12:54:18 INFO - PROCESS | 18645 | |2;jquery.html;383.91170030892874;393.43345582361417;398.9169405065248;403.0809753761424;419.9899242322216;13806.44774209033;18282.360117395892;18803.623927521443;19964.101615427306;20015.399538013866;18903.716444253347;19117.044147792625;19356.709649355234;19605.725627834217;19699.5075123122;5559.499645031946;5671.943280567183;5705.828825135231;5738.167965645;5784.363719990798;5555.777768889239;5665.3201615806165;5702.230198923134;5708.400617935098;5725.914111288334;5503.174523821419;5570.442955704418;5649.689267090308;5664.773409063632;5721.056025755766;5617.691026993534;5648.632838865481;5662.716864156776;5669.8299051028325;5688.5733569982;5050.747462626854;5050.949490505084;5054.342935418409;5073.847784566432;5081.568066714333;22327.330180094625;22353;22701;22880.65679014816;23025.309240722807;2392.5812982728125;2413.8672373019476;2480.6031035034307;2491.402063504764;2546.6434699142137;14096.92951535246;14262.358193881197;14621.075784842968;14789.926050369786;14922.403103875831;1908.2843933524928;1991.4523506035812;2000.6798912173983;2024.9470275456827;2032.217596225464;86720.56639716761;86815.56592217062;91017.08982910219;91708.54145729296;92316.53841730815;10668.466576671135;10696.572137114585;10862.402567858686;10882.238243322892;10998.945005275082;15556.611084722746;15581.298841552158;15593.298301576457;15633.452829151152;15652.68694626101;8182.1817818217705;8226.136255693065;8390.202930721573;8483.872741908875;8575.142485751376;7958.124606293303;8139.145389734111;8315;8317.459365141247;8362.163783621589;4599.195140850338;4740.407449068866;4767.475577686451;4799.352087468147;4891.33966914462;2018.3944816554974;2049.3339664608766;2062.257587268582;2063.329417939176;2101.222547657346;963.3545524498603;967.791924736171;995.4226548601794;999.2505620784411;1020.1481762728057;18787.718184227248;19402.4179274622;19459.22163113488;19653.705194422095;19656.312029078912;986.6448078691665;1038.9896101038894;1047.6595106590237;1082.734729991157;1088.1729885287239;10161.339512931783;10886.40124793128;10919.181061420426;10923.235373523936;10926.672199834018;485030;491341;497910;498644;501567;90382.54808725914;90841.54579227194;93412.53293733488;97316.51341743246;100919.49540252252;1021.3361315145215;1039.2517387481003;1040.942748148859;1047.4919663962971;1052.7420781908481;14961.850381496046;15719;17890;18133.546661333043;18316.26734930588;43845.78077109722;44097;44453.777731111135;44884.77557612191;45242.32136518021;60360.396396035474;62804.685976569825;63827;63931.36068639254;65934.34065659282;8244;8392;8400.453970491899;8492.830143397221;8762.299016078827;11694.415279236175;12240.265584064984;12956.222626642431;13182.143160694524;13258.801117983045;11735.413229338328;11947.76104477923;11971.880281197426;11981.68201497852;12292.877071229173;11527;11773.175877688822;11837.940810296237;11888.940555297515;12044.457999389873;11860.762784744084;11862.347570883685;12191.695207619881;12272;12416.751664966469;8518.190771876662;8683.305335573265;8697.130286971253;8701.8694719578;8824.676298555269;11016.283941543774;11306.265092768943;11621.6513504595;11966.760664786829;12097.57658481949 12:54:18 INFO - PROCESS | 18645 | |3;mootools.html;1440.3734375546637;1483.3325003748312;1566.9373225070997;1785.9374921877736;1790.4986603750947;7979.12229654739;8769.123087691227;8797.736067917956;9411.152996230338;9433.386829856054;9103.317251206154;9197.494137822434;9198.678046268382;9201.941776695665;9236.030216827221;2408.8193385496115;2446.889889954947;2449.608062709967;2464.100603279799;2466.0382450844186;2401.5797235483806;2418.37122348189;2444.816638752092;2456.029868202068;2463.7043554773454;2367.360812580602;2369.312899259213;2395.3053614451874;2413.710354757423;2421.2978236311537;2300.1719381022817;2312.6415405612156;2327.2552783109413;2327.976720232793;2381.404648837791;2303.4011157099108;2309.6766452696634;2310.780475854791;2313.2250696016854;2317.0384290519414;9195.21840643546;9253.861192082124;9308.813823723487;9344.67293644726;9359.76600584984;5313.920291195635;5424.349078110613;5427.185922111676;5456.317960254968;5460.808871689512;3350.1959529712935;3356.429407000816;3366.1752870546875;3380.3915295246848;3404.9489257660907;1136.2443974756777;1147.4836323654388;1153.4924633161381;1156.346664134761;1194.856617205941;12888.033397495225;12989.870101299055;12993.350332483338;12997.025223108305;13007.284599347033;4793.281007848851;4803.759812009385;4817.253325734517;4884.731339776346;4988.301637770715;10923.890761092447;10949.945250273857;10955.890441095487;10961.451927403597;10964.232503724663;5576.442355764391;5580.274564306615;5582.609217354746;5589.552835773128;5598.10430331145;4365.105153443536;4710.788014539354;4817.8313759018965;4828.130936431406;5138.332016837862;4080.7959602019782;4143.531541227417;4185.079282557833;4185.121124563876;4220;1300.4276674449936;1314.5990472905664;1316.3484075382555;1316.7498175346655;1324.1922427319328;963.3038935190945;1030.2067408095725;1043.7338478687886;1055.4036969112426;1062.1768129699544;6265.091561723524;6269.65516896566;6272.184615999982;6389.776357827547;6534.509911756637;444.64428457234084;454.8317122664569;456.58450809762957;457.8191614312395;479.9136155491975;4449.599536041772;4456.554344565518;4491.8427855025575;4502.482214545304;4527.117212143667;11146.609868654557;11448.255863368855;11514.884851151548;11577.305361678325;11600.825987610193;10679.572817087384;11502.712432189262;11569.595064172714;11578.76842463163;11591.478383472764;8551.401401901932;8767;8780.736577902673;8781.517016564278;8803.779905502413;6376.681165941777;6404.871902562016;6450.677466126581;6566.8358291043105;6699.296573859675;10690.839637405601;10721.785564288826;10731.839022414513;10745;10869.402182880018;10452.843207351743;10894.891051089704;10943.726406839893;10955.123590112613;10967.945160274467;7288;7854.646540905787;8080.878786818085;8259.83480330378;8380.874286885579;9080.636774528944;9090.13643703847;9093.136152065543;9136.451812891248;9214.078592140731;7973.282404583615;8151.755447336589;8190.7133250335955;8232.588370581567;8301.418900676894;7838.568878711498;7914.802129946567;7959.801004974922;8093.271605555293;8116.513009219466;7081.114860642419;7384.409247260313;7387.076615423072;7454.515456495311;7458.403327733659;5369.114096174244;5498.917516237179;5566.721663916707;5570.275864137799;5679.346875109415;5379.811706590251;5407.513323800877;5557;5625.268715067015;5719.170720245625 12:54:18 INFO - PROCESS | 18645 | |4;prototype.html;322.8595560930995;323.11466581566515;339.49415371097064;341.1318195193233;342.60258100603295;5407.972960135194;5533.335999680044;5683.119116536933;5694.715264236792;5736.684482353469;5564.8052318168875;5597.412271711472;5597.7201139943045;5630.40880707526;5640.774369025245;4376.759278239696;4377.868663940087;4382;4384.114830622831;4390.758508282043;4109.527404348493;4327.783610819462;4340.52254252032;4369.453818272716;4387.363832244323;4294.613484786369;4295.398644189816;4297.183535128332;4298.892527686818;4302.8709138725735;4251.256030194719;4267.466566679165;4319.451523601059;4336.698990302928;4382.430284063052;3742.700583953277;3768.0956570423177;3820.3887378019663;3823.273578020195;3839.9808000959815;5428.538574221196;5430.782768689248;5435.565154787608;5445.53712934401;5477.698726570037;4927.6550641455115;4935.259711043336;4947.925781113287;4986.526280003394;5014.771381011639;5511;5758.3665796762325;5830.82507524775;5872.647641141545;5902.93047615242;4145.564715704838;4152.380571577088;4158.604932531404;4184.476940382452;4210.494740631113;6085.113614779432;6120.265568131808;6140.8771824563255;6143.416375444325;6148.415900489446;4169.666426685858;4220.599043090901;4277.914441711148;4281.743095414286;4289.849855255051;4303.397524346594;4305;4308.310670292738;4308.4399028126145;4336.9591298088235;4956.727379994135;4956.876078098005;4983.875403114878;4992.475790041994;5005.449400565934;5755.568332375088;5861.589688721834;5896.823095307148;5951.494122999594;5965.403459654;1485.866272035522;1497.2438918346165;1498.3107770425727;1498.4416207144448;1508.4267978168225;910.6084383715066;930.15356026016;949.8480243161199;966.4925913895121;974.2985050763439;4992.975035124874;5045.924311135336;5047.974760126176;5052.595792336604;5080.517350851663;5335.413104558495;5348.839534813884;5375.381831089475;5392.514673679309;5409.24270602116;4998.975005124951;5012.949870501321;5057.468965758616;5288.8413347599635;5682.460166284196;3208.3102133041507;3241.2821204761512;3248.382807266612;3252.447083995679;3260.3153337798853;6121.540884433596;6224.813255602339;6245.531585131133;6291.653959032297;6301.897167995582;6110.480609148183;6124.38756124384;6127.387261273837;6139.84650383744;6166.414190651881;6184.6598437086395;6222;6233.781817636361;6270.2789179244055;6295.937040629535;5808.854778630568;5915;5997.900734742805;6043.884640375833;6104.786332478519;5941.821745347474;5945.34601193877;5967.224260846062;5993.280806303272;6003.399660034136;5975.641461512323;6174.76504699053;6196.256449225942;6238.469730072995;6266.404691554295;4096.283150448719;4238.008136175992;4293;4310.245707001325;4311.310190369526;6102.755889764359;6114.48026917717;6118;6120.387961203844;6127.599182453781;5732.283464566929;5800.1589769484035;5907.645541267538;5925.415123850181;5947.881042379042;5834.620749651259;5845.649261044351;5868.970655146868;5879.853003674943;5914.970425148019;5885.61743486672;5901.29184497863;5921.644701317935;5928.318243402064;5931.872944140599;5727.942720572908;5917.4614600203395;5936.3470018297085;5950.31571369298;5961.493273071837;5785.710714464176;5821.777426740432;5833.941660583339;5847.181394604674;5882.7058647066615 12:54:18 INFO - PROCESS | 18645 | |5;yui.html;736.3293979512134;750;788.4126325887212;820.8645573480375;840.7477756672996;14306.999999999987;15008.399664013426;15175.620609484768;15194.240287985598;15328;14583.708325833504;14866.851331486709;15062.096274223526;15166.393344266244;15234.390624375039;822.7984143884756;832.6669332267081;835.5655059369125;838.0822998816286;838.5178522349643;805.3275514944999;823.6787652815407;826.2027143806225;826.3926014379456;836.3058661311128;876.198278575103;879.3097418526459;880.9207171354577;882.0341725810227;882.3029806452895;869.1178453869328;871.8299931513358;875.6847534887436;875.7153924974409;878.2052242720348;638.1831255992337;639.5523133806354;643.1767337807614;643.2538255623455;644.0789670770796;16122.516324510167;16177.83822161775;16184.190790460547;16185.757213641804;16194.190290485547;14573.781393279003;14735.336909838976;14854.851451485454;14964.551063468114;14996.175210363426;12144.089193310538;12157.441967226154;12215.877841221652;12337.568185113478;12397.75204495905;3770.509833721626;3805.56236032857;3805.6384643459105;3822.980885095557;3882.3788193889127;63501;65923.67038164778;66595.66702166459;75007.24992750112;76444.23555764426;11690.76618467643;11931.224470409396;11963;11971.940140299243;12172.634820955385;21703.24038658671;21714.782852171593;21778;21779.782202178092;21790.89104554467;8148.796280093045;8463.36524760633;8705.912940870638;8791.472511649321;8972.327075469366;4693.389859318267;4774.21225497789;4818.5822669013205;4923.064617722621;4999.800007999712;3736.420854767461;3827.27281816454;3849.942250866239;3864.671502922227;3866.8646597368956;652.0414989964744;657.8782925158861;667.6995352091578;676.2932735291632;676.3304328714537;642.2581917884851;666.0608541955819;700.3009804213681;749.3068911257066;782.4640121516666;10103.595856165817;10407.257863516244;10592.311499752492;10601.73495662599;10895.727606809893;722.003634983719;748.468587303021;750.2834792772888;763.282514436428;763.8128658478709;4902.166631672624;4994.600431965434;5058.241263810384;5084.313617661643;5140.948590514122;65622.67188664121;71237;94488.52755736177;118138;118793.40603296929;30191.396172076435;56902;68409;96684.51657741806;97848;55189.1721624176;57203.71398142983;88373;92296.53851730832;93756;9486.715398538056;9736.659216927374;10002.899971000197;10030.699079027641;10034.2371610646;47035;51149.48850511596;51548.742256288475;52517.7374113127;52786;79673;81338.59330703308;81387;81788;82708.58645706733;11275.66173014811;11328.150388721044;11342.489587968395;11410.372429516456;11794.05647548177;12823.166494177849;12954.67613309637;12968.35158242103;13032.152910060815;13496.595102146952;12330.136890417585;12724.554640587536;12910.67723306925;13103.082784205015;13107.868921311047;12195.51217951272;12319.876801231872;12960.157589756636;12972.35138243103;12975.805362919375;12015.158938874194;12130.636080917586;12178.39108044612;12237.816432753338;12283.01735861111;10071.155986643438;10301.330413523097;10323.174146068146;10341.069303762697;10482.213833962636;9341.439513629204;9468.22695882339;10045.347052441568;10326.741831454274;10379.481025948522 12:54:18 INFO - PROCESS | 18645 | __end_tp_report 12:54:18 INFO - PROCESS | 18645 | __start_cc_report 12:54:18 INFO - PROCESS | 18645 | _x_x_mozilla_cycle_collect,376 12:54:18 INFO - PROCESS | 18645 | __end_cc_report 12:54:18 INFO - PROCESS | 18645 | __startTimestamp1469130858008__endTimestamp 12:54:18 INFO - PROCESS | 18645 | 12:54:18 INFO - PROCESS | 18645 | ------- Summary: start ------- 12:54:18 INFO - PROCESS | 18645 | Number of tests: 6 12:54:18 INFO - PROCESS | 18645 | 12:54:18 INFO - PROCESS | 18645 | [#0] dojo.html Cycles:165 Average:5506.94 Median:5753.77 stddev:646.29 (11.2%) stddev-sans-first:620.34 12:54:18 INFO - PROCESS | 18645 | Values: 3111.1 3115.4 3132.3 3143.1 3143.4 5414.5 5449.1 5495.7 5599.8 5605.0 5409.0 5474.6 5526.3 5538.6 5635.8 4927.8 4952.9 5085.5 5104.8 5114.5 4958.6 5227.7 5227.8 5231.3 5233.4 4951.9 4969.3 5070.4 5092.9 5160.8 5034.2 5039.0 5042.6 5057.6 5087.7 4941.1 5003.9 5009.6 5030.1 5067.1 5344.1 5427.3 5484.2 5505.9 5550.5 5897.4 5903.7 5905.5 5937.3 5981.9 5949.8 5951.4 5954.6 5967.4 5980.1 5457.4 5471.5 5497.8 5510.1 5517.4 6118.3 6123.2 6131.6 6133.8 6135.4 5867.4 5871.5 5874.7 5884.3 5914.6 5611.3 5842.7 5883.7 5948.9 5978.1 5741.5 5840.3 5890.6 5928.3 5943.9 5912.1 5963.1 5981.4 5988.0 5992.0 4377.7 4510.3 4520.4 4524.2 4564.8 3909.6 3911.2 3929.9 3949.0 3981.6 5534.8 5540.4 5543.8 5599.9 5650.7 5745.7 5825.4 5889.1 5889.8 5894.2 5588.5 5652.1 5652.6 5753.8 5772.3 5099.2 5127.1 5142.9 5146.4 5147.8 5863.2 6188.6 6195.0 6212.4 6241.6 5925.6 5954.6 5964.1 6005.1 6055.7 6146.5 6152.2 6152.5 6154.7 6161.2 5720.7 5831.1 5885.6 5890.6 5891.9 5855.2 5910.6 5924.2 5982.2 6018.9 5793.5 5798.4 5801.6 5810.8 5818.1 5738.6 5770.2 5778.0 5780.3 5785.0 5573.2 5619.0 5735.7 5832.8 5841.5 5805.6 5831.7 5916.1 5944.4 5958.2 5697.4 5791.7 5812.4 5817.6 5821.7 12:54:18 INFO - PROCESS | 18645 | 12:54:18 INFO - PROCESS | 18645 | [#1] ext.html Cycles:180 Average:58266.86 Median:41334.88 stddev:120082.45 (290.5%) stddev-sans-first:120341.09 12:54:18 INFO - PROCESS | 18645 | Values: 539.6 587.0 591.1 601.6 613.8 38629.4 42835.8 42945.6 43129.4 43341.1 43222.8 43699.1 43845.8 43967.0 44059.0 8885.5 8960.0 9003.5 9020.6 9037.4 8913.5 8972.8 8975.0 8997.2 9001.4 8958.0 9035.3 9038.4 9044.1 9064.5 8919.6 8958.6 8995.4 9015.1 9036.2 8807.4 8854.0 8870.8 8895.5 8932.4 41429.6 41712.4 41764.6 41807.2 41933.0 3380.5 3583.5 3594.8 3648.1 3986.1 32650.8 32682.2 33141.8 33170.3 33370.8 4030.0 4095.3 4193.0 4228.2 4260.2 238656.0 239188.0 240411.0 240638.0 241259.0 33992.3 56939.1 57088.4 57283.0 57459.4 36678.4 36682.4 36979.8 37150.3 37210.8 15527.6 15541.8 15561.1 15581.2 15603.1 13354.0 13568.5 13575.9 13587.1 13629.9 8229.4 8307.8 8342.9 8382.6 8433.9 3245.8 3251.8 3265.2 3268.4 3283.1 1043.8 1052.8 1057.2 1060.7 1166.5 32798.3 33463.8 33749.7 33966.5 34236.5 1089.7 1109.5 1114.0 1118.6 1171.8 16322.2 17905.6 17933.3 19029.9 19435.2 550106.0 550905.0 555483.0 558924.0 560922.0 60584.4 60772.7 60792.4 61063.7 61177.4 1343.3 1350.1 1389.5 1392.4 1397.5 30024.5 33343.3 33955.0 34199.6 34315.7 52598.2 53098.2 53117.7 53310.0 53317.7 488913.0 490635.0 490654.0 492131.0 494294.0 27854.9 28047.5 28379.7 28429.9 28499.7 46559.3 47236.5 48536.3 48651.5 48665.0 40442.4 41593.6 41665.0 41792.4 42987.4 40730.8 40960.6 41686.5 42218.0 42218.8 35811.6 40589.8 40772.4 41240.2 41849.2 34417.8 36828.3 37068.0 37570.4 37605.0 28054.6 28103.6 28240.9 28347.7 28424.3 12:54:18 INFO - PROCESS | 18645 | 12:54:18 INFO - PROCESS | 18645 | [#2] jquery.html Cycles:180 Average:29770.47 Median:12708.95 stddev:81852.18 (644.1%) stddev-sans-first:82052.06 12:54:18 INFO - PROCESS | 18645 | Values: 383.9 393.4 398.9 403.1 420.0 13806.4 18282.4 18803.6 19964.1 20015.4 18903.7 19117.0 19356.7 19605.7 19699.5 5559.5 5671.9 5705.8 5738.2 5784.4 5555.8 5665.3 5702.2 5708.4 5725.9 5503.2 5570.4 5649.7 5664.8 5721.1 5617.7 5648.6 5662.7 5669.8 5688.6 5050.7 5050.9 5054.3 5073.8 5081.6 22327.3 22353.0 22701.0 22880.7 23025.3 2392.6 2413.9 2480.6 2491.4 2546.6 14096.9 14262.4 14621.1 14789.9 14922.4 1908.3 1991.5 2000.7 2024.9 2032.2 86720.6 86815.6 91017.1 91708.5 92316.5 10668.5 10696.6 10862.4 10882.2 10998.9 15556.6 15581.3 15593.3 15633.5 15652.7 8182.2 8226.1 8390.2 8483.9 8575.1 7958.1 8139.1 8315.0 8317.5 8362.2 4599.2 4740.4 4767.5 4799.4 4891.3 2018.4 2049.3 2062.3 2063.3 2101.2 963.4 967.8 995.4 999.3 1020.1 18787.7 19402.4 19459.2 19653.7 19656.3 986.6 1039.0 1047.7 1082.7 1088.2 10161.3 10886.4 10919.2 10923.2 10926.7 485030.0 491341.0 497910.0 498644.0 501567.0 90382.5 90841.5 93412.5 97316.5 100919.5 1021.3 1039.3 1040.9 1047.5 1052.7 14961.9 15719.0 17890.0 18133.5 18316.3 43845.8 44097.0 44453.8 44884.8 45242.3 60360.4 62804.7 63827.0 63931.4 65934.3 8244.0 8392.0 8400.5 8492.8 8762.3 11694.4 12240.3 12956.2 13182.1 13258.8 11735.4 11947.8 11971.9 11981.7 12292.9 11527.0 11773.2 11837.9 11888.9 12044.5 11860.8 11862.3 12191.7 12272.0 12416.8 8518.2 8683.3 8697.1 8701.9 8824.7 11016.3 11306.3 11621.7 11966.8 12097.6 12:54:18 INFO - PROCESS | 18645 | 12:54:18 INFO - PROCESS | 18645 | [#3] mootools.html Cycles:180 Average:6086.85 Median:2490.97 stddev:3512.11 (141.0%) stddev-sans-first:3504.60 12:54:18 INFO - PROCESS | 18645 | Values: 1440.4 1483.3 1566.9 1785.9 1790.5 7979.1 8769.1 8797.7 9411.2 9433.4 9103.3 9197.5 9198.7 9201.9 9236.0 2408.8 2446.9 2449.6 2464.1 2466.0 2401.6 2418.4 2444.8 2456.0 2463.7 2367.4 2369.3 2395.3 2413.7 2421.3 2300.2 2312.6 2327.3 2328.0 2381.4 2303.4 2309.7 2310.8 2313.2 2317.0 9195.2 9253.9 9308.8 9344.7 9359.8 5313.9 5424.3 5427.2 5456.3 5460.8 3350.2 3356.4 3366.2 3380.4 3404.9 1136.2 1147.5 1153.5 1156.3 1194.9 12888.0 12989.9 12993.4 12997.0 13007.3 4793.3 4803.8 4817.3 4884.7 4988.3 10923.9 10949.9 10955.9 10961.5 10964.2 5576.4 5580.3 5582.6 5589.6 5598.1 4365.1 4710.8 4817.8 4828.1 5138.3 4080.8 4143.5 4185.1 4185.1 4220.0 1300.4 1314.6 1316.3 1316.7 1324.2 963.3 1030.2 1043.7 1055.4 1062.2 6265.1 6269.7 6272.2 6389.8 6534.5 444.6 454.8 456.6 457.8 479.9 4449.6 4456.6 4491.8 4502.5 4527.1 11146.6 11448.3 11514.9 11577.3 11600.8 10679.6 11502.7 11569.6 11578.8 11591.5 8551.4 8767.0 8780.7 8781.5 8803.8 6376.7 6404.9 6450.7 6566.8 6699.3 10690.8 10721.8 10731.8 10745.0 10869.4 10452.8 10894.9 10943.7 10955.1 10967.9 7288.0 7854.6 8080.9 8259.8 8380.9 9080.6 9090.1 9093.1 9136.5 9214.1 7973.3 8151.8 8190.7 8232.6 8301.4 7838.6 7914.8 7959.8 8093.3 8116.5 7081.1 7384.4 7387.1 7454.5 7458.4 5369.1 5498.9 5566.7 5570.3 5679.3 5379.8 5407.5 5557.0 5625.3 5719.2 12:54:18 INFO - PROCESS | 18645 | 12:54:18 INFO - PROCESS | 18645 | [#4] prototype.html Cycles:180 Average:4898.20 Median:5522.17 stddev:1451.39 (26.3%) stddev-sans-first:1414.25 12:54:18 INFO - PROCESS | 18645 | Values: 322.9 323.1 339.5 341.1 342.6 5408.0 5533.3 5683.1 5694.7 5736.7 5564.8 5597.4 5597.7 5630.4 5640.8 4376.8 4377.9 4382.0 4384.1 4390.8 4109.5 4327.8 4340.5 4369.5 4387.4 4294.6 4295.4 4297.2 4298.9 4302.9 4251.3 4267.5 4319.5 4336.7 4382.4 3742.7 3768.1 3820.4 3823.3 3840.0 5428.5 5430.8 5435.6 5445.5 5477.7 4927.7 4935.3 4947.9 4986.5 5014.8 5511.0 5758.4 5830.8 5872.6 5902.9 4145.6 4152.4 4158.6 4184.5 4210.5 6085.1 6120.3 6140.9 6143.4 6148.4 4169.7 4220.6 4277.9 4281.7 4289.8 4303.4 4305.0 4308.3 4308.4 4337.0 4956.7 4956.9 4983.9 4992.5 5005.4 5755.6 5861.6 5896.8 5951.5 5965.4 1485.9 1497.2 1498.3 1498.4 1508.4 910.6 930.2 949.8 966.5 974.3 4993.0 5045.9 5048.0 5052.6 5080.5 5335.4 5348.8 5375.4 5392.5 5409.2 4999.0 5012.9 5057.5 5288.8 5682.5 3208.3 3241.3 3248.4 3252.4 3260.3 6121.5 6224.8 6245.5 6291.7 6301.9 6110.5 6124.4 6127.4 6139.8 6166.4 6184.7 6222.0 6233.8 6270.3 6295.9 5808.9 5915.0 5997.9 6043.9 6104.8 5941.8 5945.3 5967.2 5993.3 6003.4 5975.6 6174.8 6196.3 6238.5 6266.4 4096.3 4238.0 4293.0 4310.2 4311.3 6102.8 6114.5 6118.0 6120.4 6127.6 5732.3 5800.2 5907.6 5925.4 5947.9 5834.6 5845.6 5869.0 5879.9 5915.0 5885.6 5901.3 5921.6 5928.3 5931.9 5727.9 5917.5 5936.3 5950.3 5961.5 5785.7 5821.8 5833.9 5847.2 5882.7 12:54:18 INFO - PROCESS | 18645 | 12:54:18 INFO - PROCESS | 18645 | [#5] yui.html Cycles:180 Average:19047.60 Median:25904.61 stddev:26521.21 (102.4%) stddev-sans-first:26559.97 12:54:18 INFO - PROCESS | 18645 | Values: 736.3 750.0 788.4 820.9 840.7 14307.0 15008.4 15175.6 15194.2 15328.0 14583.7 14866.9 15062.1 15166.4 15234.4 822.8 832.7 835.6 838.1 838.5 805.3 823.7 826.2 826.4 836.3 876.2 879.3 880.9 882.0 882.3 869.1 871.8 875.7 875.7 878.2 638.2 639.6 643.2 643.3 644.1 16122.5 16177.8 16184.2 16185.8 16194.2 14573.8 14735.3 14854.9 14964.6 14996.2 12144.1 12157.4 12215.9 12337.6 12397.8 3770.5 3805.6 3805.6 3823.0 3882.4 63501.0 65923.7 66595.7 75007.2 76444.2 11690.8 11931.2 11963.0 11971.9 12172.6 21703.2 21714.8 21778.0 21779.8 21790.9 8148.8 8463.4 8705.9 8791.5 8972.3 4693.4 4774.2 4818.6 4923.1 4999.8 3736.4 3827.3 3849.9 3864.7 3866.9 652.0 657.9 667.7 676.3 676.3 642.3 666.1 700.3 749.3 782.5 10103.6 10407.3 10592.3 10601.7 10895.7 722.0 748.5 750.3 763.3 763.8 4902.2 4994.6 5058.2 5084.3 5140.9 65622.7 71237.0 94488.5 118138.0 118793.4 30191.4 56902.0 68409.0 96684.5 97848.0 55189.2 57203.7 88373.0 92296.5 93756.0 9486.7 9736.7 10002.9 10030.7 10034.2 47035.0 51149.5 51548.7 52517.7 52786.0 79673.0 81338.6 81387.0 81788.0 82708.6 11275.7 11328.2 11342.5 11410.4 11794.1 12823.2 12954.7 12968.4 13032.2 13496.6 12330.1 12724.6 12910.7 13103.1 13107.9 12195.5 12319.9 12960.2 12972.4 12975.8 12015.2 12130.6 12178.4 12237.8 12283.0 10071.2 10301.3 10323.2 10341.1 10482.2 9341.4 9468.2 10045.3 10326.7 10379.5 12:54:18 INFO - PROCESS | 18645 | -------- Summary: end -------- 12:54:18 INFO - PROCESS | 18645 | 12:54:18 INFO - TEST-INFO | 18645: exit 0 12:54:18 INFO - TEST-OK | dromaeo_css | took 1112024ms 12:54:18 INFO - TEST-START | kraken 12:54:18 INFO - operating with platform_type : linux_ 12:54:18 INFO - Initialising browser for kraken test... 12:54:18 INFO - TEST-INFO | started process 18892 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUFmVhD/profile http://localhost:51648/getInfo.html) 12:54:21 INFO - PROCESS | 18892 | JavaScript error: , line 0: uncaught exception: undefined 12:54:23 INFO - PROCESS | 18892 | __metrics Screen width/height:1600/1200 12:54:23 INFO - PROCESS | 18892 | colorDepth:24 12:54:23 INFO - PROCESS | 18892 | Browser inner width/height: 1024/697 12:54:23 INFO - PROCESS | 18892 | __metrics 12:54:23 ERROR - PROCESS | 18892 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 12:54:24 INFO - TEST-INFO | 18892: exit 0 12:54:24 INFO - Browser initialized. 12:54:24 INFO - Running cycle 1/1 for kraken test... 12:54:24 INFO - TEST-INFO | started process 19013 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUFmVhD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:36 INFO - PROCESS | 19013 | RSS: Main: 167583744 12:54:36 INFO - PROCESS | 19013 | 12:54:39 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51648/tests/kraken/driver.html?testName=audio-beat-detection) 12:54:39 INFO - PROCESS | 19013 | RSS: Main: 173404160 12:54:39 INFO - PROCESS | 19013 | 12:54:42 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51648/tests/kraken/driver.html?testName=audio-dft) 12:54:43 INFO - PROCESS | 19013 | RSS: Main: 171814912 12:54:43 INFO - PROCESS | 19013 | 12:54:46 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51648/tests/kraken/driver.html?testName=audio-fft) 12:54:46 INFO - PROCESS | 19013 | RSS: Main: 168009728 12:54:46 INFO - PROCESS | 19013 | 12:54:48 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51648/tests/kraken/driver.html?testName=audio-oscillator) 12:54:49 INFO - PROCESS | 19013 | RSS: Main: 169132032 12:54:49 INFO - PROCESS | 19013 | 12:54:51 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51648/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:54:52 INFO - PROCESS | 19013 | RSS: Main: 169897984 12:54:52 INFO - PROCESS | 19013 | 12:54:55 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51648/tests/kraken/driver.html?testName=imaging-darkroom) 12:54:56 INFO - PROCESS | 19013 | RSS: Main: 169701376 12:54:56 INFO - PROCESS | 19013 | 12:54:59 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51648/tests/kraken/driver.html?testName=imaging-desaturate) 12:55:00 INFO - PROCESS | 19013 | RSS: Main: 170180608 12:55:00 INFO - PROCESS | 19013 | 12:55:02 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51648/tests/kraken/driver.html?testName=json-parse-financial) 12:55:03 INFO - PROCESS | 19013 | RSS: Main: 169902080 12:55:03 INFO - PROCESS | 19013 | 12:55:05 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51648/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:55:05 INFO - PROCESS | 19013 | RSS: Main: 169529344 12:55:05 INFO - PROCESS | 19013 | 12:55:07 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51648/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:55:08 INFO - PROCESS | 19013 | RSS: Main: 170405888 12:55:08 INFO - PROCESS | 19013 | 12:55:10 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51648/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:55:10 INFO - PROCESS | 19013 | RSS: Main: 170790912 12:55:10 INFO - PROCESS | 19013 | 12:55:13 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:55:14 INFO - PROCESS | 19013 | RSS: Main: 171106304 12:55:14 INFO - PROCESS | 19013 | 12:55:16 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:55:17 INFO - PROCESS | 19013 | RSS: Main: 171069440 12:55:17 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | Cycle 1(1): loaded http://localhost:51648/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51648/tests/kraken/driver.html?testName=ai-astar) 12:55:19 INFO - PROCESS | 19013 | RSS: Main: 171757568 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | __start_tp_report 12:55:19 INFO - PROCESS | 19013 | _x_x_mozilla_page_load 12:55:19 INFO - PROCESS | 19013 | _x_x_mozilla_page_load_details 12:55:19 INFO - PROCESS | 19013 | |i|pagename|runs| 12:55:19 INFO - PROCESS | 19013 | |0;ai-astar;102;112;106;110;115;113;114;111;110;113 12:55:19 INFO - PROCESS | 19013 | |1;audio-beat-detection;142;122;147;176;117;146;151;119;175;120 12:55:19 INFO - PROCESS | 19013 | |2;audio-dft;162;163;161;164;163;164;177;163;162;161 12:55:19 INFO - PROCESS | 19013 | |3;audio-fft;75;75;76;157;80;75;75;75;171;75 12:55:19 INFO - PROCESS | 19013 | |4;audio-oscillator;85;84;154;85;84;85;150;86;84;139 12:55:19 INFO - PROCESS | 19013 | |5;imaging-gaussian-blur;118;117;118;118;117;117;118;118;118;120 12:55:19 INFO - PROCESS | 19013 | |6;imaging-darkroom;146;147;146;147;148;147;146;146;146;147 12:55:19 INFO - PROCESS | 19013 | |7;imaging-desaturate;96;97;95;95;96;95;96;100;96;95 12:55:19 INFO - PROCESS | 19013 | |8;json-parse-financial;53;54;58;53;61;55;53;57;53;55 12:55:19 INFO - PROCESS | 19013 | |9;json-stringify-tinderbox;62;63;62;63;66;62;62;61;63;62 12:55:19 INFO - PROCESS | 19013 | |10;stanford-crypto-aes;77;81;77;75;75;76;76;77;82;76 12:55:19 INFO - PROCESS | 19013 | |11;stanford-crypto-ccm;122;151;129;121;129;127;121;134;163;131 12:55:19 INFO - PROCESS | 19013 | |12;stanford-crypto-pbkdf2;158;161;155;159;157;159;160;161;155;162 12:55:19 INFO - PROCESS | 19013 | |13;stanford-crypto-sha256-iterative;65;64;64;74;65;65;67;65;66;65 12:55:19 INFO - PROCESS | 19013 | __end_tp_report 12:55:19 INFO - PROCESS | 19013 | __start_cc_report 12:55:19 INFO - PROCESS | 19013 | _x_x_mozilla_cycle_collect,919 12:55:19 INFO - PROCESS | 19013 | __end_cc_report 12:55:19 INFO - PROCESS | 19013 | __startTimestamp1469130919505__endTimestamp 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | ------- Summary: start ------- 12:55:19 INFO - PROCESS | 19013 | Number of tests: 14 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.50 stddev:3.95 (3.5%) stddev-sans-first:2.70 12:55:19 INFO - PROCESS | 19013 | Values: 102.0 112.0 106.0 110.0 115.0 113.0 114.0 111.0 110.0 113.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:146.50 stddev:22.12 (15.1%) stddev-sans-first:23.46 12:55:19 INFO - PROCESS | 19013 | Values: 142.0 122.0 147.0 176.0 117.0 146.0 151.0 119.0 175.0 120.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.69 (2.9%) stddev-sans-first:4.92 12:55:19 INFO - PROCESS | 19013 | Values: 162.0 163.0 161.0 164.0 163.0 164.0 177.0 163.0 162.0 161.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#3] audio-fft Cycles:10 Average:93.40 Median:75.00 stddev:37.39 (49.8%) stddev-sans-first:39.06 12:55:19 INFO - PROCESS | 19013 | Values: 75.0 75.0 76.0 157.0 80.0 75.0 75.0 75.0 171.0 75.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:84.50 stddev:30.63 (36.3%) stddev-sans-first:31.75 12:55:19 INFO - PROCESS | 19013 | Values: 85.0 84.0 154.0 85.0 84.0 85.0 150.0 86.0 84.0 139.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.88 (0.7%) stddev-sans-first:0.93 12:55:19 INFO - PROCESS | 19013 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 120.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 12:55:19 INFO - PROCESS | 19013 | Values: 146.0 147.0 146.0 147.0 148.0 147.0 146.0 146.0 146.0 147.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:1.52 (1.6%) stddev-sans-first:1.62 12:55:19 INFO - PROCESS | 19013 | Values: 96.0 97.0 95.0 95.0 96.0 95.0 96.0 100.0 96.0 95.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#8] json-parse-financial Cycles:10 Average:55.20 Median:55.00 stddev:2.70 (4.9%) stddev-sans-first:2.74 12:55:19 INFO - PROCESS | 19013 | Values: 53.0 54.0 58.0 53.0 61.0 55.0 53.0 57.0 53.0 55.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#9] json-stringify-tinderbox Cycles:10 Average:62.60 Median:62.50 stddev:1.35 (2.2%) stddev-sans-first:1.41 12:55:19 INFO - PROCESS | 19013 | Values: 62.0 63.0 62.0 63.0 66.0 62.0 62.0 61.0 63.0 62.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#10] stanford-crypto-aes Cycles:10 Average:77.20 Median:77.00 stddev:2.39 (3.1%) stddev-sans-first:2.54 12:55:19 INFO - PROCESS | 19013 | Values: 77.0 81.0 77.0 75.0 75.0 76.0 76.0 77.0 82.0 76.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:130.00 stddev:13.77 (10.6%) stddev-sans-first:14.04 12:55:19 INFO - PROCESS | 19013 | Values: 122.0 151.0 129.0 121.0 129.0 127.0 121.0 134.0 163.0 131.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.70 Median:159.50 stddev:2.45 (1.5%) stddev-sans-first:2.59 12:55:19 INFO - PROCESS | 19013 | Values: 158.0 161.0 155.0 159.0 157.0 159.0 160.0 161.0 155.0 162.0 12:55:19 INFO - PROCESS | 19013 | 12:55:19 INFO - PROCESS | 19013 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.00 stddev:2.94 (4.5%) stddev-sans-first:3.10 12:55:19 INFO - PROCESS | 19013 | Values: 65.0 64.0 64.0 74.0 65.0 65.0 67.0 65.0 66.0 65.0 12:55:19 INFO - PROCESS | 19013 | -------- Summary: end -------- 12:55:19 INFO - PROCESS | 19013 | 12:55:20 INFO - TEST-INFO | 19013: exit 0 12:55:20 INFO - TEST-OK | kraken | took 61759ms 12:55:20 INFO - SUITE-END | took 1173s 12:55:20 INFO - Completed test suite (00:19:33) 12:55:20 INFO - javascript benchmark 12:55:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7312.0689276479625, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3111.051129405531, 3115.4080724662326, 3132.3422081362914, 3143.057082875137, 3143.4027534768393, 5414.458554144589, 5449.100898351772, 5495.725213739312, 5599.789660629339, 5605.047141985862, 5409.0, 5474.562035037197, 5526.253955715977, 5538.584606154534, 5635.774569017234, 4927.802887884489, 4952.87617809554, 5085.516875896802, 5104.84685459435, 5114.514121158484, 4958.553730164284, 5227.73861306935, 5227.764750586232, 5231.293775340338, 5233.398159211702, 4951.876203094916, 4969.304297398367, 5070.416902056274, 5092.898142037176, 5160.767765450545, 5034.219695947134, 5038.974805125951, 5042.596592272646, 5057.645964782467, 5087.669301495428, 4941.061198372297, 5003.949960500421, 5009.574186194178, 5030.094582975063, 5067.138586440314, 5344.144936810092, 5427.267318911936, 5484.204790305424, 5505.917411238835, 5550.500454959033, 5897.380775018604, 5903.704814759288, 5905.527557795366, 5937.2578427696535, 5981.850453738648, 5949.762009519614, 5951.434613711691, 5954.612950158225, 5967.373425790316, 5980.1328807323125, 5457.372402173722, 5471.534919531845, 5497.8075767347955, 5510.1459273812625, 5517.44825517445, 6118.284172697598, 6123.201770564325, 6131.564631961449, 6133.76314253068, 6135.416406698499, 5867.354590994987, 5871.530277577784, 5874.676892770939, 5884.32330282023, 5914.585978981516, 5611.298587676541, 5842.737076831553, 5883.7058147092475, 5948.940510594925, 5978.073398623221, 5741.5119714824705, 5840.2991641003355, 5890.617109887844, 5928.347881733092, 5943.851403714942, 5912.083627037816, 5963.075723262815, 5981.3719559445635, 5988.0, 5992.0, 4377.671674624416, 4510.345999830006, 4520.434945631796, 4524.208263553931, 4564.79458424365, 3909.58949310324, 3911.198204368098, 3929.8821035368983, 3948.9605103949166, 3981.6217459341315, 5534.833954981357, 5540.418256083134, 5543.752655652446, 5599.860003499945, 5650.689212093293, 5745.683987380734, 5825.38833422493, 5889.146073819272, 5889.764409423661, 5894.204282421904, 5588.469095435927, 5652.0674088774895, 5652.63257888236, 5753.769849206069, 5772.278465191851, 5099.158638824552, 5127.102757017507, 5142.948570514322, 5146.356705411824, 5147.845564633067, 5863.208466857005, 6188.628682279078, 6195.0, 6212.4408803207925, 6241.563090583706, 5925.585209035412, 5954.583179177589, 5964.135200395832, 6005.129256257731, 6055.666938318434, 6146.508279337553, 6152.230971128609, 6152.507799376129, 6154.723037463235, 6161.168242287234, 5720.685362305113, 5831.125331200354, 5885.588008839341, 5890.558208134321, 5891.911621325769, 5855.2095467113095, 5910.586258962004, 5924.170616113834, 5982.222311099529, 6018.8796224074395, 5793.507551857971, 5798.449147330997, 5801.564882633735, 5810.76756929735, 5818.069108942549, 5738.5696072795545, 5770.221020162225, 5777.971110144423, 5780.277465316835, 5784.971075144597, 5573.164025396223, 5618.971905140448, 5735.71321433935, 5832.795852145155, 5841.532677385884, 5805.593608447537, 5831.7375718093635, 5916.142159386951, 5944.4352786485215, 5958.1658567801405, 5697.4302569742695, 5791.710414479175, 5812.360640329476, 5817.563682723728, 5821.70891455417], "value": 5461.351508114827, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [539.6094833099158, 587.0255376075714, 591.0956236957454, 601.6330038676407, 613.8066509049652, 38629.42055869161, 42835.78582107093, 42945.570544294584, 43129.35305970413, 43341.133177336436, 43222.78388608061, 43699.12601747971, 43845.78077109618, 43967.0, 44059.0, 8885.489466790661, 8959.955200224022, 9003.5048072356, 9020.594073266719, 9037.367384283103, 8913.465192088495, 8972.775680608005, 8975.0, 8997.235235005033, 9001.414908030956, 8957.95521022394, 9035.277177825757, 9038.412503187272, 9044.14080662336, 9064.546772661373, 8919.598618062202, 8958.641654333818, 8995.370324077285, 9015.098490150966, 9036.231920286751, 8807.427517211361, 8854.0, 8870.778230544223, 8895.510746908918, 8932.419392739515, 41429.585704142875, 41712.374314385306, 41764.582354176375, 41807.163856723, 41933.0, 3380.509826075205, 3583.4624806279267, 3594.8382322795273, 3648.0515066082744, 3986.142979259473, 32650.836745816356, 32682.182945426553, 33141.83429082839, 33170.33659326824, 33370.83314583436, 4029.959700402988, 4095.28332541804, 4193.0, 4228.217779710732, 4260.1905637929, 238656.0, 239188.0, 240411.0, 240638.0, 241259.0, 33992.32015359679, 56939.14591281134, 57088.42911570914, 57283.0, 57459.425405746246, 36678.449823252675, 36682.44976325304, 36979.81510092432, 37150.25699485995, 37210.813945930095, 15527.611809704847, 15541.766873496907, 15561.066336019874, 15581.220938953235, 15603.063816171067, 13353.998450116085, 13568.525101621395, 13575.932120339532, 13587.116837405538, 13629.931850340685, 8229.423940324119, 8307.750767476986, 8342.874856877152, 8382.622781974826, 8433.915660843313, 3245.789023713451, 3251.7886337387995, 3265.1837040739815, 3268.3984847425068, 3283.113559338965, 1043.767050171983, 1052.7947050325267, 1057.1701214546545, 1060.7083052160563, 1166.4809159923752, 32798.3440331192, 33463.832680836924, 33749.66250337514, 33966.49050264248, 34236.486452703226, 1089.6730980705756, 1109.5007246738999, 1113.9554417823358, 1118.6140781430393, 1171.8359429679851, 16322.169632336683, 17905.576333568213, 17933.282668693108, 19029.858208507532, 19435.22259109648, 550106.0, 550905.0, 555483.0, 558924.0, 560922.0, 60584.394156057875, 60772.69613651904, 60792.39207607867, 61063.69468152631, 61177.38822611806, 1343.2612063365111, 1350.1021820489461, 1389.4581113365796, 1392.3873495661674, 1397.4829313154198, 30024.549631755977, 33343.333133337685, 33955.0, 34199.57541377278, 34315.65684343124, 52598.21102683539, 53098.20352694635, 53117.7344113277, 53310.0, 53317.733411332694, 488913.0, 490635.0, 490654.0, 492131.0, 494294.0, 27854.86068111455, 28047.488657485963, 28379.716202838532, 28429.857850710614, 28499.715002850535, 46559.301610475195, 47236.527634723214, 48536.27195591998, 48651.5134848647, 48665.0, 40442.39336409897, 41593.58406416018, 41665.0, 41792.37311440392, 42987.3551896728, 40730.79634601808, 40960.59664387818, 41686.50793650794, 42218.0, 42218.78890605527, 35811.64188358083, 40589.79705101455, 40772.388414174406, 41240.1751964965, 41849.1630167401, 34417.82791086029, 36828.26343473169, 37068.0, 37570.436443452825, 37605.0, 28054.57918131189, 28103.578446322914, 28240.85879570589, 28347.716522834507, 28424.28939276452], "value": 18963.41638805556, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.91170030892874, 393.43345582361417, 398.9169405065248, 403.0809753761424, 419.9899242322216, 13806.44774209033, 18282.360117395892, 18803.623927521443, 19964.101615427306, 20015.399538013866, 18903.716444253347, 19117.044147792625, 19356.709649355234, 19605.725627834217, 19699.5075123122, 5559.499645031946, 5671.943280567183, 5705.828825135231, 5738.167965645, 5784.363719990798, 5555.777768889239, 5665.3201615806165, 5702.230198923134, 5708.400617935098, 5725.914111288334, 5503.174523821419, 5570.442955704418, 5649.689267090308, 5664.773409063632, 5721.056025755766, 5617.691026993534, 5648.632838865481, 5662.716864156776, 5669.8299051028325, 5688.5733569982, 5050.747462626854, 5050.949490505084, 5054.342935418409, 5073.847784566432, 5081.568066714333, 22327.330180094625, 22353.0, 22701.0, 22880.65679014816, 23025.309240722807, 2392.5812982728125, 2413.8672373019476, 2480.6031035034307, 2491.402063504764, 2546.6434699142137, 14096.92951535246, 14262.358193881197, 14621.075784842968, 14789.926050369786, 14922.403103875831, 1908.2843933524928, 1991.4523506035812, 2000.6798912173983, 2024.9470275456827, 2032.217596225464, 86720.56639716761, 86815.56592217062, 91017.08982910219, 91708.54145729296, 92316.53841730815, 10668.466576671135, 10696.572137114585, 10862.402567858686, 10882.238243322892, 10998.945005275082, 15556.611084722746, 15581.298841552158, 15593.298301576457, 15633.452829151152, 15652.68694626101, 8182.1817818217705, 8226.136255693065, 8390.202930721573, 8483.872741908875, 8575.142485751376, 7958.124606293303, 8139.145389734111, 8315.0, 8317.459365141247, 8362.163783621589, 4599.195140850338, 4740.407449068866, 4767.475577686451, 4799.352087468147, 4891.33966914462, 2018.3944816554974, 2049.3339664608766, 2062.257587268582, 2063.329417939176, 2101.222547657346, 963.3545524498603, 967.791924736171, 995.4226548601794, 999.2505620784411, 1020.1481762728057, 18787.718184227248, 19402.4179274622, 19459.22163113488, 19653.705194422095, 19656.312029078912, 986.6448078691665, 1038.9896101038894, 1047.6595106590237, 1082.734729991157, 1088.1729885287239, 10161.339512931783, 10886.40124793128, 10919.181061420426, 10923.235373523936, 10926.672199834018, 485030.0, 491341.0, 497910.0, 498644.0, 501567.0, 90382.54808725914, 90841.54579227194, 93412.53293733488, 97316.51341743246, 100919.49540252252, 1021.3361315145215, 1039.2517387481003, 1040.942748148859, 1047.4919663962971, 1052.7420781908481, 14961.850381496046, 15719.0, 17890.0, 18133.546661333043, 18316.26734930588, 43845.78077109722, 44097.0, 44453.777731111135, 44884.77557612191, 45242.32136518021, 60360.396396035474, 62804.685976569825, 63827.0, 63931.36068639254, 65934.34065659282, 8244.0, 8392.0, 8400.453970491899, 8492.830143397221, 8762.299016078827, 11694.415279236175, 12240.265584064984, 12956.222626642431, 13182.143160694524, 13258.801117983045, 11735.413229338328, 11947.76104477923, 11971.880281197426, 11981.68201497852, 12292.877071229173, 11527.0, 11773.175877688822, 11837.940810296237, 11888.940555297515, 12044.457999389873, 11860.762784744084, 11862.347570883685, 12191.695207619881, 12272.0, 12416.751664966469, 8518.190771876662, 8683.305335573265, 8697.130286971253, 8701.8694719578, 8824.676298555269, 11016.283941543774, 11306.265092768943, 11621.6513504595, 11966.760664786829, 12097.57658481949], "value": 9413.86624789047, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.3734375546637, 1483.3325003748312, 1566.9373225070997, 1785.9374921877736, 1790.4986603750947, 7979.12229654739, 8769.123087691227, 8797.736067917956, 9411.152996230338, 9433.386829856054, 9103.317251206154, 9197.494137822434, 9198.678046268382, 9201.941776695665, 9236.030216827221, 2408.8193385496115, 2446.889889954947, 2449.608062709967, 2464.100603279799, 2466.0382450844186, 2401.5797235483806, 2418.37122348189, 2444.816638752092, 2456.029868202068, 2463.7043554773454, 2367.360812580602, 2369.312899259213, 2395.3053614451874, 2413.710354757423, 2421.2978236311537, 2300.1719381022817, 2312.6415405612156, 2327.2552783109413, 2327.976720232793, 2381.404648837791, 2303.4011157099108, 2309.6766452696634, 2310.780475854791, 2313.2250696016854, 2317.0384290519414, 9195.21840643546, 9253.861192082124, 9308.813823723487, 9344.67293644726, 9359.76600584984, 5313.920291195635, 5424.349078110613, 5427.185922111676, 5456.317960254968, 5460.808871689512, 3350.1959529712935, 3356.429407000816, 3366.1752870546875, 3380.3915295246848, 3404.9489257660907, 1136.2443974756777, 1147.4836323654388, 1153.4924633161381, 1156.346664134761, 1194.856617205941, 12888.033397495225, 12989.870101299055, 12993.350332483338, 12997.025223108305, 13007.284599347033, 4793.281007848851, 4803.759812009385, 4817.253325734517, 4884.731339776346, 4988.301637770715, 10923.890761092447, 10949.945250273857, 10955.890441095487, 10961.451927403597, 10964.232503724663, 5576.442355764391, 5580.274564306615, 5582.609217354746, 5589.552835773128, 5598.10430331145, 4365.105153443536, 4710.788014539354, 4817.8313759018965, 4828.130936431406, 5138.332016837862, 4080.7959602019782, 4143.531541227417, 4185.079282557833, 4185.121124563876, 4220.0, 1300.4276674449936, 1314.5990472905664, 1316.3484075382555, 1316.7498175346655, 1324.1922427319328, 963.3038935190945, 1030.2067408095725, 1043.7338478687886, 1055.4036969112426, 1062.1768129699544, 6265.091561723524, 6269.65516896566, 6272.184615999982, 6389.776357827547, 6534.509911756637, 444.64428457234084, 454.8317122664569, 456.58450809762957, 457.8191614312395, 479.9136155491975, 4449.599536041772, 4456.554344565518, 4491.8427855025575, 4502.482214545304, 4527.117212143667, 11146.609868654557, 11448.255863368855, 11514.884851151548, 11577.305361678325, 11600.825987610193, 10679.572817087384, 11502.712432189262, 11569.595064172714, 11578.76842463163, 11591.478383472764, 8551.401401901932, 8767.0, 8780.736577902673, 8781.517016564278, 8803.779905502413, 6376.681165941777, 6404.871902562016, 6450.677466126581, 6566.8358291043105, 6699.296573859675, 10690.839637405601, 10721.785564288826, 10731.839022414513, 10745.0, 10869.402182880018, 10452.843207351743, 10894.891051089704, 10943.726406839893, 10955.123590112613, 10967.945160274467, 7288.0, 7854.646540905787, 8080.878786818085, 8259.83480330378, 8380.874286885579, 9080.636774528944, 9090.13643703847, 9093.136152065543, 9136.451812891248, 9214.078592140731, 7973.282404583615, 8151.755447336589, 8190.7133250335955, 8232.588370581567, 8301.418900676894, 7838.568878711498, 7914.802129946567, 7959.801004974922, 8093.271605555293, 8116.513009219466, 7081.114860642419, 7384.409247260313, 7387.076615423072, 7454.515456495311, 7458.403327733659, 5369.114096174244, 5498.917516237179, 5566.721663916707, 5570.275864137799, 5679.346875109415, 5379.811706590251, 5407.513323800877, 5557.0, 5625.268715067015, 5719.170720245625], "value": 4761.07264579577, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.8595560930995, 323.11466581566515, 339.49415371097064, 341.1318195193233, 342.60258100603295, 5407.972960135194, 5533.335999680044, 5683.119116536933, 5694.715264236792, 5736.684482353469, 5564.8052318168875, 5597.412271711472, 5597.7201139943045, 5630.40880707526, 5640.774369025245, 4376.759278239696, 4377.868663940087, 4382.0, 4384.114830622831, 4390.758508282043, 4109.527404348493, 4327.783610819462, 4340.52254252032, 4369.453818272716, 4387.363832244323, 4294.613484786369, 4295.398644189816, 4297.183535128332, 4298.892527686818, 4302.8709138725735, 4251.256030194719, 4267.466566679165, 4319.451523601059, 4336.698990302928, 4382.430284063052, 3742.700583953277, 3768.0956570423177, 3820.3887378019663, 3823.273578020195, 3839.9808000959815, 5428.538574221196, 5430.782768689248, 5435.565154787608, 5445.53712934401, 5477.698726570037, 4927.6550641455115, 4935.259711043336, 4947.925781113287, 4986.526280003394, 5014.771381011639, 5511.0, 5758.3665796762325, 5830.82507524775, 5872.647641141545, 5902.93047615242, 4145.564715704838, 4152.380571577088, 4158.604932531404, 4184.476940382452, 4210.494740631113, 6085.113614779432, 6120.265568131808, 6140.8771824563255, 6143.416375444325, 6148.415900489446, 4169.666426685858, 4220.599043090901, 4277.914441711148, 4281.743095414286, 4289.849855255051, 4303.397524346594, 4305.0, 4308.310670292738, 4308.4399028126145, 4336.9591298088235, 4956.727379994135, 4956.876078098005, 4983.875403114878, 4992.475790041994, 5005.449400565934, 5755.568332375088, 5861.589688721834, 5896.823095307148, 5951.494122999594, 5965.403459654, 1485.866272035522, 1497.2438918346165, 1498.3107770425727, 1498.4416207144448, 1508.4267978168225, 910.6084383715066, 930.15356026016, 949.8480243161199, 966.4925913895121, 974.2985050763439, 4992.975035124874, 5045.924311135336, 5047.974760126176, 5052.595792336604, 5080.517350851663, 5335.413104558495, 5348.839534813884, 5375.381831089475, 5392.514673679309, 5409.24270602116, 4998.975005124951, 5012.949870501321, 5057.468965758616, 5288.8413347599635, 5682.460166284196, 3208.3102133041507, 3241.2821204761512, 3248.382807266612, 3252.447083995679, 3260.3153337798853, 6121.540884433596, 6224.813255602339, 6245.531585131133, 6291.653959032297, 6301.897167995582, 6110.480609148183, 6124.38756124384, 6127.387261273837, 6139.84650383744, 6166.414190651881, 6184.6598437086395, 6222.0, 6233.781817636361, 6270.2789179244055, 6295.937040629535, 5808.854778630568, 5915.0, 5997.900734742805, 6043.884640375833, 6104.786332478519, 5941.821745347474, 5945.34601193877, 5967.224260846062, 5993.280806303272, 6003.399660034136, 5975.641461512323, 6174.76504699053, 6196.256449225942, 6238.469730072995, 6266.404691554295, 4096.283150448719, 4238.008136175992, 4293.0, 4310.245707001325, 4311.310190369526, 6102.755889764359, 6114.48026917717, 6118.0, 6120.387961203844, 6127.599182453781, 5732.283464566929, 5800.1589769484035, 5907.645541267538, 5925.415123850181, 5947.881042379042, 5834.620749651259, 5845.649261044351, 5868.970655146868, 5879.853003674943, 5914.970425148019, 5885.61743486672, 5901.29184497863, 5921.644701317935, 5928.318243402064, 5931.872944140599, 5727.942720572908, 5917.4614600203395, 5936.3470018297085, 5950.31571369298, 5961.493273071837, 5785.710714464176, 5821.777426740432, 5833.941660583339, 5847.181394604674, 5882.7058647066615], "value": 4429.57469162586, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.3293979512134, 750.0, 788.4126325887212, 820.8645573480375, 840.7477756672996, 14306.999999999987, 15008.399664013426, 15175.620609484768, 15194.240287985598, 15328.0, 14583.708325833504, 14866.851331486709, 15062.096274223526, 15166.393344266244, 15234.390624375039, 822.7984143884756, 832.6669332267081, 835.5655059369125, 838.0822998816286, 838.5178522349643, 805.3275514944999, 823.6787652815407, 826.2027143806225, 826.3926014379456, 836.3058661311128, 876.198278575103, 879.3097418526459, 880.9207171354577, 882.0341725810227, 882.3029806452895, 869.1178453869328, 871.8299931513358, 875.6847534887436, 875.7153924974409, 878.2052242720348, 638.1831255992337, 639.5523133806354, 643.1767337807614, 643.2538255623455, 644.0789670770796, 16122.516324510167, 16177.83822161775, 16184.190790460547, 16185.757213641804, 16194.190290485547, 14573.781393279003, 14735.336909838976, 14854.851451485454, 14964.551063468114, 14996.175210363426, 12144.089193310538, 12157.441967226154, 12215.877841221652, 12337.568185113478, 12397.75204495905, 3770.509833721626, 3805.56236032857, 3805.6384643459105, 3822.980885095557, 3882.3788193889127, 63501.0, 65923.67038164778, 66595.66702166459, 75007.24992750112, 76444.23555764426, 11690.76618467643, 11931.224470409396, 11963.0, 11971.940140299243, 12172.634820955385, 21703.24038658671, 21714.782852171593, 21778.0, 21779.782202178092, 21790.89104554467, 8148.796280093045, 8463.36524760633, 8705.912940870638, 8791.472511649321, 8972.327075469366, 4693.389859318267, 4774.21225497789, 4818.5822669013205, 4923.064617722621, 4999.800007999712, 3736.420854767461, 3827.27281816454, 3849.942250866239, 3864.671502922227, 3866.8646597368956, 652.0414989964744, 657.8782925158861, 667.6995352091578, 676.2932735291632, 676.3304328714537, 642.2581917884851, 666.0608541955819, 700.3009804213681, 749.3068911257066, 782.4640121516666, 10103.595856165817, 10407.257863516244, 10592.311499752492, 10601.73495662599, 10895.727606809893, 722.003634983719, 748.468587303021, 750.2834792772888, 763.282514436428, 763.8128658478709, 4902.166631672624, 4994.600431965434, 5058.241263810384, 5084.313617661643, 5140.948590514122, 65622.67188664121, 71237.0, 94488.52755736177, 118138.0, 118793.40603296929, 30191.396172076435, 56902.0, 68409.0, 96684.51657741806, 97848.0, 55189.1721624176, 57203.71398142983, 88373.0, 92296.53851730832, 93756.0, 9486.715398538056, 9736.659216927374, 10002.899971000197, 10030.699079027641, 10034.2371610646, 47035.0, 51149.48850511596, 51548.742256288475, 52517.7374113127, 52786.0, 79673.0, 81338.59330703308, 81387.0, 81788.0, 82708.58645706733, 11275.66173014811, 11328.150388721044, 11342.489587968395, 11410.372429516456, 11794.05647548177, 12823.166494177849, 12954.67613309637, 12968.35158242103, 13032.152910060815, 13496.595102146952, 12330.136890417585, 12724.554640587536, 12910.67723306925, 13103.082784205015, 13107.868921311047, 12195.51217951272, 12319.876801231872, 12960.157589756636, 12972.35138243103, 12975.805362919375, 12015.158938874194, 12130.636080917586, 12178.39108044612, 12237.816432753338, 12283.01735861111, 10071.155986643438, 10301.330413523097, 10323.174146068146, 10341.069303762697, 10482.213833962636, 9341.439513629204, 9468.22695882339, 10045.347052441568, 10326.741831454274, 10379.481025948522], "value": 7432.76180459569, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 106.0, 110.0, 115.0, 113.0, 114.0, 111.0, 110.0, 113.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 122.0, 147.0, 176.0, 117.0, 146.0, 151.0, 119.0, 175.0, 120.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 161.0, 164.0, 163.0, 164.0, 177.0, 163.0, 162.0, 161.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 157.0, 80.0, 75.0, 75.0, 75.0, 171.0, 75.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 154.0, 85.0, 84.0, 85.0, 150.0, 86.0, 84.0, 139.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 120.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 148.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 95.0, 96.0, 100.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 58.0, 53.0, 61.0, 55.0, 53.0, 57.0, 53.0, 55.0], "value": 55.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 63.0, 66.0, 62.0, 62.0, 61.0, 63.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 81.0, 77.0, 75.0, 75.0, 76.0, 76.0, 77.0, 82.0, 76.0], "value": 77.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 151.0, 129.0, 121.0, 129.0, 127.0, 121.0, 134.0, 163.0, 131.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 161.0, 155.0, 159.0, 157.0, 159.0, 160.0, 161.0, 155.0, 162.0], "value": 158.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 74.0, 65.0, 65.0, 67.0, 65.0, 66.0, 65.0], "value": 66.0, "unit": "score"}]}]} 12:55:20 INFO - Return code: 0 12:55:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:55:20 ERROR - # TBPL SUCCESS # 12:55:20 INFO - Running post-action listener: _resource_record_post_action 12:55:20 INFO - [mozharness: 2016-07-21 19:55:20.806094Z] Finished run-tests step (success) 12:55:20 INFO - Running post-run listener: _resource_record_post_run 12:55:20 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 560586752; Read time: 16; Write time: 475376 12:55:20 INFO - TinderboxPrint: CPU usage
13.3% 12:55:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:55:20 INFO - TinderboxPrint: I/O write bytes / time
560,586,752 / 475,376 12:55:20 INFO - TinderboxPrint: CPU idle
8,232.9 (86.6%) 12:55:20 INFO - TinderboxPrint: CPU user
1,212.6 (12.8%) 12:55:20 INFO - TinderboxPrint: Swap in / out
0 / 0 12:55:20 INFO - install - Wall time: 18s; CPU: 15.0%; Read bytes: 0; Write bytes: 267378688; Read time: 0; Write time: 286512 12:55:20 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 293208064; Read time: 0; Write time: 188864 12:55:21 INFO - Running post-run listener: _upload_blobber_files 12:55:21 INFO - Blob upload gear active. 12:55:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:55:21 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 12:55:21 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'] 12:55:21 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 12:55:21 INFO - (blobuploader) - INFO - Open directory for files ... 12:55:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 12:55:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 12:55:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:22 INFO - (blobuploader) - INFO - Done attempting. 12:55:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 12:55:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 12:55:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:23 INFO - (blobuploader) - INFO - Done attempting. 12:55:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:55:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:55:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:48 INFO - (blobuploader) - INFO - Done attempting. 12:55:48 INFO - (blobuploader) - INFO - Iteration through files over. 12:55:48 INFO - Return code: 0 12:55:48 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:55:48 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:55:48 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d5f2dd7c50abe927fb624ea8ddf87cb7fd8b8fcdddd63796187a91f5b66a59d3ea2643f80a8f2bf4bb45c0adb2d7bae2d4da4cca403f8a3b1746d5dedeb79b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c35abae1a5cde941b14a0dc820ccea50db544e47e4c3cd19b03f01a5e74a8de3f53986eca9ec6a301832b2205af5524d38be53d78f425ce7a578034865581205", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34febf8de9364a2eb98a2da64c9c7e35f3b409ac28929f16a5a1d1c91f87af48beaa44a5445267b841bcaa644e1c94cc08dbbb7a0e711e9beadd6eea426c9bec"} 12:55:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:55:48 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:55:48 INFO - Contents: 12:55:48 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4d5f2dd7c50abe927fb624ea8ddf87cb7fd8b8fcdddd63796187a91f5b66a59d3ea2643f80a8f2bf4bb45c0adb2d7bae2d4da4cca403f8a3b1746d5dedeb79b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c35abae1a5cde941b14a0dc820ccea50db544e47e4c3cd19b03f01a5e74a8de3f53986eca9ec6a301832b2205af5524d38be53d78f425ce7a578034865581205", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34febf8de9364a2eb98a2da64c9c7e35f3b409ac28929f16a5a1d1c91f87af48beaa44a5445267b841bcaa644e1c94cc08dbbb7a0e711e9beadd6eea426c9bec"} 12:55:48 INFO - Running post-run listener: copy_logs_to_upload_dir 12:55:48 INFO - Copying logs to upload dir... 12:55:48 INFO - mkdir: /builds/slave/test/build/upload/logs 12:55:48 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.359743 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-07-21 12:55:48.414244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 12:55:48.417786) ========= 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=00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292 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/4d5f2dd7c50abe927fb624ea8ddf87cb7fd8b8fcdddd63796187a91f5b66a59d3ea2643f80a8f2bf4bb45c0adb2d7bae2d4da4cca403f8a3b1746d5dedeb79b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c35abae1a5cde941b14a0dc820ccea50db544e47e4c3cd19b03f01a5e74a8de3f53986eca9ec6a301832b2205af5524d38be53d78f425ce7a578034865581205", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34febf8de9364a2eb98a2da64c9c7e35f3b409ac28929f16a5a1d1c91f87af48beaa44a5445267b841bcaa644e1c94cc08dbbb7a0e711e9beadd6eea426c9bec"} build_url:https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011250 build_url: 'https://queue.taskcluster.net/v1/task/Y9du-pqGS5Oy8kL9wIP_ww/artifacts/public/build/firefox-50.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/4d5f2dd7c50abe927fb624ea8ddf87cb7fd8b8fcdddd63796187a91f5b66a59d3ea2643f80a8f2bf4bb45c0adb2d7bae2d4da4cca403f8a3b1746d5dedeb79b1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c35abae1a5cde941b14a0dc820ccea50db544e47e4c3cd19b03f01a5e74a8de3f53986eca9ec6a301832b2205af5524d38be53d78f425ce7a578034865581205", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34febf8de9364a2eb98a2da64c9c7e35f3b409ac28929f16a5a1d1c91f87af48beaa44a5445267b841bcaa644e1c94cc08dbbb7a0e711e9beadd6eea426c9bec"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 12:55:48.442773) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:55:48.443117) ========= 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=00204705a9daa57ed339a427000001b9-1469129688.904659-1437461292 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 12:55:48.525049) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 12:55:48.525371) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 12:55:48.525652) ========= ========= Total master_lag: 0.17 =========