builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-041 starttime: 1469527057.83 results: success (0) buildid: 20160726001521 builduid: d818e95b5d1a438fb1877f00d9038882 revision: d12f1688d4710d9e31f32b1fcf360539655222c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:37.834079) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:37.834547) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:37.834817) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:37.850674) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:37.851069) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-26 02:57:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-07-26 02:57:38 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.083114 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:37.948241) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:37.948582) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014664 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:37.998309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 02:57:37.998656) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d12f1688d4710d9e31f32b1fcf360539655222c5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev d12f1688d4710d9e31f32b1fcf360539655222c5 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-26 02:57:38,617 truncating revision to first 12 chars 2016-07-26 02:57:38,618 Setting DEBUG logging. 2016-07-26 02:57:38,618 attempt 1/10 2016-07-26 02:57:38,618 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/d12f1688d471?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-26 02:57:39,808 unpacking tar archive at: mozilla-inbound-d12f1688d471/testing/mozharness/ program finished with exit code 0 elapsedTime=1.563670 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-26 02:57:39.576658) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:39.577056) ========= script_repo_revision: d12f1688d4710d9e31f32b1fcf360539655222c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:39.577451) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:39.577765) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-26 02:57:39.588736) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-26 02:57:39.589130) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:57:40 INFO - MultiFileLogger online at 20160726 02:57:40 in /builds/slave/test 02:57:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 02:57:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:57:40 INFO - {'append_to_log': False, 02:57:40 INFO - 'base_work_dir': '/builds/slave/test', 02:57:40 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 02:57:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:57:40 INFO - 'branch': 'Mozilla-Inbound', 02:57:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:57:40 INFO - 'config_files': ('talos/linux_config.py',), 02:57:40 INFO - 'default_actions': ('clobber', 02:57:40 INFO - 'read-buildbot-config', 02:57:40 INFO - 'download-and-extract', 02:57:40 INFO - 'populate-webroot', 02:57:40 INFO - 'create-virtualenv', 02:57:40 INFO - 'install', 02:57:40 INFO - 'run-tests'), 02:57:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:57:40 INFO - 'download_minidump_stackwalk': True, 02:57:40 INFO - 'download_symbols': 'ondemand', 02:57:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:57:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:57:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:57:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:57:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:57:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:57:40 INFO - 'installer_path': 'installer.exe', 02:57:40 INFO - 'log_level': 'info', 02:57:40 INFO - 'log_name': 'talos', 02:57:40 INFO - 'log_to_console': True, 02:57:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:57:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:57:40 INFO - 'opt_config_files': (), 02:57:40 INFO - 'pip_index': False, 02:57:40 INFO - 'sps_profile': False, 02:57:40 INFO - 'sps_profile_interval': 0, 02:57:40 INFO - 'suite': 'dromaeojs', 02:57:40 INFO - 'system_bits': '32', 02:57:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:57:40 INFO - 'title': 'talos-linux64-ix-041', 02:57:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:57:40 INFO - 'use_talos_json': True, 02:57:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:57:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:57:40 INFO - 'work_dir': 'build'} 02:57:40 INFO - ##### 02:57:40 INFO - ##### Running clobber step. 02:57:40 INFO - ##### 02:57:40 INFO - Running pre-action listener: _resource_record_pre_action 02:57:40 INFO - Running main action method: clobber 02:57:40 INFO - rmtree: /builds/slave/test/build 02:57:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:57:40 INFO - Running post-action listener: _resource_record_post_action 02:57:40 INFO - ##### 02:57:40 INFO - ##### Finished clobber step (success) 02:57:40 INFO - ##### 02:57:40 INFO - ##### 02:57:40 INFO - ##### Running read-buildbot-config step. 02:57:40 INFO - ##### 02:57:40 INFO - Running pre-action listener: _resource_record_pre_action 02:57:40 INFO - Running main action method: read_buildbot_config 02:57:40 INFO - Using buildbot properties: 02:57:40 INFO - { 02:57:40 INFO - "project": "", 02:57:40 INFO - "product": "firefox", 02:57:40 INFO - "script_repo_revision": "production", 02:57:40 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 02:57:40 INFO - "repository": "", 02:57:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 02:57:40 INFO - "buildid": "20160726001521", 02:57:40 INFO - "pgo_build": "True", 02:57:40 INFO - "basedir": "/builds/slave/test", 02:57:40 INFO - "buildnumber": 1290, 02:57:40 INFO - "slavename": "talos-linux64-ix-041", 02:57:40 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:57:40 INFO - "platform": "ubuntu64_hw", 02:57:40 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 02:57:40 INFO - "branch": "mozilla-inbound", 02:57:40 INFO - "repo_path": "integration/mozilla-inbound", 02:57:40 INFO - "revision": "d12f1688d4710d9e31f32b1fcf360539655222c5", 02:57:40 INFO - "stage_platform": "linux64-pgo", 02:57:40 INFO - "builduid": "d818e95b5d1a438fb1877f00d9038882", 02:57:40 INFO - "slavebuilddir": "test" 02:57:40 INFO - } 02:57:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 02:57:40 INFO - Running post-action listener: _resource_record_post_action 02:57:40 INFO - ##### 02:57:40 INFO - ##### Finished read-buildbot-config step (success) 02:57:40 INFO - ##### 02:57:40 INFO - ##### 02:57:40 INFO - ##### Running download-and-extract step. 02:57:40 INFO - ##### 02:57:40 INFO - Running pre-action listener: _resource_record_pre_action 02:57:40 INFO - Running main action method: download_and_extract 02:57:40 INFO - mkdir: /builds/slave/test/build/tests 02:57: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')]} 02:57:40 INFO - https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:57:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:57:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:57:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/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 02:57:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/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 02:57:41 INFO - Downloaded 1361 bytes. 02:57:41 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 02:57:41 INFO - Using the following test package requirements: 02:57:41 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:57:41 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:57:41 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:57:41 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:41 INFO - u'jsshell-linux-x86_64.zip'], 02:57:41 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:57:41 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 02:57:41 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:57:41 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:57:41 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:57:41 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 02:57:41 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:57:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:57:41 INFO - https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:57:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:57:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:57:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/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 02:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/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 02:57:42 INFO - Downloaded 24334010 bytes. 02:57:42 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'] 02:57:42 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 02:57:43 INFO - Return code: 0 02:57:43 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 02:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 02:57:43 INFO - https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:57:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:57:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 02:57:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/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 02:57:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/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 02:57:44 INFO - Downloaded 24334010 bytes. 02:57:44 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'] 02:57:44 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 02:57:46 INFO - Return code: 0 02:57: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')]} 02:57:46 INFO - https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:57:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:57:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 02:57:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/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 02:57:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/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 02:57:47 INFO - Downloaded 14403317 bytes. 02:57:47 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'] 02:57:47 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 02:57:47 INFO - Return code: 0 02:57:47 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')]} 02:57:47 INFO - https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:57:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:57:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:57:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/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 02:57:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/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 02:57:48 INFO - Downloaded 60834624 bytes. 02:57:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:57:48 INFO - mkdir: /builds/slave/test/properties 02:57:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:57:48 INFO - Writing to file /builds/slave/test/properties/build_url 02:57:48 INFO - Contents: 02:57:48 INFO - build_url:https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 02:57:49 INFO - Running post-action listener: _resource_record_post_action 02:57:49 INFO - Running post-action listener: set_extra_try_arguments 02:57:49 INFO - ##### 02:57:49 INFO - ##### Finished download-and-extract step (success) 02:57:49 INFO - ##### 02:57:49 INFO - ##### 02:57:49 INFO - ##### Running populate-webroot step. 02:57:49 INFO - ##### 02:57:49 INFO - Running pre-action listener: _resource_record_pre_action 02:57:49 INFO - Running main action method: populate_webroot 02:57:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:57:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:57:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:57:49 INFO - '--tppagecycles', 02:57:49 INFO - '7'], 02:57:49 INFO - 'tests': ['tsvgm']}}, 02:57:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:57:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:57:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:57:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:57:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:57:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['damp', 'tps']}, 02:57:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'tests': ['damp', 'tps']}, 02:57:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['dromaeo_dom']}, 02:57:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:57:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['basic_compositor_video']}, 02:57:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:57:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'other-e10s': {'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['a11yr', 02:57:49 INFO - 'ts_paint', 02:57:49 INFO - 'tpaint', 02:57:49 INFO - 'sessionrestore', 02:57:49 INFO - 'sessionrestore_no_auto_restore', 02:57:49 INFO - 'tabpaint']}, 02:57:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['tsvgx', 02:57:49 INFO - 'tsvgr_opacity', 02:57:49 INFO - 'tart', 02:57:49 INFO - 'tscrollx', 02:57:49 INFO - 'cart']}, 02:57:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:57:49 INFO - 'tsvgr_opacity', 02:57:49 INFO - 'tart', 02:57:49 INFO - 'tscrollx', 02:57:49 INFO - 'cart']}, 02:57:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'talos_options': ['--disable-e10s'], 02:57:49 INFO - 'tests': ['tp5o']}, 02:57:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'tests': ['tp5o']}, 02:57:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'talos_options': ['--disable-e10s', 02:57:49 INFO - '--xperf_path', 02:57:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:49 INFO - 'tests': ['tp5n']}, 02:57:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:57:49 INFO - 'talos_options': ['--xperf_path', 02:57:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:57:49 INFO - 'tests': ['tp5n']}}, 02:57:49 INFO - 'talos.zip': {'path': '', 02:57:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:57:49 INFO - Running post-action listener: _resource_record_post_action 02:57:49 INFO - ##### 02:57:49 INFO - ##### Finished populate-webroot step (success) 02:57:49 INFO - ##### 02:57:49 INFO - ##### 02:57:49 INFO - ##### Running create-virtualenv step. 02:57:49 INFO - ##### 02:57:49 INFO - Running pre-action listener: _resource_record_pre_action 02:57:49 INFO - Running main action method: create_virtualenv 02:57:49 INFO - Creating virtualenv /builds/slave/test/build/venv 02:57:49 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 02:57:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:57:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:57:49 INFO - Using real prefix '/usr' 02:57:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:57:50 INFO - Installing distribute.............................................................................................................................................................................................done. 02:57:52 INFO - Installing pip.................done. 02:57:52 INFO - Return code: 0 02:57:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:52 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 0x1bad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c3b0>, '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 0x1e6d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', '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 02:57:52 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 02:57:52 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 02:57:52 INFO - Using env: {'DISPLAY': ':0', 02:57:52 INFO - 'HOME': '/home/cltbld', 02:57:52 INFO - 'LANG': 'en_US.UTF-8', 02:57:52 INFO - 'LANGUAGE': 'en_US:en', 02:57:52 INFO - 'LOGNAME': 'cltbld', 02:57:52 INFO - 'MAIL': '/var/mail/cltbld', 02:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:52 INFO - 'MOZ_NO_REMOTE': '1', 02:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:52 INFO - 'NO_EM_RESTART': '1', 02:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:52 INFO - 'PWD': '/builds/slave/test', 02:57:52 INFO - 'SHELL': '/bin/bash', 02:57:52 INFO - 'SHLVL': '1', 02:57:52 INFO - 'TERM': 'linux', 02:57:52 INFO - 'TMOUT': '86400', 02:57:52 INFO - 'USER': 'cltbld', 02:57:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', 02:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:52 INFO - '_': '/tools/buildbot/bin/python'} 02:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:52 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 02:57:52 INFO - Cleaning up... 02:57:52 INFO - Return code: 0 02:57:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:52 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 0x1bad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c3b0>, '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 0x1e6d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', '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 02:57:52 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 02:57:52 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 02:57:52 INFO - Using env: {'DISPLAY': ':0', 02:57:52 INFO - 'HOME': '/home/cltbld', 02:57:52 INFO - 'LANG': 'en_US.UTF-8', 02:57:52 INFO - 'LANGUAGE': 'en_US:en', 02:57:52 INFO - 'LOGNAME': 'cltbld', 02:57:52 INFO - 'MAIL': '/var/mail/cltbld', 02:57:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:52 INFO - 'MOZ_NO_REMOTE': '1', 02:57:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:52 INFO - 'NO_EM_RESTART': '1', 02:57:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:52 INFO - 'PWD': '/builds/slave/test', 02:57:52 INFO - 'SHELL': '/bin/bash', 02:57:52 INFO - 'SHLVL': '1', 02:57:52 INFO - 'TERM': 'linux', 02:57:52 INFO - 'TMOUT': '86400', 02:57:52 INFO - 'USER': 'cltbld', 02:57:52 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', 02:57:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:52 INFO - '_': '/tools/buildbot/bin/python'} 02:57:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:52 INFO - Downloading/unpacking psutil>=3.1.1 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:57:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:54 INFO - Installing collected packages: psutil 02:57:54 INFO - Running setup.py install for psutil 02:57:54 INFO - building 'psutil._psutil_linux' extension 02:57:54 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 02:57:54 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 02:57:54 INFO - building 'psutil._psutil_posix' extension 02:57:54 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 02:57:55 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 02:57:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:57:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:57:55 INFO - Successfully installed psutil 02:57:55 INFO - Cleaning up... 02:57:55 INFO - Return code: 0 02:57:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:57:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:57:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:55 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 0x1bad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c3b0>, '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 0x1e6d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', '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 02:57:55 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 02:57:55 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 02:57:55 INFO - Using env: {'DISPLAY': ':0', 02:57:55 INFO - 'HOME': '/home/cltbld', 02:57:55 INFO - 'LANG': 'en_US.UTF-8', 02:57:55 INFO - 'LANGUAGE': 'en_US:en', 02:57:55 INFO - 'LOGNAME': 'cltbld', 02:57:55 INFO - 'MAIL': '/var/mail/cltbld', 02:57:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:55 INFO - 'MOZ_NO_REMOTE': '1', 02:57:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:55 INFO - 'NO_EM_RESTART': '1', 02:57:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:55 INFO - 'PWD': '/builds/slave/test', 02:57:55 INFO - 'SHELL': '/bin/bash', 02:57:55 INFO - 'SHLVL': '1', 02:57:55 INFO - 'TERM': 'linux', 02:57:55 INFO - 'TMOUT': '86400', 02:57:55 INFO - 'USER': 'cltbld', 02:57:55 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', 02:57:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:55 INFO - '_': '/tools/buildbot/bin/python'} 02:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:57:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:57:57 INFO - Installing collected packages: mozsystemmonitor 02:57:57 INFO - Running setup.py install for mozsystemmonitor 02:57:57 INFO - Successfully installed mozsystemmonitor 02:57:57 INFO - Cleaning up... 02:57:57 INFO - Return code: 0 02:57:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:57:57 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')]} 02:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:57 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')]} 02:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:57:57 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 0x1bad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c3b0>, '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 0x1e6d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', '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 02:57:57 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 02:57:57 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 02:57:57 INFO - Using env: {'DISPLAY': ':0', 02:57:57 INFO - 'HOME': '/home/cltbld', 02:57:57 INFO - 'LANG': 'en_US.UTF-8', 02:57:57 INFO - 'LANGUAGE': 'en_US:en', 02:57:57 INFO - 'LOGNAME': 'cltbld', 02:57:57 INFO - 'MAIL': '/var/mail/cltbld', 02:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:57:57 INFO - 'MOZ_NO_REMOTE': '1', 02:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:57:57 INFO - 'NO_EM_RESTART': '1', 02:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:57:57 INFO - 'PWD': '/builds/slave/test', 02:57:57 INFO - 'SHELL': '/bin/bash', 02:57:57 INFO - 'SHLVL': '1', 02:57:57 INFO - 'TERM': 'linux', 02:57:57 INFO - 'TMOUT': '86400', 02:57:57 INFO - 'USER': 'cltbld', 02:57:57 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', 02:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:57:57 INFO - '_': '/tools/buildbot/bin/python'} 02:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:57:57 INFO - Downloading/unpacking jsonschema==2.5.1 02:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:57:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:57:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:57:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:57:59 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 02:57:59 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 02:57:59 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 02:57:59 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 02:57:59 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 02:57:59 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 02:57:59 INFO - Downloading functools32-3.2.3-2.tar.gz 02:57:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:57:59 INFO - warning: no files found matching '*.txt' 02:57:59 INFO - no previously-included directories found matching 'build' 02:57:59 INFO - no previously-included directories found matching 'dist' 02:57:59 INFO - no previously-included directories found matching '.git*' 02:57:59 INFO - Installing collected packages: jsonschema, functools32 02:57:59 INFO - Running setup.py install for functools32 02:58:00 INFO - warning: no files found matching '*.txt' 02:58:00 INFO - no previously-included directories found matching 'build' 02:58:00 INFO - no previously-included directories found matching 'dist' 02:58:00 INFO - no previously-included directories found matching '.git*' 02:58:00 INFO - Successfully installed jsonschema functools32 02:58:00 INFO - Cleaning up... 02:58:00 INFO - Return code: 0 02:58:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:58:00 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')]} 02:58:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:00 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')]} 02:58:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:00 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 0x1bad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c3b0>, '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 0x1e6d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', '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 02:58:00 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 02:58:00 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 02:58:00 INFO - Using env: {'DISPLAY': ':0', 02:58:00 INFO - 'HOME': '/home/cltbld', 02:58:00 INFO - 'LANG': 'en_US.UTF-8', 02:58:00 INFO - 'LANGUAGE': 'en_US:en', 02:58:00 INFO - 'LOGNAME': 'cltbld', 02:58:00 INFO - 'MAIL': '/var/mail/cltbld', 02:58:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:00 INFO - 'MOZ_NO_REMOTE': '1', 02:58:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:00 INFO - 'NO_EM_RESTART': '1', 02:58:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:00 INFO - 'PWD': '/builds/slave/test', 02:58:00 INFO - 'SHELL': '/bin/bash', 02:58:00 INFO - 'SHLVL': '1', 02:58:00 INFO - 'TERM': 'linux', 02:58:00 INFO - 'TMOUT': '86400', 02:58:00 INFO - 'USER': 'cltbld', 02:58:00 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', 02:58:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:00 INFO - '_': '/tools/buildbot/bin/python'} 02:58:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:00 INFO - Downloading/unpacking blobuploader==1.2.4 02:58:00 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 02:58:00 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 02:58:00 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 02:58:00 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 02:58:00 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 02:58:00 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 02:58:02 INFO - Downloading blobuploader-1.2.4.tar.gz 02:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:58:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:58:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:58:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:58:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:58:02 INFO - Downloading docopt-0.6.1.tar.gz 02:58:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:58:03 INFO - Installing collected packages: blobuploader, requests, docopt 02:58:03 INFO - Running setup.py install for blobuploader 02:58:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:58:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:58:03 INFO - Running setup.py install for requests 02:58:03 INFO - Running setup.py install for docopt 02:58:03 INFO - Successfully installed blobuploader requests docopt 02:58:03 INFO - Cleaning up... 02:58:03 INFO - Return code: 0 02:58:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58:03 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')]} 02:58:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:03 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')]} 02:58:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:03 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 0x1bad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c3b0>, '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 0x1e6d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', '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 02:58:03 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 02:58:03 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 02:58:03 INFO - Using env: {'DISPLAY': ':0', 02:58:03 INFO - 'HOME': '/home/cltbld', 02:58:03 INFO - 'LANG': 'en_US.UTF-8', 02:58:03 INFO - 'LANGUAGE': 'en_US:en', 02:58:03 INFO - 'LOGNAME': 'cltbld', 02:58:03 INFO - 'MAIL': '/var/mail/cltbld', 02:58:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:03 INFO - 'MOZ_NO_REMOTE': '1', 02:58:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:03 INFO - 'NO_EM_RESTART': '1', 02:58:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:03 INFO - 'PWD': '/builds/slave/test', 02:58:03 INFO - 'SHELL': '/bin/bash', 02:58:03 INFO - 'SHLVL': '1', 02:58:03 INFO - 'TERM': 'linux', 02:58:03 INFO - 'TMOUT': '86400', 02:58:03 INFO - 'USER': 'cltbld', 02:58:03 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', 02:58:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:03 INFO - '_': '/tools/buildbot/bin/python'} 02:58:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:03 INFO - Running setup.py (path:/tmp/pip-y4Nj7f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:03 INFO - Running setup.py (path:/tmp/pip-UG_ZzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:03 INFO - Running setup.py (path:/tmp/pip-iMhS_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:04 INFO - Running setup.py (path:/tmp/pip-7UWPMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:04 INFO - Running setup.py (path:/tmp/pip-liQenz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:04 INFO - Running setup.py (path:/tmp/pip-EvWYzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:04 INFO - Running setup.py (path:/tmp/pip-xeiuBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:04 INFO - Running setup.py (path:/tmp/pip-m9y3ZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:04 INFO - Running setup.py (path:/tmp/pip-xk9jqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:04 INFO - Running setup.py (path:/tmp/pip-72TiaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:04 INFO - Running setup.py (path:/tmp/pip-cJQSEG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:04 INFO - Running setup.py (path:/tmp/pip-hYjH54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:04 INFO - Running setup.py (path:/tmp/pip-rMhAgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:04 INFO - Running setup.py (path:/tmp/pip-e0b_qY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:04 INFO - Running setup.py (path:/tmp/pip-QbowHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:04 INFO - Running setup.py (path:/tmp/pip-F3JsqT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:04 INFO - Running setup.py (path:/tmp/pip-uNFBoI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:58:05 INFO - Running setup.py install for manifestparser 02:58:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Running setup.py install for mozcrash 02:58:05 INFO - Running setup.py install for mozdebug 02:58:05 INFO - Running setup.py install for mozdevice 02:58:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Running setup.py install for mozfile 02:58:05 INFO - Running setup.py install for mozhttpd 02:58:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Running setup.py install for mozinfo 02:58:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Running setup.py install for mozInstall 02:58:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:58:05 INFO - Running setup.py install for mozleak 02:58:05 INFO - Running setup.py install for mozlog 02:58:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Running setup.py install for moznetwork 02:58:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Running setup.py install for mozprocess 02:58:06 INFO - Running setup.py install for mozprofile 02:58:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Running setup.py install for mozrunner 02:58:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Running setup.py install for mozscreenshot 02:58:06 INFO - Running setup.py install for moztest 02:58:06 INFO - Running setup.py install for mozversion 02:58:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:58:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:58:06 INFO - Cleaning up... 02:58:06 INFO - Return code: 0 02:58:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:06 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 0x1bad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c3b0>, '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 0x1e6d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', '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 02:58:06 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 02:58:06 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 02:58:06 INFO - Using env: {'DISPLAY': ':0', 02:58:06 INFO - 'HOME': '/home/cltbld', 02:58:06 INFO - 'LANG': 'en_US.UTF-8', 02:58:06 INFO - 'LANGUAGE': 'en_US:en', 02:58:06 INFO - 'LOGNAME': 'cltbld', 02:58:06 INFO - 'MAIL': '/var/mail/cltbld', 02:58:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:06 INFO - 'MOZ_NO_REMOTE': '1', 02:58:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:06 INFO - 'NO_EM_RESTART': '1', 02:58:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:06 INFO - 'PWD': '/builds/slave/test', 02:58:06 INFO - 'SHELL': '/bin/bash', 02:58:06 INFO - 'SHLVL': '1', 02:58:06 INFO - 'TERM': 'linux', 02:58:06 INFO - 'TMOUT': '86400', 02:58:06 INFO - 'USER': 'cltbld', 02:58:06 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', 02:58:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:06 INFO - '_': '/tools/buildbot/bin/python'} 02:58:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:58:07 INFO - Running setup.py (path:/tmp/pip-xqbjDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:58:07 INFO - Running setup.py (path:/tmp/pip-pmxtGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:58:07 INFO - Running setup.py (path:/tmp/pip-015FTI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:58:07 INFO - Running setup.py (path:/tmp/pip-TXlTAc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:58:07 INFO - Running setup.py (path:/tmp/pip-PljNre-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:58:07 INFO - Running setup.py (path:/tmp/pip-TMvcZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:58:07 INFO - Running setup.py (path:/tmp/pip-vAIa5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:58:07 INFO - Running setup.py (path:/tmp/pip-67erWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:58:07 INFO - Running setup.py (path:/tmp/pip-Bsd1cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:58:07 INFO - Running setup.py (path:/tmp/pip-hnzNJg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:58:07 INFO - Running setup.py (path:/tmp/pip-zNZyC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:58:07 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)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:58:07 INFO - Running setup.py (path:/tmp/pip-dBZTGq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:58:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:58:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:58:07 INFO - Running setup.py (path:/tmp/pip-e92hfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:58:08 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)) 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:58:08 INFO - Running setup.py (path:/tmp/pip-RvDhYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:58:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:08 INFO - Running setup.py (path:/tmp/pip-JkyKul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:58:08 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)) 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:58:08 INFO - Running setup.py (path:/tmp/pip-H4vxPO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:58:08 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)) 02:58:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:58:08 INFO - Running setup.py (path:/tmp/pip-OS4cjz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:58:08 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)) 02:58:08 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)) 02:58:08 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)) 02:58:08 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)) 02:58:08 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)) 02:58:08 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)) 02:58:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:58:08 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 02:58:08 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 02:58:08 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 02:58:08 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 02:58:08 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 02:58:08 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 02:58:10 INFO - Downloading blessings-1.6.tar.gz 02:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:58:10 INFO - Installing collected packages: blessings 02:58:10 INFO - Running setup.py install for blessings 02:58:10 INFO - Successfully installed blessings 02:58:10 INFO - Cleaning up... 02:58:10 INFO - Return code: 0 02:58:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:58:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:10 INFO - Reading from file tmpfile_stdout 02:58:10 INFO - Current package versions: 02:58:10 INFO - argparse == 1.2.1 02:58:10 INFO - blessings == 1.6 02:58:10 INFO - blobuploader == 1.2.4 02:58:10 INFO - docopt == 0.6.1 02:58:10 INFO - functools32 == 3.2.3-2 02:58:10 INFO - jsonschema == 2.5.1 02:58:10 INFO - manifestparser == 1.1 02:58:10 INFO - mozInstall == 1.12 02:58:10 INFO - mozcrash == 0.17 02:58:10 INFO - mozdebug == 0.1 02:58:10 INFO - mozdevice == 0.48 02:58:10 INFO - mozfile == 1.2 02:58:10 INFO - mozhttpd == 0.7 02:58:10 INFO - mozinfo == 0.9 02:58:10 INFO - mozleak == 0.1 02:58:10 INFO - mozlog == 3.2 02:58:10 INFO - moznetwork == 0.27 02:58:10 INFO - mozprocess == 0.23 02:58:10 INFO - mozprofile == 0.28 02:58:10 INFO - mozrunner == 6.12 02:58:10 INFO - mozscreenshot == 0.1 02:58:10 INFO - mozsystemmonitor == 0.3 02:58:10 INFO - moztest == 0.7 02:58:10 INFO - mozversion == 1.4 02:58:10 INFO - psutil == 3.1.1 02:58:10 INFO - requests == 1.2.3 02:58:10 INFO - wsgiref == 0.1.2 02:58:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:10 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 0x1bad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c3b0>, '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 0x1e6d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', '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 02:58:10 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 02:58:10 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 02:58:10 INFO - Using env: {'DISPLAY': ':0', 02:58:10 INFO - 'HOME': '/home/cltbld', 02:58:10 INFO - 'LANG': 'en_US.UTF-8', 02:58:10 INFO - 'LANGUAGE': 'en_US:en', 02:58:10 INFO - 'LOGNAME': 'cltbld', 02:58:10 INFO - 'MAIL': '/var/mail/cltbld', 02:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:10 INFO - 'MOZ_NO_REMOTE': '1', 02:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:10 INFO - 'NO_EM_RESTART': '1', 02:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:10 INFO - 'PWD': '/builds/slave/test', 02:58:10 INFO - 'SHELL': '/bin/bash', 02:58:10 INFO - 'SHLVL': '1', 02:58:10 INFO - 'TERM': 'linux', 02:58:10 INFO - 'TMOUT': '86400', 02:58:10 INFO - 'USER': 'cltbld', 02:58:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', 02:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:10 INFO - '_': '/tools/buildbot/bin/python'} 02:58:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:10 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)) 02:58:10 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)) 02:58:10 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)) 02:58:10 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)) 02:58:10 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)) 02:58:10 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)) 02:58:10 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)) 02:58:10 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)) 02:58:10 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)) 02:58:10 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)) 02:58:10 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)) 02:58:10 INFO - Cleaning up... 02:58:10 INFO - Return code: 0 02:58:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:58: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')]} 02:58:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:58:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58: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')]} 02:58:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:58:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:58:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e6e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e6c3b0>, '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 0x1e6d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d740>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', '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 02:58:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:58:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:58:10 INFO - Using env: {'DISPLAY': ':0', 02:58:10 INFO - 'HOME': '/home/cltbld', 02:58:10 INFO - 'LANG': 'en_US.UTF-8', 02:58:10 INFO - 'LANGUAGE': 'en_US:en', 02:58:10 INFO - 'LOGNAME': 'cltbld', 02:58:10 INFO - 'MAIL': '/var/mail/cltbld', 02:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:10 INFO - 'MOZ_NO_REMOTE': '1', 02:58:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:10 INFO - 'NO_EM_RESTART': '1', 02:58:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:10 INFO - 'PWD': '/builds/slave/test', 02:58:10 INFO - 'SHELL': '/bin/bash', 02:58:10 INFO - 'SHLVL': '1', 02:58:10 INFO - 'TERM': 'linux', 02:58:10 INFO - 'TMOUT': '86400', 02:58:10 INFO - 'USER': 'cltbld', 02:58:10 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', 02:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:10 INFO - '_': '/tools/buildbot/bin/python'} 02:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:58:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:58:11 INFO - Cleaning up... 02:58:11 INFO - Return code: 0 02:58:11 INFO - Running post-action listener: _resource_record_post_action 02:58:11 INFO - Running post-action listener: _start_resource_monitoring 02:58:11 INFO - Starting resource monitoring. 02:58:11 INFO - ##### 02:58:11 INFO - ##### Finished create-virtualenv step (success) 02:58:11 INFO - ##### 02:58:11 INFO - ##### 02:58:11 INFO - ##### Running install step. 02:58:11 INFO - ##### 02:58:11 INFO - Running pre-action listener: _resource_record_pre_action 02:58:11 INFO - Running main action method: install 02:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:58:11 INFO - Reading from file tmpfile_stdout 02:58:11 INFO - Detecting whether we're running mozinstall >=1.0... 02:58:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:58:11 INFO - Reading from file tmpfile_stdout 02:58:11 INFO - Output received: 02:58:11 INFO - Usage: mozinstall [options] installer 02:58:11 INFO - Options: 02:58:11 INFO - -h, --help show this help message and exit 02:58:11 INFO - -d DEST, --destination=DEST 02:58:11 INFO - Directory to install application into. [default: 02:58:11 INFO - "/builds/slave/test"] 02:58:11 INFO - --app=APP Application being installed. [default: firefox] 02:58:11 INFO - mkdir: /builds/slave/test/build/application 02:58:11 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'] 02:58:11 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 02:58:28 INFO - Reading from file tmpfile_stdout 02:58:28 INFO - Output received: 02:58:28 INFO - /builds/slave/test/build/application/firefox/firefox 02:58:28 INFO - Running post-action listener: _resource_record_post_action 02:58:28 INFO - ##### 02:58:28 INFO - ##### Finished install step (success) 02:58:28 INFO - ##### 02:58:28 INFO - ##### 02:58:28 INFO - ##### Running run-tests step. 02:58:28 INFO - ##### 02:58:28 INFO - Running pre-action listener: _resource_record_pre_action 02:58:28 INFO - Running main action method: run_tests 02:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:58:28 INFO - Python 2.7.3 02:58:28 INFO - Return code: 0 02:58:28 INFO - grabbing minidump binary from tooltool 02:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:58:28 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 0x1e6c3b0>, '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 0x1e6d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e6d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:58:28 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 02:58:28 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 02:58:28 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 02:58:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:58:28 INFO - Return code: 0 02:58:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:58:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:58:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:58:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:58:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:58:28 INFO - Using env: {'DISPLAY': ':0', 02:58:28 INFO - 'HOME': '/home/cltbld', 02:58:28 INFO - 'LANG': 'en_US.UTF-8', 02:58:28 INFO - 'LANGUAGE': 'en_US:en', 02:58:28 INFO - 'LOGNAME': 'cltbld', 02:58:28 INFO - 'MAIL': '/var/mail/cltbld', 02:58:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:58:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:58:28 INFO - 'MOZ_NO_REMOTE': '1', 02:58:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:58:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:58:28 INFO - 'NO_EM_RESTART': '1', 02:58:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:58:28 INFO - 'PWD': '/builds/slave/test', 02:58:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:58:28 INFO - 'SHELL': '/bin/bash', 02:58:28 INFO - 'SHLVL': '1', 02:58:28 INFO - 'TERM': 'linux', 02:58:28 INFO - 'TMOUT': '86400', 02:58:28 INFO - 'USER': 'cltbld', 02:58:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038', 02:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:58:28 INFO - '_': '/tools/buildbot/bin/python'} 02:58:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:58:28 INFO - mozversion application_buildid: 20160726001521 02:58:28 INFO - mozversion application_changeset: d12f1688d4710d9e31f32b1fcf360539655222c5 02:58:28 INFO - mozversion application_display_name: Nightly 02:58:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:58:28 INFO - mozversion application_name: Firefox 02:58:28 INFO - mozversion application_remotingname: firefox 02:58:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:58:28 INFO - mozversion application_vendor: Mozilla 02:58:28 INFO - mozversion application_version: 50.0a1 02:58:28 INFO - mozversion platform_buildid: 20160726001521 02:58:28 INFO - mozversion platform_changeset: d12f1688d4710d9e31f32b1fcf360539655222c5 02:58:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 02:58:28 INFO - mozversion platform_version: 50.0a1 02:58:28 INFO - using testdate: 1469527108 02:58:28 INFO - actual date: 1469527108 02:58:28 INFO - starting webserver on 'localhost:44242' 02:58:28 INFO - SUITE-START | Running 2 tests 02:58:28 INFO - TEST-START | dromaeo_css 02:58:28 INFO - operating with platform_type : linux_ 02:58:28 INFO - Initialising browser for dromaeo_css test... 02:58:28 INFO - TEST-INFO | started process 3170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpegklT6/profile http://localhost:44242/getInfo.html) 02:58:33 INFO - PROCESS | 3170 | __metrics Screen width/height:1600/1200 02:58:33 INFO - PROCESS | 3170 | colorDepth:24 02:58:33 INFO - PROCESS | 3170 | Browser inner width/height: 1024/697 02:58:33 INFO - PROCESS | 3170 | __metrics 02:58:33 INFO - PROCESS | 3170 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:58:33 INFO - PROCESS | 3170 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:58:34 INFO - TEST-INFO | 3170: exit 0 02:58:34 INFO - Browser initialized. 02:58:34 INFO - Running cycle 1/1 for dromaeo_css test... 02:58:34 INFO - TEST-INFO | started process 3253 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpegklT6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:58:46 INFO - PROCESS | 3253 | RSS: Main: 157687808 02:58:46 INFO - PROCESS | 3253 | 02:59:38 INFO - PROCESS | 3253 | 1469527178266 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] 03:01:46 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:44242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44242/tests/dromaeo/cssquery-ext.html) 03:01:47 INFO - PROCESS | 3253 | RSS: Main: 281587712 03:01:47 INFO - PROCESS | 3253 | 03:04:50 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:44242/tests/dromaeo/cssquery-ext.html (next: http://localhost:44242/tests/dromaeo/cssquery-jquery.html) 03:04:50 INFO - PROCESS | 3253 | RSS: Main: 248160256 03:04:50 INFO - PROCESS | 3253 | 03:07:52 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:44242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44242/tests/dromaeo/cssquery-mootools.html) 03:07:53 INFO - PROCESS | 3253 | RSS: Main: 243224576 03:07:53 INFO - PROCESS | 3253 | 03:10:55 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:44242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44242/tests/dromaeo/cssquery-prototype.html) 03:10:55 INFO - PROCESS | 3253 | RSS: Main: 239415296 03:10:55 INFO - PROCESS | 3253 | 03:13:58 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:44242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44242/tests/dromaeo/cssquery-yui.html) 03:13:59 INFO - PROCESS | 3253 | RSS: Main: 207360000 03:13:59 INFO - PROCESS | 3253 | 03:17:01 INFO - PROCESS | 3253 | Cycle 1(1): loaded http://localhost:44242/tests/dromaeo/cssquery-yui.html (next: http://localhost:44242/tests/dromaeo/cssquery-dojo.html) 03:17:01 INFO - PROCESS | 3253 | RSS: Main: 279740416 03:17:01 INFO - PROCESS | 3253 | 03:17:01 INFO - PROCESS | 3253 | __start_tp_report 03:17:01 INFO - PROCESS | 3253 | _x_x_mozilla_page_load 03:17:01 INFO - PROCESS | 3253 | _x_x_mozilla_page_load_details 03:17:01 INFO - PROCESS | 3253 | |i|pagename|runs| 03:17:01 INFO - PROCESS | 3253 | |0;dojo.html;3065.40224656192;3076.2924527358723;3084.4756391413443;3097.055398103579;3137.6862313768625;5289.867753306169;5358.223057656637;5387.973060134699;5449.455054494553;5503.8073667421595;5321.654092483986;5357.276767636368;5381.919271210935;5431.511163995239;5486;4800.351952486422;4853.63597730169;4867.732274724889;4933.33399991002;5004.274380214867;4949.752512374385;4957.107720610289;5054.115529782292;5066.898662026757;5070.08738427083;4804.1352556539805;5004.324416203803;5005.674631148963;5028.396592408916;5057.140286151344;4823.807047718087;4838.177509823338;4841.03179364125;4844.031193761227;4899.828506002273;4814.229723244299;4821.855344339676;4886.51134886512;4890.193118135503;4931.7040977541465;5247.658902171346;5356.223347614613;5398.946010539884;5414.702191379472;5445.482679145475;5583.078791999315;5654.321481422215;5670.121131224667;5730.312362516524;5742.081266997302;5697.9715101424645;5748.913766293509;5750;5767.913481297784;5768.8846223075725;5273.209018647195;5305.204219367126;5376.838694839161;5383.353997520323;5385.515303622693;5808.564357673107;5919.6152250103605;5926.733297001559;5926.911096333559;5927;5651.180578816131;5677;5684.175794509773;5693;5694.572907031907;5687.943120568824;5712.685802280831;5762.567807414377;5767.9134812977;5776.942230577641;5752.07966725322;5767.884642307215;5770.855728606734;5772.653640781483;5815.592908496449;5763.193152958589;5767.36558978512;5769.394213607595;5772.5670574707065;5778.422157784272;4256.446661933929;4287.6998610097;4321.719088259253;4323.027318853233;4357.302831546937;3840.2319536092336;3865.7873816940337;3897.4738410314812;3903.375459926398;3913.3542965410957;5492.093804522209;5529.972350138223;5542.528885044736;5544.279243698294;5589.888202236014;5616.550675945915;5740.39725828782;5817.447342502455;5818.796342128006;5921.555883308769;5438.102713052381;5446.782128714886;5451.073317535949;5458.235846981426;5522.088855338904;4871.0014447038275;4878.829240976549;4879.170541008037;4882.170031094723;4924.43369012561;5850.61970971894;5908.586398952118;5948.226730525091;5963.165156877953;6054.757809687563;5777.364489906191;5789.131630255495;5791.9131213031;5793.913091303718;5794.565407594531;5982.970085149721;5998.9100163496705;6003;6003.519718422428;6010.128531363015;5570.916436253378;5616.1856530803625;5632.211490391266;5688.601797874109;5708.828735137952;5759.193712880116;5791.449812267828;5794.536437084938;5798.623089499169;5807.041838096667;5448.346198456211;5655.236543066633;5662.631928924607;5663.292088488939;5672.546196304368;5596.636218645775;5641.351244606759;5676.971615141898;5693.686847223443;5696.629719068247;5591.692456914909;5605.915911261252;5609.439056094521;5612;5616.157576363578;5509.173623956439;5549.611527193058;5720.885582288248;5722.399148089391;5759.71201439918;5413.242146099628;5465.8360249191;5529.695866727207;5538.224648549287;5540.141278101901 03:17:01 INFO - PROCESS | 3253 | |1;ext.html;592.8754961458094;607.960482568633;615.0251850816461;633.7072372360385;644.4522156167257;31437;45594;46534.30198547016;46536.30195547069;46767.29849052258;46766.29850552244;46970.76514617422;47170;47225;47278.29082563764;8306.875396869053;9150.267978561717;9307.674231401903;10740.24818262722;11028.889711102907;10993.065589424908;11083.445827708581;11091.889081109166;11096.223264371498;11100.500477478532;11159.330440173575;11167.274127181749;11205.719857003558;11226.270292431007;11246.156538259622;8411.453255538401;10996.175286853519;11250.49372778227;11275.830862537068;11281.605143820008;10761.946190268998;10827.187960902886;10833.458327083614;11109.277896936754;11119.16606254526;34914.12714682128;35653.46519802205;44373.55626443759;44837.327440088426;44916.77541612271;3214.9357012859846;3574.7140228781636;3673.2286219893854;3683.889483315505;3797.9620203797886;33897.83051084753;34462.48306275408;34622.653773462196;34702.305953881034;35692.286154277026;4279.379489973968;4347.717398369127;4360.89097772555;4363.585459381354;4380.474343078819;368867;369586;371367;375818;375874;65612.34387656157;65777.67111164413;66045.33954660392;66135.66932165308;66248.33751662518;36640.26719465596;37741.433878491844;37811.62188378081;39380.80309598434;39480.80259598684;15071.321790519452;16977.830221697626;17048.57378565546;17094.658106837793;17132;11585.826212606818;11689.064874809996;11934.701632459259;11995.700107497209;12001.219920705125;21043.68434473484;21187.36437906865;21257.89371053135;21281.893590532258;21433.46416339604;7727;7753.510920085984;7895.842083158304;8071.013724921817;8081.777511184354;954.6849539651898;1043.9425831579183;1047.5809676129609;1086.6685660873509;1143.3997151495532;34163.31673366519;34491.827540862636;34531.309373812386;34612.653873461444;34863.4770478443;1113.9610113646145;1125.4597793059377;1130.3105105885404;1132.4337831084458;1180;17620;17968.820311796975;18024.639507209784;18034.909825450788;18070.819291806914;524139;528282;529097;529606;532524;40238.1952360957;40296.59703402987;40305.596944030774;40373.394399084034;40422.59577404247;1246;1353.1745635162542;1384.813050238225;1407.2893188939724;1409.323524708146;33777.662223377454;35334;35336;35400;35498.82250588731;53243.46756532385;53634.19548706851;53962.73018634882;54035.757854528856;54077;440808;442181;442246;443966;445506;26323.868380657976;28509.572356415087;29389.706102938697;29601.407971840872;30674.386512270077;49101.754491227315;49758.75120624374;50210;50262;51117.23324150215;42673.78663106664;43019;43287;43640.781796090814;44624.33063503985;42327.57672423236;42420.78789606032;42497.57502424936;42869;43180.13639727251;41386.79306603448;41585.792071039454;42672.359914601926;42691.78654106834;42757.78621106874;37167.442488362154;37241.25517489689;37535.544079639614;37943.43084853785;38493.42259866048;28759;28763;29143.417131656824;29232.41535169327;29241.268968275963 03:17:01 INFO - PROCESS | 3253 | |2;jquery.html;395.7506770734435;397.3324814311955;403.8384646141543;409.06732649559007;412.83073939684715;18929.90535047323;19404.51488712783;20059.899700501493;20063.297784577542;20077.598448031047;19126.33057842976;19208.51978700533;19373.903130484363;19475.513112172204;19538.218471261167;5573.777048918038;5615.101583746591;5808.448197421239;5819.9418005819825;5820.796272130477;5691.886162276752;5737.397573254811;5742.310922689262;5748.02283611787;5756.453136951983;5498;5678.091505359143;5684.687342196177;5691.288588926384;5692.800751973682;5491.615586908918;5612.859678508029;5615.2138700581745;5629.831105066854;5660.094384898396;5111.488851114896;5134.948650513485;5135.38375394955;5136.357955255593;5137.537621614036;23089.884550577306;23351;23383.53232935349;23576;23585.882070589538;2225;2307.596170670126;2347.260612906929;2401.351635058542;2910.3888183481495;10324.89675103247;10503.159747220281;10669.893301066968;13730.077789109533;14358.56924292273;1877;1879.5583037986062;1909.7429766885916;1965.77393599735;2022.312413779322;84611.5769421149;84706;86331.56834215851;87817;89527.10472895253;10816.242862999514;10931.301928124587;11052.502637381338;11136.610218642309;11196.496157672924;15300.693986120215;15348.693026139415;15360.308786104652;15368.846311536965;15453.227338633023;7649.464537482434;7855.685772569033;7857.214278572097;7912.7339625659615;8033.317168040782;7385.926140738524;7589.734359297398;7597.848043039219;7605.9348360961085;7637;4618;4622.6764126510825;4685.367475390779;4744;4839.95160048395;1779.323335506764;1863.459596716964;1966.4100769769298;1985.5325517585434;1995.7704863940542;947.7677968897664;981.283662926068;1019.56158851693;1059.8622179116664;1065.2702898514542;18907.621847562972;19974.20103195856;20028.89985550063;20098.497537561387;20106.497337566678;1006.597361055569;1015.5379302417382;1021.8978102189722;1024.774549599087;1045.8849526552074;10715.714114306333;11000;11078.944605276922;11109.222354435113;11131.833022504668;484944;486676.76570725726;495384;502798;513634;95664.52167739117;98371.50814246025;98691.01308986818;100119;100263;968.4383057826444;998.1484346537214;1015.3552494166257;1019.8929112443235;1020.9183265338903;17394.82605173932;17537.386191483238;17580.472585822445;17776.644467110327;18132.365367212085;43479;43966;44641.33038004497;45109.77445112754;45506.31740523829;60913;61670.38329616647;61887.69056154691;62864.685676571324;63398.36601633925;8228;8312.270993793416;8418.957905210435;8447.239748422671;8672.392932494664;9451.763705907408;11830.881691182978;12652.17760845542;12697.174683645533;12701.618951431103;11096.667099987013;11315.20793544444;11386.373749443861;11566.884331156582;11620.360880151673;9959.551820167964;10161.491925403552;10451.790964180522;10572.788544228919;10686.412247326472;11314.321140731583;11511.424428778695;11771.88228117742;11782.82325765097;11810;7522.210167932289;7823.374130069695;8599.226069653761;8722.171393717586;8837.602307896288;11230.270032447865;11606.30362178272;11805.76388472243;11906.583269585522;11952.163348565517 03:17:01 INFO - PROCESS | 3253 | |3;mootools.html;1493.663925616736;1499.452699764586;1608.3405803620517;1747.1089744230446;1750.2911320915034;8232.753017409479;8682.088380720028;8755.299576033918;8773.210411062995;8775.692850750225;7439.3676537494375;8156.225158609937;8300.83398332033;8314.293285070777;8575.785605359853;2370.691810064689;2396.341006223294;2397.376682062659;2397.9160729374476;2402.8678422686744;2391.701037370329;2412.577798885197;2449.6937882764655;2449.963250551243;2450.5221481810963;2070.7929207079246;2296.184854376689;2353.5410594933996;2366.171839856045;2389.665446837444;2293.312006398074;2301.2866011536394;2317.768223177669;2325.2326732178426;2326.627739561662;2426.0538390027905;2437.098273638765;2440.7193172785;2447.1801946347996;2447.192426499251;8332.208440198232;8445.957770211171;8447.788805279855;8448.87326690094;8454.704085357045;5100.132977393852;5227.869303267411;5232.424433312371;5232.659877107976;5235.267062611238;3314.386838434897;3413.6927676509235;3453.188500702333;3457.94813077804;3471.861125554975;990.1435258501344;1019.2202964731986;1084.4686103809156;1085.8968398002178;1116.5868628607468;11427.771444571144;11678.182527223098;11697.766044679143;11715.53137874484;11736.941315293454;4566.840160594364;4573.49691533931;4755.857324280277;4756.54812792791;4785.066911952205;10124.69625911224;10127.442990635438;10127.7468063299;10137.949310253402;10145.594176233015;5216.40011398694;5267.578593712494;5270.60470464709;5306.336707911511;5321;4816.446108697474;4847.248676455155;4851.660383773173;4854.975725121422;4981.32752078472;3835.6931445484292;3858.2476417098396;3890.2219556088894;3926;3946.3291240489184;1112.1047556716921;1155.312589009538;1184.6090790039266;1198.5385626533848;1219.0369608009573;949.0793929887998;974.4445665970329;978.3787295067683;1028.6245520385155;1031.6286136990677;5977.103434484775;6029.517638588903;6174.475169610633;6252.874942501125;6350.259436764735;984.7242772023844;1048.6329784575337;1073.7584043590286;1102.9503672334765;1108.257467496763;3947.624975627311;4202.327627579572;4232.830686772556;4323.459567554056;4359.324304732771;10351.327163734333;10606.469676516142;10655.200859935381;10667.466626668636;10690.091342235997;9960.850587241197;10444.164466842634;10504.527296271686;10523.84214236787;10539.314944528582;7937.3650107991225;8047;8088.797780055428;8136.55248961301;8137.918620813834;5758.366579676316;5897.67562784051;5916.792912248051;5936.643801371932;6250.187475628321;9562.713118606453;9670.178034867115;10020.799584008424;10073.244506661884;10103.797924041331;10106.343087699275;10158.339707918962;10236.48817559134;10253.07722304996;10256.641017564349;8176.959115204386;8340.6246718899;8354.958225208835;8356;8358.247757701836;7919.604019799102;7996.32031277348;8004.799880003046;8021.598920054091;8083.474574152661;7351.448641351813;7482.2517748224745;7558.2441755823975;7567.243275672388;7670;7505.099388073248;7520.360769334668;7561;7631;7664.31021208094;6609.933900660932;6873.037774711444;6888.758893438706;7023.22744498115;7025.121859767529;4961.131801934719;5002;5204.297419848272;5302.416734159317;5319.707416091997;4895.412550493964;4996.775145118406;5084.186530155157;5105.361829771278;5181.3005244293045 03:17:01 INFO - PROCESS | 3253 | |4;prototype.html;331.53339156674343;339.7023370723835;347.1858491836645;348.8447640799844;350.45679197244283;5362.27609272748;5383.81156659517;5388.8952764683145;5404.378496472902;5408.67547947123;5095.312132862063;5129.974350128254;5322.414534401213;5322.520973112419;5324.946750532494;4163.666906647461;4173.24881521326;4206.558311377307;4220.134872351161;4254.936175957356;4222.071144348239;4233.491980962289;4238.131183107455;4257;4257.446531950857;4014.972438918342;4083.3262511685534;4103.958960410388;4205.726627769201;4216.641585465224;4124.278251306039;4177.436046133764;4183.121544475649;4184.832606695729;4194.874153775391;3721.9441708374397;3723.7765734056043;3727.7763334199763;3729.4778730977687;3734.1038150843874;5082.390113186441;5139.8458046258675;5157.58739300855;5169.56058735008;5213.53078222958;4756.714597124149;4763.69036012658;4765.523447655241;4775.976120119377;4789.4971028042255;5504.174373843915;5504.366997795265;5507;5577.832665020056;5593.916091258634;4000.439938408625;4004.437322815235;4080.6939479538855;4086.9386959195635;4111.116110036357;5796.855078623026;5810.128480727883;5817.712992159459;5827.650340979555;5840;4188.162367526507;4193.475815523059;4195.622393984495;4210.894727631834;4215.367694845736;4143.834246630101;4192;4220;4221.6833737469815;4255.404243405926;4716.528347165325;4734.313524538922;4740.241561350167;4751.263554149044;4773.639512738922;5530.751116199781;5542.639728417721;5564.944350556442;5592.623135167538;5607.467290607386;1388.9305534723223;1416.4900635771114;1447.0594113826098;1455.4760286296926;1457.1402872305391;998.7303428074524;1004.7541049099065;1014.1633152649094;1024.6977141743203;1035.7876635289747;5298.311219541435;5301.522862942276;5328.350080195079;5335.893282134336;5352.223927530486;5568.415316391802;5610.747516361774;5612.298462692163;5630.60585758993;5638.646724786104;5108.744562771846;5339.279197308391;5341.305630268118;5342.412334643186;5377.973110134424;2958.2752225704407;2975.821450712921;2985.7760667949556;2994.985025074904;3007.3985202959498;5779.913301300484;5785.615414982199;5796.42035796417;5811.738471768781;5816.2551234629445;5605.8417509259225;5701.2588363513305;5847.356790753014;5887.5575484006695;5910.645361278337;5951.434613711691;5952.970235148797;5979.431953964279;5986.760529578855;5995.46040856325;5548.278723765885;5748.540116790563;5767.365589785204;5771.94228057714;5773.653580785166;5682.431756824284;5688.971555142363;5709.54323654115;5719.828405147852;5720.48515633595;5927.496162826208;5931.466168044896;5958.76164953397;5959.4934430573885;5968.46283834457;3894.6689531389015;4094.6314831665295;4105.69207309447;4145.108801607669;4160.45914031174;5768.307803063659;5769.480746732646;5769.538436924952;5804.94195058044;5808.157817116579;5427.185922111715;5435;5442.537384322377;5486.533644640251;5552.083906155601;5154.355705536808;5570.916436253378;5579.302587176603;5580.525655319343;5580.832575022593;5521.917171242354;5527.668339899619;5533;5540.806071787468;5560.499555040065;5441.29263195782;5603.411641777718;5615.185798059177;5625.521830644441;5646.322441307069;5469.42571030052;5475.945240547543;5507.697076660822;5529.170624406372;5535.529479994246 03:17:01 INFO - PROCESS | 3253 | |5;yui.html;761.6229966166745;784.921507849215;789.9763007109789;818.6684392820906;825.2531459029581;14897.77653335201;16420.589485262873;16433.42483013095;16448.259828307724;16449.50651480456;14553.345099470524;14758.11451312922;14759.77860332096;14760.926195369035;14777;645.6836150286373;770.9730159444407;775.0892701076241;792.9643166057513;793.8015496125969;779.4465929190281;793.8174219929391;795.7732046366787;796.5817945578559;796.7092011415821;836.5022811427191;836.6444261188971;838.1241602525375;838.1576515601812;838.337713206566;675.9019942108391;819.6844214977247;835.6573804740027;839.3620848155385;843.1105184030845;611.782817099932;613.5275837605019;614.7387360371869;615.9568830181844;619.3032838057186;13743;13784.655383615389;13808.1024733392;13808.447662093504;13811.723765524634;13114.737705245938;13404.86595134046;13990.230537320444;14422.278886055656;14431.567052988426;13212.234513163798;13379.464821407131;13430;13667.521636742666;13877;3939.0940083780606;4085.9591404085877;4462.4645042594775;4542.500324964251;4621.768911554409;83093;84170;85013.57493212556;85403.57298213532;85685.14314856834;11427.714607022366;11716.824247636292;11784.528618855322;11790.174687771945;11945.163838531393;20825.895870520853;21185.68221476679;21207.68188477174;21229;21385.14459421637;7869.921300786918;8036.116027236999;8127.512349259064;8145.42981991255;8163.1428699985645;4592.471865735416;4814.229723244264;4867.9269810952865;4940.90118197634;5003.924941125886;3624.7643903146213;3726.795026273581;3736.3461394255896;3748.11919198988;3757.755745876509;612.0696541257264;623.2987888625297;624.6970219443566;645.8052602684995;647.6955830759536;647.8024202618152;649.1334069017914;676.5399528320789;676.5703778100941;748.580794754939;9875.358101723365;10050.69847904564;10273.126784223276;10603.09873660732;10620.628278010387;645.8482256669679;725.4667819153024;727.1201845766682;731.1628185727312;731.6341829085458;4746.311784791186;4844.8304309349705;4876.146674331978;5027.120253955543;5062.443131255633;67658.66170669116;77941;121384;130420;130787.34606326907;67243;93902;106760.46619766852;109376;112788.43605781918;60616.69691651602;66432.66783666148;93947.53026234962;94769;96460;8829.205371516595;8880.467171969443;9032.277417806428;9063.957644870925;9076.773080673036;40592.79703601463;54812.16314857922;55180;57692;59071.40928590659;83295;83638.58180709058;84844.57577712319;85172.57413712892;88000;10536.420496872746;10703.785924281627;10723.678289651323;10973.670789876316;10975.28660637056;12367.93816030914;12453.1905426147;12675.683107922006;12734.745305094031;12753.426095825525;12653.304068276333;12732.299723515296;12790.68023299425;13067.869321307046;13209.273489958145;11370.829437558608;12039.699007524881;12120.393980300772;12421.316827574208;12536.247825130522;12510;12631.368431578569;12720.872791272339;12789;12900.354982250663;9863.556139973574;10359.22305827081;10447.68656940293;10777.838332425177;10871.29336593119;10628.202884783517;10643.160949238792;10833.891661083288;10895.400752958663;11126.221164518405 03:17:01 INFO - PROCESS | 3253 | __end_tp_report 03:17:01 INFO - PROCESS | 3253 | __start_cc_report 03:17:01 INFO - PROCESS | 3253 | _x_x_mozilla_cycle_collect,1082 03:17:01 INFO - PROCESS | 3253 | __end_cc_report 03:17:01 INFO - PROCESS | 3253 | __startTimestamp1469528221671__endTimestamp 03:17:01 INFO - PROCESS | 3253 | 03:17:01 INFO - PROCESS | 3253 | ------- Summary: start ------- 03:17:01 INFO - PROCESS | 3253 | Number of tests: 6 03:17:01 INFO - PROCESS | 3253 | 03:17:01 INFO - PROCESS | 3253 | [#0] dojo.html Cycles:165 Average:5350.82 Median:5570.92 stddev:619.71 (11.1%) stddev-sans-first:595.11 03:17:01 INFO - PROCESS | 3253 | Values: 3065.4 3076.3 3084.5 3097.1 3137.7 5289.9 5358.2 5388.0 5449.5 5503.8 5321.7 5357.3 5381.9 5431.5 5486.0 4800.4 4853.6 4867.7 4933.3 5004.3 4949.8 4957.1 5054.1 5066.9 5070.1 4804.1 5004.3 5005.7 5028.4 5057.1 4823.8 4838.2 4841.0 4844.0 4899.8 4814.2 4821.9 4886.5 4890.2 4931.7 5247.7 5356.2 5398.9 5414.7 5445.5 5583.1 5654.3 5670.1 5730.3 5742.1 5698.0 5748.9 5750.0 5767.9 5768.9 5273.2 5305.2 5376.8 5383.4 5385.5 5808.6 5919.6 5926.7 5926.9 5927.0 5651.2 5677.0 5684.2 5693.0 5694.6 5687.9 5712.7 5762.6 5767.9 5776.9 5752.1 5767.9 5770.9 5772.7 5815.6 5763.2 5767.4 5769.4 5772.6 5778.4 4256.4 4287.7 4321.7 4323.0 4357.3 3840.2 3865.8 3897.5 3903.4 3913.4 5492.1 5530.0 5542.5 5544.3 5589.9 5616.6 5740.4 5817.4 5818.8 5921.6 5438.1 5446.8 5451.1 5458.2 5522.1 4871.0 4878.8 4879.2 4882.2 4924.4 5850.6 5908.6 5948.2 5963.2 6054.8 5777.4 5789.1 5791.9 5793.9 5794.6 5983.0 5998.9 6003.0 6003.5 6010.1 5570.9 5616.2 5632.2 5688.6 5708.8 5759.2 5791.4 5794.5 5798.6 5807.0 5448.3 5655.2 5662.6 5663.3 5672.5 5596.6 5641.4 5677.0 5693.7 5696.6 5591.7 5605.9 5609.4 5612.0 5616.2 5509.2 5549.6 5720.9 5722.4 5759.7 5413.2 5465.8 5529.7 5538.2 5540.1 03:17:01 INFO - PROCESS | 3253 | 03:17:01 INFO - PROCESS | 3253 | [#1] ext.html Cycles:180 Average:60922.66 Median:204267.22 stddev:119767.12 (58.6%) stddev-sans-first:120017.44 03:17:01 INFO - PROCESS | 3253 | Values: 592.9 608.0 615.0 633.7 644.5 31437.0 45594.0 46534.3 46536.3 46767.3 46766.3 46970.8 47170.0 47225.0 47278.3 8306.9 9150.3 9307.7 10740.2 11028.9 10993.1 11083.4 11091.9 11096.2 11100.5 11159.3 11167.3 11205.7 11226.3 11246.2 8411.5 10996.2 11250.5 11275.8 11281.6 10761.9 10827.2 10833.5 11109.3 11119.2 34914.1 35653.5 44373.6 44837.3 44916.8 3214.9 3574.7 3673.2 3683.9 3798.0 33897.8 34462.5 34622.7 34702.3 35692.3 4279.4 4347.7 4360.9 4363.6 4380.5 368867.0 369586.0 371367.0 375818.0 375874.0 65612.3 65777.7 66045.3 66135.7 66248.3 36640.3 37741.4 37811.6 39380.8 39480.8 15071.3 16977.8 17048.6 17094.7 17132.0 11585.8 11689.1 11934.7 11995.7 12001.2 21043.7 21187.4 21257.9 21281.9 21433.5 7727.0 7753.5 7895.8 8071.0 8081.8 954.7 1043.9 1047.6 1086.7 1143.4 34163.3 34491.8 34531.3 34612.7 34863.5 1114.0 1125.5 1130.3 1132.4 1180.0 17620.0 17968.8 18024.6 18034.9 18070.8 524139.0 528282.0 529097.0 529606.0 532524.0 40238.2 40296.6 40305.6 40373.4 40422.6 1246.0 1353.2 1384.8 1407.3 1409.3 33777.7 35334.0 35336.0 35400.0 35498.8 53243.5 53634.2 53962.7 54035.8 54077.0 440808.0 442181.0 442246.0 443966.0 445506.0 26323.9 28509.6 29389.7 29601.4 30674.4 49101.8 49758.8 50210.0 50262.0 51117.2 42673.8 43019.0 43287.0 43640.8 44624.3 42327.6 42420.8 42497.6 42869.0 43180.1 41386.8 41585.8 42672.4 42691.8 42757.8 37167.4 37241.3 37535.5 37943.4 38493.4 28759.0 28763.0 29143.4 29232.4 29241.3 03:17:01 INFO - PROCESS | 3253 | 03:17:01 INFO - PROCESS | 3253 | [#2] jquery.html Cycles:180 Average:29701.64 Median:12865.40 stddev:82197.04 (638.9%) stddev-sans-first:82398.17 03:17:01 INFO - PROCESS | 3253 | Values: 395.8 397.3 403.8 409.1 412.8 18929.9 19404.5 20059.9 20063.3 20077.6 19126.3 19208.5 19373.9 19475.5 19538.2 5573.8 5615.1 5808.4 5819.9 5820.8 5691.9 5737.4 5742.3 5748.0 5756.5 5498.0 5678.1 5684.7 5691.3 5692.8 5491.6 5612.9 5615.2 5629.8 5660.1 5111.5 5134.9 5135.4 5136.4 5137.5 23089.9 23351.0 23383.5 23576.0 23585.9 2225.0 2307.6 2347.3 2401.4 2910.4 10324.9 10503.2 10669.9 13730.1 14358.6 1877.0 1879.6 1909.7 1965.8 2022.3 84611.6 84706.0 86331.6 87817.0 89527.1 10816.2 10931.3 11052.5 11136.6 11196.5 15300.7 15348.7 15360.3 15368.8 15453.2 7649.5 7855.7 7857.2 7912.7 8033.3 7385.9 7589.7 7597.8 7605.9 7637.0 4618.0 4622.7 4685.4 4744.0 4840.0 1779.3 1863.5 1966.4 1985.5 1995.8 947.8 981.3 1019.6 1059.9 1065.3 18907.6 19974.2 20028.9 20098.5 20106.5 1006.6 1015.5 1021.9 1024.8 1045.9 10715.7 11000.0 11078.9 11109.2 11131.8 484944.0 486676.8 495384.0 502798.0 513634.0 95664.5 98371.5 98691.0 100119.0 100263.0 968.4 998.1 1015.4 1019.9 1020.9 17394.8 17537.4 17580.5 17776.6 18132.4 43479.0 43966.0 44641.3 45109.8 45506.3 60913.0 61670.4 61887.7 62864.7 63398.4 8228.0 8312.3 8419.0 8447.2 8672.4 9451.8 11830.9 12652.2 12697.2 12701.6 11096.7 11315.2 11386.4 11566.9 11620.4 9959.6 10161.5 10451.8 10572.8 10686.4 11314.3 11511.4 11771.9 11782.8 11810.0 7522.2 7823.4 8599.2 8722.2 8837.6 11230.3 11606.3 11805.8 11906.6 11952.2 03:17:01 INFO - PROCESS | 3253 | 03:17:01 INFO - PROCESS | 3253 | [#3] mootools.html Cycles:180 Average:5725.91 Median:4770.81 stddev:3166.52 (66.4%) stddev-sans-first:3159.43 03:17:01 INFO - PROCESS | 3253 | Values: 1493.7 1499.5 1608.3 1747.1 1750.3 8232.8 8682.1 8755.3 8773.2 8775.7 7439.4 8156.2 8300.8 8314.3 8575.8 2370.7 2396.3 2397.4 2397.9 2402.9 2391.7 2412.6 2449.7 2450.0 2450.5 2070.8 2296.2 2353.5 2366.2 2389.7 2293.3 2301.3 2317.8 2325.2 2326.6 2426.1 2437.1 2440.7 2447.2 2447.2 8332.2 8446.0 8447.8 8448.9 8454.7 5100.1 5227.9 5232.4 5232.7 5235.3 3314.4 3413.7 3453.2 3457.9 3471.9 990.1 1019.2 1084.5 1085.9 1116.6 11427.8 11678.2 11697.8 11715.5 11736.9 4566.8 4573.5 4755.9 4756.5 4785.1 10124.7 10127.4 10127.7 10137.9 10145.6 5216.4 5267.6 5270.6 5306.3 5321.0 4816.4 4847.2 4851.7 4855.0 4981.3 3835.7 3858.2 3890.2 3926.0 3946.3 1112.1 1155.3 1184.6 1198.5 1219.0 949.1 974.4 978.4 1028.6 1031.6 5977.1 6029.5 6174.5 6252.9 6350.3 984.7 1048.6 1073.8 1103.0 1108.3 3947.6 4202.3 4232.8 4323.5 4359.3 10351.3 10606.5 10655.2 10667.5 10690.1 9960.9 10444.2 10504.5 10523.8 10539.3 7937.4 8047.0 8088.8 8136.6 8137.9 5758.4 5897.7 5916.8 5936.6 6250.2 9562.7 9670.2 10020.8 10073.2 10103.8 10106.3 10158.3 10236.5 10253.1 10256.6 8177.0 8340.6 8355.0 8356.0 8358.2 7919.6 7996.3 8004.8 8021.6 8083.5 7351.4 7482.3 7558.2 7567.2 7670.0 7505.1 7520.4 7561.0 7631.0 7664.3 6609.9 6873.0 6888.8 7023.2 7025.1 4961.1 5002.0 5204.3 5302.4 5319.7 4895.4 4996.8 5084.2 5105.4 5181.3 03:17:01 INFO - PROCESS | 3253 | 03:17:01 INFO - PROCESS | 3253 | [#4] prototype.html Cycles:180 Average:4709.91 Median:5340.29 stddev:1368.01 (25.6%) stddev-sans-first:1331.79 03:17:01 INFO - PROCESS | 3253 | Values: 331.5 339.7 347.2 348.8 350.5 5362.3 5383.8 5388.9 5404.4 5408.7 5095.3 5130.0 5322.4 5322.5 5324.9 4163.7 4173.2 4206.6 4220.1 4254.9 4222.1 4233.5 4238.1 4257.0 4257.4 4015.0 4083.3 4104.0 4205.7 4216.6 4124.3 4177.4 4183.1 4184.8 4194.9 3721.9 3723.8 3727.8 3729.5 3734.1 5082.4 5139.8 5157.6 5169.6 5213.5 4756.7 4763.7 4765.5 4776.0 4789.5 5504.2 5504.4 5507.0 5577.8 5593.9 4000.4 4004.4 4080.7 4086.9 4111.1 5796.9 5810.1 5817.7 5827.7 5840.0 4188.2 4193.5 4195.6 4210.9 4215.4 4143.8 4192.0 4220.0 4221.7 4255.4 4716.5 4734.3 4740.2 4751.3 4773.6 5530.8 5542.6 5564.9 5592.6 5607.5 1388.9 1416.5 1447.1 1455.5 1457.1 998.7 1004.8 1014.2 1024.7 1035.8 5298.3 5301.5 5328.4 5335.9 5352.2 5568.4 5610.7 5612.3 5630.6 5638.6 5108.7 5339.3 5341.3 5342.4 5378.0 2958.3 2975.8 2985.8 2995.0 3007.4 5779.9 5785.6 5796.4 5811.7 5816.3 5605.8 5701.3 5847.4 5887.6 5910.6 5951.4 5953.0 5979.4 5986.8 5995.5 5548.3 5748.5 5767.4 5771.9 5773.7 5682.4 5689.0 5709.5 5719.8 5720.5 5927.5 5931.5 5958.8 5959.5 5968.5 3894.7 4094.6 4105.7 4145.1 4160.5 5768.3 5769.5 5769.5 5804.9 5808.2 5427.2 5435.0 5442.5 5486.5 5552.1 5154.4 5570.9 5579.3 5580.5 5580.8 5521.9 5527.7 5533.0 5540.8 5560.5 5441.3 5603.4 5615.2 5625.5 5646.3 5469.4 5475.9 5507.7 5529.2 5535.5 03:17:01 INFO - PROCESS | 3253 | 03:17:01 INFO - PROCESS | 3253 | [#5] yui.html Cycles:180 Average:20785.62 Median:4684.04 stddev:30595.54 (653.2%) stddev-sans-first:30644.43 03:17:01 INFO - PROCESS | 3253 | Values: 761.6 784.9 790.0 818.7 825.3 14897.8 16420.6 16433.4 16448.3 16449.5 14553.3 14758.1 14759.8 14760.9 14777.0 645.7 771.0 775.1 793.0 793.8 779.4 793.8 795.8 796.6 796.7 836.5 836.6 838.1 838.2 838.3 675.9 819.7 835.7 839.4 843.1 611.8 613.5 614.7 616.0 619.3 13743.0 13784.7 13808.1 13808.4 13811.7 13114.7 13404.9 13990.2 14422.3 14431.6 13212.2 13379.5 13430.0 13667.5 13877.0 3939.1 4086.0 4462.5 4542.5 4621.8 83093.0 84170.0 85013.6 85403.6 85685.1 11427.7 11716.8 11784.5 11790.2 11945.2 20825.9 21185.7 21207.7 21229.0 21385.1 7869.9 8036.1 8127.5 8145.4 8163.1 4592.5 4814.2 4867.9 4940.9 5003.9 3624.8 3726.8 3736.3 3748.1 3757.8 612.1 623.3 624.7 645.8 647.7 647.8 649.1 676.5 676.6 748.6 9875.4 10050.7 10273.1 10603.1 10620.6 645.8 725.5 727.1 731.2 731.6 4746.3 4844.8 4876.1 5027.1 5062.4 67658.7 77941.0 121384.0 130420.0 130787.3 67243.0 93902.0 106760.5 109376.0 112788.4 60616.7 66432.7 93947.5 94769.0 96460.0 8829.2 8880.5 9032.3 9064.0 9076.8 40592.8 54812.2 55180.0 57692.0 59071.4 83295.0 83638.6 84844.6 85172.6 88000.0 10536.4 10703.8 10723.7 10973.7 10975.3 12367.9 12453.2 12675.7 12734.7 12753.4 12653.3 12732.3 12790.7 13067.9 13209.3 11370.8 12039.7 12120.4 12421.3 12536.2 12510.0 12631.4 12720.9 12789.0 12900.4 9863.6 10359.2 10447.7 10777.8 10871.3 10628.2 10643.2 10833.9 10895.4 11126.2 03:17:01 INFO - PROCESS | 3253 | -------- Summary: end -------- 03:17:01 INFO - PROCESS | 3253 | 03:17:02 INFO - TEST-INFO | 3253: exit 0 03:17:02 INFO - TEST-OK | dromaeo_css | took 1113485ms 03:17:02 INFO - TEST-START | kraken 03:17:02 INFO - operating with platform_type : linux_ 03:17:02 INFO - Initialising browser for kraken test... 03:17:02 INFO - TEST-INFO | started process 3449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGbNnob/profile http://localhost:44242/getInfo.html) 03:17:06 INFO - PROCESS | 3449 | __metrics Screen width/height:1600/1200 03:17:06 INFO - PROCESS | 3449 | colorDepth:24 03:17:06 INFO - PROCESS | 3449 | Browser inner width/height: 1024/697 03:17:06 INFO - PROCESS | 3449 | __metrics 03:17:07 INFO - PROCESS | 3449 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:17:07 INFO - PROCESS | 3449 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:17:07 INFO - PROCESS | 3449 | console.error: PushService: 03:17:07 INFO - PROCESS | 3449 | stateChangeProcessEnqueue: Error transitioning state 03:17:07 INFO - PROCESS | 3449 | UnknownError 03:17:08 INFO - TEST-INFO | 3449: exit 0 03:17:08 INFO - Browser initialized. 03:17:08 INFO - Running cycle 1/1 for kraken test... 03:17:08 INFO - TEST-INFO | started process 3531 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGbNnob/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:17:20 INFO - PROCESS | 3531 | RSS: Main: 157970432 03:17:20 INFO - PROCESS | 3531 | 03:17:22 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44242/tests/kraken/driver.html?testName=audio-beat-detection) 03:17:23 INFO - PROCESS | 3531 | RSS: Main: 216633344 03:17:23 INFO - PROCESS | 3531 | 03:17:26 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44242/tests/kraken/driver.html?testName=audio-dft) 03:17:26 INFO - PROCESS | 3531 | RSS: Main: 205287424 03:17:26 INFO - PROCESS | 3531 | 03:17:29 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44242/tests/kraken/driver.html?testName=audio-fft) 03:17:30 INFO - PROCESS | 3531 | RSS: Main: 270299136 03:17:30 INFO - PROCESS | 3531 | 03:17:32 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44242/tests/kraken/driver.html?testName=audio-oscillator) 03:17:33 INFO - PROCESS | 3531 | RSS: Main: 180973568 03:17:33 INFO - PROCESS | 3531 | 03:17:35 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:17:35 INFO - PROCESS | 3531 | RSS: Main: 184438784 03:17:35 INFO - PROCESS | 3531 | 03:17:38 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44242/tests/kraken/driver.html?testName=imaging-darkroom) 03:17:39 INFO - PROCESS | 3531 | RSS: Main: 219697152 03:17:39 INFO - PROCESS | 3531 | 03:17:42 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44242/tests/kraken/driver.html?testName=imaging-desaturate) 03:17:43 INFO - PROCESS | 3531 | RSS: Main: 221548544 03:17:43 INFO - PROCESS | 3531 | 03:17:46 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44242/tests/kraken/driver.html?testName=json-parse-financial) 03:17:46 INFO - PROCESS | 3531 | RSS: Main: 222253056 03:17:46 INFO - PROCESS | 3531 | 03:17:48 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:17:48 INFO - PROCESS | 3531 | RSS: Main: 209235968 03:17:48 INFO - PROCESS | 3531 | 03:17:50 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44242/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:17:51 INFO - PROCESS | 3531 | RSS: Main: 214204416 03:17:51 INFO - PROCESS | 3531 | 03:17:53 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:17:53 INFO - PROCESS | 3531 | RSS: Main: 212516864 03:17:53 INFO - PROCESS | 3531 | 03:17:56 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:17:56 INFO - PROCESS | 3531 | RSS: Main: 223170560 03:17:56 INFO - PROCESS | 3531 | 03:17:59 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:18:00 INFO - PROCESS | 3531 | RSS: Main: 223649792 03:18:00 INFO - PROCESS | 3531 | 03:18:01 INFO - PROCESS | 3531 | Cycle 1(1): loaded http://localhost:44242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44242/tests/kraken/driver.html?testName=ai-astar) 03:18:02 INFO - PROCESS | 3531 | RSS: Main: 266297344 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | __start_tp_report 03:18:02 INFO - PROCESS | 3531 | _x_x_mozilla_page_load 03:18:02 INFO - PROCESS | 3531 | _x_x_mozilla_page_load_details 03:18:02 INFO - PROCESS | 3531 | |i|pagename|runs| 03:18:02 INFO - PROCESS | 3531 | |0;ai-astar;101;111;110;110;110;112;112;112;112;112 03:18:02 INFO - PROCESS | 3531 | |1;audio-beat-detection;145;117;126;191;118;119;140;115;160;116 03:18:02 INFO - PROCESS | 3531 | |2;audio-dft;160;160;160;161;160;160;161;161;162;160 03:18:02 INFO - PROCESS | 3531 | |3;audio-fft;74;74;76;113;75;77;75;74;104;74 03:18:02 INFO - PROCESS | 3531 | |4;audio-oscillator;83;84;109;83;83;84;121;82;84;134 03:18:02 INFO - PROCESS | 3531 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;118;117;116 03:18:02 INFO - PROCESS | 3531 | |6;imaging-darkroom;145;146;145;146;145;147;145;145;145;145 03:18:02 INFO - PROCESS | 3531 | |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 03:18:02 INFO - PROCESS | 3531 | |8;json-parse-financial;53;50;50;52;51;52;53;49;51;50 03:18:02 INFO - PROCESS | 3531 | |9;json-stringify-tinderbox;61;61;60;60;61;60;61;61;61;62 03:18:02 INFO - PROCESS | 3531 | |10;stanford-crypto-aes;74;80;74;75;74;80;74;83;75;81 03:18:02 INFO - PROCESS | 3531 | |11;stanford-crypto-ccm;119;117;123;116;133;119;120;118;155;126 03:18:02 INFO - PROCESS | 3531 | |12;stanford-crypto-pbkdf2;156;160;160;157;156;157;162;162;156;156 03:18:02 INFO - PROCESS | 3531 | |13;stanford-crypto-sha256-iterative;65;63;63;62;66;62;63;62;64;64 03:18:02 INFO - PROCESS | 3531 | __end_tp_report 03:18:02 INFO - PROCESS | 3531 | __start_cc_report 03:18:02 INFO - PROCESS | 3531 | _x_x_mozilla_cycle_collect,1656 03:18:02 INFO - PROCESS | 3531 | __end_cc_report 03:18:02 INFO - PROCESS | 3531 | __startTimestamp1469528282160__endTimestamp 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | ------- Summary: start ------- 03:18:02 INFO - PROCESS | 3531 | Number of tests: 14 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#0] ai-astar Cycles:10 Average:110.20 Median:112.00 stddev:3.36 (3.0%) stddev-sans-first:0.97 03:18:02 INFO - PROCESS | 3531 | Values: 101.0 111.0 110.0 110.0 110.0 112.0 112.0 112.0 112.0 112.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:133.00 stddev:24.94 (18.7%) stddev-sans-first:26.17 03:18:02 INFO - PROCESS | 3531 | Values: 145.0 117.0 126.0 191.0 118.0 119.0 140.0 115.0 160.0 116.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#2] audio-dft Cycles:10 Average:160.50 Median:160.50 stddev:0.71 (0.4%) stddev-sans-first:0.73 03:18:02 INFO - PROCESS | 3531 | Values: 160.0 160.0 160.0 161.0 160.0 160.0 161.0 161.0 162.0 160.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#3] audio-fft Cycles:10 Average:81.60 Median:74.50 stddev:14.37 (19.3%) stddev-sans-first:14.98 03:18:02 INFO - PROCESS | 3531 | Values: 74.0 74.0 76.0 113.0 75.0 77.0 75.0 74.0 104.0 74.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:83.00 stddev:19.31 (23.3%) stddev-sans-first:20.01 03:18:02 INFO - PROCESS | 3531 | Values: 83.0 84.0 109.0 83.0 83.0 84.0 121.0 82.0 84.0 134.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 03:18:02 INFO - PROCESS | 3531 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 116.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 03:18:02 INFO - PROCESS | 3531 | Values: 145.0 146.0 145.0 146.0 145.0 147.0 145.0 145.0 145.0 145.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:18:02 INFO - PROCESS | 3531 | Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#8] json-parse-financial Cycles:10 Average:51.10 Median:51.50 stddev:1.37 (2.7%) stddev-sans-first:1.27 03:18:02 INFO - PROCESS | 3531 | Values: 53.0 50.0 50.0 52.0 51.0 52.0 53.0 49.0 51.0 50.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 03:18:02 INFO - PROCESS | 3531 | Values: 61.0 61.0 60.0 60.0 61.0 60.0 61.0 61.0 61.0 62.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.50 stddev:3.56 (4.6%) stddev-sans-first:3.61 03:18:02 INFO - PROCESS | 3531 | Values: 74.0 80.0 74.0 75.0 74.0 80.0 74.0 83.0 75.0 81.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:121.50 stddev:11.82 (9.7%) stddev-sans-first:12.37 03:18:02 INFO - PROCESS | 3531 | Values: 119.0 117.0 123.0 116.0 133.0 119.0 120.0 118.0 155.0 126.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.50 stddev:2.53 (1.6%) stddev-sans-first:2.55 03:18:02 INFO - PROCESS | 3531 | Values: 156.0 160.0 160.0 157.0 156.0 157.0 162.0 162.0 156.0 156.0 03:18:02 INFO - PROCESS | 3531 | 03:18:02 INFO - PROCESS | 3531 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.35 (2.1%) stddev-sans-first:1.30 03:18:02 INFO - PROCESS | 3531 | Values: 65.0 63.0 63.0 62.0 66.0 62.0 63.0 62.0 64.0 64.0 03:18:02 INFO - PROCESS | 3531 | -------- Summary: end -------- 03:18:02 INFO - PROCESS | 3531 | 03:18:03 INFO - TEST-INFO | 3531: exit 0 03:18:03 INFO - TEST-OK | kraken | took 60647ms 03:18:03 INFO - SUITE-END | took 1174s 03:18:03 INFO - Completed test suite (00:19:34) 03:18:03 INFO - javascript benchmark 03:18:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.40224656192, 3076.2924527358723, 3084.4756391413443, 3097.055398103579, 3137.6862313768625, 5289.867753306169, 5358.223057656637, 5387.973060134699, 5449.455054494553, 5503.8073667421595, 5321.654092483986, 5357.276767636368, 5381.919271210935, 5431.511163995239, 5486.0, 4800.351952486422, 4853.63597730169, 4867.732274724889, 4933.33399991002, 5004.274380214867, 4949.752512374385, 4957.107720610289, 5054.115529782292, 5066.898662026757, 5070.08738427083, 4804.1352556539805, 5004.324416203803, 5005.674631148963, 5028.396592408916, 5057.140286151344, 4823.807047718087, 4838.177509823338, 4841.03179364125, 4844.031193761227, 4899.828506002273, 4814.229723244299, 4821.855344339676, 4886.51134886512, 4890.193118135503, 4931.7040977541465, 5247.658902171346, 5356.223347614613, 5398.946010539884, 5414.702191379472, 5445.482679145475, 5583.078791999315, 5654.321481422215, 5670.121131224667, 5730.312362516524, 5742.081266997302, 5697.9715101424645, 5748.913766293509, 5750.0, 5767.913481297784, 5768.8846223075725, 5273.209018647195, 5305.204219367126, 5376.838694839161, 5383.353997520323, 5385.515303622693, 5808.564357673107, 5919.6152250103605, 5926.733297001559, 5926.911096333559, 5927.0, 5651.180578816131, 5677.0, 5684.175794509773, 5693.0, 5694.572907031907, 5687.943120568824, 5712.685802280831, 5762.567807414377, 5767.9134812977, 5776.942230577641, 5752.07966725322, 5767.884642307215, 5770.855728606734, 5772.653640781483, 5815.592908496449, 5763.193152958589, 5767.36558978512, 5769.394213607595, 5772.5670574707065, 5778.422157784272, 4256.446661933929, 4287.6998610097, 4321.719088259253, 4323.027318853233, 4357.302831546937, 3840.2319536092336, 3865.7873816940337, 3897.4738410314812, 3903.375459926398, 3913.3542965410957, 5492.093804522209, 5529.972350138223, 5542.528885044736, 5544.279243698294, 5589.888202236014, 5616.550675945915, 5740.39725828782, 5817.447342502455, 5818.796342128006, 5921.555883308769, 5438.102713052381, 5446.782128714886, 5451.073317535949, 5458.235846981426, 5522.088855338904, 4871.0014447038275, 4878.829240976549, 4879.170541008037, 4882.170031094723, 4924.43369012561, 5850.61970971894, 5908.586398952118, 5948.226730525091, 5963.165156877953, 6054.757809687563, 5777.364489906191, 5789.131630255495, 5791.9131213031, 5793.913091303718, 5794.565407594531, 5982.970085149721, 5998.9100163496705, 6003.0, 6003.519718422428, 6010.128531363015, 5570.916436253378, 5616.1856530803625, 5632.211490391266, 5688.601797874109, 5708.828735137952, 5759.193712880116, 5791.449812267828, 5794.536437084938, 5798.623089499169, 5807.041838096667, 5448.346198456211, 5655.236543066633, 5662.631928924607, 5663.292088488939, 5672.546196304368, 5596.636218645775, 5641.351244606759, 5676.971615141898, 5693.686847223443, 5696.629719068247, 5591.692456914909, 5605.915911261252, 5609.439056094521, 5612.0, 5616.157576363578, 5509.173623956439, 5549.611527193058, 5720.885582288248, 5722.399148089391, 5759.71201439918, 5413.242146099628, 5465.8360249191, 5529.695866727207, 5538.224648549287, 5540.141278101901], "value": 5307.93843384796, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.8754961458094, 607.960482568633, 615.0251850816461, 633.7072372360385, 644.4522156167257, 31437.0, 45594.0, 46534.30198547016, 46536.30195547069, 46767.29849052258, 46766.29850552244, 46970.76514617422, 47170.0, 47225.0, 47278.29082563764, 8306.875396869053, 9150.267978561717, 9307.674231401903, 10740.24818262722, 11028.889711102907, 10993.065589424908, 11083.445827708581, 11091.889081109166, 11096.223264371498, 11100.500477478532, 11159.330440173575, 11167.274127181749, 11205.719857003558, 11226.270292431007, 11246.156538259622, 8411.453255538401, 10996.175286853519, 11250.49372778227, 11275.830862537068, 11281.605143820008, 10761.946190268998, 10827.187960902886, 10833.458327083614, 11109.277896936754, 11119.16606254526, 34914.12714682128, 35653.46519802205, 44373.55626443759, 44837.327440088426, 44916.77541612271, 3214.9357012859846, 3574.7140228781636, 3673.2286219893854, 3683.889483315505, 3797.9620203797886, 33897.83051084753, 34462.48306275408, 34622.653773462196, 34702.305953881034, 35692.286154277026, 4279.379489973968, 4347.717398369127, 4360.89097772555, 4363.585459381354, 4380.474343078819, 368867.0, 369586.0, 371367.0, 375818.0, 375874.0, 65612.34387656157, 65777.67111164413, 66045.33954660392, 66135.66932165308, 66248.33751662518, 36640.26719465596, 37741.433878491844, 37811.62188378081, 39380.80309598434, 39480.80259598684, 15071.321790519452, 16977.830221697626, 17048.57378565546, 17094.658106837793, 17132.0, 11585.826212606818, 11689.064874809996, 11934.701632459259, 11995.700107497209, 12001.219920705125, 21043.68434473484, 21187.36437906865, 21257.89371053135, 21281.893590532258, 21433.46416339604, 7727.0, 7753.510920085984, 7895.842083158304, 8071.013724921817, 8081.777511184354, 954.6849539651898, 1043.9425831579183, 1047.5809676129609, 1086.6685660873509, 1143.3997151495532, 34163.31673366519, 34491.827540862636, 34531.309373812386, 34612.653873461444, 34863.4770478443, 1113.9610113646145, 1125.4597793059377, 1130.3105105885404, 1132.4337831084458, 1180.0, 17620.0, 17968.820311796975, 18024.639507209784, 18034.909825450788, 18070.819291806914, 524139.0, 528282.0, 529097.0, 529606.0, 532524.0, 40238.1952360957, 40296.59703402987, 40305.596944030774, 40373.394399084034, 40422.59577404247, 1246.0, 1353.1745635162542, 1384.813050238225, 1407.2893188939724, 1409.323524708146, 33777.662223377454, 35334.0, 35336.0, 35400.0, 35498.82250588731, 53243.46756532385, 53634.19548706851, 53962.73018634882, 54035.757854528856, 54077.0, 440808.0, 442181.0, 442246.0, 443966.0, 445506.0, 26323.868380657976, 28509.572356415087, 29389.706102938697, 29601.407971840872, 30674.386512270077, 49101.754491227315, 49758.75120624374, 50210.0, 50262.0, 51117.23324150215, 42673.78663106664, 43019.0, 43287.0, 43640.781796090814, 44624.33063503985, 42327.57672423236, 42420.78789606032, 42497.57502424936, 42869.0, 43180.13639727251, 41386.79306603448, 41585.792071039454, 42672.359914601926, 42691.78654106834, 42757.78621106874, 37167.442488362154, 37241.25517489689, 37535.544079639614, 37943.43084853785, 38493.42259866048, 28759.0, 28763.0, 29143.417131656824, 29232.41535169327, 29241.268968275963], "value": 20781.26876794027, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.7506770734435, 397.3324814311955, 403.8384646141543, 409.06732649559007, 412.83073939684715, 18929.90535047323, 19404.51488712783, 20059.899700501493, 20063.297784577542, 20077.598448031047, 19126.33057842976, 19208.51978700533, 19373.903130484363, 19475.513112172204, 19538.218471261167, 5573.777048918038, 5615.101583746591, 5808.448197421239, 5819.9418005819825, 5820.796272130477, 5691.886162276752, 5737.397573254811, 5742.310922689262, 5748.02283611787, 5756.453136951983, 5498.0, 5678.091505359143, 5684.687342196177, 5691.288588926384, 5692.800751973682, 5491.615586908918, 5612.859678508029, 5615.2138700581745, 5629.831105066854, 5660.094384898396, 5111.488851114896, 5134.948650513485, 5135.38375394955, 5136.357955255593, 5137.537621614036, 23089.884550577306, 23351.0, 23383.53232935349, 23576.0, 23585.882070589538, 2225.0, 2307.596170670126, 2347.260612906929, 2401.351635058542, 2910.3888183481495, 10324.89675103247, 10503.159747220281, 10669.893301066968, 13730.077789109533, 14358.56924292273, 1877.0, 1879.5583037986062, 1909.7429766885916, 1965.77393599735, 2022.312413779322, 84611.5769421149, 84706.0, 86331.56834215851, 87817.0, 89527.10472895253, 10816.242862999514, 10931.301928124587, 11052.502637381338, 11136.610218642309, 11196.496157672924, 15300.693986120215, 15348.693026139415, 15360.308786104652, 15368.846311536965, 15453.227338633023, 7649.464537482434, 7855.685772569033, 7857.214278572097, 7912.7339625659615, 8033.317168040782, 7385.926140738524, 7589.734359297398, 7597.848043039219, 7605.9348360961085, 7637.0, 4618.0, 4622.6764126510825, 4685.367475390779, 4744.0, 4839.95160048395, 1779.323335506764, 1863.459596716964, 1966.4100769769298, 1985.5325517585434, 1995.7704863940542, 947.7677968897664, 981.283662926068, 1019.56158851693, 1059.8622179116664, 1065.2702898514542, 18907.621847562972, 19974.20103195856, 20028.89985550063, 20098.497537561387, 20106.497337566678, 1006.597361055569, 1015.5379302417382, 1021.8978102189722, 1024.774549599087, 1045.8849526552074, 10715.714114306333, 11000.0, 11078.944605276922, 11109.222354435113, 11131.833022504668, 484944.0, 486676.76570725726, 495384.0, 502798.0, 513634.0, 95664.52167739117, 98371.50814246025, 98691.01308986818, 100119.0, 100263.0, 968.4383057826444, 998.1484346537214, 1015.3552494166257, 1019.8929112443235, 1020.9183265338903, 17394.82605173932, 17537.386191483238, 17580.472585822445, 17776.644467110327, 18132.365367212085, 43479.0, 43966.0, 44641.33038004497, 45109.77445112754, 45506.31740523829, 60913.0, 61670.38329616647, 61887.69056154691, 62864.685676571324, 63398.36601633925, 8228.0, 8312.270993793416, 8418.957905210435, 8447.239748422671, 8672.392932494664, 9451.763705907408, 11830.881691182978, 12652.17760845542, 12697.174683645533, 12701.618951431103, 11096.667099987013, 11315.20793544444, 11386.373749443861, 11566.884331156582, 11620.360880151673, 9959.551820167964, 10161.491925403552, 10451.790964180522, 10572.788544228919, 10686.412247326472, 11314.321140731583, 11511.424428778695, 11771.88228117742, 11782.82325765097, 11810.0, 7522.210167932289, 7823.374130069695, 8599.226069653761, 8722.171393717586, 8837.602307896288, 11230.270032447865, 11606.30362178272, 11805.76388472243, 11906.583269585522, 11952.163348565517], "value": 9256.928439650459, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1493.663925616736, 1499.452699764586, 1608.3405803620517, 1747.1089744230446, 1750.2911320915034, 8232.753017409479, 8682.088380720028, 8755.299576033918, 8773.210411062995, 8775.692850750225, 7439.3676537494375, 8156.225158609937, 8300.83398332033, 8314.293285070777, 8575.785605359853, 2370.691810064689, 2396.341006223294, 2397.376682062659, 2397.9160729374476, 2402.8678422686744, 2391.701037370329, 2412.577798885197, 2449.6937882764655, 2449.963250551243, 2450.5221481810963, 2070.7929207079246, 2296.184854376689, 2353.5410594933996, 2366.171839856045, 2389.665446837444, 2293.312006398074, 2301.2866011536394, 2317.768223177669, 2325.2326732178426, 2326.627739561662, 2426.0538390027905, 2437.098273638765, 2440.7193172785, 2447.1801946347996, 2447.192426499251, 8332.208440198232, 8445.957770211171, 8447.788805279855, 8448.87326690094, 8454.704085357045, 5100.132977393852, 5227.869303267411, 5232.424433312371, 5232.659877107976, 5235.267062611238, 3314.386838434897, 3413.6927676509235, 3453.188500702333, 3457.94813077804, 3471.861125554975, 990.1435258501344, 1019.2202964731986, 1084.4686103809156, 1085.8968398002178, 1116.5868628607468, 11427.771444571144, 11678.182527223098, 11697.766044679143, 11715.53137874484, 11736.941315293454, 4566.840160594364, 4573.49691533931, 4755.857324280277, 4756.54812792791, 4785.066911952205, 10124.69625911224, 10127.442990635438, 10127.7468063299, 10137.949310253402, 10145.594176233015, 5216.40011398694, 5267.578593712494, 5270.60470464709, 5306.336707911511, 5321.0, 4816.446108697474, 4847.248676455155, 4851.660383773173, 4854.975725121422, 4981.32752078472, 3835.6931445484292, 3858.2476417098396, 3890.2219556088894, 3926.0, 3946.3291240489184, 1112.1047556716921, 1155.312589009538, 1184.6090790039266, 1198.5385626533848, 1219.0369608009573, 949.0793929887998, 974.4445665970329, 978.3787295067683, 1028.6245520385155, 1031.6286136990677, 5977.103434484775, 6029.517638588903, 6174.475169610633, 6252.874942501125, 6350.259436764735, 984.7242772023844, 1048.6329784575337, 1073.7584043590286, 1102.9503672334765, 1108.257467496763, 3947.624975627311, 4202.327627579572, 4232.830686772556, 4323.459567554056, 4359.324304732771, 10351.327163734333, 10606.469676516142, 10655.200859935381, 10667.466626668636, 10690.091342235997, 9960.850587241197, 10444.164466842634, 10504.527296271686, 10523.84214236787, 10539.314944528582, 7937.3650107991225, 8047.0, 8088.797780055428, 8136.55248961301, 8137.918620813834, 5758.366579676316, 5897.67562784051, 5916.792912248051, 5936.643801371932, 6250.187475628321, 9562.713118606453, 9670.178034867115, 10020.799584008424, 10073.244506661884, 10103.797924041331, 10106.343087699275, 10158.339707918962, 10236.48817559134, 10253.07722304996, 10256.641017564349, 8176.959115204386, 8340.6246718899, 8354.958225208835, 8356.0, 8358.247757701836, 7919.604019799102, 7996.32031277348, 8004.799880003046, 8021.598920054091, 8083.474574152661, 7351.448641351813, 7482.2517748224745, 7558.2441755823975, 7567.243275672388, 7670.0, 7505.099388073248, 7520.360769334668, 7561.0, 7631.0, 7664.31021208094, 6609.933900660932, 6873.037774711444, 6888.758893438706, 7023.22744498115, 7025.121859767529, 4961.131801934719, 5002.0, 5204.297419848272, 5302.416734159317, 5319.707416091997, 4895.412550493964, 4996.775145118406, 5084.186530155157, 5105.361829771278, 5181.3005244293045], "value": 4626.100854391409, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [331.53339156674343, 339.7023370723835, 347.1858491836645, 348.8447640799844, 350.45679197244283, 5362.27609272748, 5383.81156659517, 5388.8952764683145, 5404.378496472902, 5408.67547947123, 5095.312132862063, 5129.974350128254, 5322.414534401213, 5322.520973112419, 5324.946750532494, 4163.666906647461, 4173.24881521326, 4206.558311377307, 4220.134872351161, 4254.936175957356, 4222.071144348239, 4233.491980962289, 4238.131183107455, 4257.0, 4257.446531950857, 4014.972438918342, 4083.3262511685534, 4103.958960410388, 4205.726627769201, 4216.641585465224, 4124.278251306039, 4177.436046133764, 4183.121544475649, 4184.832606695729, 4194.874153775391, 3721.9441708374397, 3723.7765734056043, 3727.7763334199763, 3729.4778730977687, 3734.1038150843874, 5082.390113186441, 5139.8458046258675, 5157.58739300855, 5169.56058735008, 5213.53078222958, 4756.714597124149, 4763.69036012658, 4765.523447655241, 4775.976120119377, 4789.4971028042255, 5504.174373843915, 5504.366997795265, 5507.0, 5577.832665020056, 5593.916091258634, 4000.439938408625, 4004.437322815235, 4080.6939479538855, 4086.9386959195635, 4111.116110036357, 5796.855078623026, 5810.128480727883, 5817.712992159459, 5827.650340979555, 5840.0, 4188.162367526507, 4193.475815523059, 4195.622393984495, 4210.894727631834, 4215.367694845736, 4143.834246630101, 4192.0, 4220.0, 4221.6833737469815, 4255.404243405926, 4716.528347165325, 4734.313524538922, 4740.241561350167, 4751.263554149044, 4773.639512738922, 5530.751116199781, 5542.639728417721, 5564.944350556442, 5592.623135167538, 5607.467290607386, 1388.9305534723223, 1416.4900635771114, 1447.0594113826098, 1455.4760286296926, 1457.1402872305391, 998.7303428074524, 1004.7541049099065, 1014.1633152649094, 1024.6977141743203, 1035.7876635289747, 5298.311219541435, 5301.522862942276, 5328.350080195079, 5335.893282134336, 5352.223927530486, 5568.415316391802, 5610.747516361774, 5612.298462692163, 5630.60585758993, 5638.646724786104, 5108.744562771846, 5339.279197308391, 5341.305630268118, 5342.412334643186, 5377.973110134424, 2958.2752225704407, 2975.821450712921, 2985.7760667949556, 2994.985025074904, 3007.3985202959498, 5779.913301300484, 5785.615414982199, 5796.42035796417, 5811.738471768781, 5816.2551234629445, 5605.8417509259225, 5701.2588363513305, 5847.356790753014, 5887.5575484006695, 5910.645361278337, 5951.434613711691, 5952.970235148797, 5979.431953964279, 5986.760529578855, 5995.46040856325, 5548.278723765885, 5748.540116790563, 5767.365589785204, 5771.94228057714, 5773.653580785166, 5682.431756824284, 5688.971555142363, 5709.54323654115, 5719.828405147852, 5720.48515633595, 5927.496162826208, 5931.466168044896, 5958.76164953397, 5959.4934430573885, 5968.46283834457, 3894.6689531389015, 4094.6314831665295, 4105.69207309447, 4145.108801607669, 4160.45914031174, 5768.307803063659, 5769.480746732646, 5769.538436924952, 5804.94195058044, 5808.157817116579, 5427.185922111715, 5435.0, 5442.537384322377, 5486.533644640251, 5552.083906155601, 5154.355705536808, 5570.916436253378, 5579.302587176603, 5580.525655319343, 5580.832575022593, 5521.917171242354, 5527.668339899619, 5533.0, 5540.806071787468, 5560.499555040065, 5441.29263195782, 5603.411641777718, 5615.185798059177, 5625.521830644441, 5646.322441307069, 5469.42571030052, 5475.945240547543, 5507.697076660822, 5529.170624406372, 5535.529479994246], "value": 4279.998532922622, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [761.6229966166745, 784.921507849215, 789.9763007109789, 818.6684392820906, 825.2531459029581, 14897.77653335201, 16420.589485262873, 16433.42483013095, 16448.259828307724, 16449.50651480456, 14553.345099470524, 14758.11451312922, 14759.77860332096, 14760.926195369035, 14777.0, 645.6836150286373, 770.9730159444407, 775.0892701076241, 792.9643166057513, 793.8015496125969, 779.4465929190281, 793.8174219929391, 795.7732046366787, 796.5817945578559, 796.7092011415821, 836.5022811427191, 836.6444261188971, 838.1241602525375, 838.1576515601812, 838.337713206566, 675.9019942108391, 819.6844214977247, 835.6573804740027, 839.3620848155385, 843.1105184030845, 611.782817099932, 613.5275837605019, 614.7387360371869, 615.9568830181844, 619.3032838057186, 13743.0, 13784.655383615389, 13808.1024733392, 13808.447662093504, 13811.723765524634, 13114.737705245938, 13404.86595134046, 13990.230537320444, 14422.278886055656, 14431.567052988426, 13212.234513163798, 13379.464821407131, 13430.0, 13667.521636742666, 13877.0, 3939.0940083780606, 4085.9591404085877, 4462.4645042594775, 4542.500324964251, 4621.768911554409, 83093.0, 84170.0, 85013.57493212556, 85403.57298213532, 85685.14314856834, 11427.714607022366, 11716.824247636292, 11784.528618855322, 11790.174687771945, 11945.163838531393, 20825.895870520853, 21185.68221476679, 21207.68188477174, 21229.0, 21385.14459421637, 7869.921300786918, 8036.116027236999, 8127.512349259064, 8145.42981991255, 8163.1428699985645, 4592.471865735416, 4814.229723244264, 4867.9269810952865, 4940.90118197634, 5003.924941125886, 3624.7643903146213, 3726.795026273581, 3736.3461394255896, 3748.11919198988, 3757.755745876509, 612.0696541257264, 623.2987888625297, 624.6970219443566, 645.8052602684995, 647.6955830759536, 647.8024202618152, 649.1334069017914, 676.5399528320789, 676.5703778100941, 748.580794754939, 9875.358101723365, 10050.69847904564, 10273.126784223276, 10603.09873660732, 10620.628278010387, 645.8482256669679, 725.4667819153024, 727.1201845766682, 731.1628185727312, 731.6341829085458, 4746.311784791186, 4844.8304309349705, 4876.146674331978, 5027.120253955543, 5062.443131255633, 67658.66170669116, 77941.0, 121384.0, 130420.0, 130787.34606326907, 67243.0, 93902.0, 106760.46619766852, 109376.0, 112788.43605781918, 60616.69691651602, 66432.66783666148, 93947.53026234962, 94769.0, 96460.0, 8829.205371516595, 8880.467171969443, 9032.277417806428, 9063.957644870925, 9076.773080673036, 40592.79703601463, 54812.16314857922, 55180.0, 57692.0, 59071.40928590659, 83295.0, 83638.58180709058, 84844.57577712319, 85172.57413712892, 88000.0, 10536.420496872746, 10703.785924281627, 10723.678289651323, 10973.670789876316, 10975.28660637056, 12367.93816030914, 12453.1905426147, 12675.683107922006, 12734.745305094031, 12753.426095825525, 12653.304068276333, 12732.299723515296, 12790.68023299425, 13067.869321307046, 13209.273489958145, 11370.829437558608, 12039.699007524881, 12120.393980300772, 12421.316827574208, 12536.247825130522, 12510.0, 12631.368431578569, 12720.872791272339, 12789.0, 12900.354982250663, 9863.556139973574, 10359.22305827081, 10447.68656940293, 10777.838332425177, 10871.29336593119, 10628.202884783517, 10643.160949238792, 10833.891661083288, 10895.400752958663, 11126.221164518405], "value": 7462.2172820179485, "unit": "score"}], "name": "dromaeo_css", "value": 7296.359902670502, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 110.0, 110.0, 112.0, 112.0, 112.0, 112.0, 112.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 126.0, 191.0, 118.0, 119.0, 140.0, 115.0, 160.0, 116.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 161.0, 160.0, 160.0, 161.0, 161.0, 162.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 76.0, 113.0, 75.0, 77.0, 75.0, 74.0, 104.0, 74.0], "value": 81.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 109.0, 83.0, 83.0, 84.0, 121.0, 82.0, 84.0, 134.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 147.0, 145.0, 145.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 50.0, 50.0, 52.0, 51.0, 52.0, 53.0, 49.0, 51.0, 50.0], "value": 51.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 61.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 80.0, 74.0, 75.0, 74.0, 80.0, 74.0, 83.0, 75.0, 81.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 117.0, 123.0, 116.0, 133.0, 119.0, 120.0, 118.0, 155.0, 126.0], "value": 124.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 160.0, 160.0, 157.0, 156.0, 157.0, 162.0, 162.0, 156.0, 156.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 62.0, 66.0, 62.0, 63.0, 62.0, 64.0, 64.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1474.0, "alertThreshold": 2.0}]} 03:18:03 INFO - Return code: 0 03:18:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:18:03 INFO - # TBPL SUCCESS # 03:18:03 INFO - Running post-action listener: _resource_record_post_action 03:18:03 INFO - ##### 03:18:03 INFO - ##### Finished run-tests step (success) 03:18:03 INFO - ##### 03:18:03 INFO - Running post-run listener: _resource_record_post_run 03:18:03 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 563736576; Read time: 0; Write time: 413340 03:18:03 INFO - TinderboxPrint: CPU usage
13.0% 03:18:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:18:03 INFO - TinderboxPrint: I/O write bytes / time
563,736,576 / 413,340 03:18:03 INFO - TinderboxPrint: CPU idle
8,277.4 (87.0%) 03:18:03 INFO - TinderboxPrint: CPU user
1,194.6 (12.6%) 03:18:03 INFO - TinderboxPrint: Swap in / out
0 / 0 03:18:03 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 271876096; Read time: 0; Write time: 222852 03:18:03 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 291573760; Read time: 0; Write time: 190464 03:18:04 INFO - Running post-run listener: _upload_blobber_files 03:18:04 INFO - Blob upload gear active. 03:18:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:18:04 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 03:18:04 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:18:04 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:18:04 INFO - (blobuploader) - INFO - Open directory for files ... 03:18:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:18:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:18:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:20 INFO - (blobuploader) - INFO - Done attempting. 03:18:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:18:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:18:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:21 INFO - (blobuploader) - INFO - Done attempting. 03:18:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:18:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:18:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:18:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:18:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:18:22 INFO - (blobuploader) - INFO - Done attempting. 03:18:22 INFO - (blobuploader) - INFO - Iteration through files over. 03:18:22 INFO - Return code: 0 03:18:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:18:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:18:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04a3b2a06ded0e055484ee1beafd6908db99356cbe886f86fe2000ac66f35b0628fc2d1b5f89c1d2aa99ef7dbd158246c9fc575893dd975b0190d25dd6b615ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f6a9f65caf7059cf7de83628772bb28eafb5c9980b99a5c21f0e4825c394c501c7d8f6b5091fda68bac6c5601e86b515310098a1e6b406a1f5ab8fb3e7324e65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0d4446a29d72fe82861f8d995e2e0198fa865d3f50ef935df36d0dce74c3be99a2784204371c41e6ebdeb2603878aff3b38c32f81c1b3072ba3576ae7308bbd"} 03:18:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:18:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:18:22 INFO - Contents: 03:18:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04a3b2a06ded0e055484ee1beafd6908db99356cbe886f86fe2000ac66f35b0628fc2d1b5f89c1d2aa99ef7dbd158246c9fc575893dd975b0190d25dd6b615ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f6a9f65caf7059cf7de83628772bb28eafb5c9980b99a5c21f0e4825c394c501c7d8f6b5091fda68bac6c5601e86b515310098a1e6b406a1f5ab8fb3e7324e65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0d4446a29d72fe82861f8d995e2e0198fa865d3f50ef935df36d0dce74c3be99a2784204371c41e6ebdeb2603878aff3b38c32f81c1b3072ba3576ae7308bbd"} 03:18:22 INFO - Running post-run listener: copy_logs_to_upload_dir 03:18:22 INFO - Copying logs to upload dir... 03:18:22 INFO - mkdir: /builds/slave/test/build/upload/logs 03:18:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.469694 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-26 03:18:22.074300) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 03:18:22.080624) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04a3b2a06ded0e055484ee1beafd6908db99356cbe886f86fe2000ac66f35b0628fc2d1b5f89c1d2aa99ef7dbd158246c9fc575893dd975b0190d25dd6b615ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f6a9f65caf7059cf7de83628772bb28eafb5c9980b99a5c21f0e4825c394c501c7d8f6b5091fda68bac6c5601e86b515310098a1e6b406a1f5ab8fb3e7324e65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0d4446a29d72fe82861f8d995e2e0198fa865d3f50ef935df36d0dce74c3be99a2784204371c41e6ebdeb2603878aff3b38c32f81c1b3072ba3576ae7308bbd"} build_url:https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/dh3fkcPlS9OhlKqBWqNBgQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/04a3b2a06ded0e055484ee1beafd6908db99356cbe886f86fe2000ac66f35b0628fc2d1b5f89c1d2aa99ef7dbd158246c9fc575893dd975b0190d25dd6b615ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/f6a9f65caf7059cf7de83628772bb28eafb5c9980b99a5c21f0e4825c394c501c7d8f6b5091fda68bac6c5601e86b515310098a1e6b406a1f5ab8fb3e7324e65", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/e0d4446a29d72fe82861f8d995e2e0198fa865d3f50ef935df36d0dce74c3be99a2784204371c41e6ebdeb2603878aff3b38c32f81c1b3072ba3576ae7308bbd"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-26 03:18:22.106010) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:18:22.109317) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1469527057.762924-1345184038 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-26 03:18:22.189029) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 03:18:22.189346) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-26 03:18:22.189632) ========= ========= Total master_lag: 0.17 =========