builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-066 starttime: 1467306903.01 results: success (0) buildid: 20160630073448 builduid: daad9d85d4c3400a80c68e9f4d79ecec revision: 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:03.009032) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:03.009415) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:03.009715) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:03.038497) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:03.038932) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 10:15:03-- 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% 225M=0s 2016-06-30 10:15:04 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.773241 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:03.826536) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:03.826846) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021247 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:03.877400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:03.877756) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 --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=82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 10:15:04,804 truncating revision to first 12 chars 2016-06-30 10:15:04,804 Setting DEBUG logging. 2016-06-30 10:15:04,804 attempt 1/10 2016-06-30 10:15:04,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/82e1f1b9c055?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 10:15:05,143 unpacking tar archive at: mozilla-central-82e1f1b9c055/testing/mozharness/ program finished with exit code 0 elapsedTime=0.689005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:04.580391) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:04.580727) ========= script_repo_revision: 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:04.581137) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:04.581406) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 10:15:04.592262) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-30 10:15:04.592639) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:15:05 INFO - MultiFileLogger online at 20160630 10:15:05 in /builds/slave/test 10:15:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:15:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:15:05 INFO - {'append_to_log': False, 10:15:05 INFO - 'base_work_dir': '/builds/slave/test', 10:15:05 INFO - 'blob_upload_branch': 'Firefox', 10:15:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:15:05 INFO - 'branch': 'Firefox', 10:15:05 INFO - 'buildbot_json_path': 'buildprops.json', 10:15:05 INFO - 'config_files': ('talos/linux_config.py',), 10:15:05 INFO - 'default_actions': ('clobber', 10:15:05 INFO - 'read-buildbot-config', 10:15:05 INFO - 'download-and-extract', 10:15:05 INFO - 'populate-webroot', 10:15:05 INFO - 'create-virtualenv', 10:15:05 INFO - 'install', 10:15:05 INFO - 'run-tests'), 10:15:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:15:05 INFO - 'download_minidump_stackwalk': True, 10:15:05 INFO - 'download_symbols': 'ondemand', 10:15:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:15:05 INFO - 'tooltool.py': '/tools/tooltool.py', 10:15:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:15:05 INFO - '/tools/misc-python/virtualenv.py')}, 10:15:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:15:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:15:05 INFO - 'installer_path': 'installer.exe', 10:15:05 INFO - 'log_level': 'info', 10:15:05 INFO - 'log_name': 'talos', 10:15:05 INFO - 'log_to_console': True, 10:15:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:15:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:15:05 INFO - 'opt_config_files': (), 10:15:05 INFO - 'pip_index': False, 10:15:05 INFO - 'sps_profile': False, 10:15:05 INFO - 'sps_profile_interval': 0, 10:15:05 INFO - 'suite': 'dromaeojs-e10s', 10:15:05 INFO - 'system_bits': '32', 10:15:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:15:05 INFO - 'title': 'talos-linux64-ix-066', 10:15:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:15:05 INFO - 'use_talos_json': True, 10:15:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:15:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:15:05 INFO - 'work_dir': 'build'} 10:15:05 INFO - ##### 10:15:05 INFO - ##### Running clobber step. 10:15:05 INFO - ##### 10:15:05 INFO - Running pre-action listener: _resource_record_pre_action 10:15:05 INFO - Running main action method: clobber 10:15:05 INFO - rmtree: /builds/slave/test/build 10:15:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:15:06 INFO - Running post-action listener: _resource_record_post_action 10:15:06 INFO - ##### 10:15:06 INFO - ##### Finished clobber step (success) 10:15:06 INFO - ##### 10:15:06 INFO - ##### 10:15:06 INFO - ##### Running read-buildbot-config step. 10:15:06 INFO - ##### 10:15:06 INFO - Running pre-action listener: _resource_record_pre_action 10:15:06 INFO - Running main action method: read_buildbot_config 10:15:06 INFO - Using buildbot properties: 10:15:06 INFO - { 10:15:06 INFO - "project": "", 10:15:06 INFO - "product": "firefox", 10:15:06 INFO - "script_repo_revision": "production", 10:15:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:15:06 INFO - "repository": "", 10:15:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:15:06 INFO - "buildid": "20160630073448", 10:15:06 INFO - "pgo_build": "True", 10:15:06 INFO - "basedir": "/builds/slave/test", 10:15:06 INFO - "buildnumber": 269, 10:15:06 INFO - "slavename": "talos-linux64-ix-066", 10:15:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:15:06 INFO - "platform": "ubuntu64_hw", 10:15:06 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:15:06 INFO - "branch": "mozilla-central", 10:15:06 INFO - "repo_path": "mozilla-central", 10:15:06 INFO - "revision": "82e1f1b9c0559f38a8460e2f2f3044de4c7712d6", 10:15:06 INFO - "stage_platform": "linux64-pgo", 10:15:06 INFO - "builduid": "daad9d85d4c3400a80c68e9f4d79ecec", 10:15:06 INFO - "slavebuilddir": "test" 10:15:06 INFO - } 10:15:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:15:06 INFO - Running post-action listener: _resource_record_post_action 10:15:06 INFO - ##### 10:15:06 INFO - ##### Finished read-buildbot-config step (success) 10:15:06 INFO - ##### 10:15:06 INFO - ##### 10:15:06 INFO - ##### Running download-and-extract step. 10:15:06 INFO - ##### 10:15:06 INFO - Running pre-action listener: _resource_record_pre_action 10:15:06 INFO - Running main action method: download_and_extract 10:15:06 INFO - mkdir: /builds/slave/test/build/tests 10:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:06 INFO - https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:15:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:15:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:15:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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 10:15:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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 10:15:07 INFO - Downloaded 1361 bytes. 10:15:07 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:15:07 INFO - Using the following test package requirements: 10:15:07 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:07 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:15:07 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:15:07 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:07 INFO - u'jsshell-linux-x86_64.zip'], 10:15:07 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:15:07 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:15:07 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:15:07 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:15:07 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:15:07 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:15:07 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:15:07 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:15:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:07 INFO - https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:15:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:15:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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 10:15:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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 10:15:08 INFO - Downloaded 24268234 bytes. 10:15:08 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'] 10:15:08 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 10:15:10 INFO - Return code: 0 10:15:10 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 10:15: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')]} 10:15:10 INFO - https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:15:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:15:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:15:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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 10:15:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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 10:15:27 INFO - Downloaded 24268234 bytes. 10:15:27 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'] 10:15:27 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 10:15:29 INFO - Return code: 0 10:15:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:29 INFO - https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:15:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:15:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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 10:15:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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 10:15:30 INFO - Downloaded 14405242 bytes. 10:15:30 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'] 10:15:30 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 10:15:30 INFO - Return code: 0 10:15:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:30 INFO - https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:15:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:15:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:15:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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 10:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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 10:15:31 INFO - Downloaded 60319739 bytes. 10:15:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:15:31 INFO - mkdir: /builds/slave/test/properties 10:15:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:15:31 INFO - Writing to file /builds/slave/test/properties/build_url 10:15:31 INFO - Contents: 10:15:31 INFO - build_url:https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:15:32 INFO - Running post-action listener: _resource_record_post_action 10:15:32 INFO - Running post-action listener: set_extra_try_arguments 10:15:32 INFO - ##### 10:15:32 INFO - ##### Finished download-and-extract step (success) 10:15:32 INFO - ##### 10:15:32 INFO - ##### 10:15:32 INFO - ##### Running populate-webroot step. 10:15:32 INFO - ##### 10:15:32 INFO - Running pre-action listener: _resource_record_pre_action 10:15:32 INFO - Running main action method: populate_webroot 10:15:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:15:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:15:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:15:32 INFO - '--tppagecycles', 10:15:32 INFO - '7'], 10:15:32 INFO - 'tests': ['tsvgm']}}, 10:15:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:15:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:15:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:15:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:15:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:15:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['damp', 'tps']}, 10:15:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'tests': ['damp', 'tps']}, 10:15:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['dromaeo_dom']}, 10:15:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:15:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['basic_compositor_video']}, 10:15:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:15:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'other-e10s': {'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['a11yr', 10:15:32 INFO - 'ts_paint', 10:15:32 INFO - 'tpaint', 10:15:32 INFO - 'sessionrestore', 10:15:32 INFO - 'sessionrestore_no_auto_restore', 10:15:32 INFO - 'tabpaint']}, 10:15:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['tsvgx', 10:15:32 INFO - 'tsvgr_opacity', 10:15:32 INFO - 'tart', 10:15:32 INFO - 'tscrollx', 10:15:32 INFO - 'cart']}, 10:15:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:15:32 INFO - 'tsvgr_opacity', 10:15:32 INFO - 'tart', 10:15:32 INFO - 'tscrollx', 10:15:32 INFO - 'cart']}, 10:15:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--disable-e10s'], 10:15:32 INFO - 'tests': ['tp5o']}, 10:15:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'tests': ['tp5o']}, 10:15:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--disable-e10s', 10:15:32 INFO - '--xperf_path', 10:15:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:32 INFO - 'tests': ['tp5n']}, 10:15:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:15:32 INFO - 'talos_options': ['--xperf_path', 10:15:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:15:32 INFO - 'tests': ['tp5n']}}, 10:15:32 INFO - 'talos.zip': {'path': '', 10:15:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:15:32 INFO - Running post-action listener: _resource_record_post_action 10:15:32 INFO - ##### 10:15:32 INFO - ##### Finished populate-webroot step (success) 10:15:32 INFO - ##### 10:15:32 INFO - ##### 10:15:32 INFO - ##### Running create-virtualenv step. 10:15:32 INFO - ##### 10:15:32 INFO - Running pre-action listener: _resource_record_pre_action 10:15:32 INFO - Running main action method: create_virtualenv 10:15:32 INFO - Creating virtualenv /builds/slave/test/build/venv 10:15:32 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 10:15:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:15:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:15:32 INFO - Using real prefix '/usr' 10:15:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:15:33 INFO - Installing distribute.............................................................................................................................................................................................done. 10:15:35 INFO - Installing pip.................done. 10:15:35 INFO - Return code: 0 10:15:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:15:35 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')]} 10:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:35 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')]} 10:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:35 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 0xdb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10773b0>, '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 0x10782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', '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 10:15:35 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 10:15:35 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 10:15:35 INFO - Using env: {'DISPLAY': ':0', 10:15:35 INFO - 'HOME': '/home/cltbld', 10:15:35 INFO - 'LANG': 'en_US.UTF-8', 10:15:35 INFO - 'LANGUAGE': 'en_US:en', 10:15:35 INFO - 'LOGNAME': 'cltbld', 10:15:35 INFO - 'MAIL': '/var/mail/cltbld', 10:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:35 INFO - 'MOZ_NO_REMOTE': '1', 10:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:35 INFO - 'NO_EM_RESTART': '1', 10:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:35 INFO - 'PWD': '/builds/slave/test', 10:15:35 INFO - 'SHELL': '/bin/bash', 10:15:35 INFO - 'SHLVL': '1', 10:15:35 INFO - 'TERM': 'linux', 10:15:35 INFO - 'TMOUT': '86400', 10:15:35 INFO - 'USER': 'cltbld', 10:15:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', 10:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:35 INFO - '_': '/tools/buildbot/bin/python'} 10:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:35 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 10:15:35 INFO - Cleaning up... 10:15:35 INFO - Return code: 0 10:15:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:15:35 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')]} 10:15:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:35 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')]} 10:15:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:35 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 0xdb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10773b0>, '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 0x10782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', '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 10:15:35 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 10:15:35 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 10:15:35 INFO - Using env: {'DISPLAY': ':0', 10:15:35 INFO - 'HOME': '/home/cltbld', 10:15:35 INFO - 'LANG': 'en_US.UTF-8', 10:15:35 INFO - 'LANGUAGE': 'en_US:en', 10:15:35 INFO - 'LOGNAME': 'cltbld', 10:15:35 INFO - 'MAIL': '/var/mail/cltbld', 10:15:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:35 INFO - 'MOZ_NO_REMOTE': '1', 10:15:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:35 INFO - 'NO_EM_RESTART': '1', 10:15:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:35 INFO - 'PWD': '/builds/slave/test', 10:15:35 INFO - 'SHELL': '/bin/bash', 10:15:35 INFO - 'SHLVL': '1', 10:15:35 INFO - 'TERM': 'linux', 10:15:35 INFO - 'TMOUT': '86400', 10:15:35 INFO - 'USER': 'cltbld', 10:15:35 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', 10:15:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:35 INFO - '_': '/tools/buildbot/bin/python'} 10:15:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:35 INFO - Downloading/unpacking psutil>=3.1.1 10:15:35 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 10:15:35 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 10:15:35 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 10:15:35 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 10:15:35 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 10:15:35 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 10:15:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:15:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:37 INFO - Installing collected packages: psutil 10:15:37 INFO - Running setup.py install for psutil 10:15:37 INFO - building 'psutil._psutil_linux' extension 10:15:37 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 10:15:37 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 10:15:37 INFO - building 'psutil._psutil_posix' extension 10:15:37 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 10:15:37 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 10:15:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:15:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:15:38 INFO - Successfully installed psutil 10:15:38 INFO - Cleaning up... 10:15:38 INFO - Return code: 0 10:15:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10773b0>, '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 0x10782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', '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 10:15:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:15:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:15:38 INFO - Using env: {'DISPLAY': ':0', 10:15:38 INFO - 'HOME': '/home/cltbld', 10:15:38 INFO - 'LANG': 'en_US.UTF-8', 10:15:38 INFO - 'LANGUAGE': 'en_US:en', 10:15:38 INFO - 'LOGNAME': 'cltbld', 10:15:38 INFO - 'MAIL': '/var/mail/cltbld', 10:15:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:38 INFO - 'MOZ_NO_REMOTE': '1', 10:15:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:38 INFO - 'NO_EM_RESTART': '1', 10:15:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:38 INFO - 'PWD': '/builds/slave/test', 10:15:38 INFO - 'SHELL': '/bin/bash', 10:15:38 INFO - 'SHLVL': '1', 10:15:38 INFO - 'TERM': 'linux', 10:15:38 INFO - 'TMOUT': '86400', 10:15:38 INFO - 'USER': 'cltbld', 10:15:38 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', 10:15:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:38 INFO - '_': '/tools/buildbot/bin/python'} 10:15:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:15:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:15:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:15:40 INFO - Installing collected packages: mozsystemmonitor 10:15:40 INFO - Running setup.py install for mozsystemmonitor 10:15:40 INFO - Successfully installed mozsystemmonitor 10:15:40 INFO - Cleaning up... 10:15:40 INFO - Return code: 0 10:15:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:40 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 0xdb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10773b0>, '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 0x10782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', '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 10:15:40 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 10:15:40 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 10:15:40 INFO - Using env: {'DISPLAY': ':0', 10:15:40 INFO - 'HOME': '/home/cltbld', 10:15:40 INFO - 'LANG': 'en_US.UTF-8', 10:15:40 INFO - 'LANGUAGE': 'en_US:en', 10:15:40 INFO - 'LOGNAME': 'cltbld', 10:15:40 INFO - 'MAIL': '/var/mail/cltbld', 10:15:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:40 INFO - 'MOZ_NO_REMOTE': '1', 10:15:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:40 INFO - 'NO_EM_RESTART': '1', 10:15:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:40 INFO - 'PWD': '/builds/slave/test', 10:15:40 INFO - 'SHELL': '/bin/bash', 10:15:40 INFO - 'SHLVL': '1', 10:15:40 INFO - 'TERM': 'linux', 10:15:40 INFO - 'TMOUT': '86400', 10:15:40 INFO - 'USER': 'cltbld', 10:15:40 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', 10:15:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:40 INFO - '_': '/tools/buildbot/bin/python'} 10:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:40 INFO - Downloading/unpacking jsonschema==2.5.1 10:15:40 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 10:15:40 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 10:15:40 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 10:15:40 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 10:15:40 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 10:15:40 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 10:15:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:15:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:15:42 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 10:15:42 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 10:15:42 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 10:15:42 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 10:15:42 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 10:15:42 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 10:15:42 INFO - Downloading functools32-3.2.3-2.tar.gz 10:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:15:42 INFO - warning: no files found matching '*.txt' 10:15:42 INFO - no previously-included directories found matching 'build' 10:15:42 INFO - no previously-included directories found matching 'dist' 10:15:42 INFO - no previously-included directories found matching '.git*' 10:15:42 INFO - Installing collected packages: jsonschema, functools32 10:15:42 INFO - Running setup.py install for functools32 10:15:42 INFO - warning: no files found matching '*.txt' 10:15:42 INFO - no previously-included directories found matching 'build' 10:15:42 INFO - no previously-included directories found matching 'dist' 10:15:42 INFO - no previously-included directories found matching '.git*' 10:15:42 INFO - Successfully installed jsonschema functools32 10:15:42 INFO - Cleaning up... 10:15:42 INFO - Return code: 0 10:15:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:15:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:42 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 0xdb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10773b0>, '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 0x10782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', '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 10:15:42 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 10:15:42 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 10:15:42 INFO - Using env: {'DISPLAY': ':0', 10:15:42 INFO - 'HOME': '/home/cltbld', 10:15:42 INFO - 'LANG': 'en_US.UTF-8', 10:15:42 INFO - 'LANGUAGE': 'en_US:en', 10:15:42 INFO - 'LOGNAME': 'cltbld', 10:15:42 INFO - 'MAIL': '/var/mail/cltbld', 10:15:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:42 INFO - 'MOZ_NO_REMOTE': '1', 10:15:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:42 INFO - 'NO_EM_RESTART': '1', 10:15:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:42 INFO - 'PWD': '/builds/slave/test', 10:15:42 INFO - 'SHELL': '/bin/bash', 10:15:42 INFO - 'SHLVL': '1', 10:15:42 INFO - 'TERM': 'linux', 10:15:42 INFO - 'TMOUT': '86400', 10:15:42 INFO - 'USER': 'cltbld', 10:15:42 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', 10:15:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:42 INFO - '_': '/tools/buildbot/bin/python'} 10:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:43 INFO - Downloading/unpacking blobuploader==1.2.4 10:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:45 INFO - Downloading blobuploader-1.2.4.tar.gz 10:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:15:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:15:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:15:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:15:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:15:45 INFO - Downloading docopt-0.6.1.tar.gz 10:15:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:15:45 INFO - Installing collected packages: blobuploader, requests, docopt 10:15:45 INFO - Running setup.py install for blobuploader 10:15:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:15:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:15:45 INFO - Running setup.py install for requests 10:15:46 INFO - Running setup.py install for docopt 10:15:46 INFO - Successfully installed blobuploader requests docopt 10:15:46 INFO - Cleaning up... 10:15:46 INFO - Return code: 0 10:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:46 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 0xdb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10773b0>, '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 0x10782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', '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 10:15:46 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 10:15:46 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 10:15:46 INFO - Using env: {'DISPLAY': ':0', 10:15:46 INFO - 'HOME': '/home/cltbld', 10:15:46 INFO - 'LANG': 'en_US.UTF-8', 10:15:46 INFO - 'LANGUAGE': 'en_US:en', 10:15:46 INFO - 'LOGNAME': 'cltbld', 10:15:46 INFO - 'MAIL': '/var/mail/cltbld', 10:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:46 INFO - 'MOZ_NO_REMOTE': '1', 10:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:46 INFO - 'NO_EM_RESTART': '1', 10:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:46 INFO - 'PWD': '/builds/slave/test', 10:15:46 INFO - 'SHELL': '/bin/bash', 10:15:46 INFO - 'SHLVL': '1', 10:15:46 INFO - 'TERM': 'linux', 10:15:46 INFO - 'TMOUT': '86400', 10:15:46 INFO - 'USER': 'cltbld', 10:15:46 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', 10:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:46 INFO - '_': '/tools/buildbot/bin/python'} 10:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:46 INFO - Running setup.py (path:/tmp/pip-CSLSs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:46 INFO - Running setup.py (path:/tmp/pip-wSZxwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:46 INFO - Running setup.py (path:/tmp/pip-GHKh7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:46 INFO - Running setup.py (path:/tmp/pip-xehNQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:46 INFO - Running setup.py (path:/tmp/pip-TH210j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:47 INFO - Running setup.py (path:/tmp/pip-JH0B_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:47 INFO - Running setup.py (path:/tmp/pip-K3E_RW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:47 INFO - Running setup.py (path:/tmp/pip-eP9vRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:47 INFO - Running setup.py (path:/tmp/pip-o9xoQL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:47 INFO - Running setup.py (path:/tmp/pip-Jyhi04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:47 INFO - Running setup.py (path:/tmp/pip-LOaQSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:47 INFO - Running setup.py (path:/tmp/pip-ApWejp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:47 INFO - Running setup.py (path:/tmp/pip-bOokFy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:47 INFO - Running setup.py (path:/tmp/pip-xs2APa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:47 INFO - Running setup.py (path:/tmp/pip-6GpPXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:47 INFO - Running setup.py (path:/tmp/pip-wvds45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:47 INFO - Running setup.py (path:/tmp/pip-xOWEeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:15:47 INFO - Running setup.py install for manifestparser 10:15:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:15:47 INFO - Running setup.py install for mozcrash 10:15:48 INFO - Running setup.py install for mozdebug 10:15:48 INFO - Running setup.py install for mozdevice 10:15:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for mozfile 10:15:48 INFO - Running setup.py install for mozhttpd 10:15:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for mozinfo 10:15:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for mozInstall 10:15:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for mozleak 10:15:48 INFO - Running setup.py install for mozlog 10:15:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:15:48 INFO - Running setup.py install for moznetwork 10:15:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Running setup.py install for mozprocess 10:15:49 INFO - Running setup.py install for mozprofile 10:15:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Running setup.py install for mozrunner 10:15:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Running setup.py install for mozscreenshot 10:15:49 INFO - Running setup.py install for moztest 10:15:49 INFO - Running setup.py install for mozversion 10:15:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:15:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:15:49 INFO - Cleaning up... 10:15:49 INFO - Return code: 0 10:15:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:15:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:49 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 0xdb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10773b0>, '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 0x10782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', '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 10:15:49 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 10:15:49 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 10:15:49 INFO - Using env: {'DISPLAY': ':0', 10:15:49 INFO - 'HOME': '/home/cltbld', 10:15:49 INFO - 'LANG': 'en_US.UTF-8', 10:15:49 INFO - 'LANGUAGE': 'en_US:en', 10:15:49 INFO - 'LOGNAME': 'cltbld', 10:15:49 INFO - 'MAIL': '/var/mail/cltbld', 10:15:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:49 INFO - 'MOZ_NO_REMOTE': '1', 10:15:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:49 INFO - 'NO_EM_RESTART': '1', 10:15:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:49 INFO - 'PWD': '/builds/slave/test', 10:15:49 INFO - 'SHELL': '/bin/bash', 10:15:49 INFO - 'SHLVL': '1', 10:15:49 INFO - 'TERM': 'linux', 10:15:49 INFO - 'TMOUT': '86400', 10:15:49 INFO - 'USER': 'cltbld', 10:15:49 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', 10:15:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:49 INFO - '_': '/tools/buildbot/bin/python'} 10:15:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:15:49 INFO - Running setup.py (path:/tmp/pip-vcLKDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:15:49 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)) 10:15:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:15:49 INFO - Running setup.py (path:/tmp/pip-B_hSkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:15:50 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:15:50 INFO - Running setup.py (path:/tmp/pip-iRo7Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:15:50 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:15:50 INFO - Running setup.py (path:/tmp/pip-qlF2sw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:15:50 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:15:50 INFO - Running setup.py (path:/tmp/pip-4BGIPL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:15:50 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:15:50 INFO - Running setup.py (path:/tmp/pip-u5l1zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:15:50 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:15:50 INFO - Running setup.py (path:/tmp/pip-6A8OmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:15:50 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:15:50 INFO - Running setup.py (path:/tmp/pip-wGJJs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:15:50 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:15:50 INFO - Running setup.py (path:/tmp/pip-kNbZK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:15:50 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:15:50 INFO - Running setup.py (path:/tmp/pip-FmrXZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:15:50 INFO - Running setup.py (path:/tmp/pip-aepTYw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:15:50 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:15:50 INFO - Running setup.py (path:/tmp/pip-vZTdJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:15:50 INFO - Running setup.py (path:/tmp/pip-WnFZ9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:15:50 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)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:15:50 INFO - Running setup.py (path:/tmp/pip-mt04Fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:15:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 10:15:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:50 INFO - Running setup.py (path:/tmp/pip-y2JTKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:15:51 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)) 10:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:15:51 INFO - Running setup.py (path:/tmp/pip-nVdofu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:15:51 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)) 10:15:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:15:51 INFO - Running setup.py (path:/tmp/pip-YSCar5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:15:51 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)) 10:15:51 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)) 10:15:51 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)) 10:15:51 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)) 10:15:51 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)) 10:15:51 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)) 10:15:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:15:51 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 10:15:51 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 10:15:51 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 10:15:51 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 10:15:51 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 10:15:51 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 10:15:53 INFO - Downloading blessings-1.6.tar.gz 10:15:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:15:53 INFO - Installing collected packages: blessings 10:15:53 INFO - Running setup.py install for blessings 10:15:53 INFO - Successfully installed blessings 10:15:53 INFO - Cleaning up... 10:15:53 INFO - Return code: 0 10:15:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:15:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:53 INFO - Reading from file tmpfile_stdout 10:15:53 INFO - Current package versions: 10:15:53 INFO - argparse == 1.2.1 10:15:53 INFO - blessings == 1.6 10:15:53 INFO - blobuploader == 1.2.4 10:15:53 INFO - docopt == 0.6.1 10:15:53 INFO - functools32 == 3.2.3-2 10:15:53 INFO - jsonschema == 2.5.1 10:15:53 INFO - manifestparser == 1.1 10:15:53 INFO - mozInstall == 1.12 10:15:53 INFO - mozcrash == 0.17 10:15:53 INFO - mozdebug == 0.1 10:15:53 INFO - mozdevice == 0.48 10:15:53 INFO - mozfile == 1.2 10:15:53 INFO - mozhttpd == 0.7 10:15:53 INFO - mozinfo == 0.9 10:15:53 INFO - mozleak == 0.1 10:15:53 INFO - mozlog == 3.2 10:15:53 INFO - moznetwork == 0.27 10:15:53 INFO - mozprocess == 0.22 10:15:53 INFO - mozprofile == 0.28 10:15:53 INFO - mozrunner == 6.11 10:15:53 INFO - mozscreenshot == 0.1 10:15:53 INFO - mozsystemmonitor == 0.3 10:15:53 INFO - moztest == 0.7 10:15:53 INFO - mozversion == 1.4 10:15:53 INFO - psutil == 3.1.1 10:15:53 INFO - requests == 1.2.3 10:15:53 INFO - wsgiref == 0.1.2 10:15:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:15:53 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')]} 10:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:53 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')]} 10:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:53 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 0xdb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10773b0>, '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 0x10782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', '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 10:15:53 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 10:15:53 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 10:15:53 INFO - Using env: {'DISPLAY': ':0', 10:15:53 INFO - 'HOME': '/home/cltbld', 10:15:53 INFO - 'LANG': 'en_US.UTF-8', 10:15:53 INFO - 'LANGUAGE': 'en_US:en', 10:15:53 INFO - 'LOGNAME': 'cltbld', 10:15:53 INFO - 'MAIL': '/var/mail/cltbld', 10:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:53 INFO - 'MOZ_NO_REMOTE': '1', 10:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:53 INFO - 'NO_EM_RESTART': '1', 10:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:53 INFO - 'PWD': '/builds/slave/test', 10:15:53 INFO - 'SHELL': '/bin/bash', 10:15:53 INFO - 'SHLVL': '1', 10:15:53 INFO - 'TERM': 'linux', 10:15:53 INFO - 'TMOUT': '86400', 10:15:53 INFO - 'USER': 'cltbld', 10:15:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', 10:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:53 INFO - '_': '/tools/buildbot/bin/python'} 10:15:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:53 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)) 10:15:53 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)) 10:15:53 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)) 10:15:53 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)) 10:15:53 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)) 10:15:53 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)) 10:15:53 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)) 10:15:53 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)) 10:15:53 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)) 10:15:53 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)) 10:15:53 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)) 10:15:53 INFO - Cleaning up... 10:15:53 INFO - Return code: 0 10:15:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:15:53 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')]} 10:15:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:15:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:53 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')]} 10:15:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:15:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:15:53 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 0xdb8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf1b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10773b0>, '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 0x10782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078740>, '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': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', '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 10:15:53 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 10:15:53 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 10:15:53 INFO - Using env: {'DISPLAY': ':0', 10:15:53 INFO - 'HOME': '/home/cltbld', 10:15:53 INFO - 'LANG': 'en_US.UTF-8', 10:15:53 INFO - 'LANGUAGE': 'en_US:en', 10:15:53 INFO - 'LOGNAME': 'cltbld', 10:15:53 INFO - 'MAIL': '/var/mail/cltbld', 10:15:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:15:53 INFO - 'MOZ_NO_REMOTE': '1', 10:15:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:15:53 INFO - 'NO_EM_RESTART': '1', 10:15:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:15:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:15:53 INFO - 'PWD': '/builds/slave/test', 10:15:53 INFO - 'SHELL': '/bin/bash', 10:15:53 INFO - 'SHLVL': '1', 10:15:53 INFO - 'TERM': 'linux', 10:15:53 INFO - 'TMOUT': '86400', 10:15:53 INFO - 'USER': 'cltbld', 10:15:53 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', 10:15:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:15:53 INFO - '_': '/tools/buildbot/bin/python'} 10:15:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:15:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:15:54 INFO - Cleaning up... 10:15:54 INFO - Return code: 0 10:15:54 INFO - Running post-action listener: _resource_record_post_action 10:15:54 INFO - Running post-action listener: _start_resource_monitoring 10:15:54 INFO - Starting resource monitoring. 10:15:54 INFO - ##### 10:15:54 INFO - ##### Finished create-virtualenv step (success) 10:15:54 INFO - ##### 10:15:54 INFO - ##### 10:15:54 INFO - ##### Running install step. 10:15:54 INFO - ##### 10:15:54 INFO - Running pre-action listener: _resource_record_pre_action 10:15:54 INFO - Running main action method: install 10:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:15:54 INFO - Reading from file tmpfile_stdout 10:15:54 INFO - Detecting whether we're running mozinstall >=1.0... 10:15:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:15:54 INFO - Reading from file tmpfile_stdout 10:15:54 INFO - Output received: 10:15:54 INFO - Usage: mozinstall [options] installer 10:15:54 INFO - Options: 10:15:54 INFO - -h, --help show this help message and exit 10:15:54 INFO - -d DEST, --destination=DEST 10:15:54 INFO - Directory to install application into. [default: 10:15:54 INFO - "/builds/slave/test"] 10:15:54 INFO - --app=APP Application being installed. [default: firefox] 10:15:54 INFO - mkdir: /builds/slave/test/build/application 10:15:54 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'] 10:15:54 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 10:16:11 INFO - Reading from file tmpfile_stdout 10:16:11 INFO - Output received: 10:16:11 INFO - /builds/slave/test/build/application/firefox/firefox 10:16:11 INFO - Running post-action listener: _resource_record_post_action 10:16:11 INFO - ##### 10:16:11 INFO - ##### Finished install step (success) 10:16:11 INFO - ##### 10:16:11 INFO - ##### 10:16:11 INFO - ##### Running run-tests step. 10:16:11 INFO - ##### 10:16:11 INFO - Running pre-action listener: _resource_record_pre_action 10:16:11 INFO - Running main action method: run_tests 10:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:16:11 INFO - Python 2.7.3 10:16:11 INFO - Return code: 0 10:16:11 INFO - grabbing minidump binary from tooltool 10:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:16:11 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 0x10773b0>, '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 0x10782b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1078740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:16:11 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 10:16:11 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 10:16:11 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 10:16:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:16:11 INFO - Return code: 0 10:16:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:16:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:16:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:16:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:16:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-066 --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 10:16:11 INFO - Using env: {'DISPLAY': ':0', 10:16:11 INFO - 'HOME': '/home/cltbld', 10:16:11 INFO - 'LANG': 'en_US.UTF-8', 10:16:11 INFO - 'LANGUAGE': 'en_US:en', 10:16:11 INFO - 'LOGNAME': 'cltbld', 10:16:11 INFO - 'MAIL': '/var/mail/cltbld', 10:16:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:16:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:16:11 INFO - 'MOZ_NO_REMOTE': '1', 10:16:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:16:11 INFO - 'NO_EM_RESTART': '1', 10:16:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:16:11 INFO - 'PWD': '/builds/slave/test', 10:16:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:16:11 INFO - 'SHELL': '/bin/bash', 10:16:11 INFO - 'SHLVL': '1', 10:16:11 INFO - 'TERM': 'linux', 10:16:11 INFO - 'TMOUT': '86400', 10:16:11 INFO - 'USER': 'cltbld', 10:16:11 INFO - 'XDG_SESSION_COOKIE': '82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209', 10:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:16:11 INFO - '_': '/tools/buildbot/bin/python'} 10:16:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-066', '--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 10:16:11 INFO - mozversion application_buildid: 20160630073448 10:16:11 INFO - mozversion application_changeset: 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 10:16:11 INFO - mozversion application_display_name: Nightly 10:16:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:16:11 INFO - mozversion application_name: Firefox 10:16:11 INFO - mozversion application_remotingname: firefox 10:16:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:16:11 INFO - mozversion application_vendor: Mozilla 10:16:11 INFO - mozversion application_version: 50.0a1 10:16:11 INFO - mozversion platform_buildid: 20160630073448 10:16:11 INFO - mozversion platform_changeset: 82e1f1b9c0559f38a8460e2f2f3044de4c7712d6 10:16:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:16:11 INFO - mozversion platform_version: 50.0a1 10:16:11 INFO - using testdate: 1467306971 10:16:11 INFO - actual date: 1467306971 10:16:11 INFO - starting webserver on 'localhost:36828' 10:16:11 INFO - SUITE-START | Running 2 tests 10:16:11 INFO - TEST-START | dromaeo_css 10:16:11 INFO - operating with platform_type : linux_ 10:16:11 INFO - Initialising browser for dromaeo_css test... 10:16:11 INFO - TEST-INFO | started process 13694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzyneNL/profile http://localhost:36828/getInfo.html) 10:16:16 INFO - PROCESS | 13694 | __metrics Screen width/height:1600/1200 10:16:16 INFO - PROCESS | 13694 | colorDepth:24 10:16:16 INFO - PROCESS | 13694 | Browser inner width/height: 1024/697 10:16:16 INFO - PROCESS | 13694 | __metrics 10:16:17 ERROR - PROCESS | 13694 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:16:18 INFO - TEST-INFO | 13694: exit 0 10:16:18 INFO - Browser initialized. 10:16:18 INFO - Running cycle 1/1 for dromaeo_css test... 10:16:18 INFO - TEST-INFO | started process 13817 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzyneNL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:16:30 INFO - PROCESS | 13817 | RSS: Main: 168636416 10:16:30 INFO - PROCESS | 13817 | 10:17:19 INFO - PROCESS | 13817 | 1467307039909 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] 10:19:27 INFO - PROCESS | 13817 | Cycle 1(1): loaded http://localhost:36828/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36828/tests/dromaeo/cssquery-ext.html) 10:19:29 INFO - PROCESS | 13817 | RSS: Main: 172306432 10:19:29 INFO - PROCESS | 13817 | 10:22:31 INFO - PROCESS | 13817 | Cycle 1(1): loaded http://localhost:36828/tests/dromaeo/cssquery-ext.html (next: http://localhost:36828/tests/dromaeo/cssquery-jquery.html) 10:22:31 INFO - PROCESS | 13817 | RSS: Main: 169619456 10:22:31 INFO - PROCESS | 13817 | 10:25:33 INFO - PROCESS | 13817 | Cycle 1(1): loaded http://localhost:36828/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36828/tests/dromaeo/cssquery-mootools.html) 10:25:34 INFO - PROCESS | 13817 | RSS: Main: 172511232 10:25:34 INFO - PROCESS | 13817 | 10:28:35 INFO - PROCESS | 13817 | Cycle 1(1): loaded http://localhost:36828/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36828/tests/dromaeo/cssquery-prototype.html) 10:28:36 INFO - PROCESS | 13817 | RSS: Main: 167514112 10:28:36 INFO - PROCESS | 13817 | 10:31:39 INFO - PROCESS | 13817 | Cycle 1(1): loaded http://localhost:36828/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36828/tests/dromaeo/cssquery-yui.html) 10:31:39 INFO - PROCESS | 13817 | RSS: Main: 169365504 10:31:39 INFO - PROCESS | 13817 | 10:34:42 INFO - PROCESS | 13817 | Cycle 1(1): loaded http://localhost:36828/tests/dromaeo/cssquery-yui.html (next: http://localhost:36828/tests/dromaeo/cssquery-dojo.html) 10:34:42 INFO - PROCESS | 13817 | RSS: Main: 170799104 10:34:42 INFO - PROCESS | 13817 | 10:34:42 INFO - PROCESS | 13817 | __start_tp_report 10:34:42 INFO - PROCESS | 13817 | _x_x_mozilla_page_load 10:34:42 INFO - PROCESS | 13817 | _x_x_mozilla_page_load_details 10:34:42 INFO - PROCESS | 13817 | |i|pagename|runs| 10:34:42 INFO - PROCESS | 13817 | |0;dojo.html;3125.078101959922;3140.4347217500867;3158.1630867820018;3158.968410315896;3182.8567714452847;5396.244525766391;5408.945910540893;5483.259759932408;5484.095124304485;5493.533049690776;5325.360956685203;5390.029794636964;5478.972605136969;5515.944840551603;5539.279893613824;4956.578690811285;4970.627202959783;5063.544281014708;5104.948950510485;5216.165413533835;656.7303632230996;4860.878478038059;4934.654574179809;4963.528464795839;5101.107306221415;4921.384826896638;4959.851204463872;4982.128127577677;4985.376827896513;4985.6759310644875;4976.979719157564;4981.576565991895;4984.053029924303;4988.975055124701;5010.348654674905;4902.166631672589;4969.751512424365;5003.374578177728;5007.949920500785;5014.974925125388;5454.59090568205;5492.203630473559;5498.5876059295715;5529.198266251411;5573.8606534836545;5646.096624540054;5844.795432159896;5872.089826076922;5875.1187321901625;5880.176775251468;5937.139114828369;5951.9107213391835;6028.39716028398;6029.246344206974;6053.485453736438;5535.418781027975;5550.69471179085;5568.1647752837;5583.939051580187;5587.692676902769;5701.258836351248;5897.941020589825;5917.378675239124;6071.119687645355;6082.330943596201;5814.563907706939;5819.6508209507565;5823.679697616587;5839.386864379179;5840.707964601753;5940.46535811779;5947.345791962881;5950.613210141327;5960.284765828128;5964.433378829004;5699.316082070178;5745.425457454221;5786.07422812348;5802.071668533014;5956.761729530857;5759.85600359986;5769.798057067983;5789.3052833659385;5816.1566572846705;5828.417158284137;4363.629091527192;4416.1609294233995;4421.53573874745;4433.268510695699;4475.619572336388;3885.4366116913457;3959.762414255154;3987.760734355948;3990.84036638537;4062.776547289868;5584.357798853184;5599.384067752544;5648.011597970339;5661.66030038199;5663.178839068312;5909.084091965752;5915;5915.142304365843;5921.2302400688495;5937.940620593825;5491.945080549223;5629.662220266715;5670.603057785998;5680.261565996394;5711.371749107595;4964.255361695775;4973.303737476756;4979.676321039121;4989.3264409305;5036.64743467961;5802.506786923159;6074.635521868702;6085.604435711664;6086.2087928569;6094.360092190344;5804.622699524517;5831.620944638585;5838.036723940502;5875.118732190205;5889.38161493037;5974.1636170935235;5983.55123365758;6007.279126504847;6007.969960150172;6014.879702405839;5586.13414920688;5755.683437410982;5768.307803063659;5771.94228057714;5804.158397032491;5912.260967379078;5917.142014407801;5921.970390148022;5928.407159284209;6046.334903160561;5753.769849205984;5787.8553036174435;5788.884222315614;5791.247137872049;5798.913016304843;5598.1322894951345;5638.971805140948;5673.77304907799;5771.018926782541;5776.162456443876;5615.550755939434;5619.887602247851;5624.437556244343;5654.6324488908085;5692.857678558069;5763.682997435014;5763.94236057634;5789.363170051207;5811.53507719373;5814.854628634318;5471.699056551928;5615.073512870331;5662.235598194191;5665.971670141623;5720.08478643415 10:34:42 INFO - PROCESS | 13817 | |1;ext.html;578.1905332534451;626.2735227136521;643.8680070585528;650.5738741124562;684.7808701215607;39396.803015984915;42961.570384296145;43137.705868823985;43298.350524742156;43434.34848477275;44065.559344406545;44554;44592.77703611486;44673.329900051525;44687.77656111715;8885.822283554326;8932.062133475989;8991.235744961687;9012.68455604054;9033.051529589397;8884.511351875644;8959.820803583925;8959.910400896006;8960.507172105532;8976.326775491832;8978.685745998891;9009.144131307516;9016.77458063547;9019.413738107034;9020.954895225515;8951.194392504673;8961.283097352196;9024.909750902472;9025.503597302146;9039.593218305192;8853.822923541558;8915.73252802417;8987.595558199897;8990.820183596357;8999.775005624846;40599.797001015104;40799.79600101981;41099.1780164398;41136.79431602853;41263.793681031704;2897.463969165711;3321.3025264694443;3460.723142148647;3528.6471352864764;3753.004986787979;30977.380452390826;31642;32077;32630.510542341646;32649.673503265138;4212.7682977436225;4236.809343579546;4270.12462445198;4352.347147927804;4401.977990110029;137820;137894.6210537892;138415.30792346076;138852;139124;33957.660423395944;36451.635483645354;36999.075023124096;37025;37064;35475.64524354723;37115.81442092772;37235.81382093072;37251.4412283816;37292.44061339082;14132.50536231227;14255.144691318554;14274.500392486421;14297.85702142986;14343.211123388313;11555.133364997491;11620.76758464826;11629.47667354971;11642.185047046625;11647.30116193031;8895.110488951183;8967.730968070968;9037.367384283169;9100.498417760995;9131.863022054675;3432.5709286339206;3463.8268086595567;3466.4800279957703;3509.385857474983;3555.8399872005302;974.4835237324229;1046.931949423285;1092.847001419802;1116.4864162485185;1129.1587767113554;32590.185245368582;32989.67010329866;33013.83493082567;33257.16857078592;33418;1100.0319718647538;1113.6158025481195;1118.424011634009;1135.239389608964;1159.6115301374134;16804.83195168057;17523.773618600353;17537.421632053178;17558.209880555405;17608.471745847644;519878;578541;580775;594965;796656;59791.103133453034;60110.39889601048;60285;60682.69658651679;60784.69607652022;1353.1813252982001;1370.047816767357;1371.4240019191964;1374.9656258593616;1378.7725025370903;31194.532082018333;33430.33139337151;33464.498032529045;33669.66330336665;33797.83101084479;52578.47421525889;52958;53298.2005269929;53321.7333913328;53390.46609533855;341665;345601;348243;348274;348883;29724.405511890072;29765;30344.393112137193;30361.696383035887;30421.847890760404;47776.7611161942;48537.757311213216;49174.50825491842;50049.99600031916;50258;40306.395404069546;41662.791686041375;42408.36387454129;42708.78645606877;43126.78436607797;41636.791816041936;41838.1632367357;42066;42080.3687944675;42290.154196916505;40846;41719.58280417157;41963.160736784484;42016.15967680691;42019.36970945499;31898.362032758752;33843.4923476153;34140;34359.48460773141;34445.31109377849;27882.86058569694;28176.577351340155;28186.577201342407;28196.154115376572;28350.432991339647 10:34:42 INFO - PROCESS | 13817 | |2;jquery.html;395.45427310311766;396.54991584551533;398.8922990792484;409.41658137154553;410.99383509247366;18220.362287319946;19977.500562485926;20018.59962800745;20372.388828335137;20722.792772072276;19379.4186174415;19791.406257812254;19899.403017909448;19941.90029049853;20019.39941801748;5299.205119232108;5646.124850648156;5654.632448890829;5664.122061080539;5733.5413166946755;5624.55003599711;5679.971600141994;5694.145878118274;5707.086866101425;5753.741081651336;5751.7986870459545;5818.738156782933;5905.232319798421;5912.940870591304;5938.287405511344;5795.275590551181;6444.903326450107;6585.045168450596;6615.603063816138;6626.93373066268;5777.1911932329085;5805.216295800055;5825.1844741736195;5860.120981852713;6014.75940962361;23034;23672.64491032636;24069.27792166238;24142.637860432107;24323.513529729484;2407.650890620868;2434.5861203595255;2444.1934161726585;2583.173384516955;2827.6324077869745;10000.94999525005;10595.25833191677;11007.119430445546;11392.886071139266;14812.777808332776;1998.9600207995904;2021.2521367094268;2032.4309193425865;2050.63088644044;2056.126146387794;76181.23818761797;83960.58019709862;86602.5669871653;87796;89504.5524772372;10723.30298530593;11065.114790816715;11091.889081109086;11126.61056863006;11164.944175279234;14340.282985850667;14544.200068996306;14552.908531859941;14583.270836458347;14594.635134121732;7655.693772249159;7704.730334438268;7728.304452599293;7899.565523896241;7972.481788683717;7436.070491188601;7576.924230757732;7667.386609071261;7785.610719464004;7825.686972521035;4459.777011149429;4559.544045595414;4611.446626404853;4679.298105284234;4807.759612019385;1938.7964263752103;1947.6688962876344;1980.4751740788702;1995.890226037582;2014.4963759060236;884.6240347852137;939.7274790310734;949.7293271417612;1007.3301254665565;1018.7707765752795;19115.904420478088;19757.802421975884;20014.89992550028;20051.598968020557;20575.691364629543;969.2004096620317;980.7008862296925;985.5417230987625;994.1847684898314;1059.9258051936445;10655.147588192925;10949.562017519369;11097.667069987914;11152.498137583829;11198.38408887519;345253;350995;454713;455126;459210;62259.37740622536;85547.57226213954;93271;99146.5042674782;99883;1004.708634495988;1007.1590222164575;1053.4206186597341;1065.7016035510069;1070.282910449985;15167.696646067237;17685.646287074444;17741.93548387101;17819;17935.103244837446;43651.56348436475;44935.77532112318;45233.77383113063;46285.53714462812;46392.76803615961;58240.70879645744;59584.70207648934;60485.69757151186;60504.39495604987;60838.391616083274;8484.321254299764;8642.09258027898;8664.393492455467;8745.737627871174;8885.42244754089;13109.934450327688;13186.604401867959;13301.268430236043;13766.518171863936;14630.341634626255;12266.4480098394;12415.44130514111;12462.813057804322;12739.490420383081;12896.677583060498;12387.566435175086;12610.558630447891;12619.74760504803;12624.747505049663;12915.483380665044;12214;12343.382830858602;12437.813432798695;12606.936965315115;12635.241885486901;8641.222289993932;8713.25937295337;8756.211940925346;8794.516301603473;8967.506787126771;8971.820563588823;11778.46996885125;11888.34614096233;12141.392930353624;12697.492100316253 10:34:42 INFO - PROCESS | 13817 | |3;mootools.html;1458.4312118273872;1503.2333509909945;1620.3923528676746;1777.6000399910022;1782.483079906827;8287.83424331513;8821.603027863746;8972.775680607989;9606.567704453299;9632.807343853128;8819.206271435569;8945.731628051153;9165.129312715299;9219.58511866966;9287.396319239244;2405.3144853716694;2418.5404773093055;2431.598786200275;2457.1400009996446;2457.5576396248666;2380.297812145421;2402.25530085674;2412.7949124324364;2436.8903399347073;2439.1462987954164;2431.501542183848;2443.755624437551;2449.4243852694603;2456.5823809952262;2469.8888550015204;2322.082777302964;2325.6395258734838;2329.6621989811465;2350.8001819845335;2380.8928598213124;2389.319044072431;2391.4380120671626;2394.437307232799;2395.5089206712582;2404.6393041043807;9265.841769778777;9385;9397.62409503619;9415.764605884839;9432.103950124796;5504;5636.379998200195;5642.576806739511;5664.971675141598;5674.687892165929;3483.9477407838904;3537.964620353789;3610.819459027038;3612.548431446069;3632.56409230894;1164.4585267850491;1166.7608140331213;1171.022196465952;1179.8466199394109;1185.8043422835221;13238.801417978642;13314.400851961685;13384.531541396005;13478.326083695874;13545;4845.53967373099;4882.975585122052;4935.3090567320605;5033.3205017322925;5074.695518268842;11359.261647992855;11360.943195283971;11393.25943813666;11397.487113079931;11420.657380278604;5698.17376480408;5704.229928959538;5706.229658996065;5707.3721890592005;5714.171445140431;4479.55204479556;4907.55831975124;5010.674306170087;5035.295058691786;5199.688018718889;4281.2293787118615;4305.095929854766;4390.397504910685;4400.845970391021;4401.22978478765;1340.9798853017212;1373.7733274009877;1379.35170469879;1388.5140200929593;1397.6366144802425;965.3049804141007;972.3096601412934;973.1728031173446;987.8419452887504;987.9012098790064;6217.96891015542;6385.744570217233;6385.776497822554;6407.327230640809;6506.707198175999;449.7369039112091;452.3621693412273;460.6360974829914;464.8256903661127;466.18185085175975;4364.236258654722;4460.7323560586465;4496.977515112469;4501.864944051684;4543.477500087466;11639.6508104757;11896.286222826659;12040.75918481643;12041.819372709417;12070.879291207151;11144.275622084539;11622.593209237637;11646.24299420535;12112.09159313055;12144.696382590506;8589.785255368666;8841.778955526162;8870.911290887008;8883.555822208864;8884.511351875579;6506.60960342381;6679.4990375721045;6694.765683201064;6813.693383797642;6857.862842743018;10926.945365273123;11031.22781405294;11067.280626759235;11176.608818691308;11199.60801371948;10478.895211048097;10708.785824283315;10750.946245269037;10784.784304314027;10847.077998370227;7366.96316518414;7738.2261773822165;7976.960115199619;8240.629171687408;8499.447535910145;9145.63417463294;9161.49611771359;9172.31207659415;9221.262299015929;9251.167394934488;8189.590520474072;8401.117882622237;8479.95760021196;8600.526971016654;8640.697575584825;7756.728514501965;7878.330341921001;7951.522908625501;7953;8174.264316211569;7505.174430812497;7510.511816731895;7547.05661792276;7579.052618422697;7582.962085189539;5413.377461591967;5512.428957747023;5570.415106413769;5587.944120558743;5708.029634962149;5555.916661250165;5660.7169641518585;5662.207290979184;5715.771369145187;5853.385394533512 10:34:42 INFO - PROCESS | 13817 | |4;prototype.html;323.8251344274092;324.6396499885127;327.8573820388131;331.2579821200509;333.77470207609855;5675.432456754323;5723.7121647629365;5731.914021289684;5734.741936612852;5766.855828604276;5641.943580564193;5645.5441882781015;5677.347105082917;5688.857778555538;5712.571557133211;4183.1215444756635;4293.785310734451;4353.71700839446;4382.9342559861625;4415.293553031515;4344.91310173798;4400.295952647577;4407.625351845081;4417.602415782579;4434.800433980478;4380.737155770648;4380.912381752379;4389.868303950887;4409.05205380843;4420.4253447052;4301.419308393358;4343.695941284127;4368.689393182032;4378.299472084483;4386;3794.810259487042;3802.6387493188104;3802.8098595070414;3814.5803961564206;3824.9235015299814;5525.723713814293;5531.695756733418;5551.2228288039705;5569.693666848321;5573.860653483695;4758.405199350082;4929.309896614477;4951.950480495185;4963.8262660806695;5049.570786483153;5914.319853216892;5919.408059194089;5920.898081181204;5947.345791962881;5954.672493012882;4141.937870931938;4156.937645935313;4160.1471698301775;4161.3549899765585;4169.833206671729;6034.39656034393;6066.332703402622;6084.39156084388;6124.265088189446;6151.924037980964;4296.183725092223;4310.52584215736;4315.438992930899;4316.611504964569;4317.266064768934;4348.695591308641;4352.455943007124;4360.781960902005;4372.256716358227;4383.693141480066;4887.193613053877;4954.851354459372;4974.527419895104;4993.375828021497;4997.700137991732;5945;5957.255343082114;5983.491403230774;6009.729562169713;6014.699265036731;1480.4596322342268;1498.8501149885142;1524.786529885817;1528.7783271425803;1530.0972426268554;942.8538576520513;953.7615596100975;963.8602402651576;998.6318743321696;1020.3367810922811;5713.285839270091;5720.342160651495;5724;5740.483356497935;5799.072148456226;6022.608530445507;6039.698015099315;6043.335233124353;6053.51571874249;6089.634621922699;5552.500274975271;5691.9146212806845;5699.145128230715;5699.544036477072;5716.1997320375185;3166.240102375459;3208.3102133041507;3208.4866421372467;3223.6615155408813;3235.2720637856296;5923.637563360451;6185.443310102112;6201.1938448002375;6220.626762394271;6231.688415579203;6188.226471691039;6196.437048697017;6200.720967556471;6207.348228435949;6229.563930524911;5885.705714714247;6177.1969643945995;6203.689815509207;6214.4407003369915;6224.968875155595;6014.578979471395;6022.247219097613;6049.0926361046195;6067.271927368744;6073;5956.136360227656;5990.64056156632;5996.37038110992;6034.939650603438;6059.33347331802;5869.559783016205;6122.295935967242;6131.84670383244;6146.264912114067;6176.320604733565;4264.296391095435;4271.893202669959;4321.719088259253;4327.3725309830525;4330.437043184366;5898.734556944862;6110.450059494667;6111.755529778759;6115.296740874856;6138.693065346625;5799.4780469757925;5830;5843.386444423444;5847.853803654943;5856.41435856428;5784.971075144597;5820.30156381237;5836.824895253149;5865.0058979947025;5866.120081987736;5362.302900622894;5777.826665200051;5801.419858014165;5857.238558987475;5866.911996319973;5986.6707331097205;5986.850328741816;5994.850128746816;6017.909731353946;6064.9646410164;5607.299087614048;5882.205902203319;5890.7349169288345;5936.257967754031;5965.313988891333 10:34:42 INFO - PROCESS | 13817 | |5;yui.html;736.3078706016347;750.0848964263597;776.7941495503688;819.4427789103411;853.1681610429831;12102.515899364014;15344.07935523868;16235;16423.014619122845;16646.084465354415;14963.476278330261;15262.084274943483;15277.38890444381;15402.152881591535;15402.61493462664;783.447669393078;806.1817255485687;808.0666829811577;808.6199486241458;808.7088648086684;788;789.6880732110812;791.8535071011881;796.8565658181525;797.027626295918;833.2375876073386;833.9291160251386;835.807764214231;837.6649340263882;838.2958315015386;793.083987993868;823.2672921100226;829.6473998550622;829.9543525106117;833.9874901876477;600.9909851352189;603.2971588099903;603.8279090459198;605.4399680295753;606.087837804102;15827.76258356114;15879.761803572956;15957.680846383124;15970.76043859343;15973.440929567409;14472.71054578913;14573.927130364385;14673.633159170999;15050.397984080624;15170.469033583771;10665.52005159762;12690.11169218155;12958.611241662766;13042.41309141091;13256.801147982787;3905.9804700976597;3929.4302326162547;3968.2460332536725;4010.6991975601654;4067;79184.60407697983;80168.59915700443;80201.19798802055;80221;80569;11514.30914145154;11592.710182245342;11770.705732356588;12133.820411494899;12272.631821045205;21401.78598214029;21439.356819295444;21447.249346272805;21496.677549836764;21500.89249553742;8669.472031637373;8693.304535637133;8763.211310981915;8791.164839340252;8983.281337492985;4959.404871415453;5123.38519377677;5168;5229.006488767198;5283.894322113536;3749.7375183736876;3854.4989151410136;3855.383138697795;3857.5756666766633;3861.2663593917064;669.437672355224;678.3860606151441;688.174190970837;693.1058933975216;695.8886578147473;711.1466240511407;734.6914295995695;742.1539445032668;760.5930827007525;767.1063211358704;9947.20422366209;10009.149222316039;10132.189424845994;10520.947395262974;10563.366198028143;586.8415527807554;701.5451880558413;702.596007295807;710.098175317344;757.6590534259495;4739.360186374795;5024.246363045572;5038.319826823332;5070.112730272188;5092.668976516515;65647.34352656508;78852.63442096746;119241;125221.37389312994;126012.36993814973;106496;106970;107117.464412679;108306;110393;91717.54141229251;94489.0551094494;95329.52335238279;97276.51361743288;98119.50940245253;9301.325761362748;9363.578638961128;9378.906210937803;9572.23422126242;9647.565859536197;53019.20471192858;54061;54381.72809135929;54621.72689136529;57108.42891571031;44290.335644966;44444.77777611091;57888.710556446946;78110.60944695468;80106;11669.649910502698;11870.347130907883;11946.880531194576;12034.458449369975;12347.073969452507;13116.08187426871;13245.337733113112;13507.594772156852;13721.794173087212;13754.210854647536;13089.607311780663;13434;13568.457261709817;13732.244726539737;13823;13170.670733231746;13509.864901351253;13613.251271180181;13672.658183545092;13824.308784560933;13302.800457992944;13370.465181392636;13504.527341542998;13761;13922;10206.489675516046;10419.583216671248;10509.264550238211;10602.416867072077;10691.839622405514;10676.519556620126;10761.677149685522;10803.282913387226;10835.783284334428;10853.131749460183 10:34:42 INFO - PROCESS | 13817 | __end_tp_report 10:34:42 INFO - PROCESS | 13817 | __start_cc_report 10:34:42 INFO - PROCESS | 13817 | _x_x_mozilla_cycle_collect,349 10:34:42 INFO - PROCESS | 13817 | __end_cc_report 10:34:42 INFO - PROCESS | 13817 | __startTimestamp1467308082605__endTimestamp 10:34:42 INFO - PROCESS | 13817 | 10:34:42 INFO - PROCESS | 13817 | ------- Summary: start ------- 10:34:42 INFO - PROCESS | 13817 | Number of tests: 6 10:34:42 INFO - PROCESS | 13817 | 10:34:42 INFO - PROCESS | 13817 | [#0] dojo.html Cycles:165 Average:5425.01 Median:5665.97 stddev:730.40 (12.9%) stddev-sans-first:710.00 10:34:42 INFO - PROCESS | 13817 | Values: 3125.1 3140.4 3158.2 3159.0 3182.9 5396.2 5408.9 5483.3 5484.1 5493.5 5325.4 5390.0 5479.0 5515.9 5539.3 4956.6 4970.6 5063.5 5104.9 5216.2 656.7 4860.9 4934.7 4963.5 5101.1 4921.4 4959.9 4982.1 4985.4 4985.7 4977.0 4981.6 4984.1 4989.0 5010.3 4902.2 4969.8 5003.4 5007.9 5015.0 5454.6 5492.2 5498.6 5529.2 5573.9 5646.1 5844.8 5872.1 5875.1 5880.2 5937.1 5951.9 6028.4 6029.2 6053.5 5535.4 5550.7 5568.2 5583.9 5587.7 5701.3 5897.9 5917.4 6071.1 6082.3 5814.6 5819.7 5823.7 5839.4 5840.7 5940.5 5947.3 5950.6 5960.3 5964.4 5699.3 5745.4 5786.1 5802.1 5956.8 5759.9 5769.8 5789.3 5816.2 5828.4 4363.6 4416.2 4421.5 4433.3 4475.6 3885.4 3959.8 3987.8 3990.8 4062.8 5584.4 5599.4 5648.0 5661.7 5663.2 5909.1 5915.0 5915.1 5921.2 5937.9 5491.9 5629.7 5670.6 5680.3 5711.4 4964.3 4973.3 4979.7 4989.3 5036.6 5802.5 6074.6 6085.6 6086.2 6094.4 5804.6 5831.6 5838.0 5875.1 5889.4 5974.2 5983.6 6007.3 6008.0 6014.9 5586.1 5755.7 5768.3 5771.9 5804.2 5912.3 5917.1 5922.0 5928.4 6046.3 5753.8 5787.9 5788.9 5791.2 5798.9 5598.1 5639.0 5673.8 5771.0 5776.2 5615.6 5619.9 5624.4 5654.6 5692.9 5763.7 5763.9 5789.4 5811.5 5814.9 5471.7 5615.1 5662.2 5666.0 5720.1 10:34:42 INFO - PROCESS | 13817 | 10:34:42 INFO - PROCESS | 13817 | [#1] ext.html Cycles:180 Average:52536.55 Median:40453.10 stddev:112810.12 (278.9%) stddev-sans-first:113059.13 10:34:42 INFO - PROCESS | 13817 | Values: 578.2 626.3 643.9 650.6 684.8 39396.8 42961.6 43137.7 43298.4 43434.3 44065.6 44554.0 44592.8 44673.3 44687.8 8885.8 8932.1 8991.2 9012.7 9033.1 8884.5 8959.8 8959.9 8960.5 8976.3 8978.7 9009.1 9016.8 9019.4 9021.0 8951.2 8961.3 9024.9 9025.5 9039.6 8853.8 8915.7 8987.6 8990.8 8999.8 40599.8 40799.8 41099.2 41136.8 41263.8 2897.5 3321.3 3460.7 3528.6 3753.0 30977.4 31642.0 32077.0 32630.5 32649.7 4212.8 4236.8 4270.1 4352.3 4402.0 137820.0 137894.6 138415.3 138852.0 139124.0 33957.7 36451.6 36999.1 37025.0 37064.0 35475.6 37115.8 37235.8 37251.4 37292.4 14132.5 14255.1 14274.5 14297.9 14343.2 11555.1 11620.8 11629.5 11642.2 11647.3 8895.1 8967.7 9037.4 9100.5 9131.9 3432.6 3463.8 3466.5 3509.4 3555.8 974.5 1046.9 1092.8 1116.5 1129.2 32590.2 32989.7 33013.8 33257.2 33418.0 1100.0 1113.6 1118.4 1135.2 1159.6 16804.8 17523.8 17537.4 17558.2 17608.5 519878.0 578541.0 580775.0 594965.0 796656.0 59791.1 60110.4 60285.0 60682.7 60784.7 1353.2 1370.0 1371.4 1375.0 1378.8 31194.5 33430.3 33464.5 33669.7 33797.8 52578.5 52958.0 53298.2 53321.7 53390.5 341665.0 345601.0 348243.0 348274.0 348883.0 29724.4 29765.0 30344.4 30361.7 30421.8 47776.8 48537.8 49174.5 50050.0 50258.0 40306.4 41662.8 42408.4 42708.8 43126.8 41636.8 41838.2 42066.0 42080.4 42290.2 40846.0 41719.6 41963.2 42016.2 42019.4 31898.4 33843.5 34140.0 34359.5 34445.3 27882.9 28176.6 28186.6 28196.2 28350.4 10:34:42 INFO - PROCESS | 13817 | 10:34:42 INFO - PROCESS | 13817 | [#2] jquery.html Cycles:180 Average:27210.48 Median:2705.40 stddev:69213.29 (2558.3%) stddev-sans-first:69378.17 10:34:42 INFO - PROCESS | 13817 | Values: 395.5 396.5 398.9 409.4 411.0 18220.4 19977.5 20018.6 20372.4 20722.8 19379.4 19791.4 19899.4 19941.9 20019.4 5299.2 5646.1 5654.6 5664.1 5733.5 5624.6 5680.0 5694.1 5707.1 5753.7 5751.8 5818.7 5905.2 5912.9 5938.3 5795.3 6444.9 6585.0 6615.6 6626.9 5777.2 5805.2 5825.2 5860.1 6014.8 23034.0 23672.6 24069.3 24142.6 24323.5 2407.7 2434.6 2444.2 2583.2 2827.6 10000.9 10595.3 11007.1 11392.9 14812.8 1999.0 2021.3 2032.4 2050.6 2056.1 76181.2 83960.6 86602.6 87796.0 89504.6 10723.3 11065.1 11091.9 11126.6 11164.9 14340.3 14544.2 14552.9 14583.3 14594.6 7655.7 7704.7 7728.3 7899.6 7972.5 7436.1 7576.9 7667.4 7785.6 7825.7 4459.8 4559.5 4611.4 4679.3 4807.8 1938.8 1947.7 1980.5 1995.9 2014.5 884.6 939.7 949.7 1007.3 1018.8 19115.9 19757.8 20014.9 20051.6 20575.7 969.2 980.7 985.5 994.2 1059.9 10655.1 10949.6 11097.7 11152.5 11198.4 345253.0 350995.0 454713.0 455126.0 459210.0 62259.4 85547.6 93271.0 99146.5 99883.0 1004.7 1007.2 1053.4 1065.7 1070.3 15167.7 17685.6 17741.9 17819.0 17935.1 43651.6 44935.8 45233.8 46285.5 46392.8 58240.7 59584.7 60485.7 60504.4 60838.4 8484.3 8642.1 8664.4 8745.7 8885.4 13109.9 13186.6 13301.3 13766.5 14630.3 12266.4 12415.4 12462.8 12739.5 12896.7 12387.6 12610.6 12619.7 12624.7 12915.5 12214.0 12343.4 12437.8 12606.9 12635.2 8641.2 8713.3 8756.2 8794.5 8967.5 8971.8 11778.5 11888.3 12141.4 12697.5 10:34:42 INFO - PROCESS | 13817 | 10:34:42 INFO - PROCESS | 13817 | [#3] mootools.html Cycles:180 Average:6202.77 Median:2655.86 stddev:3593.58 (135.3%) stddev-sans-first:3585.97 10:34:42 INFO - PROCESS | 13817 | Values: 1458.4 1503.2 1620.4 1777.6 1782.5 8287.8 8821.6 8972.8 9606.6 9632.8 8819.2 8945.7 9165.1 9219.6 9287.4 2405.3 2418.5 2431.6 2457.1 2457.6 2380.3 2402.3 2412.8 2436.9 2439.1 2431.5 2443.8 2449.4 2456.6 2469.9 2322.1 2325.6 2329.7 2350.8 2380.9 2389.3 2391.4 2394.4 2395.5 2404.6 9265.8 9385.0 9397.6 9415.8 9432.1 5504.0 5636.4 5642.6 5665.0 5674.7 3483.9 3538.0 3610.8 3612.5 3632.6 1164.5 1166.8 1171.0 1179.8 1185.8 13238.8 13314.4 13384.5 13478.3 13545.0 4845.5 4883.0 4935.3 5033.3 5074.7 11359.3 11360.9 11393.3 11397.5 11420.7 5698.2 5704.2 5706.2 5707.4 5714.2 4479.6 4907.6 5010.7 5035.3 5199.7 4281.2 4305.1 4390.4 4400.8 4401.2 1341.0 1373.8 1379.4 1388.5 1397.6 965.3 972.3 973.2 987.8 987.9 6218.0 6385.7 6385.8 6407.3 6506.7 449.7 452.4 460.6 464.8 466.2 4364.2 4460.7 4497.0 4501.9 4543.5 11639.7 11896.3 12040.8 12041.8 12070.9 11144.3 11622.6 11646.2 12112.1 12144.7 8589.8 8841.8 8870.9 8883.6 8884.5 6506.6 6679.5 6694.8 6813.7 6857.9 10926.9 11031.2 11067.3 11176.6 11199.6 10478.9 10708.8 10750.9 10784.8 10847.1 7367.0 7738.2 7977.0 8240.6 8499.4 9145.6 9161.5 9172.3 9221.3 9251.2 8189.6 8401.1 8480.0 8600.5 8640.7 7756.7 7878.3 7951.5 7953.0 8174.3 7505.2 7510.5 7547.1 7579.1 7583.0 5413.4 5512.4 5570.4 5587.9 5708.0 5555.9 5660.7 5662.2 5715.8 5853.4 10:34:42 INFO - PROCESS | 13817 | 10:34:42 INFO - PROCESS | 13817 | [#4] prototype.html Cycles:180 Average:4965.05 Median:5722.03 stddev:1468.53 (25.7%) stddev-sans-first:1430.73 10:34:42 INFO - PROCESS | 13817 | Values: 323.8 324.6 327.9 331.3 333.8 5675.4 5723.7 5731.9 5734.7 5766.9 5641.9 5645.5 5677.3 5688.9 5712.6 4183.1 4293.8 4353.7 4382.9 4415.3 4344.9 4400.3 4407.6 4417.6 4434.8 4380.7 4380.9 4389.9 4409.1 4420.4 4301.4 4343.7 4368.7 4378.3 4386.0 3794.8 3802.6 3802.8 3814.6 3824.9 5525.7 5531.7 5551.2 5569.7 5573.9 4758.4 4929.3 4952.0 4963.8 5049.6 5914.3 5919.4 5920.9 5947.3 5954.7 4141.9 4156.9 4160.1 4161.4 4169.8 6034.4 6066.3 6084.4 6124.3 6151.9 4296.2 4310.5 4315.4 4316.6 4317.3 4348.7 4352.5 4360.8 4372.3 4383.7 4887.2 4954.9 4974.5 4993.4 4997.7 5945.0 5957.3 5983.5 6009.7 6014.7 1480.5 1498.9 1524.8 1528.8 1530.1 942.9 953.8 963.9 998.6 1020.3 5713.3 5720.3 5724.0 5740.5 5799.1 6022.6 6039.7 6043.3 6053.5 6089.6 5552.5 5691.9 5699.1 5699.5 5716.2 3166.2 3208.3 3208.5 3223.7 3235.3 5923.6 6185.4 6201.2 6220.6 6231.7 6188.2 6196.4 6200.7 6207.3 6229.6 5885.7 6177.2 6203.7 6214.4 6225.0 6014.6 6022.2 6049.1 6067.3 6073.0 5956.1 5990.6 5996.4 6034.9 6059.3 5869.6 6122.3 6131.8 6146.3 6176.3 4264.3 4271.9 4321.7 4327.4 4330.4 5898.7 6110.5 6111.8 6115.3 6138.7 5799.5 5830.0 5843.4 5847.9 5856.4 5785.0 5820.3 5836.8 5865.0 5866.1 5362.3 5777.8 5801.4 5857.2 5866.9 5986.7 5986.9 5994.9 6017.9 6065.0 5607.3 5882.2 5890.7 5936.3 5965.3 10:34:42 INFO - PROCESS | 13817 | 10:34:42 INFO - PROCESS | 13817 | [#5] yui.html Cycles:180 Average:20823.21 Median:4038.85 stddev:30320.88 (750.7%) stddev-sans-first:30368.42 10:34:42 INFO - PROCESS | 13817 | Values: 736.3 750.1 776.8 819.4 853.2 12102.5 15344.1 16235.0 16423.0 16646.1 14963.5 15262.1 15277.4 15402.2 15402.6 783.4 806.2 808.1 808.6 808.7 788.0 789.7 791.9 796.9 797.0 833.2 833.9 835.8 837.7 838.3 793.1 823.3 829.6 830.0 834.0 601.0 603.3 603.8 605.4 606.1 15827.8 15879.8 15957.7 15970.8 15973.4 14472.7 14573.9 14673.6 15050.4 15170.5 10665.5 12690.1 12958.6 13042.4 13256.8 3906.0 3929.4 3968.2 4010.7 4067.0 79184.6 80168.6 80201.2 80221.0 80569.0 11514.3 11592.7 11770.7 12133.8 12272.6 21401.8 21439.4 21447.2 21496.7 21500.9 8669.5 8693.3 8763.2 8791.2 8983.3 4959.4 5123.4 5168.0 5229.0 5283.9 3749.7 3854.5 3855.4 3857.6 3861.3 669.4 678.4 688.2 693.1 695.9 711.1 734.7 742.2 760.6 767.1 9947.2 10009.1 10132.2 10520.9 10563.4 586.8 701.5 702.6 710.1 757.7 4739.4 5024.2 5038.3 5070.1 5092.7 65647.3 78852.6 119241.0 125221.4 126012.4 106496.0 106970.0 107117.5 108306.0 110393.0 91717.5 94489.1 95329.5 97276.5 98119.5 9301.3 9363.6 9378.9 9572.2 9647.6 53019.2 54061.0 54381.7 54621.7 57108.4 44290.3 44444.8 57888.7 78110.6 80106.0 11669.6 11870.3 11946.9 12034.5 12347.1 13116.1 13245.3 13507.6 13721.8 13754.2 13089.6 13434.0 13568.5 13732.2 13823.0 13170.7 13509.9 13613.3 13672.7 13824.3 13302.8 13370.5 13504.5 13761.0 13922.0 10206.5 10419.6 10509.3 10602.4 10691.8 10676.5 10761.7 10803.3 10835.8 10853.1 10:34:42 INFO - PROCESS | 13817 | -------- Summary: end -------- 10:34:42 INFO - PROCESS | 13817 | 10:34:43 INFO - TEST-INFO | 13817: exit 0 10:34:43 INFO - TEST-OK | dromaeo_css | took 1111373ms 10:34:43 INFO - TEST-START | kraken 10:34:43 INFO - operating with platform_type : linux_ 10:34:43 INFO - Initialising browser for kraken test... 10:34:43 INFO - TEST-INFO | started process 14068 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZU3hgm/profile http://localhost:36828/getInfo.html) 10:34:48 INFO - PROCESS | 14068 | __metrics Screen width/height:1600/1200 10:34:48 INFO - PROCESS | 14068 | colorDepth:24 10:34:48 INFO - PROCESS | 14068 | Browser inner width/height: 1024/697 10:34:48 INFO - PROCESS | 14068 | __metrics 10:34:48 ERROR - PROCESS | 14068 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 10:34:49 INFO - TEST-INFO | 14068: exit 0 10:34:49 INFO - Browser initialized. 10:34:49 INFO - Running cycle 1/1 for kraken test... 10:34:49 INFO - TEST-INFO | started process 14186 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZU3hgm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:35:01 INFO - PROCESS | 14186 | RSS: Main: 168701952 10:35:01 INFO - PROCESS | 14186 | 10:35:03 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36828/tests/kraken/driver.html?testName=audio-beat-detection) 10:35:04 INFO - PROCESS | 14186 | RSS: Main: 173772800 10:35:04 INFO - PROCESS | 14186 | 10:35:07 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36828/tests/kraken/driver.html?testName=audio-dft) 10:35:07 INFO - PROCESS | 14186 | RSS: Main: 173166592 10:35:07 INFO - PROCESS | 14186 | 10:35:10 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36828/tests/kraken/driver.html?testName=audio-fft) 10:35:11 INFO - PROCESS | 14186 | RSS: Main: 168214528 10:35:11 INFO - PROCESS | 14186 | 10:35:13 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36828/tests/kraken/driver.html?testName=audio-oscillator) 10:35:14 INFO - PROCESS | 14186 | RSS: Main: 169005056 10:35:14 INFO - PROCESS | 14186 | 10:35:16 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36828/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:35:16 INFO - PROCESS | 14186 | RSS: Main: 169414656 10:35:16 INFO - PROCESS | 14186 | 10:35:20 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36828/tests/kraken/driver.html?testName=imaging-darkroom) 10:35:20 INFO - PROCESS | 14186 | RSS: Main: 170217472 10:35:20 INFO - PROCESS | 14186 | 10:35:24 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36828/tests/kraken/driver.html?testName=imaging-desaturate) 10:35:24 INFO - PROCESS | 14186 | RSS: Main: 167084032 10:35:24 INFO - PROCESS | 14186 | 10:35:27 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36828/tests/kraken/driver.html?testName=json-parse-financial) 10:35:28 INFO - PROCESS | 14186 | RSS: Main: 168148992 10:35:28 INFO - PROCESS | 14186 | 10:35:29 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36828/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:35:30 INFO - PROCESS | 14186 | RSS: Main: 168472576 10:35:30 INFO - PROCESS | 14186 | 10:35:32 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36828/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:35:32 INFO - PROCESS | 14186 | RSS: Main: 168755200 10:35:32 INFO - PROCESS | 14186 | 10:35:34 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36828/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:35:35 INFO - PROCESS | 14186 | RSS: Main: 169263104 10:35:35 INFO - PROCESS | 14186 | 10:35:38 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:35:38 INFO - PROCESS | 14186 | RSS: Main: 169447424 10:35:38 INFO - PROCESS | 14186 | 10:35:41 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:35:42 INFO - PROCESS | 14186 | RSS: Main: 168972288 10:35:42 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | Cycle 1(1): loaded http://localhost:36828/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36828/tests/kraken/driver.html?testName=ai-astar) 10:35:43 INFO - PROCESS | 14186 | RSS: Main: 169857024 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | __start_tp_report 10:35:43 INFO - PROCESS | 14186 | _x_x_mozilla_page_load 10:35:43 INFO - PROCESS | 14186 | _x_x_mozilla_page_load_details 10:35:43 INFO - PROCESS | 14186 | |i|pagename|runs| 10:35:43 INFO - PROCESS | 14186 | |0;ai-astar;102;112;106;111;112;112;113;113;111;111 10:35:43 INFO - PROCESS | 14186 | |1;audio-beat-detection;145;122;140;164;117;143;149;122;191;118 10:35:43 INFO - PROCESS | 14186 | |2;audio-dft;162;163;162;163;162;164;165;174;169;163 10:35:43 INFO - PROCESS | 14186 | |3;audio-fft;74;76;76;168;76;75;75;75;171;75 10:35:43 INFO - PROCESS | 14186 | |4;audio-oscillator;84;84;146;84;84;83;145;84;84;138 10:35:43 INFO - PROCESS | 14186 | |5;imaging-gaussian-blur;118;118;117;117;118;117;118;118;118;117 10:35:43 INFO - PROCESS | 14186 | |6;imaging-darkroom;146;148;147;150;149;150;147;147;147;147 10:35:43 INFO - PROCESS | 14186 | |7;imaging-desaturate;96;96;98;96;95;96;95;96;95;96 10:35:43 INFO - PROCESS | 14186 | |8;json-parse-financial;53;54;53;52;54;52;54;53;52;56 10:35:43 INFO - PROCESS | 14186 | |9;json-stringify-tinderbox;62;61;61;63;62;61;60;61;63;62 10:35:43 INFO - PROCESS | 14186 | |10;stanford-crypto-aes;75;75;74;75;75;75;75;74;79;74 10:35:43 INFO - PROCESS | 14186 | |11;stanford-crypto-ccm;128;119;122;120;130;120;122;143;157;127 10:35:43 INFO - PROCESS | 14186 | |12;stanford-crypto-pbkdf2;156;155;156;159;157;157;161;154;159;155 10:35:43 INFO - PROCESS | 14186 | |13;stanford-crypto-sha256-iterative;65;67;69;73;65;64;62;64;66;65 10:35:43 INFO - PROCESS | 14186 | __end_tp_report 10:35:43 INFO - PROCESS | 14186 | __start_cc_report 10:35:43 INFO - PROCESS | 14186 | _x_x_mozilla_cycle_collect,894 10:35:43 INFO - PROCESS | 14186 | __end_cc_report 10:35:43 INFO - PROCESS | 14186 | __startTimestamp1467308143948__endTimestamp 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | ------- Summary: start ------- 10:35:43 INFO - PROCESS | 14186 | Number of tests: 14 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#0] ai-astar Cycles:10 Average:110.30 Median:112.00 stddev:3.53 (3.2%) stddev-sans-first:2.11 10:35:43 INFO - PROCESS | 14186 | Values: 102.0 112.0 106.0 111.0 112.0 112.0 113.0 113.0 111.0 111.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:144.00 stddev:23.43 (16.3%) stddev-sans-first:24.81 10:35:43 INFO - PROCESS | 14186 | Values: 145.0 122.0 140.0 164.0 117.0 143.0 149.0 122.0 191.0 118.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#2] audio-dft Cycles:10 Average:164.70 Median:163.50 stddev:3.89 (2.4%) stddev-sans-first:4.00 10:35:43 INFO - PROCESS | 14186 | Values: 162.0 163.0 162.0 163.0 162.0 164.0 165.0 174.0 169.0 163.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#3] audio-fft Cycles:10 Average:94.10 Median:75.00 stddev:39.75 (53.0%) stddev-sans-first:41.49 10:35:43 INFO - PROCESS | 14186 | Values: 74.0 76.0 76.0 168.0 76.0 75.0 75.0 75.0 171.0 75.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#4] audio-oscillator Cycles:10 Average:101.60 Median:84.00 stddev:28.64 (34.1%) stddev-sans-first:29.67 10:35:43 INFO - PROCESS | 14186 | Values: 84.0 84.0 146.0 84.0 84.0 83.0 145.0 84.0 84.0 138.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:35:43 INFO - PROCESS | 14186 | Values: 118.0 118.0 117.0 117.0 118.0 117.0 118.0 118.0 118.0 117.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:147.50 stddev:1.40 (0.9%) stddev-sans-first:1.32 10:35:43 INFO - PROCESS | 14186 | Values: 146.0 148.0 147.0 150.0 149.0 150.0 147.0 147.0 147.0 147.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 10:35:43 INFO - PROCESS | 14186 | Values: 96.0 96.0 98.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.50 stddev:1.25 (2.3%) stddev-sans-first:1.32 10:35:43 INFO - PROCESS | 14186 | Values: 53.0 54.0 53.0 52.0 54.0 52.0 54.0 53.0 52.0 56.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.97 (1.6%) stddev-sans-first:1.01 10:35:43 INFO - PROCESS | 14186 | Values: 62.0 61.0 61.0 63.0 62.0 61.0 60.0 61.0 63.0 62.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#10] stanford-crypto-aes Cycles:10 Average:75.10 Median:75.00 stddev:1.45 (1.9%) stddev-sans-first:1.54 10:35:43 INFO - PROCESS | 14186 | Values: 75.0 75.0 74.0 75.0 75.0 75.0 75.0 74.0 79.0 74.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#11] stanford-crypto-ccm Cycles:10 Average:128.80 Median:127.50 stddev:12.23 (9.6%) stddev-sans-first:12.97 10:35:43 INFO - PROCESS | 14186 | Values: 128.0 119.0 122.0 120.0 130.0 120.0 122.0 143.0 157.0 127.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.90 Median:157.00 stddev:2.18 (1.4%) stddev-sans-first:2.29 10:35:43 INFO - PROCESS | 14186 | Values: 156.0 155.0 156.0 159.0 157.0 157.0 161.0 154.0 159.0 155.0 10:35:43 INFO - PROCESS | 14186 | 10:35:43 INFO - PROCESS | 14186 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:65.50 stddev:3.09 (4.7%) stddev-sans-first:3.26 10:35:43 INFO - PROCESS | 14186 | Values: 65.0 67.0 69.0 73.0 65.0 64.0 62.0 64.0 66.0 65.0 10:35:43 INFO - PROCESS | 14186 | -------- Summary: end -------- 10:35:43 INFO - PROCESS | 14186 | 10:35:44 INFO - TEST-INFO | 14186: exit 0 10:35:44 INFO - TEST-OK | kraken | took 61629ms 10:35:44 INFO - SUITE-END | took 1173s 10:35:45 INFO - Completed test suite (00:19:33) 10:35:45 INFO - javascript benchmark 10:35:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7313.106645475781, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3125.078101959922, 3140.4347217500867, 3158.1630867820018, 3158.968410315896, 3182.8567714452847, 5396.244525766391, 5408.945910540893, 5483.259759932408, 5484.095124304485, 5493.533049690776, 5325.360956685203, 5390.029794636964, 5478.972605136969, 5515.944840551603, 5539.279893613824, 4956.578690811285, 4970.627202959783, 5063.544281014708, 5104.948950510485, 5216.165413533835, 656.7303632230996, 4860.878478038059, 4934.654574179809, 4963.528464795839, 5101.107306221415, 4921.384826896638, 4959.851204463872, 4982.128127577677, 4985.376827896513, 4985.6759310644875, 4976.979719157564, 4981.576565991895, 4984.053029924303, 4988.975055124701, 5010.348654674905, 4902.166631672589, 4969.751512424365, 5003.374578177728, 5007.949920500785, 5014.974925125388, 5454.59090568205, 5492.203630473559, 5498.5876059295715, 5529.198266251411, 5573.8606534836545, 5646.096624540054, 5844.795432159896, 5872.089826076922, 5875.1187321901625, 5880.176775251468, 5937.139114828369, 5951.9107213391835, 6028.39716028398, 6029.246344206974, 6053.485453736438, 5535.418781027975, 5550.69471179085, 5568.1647752837, 5583.939051580187, 5587.692676902769, 5701.258836351248, 5897.941020589825, 5917.378675239124, 6071.119687645355, 6082.330943596201, 5814.563907706939, 5819.6508209507565, 5823.679697616587, 5839.386864379179, 5840.707964601753, 5940.46535811779, 5947.345791962881, 5950.613210141327, 5960.284765828128, 5964.433378829004, 5699.316082070178, 5745.425457454221, 5786.07422812348, 5802.071668533014, 5956.761729530857, 5759.85600359986, 5769.798057067983, 5789.3052833659385, 5816.1566572846705, 5828.417158284137, 4363.629091527192, 4416.1609294233995, 4421.53573874745, 4433.268510695699, 4475.619572336388, 3885.4366116913457, 3959.762414255154, 3987.760734355948, 3990.84036638537, 4062.776547289868, 5584.357798853184, 5599.384067752544, 5648.011597970339, 5661.66030038199, 5663.178839068312, 5909.084091965752, 5915.0, 5915.142304365843, 5921.2302400688495, 5937.940620593825, 5491.945080549223, 5629.662220266715, 5670.603057785998, 5680.261565996394, 5711.371749107595, 4964.255361695775, 4973.303737476756, 4979.676321039121, 4989.3264409305, 5036.64743467961, 5802.506786923159, 6074.635521868702, 6085.604435711664, 6086.2087928569, 6094.360092190344, 5804.622699524517, 5831.620944638585, 5838.036723940502, 5875.118732190205, 5889.38161493037, 5974.1636170935235, 5983.55123365758, 6007.279126504847, 6007.969960150172, 6014.879702405839, 5586.13414920688, 5755.683437410982, 5768.307803063659, 5771.94228057714, 5804.158397032491, 5912.260967379078, 5917.142014407801, 5921.970390148022, 5928.407159284209, 6046.334903160561, 5753.769849205984, 5787.8553036174435, 5788.884222315614, 5791.247137872049, 5798.913016304843, 5598.1322894951345, 5638.971805140948, 5673.77304907799, 5771.018926782541, 5776.162456443876, 5615.550755939434, 5619.887602247851, 5624.437556244343, 5654.6324488908085, 5692.857678558069, 5763.682997435014, 5763.94236057634, 5789.363170051207, 5811.53507719373, 5814.854628634318, 5471.699056551928, 5615.073512870331, 5662.235598194191, 5665.971670141623, 5720.08478643415], "value": 5376.7364355653, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.1905332534451, 626.2735227136521, 643.8680070585528, 650.5738741124562, 684.7808701215607, 39396.803015984915, 42961.570384296145, 43137.705868823985, 43298.350524742156, 43434.34848477275, 44065.559344406545, 44554.0, 44592.77703611486, 44673.329900051525, 44687.77656111715, 8885.822283554326, 8932.062133475989, 8991.235744961687, 9012.68455604054, 9033.051529589397, 8884.511351875644, 8959.820803583925, 8959.910400896006, 8960.507172105532, 8976.326775491832, 8978.685745998891, 9009.144131307516, 9016.77458063547, 9019.413738107034, 9020.954895225515, 8951.194392504673, 8961.283097352196, 9024.909750902472, 9025.503597302146, 9039.593218305192, 8853.822923541558, 8915.73252802417, 8987.595558199897, 8990.820183596357, 8999.775005624846, 40599.797001015104, 40799.79600101981, 41099.1780164398, 41136.79431602853, 41263.793681031704, 2897.463969165711, 3321.3025264694443, 3460.723142148647, 3528.6471352864764, 3753.004986787979, 30977.380452390826, 31642.0, 32077.0, 32630.510542341646, 32649.673503265138, 4212.7682977436225, 4236.809343579546, 4270.12462445198, 4352.347147927804, 4401.977990110029, 137820.0, 137894.6210537892, 138415.30792346076, 138852.0, 139124.0, 33957.660423395944, 36451.635483645354, 36999.075023124096, 37025.0, 37064.0, 35475.64524354723, 37115.81442092772, 37235.81382093072, 37251.4412283816, 37292.44061339082, 14132.50536231227, 14255.144691318554, 14274.500392486421, 14297.85702142986, 14343.211123388313, 11555.133364997491, 11620.76758464826, 11629.47667354971, 11642.185047046625, 11647.30116193031, 8895.110488951183, 8967.730968070968, 9037.367384283169, 9100.498417760995, 9131.863022054675, 3432.5709286339206, 3463.8268086595567, 3466.4800279957703, 3509.385857474983, 3555.8399872005302, 974.4835237324229, 1046.931949423285, 1092.847001419802, 1116.4864162485185, 1129.1587767113554, 32590.185245368582, 32989.67010329866, 33013.83493082567, 33257.16857078592, 33418.0, 1100.0319718647538, 1113.6158025481195, 1118.424011634009, 1135.239389608964, 1159.6115301374134, 16804.83195168057, 17523.773618600353, 17537.421632053178, 17558.209880555405, 17608.471745847644, 519878.0, 578541.0, 580775.0, 594965.0, 796656.0, 59791.103133453034, 60110.39889601048, 60285.0, 60682.69658651679, 60784.69607652022, 1353.1813252982001, 1370.047816767357, 1371.4240019191964, 1374.9656258593616, 1378.7725025370903, 31194.532082018333, 33430.33139337151, 33464.498032529045, 33669.66330336665, 33797.83101084479, 52578.47421525889, 52958.0, 53298.2005269929, 53321.7333913328, 53390.46609533855, 341665.0, 345601.0, 348243.0, 348274.0, 348883.0, 29724.405511890072, 29765.0, 30344.393112137193, 30361.696383035887, 30421.847890760404, 47776.7611161942, 48537.757311213216, 49174.50825491842, 50049.99600031916, 50258.0, 40306.395404069546, 41662.791686041375, 42408.36387454129, 42708.78645606877, 43126.78436607797, 41636.791816041936, 41838.1632367357, 42066.0, 42080.3687944675, 42290.154196916505, 40846.0, 41719.58280417157, 41963.160736784484, 42016.15967680691, 42019.36970945499, 31898.362032758752, 33843.4923476153, 34140.0, 34359.48460773141, 34445.31109377849, 27882.86058569694, 28176.577351340155, 28186.577201342407, 28196.154115376572, 28350.432991339647], "value": 18314.37970348521, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.45427310311766, 396.54991584551533, 398.8922990792484, 409.41658137154553, 410.99383509247366, 18220.362287319946, 19977.500562485926, 20018.59962800745, 20372.388828335137, 20722.792772072276, 19379.4186174415, 19791.406257812254, 19899.403017909448, 19941.90029049853, 20019.39941801748, 5299.205119232108, 5646.124850648156, 5654.632448890829, 5664.122061080539, 5733.5413166946755, 5624.55003599711, 5679.971600141994, 5694.145878118274, 5707.086866101425, 5753.741081651336, 5751.7986870459545, 5818.738156782933, 5905.232319798421, 5912.940870591304, 5938.287405511344, 5795.275590551181, 6444.903326450107, 6585.045168450596, 6615.603063816138, 6626.93373066268, 5777.1911932329085, 5805.216295800055, 5825.1844741736195, 5860.120981852713, 6014.75940962361, 23034.0, 23672.64491032636, 24069.27792166238, 24142.637860432107, 24323.513529729484, 2407.650890620868, 2434.5861203595255, 2444.1934161726585, 2583.173384516955, 2827.6324077869745, 10000.94999525005, 10595.25833191677, 11007.119430445546, 11392.886071139266, 14812.777808332776, 1998.9600207995904, 2021.2521367094268, 2032.4309193425865, 2050.63088644044, 2056.126146387794, 76181.23818761797, 83960.58019709862, 86602.5669871653, 87796.0, 89504.5524772372, 10723.30298530593, 11065.114790816715, 11091.889081109086, 11126.61056863006, 11164.944175279234, 14340.282985850667, 14544.200068996306, 14552.908531859941, 14583.270836458347, 14594.635134121732, 7655.693772249159, 7704.730334438268, 7728.304452599293, 7899.565523896241, 7972.481788683717, 7436.070491188601, 7576.924230757732, 7667.386609071261, 7785.610719464004, 7825.686972521035, 4459.777011149429, 4559.544045595414, 4611.446626404853, 4679.298105284234, 4807.759612019385, 1938.7964263752103, 1947.6688962876344, 1980.4751740788702, 1995.890226037582, 2014.4963759060236, 884.6240347852137, 939.7274790310734, 949.7293271417612, 1007.3301254665565, 1018.7707765752795, 19115.904420478088, 19757.802421975884, 20014.89992550028, 20051.598968020557, 20575.691364629543, 969.2004096620317, 980.7008862296925, 985.5417230987625, 994.1847684898314, 1059.9258051936445, 10655.147588192925, 10949.562017519369, 11097.667069987914, 11152.498137583829, 11198.38408887519, 345253.0, 350995.0, 454713.0, 455126.0, 459210.0, 62259.37740622536, 85547.57226213954, 93271.0, 99146.5042674782, 99883.0, 1004.708634495988, 1007.1590222164575, 1053.4206186597341, 1065.7016035510069, 1070.282910449985, 15167.696646067237, 17685.646287074444, 17741.93548387101, 17819.0, 17935.103244837446, 43651.56348436475, 44935.77532112318, 45233.77383113063, 46285.53714462812, 46392.76803615961, 58240.70879645744, 59584.70207648934, 60485.69757151186, 60504.39495604987, 60838.391616083274, 8484.321254299764, 8642.09258027898, 8664.393492455467, 8745.737627871174, 8885.42244754089, 13109.934450327688, 13186.604401867959, 13301.268430236043, 13766.518171863936, 14630.341634626255, 12266.4480098394, 12415.44130514111, 12462.813057804322, 12739.490420383081, 12896.677583060498, 12387.566435175086, 12610.558630447891, 12619.74760504803, 12624.747505049663, 12915.483380665044, 12214.0, 12343.382830858602, 12437.813432798695, 12606.936965315115, 12635.241885486901, 8641.222289993932, 8713.25937295337, 8756.211940925346, 8794.516301603473, 8967.506787126771, 8971.820563588823, 11778.46996885125, 11888.34614096233, 12141.392930353624, 12697.492100316253], "value": 9388.421781790905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.4312118273872, 1503.2333509909945, 1620.3923528676746, 1777.6000399910022, 1782.483079906827, 8287.83424331513, 8821.603027863746, 8972.775680607989, 9606.567704453299, 9632.807343853128, 8819.206271435569, 8945.731628051153, 9165.129312715299, 9219.58511866966, 9287.396319239244, 2405.3144853716694, 2418.5404773093055, 2431.598786200275, 2457.1400009996446, 2457.5576396248666, 2380.297812145421, 2402.25530085674, 2412.7949124324364, 2436.8903399347073, 2439.1462987954164, 2431.501542183848, 2443.755624437551, 2449.4243852694603, 2456.5823809952262, 2469.8888550015204, 2322.082777302964, 2325.6395258734838, 2329.6621989811465, 2350.8001819845335, 2380.8928598213124, 2389.319044072431, 2391.4380120671626, 2394.437307232799, 2395.5089206712582, 2404.6393041043807, 9265.841769778777, 9385.0, 9397.62409503619, 9415.764605884839, 9432.103950124796, 5504.0, 5636.379998200195, 5642.576806739511, 5664.971675141598, 5674.687892165929, 3483.9477407838904, 3537.964620353789, 3610.819459027038, 3612.548431446069, 3632.56409230894, 1164.4585267850491, 1166.7608140331213, 1171.022196465952, 1179.8466199394109, 1185.8043422835221, 13238.801417978642, 13314.400851961685, 13384.531541396005, 13478.326083695874, 13545.0, 4845.53967373099, 4882.975585122052, 4935.3090567320605, 5033.3205017322925, 5074.695518268842, 11359.261647992855, 11360.943195283971, 11393.25943813666, 11397.487113079931, 11420.657380278604, 5698.17376480408, 5704.229928959538, 5706.229658996065, 5707.3721890592005, 5714.171445140431, 4479.55204479556, 4907.55831975124, 5010.674306170087, 5035.295058691786, 5199.688018718889, 4281.2293787118615, 4305.095929854766, 4390.397504910685, 4400.845970391021, 4401.22978478765, 1340.9798853017212, 1373.7733274009877, 1379.35170469879, 1388.5140200929593, 1397.6366144802425, 965.3049804141007, 972.3096601412934, 973.1728031173446, 987.8419452887504, 987.9012098790064, 6217.96891015542, 6385.744570217233, 6385.776497822554, 6407.327230640809, 6506.707198175999, 449.7369039112091, 452.3621693412273, 460.6360974829914, 464.8256903661127, 466.18185085175975, 4364.236258654722, 4460.7323560586465, 4496.977515112469, 4501.864944051684, 4543.477500087466, 11639.6508104757, 11896.286222826659, 12040.75918481643, 12041.819372709417, 12070.879291207151, 11144.275622084539, 11622.593209237637, 11646.24299420535, 12112.09159313055, 12144.696382590506, 8589.785255368666, 8841.778955526162, 8870.911290887008, 8883.555822208864, 8884.511351875579, 6506.60960342381, 6679.4990375721045, 6694.765683201064, 6813.693383797642, 6857.862842743018, 10926.945365273123, 11031.22781405294, 11067.280626759235, 11176.608818691308, 11199.60801371948, 10478.895211048097, 10708.785824283315, 10750.946245269037, 10784.784304314027, 10847.077998370227, 7366.96316518414, 7738.2261773822165, 7976.960115199619, 8240.629171687408, 8499.447535910145, 9145.63417463294, 9161.49611771359, 9172.31207659415, 9221.262299015929, 9251.167394934488, 8189.590520474072, 8401.117882622237, 8479.95760021196, 8600.526971016654, 8640.697575584825, 7756.728514501965, 7878.330341921001, 7951.522908625501, 7953.0, 8174.264316211569, 7505.174430812497, 7510.511816731895, 7547.05661792276, 7579.052618422697, 7582.962085189539, 5413.377461591967, 5512.428957747023, 5570.415106413769, 5587.944120558743, 5708.029634962149, 5555.916661250165, 5660.7169641518585, 5662.207290979184, 5715.771369145187, 5853.385394533512], "value": 4840.4388029061865, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.8251344274092, 324.6396499885127, 327.8573820388131, 331.2579821200509, 333.77470207609855, 5675.432456754323, 5723.7121647629365, 5731.914021289684, 5734.741936612852, 5766.855828604276, 5641.943580564193, 5645.5441882781015, 5677.347105082917, 5688.857778555538, 5712.571557133211, 4183.1215444756635, 4293.785310734451, 4353.71700839446, 4382.9342559861625, 4415.293553031515, 4344.91310173798, 4400.295952647577, 4407.625351845081, 4417.602415782579, 4434.800433980478, 4380.737155770648, 4380.912381752379, 4389.868303950887, 4409.05205380843, 4420.4253447052, 4301.419308393358, 4343.695941284127, 4368.689393182032, 4378.299472084483, 4386.0, 3794.810259487042, 3802.6387493188104, 3802.8098595070414, 3814.5803961564206, 3824.9235015299814, 5525.723713814293, 5531.695756733418, 5551.2228288039705, 5569.693666848321, 5573.860653483695, 4758.405199350082, 4929.309896614477, 4951.950480495185, 4963.8262660806695, 5049.570786483153, 5914.319853216892, 5919.408059194089, 5920.898081181204, 5947.345791962881, 5954.672493012882, 4141.937870931938, 4156.937645935313, 4160.1471698301775, 4161.3549899765585, 4169.833206671729, 6034.39656034393, 6066.332703402622, 6084.39156084388, 6124.265088189446, 6151.924037980964, 4296.183725092223, 4310.52584215736, 4315.438992930899, 4316.611504964569, 4317.266064768934, 4348.695591308641, 4352.455943007124, 4360.781960902005, 4372.256716358227, 4383.693141480066, 4887.193613053877, 4954.851354459372, 4974.527419895104, 4993.375828021497, 4997.700137991732, 5945.0, 5957.255343082114, 5983.491403230774, 6009.729562169713, 6014.699265036731, 1480.4596322342268, 1498.8501149885142, 1524.786529885817, 1528.7783271425803, 1530.0972426268554, 942.8538576520513, 953.7615596100975, 963.8602402651576, 998.6318743321696, 1020.3367810922811, 5713.285839270091, 5720.342160651495, 5724.0, 5740.483356497935, 5799.072148456226, 6022.608530445507, 6039.698015099315, 6043.335233124353, 6053.51571874249, 6089.634621922699, 5552.500274975271, 5691.9146212806845, 5699.145128230715, 5699.544036477072, 5716.1997320375185, 3166.240102375459, 3208.3102133041507, 3208.4866421372467, 3223.6615155408813, 3235.2720637856296, 5923.637563360451, 6185.443310102112, 6201.1938448002375, 6220.626762394271, 6231.688415579203, 6188.226471691039, 6196.437048697017, 6200.720967556471, 6207.348228435949, 6229.563930524911, 5885.705714714247, 6177.1969643945995, 6203.689815509207, 6214.4407003369915, 6224.968875155595, 6014.578979471395, 6022.247219097613, 6049.0926361046195, 6067.271927368744, 6073.0, 5956.136360227656, 5990.64056156632, 5996.37038110992, 6034.939650603438, 6059.33347331802, 5869.559783016205, 6122.295935967242, 6131.84670383244, 6146.264912114067, 6176.320604733565, 4264.296391095435, 4271.893202669959, 4321.719088259253, 4327.3725309830525, 4330.437043184366, 5898.734556944862, 6110.450059494667, 6111.755529778759, 6115.296740874856, 6138.693065346625, 5799.4780469757925, 5830.0, 5843.386444423444, 5847.853803654943, 5856.41435856428, 5784.971075144597, 5820.30156381237, 5836.824895253149, 5865.0058979947025, 5866.120081987736, 5362.302900622894, 5777.826665200051, 5801.419858014165, 5857.238558987475, 5866.911996319973, 5986.6707331097205, 5986.850328741816, 5994.850128746816, 6017.909731353946, 6064.9646410164, 5607.299087614048, 5882.205902203319, 5890.7349169288345, 5936.257967754031, 5965.313988891333], "value": 4487.293531542641, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [736.3078706016347, 750.0848964263597, 776.7941495503688, 819.4427789103411, 853.1681610429831, 12102.515899364014, 15344.07935523868, 16235.0, 16423.014619122845, 16646.084465354415, 14963.476278330261, 15262.084274943483, 15277.38890444381, 15402.152881591535, 15402.61493462664, 783.447669393078, 806.1817255485687, 808.0666829811577, 808.6199486241458, 808.7088648086684, 788.0, 789.6880732110812, 791.8535071011881, 796.8565658181525, 797.027626295918, 833.2375876073386, 833.9291160251386, 835.807764214231, 837.6649340263882, 838.2958315015386, 793.083987993868, 823.2672921100226, 829.6473998550622, 829.9543525106117, 833.9874901876477, 600.9909851352189, 603.2971588099903, 603.8279090459198, 605.4399680295753, 606.087837804102, 15827.76258356114, 15879.761803572956, 15957.680846383124, 15970.76043859343, 15973.440929567409, 14472.71054578913, 14573.927130364385, 14673.633159170999, 15050.397984080624, 15170.469033583771, 10665.52005159762, 12690.11169218155, 12958.611241662766, 13042.41309141091, 13256.801147982787, 3905.9804700976597, 3929.4302326162547, 3968.2460332536725, 4010.6991975601654, 4067.0, 79184.60407697983, 80168.59915700443, 80201.19798802055, 80221.0, 80569.0, 11514.30914145154, 11592.710182245342, 11770.705732356588, 12133.820411494899, 12272.631821045205, 21401.78598214029, 21439.356819295444, 21447.249346272805, 21496.677549836764, 21500.89249553742, 8669.472031637373, 8693.304535637133, 8763.211310981915, 8791.164839340252, 8983.281337492985, 4959.404871415453, 5123.38519377677, 5168.0, 5229.006488767198, 5283.894322113536, 3749.7375183736876, 3854.4989151410136, 3855.383138697795, 3857.5756666766633, 3861.2663593917064, 669.437672355224, 678.3860606151441, 688.174190970837, 693.1058933975216, 695.8886578147473, 711.1466240511407, 734.6914295995695, 742.1539445032668, 760.5930827007525, 767.1063211358704, 9947.20422366209, 10009.149222316039, 10132.189424845994, 10520.947395262974, 10563.366198028143, 586.8415527807554, 701.5451880558413, 702.596007295807, 710.098175317344, 757.6590534259495, 4739.360186374795, 5024.246363045572, 5038.319826823332, 5070.112730272188, 5092.668976516515, 65647.34352656508, 78852.63442096746, 119241.0, 125221.37389312994, 126012.36993814973, 106496.0, 106970.0, 107117.464412679, 108306.0, 110393.0, 91717.54141229251, 94489.0551094494, 95329.52335238279, 97276.51361743288, 98119.50940245253, 9301.325761362748, 9363.578638961128, 9378.906210937803, 9572.23422126242, 9647.565859536197, 53019.20471192858, 54061.0, 54381.72809135929, 54621.72689136529, 57108.42891571031, 44290.335644966, 44444.77777611091, 57888.710556446946, 78110.60944695468, 80106.0, 11669.649910502698, 11870.347130907883, 11946.880531194576, 12034.458449369975, 12347.073969452507, 13116.08187426871, 13245.337733113112, 13507.594772156852, 13721.794173087212, 13754.210854647536, 13089.607311780663, 13434.0, 13568.457261709817, 13732.244726539737, 13823.0, 13170.670733231746, 13509.864901351253, 13613.251271180181, 13672.658183545092, 13824.308784560933, 13302.800457992944, 13370.465181392636, 13504.527341542998, 13761.0, 13922.0, 10206.489675516046, 10419.583216671248, 10509.264550238211, 10602.416867072077, 10691.839622405514, 10676.519556620126, 10761.677149685522, 10803.282913387226, 10835.783284334428, 10853.131749460183], "value": 7617.294260519917, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 106.0, 111.0, 112.0, 112.0, 113.0, 113.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 140.0, 164.0, 117.0, 143.0, 149.0, 122.0, 191.0, 118.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 163.0, 162.0, 164.0, 165.0, 174.0, 169.0, 163.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 76.0, 168.0, 76.0, 75.0, 75.0, 75.0, 171.0, 75.0], "value": 94.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 146.0, 84.0, 84.0, 83.0, 145.0, 84.0, 84.0, 138.0], "value": 101.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 147.0, 150.0, 149.0, 150.0, 147.0, 147.0, 147.0, 147.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 98.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 52.0, 54.0, 52.0, 54.0, 53.0, 52.0, 56.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 61.0, 63.0, 62.0, 61.0, 60.0, 61.0, 63.0, 62.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 75.0, 75.0, 75.0, 75.0, 74.0, 79.0, 74.0], "value": 75.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 119.0, 122.0, 120.0, 130.0, 120.0, 122.0, 143.0, 157.0, 127.0], "value": 128.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 156.0, 159.0, 157.0, 157.0, 161.0, 154.0, 159.0, 155.0], "value": 156.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 69.0, 73.0, 65.0, 64.0, 62.0, 64.0, 66.0, 65.0], "value": 66.0, "unit": "score"}]}]} 10:35:45 INFO - Return code: 0 10:35:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:35:45 ERROR - # TBPL SUCCESS # 10:35:45 INFO - Running post-action listener: _resource_record_post_action 10:35:45 INFO - ##### 10:35:45 INFO - ##### Finished run-tests step (success) 10:35:45 INFO - ##### 10:35:45 INFO - Running post-run listener: _resource_record_post_run 10:35:45 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551997440; Read time: 8; Write time: 477072 10:35:45 INFO - TinderboxPrint: CPU usage
13.3% 10:35:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 10:35:45 INFO - TinderboxPrint: I/O write bytes / time
551,997,440 / 477,072 10:35:45 INFO - TinderboxPrint: CPU idle
8,230.0 (86.7%) 10:35:45 INFO - TinderboxPrint: CPU user
1,210.5 (12.7%) 10:35:45 INFO - TinderboxPrint: Swap in / out
0 / 0 10:35:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256638976; Read time: 0; Write time: 299932 10:35:45 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 295358464; Read time: 0; Write time: 177140 10:35:45 INFO - Running post-run listener: _upload_blobber_files 10:35:45 INFO - Blob upload gear active. 10:35:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:35:45 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 10:35:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:35:46 INFO - (blobuploader) - INFO - Open directory for files ... 10:35:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:35:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:35:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:47 INFO - (blobuploader) - INFO - Done attempting. 10:35:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:35:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:50 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:35:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:50 INFO - (blobuploader) - INFO - Done attempting. 10:35:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:35:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:35:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:35:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:35:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:35:51 INFO - (blobuploader) - INFO - Done attempting. 10:35:51 INFO - (blobuploader) - INFO - Iteration through files over. 10:35:51 INFO - Return code: 0 10:35:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:35:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:35:51 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c59c5eb182e2c8ab9157f00a2f67a28c8fc5e0727641304a6d845dcf52b2c65edea610c7a975e028b54ea7057cd5e9bbfd796b7265a3820995beee46904754e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70c1323ac6a4810a465ea9468104ac267dceb0fc00bf1a2fd62817ee98f99c501593fc9008cca8a62173cd9ce32ce153be13af48382356f1d37dd17c43a96acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c7899d3c9b319b11c849b6e2380ded6fe27dbf4c67b0ae7e933e0b919e2e103ca086e207d12e87dab119d31f3f18dd44f1afe99bbc0fc9aa7aaec7e59bae158"} 10:35:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:35:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:35:51 INFO - Contents: 10:35:51 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c59c5eb182e2c8ab9157f00a2f67a28c8fc5e0727641304a6d845dcf52b2c65edea610c7a975e028b54ea7057cd5e9bbfd796b7265a3820995beee46904754e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70c1323ac6a4810a465ea9468104ac267dceb0fc00bf1a2fd62817ee98f99c501593fc9008cca8a62173cd9ce32ce153be13af48382356f1d37dd17c43a96acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c7899d3c9b319b11c849b6e2380ded6fe27dbf4c67b0ae7e933e0b919e2e103ca086e207d12e87dab119d31f3f18dd44f1afe99bbc0fc9aa7aaec7e59bae158"} 10:35:51 INFO - Running post-run listener: copy_logs_to_upload_dir 10:35:51 INFO - Copying logs to upload dir... 10:35:51 INFO - mkdir: /builds/slave/test/build/upload/logs 10:35:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.925827 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-06-30 10:35:50.524021) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 10:35:50.528176) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c59c5eb182e2c8ab9157f00a2f67a28c8fc5e0727641304a6d845dcf52b2c65edea610c7a975e028b54ea7057cd5e9bbfd796b7265a3820995beee46904754e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70c1323ac6a4810a465ea9468104ac267dceb0fc00bf1a2fd62817ee98f99c501593fc9008cca8a62173cd9ce32ce153be13af48382356f1d37dd17c43a96acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c7899d3c9b319b11c849b6e2380ded6fe27dbf4c67b0ae7e933e0b919e2e103ca086e207d12e87dab119d31f3f18dd44f1afe99bbc0fc9aa7aaec7e59bae158"} build_url:https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011197 build_url: 'https://queue.taskcluster.net/v1/task/PwZQ6ODMQeSMrsbOWdU4Xw/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/Firefox/sha512/3c59c5eb182e2c8ab9157f00a2f67a28c8fc5e0727641304a6d845dcf52b2c65edea610c7a975e028b54ea7057cd5e9bbfd796b7265a3820995beee46904754e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/70c1323ac6a4810a465ea9468104ac267dceb0fc00bf1a2fd62817ee98f99c501593fc9008cca8a62173cd9ce32ce153be13af48382356f1d37dd17c43a96acb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c7899d3c9b319b11c849b6e2380ded6fe27dbf4c67b0ae7e933e0b919e2e103ca086e207d12e87dab119d31f3f18dd44f1afe99bbc0fc9aa7aaec7e59bae158"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 10:35:50.556359) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 10:35:50.556917) ========= 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=82c74bd3bc9a11c5833d2010000001e6-1467303950.140114-1081635209 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 10:35:50.640780) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 10:35:50.641097) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 10:35:50.641409) ========= ========= Total master_lag: 0.16 =========