builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-002 starttime: 1480954554.82 results: success (0) buildid: 20161205062639 builduid: a5330a2e4c1b484f8f6d8f5cf1e2061e revision: 15a86e8b45cc6840917edb57f259f6fb4f94c1fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:54.822403) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:54.822820) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:54.823101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:54.839527) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:54.839845) ========= 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=a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-05 08:15:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 69.2M=0s 2016-12-05 08:15:55 (69.2 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076718 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:54.931447) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:54.931788) ========= 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=a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021878 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:54.983280) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:54.983681) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 15a86e8b45cc6840917edb57f259f6fb4f94c1fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 15a86e8b45cc6840917edb57f259f6fb4f94c1fa --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=a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-05 08:15:55,660 truncating revision to first 12 chars 2016-12-05 08:15:55,660 Setting DEBUG logging. 2016-12-05 08:15:55,660 attempt 1/10 2016-12-05 08:15:55,660 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/15a86e8b45cc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-05 08:15:55,966 unpacking tar archive at: mozilla-aurora-15a86e8b45cc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.634907 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:55.632506) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:55.632817) ========= script_repo_revision: 15a86e8b45cc6840917edb57f259f6fb4f94c1fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:55.633203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:55.633466) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-05 08:15:55.644849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-05 08:15:55.645370) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:15:56 INFO - MultiFileLogger online at 20161205 08:15:56 in /builds/slave/test 08:15:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:15:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:15:56 INFO - {'append_to_log': False, 08:15:56 INFO - 'base_work_dir': '/builds/slave/test', 08:15:56 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:15:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:15:56 INFO - 'branch': 'Mozilla-Aurora', 08:15:56 INFO - 'buildbot_json_path': 'buildprops.json', 08:15:56 INFO - 'config_files': ('talos/linux_config.py',), 08:15:56 INFO - 'default_actions': ('clobber', 08:15:56 INFO - 'read-buildbot-config', 08:15:56 INFO - 'download-and-extract', 08:15:56 INFO - 'populate-webroot', 08:15:56 INFO - 'create-virtualenv', 08:15:56 INFO - 'install', 08:15:56 INFO - 'run-tests'), 08:15:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:15:56 INFO - 'download_minidump_stackwalk': True, 08:15:56 INFO - 'download_symbols': 'ondemand', 08:15:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:15:56 INFO - 'tooltool.py': '/tools/tooltool.py', 08:15:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:15:56 INFO - '/tools/misc-python/virtualenv.py')}, 08:15:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:15:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:15:56 INFO - 'installer_path': 'installer.exe', 08:15:56 INFO - 'log_level': 'info', 08:15:56 INFO - 'log_name': 'talos', 08:15:56 INFO - 'log_to_console': True, 08:15:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:15:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:15:56 INFO - 'opt_config_files': (), 08:15:56 INFO - 'pip_index': False, 08:15:56 INFO - 'sps_profile': False, 08:15:56 INFO - 'sps_profile_interval': 0, 08:15:56 INFO - 'suite': 'dromaeojs', 08:15:56 INFO - 'system_bits': '32', 08:15:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:15:56 INFO - 'title': 'talos-linux64-ix-002', 08:15:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:15:56 INFO - 'use_talos_json': True, 08:15:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:15:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:15:56 INFO - 'work_dir': 'build'} 08:15:56 INFO - [mozharness: 2016-12-05 16:15:56.414654Z] Running clobber step. 08:15:56 INFO - Running pre-action listener: _resource_record_pre_action 08:15:56 INFO - Running main action method: clobber 08:15:56 INFO - rmtree: /builds/slave/test/build 08:15:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:15:56 INFO - Running post-action listener: _resource_record_post_action 08:15:56 INFO - [mozharness: 2016-12-05 16:15:56.875617Z] Finished clobber step (success) 08:15:56 INFO - [mozharness: 2016-12-05 16:15:56.875716Z] Running read-buildbot-config step. 08:15:56 INFO - Running pre-action listener: _resource_record_pre_action 08:15:56 INFO - Running main action method: read_buildbot_config 08:15:56 INFO - Using buildbot properties: 08:15:56 INFO - { 08:15:56 INFO - "project": "", 08:15:56 INFO - "product": "firefox", 08:15:56 INFO - "script_repo_revision": "production", 08:15:56 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 08:15:56 INFO - "repository": "", 08:15:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 08:15:56 INFO - "buildid": "20161205062639", 08:15:56 INFO - "pgo_build": "True", 08:15:56 INFO - "basedir": "/builds/slave/test", 08:15:56 INFO - "buildnumber": 629, 08:15:56 INFO - "slavename": "talos-linux64-ix-002", 08:15:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:15:56 INFO - "platform": "ubuntu64_hw", 08:15:56 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 08:15:56 INFO - "branch": "mozilla-aurora", 08:15:56 INFO - "repo_path": "releases/mozilla-aurora", 08:15:56 INFO - "revision": "15a86e8b45cc6840917edb57f259f6fb4f94c1fa", 08:15:56 INFO - "stage_platform": "linux64-pgo", 08:15:56 INFO - "builduid": "a5330a2e4c1b484f8f6d8f5cf1e2061e", 08:15:56 INFO - "slavebuilddir": "test" 08:15:56 INFO - } 08:15:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 08:15:56 INFO - Running post-action listener: _resource_record_post_action 08:15:56 INFO - [mozharness: 2016-12-05 16:15:56.878173Z] Finished read-buildbot-config step (success) 08:15:56 INFO - [mozharness: 2016-12-05 16:15:56.878260Z] Running download-and-extract step. 08:15:56 INFO - Running pre-action listener: _resource_record_pre_action 08:15:56 INFO - Running main action method: download_and_extract 08:15:56 INFO - mkdir: /builds/slave/test/build/tests 08:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:15:56 INFO - trying https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:15:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:15:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:15:57 INFO - Downloaded 1361 bytes. 08:15:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 08:15:57 INFO - Using the following test package requirements: 08:15:57 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:15:57 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:15:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 08:15:57 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:15:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 08:15:57 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:15:57 INFO - u'jsshell-linux-x86_64.zip'], 08:15:57 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:15:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 08:15:57 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 08:15:57 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:15:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 08:15:57 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:15:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 08:15:57 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:15:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 08:15:57 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 08:15:57 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 08:15:57 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:15:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:15:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:15:57 INFO - Fetch https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:15:57 INFO - Http code: 200 08:15:57 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 08:15:57 INFO - x-amz-cf-id: T-4dqctgkx6kbF8H9_Ob6MsNc83-mth7663RI95kKwOY16LU-l-tlQ== 08:15:57 INFO - x-amz-version-id: rPEX3aOn8jxCO_APu6sKsBxqgdYj.VeH 08:15:58 INFO - Expected file size: 21954668 08:15:58 INFO - Obtained file size: 21954668 08:16:02 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:16:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 08:16:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:16:02 INFO - Fetch https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 08:16:02 INFO - Http code: 200 08:16:02 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 08:16:02 INFO - x-amz-cf-id: XuV4D0SgiTiZjE9I_QhET4UeS5V_eH3DSAAccM04YULkHnm-OqKxdw== 08:16:02 INFO - x-amz-version-id: rPEX3aOn8jxCO_APu6sKsBxqgdYj.VeH 08:16:03 INFO - Expected file size: 21954668 08:16:03 INFO - Obtained file size: 21954668 08:16:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 08:16:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:16:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 08:16:08 INFO - Http code: 200 08:16:08 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 08:16:08 INFO - x-amz-cf-id: 6N1VDbMlEpEurHOOi6FdAtrnKuQSkPxJ_m7ZiZA3rnBrk3DxKUTdKQ== 08:16:08 INFO - x-amz-version-id: HOnjgqVQ.6QRDqmvpIvuZ22QMQHEzVNs 08:16:08 INFO - Expected file size: 14409038 08:16:08 INFO - Obtained file size: 14409038 08:16:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:09 INFO - trying https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:16:09 INFO - Downloading https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:16:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:16:12 INFO - Downloaded 63986118 bytes. 08:16:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:16:12 INFO - mkdir: /builds/slave/test/properties 08:16:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:16:12 INFO - Writing to file /builds/slave/test/properties/build_url 08:16:12 INFO - Contents: 08:16:12 INFO - build_url:https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 08:16:12 INFO - Running post-action listener: _resource_record_post_action 08:16:12 INFO - Running post-action listener: set_extra_try_arguments 08:16:12 INFO - [mozharness: 2016-12-05 16:16:12.816701Z] Finished download-and-extract step (success) 08:16:12 INFO - [mozharness: 2016-12-05 16:16:12.816928Z] Running populate-webroot step. 08:16:12 INFO - Running pre-action listener: _resource_record_pre_action 08:16:12 INFO - Running main action method: populate_webroot 08:16:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:16:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:16:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:16:12 INFO - '--tppagecycles', 08:16:12 INFO - '7'], 08:16:12 INFO - 'tests': ['tsvgm']}}, 08:16:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:12 INFO - 'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:12 INFO - 'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['damp', 'tps']}, 08:16:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:12 INFO - 'tests': ['damp', 'tps']}, 08:16:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['dromaeo_dom']}, 08:16:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['basic_compositor_video']}, 08:16:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:16:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['a11yr', 08:16:12 INFO - 'ts_paint', 08:16:12 INFO - 'tpaint', 08:16:12 INFO - 'sessionrestore', 08:16:12 INFO - 'sessionrestore_no_auto_restore', 08:16:12 INFO - 'tabpaint']}, 08:16:12 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:12 INFO - 'ts_paint', 08:16:12 INFO - 'tpaint', 08:16:12 INFO - 'sessionrestore', 08:16:12 INFO - 'sessionrestore_no_auto_restore', 08:16:12 INFO - 'tabpaint']}, 08:16:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:16:12 INFO - 'ts_paint', 08:16:12 INFO - 'tpaint', 08:16:12 INFO - 'sessionrestore', 08:16:12 INFO - 'sessionrestore_no_auto_restore', 08:16:12 INFO - 'tabpaint']}, 08:16:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:16:12 INFO - 'ts_paint', 08:16:12 INFO - 'tpaint', 08:16:12 INFO - 'sessionrestore', 08:16:12 INFO - 'sessionrestore_no_auto_restore', 08:16:12 INFO - 'tabpaint']}, 08:16:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['a11yr', 08:16:12 INFO - 'ts_paint', 08:16:12 INFO - 'tpaint', 08:16:12 INFO - 'sessionrestore', 08:16:12 INFO - 'sessionrestore_no_auto_restore', 08:16:12 INFO - 'tabpaint']}, 08:16:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['a11yr', 08:16:12 INFO - 'ts_paint', 08:16:12 INFO - 'tpaint', 08:16:12 INFO - 'sessionrestore', 08:16:12 INFO - 'sessionrestore_no_auto_restore', 08:16:12 INFO - 'tabpaint']}, 08:16:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['tsvgx', 08:16:12 INFO - 'tsvgr_opacity', 08:16:12 INFO - 'tart', 08:16:12 INFO - 'tscrollx', 08:16:12 INFO - 'cart']}, 08:16:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:12 INFO - 'tsvgr_opacity', 08:16:12 INFO - 'tart', 08:16:12 INFO - 'tscrollx', 08:16:12 INFO - 'cart']}, 08:16:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:12 INFO - 'talos_options': ['--disable-e10s'], 08:16:12 INFO - 'tests': ['tp5o']}, 08:16:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:12 INFO - 'tests': ['tp5o']}, 08:16:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:12 INFO - 'talos_options': ['--disable-e10s', 08:16:12 INFO - '--xperf_path', 08:16:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:12 INFO - 'tests': ['tp5n']}, 08:16:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:16:12 INFO - 'talos_options': ['--xperf_path', 08:16:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:12 INFO - 'tests': ['tp5n']}}, 08:16:12 INFO - 'talos.zip': {'path': '', 08:16:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:16:12 INFO - Running post-action listener: _resource_record_post_action 08:16:12 INFO - [mozharness: 2016-12-05 16:16:12.835937Z] Finished populate-webroot step (success) 08:16:12 INFO - [mozharness: 2016-12-05 16:16:12.836026Z] Running create-virtualenv step. 08:16:12 INFO - Running pre-action listener: _resource_record_pre_action 08:16:12 INFO - Running main action method: create_virtualenv 08:16:12 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:12 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 08:16:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:12 INFO - Using real prefix '/usr' 08:16:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:13 INFO - Installing distribute.............................................................................................................................................................................................done. 08:16:15 INFO - Installing pip.................done. 08:16:15 INFO - Return code: 0 08:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:16:15 INFO - Reading from file tmpfile_stdout 08:16:15 INFO - Output received: 08:16:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:16:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba9b60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', '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 08:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:16:15 INFO - Using env: {'DISPLAY': ':0', 08:16:15 INFO - 'HOME': '/home/cltbld', 08:16:15 INFO - 'LANG': 'en_US.UTF-8', 08:16:15 INFO - 'LANGUAGE': 'en_US:en', 08:16:15 INFO - 'LOGNAME': 'cltbld', 08:16:15 INFO - 'MAIL': '/var/mail/cltbld', 08:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:15 INFO - 'MOZ_NO_REMOTE': '1', 08:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:15 INFO - 'NO_EM_RESTART': '1', 08:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:15 INFO - 'PWD': '/builds/slave/test', 08:16:15 INFO - 'SHELL': '/bin/bash', 08:16:15 INFO - 'SHLVL': '1', 08:16:15 INFO - 'TERM': 'linux', 08:16:15 INFO - 'TMOUT': '86400', 08:16:15 INFO - 'USER': 'cltbld', 08:16:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:15 INFO - '_': '/tools/buildbot/bin/python'} 08:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:15 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 08:16:15 INFO - Cleaning up... 08:16:15 INFO - Return code: 0 08:16:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbba9b60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', '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 08:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:16:15 INFO - Using env: {'DISPLAY': ':0', 08:16:15 INFO - 'HOME': '/home/cltbld', 08:16:15 INFO - 'LANG': 'en_US.UTF-8', 08:16:15 INFO - 'LANGUAGE': 'en_US:en', 08:16:15 INFO - 'LOGNAME': 'cltbld', 08:16:15 INFO - 'MAIL': '/var/mail/cltbld', 08:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:15 INFO - 'MOZ_NO_REMOTE': '1', 08:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:15 INFO - 'NO_EM_RESTART': '1', 08:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:15 INFO - 'PWD': '/builds/slave/test', 08:16:15 INFO - 'SHELL': '/bin/bash', 08:16:15 INFO - 'SHLVL': '1', 08:16:15 INFO - 'TERM': 'linux', 08:16:15 INFO - 'TMOUT': '86400', 08:16:15 INFO - 'USER': 'cltbld', 08:16:15 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:15 INFO - '_': '/tools/buildbot/bin/python'} 08:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:16 INFO - Downloading/unpacking psutil>=3.1.1 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 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 08:16:16 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 08:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:18 INFO - Installing collected packages: psutil 08:16:18 INFO - Running setup.py install for psutil 08:16:18 INFO - building 'psutil._psutil_linux' extension 08:16:18 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 08:16:18 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 08:16:18 INFO - building 'psutil._psutil_posix' extension 08:16:18 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 08:16:18 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 08:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:18 INFO - Successfully installed psutil 08:16:18 INFO - Cleaning up... 08:16:18 INFO - Return code: 0 08:16:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:18 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 0x7fbba9b60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', '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 08:16:18 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 08:16:18 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 08:16:18 INFO - Using env: {'DISPLAY': ':0', 08:16:18 INFO - 'HOME': '/home/cltbld', 08:16:18 INFO - 'LANG': 'en_US.UTF-8', 08:16:18 INFO - 'LANGUAGE': 'en_US:en', 08:16:18 INFO - 'LOGNAME': 'cltbld', 08:16:18 INFO - 'MAIL': '/var/mail/cltbld', 08:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:18 INFO - 'MOZ_NO_REMOTE': '1', 08:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:18 INFO - 'NO_EM_RESTART': '1', 08:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:18 INFO - 'PWD': '/builds/slave/test', 08:16:18 INFO - 'SHELL': '/bin/bash', 08:16:18 INFO - 'SHLVL': '1', 08:16:18 INFO - 'TERM': 'linux', 08:16:18 INFO - 'TMOUT': '86400', 08:16:18 INFO - 'USER': 'cltbld', 08:16:18 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:18 INFO - '_': '/tools/buildbot/bin/python'} 08:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:16:20 INFO - Installing collected packages: mozsystemmonitor 08:16:20 INFO - Running setup.py install for mozsystemmonitor 08:16:21 INFO - Successfully installed mozsystemmonitor 08:16:21 INFO - Cleaning up... 08:16:21 INFO - Return code: 0 08:16:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:21 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 0x7fbba9b60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', '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 08:16:21 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 08:16:21 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 08:16:21 INFO - Using env: {'DISPLAY': ':0', 08:16:21 INFO - 'HOME': '/home/cltbld', 08:16:21 INFO - 'LANG': 'en_US.UTF-8', 08:16:21 INFO - 'LANGUAGE': 'en_US:en', 08:16:21 INFO - 'LOGNAME': 'cltbld', 08:16:21 INFO - 'MAIL': '/var/mail/cltbld', 08:16:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:21 INFO - 'MOZ_NO_REMOTE': '1', 08:16:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:21 INFO - 'NO_EM_RESTART': '1', 08:16:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:21 INFO - 'PWD': '/builds/slave/test', 08:16:21 INFO - 'SHELL': '/bin/bash', 08:16:21 INFO - 'SHLVL': '1', 08:16:21 INFO - 'TERM': 'linux', 08:16:21 INFO - 'TMOUT': '86400', 08:16:21 INFO - 'USER': 'cltbld', 08:16:21 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:21 INFO - '_': '/tools/buildbot/bin/python'} 08:16:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:21 INFO - Downloading/unpacking jsonschema==2.5.1 08:16:21 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 08:16:21 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 08:16:21 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 08:16:21 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 08:16:21 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 08:16:21 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 08:16:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:16:23 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 08:16:23 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 08:16:23 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 08:16:23 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 08:16:23 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 08:16:23 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 08:16:23 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:23 INFO - warning: no files found matching '*.txt' 08:16:23 INFO - no previously-included directories found matching 'build' 08:16:23 INFO - no previously-included directories found matching 'dist' 08:16:23 INFO - no previously-included directories found matching '.git*' 08:16:23 INFO - Installing collected packages: jsonschema, functools32 08:16:23 INFO - Running setup.py install for functools32 08:16:23 INFO - warning: no files found matching '*.txt' 08:16:23 INFO - no previously-included directories found matching 'build' 08:16:23 INFO - no previously-included directories found matching 'dist' 08:16:23 INFO - no previously-included directories found matching '.git*' 08:16:23 INFO - Successfully installed jsonschema functools32 08:16:23 INFO - Cleaning up... 08:16:23 INFO - Return code: 0 08:16:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba9b60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', '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 08:16:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:16:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:16:23 INFO - Using env: {'DISPLAY': ':0', 08:16:23 INFO - 'HOME': '/home/cltbld', 08:16:23 INFO - 'LANG': 'en_US.UTF-8', 08:16:23 INFO - 'LANGUAGE': 'en_US:en', 08:16:23 INFO - 'LOGNAME': 'cltbld', 08:16:23 INFO - 'MAIL': '/var/mail/cltbld', 08:16:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:23 INFO - 'MOZ_NO_REMOTE': '1', 08:16:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:23 INFO - 'NO_EM_RESTART': '1', 08:16:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:23 INFO - 'PWD': '/builds/slave/test', 08:16:23 INFO - 'SHELL': '/bin/bash', 08:16:23 INFO - 'SHLVL': '1', 08:16:23 INFO - 'TERM': 'linux', 08:16:23 INFO - 'TMOUT': '86400', 08:16:23 INFO - 'USER': 'cltbld', 08:16:23 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:23 INFO - '_': '/tools/buildbot/bin/python'} 08:16:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:16:23 INFO - Cleaning up... 08:16:23 INFO - Return code: 0 08:16:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:24 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 0x7fbba9b60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', '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 08:16:24 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 08:16:24 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 08:16:24 INFO - Using env: {'DISPLAY': ':0', 08:16:24 INFO - 'HOME': '/home/cltbld', 08:16:24 INFO - 'LANG': 'en_US.UTF-8', 08:16:24 INFO - 'LANGUAGE': 'en_US:en', 08:16:24 INFO - 'LOGNAME': 'cltbld', 08:16:24 INFO - 'MAIL': '/var/mail/cltbld', 08:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:24 INFO - 'MOZ_NO_REMOTE': '1', 08:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:24 INFO - 'NO_EM_RESTART': '1', 08:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:24 INFO - 'PWD': '/builds/slave/test', 08:16:24 INFO - 'SHELL': '/bin/bash', 08:16:24 INFO - 'SHLVL': '1', 08:16:24 INFO - 'TERM': 'linux', 08:16:24 INFO - 'TMOUT': '86400', 08:16:24 INFO - 'USER': 'cltbld', 08:16:24 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:24 INFO - '_': '/tools/buildbot/bin/python'} 08:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:24 INFO - Downloading/unpacking blobuploader==1.2.4 08:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:26 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:27 INFO - Downloading docopt-0.6.1.tar.gz 08:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:27 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:27 INFO - Running setup.py install for blobuploader 08:16:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:27 INFO - Running setup.py install for requests 08:16:27 INFO - Running setup.py install for docopt 08:16:27 INFO - Successfully installed blobuploader requests docopt 08:16:27 INFO - Cleaning up... 08:16:27 INFO - Return code: 0 08:16:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:27 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 0x7fbba9b60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', '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 08:16:27 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 08:16:27 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 08:16:27 INFO - Using env: {'DISPLAY': ':0', 08:16:27 INFO - 'HOME': '/home/cltbld', 08:16:27 INFO - 'LANG': 'en_US.UTF-8', 08:16:27 INFO - 'LANGUAGE': 'en_US:en', 08:16:27 INFO - 'LOGNAME': 'cltbld', 08:16:27 INFO - 'MAIL': '/var/mail/cltbld', 08:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:27 INFO - 'MOZ_NO_REMOTE': '1', 08:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:27 INFO - 'NO_EM_RESTART': '1', 08:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:27 INFO - 'PWD': '/builds/slave/test', 08:16:27 INFO - 'SHELL': '/bin/bash', 08:16:27 INFO - 'SHLVL': '1', 08:16:27 INFO - 'TERM': 'linux', 08:16:27 INFO - 'TMOUT': '86400', 08:16:27 INFO - 'USER': 'cltbld', 08:16:27 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:27 INFO - '_': '/tools/buildbot/bin/python'} 08:16:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:28 INFO - Running setup.py (path:/tmp/pip-yM1fq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:28 INFO - Running setup.py (path:/tmp/pip-xYfbMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:28 INFO - Running setup.py (path:/tmp/pip-BRQoZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:28 INFO - Running setup.py (path:/tmp/pip-1JXXg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:28 INFO - Running setup.py (path:/tmp/pip-FqtU6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:28 INFO - Running setup.py (path:/tmp/pip-HcinXT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:28 INFO - Running setup.py (path:/tmp/pip-qlj87T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:28 INFO - Running setup.py (path:/tmp/pip-gUYJlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:28 INFO - Running setup.py (path:/tmp/pip-tPJRXY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:28 INFO - Running setup.py (path:/tmp/pip-grIWPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:28 INFO - Running setup.py (path:/tmp/pip-eFz4CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:28 INFO - Running setup.py (path:/tmp/pip-5SBBDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:28 INFO - Running setup.py (path:/tmp/pip-jjGHSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:28 INFO - Running setup.py (path:/tmp/pip-dXioBd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:29 INFO - Running setup.py (path:/tmp/pip-HZlx8E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:29 INFO - Running setup.py (path:/tmp/pip-49UiXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:29 INFO - Running setup.py (path:/tmp/pip-ceDu5T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:29 INFO - Running setup.py install for manifestparser 08:16:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:29 INFO - Running setup.py install for mozcrash 08:16:29 INFO - Running setup.py install for mozdebug 08:16:29 INFO - Running setup.py install for mozdevice 08:16:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:29 INFO - Running setup.py install for mozfile 08:16:29 INFO - Running setup.py install for mozhttpd 08:16:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:29 INFO - Running setup.py install for mozinfo 08:16:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:29 INFO - Running setup.py install for mozInstall 08:16:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:30 INFO - Running setup.py install for mozleak 08:16:30 INFO - Running setup.py install for mozlog 08:16:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:30 INFO - Running setup.py install for moznetwork 08:16:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:30 INFO - Running setup.py install for mozprocess 08:16:30 INFO - Running setup.py install for mozprofile 08:16:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:30 INFO - Running setup.py install for mozrunner 08:16:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:30 INFO - Running setup.py install for mozscreenshot 08:16:30 INFO - Running setup.py install for moztest 08:16:30 INFO - Running setup.py install for mozversion 08:16:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:16:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:16:31 INFO - Cleaning up... 08:16:31 INFO - Return code: 0 08:16:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:31 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 0x7fbba9b60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', '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 08:16:31 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 08:16:31 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 08:16:31 INFO - Using env: {'DISPLAY': ':0', 08:16:31 INFO - 'HOME': '/home/cltbld', 08:16:31 INFO - 'LANG': 'en_US.UTF-8', 08:16:31 INFO - 'LANGUAGE': 'en_US:en', 08:16:31 INFO - 'LOGNAME': 'cltbld', 08:16:31 INFO - 'MAIL': '/var/mail/cltbld', 08:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:31 INFO - 'MOZ_NO_REMOTE': '1', 08:16:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:31 INFO - 'NO_EM_RESTART': '1', 08:16:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:31 INFO - 'PWD': '/builds/slave/test', 08:16:31 INFO - 'SHELL': '/bin/bash', 08:16:31 INFO - 'SHLVL': '1', 08:16:31 INFO - 'TERM': 'linux', 08:16:31 INFO - 'TMOUT': '86400', 08:16:31 INFO - 'USER': 'cltbld', 08:16:31 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:31 INFO - '_': '/tools/buildbot/bin/python'} 08:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:31 INFO - Running setup.py (path:/tmp/pip-BpzFWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:31 INFO - Running setup.py (path:/tmp/pip-vVAGVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:31 INFO - Running setup.py (path:/tmp/pip-usHeqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:31 INFO - Running setup.py (path:/tmp/pip-_uMz4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:31 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)) 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:31 INFO - Running setup.py (path:/tmp/pip-xufawl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:31 INFO - Running setup.py (path:/tmp/pip-wvmS_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:31 INFO - Running setup.py (path:/tmp/pip-keq369-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:31 INFO - Running setup.py (path:/tmp/pip-Omj1mY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:31 INFO - Running setup.py (path:/tmp/pip-zdUA9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:31 INFO - Running setup.py (path:/tmp/pip-2CkA6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 08:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:31 INFO - Running setup.py (path:/tmp/pip-vJ2IJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:32 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)) 08:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:32 INFO - Running setup.py (path:/tmp/pip-DQaYNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:32 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)) 08:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:32 INFO - Running setup.py (path:/tmp/pip-aBx2Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:32 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)) 08:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:32 INFO - Running setup.py (path:/tmp/pip-RQP4tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:32 INFO - Running setup.py (path:/tmp/pip-GYNLy1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:32 INFO - Running setup.py (path:/tmp/pip-ynO0Cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:16:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:32 INFO - Running setup.py (path:/tmp/pip-fLcMzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:16:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:16:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:16:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:16:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:16:34 INFO - Downloading blessings-1.6.tar.gz 08:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:16:34 INFO - Installing collected packages: blessings 08:16:34 INFO - Running setup.py install for blessings 08:16:34 INFO - Successfully installed blessings 08:16:34 INFO - Cleaning up... 08:16:34 INFO - Return code: 0 08:16:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:16:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:34 INFO - Reading from file tmpfile_stdout 08:16:34 INFO - Current package versions: 08:16:34 INFO - argparse == 1.2.1 08:16:34 INFO - blessings == 1.6 08:16:34 INFO - blobuploader == 1.2.4 08:16:34 INFO - docopt == 0.6.1 08:16:34 INFO - functools32 == 3.2.3-2 08:16:34 INFO - jsonschema == 2.5.1 08:16:34 INFO - manifestparser == 1.1 08:16:34 INFO - mozInstall == 1.12 08:16:34 INFO - mozcrash == 1.0 08:16:34 INFO - mozdebug == 0.1 08:16:34 INFO - mozdevice == 0.48 08:16:34 INFO - mozfile == 1.2 08:16:34 INFO - mozhttpd == 0.7 08:16:34 INFO - mozinfo == 0.9 08:16:34 INFO - mozleak == 0.1 08:16:34 INFO - mozlog == 3.4 08:16:34 INFO - moznetwork == 0.27 08:16:34 INFO - mozprocess == 0.23 08:16:34 INFO - mozprofile == 0.28 08:16:34 INFO - mozrunner == 6.13 08:16:34 INFO - mozscreenshot == 0.1 08:16:34 INFO - mozsystemmonitor == 0.3 08:16:34 INFO - moztest == 0.7 08:16:34 INFO - mozversion == 1.4 08:16:34 INFO - psutil == 3.1.1 08:16:34 INFO - requests == 1.2.3 08:16:34 INFO - wsgiref == 0.1.2 08:16:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:34 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 0x7fbba9b60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', '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 08:16:34 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 08:16:34 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 08:16:34 INFO - Using env: {'DISPLAY': ':0', 08:16:34 INFO - 'HOME': '/home/cltbld', 08:16:34 INFO - 'LANG': 'en_US.UTF-8', 08:16:34 INFO - 'LANGUAGE': 'en_US:en', 08:16:34 INFO - 'LOGNAME': 'cltbld', 08:16:34 INFO - 'MAIL': '/var/mail/cltbld', 08:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:34 INFO - 'MOZ_NO_REMOTE': '1', 08:16:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:34 INFO - 'NO_EM_RESTART': '1', 08:16:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:34 INFO - 'PWD': '/builds/slave/test', 08:16:34 INFO - 'SHELL': '/bin/bash', 08:16:34 INFO - 'SHLVL': '1', 08:16:34 INFO - 'TERM': 'linux', 08:16:34 INFO - 'TMOUT': '86400', 08:16:34 INFO - 'USER': 'cltbld', 08:16:34 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:34 INFO - '_': '/tools/buildbot/bin/python'} 08:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:35 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)) 08:16:35 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)) 08:16:35 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)) 08:16:35 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)) 08:16:35 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)) 08:16:35 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)) 08:16:35 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)) 08:16:35 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)) 08:16:35 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)) 08:16:35 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)) 08:16:35 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)) 08:16:35 INFO - Cleaning up... 08:16:35 INFO - Return code: 0 08:16:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbba9b60f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23d48a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a1ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, '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': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', '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 08:16:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:16:35 INFO - Using env: {'DISPLAY': ':0', 08:16:35 INFO - 'HOME': '/home/cltbld', 08:16:35 INFO - 'LANG': 'en_US.UTF-8', 08:16:35 INFO - 'LANGUAGE': 'en_US:en', 08:16:35 INFO - 'LOGNAME': 'cltbld', 08:16:35 INFO - 'MAIL': '/var/mail/cltbld', 08:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:35 INFO - 'MOZ_NO_REMOTE': '1', 08:16:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:35 INFO - 'NO_EM_RESTART': '1', 08:16:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:35 INFO - 'PWD': '/builds/slave/test', 08:16:35 INFO - 'SHELL': '/bin/bash', 08:16:35 INFO - 'SHLVL': '1', 08:16:35 INFO - 'TERM': 'linux', 08:16:35 INFO - 'TMOUT': '86400', 08:16:35 INFO - 'USER': 'cltbld', 08:16:35 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:35 INFO - '_': '/tools/buildbot/bin/python'} 08:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:16:35 INFO - Cleaning up... 08:16:35 INFO - Return code: 0 08:16:35 INFO - Running post-action listener: _resource_record_post_action 08:16:35 INFO - Running post-action listener: _start_resource_monitoring 08:16:35 INFO - Starting resource monitoring. 08:16:35 INFO - [mozharness: 2016-12-05 16:16:35.529202Z] Finished create-virtualenv step (success) 08:16:35 INFO - [mozharness: 2016-12-05 16:16:35.530238Z] Running install step. 08:16:35 INFO - Running pre-action listener: _resource_record_pre_action 08:16:35 INFO - Running main action method: install 08:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:16:35 INFO - Reading from file tmpfile_stdout 08:16:35 INFO - Detecting whether we're running mozinstall >=1.0... 08:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:16:35 INFO - Reading from file tmpfile_stdout 08:16:35 INFO - Output received: 08:16:35 INFO - Usage: mozinstall [options] installer 08:16:35 INFO - Options: 08:16:35 INFO - -h, --help show this help message and exit 08:16:35 INFO - -d DEST, --destination=DEST 08:16:35 INFO - Directory to install application into. [default: 08:16:35 INFO - "/builds/slave/test"] 08:16:35 INFO - --app=APP Application being installed. [default: firefox] 08:16:35 INFO - mkdir: /builds/slave/test/build/application 08:16:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:16:51 INFO - Reading from file tmpfile_stdout 08:16:51 INFO - Output received: 08:16:51 INFO - /builds/slave/test/build/application/firefox/firefox 08:16:51 INFO - Running post-action listener: _resource_record_post_action 08:16:51 INFO - [mozharness: 2016-12-05 16:16:51.754557Z] Finished install step (success) 08:16:51 INFO - [mozharness: 2016-12-05 16:16:51.754800Z] Running run-tests step. 08:16:51 INFO - Running pre-action listener: _resource_record_pre_action 08:16:51 INFO - Running main action method: run_tests 08:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:16:51 INFO - Python 2.7.3 08:16:51 INFO - Return code: 0 08:16:51 INFO - grabbing minidump binary from tooltool 08:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:51 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 0x249ef60>, '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 0x249fd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24a01d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:16:51 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 08:16:51 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 08:16:51 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 08:16:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:16:51 INFO - Return code: 0 08:16:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:16:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:16:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:16:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:16:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 08:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 08:16:51 INFO - Using env: {'DISPLAY': ':0', 08:16:51 INFO - 'HOME': '/home/cltbld', 08:16:51 INFO - 'LANG': 'en_US.UTF-8', 08:16:51 INFO - 'LANGUAGE': 'en_US:en', 08:16:51 INFO - 'LOGNAME': 'cltbld', 08:16:51 INFO - 'MAIL': '/var/mail/cltbld', 08:16:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:16:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:51 INFO - 'MOZ_NO_REMOTE': '1', 08:16:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:51 INFO - 'NO_EM_RESTART': '1', 08:16:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:51 INFO - 'PWD': '/builds/slave/test', 08:16:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:16:51 INFO - 'SHELL': '/bin/bash', 08:16:51 INFO - 'SHLVL': '1', 08:16:51 INFO - 'TERM': 'linux', 08:16:51 INFO - 'TMOUT': '86400', 08:16:51 INFO - 'USER': 'cltbld', 08:16:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288', 08:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:51 INFO - '_': '/tools/buildbot/bin/python'} 08:16:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 08:16:52 INFO - mozversion application_buildid: 20161205062639 08:16:52 INFO - mozversion application_changeset: 15a86e8b45cc6840917edb57f259f6fb4f94c1fa 08:16:52 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:16:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:16:52 INFO - mozversion application_name: Firefox 08:16:52 INFO - mozversion application_remotingname: firefox-dev 08:16:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:16:52 INFO - mozversion application_vendor: Mozilla 08:16:52 INFO - mozversion application_version: 52.0a2 08:16:52 INFO - mozversion platform_buildid: 20161205062639 08:16:52 INFO - mozversion platform_changeset: 15a86e8b45cc6840917edb57f259f6fb4f94c1fa 08:16:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:16:52 INFO - mozversion platform_version: 52.0a2 08:16:52 INFO - using testdate: 1480954612 08:16:52 INFO - actual date: 1480954612 08:16:52 INFO - starting webserver on 'localhost:36158' 08:16:52 INFO - SUITE-START | Running 2 tests 08:16:52 INFO - TEST-START | dromaeo_css 08:16:52 INFO - operating with platform_type : linux_ 08:16:52 INFO - Initialising browser for dromaeo_css test... 08:16:52 INFO - TEST-INFO | started process 13333 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPg0v_s/profile http://localhost:36158/getInfo.html) 08:16:56 INFO - PROCESS | 13333 | __metrics Screen width/height:1600/1200 08:16:56 INFO - PROCESS | 13333 | colorDepth:24 08:16:56 INFO - PROCESS | 13333 | Browser inner width/height: 1024/697 08:16:56 INFO - PROCESS | 13333 | __metrics 08:16:56 INFO - PROCESS | 13333 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:16:56 INFO - PROCESS | 13333 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:16:57 INFO - PROCESS | 13333 | console.error: PushService: 08:16:57 INFO - PROCESS | 13333 | stateChangeProcessEnqueue: Error transitioning state 08:16:57 INFO - PROCESS | 13333 | UnknownError 08:16:57 INFO - TEST-INFO | 13333: exit 0 08:16:57 INFO - Browser initialized. 08:16:57 INFO - Running cycle 1/1 for dromaeo_css test... 08:16:57 INFO - TEST-INFO | started process 13425 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPg0v_s/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:09 INFO - PROCESS | 13425 | RSS: Main: 147787776 08:17:09 INFO - PROCESS | 13425 | 08:18:00 INFO - PROCESS | 13425 | 1480954680912 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] 08:20:11 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36158/tests/dromaeo/cssquery-ext.html) 08:20:12 INFO - PROCESS | 13425 | RSS: Main: 246976512 08:20:12 INFO - PROCESS | 13425 | 08:23:14 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-ext.html (next: http://localhost:36158/tests/dromaeo/cssquery-jquery.html) 08:23:15 INFO - PROCESS | 13425 | RSS: Main: 230326272 08:23:15 INFO - PROCESS | 13425 | 08:26:16 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36158/tests/dromaeo/cssquery-mootools.html) 08:26:17 INFO - PROCESS | 13425 | RSS: Main: 199376896 08:26:17 INFO - PROCESS | 13425 | 08:29:19 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36158/tests/dromaeo/cssquery-prototype.html) 08:29:19 INFO - PROCESS | 13425 | RSS: Main: 217698304 08:29:19 INFO - PROCESS | 13425 | 08:32:22 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36158/tests/dromaeo/cssquery-yui.html) 08:32:23 INFO - PROCESS | 13425 | RSS: Main: 175525888 08:32:23 INFO - PROCESS | 13425 | 08:35:25 INFO - PROCESS | 13425 | Cycle 1(1): loaded http://localhost:36158/tests/dromaeo/cssquery-yui.html (next: http://localhost:36158/tests/dromaeo/cssquery-dojo.html) 08:35:25 INFO - PROCESS | 13425 | RSS: Main: 272302080 08:35:25 INFO - PROCESS | 13425 | 08:35:25 INFO - PROCESS | 13425 | __start_tp_report 08:35:25 INFO - PROCESS | 13425 | _x_x_mozilla_page_load 08:35:25 INFO - PROCESS | 13425 | _x_x_mozilla_page_load_details 08:35:25 INFO - PROCESS | 13425 | |i|pagename|runs| 08:35:25 INFO - PROCESS | 13425 | |0;dojo.html;3103.906882793516;3122.656507784142;3143.2141964508874;3150.2281940924477;3150.82670453125;5410.864728381793;5480.616356855022;5496.065668836298;5497.065498865192;5539.806106786264;5579.079451890433;5614.29821272341;5625.662460252388;5633.380328163909;5633.8309850704545;5067.898642027158;5095.821646242363;5122;5155.252488389181;5173;4940.3330550375595;5129.358830146231;5162.948370516285;5168.250603662466;5170.146925757264;4934.777934992916;4945.332380128672;4966.329545511346;4988.426330971948;5030.748462576857;4963.627727920402;5001.674891132083;5084.237364395333;5089.236614507817;5119.974400128012;4857.708537487727;5006.274090256892;5019.046381187599;5030.597552195853;5058.215976523645;5386.13821788512;5393.164059570773;5406.621536492447;5432.809851655213;5433.130699088167;5790.565707571906;5799.507041901444;5894.115882617599;5895.764169433218;5901.085331773582;5795.072788353843;5901.232839730807;5933.732982015819;5934.495567876736;5942.61373010753;5426.158945363475;5473.233747275384;5480.7533660985355;5489.204065410493;5522.751476183581;5976.970115149396;6007.609505382136;6011.699415029231;6018.8194354169445;6022.879542409128;5644.774209031675;5746.310442746897;5767.567432442584;5767.798127065533;5770.16332631766;5777.24895763548;5826.067829147316;5890.6171098879295;5890.764369425175;5976.880462390728;5898;5901.852453688693;5907.793227237026;5915.142304365843;5967.6121052131475;5888.499477544457;5938.8812223755285;5948.226730525091;5949.0481522956115;5953.404659534012;4466.285394336891;4490.887727806766;4514.413126293561;4554.20301447252;4559.977200113978;4094.0583665757044;4107.281225785476;4108.938365924513;4137.668986481074;4142.79286035697;5649.717514124277;5653.23681303027;5656.886862262814;5659.717014149276;5688.431156884361;5793.073108302651;5853.239078919713;5879.882402351929;5907.1139329100115;5946.762129514857;5665.49010589049;5669.574781891375;5670.914936275959;5678.346990096109;5701.372848986608;5183.740812959337;5185.662931909414;5193.246979187997;5195.558377537952;5222.21666749983;5976.820695379059;6094.573379863367;6111.694415279129;6206.100115483229;6220.129181914535;5942.494887934574;5983.670898100646;5993.3706960768495;5994.490468310242;6031.215941927521;6201.751929922933;6224.315325314121;6226.875462490815;6229.345918678474;6240.781572644935;5663.2071509989455;5670.291213598301;5892.145638882424;5893.174955506318;5897.587168898136;5748.597598168088;5793.739281732416;5807.970960145172;5852.209951656642;5887.764489420375;5681.289838770153;5717.399673034438;5719.342275638189;5729.054705973468;5731.168980497721;5650.378458369658;5712.828615141552;5718.971405142947;5721.056025755704;5724.141378793214;5576.191452239322;5671.8865622688145;5673.319201695823;5706.229658995982;5728.140778883201;5808.82573522795;5814.156947242711;5820.621659592113;5823.242978412779;5828.154917537018;5584.888302233851;5634.74643641029;5639.746211420414;5664.830055098354;5672.262605861211 08:35:25 INFO - PROCESS | 13425 | |1;ext.html;603.9124326972589;608.6165715599171;619.4734475695659;636.2110982381848;636.430394796657;33469.665303346956;36413.45379819305;36426.271474570494;47732.522674773245;48530.27204591934;46872.29691554621;47117.293240601415;47155.29267060988;47246;47299.29051064237;8848.690295839648;8993.955030224839;8998.415103018315;9004.909950900472;9009.864852027225;8271.95864020679;8484.066752657203;8945.15021072997;10550.47247637619;10848.457577121151;10920.617778377758;10982.725431864188;10984.560617575327;10990.17573681973;10998;10846.620368287111;10881;10907.072898803652;10910.399928003957;10914.890851091546;10660.680179594547;10694.358338499715;10696.732581685521;10729.570817167381;10739.140868730483;43354.783226083986;43446.131077378275;43733.78133109346;43748.3437748434;43761.78119109416;3474.0967348489576;3538.663826936437;3554.5556805399324;3654.7624404413627;4322.351647252905;33209.501857472154;33438.83280583606;33671.4949275761;33823;33978.660213397794;3706.9814650926573;3793.753406028627;3808.276402677104;3823.617638236182;3877.4571559981623;343155;344460;345228;345250;345803.270983646;40434.79782601068;63104.36895631077;63334;63346.683266584296;63428.36571634225;40869;40980.79509602433;41017.79491102525;41045.589544104776;41058;15320.23398830054;15448.768268475982;15456.149911754737;15459.613509662124;15466.14936178521;11120.944395277971;12765.808512872314;12879.291638959947;12881.935590321988;12884.935575322063;8899.199072083544;9237.491937943343;9474.289428292906;9557.426554406758;9710.126088652056;3577.5706915170344;3591.5151454553825;3619.529461170031;3690.9630903691154;3696.5748938872375;1049.92125590581;1051.9263651544318;1102.366139469808;1105.5080489182237;1187.940602969848;33939.830300848334;33962.660373396444;34107.91492764861;34121.82939085338;34460.48309275363;1113.092829344082;1151.1251448898897;1183.621241202824;1208.9395530223453;1214.3606131722104;17826.19782109808;18089.7286540702;18152.818471815113;18186.909065454587;18263.360782372554;487772;494247;494531;497677;502662;61770;62646.37353626405;62831;62869.37130628726;62876.056859146236;1267.8922291605318;1329.7407005634002;1360.1974834847488;1409.041851540962;1424.9928750356182;31876.521852171772;33619.327613448084;33986;34151.4877276846;34681.47977780285;51135.74432127816;58643.70678146582;60618.393816061274;60690;67296.6635166821;501473;507220;507343;508400;508589;29494.705052949197;31025.379492410477;32758.508622370206;32958.34083318272;33257.334853303284;50631;50807.237891430916;50823;50955.49044509508;52089.47910520846;42306.78846605747;42942.35586466143;43279.35080973725;43567.95024348265;44647;43436.78281608572;43809.34285985777;44055.11889762251;44457.555424445345;44485.77757111194;44170.337444938996;44273.33589996088;44710.55289447064;44792.55207447884;44923.32615010843;36972;38764.6123538761;38989;39713.4186277891;40137.598624013386;29340;29521.557176642797;29547;29727;29801.25496862596 08:35:25 INFO - PROCESS | 13425 | |2;jquery.html;363.13935971746963;377.8261999480239;387.7460263527391;389.76614031581056;409.1898041877083;15093.169875656835;18955.62088758224;19839.10724017419;19916.9004154979;20848.47878803031;19693.901530492327;19979.100940457676;20049.699254511193;20156.496087597818;20305.695414568792;5569.721513924308;5826.446487583673;5835.44563266489;5836.562257830658;5837.328707198662;4552.294394368878;5591.741858081939;5723.742431590588;5771.711414429283;5792.131180322965;5690.516306113986;5691.857703557403;5695.8576035599235;5697.088465845465;5701.03082475978;5508.476694713996;5707.942920570804;5742.74157662902;5749.223854779614;5753.597248192628;4968.850934471971;5140.228965655144;5146.356705411824;5149.227615857614;5151.4333423323405;23037.424064398525;23337.76662233373;23556.411089722722;23835.284941451784;24140;2341.39123827806;2403.639454081884;2438.987805060981;2454.349597356702;2494.0896572751;13895.166290022631;14408.783868241984;14713.852861471356;14868.256587170707;15028.924855375653;1905.5236190952262;2025.4936265933516;2037.3480486244407;2093.822025127866;2105.589410065038;82891.17839664502;84734;86390.56804715999;86454.56772716096;86655;10442.2168337375;10575.682729518127;10637.46812659364;10897.618583349546;11036.11711063113;14998.175100369584;15054.473093441897;15073;15077.396904123712;15088.321025553876;7719.498232614862;8126.065502467174;8265.504069755834;8275.131111233355;8315.334773218128;8008.679652813822;8030;8052.476589021695;8277.793055173668;8295.294899933453;6679.432248258952;6706.463482921355;6723.294054124247;6782.152230971129;6807.965960170168;1847.1226167570296;1862.2644055597964;1875.7842848072646;1881.388548721671;1888.9244430222636;1026.8767747870304;1026.9114738377343;1038.4392428088747;1041.401194313273;1086.9130469562417;20529.79470205309;20744;20817.271395501386;21014.159433622484;21091.156353745984;983.5672304186136;1008.1279693065445;1012.4077414712328;1020.4693559349097;1075.5912753153752;10863.293885897392;11774.234674746114;11893.940530297294;11906.88093119075;12066;467609;484279;492151;492683;494231;81273.59363203264;82704;83461;83718;83980.16019839846;997.3467378866853;1005.607812952949;1012.5392946209457;1020.6172685243034;1022.8568000479938;17660.293588256325;18060.187291572172;18482.445526634223;18535.814641853947;18794.436166915013;40355.59644403518;40789.59210407977;40852.38721419241;41182.794086029375;41953.58046419619;52685.47314526806;53121.203181953075;53711;54030;55547.44452555423;8143.429959902987;8665.350098742494;8824.470531768115;8838.02781694026;8858.379913406257;9764.267679923893;12380.566680166152;13244.20534767917;13447.260400678057;13967.580972570839;12006.279623222634;12009.279443233434;12183.147179697336;12487.687807804878;12657.62099049659;11663.475143618387;11881.168318217642;11925.582604608797;12048.819267711167;12249.203801752858;12017.519299227934;12115.515379384726;12187.207831490925;12214.511419543118;12798.360081995677;8459.703910363107;8506.532140732319;8593.742187734379;8815.647374104963;8821.735347939572;11692.240004400028;12354.196977196454;12452.564160254347;12471.189372690746;12650.367481625697 08:35:25 INFO - PROCESS | 13425 | |3;mootools.html;1337.8394592648883;1460.4888289098817;1487.523992322457;1614.9354025838968;1788.30256200082;7352.889706654398;7940.523568585889;8238.876416853753;8258.504489730612;8462.492250464977;8228.670853165866;8299.21157490039;8312.376571757111;8314.91685083149;8329.83340333193;2390.7250666173395;2417.443987882788;2420.455397535558;2429.0405289910564;2430.0887167312258;2333.6032874411308;2380.321608341623;2403.327068420845;2404.13451157584;2405.4226985523524;2368.7157541095007;2381.7975472084895;2393.3298676370646;2398.736139024706;2410.276916924924;2329.7087864017;2344.929652110431;2361.055577768889;2376.097083108425;2378.250850981935;2346.77705617966;2352.294311706481;2378.143868207444;2382.3329467748886;2382.749811269809;8100.3519718422385;8231.835363292701;8258.793530161794;8319.625616847195;8331.250187483094;5023.547880690719;5202.791888324463;5215.6349055566125;5231.581473482112;5239.816606418757;3224.91937701557;3331.933361332784;3346.1634591352163;3380.8478618462227;3388.644192359816;987.7283746969568;992.3153024413132;998.675430485088;1022.7852151048214;1038.1850247555708;10931.234813563055;11012.724681882937;11061.115110791117;11121.110311175167;11150.888491115065;4201.516825565038;4410.757408342508;4501.257292546693;4506.436695413074;4543.45478542577;9161.312901532412;9168.541572921327;9173.954130229306;9176.632934682539;9176.632934682671;5183.948160518346;5185.48145185486;5189.143791274473;5212.4266330703595;5217.634765566374;4239.97880010598;4386.539413361615;4587.495375508692;4739.241721324572;4872.3909511311085;3762.698984081267;3828.2152158807376;3908.9804550977065;3937.114149316438;3974.5627980922077;1260.8423947006625;1270.0220829960879;1287.2147989726259;1290.161395093197;1306.5231190615548;917.2570218123342;928.3640706116332;951.7002144324516;954.6515521834481;965.8020105878278;5608.4111168326735;5778.913316300259;5791.739371728282;5832.62087964281;6118.816435506942;437.61489888898205;446.7520526108041;449.1197253383405;451.58228638509905;452.74419952726606;3917.373220284741;4095.6928230382246;4111.97944010284;4121.361189015707;4122.154958233555;9770.804583908282;10250.436226007492;10270.33242839213;10272.589096436208;10282.691519254435;10179.949100254451;10204.4387558685;10210.693679189637;10229.386236825814;10253.025962533547;7892.802679933047;7915.643796029192;8014.118446970829;8020.318272946864;8023.999999999884;5474.315710536183;5541.085720856175;5661.547076233974;5696.886062278649;5784.82645520635;9295.07049295065;9412.15290623847;9444.811103778024;9500;9526;9304.72085837426;9365.85951210746;9404.623815047322;9461.952690236505;9492.477913714813;7354.779356619096;7383.07711536058;7403.888941665771;7409.851802964018;7433.516821406592;8001.359891208573;8043.718469853761;8075.636596353295;8078.83842323162;8079.636416361395;7245.818854528679;7335.889961650686;7385.556866588022;7563.584002879675;7582.886256706043;7152.856942861218;7320.048393708784;7334.926650733424;7356.558606483628;7385.889211661937;6388.0737293091315;6517.967410162919;6519.511036672364;6522.673866306571;6522.771702990372;4900.26496025599;4955.776990035385;5008.1235783736975;5031.949680503149;5335.813246536352;4921.286413469955;4978.60171186297;5007.173816320266;5054.191329387428;5104.566111880383 08:35:25 INFO - PROCESS | 13425 | |4;prototype.html;319.68511016648597;333.69300243775723;335.453211265637;338.2507745344062;339.1622691950881;5129.717865517405;5316.948898546382;5341.732913354326;5348.411674715783;5386.814900721844;5162.199859021857;5233.528982391584;5247.134222853234;5266.710330931797;5274.947250527493;4165.604267594574;4169.3954376615375;4178.937315940256;4185.372194170884;4187.392828039932;3992.8203230854683;4117.423560701504;4169.416281720546;4193.916121677565;4201.411802347674;4072.6538244249273;4086.652634526054;4087.897802554945;4094.242565125461;4099.323611604097;4072.4705788247634;4076.9196163016823;4082.3672330788777;4090.9181816363803;4092.3247664135383;3462.809545474998;3569.589497207802;3575.7496975211748;3591.563374650135;3608.8736894208578;5110;5123.2827404163445;5130.563902068328;5146.742662866842;5169.534741873212;4663.27719203524;4680.180968330528;4681.338124965656;4687;4692.765361731934;5397.78408863645;5470.8085217017615;5491.560675145979;5516.724163791794;5534.1975413565215;3917.3144699677728;3939.3697008478507;3948.2824971137647;3950.6246906543834;3962.663173630216;5705.914411283834;5736.913946290809;5759.884802303931;5773.884522309572;5830.242068531106;3983.3427484464737;4038.192361527706;4042.595740425934;4091.6317531422314;4096.344584866407;4116.485439320085;4124.835006599702;4135.29699951009;4137.8758637240935;4139.937900931488;4702.9764851176205;4708.987567672898;4709.458412282563;4725.3384526166365;4747.715137091785;5350.545203657655;5596.832095037155;5597.216389705444;5607.495325420732;5625.606207565513;1336.1448672849385;1361.530272056139;1361.9319034048258;1362;1393.9721205575831;980.5501433224499;990.7968866382374;1004.1172800998129;1010.934289271195;1016.1159790981745;5139.306193663882;5153.758115219891;5177.136230956852;5200.6879587224885;5222.399424066281;5457.489554804755;5457.918131228034;5463.808766693226;5494.752736126884;5500.614956952975;5168.9224661630105;5171.637985341065;5183.740812959337;5213.843584692465;5214.45248248936;2893.8263704177816;2910.126961911418;2925.663548691885;2941.249981254766;2941.485240082977;5693.572982026365;5779.88440231193;5780.127314699162;5782;5811.27359080115;5503.257060296889;5550.195221692913;5620.85947851307;5643.915341269884;5651.547876169897;5717.885642287214;5728.770849165987;5730.713464326767;5743;5777.39337369587;5266.236395722675;5495.670259784426;5526.751296191762;5543.473370029841;5567.47109024642;5333.7866485340155;5424.26423544462;5462.508374246178;5463.562914966873;5491.956528259618;5713.800271847778;5728.684922329312;5728.79949201776;5754;5754.251947246831;3853.9036524087123;3970.664641700985;3971.6822654187017;3972.841086356513;4024.8390064397095;5458.8362349128;5464.590155738256;5508.008558459515;5537.280153580009;5560.332760068818;5379;5477.877035207694;5487.122060470306;5500.58745594074;5501.312335958005;5450.482204190595;5494.532964697885;5543.362513311021;5554.555635549065;5581.6371935824045;5374.865628359166;5488.780448782004;5518.392976772471;5530.668159910419;5589.860253493533;5530.474604912527;5590.770030593263;5597.208893154151;5608.551315894637;5619.73555949908;5424.430434804289;5455.290812194548;5481.616286860041;5513.979913715815;5527.585431092603 08:35:25 INFO - PROCESS | 13425 | |5;yui.html;744.5607091815831;765.4106338119648;808.4098608016149;816.2245866426892;851.289173540094;14332.068415552994;14993.92503037486;15167.165805880672;15274.465393711222;15644.608884777886;13585.049046566744;14539.636509087279;14630.561083167522;14634.341454634541;14652.853471465281;858.3219256787131;867.6832955971057;873.7902903303193;874.7987962768567;875.0505701314082;862.3833958719514;865.6234537975969;865.969691060813;866.6100254885296;866.6663334616155;913.5614904845678;913.6710784117712;914.7484441778497;915.2997956563235;916.5829547555846;898.5821592959305;906.6192199276254;908.0374802709116;908.4776253654143;909.2407839454064;665.2349797732597;666.9699863506105;667.5427332277357;668.0913957018452;668.3750693101965;13716.725665486734;13774.380152893043;13777.586672399844;13789.862101378958;14001.789973150411;11466.48400821965;11786.469608867621;11870.940645296718;11890.227135236268;11890.762184756342;10809.83785243222;10813.729656758565;10831.620893268777;10840.078593319577;10891.83662245067;3651.2530323332676;3654.689351405134;3697.0572504011575;3720.293144302601;3744.120131769032;65258.673706631635;65477;65769;66079.3392066078;66263.33736662669;9119.179273865384;9137.954310228406;9139.908600913906;9342.252619790537;9527.666531671359;19328.1302341395;19341;19350.516237093903;19418.611627767365;19486.415407537796;7828.295453409107;7864.842703145905;7892.9210707893335;8189.058258300252;8334.6666133354;4299.441072660534;4327.826886924488;4349.188818077345;4379.1241751649795;4533.886652833706;3469.982650086784;3632.055665526982;3641.289948460078;3642.453631955175;3643.9635603643624;582.7785441532191;585.7539833270037;599.6222379900635;601.7562887030672;610;718.6119495472491;728.4354625165433;731.0313834169747;741.7552207771422;768.692522990797;8958.68644597436;9410.576524056434;9551.474668893277;9817.509124543887;9890.456024918698;634.1977398590786;678.5284227461866;687.8005378440297;712.4763298975249;725.0936329588015;4468.821247150143;4484.1031793641405;4512.300593408027;4562.384078149474;4595.586397224266;90021.54989225011;90022;90258.54870725736;92353;92381;75470.62264688642;76922.61538692271;79037.60481197672;79076;83009;63610;63999.360006400275;65854.34145658578;66717.33282667208;70990.29009709836;9302.348835581444;9637.951810240904;9926.652567160114;10086.546105425126;10250.743731406774;35759.46360804538;38496;42003.36994945139;49873.25190122223;50657;44703.776481117384;59971.70014150076;60210.698946504985;61402.692986534785;62847.6857615709;12599;12768.297743623818;12864.22814631125;12927.741445171232;13087.41106650184;13308.667283317995;13362.465501379836;13595.796063058864;13607.183568985893;13667.31663416845;12388.690282743004;12418.937905310415;12439.440225190068;13006.219626822422;13029.674258143623;12269.202501837352;12326.938365308117;12719.364031798557;13068.085234033526;13089.0837641368;12250.877491224974;12441.93779031099;12874.420651070912;13055.543055992996;13064.150830196008;10065.798684026426;10079.193664506969;10225.897741022793;10306.793864122825;10450.268481206547;10881.836772448261;10958.945205273923;11180.944095279472;11194.216404851908;11295 08:35:25 INFO - PROCESS | 13425 | __end_tp_report 08:35:25 INFO - PROCESS | 13425 | __start_cc_report 08:35:25 INFO - PROCESS | 13425 | _x_x_mozilla_cycle_collect,1047 08:35:25 INFO - PROCESS | 13425 | __end_cc_report 08:35:25 INFO - PROCESS | 13425 | __startTimestamp1480955725969__endTimestamp 08:35:25 INFO - PROCESS | 13425 | 08:35:25 INFO - PROCESS | 13425 | ------- Summary: start ------- 08:35:25 INFO - PROCESS | 13425 | Number of tests: 6 08:35:25 INFO - PROCESS | 13425 | 08:35:25 INFO - PROCESS | 13425 | [#0] dojo.html Cycles:165 Average:5489.86 Median:5672.26 stddev:618.99 (10.9%) stddev-sans-first:591.92 08:35:25 INFO - PROCESS | 13425 | Values: 3103.9 3122.7 3143.2 3150.2 3150.8 5410.9 5480.6 5496.1 5497.1 5539.8 5579.1 5614.3 5625.7 5633.4 5633.8 5067.9 5095.8 5122.0 5155.3 5173.0 4940.3 5129.4 5162.9 5168.3 5170.1 4934.8 4945.3 4966.3 4988.4 5030.7 4963.6 5001.7 5084.2 5089.2 5120.0 4857.7 5006.3 5019.0 5030.6 5058.2 5386.1 5393.2 5406.6 5432.8 5433.1 5790.6 5799.5 5894.1 5895.8 5901.1 5795.1 5901.2 5933.7 5934.5 5942.6 5426.2 5473.2 5480.8 5489.2 5522.8 5977.0 6007.6 6011.7 6018.8 6022.9 5644.8 5746.3 5767.6 5767.8 5770.2 5777.2 5826.1 5890.6 5890.8 5976.9 5898.0 5901.9 5907.8 5915.1 5967.6 5888.5 5938.9 5948.2 5949.0 5953.4 4466.3 4490.9 4514.4 4554.2 4560.0 4094.1 4107.3 4108.9 4137.7 4142.8 5649.7 5653.2 5656.9 5659.7 5688.4 5793.1 5853.2 5879.9 5907.1 5946.8 5665.5 5669.6 5670.9 5678.3 5701.4 5183.7 5185.7 5193.2 5195.6 5222.2 5976.8 6094.6 6111.7 6206.1 6220.1 5942.5 5983.7 5993.4 5994.5 6031.2 6201.8 6224.3 6226.9 6229.3 6240.8 5663.2 5670.3 5892.1 5893.2 5897.6 5748.6 5793.7 5808.0 5852.2 5887.8 5681.3 5717.4 5719.3 5729.1 5731.2 5650.4 5712.8 5719.0 5721.1 5724.1 5576.2 5671.9 5673.3 5706.2 5728.1 5808.8 5814.2 5820.6 5823.2 5828.2 5584.9 5634.7 5639.7 5664.8 5672.3 08:35:25 INFO - PROCESS | 13425 | 08:35:25 INFO - PROCESS | 13425 | [#1] ext.html Cycles:180 Average:61295.58 Median:3750.37 stddev:120619.35 (3216.2%) stddev-sans-first:120871.65 08:35:25 INFO - PROCESS | 13425 | Values: 603.9 608.6 619.5 636.2 636.4 33469.7 36413.5 36426.3 47732.5 48530.3 46872.3 47117.3 47155.3 47246.0 47299.3 8848.7 8994.0 8998.4 9004.9 9009.9 8272.0 8484.1 8945.2 10550.5 10848.5 10920.6 10982.7 10984.6 10990.2 10998.0 10846.6 10881.0 10907.1 10910.4 10914.9 10660.7 10694.4 10696.7 10729.6 10739.1 43354.8 43446.1 43733.8 43748.3 43761.8 3474.1 3538.7 3554.6 3654.8 4322.4 33209.5 33438.8 33671.5 33823.0 33978.7 3707.0 3793.8 3808.3 3823.6 3877.5 343155.0 344460.0 345228.0 345250.0 345803.3 40434.8 63104.4 63334.0 63346.7 63428.4 40869.0 40980.8 41017.8 41045.6 41058.0 15320.2 15448.8 15456.1 15459.6 15466.1 11120.9 12765.8 12879.3 12881.9 12884.9 8899.2 9237.5 9474.3 9557.4 9710.1 3577.6 3591.5 3619.5 3691.0 3696.6 1049.9 1051.9 1102.4 1105.5 1187.9 33939.8 33962.7 34107.9 34121.8 34460.5 1113.1 1151.1 1183.6 1208.9 1214.4 17826.2 18089.7 18152.8 18186.9 18263.4 487772.0 494247.0 494531.0 497677.0 502662.0 61770.0 62646.4 62831.0 62869.4 62876.1 1267.9 1329.7 1360.2 1409.0 1425.0 31876.5 33619.3 33986.0 34151.5 34681.5 51135.7 58643.7 60618.4 60690.0 67296.7 501473.0 507220.0 507343.0 508400.0 508589.0 29494.7 31025.4 32758.5 32958.3 33257.3 50631.0 50807.2 50823.0 50955.5 52089.5 42306.8 42942.4 43279.4 43568.0 44647.0 43436.8 43809.3 44055.1 44457.6 44485.8 44170.3 44273.3 44710.6 44792.6 44923.3 36972.0 38764.6 38989.0 39713.4 40137.6 29340.0 29521.6 29547.0 29727.0 29801.3 08:35:25 INFO - PROCESS | 13425 | 08:35:25 INFO - PROCESS | 13425 | [#2] jquery.html Cycles:180 Average:28958.19 Median:23695.85 stddev:79996.93 (337.6%) stddev-sans-first:80192.53 08:35:25 INFO - PROCESS | 13425 | Values: 363.1 377.8 387.7 389.8 409.2 15093.2 18955.6 19839.1 19916.9 20848.5 19693.9 19979.1 20049.7 20156.5 20305.7 5569.7 5826.4 5835.4 5836.6 5837.3 4552.3 5591.7 5723.7 5771.7 5792.1 5690.5 5691.9 5695.9 5697.1 5701.0 5508.5 5707.9 5742.7 5749.2 5753.6 4968.9 5140.2 5146.4 5149.2 5151.4 23037.4 23337.8 23556.4 23835.3 24140.0 2341.4 2403.6 2439.0 2454.3 2494.1 13895.2 14408.8 14713.9 14868.3 15028.9 1905.5 2025.5 2037.3 2093.8 2105.6 82891.2 84734.0 86390.6 86454.6 86655.0 10442.2 10575.7 10637.5 10897.6 11036.1 14998.2 15054.5 15073.0 15077.4 15088.3 7719.5 8126.1 8265.5 8275.1 8315.3 8008.7 8030.0 8052.5 8277.8 8295.3 6679.4 6706.5 6723.3 6782.2 6808.0 1847.1 1862.3 1875.8 1881.4 1888.9 1026.9 1026.9 1038.4 1041.4 1086.9 20529.8 20744.0 20817.3 21014.2 21091.2 983.6 1008.1 1012.4 1020.5 1075.6 10863.3 11774.2 11893.9 11906.9 12066.0 467609.0 484279.0 492151.0 492683.0 494231.0 81273.6 82704.0 83461.0 83718.0 83980.2 997.3 1005.6 1012.5 1020.6 1022.9 17660.3 18060.2 18482.4 18535.8 18794.4 40355.6 40789.6 40852.4 41182.8 41953.6 52685.5 53121.2 53711.0 54030.0 55547.4 8143.4 8665.4 8824.5 8838.0 8858.4 9764.3 12380.6 13244.2 13447.3 13967.6 12006.3 12009.3 12183.1 12487.7 12657.6 11663.5 11881.2 11925.6 12048.8 12249.2 12017.5 12115.5 12187.2 12214.5 12798.4 8459.7 8506.5 8593.7 8815.6 8821.7 11692.2 12354.2 12452.6 12471.2 12650.4 08:35:25 INFO - PROCESS | 13425 | 08:35:25 INFO - PROCESS | 13425 | [#3] mootools.html Cycles:180 Average:5500.79 Median:5144.26 stddev:3018.84 (58.7%) stddev-sans-first:3011.10 08:35:25 INFO - PROCESS | 13425 | Values: 1337.8 1460.5 1487.5 1614.9 1788.3 7352.9 7940.5 8238.9 8258.5 8462.5 8228.7 8299.2 8312.4 8314.9 8329.8 2390.7 2417.4 2420.5 2429.0 2430.1 2333.6 2380.3 2403.3 2404.1 2405.4 2368.7 2381.8 2393.3 2398.7 2410.3 2329.7 2344.9 2361.1 2376.1 2378.3 2346.8 2352.3 2378.1 2382.3 2382.7 8100.4 8231.8 8258.8 8319.6 8331.3 5023.5 5202.8 5215.6 5231.6 5239.8 3224.9 3331.9 3346.2 3380.8 3388.6 987.7 992.3 998.7 1022.8 1038.2 10931.2 11012.7 11061.1 11121.1 11150.9 4201.5 4410.8 4501.3 4506.4 4543.5 9161.3 9168.5 9174.0 9176.6 9176.6 5183.9 5185.5 5189.1 5212.4 5217.6 4240.0 4386.5 4587.5 4739.2 4872.4 3762.7 3828.2 3909.0 3937.1 3974.6 1260.8 1270.0 1287.2 1290.2 1306.5 917.3 928.4 951.7 954.7 965.8 5608.4 5778.9 5791.7 5832.6 6118.8 437.6 446.8 449.1 451.6 452.7 3917.4 4095.7 4112.0 4121.4 4122.2 9770.8 10250.4 10270.3 10272.6 10282.7 10179.9 10204.4 10210.7 10229.4 10253.0 7892.8 7915.6 8014.1 8020.3 8024.0 5474.3 5541.1 5661.5 5696.9 5784.8 9295.1 9412.2 9444.8 9500.0 9526.0 9304.7 9365.9 9404.6 9462.0 9492.5 7354.8 7383.1 7403.9 7409.9 7433.5 8001.4 8043.7 8075.6 8078.8 8079.6 7245.8 7335.9 7385.6 7563.6 7582.9 7152.9 7320.0 7334.9 7356.6 7385.9 6388.1 6518.0 6519.5 6522.7 6522.8 4900.3 4955.8 5008.1 5031.9 5335.8 4921.3 4978.6 5007.2 5054.2 5104.6 08:35:25 INFO - PROCESS | 13425 | 08:35:25 INFO - PROCESS | 13425 | [#4] prototype.html Cycles:180 Average:4619.26 Median:5240.33 stddev:1347.39 (25.7%) stddev-sans-first:1311.96 08:35:25 INFO - PROCESS | 13425 | Values: 319.7 333.7 335.5 338.3 339.2 5129.7 5316.9 5341.7 5348.4 5386.8 5162.2 5233.5 5247.1 5266.7 5274.9 4165.6 4169.4 4178.9 4185.4 4187.4 3992.8 4117.4 4169.4 4193.9 4201.4 4072.7 4086.7 4087.9 4094.2 4099.3 4072.5 4076.9 4082.4 4090.9 4092.3 3462.8 3569.6 3575.7 3591.6 3608.9 5110.0 5123.3 5130.6 5146.7 5169.5 4663.3 4680.2 4681.3 4687.0 4692.8 5397.8 5470.8 5491.6 5516.7 5534.2 3917.3 3939.4 3948.3 3950.6 3962.7 5705.9 5736.9 5759.9 5773.9 5830.2 3983.3 4038.2 4042.6 4091.6 4096.3 4116.5 4124.8 4135.3 4137.9 4139.9 4703.0 4709.0 4709.5 4725.3 4747.7 5350.5 5596.8 5597.2 5607.5 5625.6 1336.1 1361.5 1361.9 1362.0 1394.0 980.6 990.8 1004.1 1010.9 1016.1 5139.3 5153.8 5177.1 5200.7 5222.4 5457.5 5457.9 5463.8 5494.8 5500.6 5168.9 5171.6 5183.7 5213.8 5214.5 2893.8 2910.1 2925.7 2941.2 2941.5 5693.6 5779.9 5780.1 5782.0 5811.3 5503.3 5550.2 5620.9 5643.9 5651.5 5717.9 5728.8 5730.7 5743.0 5777.4 5266.2 5495.7 5526.8 5543.5 5567.5 5333.8 5424.3 5462.5 5463.6 5492.0 5713.8 5728.7 5728.8 5754.0 5754.3 3853.9 3970.7 3971.7 3972.8 4024.8 5458.8 5464.6 5508.0 5537.3 5560.3 5379.0 5477.9 5487.1 5500.6 5501.3 5450.5 5494.5 5543.4 5554.6 5581.6 5374.9 5488.8 5518.4 5530.7 5589.9 5530.5 5590.8 5597.2 5608.6 5619.7 5424.4 5455.3 5481.6 5514.0 5527.6 08:35:25 INFO - PROCESS | 13425 | 08:35:25 INFO - PROCESS | 13425 | [#5] yui.html Cycles:180 Average:17607.37 Median:27234.42 stddev:23679.92 (86.9%) stddev-sans-first:23712.50 08:35:25 INFO - PROCESS | 13425 | Values: 744.6 765.4 808.4 816.2 851.3 14332.1 14993.9 15167.2 15274.5 15644.6 13585.0 14539.6 14630.6 14634.3 14652.9 858.3 867.7 873.8 874.8 875.1 862.4 865.6 866.0 866.6 866.7 913.6 913.7 914.7 915.3 916.6 898.6 906.6 908.0 908.5 909.2 665.2 667.0 667.5 668.1 668.4 13716.7 13774.4 13777.6 13789.9 14001.8 11466.5 11786.5 11870.9 11890.2 11890.8 10809.8 10813.7 10831.6 10840.1 10891.8 3651.3 3654.7 3697.1 3720.3 3744.1 65258.7 65477.0 65769.0 66079.3 66263.3 9119.2 9138.0 9139.9 9342.3 9527.7 19328.1 19341.0 19350.5 19418.6 19486.4 7828.3 7864.8 7892.9 8189.1 8334.7 4299.4 4327.8 4349.2 4379.1 4533.9 3470.0 3632.1 3641.3 3642.5 3644.0 582.8 585.8 599.6 601.8 610.0 718.6 728.4 731.0 741.8 768.7 8958.7 9410.6 9551.5 9817.5 9890.5 634.2 678.5 687.8 712.5 725.1 4468.8 4484.1 4512.3 4562.4 4595.6 90021.5 90022.0 90258.5 92353.0 92381.0 75470.6 76922.6 79037.6 79076.0 83009.0 63610.0 63999.4 65854.3 66717.3 70990.3 9302.3 9638.0 9926.7 10086.5 10250.7 35759.5 38496.0 42003.4 49873.3 50657.0 44703.8 59971.7 60210.7 61402.7 62847.7 12599.0 12768.3 12864.2 12927.7 13087.4 13308.7 13362.5 13595.8 13607.2 13667.3 12388.7 12418.9 12439.4 13006.2 13029.7 12269.2 12326.9 12719.4 13068.1 13089.1 12250.9 12441.9 12874.4 13055.5 13064.2 10065.8 10079.2 10225.9 10306.8 10450.3 10881.8 10958.9 11180.9 11194.2 11295.0 08:35:25 INFO - PROCESS | 13425 | -------- Summary: end -------- 08:35:25 INFO - PROCESS | 13425 | 08:35:26 INFO - TEST-INFO | 13425: exit 0 08:35:26 INFO - TEST-OK | dromaeo_css | took 1114665ms 08:35:26 INFO - TEST-START | kraken 08:35:26 INFO - operating with platform_type : linux_ 08:35:26 INFO - Initialising browser for kraken test... 08:35:26 INFO - TEST-INFO | started process 13746 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppt1IXH/profile http://localhost:36158/getInfo.html) 08:35:30 INFO - PROCESS | 13746 | __metrics Screen width/height:1600/1200 08:35:30 INFO - PROCESS | 13746 | colorDepth:24 08:35:30 INFO - PROCESS | 13746 | Browser inner width/height: 1024/697 08:35:30 INFO - PROCESS | 13746 | __metrics 08:35:31 INFO - PROCESS | 13746 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:35:31 INFO - PROCESS | 13746 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:35:31 INFO - PROCESS | 13746 | console.error: PushService: 08:35:31 INFO - PROCESS | 13746 | stateChangeProcessEnqueue: Error transitioning state 08:35:31 INFO - PROCESS | 13746 | UnknownError 08:35:32 INFO - TEST-INFO | 13746: exit 0 08:35:32 INFO - Browser initialized. 08:35:32 INFO - Running cycle 1/1 for kraken test... 08:35:32 INFO - TEST-INFO | started process 13836 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppt1IXH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:35:44 INFO - PROCESS | 13836 | RSS: Main: 144453632 08:35:44 INFO - PROCESS | 13836 | 08:35:46 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36158/tests/kraken/driver.html?testName=audio-beat-detection) 08:35:47 INFO - PROCESS | 13836 | RSS: Main: 186216448 08:35:47 INFO - PROCESS | 13836 | 08:35:50 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36158/tests/kraken/driver.html?testName=audio-dft) 08:35:50 INFO - PROCESS | 13836 | RSS: Main: 175771648 08:35:50 INFO - PROCESS | 13836 | 08:35:53 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36158/tests/kraken/driver.html?testName=audio-fft) 08:35:54 INFO - PROCESS | 13836 | RSS: Main: 266797056 08:35:54 INFO - PROCESS | 13836 | 08:35:56 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36158/tests/kraken/driver.html?testName=audio-oscillator) 08:35:56 INFO - PROCESS | 13836 | RSS: Main: 173592576 08:35:56 INFO - PROCESS | 13836 | 08:35:58 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36158/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:35:59 INFO - PROCESS | 13836 | RSS: Main: 175816704 08:35:59 INFO - PROCESS | 13836 | 08:36:02 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36158/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:02 INFO - PROCESS | 13836 | RSS: Main: 214265856 08:36:02 INFO - PROCESS | 13836 | 08:36:06 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36158/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:06 INFO - PROCESS | 13836 | RSS: Main: 213389312 08:36:06 INFO - PROCESS | 13836 | 08:36:09 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36158/tests/kraken/driver.html?testName=json-parse-financial) 08:36:10 INFO - PROCESS | 13836 | RSS: Main: 211668992 08:36:10 INFO - PROCESS | 13836 | 08:36:11 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36158/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:36:12 INFO - PROCESS | 13836 | RSS: Main: 173563904 08:36:12 INFO - PROCESS | 13836 | 08:36:13 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:36:14 INFO - PROCESS | 13836 | RSS: Main: 181051392 08:36:14 INFO - PROCESS | 13836 | 08:36:16 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:36:17 INFO - PROCESS | 13836 | RSS: Main: 189837312 08:36:17 INFO - PROCESS | 13836 | 08:36:19 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:36:20 INFO - PROCESS | 13836 | RSS: Main: 198987776 08:36:20 INFO - PROCESS | 13836 | 08:36:23 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:36:23 INFO - PROCESS | 13836 | RSS: Main: 195129344 08:36:23 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | Cycle 1(1): loaded http://localhost:36158/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36158/tests/kraken/driver.html?testName=ai-astar) 08:36:25 INFO - PROCESS | 13836 | RSS: Main: 247062528 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | __start_tp_report 08:36:25 INFO - PROCESS | 13836 | _x_x_mozilla_page_load 08:36:25 INFO - PROCESS | 13836 | _x_x_mozilla_page_load_details 08:36:25 INFO - PROCESS | 13836 | |i|pagename|runs| 08:36:25 INFO - PROCESS | 13836 | |0;ai-astar;106;111;109;112;113;111;110;111;110;111 08:36:25 INFO - PROCESS | 13836 | |1;audio-beat-detection;149;126;126;160;127;123;132;126;152;121 08:36:25 INFO - PROCESS | 13836 | |2;audio-dft;163;160;161;161;161;159;161;160;160;159 08:36:25 INFO - PROCESS | 13836 | |3;audio-fft;76;75;76;105;76;76;76;76;106;76 08:36:25 INFO - PROCESS | 13836 | |4;audio-oscillator;82;81;117;82;81;82;99;81;83;111 08:36:25 INFO - PROCESS | 13836 | |5;imaging-gaussian-blur;117;116;116;116;116;117;116;116;116;117 08:36:25 INFO - PROCESS | 13836 | |6;imaging-darkroom;146;146;145;145;145;146;147;146;146;145 08:36:25 INFO - PROCESS | 13836 | |7;imaging-desaturate;85;84;84;84;84;84;85;84;85;84 08:36:25 INFO - PROCESS | 13836 | |8;json-parse-financial;55;49;52;50;50;50;50;51;49;49 08:36:25 INFO - PROCESS | 13836 | |9;json-stringify-tinderbox;60;61;60;60;60;61;60;60;60;60 08:36:25 INFO - PROCESS | 13836 | |10;stanford-crypto-aes;75;76;76;76;75;83;78;77;74;76 08:36:25 INFO - PROCESS | 13836 | |11;stanford-crypto-ccm;136;127;137;134;130;136;128;134;169;135 08:36:25 INFO - PROCESS | 13836 | |12;stanford-crypto-pbkdf2;158;160;159;158;160;159;155;157;157;158 08:36:25 INFO - PROCESS | 13836 | |13;stanford-crypto-sha256-iterative;63;63;63;64;62;62;63;63;63;62 08:36:25 INFO - PROCESS | 13836 | __end_tp_report 08:36:25 INFO - PROCESS | 13836 | __start_cc_report 08:36:25 INFO - PROCESS | 13836 | _x_x_mozilla_cycle_collect,1625 08:36:25 INFO - PROCESS | 13836 | __end_cc_report 08:36:25 INFO - PROCESS | 13836 | __startTimestamp1480955785532__endTimestamp 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | ------- Summary: start ------- 08:36:25 INFO - PROCESS | 13836 | Number of tests: 14 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.00 stddev:1.90 (1.7%) stddev-sans-first:1.17 08:36:25 INFO - PROCESS | 13836 | Values: 106.0 111.0 109.0 112.0 113.0 111.0 110.0 111.0 110.0 111.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:129.50 stddev:13.98 (10.8%) stddev-sans-first:13.77 08:36:25 INFO - PROCESS | 13836 | Values: 149.0 126.0 126.0 160.0 127.0 123.0 132.0 126.0 152.0 121.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.18 (0.7%) stddev-sans-first:0.83 08:36:25 INFO - PROCESS | 13836 | Values: 163.0 160.0 161.0 161.0 161.0 159.0 161.0 160.0 160.0 159.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.50 (16.4%) stddev-sans-first:13.08 08:36:25 INFO - PROCESS | 13836 | Values: 76.0 75.0 76.0 105.0 76.0 76.0 76.0 76.0 106.0 76.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.00 stddev:13.88 (16.9%) stddev-sans-first:14.43 08:36:25 INFO - PROCESS | 13836 | Values: 82.0 81.0 117.0 82.0 81.0 82.0 99.0 81.0 83.0 111.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#5] imaging-gaussian-blur Cycles:10 Average:116.30 Median:116.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 08:36:25 INFO - PROCESS | 13836 | Values: 117.0 116.0 116.0 116.0 116.0 117.0 116.0 116.0 116.0 117.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 08:36:25 INFO - PROCESS | 13836 | Values: 146.0 146.0 145.0 145.0 145.0 146.0 147.0 146.0 146.0 145.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 08:36:25 INFO - PROCESS | 13836 | Values: 85.0 84.0 84.0 84.0 84.0 84.0 85.0 84.0 85.0 84.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:50.00 stddev:1.84 (3.7%) stddev-sans-first:1.00 08:36:25 INFO - PROCESS | 13836 | Values: 55.0 49.0 52.0 50.0 50.0 50.0 50.0 51.0 49.0 49.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 08:36:25 INFO - PROCESS | 13836 | Values: 60.0 61.0 60.0 60.0 60.0 61.0 60.0 60.0 60.0 60.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:2.50 (3.3%) stddev-sans-first:2.59 08:36:25 INFO - PROCESS | 13836 | Values: 75.0 76.0 76.0 76.0 75.0 83.0 78.0 77.0 74.0 76.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#11] stanford-crypto-ccm Cycles:10 Average:136.60 Median:135.50 stddev:11.91 (8.8%) stddev-sans-first:12.63 08:36:25 INFO - PROCESS | 13836 | Values: 136.0 127.0 137.0 134.0 130.0 136.0 128.0 134.0 169.0 135.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.10 Median:158.50 stddev:1.52 (1.0%) stddev-sans-first:1.62 08:36:25 INFO - PROCESS | 13836 | Values: 158.0 160.0 159.0 158.0 160.0 159.0 155.0 157.0 157.0 158.0 08:36:25 INFO - PROCESS | 13836 | 08:36:25 INFO - PROCESS | 13836 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 08:36:25 INFO - PROCESS | 13836 | Values: 63.0 63.0 63.0 64.0 62.0 62.0 63.0 63.0 63.0 62.0 08:36:25 INFO - PROCESS | 13836 | -------- Summary: end -------- 08:36:25 INFO - PROCESS | 13836 | 08:36:26 INFO - TEST-INFO | 13836: exit 0 08:36:26 INFO - TEST-OK | kraken | took 59946ms 08:36:26 INFO - SUITE-END | took 1174s 08:36:26 INFO - Completed test suite (00:19:34) 08:36:26 INFO - javascript benchmark 08:36:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3103.906882793516, 3122.656507784142, 3143.2141964508874, 3150.2281940924477, 3150.82670453125, 5410.864728381793, 5480.616356855022, 5496.065668836298, 5497.065498865192, 5539.806106786264, 5579.079451890433, 5614.29821272341, 5625.662460252388, 5633.380328163909, 5633.8309850704545, 5067.898642027158, 5095.821646242363, 5122.0, 5155.252488389181, 5173.0, 4940.3330550375595, 5129.358830146231, 5162.948370516285, 5168.250603662466, 5170.146925757264, 4934.777934992916, 4945.332380128672, 4966.329545511346, 4988.426330971948, 5030.748462576857, 4963.627727920402, 5001.674891132083, 5084.237364395333, 5089.236614507817, 5119.974400128012, 4857.708537487727, 5006.274090256892, 5019.046381187599, 5030.597552195853, 5058.215976523645, 5386.13821788512, 5393.164059570773, 5406.621536492447, 5432.809851655213, 5433.130699088167, 5790.565707571906, 5799.507041901444, 5894.115882617599, 5895.764169433218, 5901.085331773582, 5795.072788353843, 5901.232839730807, 5933.732982015819, 5934.495567876736, 5942.61373010753, 5426.158945363475, 5473.233747275384, 5480.7533660985355, 5489.204065410493, 5522.751476183581, 5976.970115149396, 6007.609505382136, 6011.699415029231, 6018.8194354169445, 6022.879542409128, 5644.774209031675, 5746.310442746897, 5767.567432442584, 5767.798127065533, 5770.16332631766, 5777.24895763548, 5826.067829147316, 5890.6171098879295, 5890.764369425175, 5976.880462390728, 5898.0, 5901.852453688693, 5907.793227237026, 5915.142304365843, 5967.6121052131475, 5888.499477544457, 5938.8812223755285, 5948.226730525091, 5949.0481522956115, 5953.404659534012, 4466.285394336891, 4490.887727806766, 4514.413126293561, 4554.20301447252, 4559.977200113978, 4094.0583665757044, 4107.281225785476, 4108.938365924513, 4137.668986481074, 4142.79286035697, 5649.717514124277, 5653.23681303027, 5656.886862262814, 5659.717014149276, 5688.431156884361, 5793.073108302651, 5853.239078919713, 5879.882402351929, 5907.1139329100115, 5946.762129514857, 5665.49010589049, 5669.574781891375, 5670.914936275959, 5678.346990096109, 5701.372848986608, 5183.740812959337, 5185.662931909414, 5193.246979187997, 5195.558377537952, 5222.21666749983, 5976.820695379059, 6094.573379863367, 6111.694415279129, 6206.100115483229, 6220.129181914535, 5942.494887934574, 5983.670898100646, 5993.3706960768495, 5994.490468310242, 6031.215941927521, 6201.751929922933, 6224.315325314121, 6226.875462490815, 6229.345918678474, 6240.781572644935, 5663.2071509989455, 5670.291213598301, 5892.145638882424, 5893.174955506318, 5897.587168898136, 5748.597598168088, 5793.739281732416, 5807.970960145172, 5852.209951656642, 5887.764489420375, 5681.289838770153, 5717.399673034438, 5719.342275638189, 5729.054705973468, 5731.168980497721, 5650.378458369658, 5712.828615141552, 5718.971405142947, 5721.056025755704, 5724.141378793214, 5576.191452239322, 5671.8865622688145, 5673.319201695823, 5706.229658995982, 5728.140778883201, 5808.82573522795, 5814.156947242711, 5820.621659592113, 5823.242978412779, 5828.154917537018, 5584.888302233851, 5634.74643641029, 5639.746211420414, 5664.830055098354, 5672.262605861211], "value": 5447.8580989314405, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.9124326972589, 608.6165715599171, 619.4734475695659, 636.2110982381848, 636.430394796657, 33469.665303346956, 36413.45379819305, 36426.271474570494, 47732.522674773245, 48530.27204591934, 46872.29691554621, 47117.293240601415, 47155.29267060988, 47246.0, 47299.29051064237, 8848.690295839648, 8993.955030224839, 8998.415103018315, 9004.909950900472, 9009.864852027225, 8271.95864020679, 8484.066752657203, 8945.15021072997, 10550.47247637619, 10848.457577121151, 10920.617778377758, 10982.725431864188, 10984.560617575327, 10990.17573681973, 10998.0, 10846.620368287111, 10881.0, 10907.072898803652, 10910.399928003957, 10914.890851091546, 10660.680179594547, 10694.358338499715, 10696.732581685521, 10729.570817167381, 10739.140868730483, 43354.783226083986, 43446.131077378275, 43733.78133109346, 43748.3437748434, 43761.78119109416, 3474.0967348489576, 3538.663826936437, 3554.5556805399324, 3654.7624404413627, 4322.351647252905, 33209.501857472154, 33438.83280583606, 33671.4949275761, 33823.0, 33978.660213397794, 3706.9814650926573, 3793.753406028627, 3808.276402677104, 3823.617638236182, 3877.4571559981623, 343155.0, 344460.0, 345228.0, 345250.0, 345803.270983646, 40434.79782601068, 63104.36895631077, 63334.0, 63346.683266584296, 63428.36571634225, 40869.0, 40980.79509602433, 41017.79491102525, 41045.589544104776, 41058.0, 15320.23398830054, 15448.768268475982, 15456.149911754737, 15459.613509662124, 15466.14936178521, 11120.944395277971, 12765.808512872314, 12879.291638959947, 12881.935590321988, 12884.935575322063, 8899.199072083544, 9237.491937943343, 9474.289428292906, 9557.426554406758, 9710.126088652056, 3577.5706915170344, 3591.5151454553825, 3619.529461170031, 3690.9630903691154, 3696.5748938872375, 1049.92125590581, 1051.9263651544318, 1102.366139469808, 1105.5080489182237, 1187.940602969848, 33939.830300848334, 33962.660373396444, 34107.91492764861, 34121.82939085338, 34460.48309275363, 1113.092829344082, 1151.1251448898897, 1183.621241202824, 1208.9395530223453, 1214.3606131722104, 17826.19782109808, 18089.7286540702, 18152.818471815113, 18186.909065454587, 18263.360782372554, 487772.0, 494247.0, 494531.0, 497677.0, 502662.0, 61770.0, 62646.37353626405, 62831.0, 62869.37130628726, 62876.056859146236, 1267.8922291605318, 1329.7407005634002, 1360.1974834847488, 1409.041851540962, 1424.9928750356182, 31876.521852171772, 33619.327613448084, 33986.0, 34151.4877276846, 34681.47977780285, 51135.74432127816, 58643.70678146582, 60618.393816061274, 60690.0, 67296.6635166821, 501473.0, 507220.0, 507343.0, 508400.0, 508589.0, 29494.705052949197, 31025.379492410477, 32758.508622370206, 32958.34083318272, 33257.334853303284, 50631.0, 50807.237891430916, 50823.0, 50955.49044509508, 52089.47910520846, 42306.78846605747, 42942.35586466143, 43279.35080973725, 43567.95024348265, 44647.0, 43436.78281608572, 43809.34285985777, 44055.11889762251, 44457.555424445345, 44485.77757111194, 44170.337444938996, 44273.33589996088, 44710.55289447064, 44792.55207447884, 44923.32615010843, 36972.0, 38764.6123538761, 38989.0, 39713.4186277891, 40137.598624013386, 29340.0, 29521.557176642797, 29547.0, 29727.0, 29801.25496862596], "value": 20079.991948311803, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.13935971746963, 377.8261999480239, 387.7460263527391, 389.76614031581056, 409.1898041877083, 15093.169875656835, 18955.62088758224, 19839.10724017419, 19916.9004154979, 20848.47878803031, 19693.901530492327, 19979.100940457676, 20049.699254511193, 20156.496087597818, 20305.695414568792, 5569.721513924308, 5826.446487583673, 5835.44563266489, 5836.562257830658, 5837.328707198662, 4552.294394368878, 5591.741858081939, 5723.742431590588, 5771.711414429283, 5792.131180322965, 5690.516306113986, 5691.857703557403, 5695.8576035599235, 5697.088465845465, 5701.03082475978, 5508.476694713996, 5707.942920570804, 5742.74157662902, 5749.223854779614, 5753.597248192628, 4968.850934471971, 5140.228965655144, 5146.356705411824, 5149.227615857614, 5151.4333423323405, 23037.424064398525, 23337.76662233373, 23556.411089722722, 23835.284941451784, 24140.0, 2341.39123827806, 2403.639454081884, 2438.987805060981, 2454.349597356702, 2494.0896572751, 13895.166290022631, 14408.783868241984, 14713.852861471356, 14868.256587170707, 15028.924855375653, 1905.5236190952262, 2025.4936265933516, 2037.3480486244407, 2093.822025127866, 2105.589410065038, 82891.17839664502, 84734.0, 86390.56804715999, 86454.56772716096, 86655.0, 10442.2168337375, 10575.682729518127, 10637.46812659364, 10897.618583349546, 11036.11711063113, 14998.175100369584, 15054.473093441897, 15073.0, 15077.396904123712, 15088.321025553876, 7719.498232614862, 8126.065502467174, 8265.504069755834, 8275.131111233355, 8315.334773218128, 8008.679652813822, 8030.0, 8052.476589021695, 8277.793055173668, 8295.294899933453, 6679.432248258952, 6706.463482921355, 6723.294054124247, 6782.152230971129, 6807.965960170168, 1847.1226167570296, 1862.2644055597964, 1875.7842848072646, 1881.388548721671, 1888.9244430222636, 1026.8767747870304, 1026.9114738377343, 1038.4392428088747, 1041.401194313273, 1086.9130469562417, 20529.79470205309, 20744.0, 20817.271395501386, 21014.159433622484, 21091.156353745984, 983.5672304186136, 1008.1279693065445, 1012.4077414712328, 1020.4693559349097, 1075.5912753153752, 10863.293885897392, 11774.234674746114, 11893.940530297294, 11906.88093119075, 12066.0, 467609.0, 484279.0, 492151.0, 492683.0, 494231.0, 81273.59363203264, 82704.0, 83461.0, 83718.0, 83980.16019839846, 997.3467378866853, 1005.607812952949, 1012.5392946209457, 1020.6172685243034, 1022.8568000479938, 17660.293588256325, 18060.187291572172, 18482.445526634223, 18535.814641853947, 18794.436166915013, 40355.59644403518, 40789.59210407977, 40852.38721419241, 41182.794086029375, 41953.58046419619, 52685.47314526806, 53121.203181953075, 53711.0, 54030.0, 55547.44452555423, 8143.429959902987, 8665.350098742494, 8824.470531768115, 8838.02781694026, 8858.379913406257, 9764.267679923893, 12380.566680166152, 13244.20534767917, 13447.260400678057, 13967.580972570839, 12006.279623222634, 12009.279443233434, 12183.147179697336, 12487.687807804878, 12657.62099049659, 11663.475143618387, 11881.168318217642, 11925.582604608797, 12048.819267711167, 12249.203801752858, 12017.519299227934, 12115.515379384726, 12187.207831490925, 12214.511419543118, 12798.360081995677, 8459.703910363107, 8506.532140732319, 8593.742187734379, 8815.647374104963, 8821.735347939572, 11692.240004400028, 12354.196977196454, 12452.564160254347, 12471.189372690746, 12650.367481625697], "value": 9458.867899847493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1337.8394592648883, 1460.4888289098817, 1487.523992322457, 1614.9354025838968, 1788.30256200082, 7352.889706654398, 7940.523568585889, 8238.876416853753, 8258.504489730612, 8462.492250464977, 8228.670853165866, 8299.21157490039, 8312.376571757111, 8314.91685083149, 8329.83340333193, 2390.7250666173395, 2417.443987882788, 2420.455397535558, 2429.0405289910564, 2430.0887167312258, 2333.6032874411308, 2380.321608341623, 2403.327068420845, 2404.13451157584, 2405.4226985523524, 2368.7157541095007, 2381.7975472084895, 2393.3298676370646, 2398.736139024706, 2410.276916924924, 2329.7087864017, 2344.929652110431, 2361.055577768889, 2376.097083108425, 2378.250850981935, 2346.77705617966, 2352.294311706481, 2378.143868207444, 2382.3329467748886, 2382.749811269809, 8100.3519718422385, 8231.835363292701, 8258.793530161794, 8319.625616847195, 8331.250187483094, 5023.547880690719, 5202.791888324463, 5215.6349055566125, 5231.581473482112, 5239.816606418757, 3224.91937701557, 3331.933361332784, 3346.1634591352163, 3380.8478618462227, 3388.644192359816, 987.7283746969568, 992.3153024413132, 998.675430485088, 1022.7852151048214, 1038.1850247555708, 10931.234813563055, 11012.724681882937, 11061.115110791117, 11121.110311175167, 11150.888491115065, 4201.516825565038, 4410.757408342508, 4501.257292546693, 4506.436695413074, 4543.45478542577, 9161.312901532412, 9168.541572921327, 9173.954130229306, 9176.632934682539, 9176.632934682671, 5183.948160518346, 5185.48145185486, 5189.143791274473, 5212.4266330703595, 5217.634765566374, 4239.97880010598, 4386.539413361615, 4587.495375508692, 4739.241721324572, 4872.3909511311085, 3762.698984081267, 3828.2152158807376, 3908.9804550977065, 3937.114149316438, 3974.5627980922077, 1260.8423947006625, 1270.0220829960879, 1287.2147989726259, 1290.161395093197, 1306.5231190615548, 917.2570218123342, 928.3640706116332, 951.7002144324516, 954.6515521834481, 965.8020105878278, 5608.4111168326735, 5778.913316300259, 5791.739371728282, 5832.62087964281, 6118.816435506942, 437.61489888898205, 446.7520526108041, 449.1197253383405, 451.58228638509905, 452.74419952726606, 3917.373220284741, 4095.6928230382246, 4111.97944010284, 4121.361189015707, 4122.154958233555, 9770.804583908282, 10250.436226007492, 10270.33242839213, 10272.589096436208, 10282.691519254435, 10179.949100254451, 10204.4387558685, 10210.693679189637, 10229.386236825814, 10253.025962533547, 7892.802679933047, 7915.643796029192, 8014.118446970829, 8020.318272946864, 8023.999999999884, 5474.315710536183, 5541.085720856175, 5661.547076233974, 5696.886062278649, 5784.82645520635, 9295.07049295065, 9412.15290623847, 9444.811103778024, 9500.0, 9526.0, 9304.72085837426, 9365.85951210746, 9404.623815047322, 9461.952690236505, 9492.477913714813, 7354.779356619096, 7383.07711536058, 7403.888941665771, 7409.851802964018, 7433.516821406592, 8001.359891208573, 8043.718469853761, 8075.636596353295, 8078.83842323162, 8079.636416361395, 7245.818854528679, 7335.889961650686, 7385.556866588022, 7563.584002879675, 7582.886256706043, 7152.856942861218, 7320.048393708784, 7334.926650733424, 7356.558606483628, 7385.889211661937, 6388.0737293091315, 6517.967410162919, 6519.511036672364, 6522.673866306571, 6522.771702990372, 4900.26496025599, 4955.776990035385, 5008.1235783736975, 5031.949680503149, 5335.813246536352, 4921.286413469955, 4978.60171186297, 5007.173816320266, 5054.191329387428, 5104.566111880383], "value": 4389.134766668025, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.68511016648597, 333.69300243775723, 335.453211265637, 338.2507745344062, 339.1622691950881, 5129.717865517405, 5316.948898546382, 5341.732913354326, 5348.411674715783, 5386.814900721844, 5162.199859021857, 5233.528982391584, 5247.134222853234, 5266.710330931797, 5274.947250527493, 4165.604267594574, 4169.3954376615375, 4178.937315940256, 4185.372194170884, 4187.392828039932, 3992.8203230854683, 4117.423560701504, 4169.416281720546, 4193.916121677565, 4201.411802347674, 4072.6538244249273, 4086.652634526054, 4087.897802554945, 4094.242565125461, 4099.323611604097, 4072.4705788247634, 4076.9196163016823, 4082.3672330788777, 4090.9181816363803, 4092.3247664135383, 3462.809545474998, 3569.589497207802, 3575.7496975211748, 3591.563374650135, 3608.8736894208578, 5110.0, 5123.2827404163445, 5130.563902068328, 5146.742662866842, 5169.534741873212, 4663.27719203524, 4680.180968330528, 4681.338124965656, 4687.0, 4692.765361731934, 5397.78408863645, 5470.8085217017615, 5491.560675145979, 5516.724163791794, 5534.1975413565215, 3917.3144699677728, 3939.3697008478507, 3948.2824971137647, 3950.6246906543834, 3962.663173630216, 5705.914411283834, 5736.913946290809, 5759.884802303931, 5773.884522309572, 5830.242068531106, 3983.3427484464737, 4038.192361527706, 4042.595740425934, 4091.6317531422314, 4096.344584866407, 4116.485439320085, 4124.835006599702, 4135.29699951009, 4137.8758637240935, 4139.937900931488, 4702.9764851176205, 4708.987567672898, 4709.458412282563, 4725.3384526166365, 4747.715137091785, 5350.545203657655, 5596.832095037155, 5597.216389705444, 5607.495325420732, 5625.606207565513, 1336.1448672849385, 1361.530272056139, 1361.9319034048258, 1362.0, 1393.9721205575831, 980.5501433224499, 990.7968866382374, 1004.1172800998129, 1010.934289271195, 1016.1159790981745, 5139.306193663882, 5153.758115219891, 5177.136230956852, 5200.6879587224885, 5222.399424066281, 5457.489554804755, 5457.918131228034, 5463.808766693226, 5494.752736126884, 5500.614956952975, 5168.9224661630105, 5171.637985341065, 5183.740812959337, 5213.843584692465, 5214.45248248936, 2893.8263704177816, 2910.126961911418, 2925.663548691885, 2941.249981254766, 2941.485240082977, 5693.572982026365, 5779.88440231193, 5780.127314699162, 5782.0, 5811.27359080115, 5503.257060296889, 5550.195221692913, 5620.85947851307, 5643.915341269884, 5651.547876169897, 5717.885642287214, 5728.770849165987, 5730.713464326767, 5743.0, 5777.39337369587, 5266.236395722675, 5495.670259784426, 5526.751296191762, 5543.473370029841, 5567.47109024642, 5333.7866485340155, 5424.26423544462, 5462.508374246178, 5463.562914966873, 5491.956528259618, 5713.800271847778, 5728.684922329312, 5728.79949201776, 5754.0, 5754.251947246831, 3853.9036524087123, 3970.664641700985, 3971.6822654187017, 3972.841086356513, 4024.8390064397095, 5458.8362349128, 5464.590155738256, 5508.008558459515, 5537.280153580009, 5560.332760068818, 5379.0, 5477.877035207694, 5487.122060470306, 5500.58745594074, 5501.312335958005, 5450.482204190595, 5494.532964697885, 5543.362513311021, 5554.555635549065, 5581.6371935824045, 5374.865628359166, 5488.780448782004, 5518.392976772471, 5530.668159910419, 5589.860253493533, 5530.474604912527, 5590.770030593263, 5597.208893154151, 5608.551315894637, 5619.73555949908, 5424.430434804289, 5455.290812194548, 5481.616286860041, 5513.979913715815, 5527.585431092603], "value": 4193.200353835117, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.5607091815831, 765.4106338119648, 808.4098608016149, 816.2245866426892, 851.289173540094, 14332.068415552994, 14993.92503037486, 15167.165805880672, 15274.465393711222, 15644.608884777886, 13585.049046566744, 14539.636509087279, 14630.561083167522, 14634.341454634541, 14652.853471465281, 858.3219256787131, 867.6832955971057, 873.7902903303193, 874.7987962768567, 875.0505701314082, 862.3833958719514, 865.6234537975969, 865.969691060813, 866.6100254885296, 866.6663334616155, 913.5614904845678, 913.6710784117712, 914.7484441778497, 915.2997956563235, 916.5829547555846, 898.5821592959305, 906.6192199276254, 908.0374802709116, 908.4776253654143, 909.2407839454064, 665.2349797732597, 666.9699863506105, 667.5427332277357, 668.0913957018452, 668.3750693101965, 13716.725665486734, 13774.380152893043, 13777.586672399844, 13789.862101378958, 14001.789973150411, 11466.48400821965, 11786.469608867621, 11870.940645296718, 11890.227135236268, 11890.762184756342, 10809.83785243222, 10813.729656758565, 10831.620893268777, 10840.078593319577, 10891.83662245067, 3651.2530323332676, 3654.689351405134, 3697.0572504011575, 3720.293144302601, 3744.120131769032, 65258.673706631635, 65477.0, 65769.0, 66079.3392066078, 66263.33736662669, 9119.179273865384, 9137.954310228406, 9139.908600913906, 9342.252619790537, 9527.666531671359, 19328.1302341395, 19341.0, 19350.516237093903, 19418.611627767365, 19486.415407537796, 7828.295453409107, 7864.842703145905, 7892.9210707893335, 8189.058258300252, 8334.6666133354, 4299.441072660534, 4327.826886924488, 4349.188818077345, 4379.1241751649795, 4533.886652833706, 3469.982650086784, 3632.055665526982, 3641.289948460078, 3642.453631955175, 3643.9635603643624, 582.7785441532191, 585.7539833270037, 599.6222379900635, 601.7562887030672, 610.0, 718.6119495472491, 728.4354625165433, 731.0313834169747, 741.7552207771422, 768.692522990797, 8958.68644597436, 9410.576524056434, 9551.474668893277, 9817.509124543887, 9890.456024918698, 634.1977398590786, 678.5284227461866, 687.8005378440297, 712.4763298975249, 725.0936329588015, 4468.821247150143, 4484.1031793641405, 4512.300593408027, 4562.384078149474, 4595.586397224266, 90021.54989225011, 90022.0, 90258.54870725736, 92353.0, 92381.0, 75470.62264688642, 76922.61538692271, 79037.60481197672, 79076.0, 83009.0, 63610.0, 63999.360006400275, 65854.34145658578, 66717.33282667208, 70990.29009709836, 9302.348835581444, 9637.951810240904, 9926.652567160114, 10086.546105425126, 10250.743731406774, 35759.46360804538, 38496.0, 42003.36994945139, 49873.25190122223, 50657.0, 44703.776481117384, 59971.70014150076, 60210.698946504985, 61402.692986534785, 62847.6857615709, 12599.0, 12768.297743623818, 12864.22814631125, 12927.741445171232, 13087.41106650184, 13308.667283317995, 13362.465501379836, 13595.796063058864, 13607.183568985893, 13667.31663416845, 12388.690282743004, 12418.937905310415, 12439.440225190068, 13006.219626822422, 13029.674258143623, 12269.202501837352, 12326.938365308117, 12719.364031798557, 13068.085234033526, 13089.0837641368, 12250.877491224974, 12441.93779031099, 12874.420651070912, 13055.543055992996, 13064.150830196008, 10065.798684026426, 10079.193664506969, 10225.897741022793, 10306.793864122825, 10450.268481206547, 10881.836772448261, 10958.945205273923, 11180.944095279472, 11194.216404851908, 11295.0], "value": 7097.260518515732, "unit": "score"}], "name": "dromaeo_css", "value": 7163.883202985168, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 111.0, 109.0, 112.0, 113.0, 111.0, 110.0, 111.0, 110.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 126.0, 160.0, 127.0, 123.0, 132.0, 126.0, 152.0, 121.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 161.0, 161.0, 161.0, 159.0, 161.0, 160.0, 160.0, 159.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 76.0, 105.0, 76.0, 76.0, 76.0, 76.0, 106.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 117.0, 82.0, 81.0, 82.0, 99.0, 81.0, 83.0, 111.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 116.0, 116.0, 117.0], "value": 116.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 145.0, 146.0, 147.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 49.0, 52.0, 50.0, 50.0, 50.0, 50.0, 51.0, 49.0, 49.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 76.0, 75.0, 83.0, 78.0, 77.0, 74.0, 76.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 127.0, 137.0, 134.0, 130.0, 136.0, 128.0, 134.0, 169.0, 135.0], "value": 136.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 160.0, 159.0, 158.0, 160.0, 159.0, 155.0, 157.0, 157.0, 158.0], "value": 158.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 62.0, 62.0, 63.0, 63.0, 63.0, 62.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1467.8999999999996, "alertThreshold": 2.0}]} 08:36:26 INFO - Return code: 0 08:36:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:36:26 INFO - # TBPL SUCCESS # 08:36:26 INFO - Running post-action listener: _resource_record_post_action 08:36:26 INFO - [mozharness: 2016-12-05 16:36:26.844191Z] Finished run-tests step (success) 08:36:26 INFO - Running post-run listener: _resource_record_post_run 08:36:26 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 262144; Write bytes: 356368384; Read time: 12; Write time: 236216 08:36:26 INFO - TinderboxPrint: CPU usage
13.0% 08:36:26 INFO - TinderboxPrint: I/O read bytes / time
262,144 / 12 08:36:26 INFO - TinderboxPrint: I/O write bytes / time
356,368,384 / 236,216 08:36:26 INFO - TinderboxPrint: CPU idle
8,270.2 (87.0%) 08:36:26 INFO - TinderboxPrint: CPU user
1,192.2 (12.5%) 08:36:26 INFO - TinderboxPrint: Swap in / out
0 / 0 08:36:26 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 107806720; Read time: 0; Write time: 86180 08:36:26 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 262144; Write bytes: 247795712; Read time: 12; Write time: 150004 08:36:27 INFO - Running post-run listener: _upload_blobber_files 08:36:27 INFO - Blob upload gear active. 08:36:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:36:27 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 08:36:27 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:36:27 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:36:27 INFO - (blobuploader) - INFO - Open directory for files ... 08:36:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:36:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:36:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:28 INFO - (blobuploader) - INFO - Done attempting. 08:36:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:36:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:36:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:33 INFO - (blobuploader) - INFO - Done attempting. 08:36:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:36:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:36:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:36:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:36:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:36:34 INFO - (blobuploader) - INFO - Done attempting. 08:36:34 INFO - (blobuploader) - INFO - Iteration through files over. 08:36:34 INFO - Return code: 0 08:36:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:36:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:36:34 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e5b268791b6065744b450b2b2684cad369a2c8bf484f31b6618ec2b8054942259984fa4bc927b4976a685f050043d281571e1f89a7f98371afba2680fa9d210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09c744c954992fea2cb4e2b9f4084ab4a779b154b90b66d3db1a44f49c08222f91d5163a06d3b47784f3780e44067645d3ba7217941a3e426a1982776fa47e7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e930d9fedd29249baa70c4f480ba1f700471569b75adcc66a5af79b59960d5e48cad24279f92f750bb1e770c791682aaf9a6da6e1125d1702f8d36b6eb06ea2"} 08:36:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:36:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:36:34 INFO - Contents: 08:36:34 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e5b268791b6065744b450b2b2684cad369a2c8bf484f31b6618ec2b8054942259984fa4bc927b4976a685f050043d281571e1f89a7f98371afba2680fa9d210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09c744c954992fea2cb4e2b9f4084ab4a779b154b90b66d3db1a44f49c08222f91d5163a06d3b47784f3780e44067645d3ba7217941a3e426a1982776fa47e7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e930d9fedd29249baa70c4f480ba1f700471569b75adcc66a5af79b59960d5e48cad24279f92f750bb1e770c791682aaf9a6da6e1125d1702f8d36b6eb06ea2"} 08:36:34 INFO - Running post-run listener: copy_logs_to_upload_dir 08:36:34 INFO - Copying logs to upload dir... 08:36:34 INFO - mkdir: /builds/slave/test/build/upload/logs 08:36:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.234817 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-12-05 08:36:34.051109) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 08:36:34.055959) ========= 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=a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288 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-Aurora/sha512/0e5b268791b6065744b450b2b2684cad369a2c8bf484f31b6618ec2b8054942259984fa4bc927b4976a685f050043d281571e1f89a7f98371afba2680fa9d210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09c744c954992fea2cb4e2b9f4084ab4a779b154b90b66d3db1a44f49c08222f91d5163a06d3b47784f3780e44067645d3ba7217941a3e426a1982776fa47e7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e930d9fedd29249baa70c4f480ba1f700471569b75adcc66a5af79b59960d5e48cad24279f92f750bb1e770c791682aaf9a6da6e1125d1702f8d36b6eb06ea2"} build_url:https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011335 build_url: 'https://queue.taskcluster.net/v1/task/ImFjdNSORByedj2IQNRjag/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0e5b268791b6065744b450b2b2684cad369a2c8bf484f31b6618ec2b8054942259984fa4bc927b4976a685f050043d281571e1f89a7f98371afba2680fa9d210", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/09c744c954992fea2cb4e2b9f4084ab4a779b154b90b66d3db1a44f49c08222f91d5163a06d3b47784f3780e44067645d3ba7217941a3e426a1982776fa47e7c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7e930d9fedd29249baa70c4f480ba1f700471569b75adcc66a5af79b59960d5e48cad24279f92f750bb1e770c791682aaf9a6da6e1125d1702f8d36b6eb06ea2"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-05 08:36:34.085915) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:36:34.086292) ========= 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=a0d2d2de893abaa8702a9954000001a7-1480953289.846478-2065305288 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-05 08:36:34.135359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 08:36:34.138709) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-05 08:36:34.139007) ========= ========= Total master_lag: 0.29 =========