builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-064 starttime: 1480674956.95 results: success (0) buildid: 20161202004006 builduid: 469c4f26a17a4cba93fbf63c529cdf1b revision: 618770ed4835a5ee8852afc1406754ea6391b2d4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:56.949366) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:56.949873) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:56.950215) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:56.961063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:56.961410) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-02 02:35:57-- 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% 228M=0s 2016-12-02 02:35:57 (228 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.162230 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:57.135496) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:57.135825) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015760 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:57.185771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 02:35:57.186172) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 618770ed4835a5ee8852afc1406754ea6391b2d4 --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 618770ed4835a5ee8852afc1406754ea6391b2d4 --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=a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-02 02:35:58,051 truncating revision to first 12 chars 2016-12-02 02:35:58,051 Setting DEBUG logging. 2016-12-02 02:35:58,051 attempt 1/10 2016-12-02 02:35:58,051 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/618770ed4835?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-02 02:35:58,982 unpacking tar archive at: mozilla-aurora-618770ed4835/testing/mozharness/ program finished with exit code 0 elapsedTime=1.233495 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-02 02:35:58.433675) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:58.434030) ========= script_repo_revision: 618770ed4835a5ee8852afc1406754ea6391b2d4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:58.434464) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:58.434742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-02 02:35:58.444317) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-02 02:35:58.444694) ========= /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=a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:35:59 INFO - MultiFileLogger online at 20161202 02:35:59 in /builds/slave/test 02:35:59 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 02:35:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:35:59 INFO - {'append_to_log': False, 02:35:59 INFO - 'base_work_dir': '/builds/slave/test', 02:35:59 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:35:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:35:59 INFO - 'branch': 'Mozilla-Aurora', 02:35:59 INFO - 'buildbot_json_path': 'buildprops.json', 02:35:59 INFO - 'config_files': ('talos/linux_config.py',), 02:35:59 INFO - 'default_actions': ('clobber', 02:35:59 INFO - 'read-buildbot-config', 02:35:59 INFO - 'download-and-extract', 02:35:59 INFO - 'populate-webroot', 02:35:59 INFO - 'create-virtualenv', 02:35:59 INFO - 'install', 02:35:59 INFO - 'run-tests'), 02:35:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:35:59 INFO - 'download_minidump_stackwalk': True, 02:35:59 INFO - 'download_symbols': 'ondemand', 02:35:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:35:59 INFO - 'tooltool.py': '/tools/tooltool.py', 02:35:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:35:59 INFO - '/tools/misc-python/virtualenv.py')}, 02:35:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:35:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:35:59 INFO - 'installer_path': 'installer.exe', 02:35:59 INFO - 'log_level': 'info', 02:35:59 INFO - 'log_name': 'talos', 02:35:59 INFO - 'log_to_console': True, 02:35:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:35:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:35:59 INFO - 'opt_config_files': (), 02:35:59 INFO - 'pip_index': False, 02:35:59 INFO - 'sps_profile': False, 02:35:59 INFO - 'sps_profile_interval': 0, 02:35:59 INFO - 'suite': 'dromaeojs', 02:35:59 INFO - 'system_bits': '32', 02:35:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:35:59 INFO - 'title': 'talos-linux64-ix-064', 02:35:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:35:59 INFO - 'use_talos_json': True, 02:35:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:35:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:35:59 INFO - 'work_dir': 'build'} 02:35:59 INFO - [mozharness: 2016-12-02 10:35:59.402520Z] Running clobber step. 02:35:59 INFO - Running pre-action listener: _resource_record_pre_action 02:35:59 INFO - Running main action method: clobber 02:35:59 INFO - rmtree: /builds/slave/test/build 02:35:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:35:59 INFO - Running post-action listener: _resource_record_post_action 02:35:59 INFO - [mozharness: 2016-12-02 10:35:59.860123Z] Finished clobber step (success) 02:35:59 INFO - [mozharness: 2016-12-02 10:35:59.860222Z] Running read-buildbot-config step. 02:35:59 INFO - Running pre-action listener: _resource_record_pre_action 02:35:59 INFO - Running main action method: read_buildbot_config 02:35:59 INFO - Using buildbot properties: 02:35:59 INFO - { 02:35:59 INFO - "project": "", 02:35:59 INFO - "product": "firefox", 02:35:59 INFO - "script_repo_revision": "production", 02:35:59 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:35:59 INFO - "repository": "", 02:35:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:35:59 INFO - "buildid": "20161202004006", 02:35:59 INFO - "stage_platform": "linux64-pgo", 02:35:59 INFO - "basedir": "/builds/slave/test", 02:35:59 INFO - "nightly_build": "True", 02:35:59 INFO - "buildnumber": 656, 02:35:59 INFO - "slavename": "talos-linux64-ix-064", 02:35:59 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:35:59 INFO - "platform": "ubuntu64_hw", 02:35:59 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:35:59 INFO - "branch": "mozilla-aurora", 02:35:59 INFO - "repo_path": "releases/mozilla-aurora", 02:35:59 INFO - "revision": "618770ed4835a5ee8852afc1406754ea6391b2d4", 02:35:59 INFO - "pgo_build": "True", 02:35:59 INFO - "builduid": "469c4f26a17a4cba93fbf63c529cdf1b", 02:35:59 INFO - "slavebuilddir": "test" 02:35:59 INFO - } 02:35:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:35:59 INFO - Running post-action listener: _resource_record_post_action 02:35:59 INFO - [mozharness: 2016-12-02 10:35:59.862717Z] Finished read-buildbot-config step (success) 02:35:59 INFO - [mozharness: 2016-12-02 10:35:59.862804Z] Running download-and-extract step. 02:35:59 INFO - Running pre-action listener: _resource_record_pre_action 02:35:59 INFO - Running main action method: download_and_extract 02:35:59 INFO - mkdir: /builds/slave/test/build/tests 02:35:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:35:59 INFO - trying https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:35:59 INFO - Downloading https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/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 02:35:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/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 02:36:00 INFO - Downloaded 1361 bytes. 02:36:00 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:36:00 INFO - Using the following test package requirements: 02:36:00 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:36:00 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:36:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:36:00 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:36:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:36:00 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:36:00 INFO - u'jsshell-linux-x86_64.zip'], 02:36:00 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:36:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:36:00 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:36:00 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:36:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:36:00 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:36:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:36:00 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:36:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:36:00 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:36:00 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:36:00 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:36:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:36:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:36:00 INFO - Fetch https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:36:01 INFO - Http code: 200 02:36:01 INFO - via: 1.1 ae162f6796e551002447afd7c07ec67a.cloudfront.net (CloudFront) 02:36:01 INFO - x-amz-cf-id: UVM4Z-X8sb4GvhjiA2Ftugu26FBWaerP9aDJBD7kR0M_5Bbq6ZnJDQ== 02:36:01 INFO - x-amz-version-id: VWXTfpAyWkQneYT4Dash2bDy0yjH1Il2 02:36:01 INFO - Expected file size: 21946446 02:36:01 INFO - Obtained file size: 21946446 02:36:05 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 02:36:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:36:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:36:05 INFO - Fetch https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:36:05 INFO - Http code: 200 02:36:05 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 02:36:05 INFO - x-amz-cf-id: gMskHOMwsvaAlaXCS74dySZUCYnj-cgkgOosBZsusuCqByZwNtSObw== 02:36:05 INFO - x-amz-version-id: VWXTfpAyWkQneYT4Dash2bDy0yjH1Il2 02:36:06 INFO - Expected file size: 21946446 02:36:06 INFO - Obtained file size: 21946446 02:36:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:36:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:36:10 INFO - Fetch https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:36:11 INFO - Http code: 200 02:36:11 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 02:36:11 INFO - x-amz-cf-id: Pbxd9YTuA_CQ2MaY5psT9nghhZX2iTbzFbRFMJg2SWxVsJP340aZ-A== 02:36:11 INFO - x-amz-version-id: YQGTo_GGEJOQsEbHsOcubCOxIuFXZ_jt 02:36:11 INFO - Expected file size: 14409038 02:36:11 INFO - Obtained file size: 14409038 02:36:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:11 INFO - trying https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:36:11 INFO - Downloading https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/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 02:36:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/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 02:36:13 INFO - Downloaded 63996273 bytes. 02:36:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:36:13 INFO - mkdir: /builds/slave/test/properties 02:36:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:36:13 INFO - Writing to file /builds/slave/test/properties/build_url 02:36:13 INFO - Contents: 02:36:13 INFO - build_url:https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:36:14 INFO - Running post-action listener: _resource_record_post_action 02:36:14 INFO - Running post-action listener: set_extra_try_arguments 02:36:14 INFO - [mozharness: 2016-12-02 10:36:14.639726Z] Finished download-and-extract step (success) 02:36:14 INFO - [mozharness: 2016-12-02 10:36:14.640027Z] Running populate-webroot step. 02:36:14 INFO - Running pre-action listener: _resource_record_pre_action 02:36:14 INFO - Running main action method: populate_webroot 02:36:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:36:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:36:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:36:14 INFO - '--tppagecycles', 02:36:14 INFO - '7'], 02:36:14 INFO - 'tests': ['tsvgm']}}, 02:36:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:36:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:36:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:36:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:36:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:36:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['damp', 'tps']}, 02:36:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'tests': ['damp', 'tps']}, 02:36:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['dromaeo_dom']}, 02:36:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:36:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['basic_compositor_video']}, 02:36:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:36:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'other-e10s': {'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['a11yr', 02:36:14 INFO - 'ts_paint', 02:36:14 INFO - 'tpaint', 02:36:14 INFO - 'sessionrestore', 02:36:14 INFO - 'sessionrestore_no_auto_restore', 02:36:14 INFO - 'tabpaint']}, 02:36:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['tsvgx', 02:36:14 INFO - 'tsvgr_opacity', 02:36:14 INFO - 'tart', 02:36:14 INFO - 'tscrollx', 02:36:14 INFO - 'cart']}, 02:36:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:36:14 INFO - 'tsvgr_opacity', 02:36:14 INFO - 'tart', 02:36:14 INFO - 'tscrollx', 02:36:14 INFO - 'cart']}, 02:36:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'talos_options': ['--disable-e10s'], 02:36:14 INFO - 'tests': ['tp5o']}, 02:36:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'tests': ['tp5o']}, 02:36:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'talos_options': ['--disable-e10s', 02:36:14 INFO - '--xperf_path', 02:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:14 INFO - 'tests': ['tp5n']}, 02:36:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:36:14 INFO - 'talos_options': ['--xperf_path', 02:36:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:36:14 INFO - 'tests': ['tp5n']}}, 02:36:14 INFO - 'talos.zip': {'path': '', 02:36:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:36:14 INFO - Running post-action listener: _resource_record_post_action 02:36:14 INFO - [mozharness: 2016-12-02 10:36:14.660895Z] Finished populate-webroot step (success) 02:36:14 INFO - [mozharness: 2016-12-02 10:36:14.660986Z] Running create-virtualenv step. 02:36:14 INFO - Running pre-action listener: _resource_record_pre_action 02:36:14 INFO - Running main action method: create_virtualenv 02:36:14 INFO - Creating virtualenv /builds/slave/test/build/venv 02:36:14 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:36:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:36:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:36:14 INFO - Using real prefix '/usr' 02:36:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:36:15 INFO - Installing distribute.............................................................................................................................................................................................done. 02:36:17 INFO - Installing pip.................done. 02:36:17 INFO - Return code: 0 02:36:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:36:17 INFO - Reading from file tmpfile_stdout 02:36:17 INFO - Output received: 02:36:17 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) 02:36:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbc3007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2497ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:36:17 INFO - Using env: {'DISPLAY': ':0', 02:36:17 INFO - 'HOME': '/home/cltbld', 02:36:17 INFO - 'LANG': 'en_US.UTF-8', 02:36:17 INFO - 'LANGUAGE': 'en_US:en', 02:36:17 INFO - 'LOGNAME': 'cltbld', 02:36:17 INFO - 'MAIL': '/var/mail/cltbld', 02:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:17 INFO - 'MOZ_NO_REMOTE': '1', 02:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:17 INFO - 'NO_EM_RESTART': '1', 02:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:17 INFO - 'PWD': '/builds/slave/test', 02:36:17 INFO - 'SHELL': '/bin/bash', 02:36:17 INFO - 'SHLVL': '1', 02:36:17 INFO - 'TERM': 'linux', 02:36:17 INFO - 'TMOUT': '86400', 02:36:17 INFO - 'USER': 'cltbld', 02:36:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:17 INFO - '_': '/tools/buildbot/bin/python'} 02:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:17 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:36:17 INFO - Cleaning up... 02:36:17 INFO - Return code: 0 02:36:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcbc3007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2497ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:36:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:36:17 INFO - Using env: {'DISPLAY': ':0', 02:36:17 INFO - 'HOME': '/home/cltbld', 02:36:17 INFO - 'LANG': 'en_US.UTF-8', 02:36:17 INFO - 'LANGUAGE': 'en_US:en', 02:36:17 INFO - 'LOGNAME': 'cltbld', 02:36:17 INFO - 'MAIL': '/var/mail/cltbld', 02:36:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:17 INFO - 'MOZ_NO_REMOTE': '1', 02:36:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:17 INFO - 'NO_EM_RESTART': '1', 02:36:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:17 INFO - 'PWD': '/builds/slave/test', 02:36:17 INFO - 'SHELL': '/bin/bash', 02:36:17 INFO - 'SHLVL': '1', 02:36:17 INFO - 'TERM': 'linux', 02:36:17 INFO - 'TMOUT': '86400', 02:36:17 INFO - 'USER': 'cltbld', 02:36:17 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:17 INFO - '_': '/tools/buildbot/bin/python'} 02:36:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:17 INFO - Downloading/unpacking psutil>=3.1.1 02:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:36:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:20 INFO - Installing collected packages: psutil 02:36:20 INFO - Running setup.py install for psutil 02:36:20 INFO - building 'psutil._psutil_linux' extension 02:36:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:36:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:36:20 INFO - building 'psutil._psutil_posix' extension 02:36:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:36:20 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:36:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:36:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:36:20 INFO - Successfully installed psutil 02:36:20 INFO - Cleaning up... 02:36:20 INFO - Return code: 0 02:36:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:36:20 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')]} 02:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:20 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')]} 02:36:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:20 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 0x7fcbc3007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2497ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:36:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:36:20 INFO - Using env: {'DISPLAY': ':0', 02:36:20 INFO - 'HOME': '/home/cltbld', 02:36:20 INFO - 'LANG': 'en_US.UTF-8', 02:36:20 INFO - 'LANGUAGE': 'en_US:en', 02:36:20 INFO - 'LOGNAME': 'cltbld', 02:36:20 INFO - 'MAIL': '/var/mail/cltbld', 02:36:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:20 INFO - 'MOZ_NO_REMOTE': '1', 02:36:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:20 INFO - 'NO_EM_RESTART': '1', 02:36:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:20 INFO - 'PWD': '/builds/slave/test', 02:36:20 INFO - 'SHELL': '/bin/bash', 02:36:20 INFO - 'SHLVL': '1', 02:36:20 INFO - 'TERM': 'linux', 02:36:20 INFO - 'TMOUT': '86400', 02:36:20 INFO - 'USER': 'cltbld', 02:36:20 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:20 INFO - '_': '/tools/buildbot/bin/python'} 02:36:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:36:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:36:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:36:22 INFO - Installing collected packages: mozsystemmonitor 02:36:22 INFO - Running setup.py install for mozsystemmonitor 02:36:22 INFO - Successfully installed mozsystemmonitor 02:36:22 INFO - Cleaning up... 02:36:22 INFO - Return code: 0 02:36:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:36:22 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')]} 02:36:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:22 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')]} 02:36:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:22 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 0x7fcbc3007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2497ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:36:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:36:22 INFO - Using env: {'DISPLAY': ':0', 02:36:22 INFO - 'HOME': '/home/cltbld', 02:36:22 INFO - 'LANG': 'en_US.UTF-8', 02:36:22 INFO - 'LANGUAGE': 'en_US:en', 02:36:22 INFO - 'LOGNAME': 'cltbld', 02:36:22 INFO - 'MAIL': '/var/mail/cltbld', 02:36:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:22 INFO - 'MOZ_NO_REMOTE': '1', 02:36:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:22 INFO - 'NO_EM_RESTART': '1', 02:36:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:22 INFO - 'PWD': '/builds/slave/test', 02:36:22 INFO - 'SHELL': '/bin/bash', 02:36:22 INFO - 'SHLVL': '1', 02:36:22 INFO - 'TERM': 'linux', 02:36:22 INFO - 'TMOUT': '86400', 02:36:22 INFO - 'USER': 'cltbld', 02:36:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:22 INFO - '_': '/tools/buildbot/bin/python'} 02:36:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:23 INFO - Downloading/unpacking jsonschema==2.5.1 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:36:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:25 INFO - Downloading functools32-3.2.3-2.tar.gz 02:36:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:36:25 INFO - warning: no files found matching '*.txt' 02:36:25 INFO - no previously-included directories found matching 'build' 02:36:25 INFO - no previously-included directories found matching 'dist' 02:36:25 INFO - no previously-included directories found matching '.git*' 02:36:25 INFO - Installing collected packages: jsonschema, functools32 02:36:25 INFO - Running setup.py install for functools32 02:36:25 INFO - warning: no files found matching '*.txt' 02:36:25 INFO - no previously-included directories found matching 'build' 02:36:25 INFO - no previously-included directories found matching 'dist' 02:36:25 INFO - no previously-included directories found matching '.git*' 02:36:25 INFO - Successfully installed jsonschema functools32 02:36:25 INFO - Cleaning up... 02:36:25 INFO - Return code: 0 02:36:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:36:25 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')]} 02:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:25 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')]} 02:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:25 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 0x7fcbc3007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2497ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:25 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 02:36:25 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 02:36:25 INFO - Using env: {'DISPLAY': ':0', 02:36:25 INFO - 'HOME': '/home/cltbld', 02:36:25 INFO - 'LANG': 'en_US.UTF-8', 02:36:25 INFO - 'LANGUAGE': 'en_US:en', 02:36:25 INFO - 'LOGNAME': 'cltbld', 02:36:25 INFO - 'MAIL': '/var/mail/cltbld', 02:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:25 INFO - 'MOZ_NO_REMOTE': '1', 02:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:25 INFO - 'NO_EM_RESTART': '1', 02:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:25 INFO - 'PWD': '/builds/slave/test', 02:36:25 INFO - 'SHELL': '/bin/bash', 02:36:25 INFO - 'SHLVL': '1', 02:36:25 INFO - 'TERM': 'linux', 02:36:25 INFO - 'TMOUT': '86400', 02:36:25 INFO - 'USER': 'cltbld', 02:36:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:25 INFO - '_': '/tools/buildbot/bin/python'} 02:36:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:36:25 INFO - Cleaning up... 02:36:25 INFO - Return code: 0 02:36:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:36:25 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')]} 02:36:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:25 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')]} 02:36:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:25 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 0x7fcbc3007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2497ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:36:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:36:25 INFO - Using env: {'DISPLAY': ':0', 02:36:25 INFO - 'HOME': '/home/cltbld', 02:36:25 INFO - 'LANG': 'en_US.UTF-8', 02:36:25 INFO - 'LANGUAGE': 'en_US:en', 02:36:25 INFO - 'LOGNAME': 'cltbld', 02:36:25 INFO - 'MAIL': '/var/mail/cltbld', 02:36:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:25 INFO - 'MOZ_NO_REMOTE': '1', 02:36:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:25 INFO - 'NO_EM_RESTART': '1', 02:36:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:25 INFO - 'PWD': '/builds/slave/test', 02:36:25 INFO - 'SHELL': '/bin/bash', 02:36:25 INFO - 'SHLVL': '1', 02:36:25 INFO - 'TERM': 'linux', 02:36:25 INFO - 'TMOUT': '86400', 02:36:25 INFO - 'USER': 'cltbld', 02:36:25 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:25 INFO - '_': '/tools/buildbot/bin/python'} 02:36:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:26 INFO - Downloading/unpacking blobuploader==1.2.4 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36: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 02:36:27 INFO - Downloading blobuploader-1.2.4.tar.gz 02:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:36:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:36:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:28 INFO - Downloading docopt-0.6.1.tar.gz 02:36:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:36:28 INFO - Installing collected packages: blobuploader, requests, docopt 02:36:28 INFO - Running setup.py install for blobuploader 02:36:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:36:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:36:28 INFO - Running setup.py install for requests 02:36:29 INFO - Running setup.py install for docopt 02:36:29 INFO - Successfully installed blobuploader requests docopt 02:36:29 INFO - Cleaning up... 02:36:29 INFO - Return code: 0 02:36:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:29 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 0x7fcbc3007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2497ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:36:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:36:29 INFO - Using env: {'DISPLAY': ':0', 02:36:29 INFO - 'HOME': '/home/cltbld', 02:36:29 INFO - 'LANG': 'en_US.UTF-8', 02:36:29 INFO - 'LANGUAGE': 'en_US:en', 02:36:29 INFO - 'LOGNAME': 'cltbld', 02:36:29 INFO - 'MAIL': '/var/mail/cltbld', 02:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:29 INFO - 'MOZ_NO_REMOTE': '1', 02:36:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:29 INFO - 'NO_EM_RESTART': '1', 02:36:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:29 INFO - 'PWD': '/builds/slave/test', 02:36:29 INFO - 'SHELL': '/bin/bash', 02:36:29 INFO - 'SHLVL': '1', 02:36:29 INFO - 'TERM': 'linux', 02:36:29 INFO - 'TMOUT': '86400', 02:36:29 INFO - 'USER': 'cltbld', 02:36:29 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:29 INFO - '_': '/tools/buildbot/bin/python'} 02:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:29 INFO - Running setup.py (path:/tmp/pip-MTXZxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:29 INFO - Running setup.py (path:/tmp/pip-tSMmob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:29 INFO - Running setup.py (path:/tmp/pip-YYWzAG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:29 INFO - Running setup.py (path:/tmp/pip-BN35f_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:29 INFO - Running setup.py (path:/tmp/pip-ZHrnuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:30 INFO - Running setup.py (path:/tmp/pip-sf6JTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:30 INFO - Running setup.py (path:/tmp/pip-g5PLqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:30 INFO - Running setup.py (path:/tmp/pip-vwak7q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:30 INFO - Running setup.py (path:/tmp/pip-jN3CCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:30 INFO - Running setup.py (path:/tmp/pip-9qSiAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:30 INFO - Running setup.py (path:/tmp/pip-VpfqYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:30 INFO - Running setup.py (path:/tmp/pip-odlhxR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:30 INFO - Running setup.py (path:/tmp/pip-wpeqVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:30 INFO - Running setup.py (path:/tmp/pip-pSH8oT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:30 INFO - Running setup.py (path:/tmp/pip-RJN3hI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:30 INFO - Running setup.py (path:/tmp/pip-P9NckI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:30 INFO - Running setup.py (path:/tmp/pip-RdMNpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:36:30 INFO - Running setup.py install for manifestparser 02:36:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Running setup.py install for mozcrash 02:36:31 INFO - Running setup.py install for mozdebug 02:36:31 INFO - Running setup.py install for mozdevice 02:36:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Running setup.py install for mozfile 02:36:31 INFO - Running setup.py install for mozhttpd 02:36:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Running setup.py install for mozinfo 02:36:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Running setup.py install for mozInstall 02:36:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Running setup.py install for mozleak 02:36:31 INFO - Running setup.py install for mozlog 02:36:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:36:31 INFO - Running setup.py install for moznetwork 02:36:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:36:32 INFO - Running setup.py install for mozprocess 02:36:32 INFO - Running setup.py install for mozprofile 02:36:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:36:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:36:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:36:32 INFO - Running setup.py install for mozrunner 02:36:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:36:32 INFO - Running setup.py install for mozscreenshot 02:36:32 INFO - Running setup.py install for moztest 02:36:32 INFO - Running setup.py install for mozversion 02:36:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:36:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:36:32 INFO - Cleaning up... 02:36:32 INFO - Return code: 0 02:36:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:32 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 0x7fcbc3007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2497ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:36:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:36:32 INFO - Using env: {'DISPLAY': ':0', 02:36:32 INFO - 'HOME': '/home/cltbld', 02:36:32 INFO - 'LANG': 'en_US.UTF-8', 02:36:32 INFO - 'LANGUAGE': 'en_US:en', 02:36:32 INFO - 'LOGNAME': 'cltbld', 02:36:32 INFO - 'MAIL': '/var/mail/cltbld', 02:36:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:32 INFO - 'MOZ_NO_REMOTE': '1', 02:36:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:32 INFO - 'NO_EM_RESTART': '1', 02:36:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:32 INFO - 'PWD': '/builds/slave/test', 02:36:32 INFO - 'SHELL': '/bin/bash', 02:36:32 INFO - 'SHLVL': '1', 02:36:32 INFO - 'TERM': 'linux', 02:36:32 INFO - 'TMOUT': '86400', 02:36:32 INFO - 'USER': 'cltbld', 02:36:32 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:32 INFO - '_': '/tools/buildbot/bin/python'} 02:36:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:36:32 INFO - Running setup.py (path:/tmp/pip-mjmwEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:36:33 INFO - Running setup.py (path:/tmp/pip-j0CwPd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:36:33 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)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:36:33 INFO - Running setup.py (path:/tmp/pip-CCVAqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:36:33 INFO - Running setup.py (path:/tmp/pip-WgO14k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:36:33 INFO - Running setup.py (path:/tmp/pip-HtGUNv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:36:33 INFO - Running setup.py (path:/tmp/pip-JBLB5B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:36:33 INFO - Running setup.py (path:/tmp/pip-Y140e8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:36:33 INFO - Running setup.py (path:/tmp/pip-4L5d2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:36:33 INFO - Running setup.py (path:/tmp/pip-nwmwzm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:36:33 INFO - Running setup.py (path:/tmp/pip-KCv69E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:36:33 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)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:36:33 INFO - Running setup.py (path:/tmp/pip-oeRqX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:36:33 INFO - Running setup.py (path:/tmp/pip-joCmrJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:36:33 INFO - Running setup.py (path:/tmp/pip-ZpQd7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:36:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:36:33 INFO - Running setup.py (path:/tmp/pip-RyjL9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:36:33 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)) 02:36:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:33 INFO - Running setup.py (path:/tmp/pip-q2YJCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:36:34 INFO - Running setup.py (path:/tmp/pip-KgFb_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:36:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:36:34 INFO - Running setup.py (path:/tmp/pip-3K2qvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:36:34 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)) 02:36:34 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)) 02:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:36:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:36:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:36:36 INFO - Downloading blessings-1.6.tar.gz 02:36:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:36:36 INFO - Installing collected packages: blessings 02:36:36 INFO - Running setup.py install for blessings 02:36:36 INFO - Successfully installed blessings 02:36:36 INFO - Cleaning up... 02:36:36 INFO - Return code: 0 02:36:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:36:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:36 INFO - Reading from file tmpfile_stdout 02:36:36 INFO - Current package versions: 02:36:36 INFO - argparse == 1.2.1 02:36:36 INFO - blessings == 1.6 02:36:36 INFO - blobuploader == 1.2.4 02:36:36 INFO - docopt == 0.6.1 02:36:36 INFO - functools32 == 3.2.3-2 02:36:36 INFO - jsonschema == 2.5.1 02:36:36 INFO - manifestparser == 1.1 02:36:36 INFO - mozInstall == 1.12 02:36:36 INFO - mozcrash == 1.0 02:36:36 INFO - mozdebug == 0.1 02:36:36 INFO - mozdevice == 0.48 02:36:36 INFO - mozfile == 1.2 02:36:36 INFO - mozhttpd == 0.7 02:36:36 INFO - mozinfo == 0.9 02:36:36 INFO - mozleak == 0.1 02:36:36 INFO - mozlog == 3.4 02:36:36 INFO - moznetwork == 0.27 02:36:36 INFO - mozprocess == 0.23 02:36:36 INFO - mozprofile == 0.28 02:36:36 INFO - mozrunner == 6.13 02:36:36 INFO - mozscreenshot == 0.1 02:36:36 INFO - mozsystemmonitor == 0.3 02:36:36 INFO - moztest == 0.7 02:36:36 INFO - mozversion == 1.4 02:36:36 INFO - psutil == 3.1.1 02:36:36 INFO - requests == 1.2.3 02:36:36 INFO - wsgiref == 0.1.2 02:36:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:36:36 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')]} 02:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:36 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')]} 02:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:36 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 0x7fcbc3007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2497ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:36:36 INFO - Using env: {'DISPLAY': ':0', 02:36:36 INFO - 'HOME': '/home/cltbld', 02:36:36 INFO - 'LANG': 'en_US.UTF-8', 02:36:36 INFO - 'LANGUAGE': 'en_US:en', 02:36:36 INFO - 'LOGNAME': 'cltbld', 02:36:36 INFO - 'MAIL': '/var/mail/cltbld', 02:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:36 INFO - 'MOZ_NO_REMOTE': '1', 02:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:36 INFO - 'NO_EM_RESTART': '1', 02:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:36 INFO - 'PWD': '/builds/slave/test', 02:36:36 INFO - 'SHELL': '/bin/bash', 02:36:36 INFO - 'SHLVL': '1', 02:36:36 INFO - 'TERM': 'linux', 02:36:36 INFO - 'TMOUT': '86400', 02:36:36 INFO - 'USER': 'cltbld', 02:36:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:36 INFO - '_': '/tools/buildbot/bin/python'} 02:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:36:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:36:36 INFO - Cleaning up... 02:36:36 INFO - Return code: 0 02:36:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:36:36 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')]} 02:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:36 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')]} 02:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:36:36 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 0x7fcbc3007f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23ca8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2497ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:36:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:36:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:36:36 INFO - Using env: {'DISPLAY': ':0', 02:36:36 INFO - 'HOME': '/home/cltbld', 02:36:36 INFO - 'LANG': 'en_US.UTF-8', 02:36:36 INFO - 'LANGUAGE': 'en_US:en', 02:36:36 INFO - 'LOGNAME': 'cltbld', 02:36:36 INFO - 'MAIL': '/var/mail/cltbld', 02:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:36 INFO - 'MOZ_NO_REMOTE': '1', 02:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:36 INFO - 'NO_EM_RESTART': '1', 02:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:36 INFO - 'PWD': '/builds/slave/test', 02:36:36 INFO - 'SHELL': '/bin/bash', 02:36:36 INFO - 'SHLVL': '1', 02:36:36 INFO - 'TERM': 'linux', 02:36:36 INFO - 'TMOUT': '86400', 02:36:36 INFO - 'USER': 'cltbld', 02:36:36 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:36 INFO - '_': '/tools/buildbot/bin/python'} 02:36:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:36:37 INFO - Cleaning up... 02:36:37 INFO - Return code: 0 02:36:37 INFO - Running post-action listener: _resource_record_post_action 02:36:37 INFO - Running post-action listener: _start_resource_monitoring 02:36:37 INFO - Starting resource monitoring. 02:36:37 INFO - [mozharness: 2016-12-02 10:36:37.170878Z] Finished create-virtualenv step (success) 02:36:37 INFO - [mozharness: 2016-12-02 10:36:37.171334Z] Running install step. 02:36:37 INFO - Running pre-action listener: _resource_record_pre_action 02:36:37 INFO - Running main action method: install 02:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:36:37 INFO - Reading from file tmpfile_stdout 02:36:37 INFO - Detecting whether we're running mozinstall >=1.0... 02:36:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:36:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:36:37 INFO - Reading from file tmpfile_stdout 02:36:37 INFO - Output received: 02:36:37 INFO - Usage: mozinstall [options] installer 02:36:37 INFO - Options: 02:36:37 INFO - -h, --help show this help message and exit 02:36:37 INFO - -d DEST, --destination=DEST 02:36:37 INFO - Directory to install application into. [default: 02:36:37 INFO - "/builds/slave/test"] 02:36:37 INFO - --app=APP Application being installed. [default: firefox] 02:36:37 INFO - mkdir: /builds/slave/test/build/application 02:36:37 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'] 02:36:37 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 02:36:53 INFO - Reading from file tmpfile_stdout 02:36:53 INFO - Output received: 02:36:53 INFO - /builds/slave/test/build/application/firefox/firefox 02:36:53 INFO - Running post-action listener: _resource_record_post_action 02:36:53 INFO - [mozharness: 2016-12-02 10:36:53.384064Z] Finished install step (success) 02:36:53 INFO - [mozharness: 2016-12-02 10:36:53.384306Z] Running run-tests step. 02:36:53 INFO - Running pre-action listener: _resource_record_pre_action 02:36:53 INFO - Running main action method: run_tests 02:36:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:36:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:36:53 INFO - Python 2.7.3 02:36:53 INFO - Return code: 0 02:36:53 INFO - grabbing minidump binary from tooltool 02:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:36:53 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 0x2494f60>, '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 0x2495d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24961d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:36:53 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:36:53 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:36:53 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:36:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:36:53 INFO - Return code: 0 02:36:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:36:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:36:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:36:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:36:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:36:53 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/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:36:53 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/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:36:53 INFO - Using env: {'DISPLAY': ':0', 02:36:53 INFO - 'HOME': '/home/cltbld', 02:36:53 INFO - 'LANG': 'en_US.UTF-8', 02:36:53 INFO - 'LANGUAGE': 'en_US:en', 02:36:53 INFO - 'LOGNAME': 'cltbld', 02:36:53 INFO - 'MAIL': '/var/mail/cltbld', 02:36:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:36:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:36:53 INFO - 'MOZ_NO_REMOTE': '1', 02:36:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:36:53 INFO - 'NO_EM_RESTART': '1', 02:36:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:36:53 INFO - 'PWD': '/builds/slave/test', 02:36:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:36:53 INFO - 'SHELL': '/bin/bash', 02:36:53 INFO - 'SHLVL': '1', 02:36:53 INFO - 'TERM': 'linux', 02:36:53 INFO - 'TMOUT': '86400', 02:36:53 INFO - 'USER': 'cltbld', 02:36:53 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669', 02:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:36:53 INFO - '_': '/tools/buildbot/bin/python'} 02:36:53 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/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:36:53 INFO - mozversion application_buildid: 20161202004006 02:36:53 INFO - mozversion application_changeset: 618770ed4835a5ee8852afc1406754ea6391b2d4 02:36:53 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:36:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:36:53 INFO - mozversion application_name: Firefox 02:36:53 INFO - mozversion application_remotingname: firefox-dev 02:36:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:36:53 INFO - mozversion application_vendor: Mozilla 02:36:53 INFO - mozversion application_version: 52.0a2 02:36:53 INFO - mozversion platform_buildid: 20161202004006 02:36:53 INFO - mozversion platform_changeset: 618770ed4835a5ee8852afc1406754ea6391b2d4 02:36:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:36:53 INFO - mozversion platform_version: 52.0a2 02:36:53 INFO - using testdate: 1480675013 02:36:53 INFO - actual date: 1480675013 02:36:53 INFO - starting webserver on 'localhost:44801' 02:36:53 INFO - SUITE-START | Running 2 tests 02:36:53 INFO - TEST-START | dromaeo_css 02:36:53 INFO - operating with platform_type : linux_ 02:36:53 INFO - Initialising browser for dromaeo_css test... 02:36:53 INFO - TEST-INFO | started process 9205 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp66dwu3/profile http://localhost:44801/getInfo.html) 02:36:58 INFO - PROCESS | 9205 | __metrics Screen width/height:1600/1200 02:36:58 INFO - PROCESS | 9205 | colorDepth:24 02:36:58 INFO - PROCESS | 9205 | Browser inner width/height: 1024/697 02:36:58 INFO - PROCESS | 9205 | __metrics 02:36:58 INFO - PROCESS | 9205 | 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" 02:36:58 INFO - PROCESS | 9205 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:36:59 INFO - PROCESS | 9205 | console.error: PushService: 02:36:59 INFO - PROCESS | 9205 | stateChangeProcessEnqueue: Error transitioning state 02:36:59 INFO - PROCESS | 9205 | UnknownError 02:37:00 INFO - TEST-INFO | 9205: exit 0 02:37:00 INFO - Browser initialized. 02:37:00 INFO - Running cycle 1/1 for dromaeo_css test... 02:37:00 INFO - TEST-INFO | started process 9294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp66dwu3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:37:11 INFO - PROCESS | 9294 | RSS: Main: 144510976 02:37:11 INFO - PROCESS | 9294 | 02:38:03 INFO - PROCESS | 9294 | 1480675083296 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] 02:40:13 INFO - PROCESS | 9294 | Cycle 1(1): loaded http://localhost:44801/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44801/tests/dromaeo/cssquery-ext.html) 02:40:14 INFO - PROCESS | 9294 | RSS: Main: 241102848 02:40:14 INFO - PROCESS | 9294 | 02:43:16 INFO - PROCESS | 9294 | Cycle 1(1): loaded http://localhost:44801/tests/dromaeo/cssquery-ext.html (next: http://localhost:44801/tests/dromaeo/cssquery-jquery.html) 02:43:17 INFO - PROCESS | 9294 | RSS: Main: 233373696 02:43:17 INFO - PROCESS | 9294 | 02:46:19 INFO - PROCESS | 9294 | Cycle 1(1): loaded http://localhost:44801/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44801/tests/dromaeo/cssquery-mootools.html) 02:46:20 INFO - PROCESS | 9294 | RSS: Main: 226566144 02:46:20 INFO - PROCESS | 9294 | 02:49:22 INFO - PROCESS | 9294 | Cycle 1(1): loaded http://localhost:44801/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44801/tests/dromaeo/cssquery-prototype.html) 02:49:22 INFO - PROCESS | 9294 | RSS: Main: 225255424 02:49:22 INFO - PROCESS | 9294 | 02:52:25 INFO - PROCESS | 9294 | Cycle 1(1): loaded http://localhost:44801/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44801/tests/dromaeo/cssquery-yui.html) 02:52:25 INFO - PROCESS | 9294 | RSS: Main: 175308800 02:52:25 INFO - PROCESS | 9294 | 02:55:28 INFO - PROCESS | 9294 | Cycle 1(1): loaded http://localhost:44801/tests/dromaeo/cssquery-yui.html (next: http://localhost:44801/tests/dromaeo/cssquery-dojo.html) 02:55:28 INFO - PROCESS | 9294 | RSS: Main: 267976704 02:55:28 INFO - PROCESS | 9294 | 02:55:28 INFO - PROCESS | 9294 | __start_tp_report 02:55:28 INFO - PROCESS | 9294 | _x_x_mozilla_page_load 02:55:28 INFO - PROCESS | 9294 | _x_x_mozilla_page_load_details 02:55:28 INFO - PROCESS | 9294 | |i|pagename|runs| 02:55:28 INFO - PROCESS | 9294 | |0;dojo.html;3143.654198038216;3178.6821317868207;3182.5385319128713;3206.9679303206963;3229.160418291245;5404.054290499162;5472.616916815825;5482.479164479373;5484.780608775649;5486.725663716808;5488.313960754906;5520.889582208353;5524.889502209953;5530.861728456791;5540.252065971093;4974.676646018006;5001.8499445016705;5036.269740887569;5067.417247016585;5108.489151084899;4896.534829191221;5035.395752509704;5086.440491545927;5094.566961808232;5095.414027386861;4877.365942427479;4928.5564299213065;4969.478204788499;5015.047141043208;5027.396712394518;4964.528369804862;5000.849974500771;5007.399112106534;5057.645964782467;5080.49195080489;4977.576905962997;4982.476839931791;5012.699238045692;5032.823851165228;5033.647644664875;5290.867728306785;5337.092694241988;5373.247745315659;5390.272313237702;5392.083345831179;5756.309242890838;5780.797672081457;5792.189093526909;5867.677277749722;5868.735906884158;5897.380775018604;5897.380775018647;5916.349201587822;5923.496502797224;5930.7034648267845;5385.649932754398;5412.648177868426;5440.782368705247;5464.207689884945;5469.726513674301;5967.880642387128;5988.730507127189;5996.550258730613;5997.310309314485;5997.520198384206;5776.68228247442;5777.88444231113;5783.71081445926;5789.9710501447225;5801.245838041028;5629.634073785191;5666;5757.136429535603;5825.796097136665;5826.533877289807;5808.39011903744;5809.506191973645;5814.30228372598;5833.445822646841;5846.824595262064;5750.108733146369;5798.478136967693;5801.245838041028;5801.361850196475;5812;4477.283634618446;4502.257127573979;4524.072565124142;4531.909361812745;4534.977325113419;4032.8991775205855;4079.4696689430184;4094.2630326541507;4094.4267802507675;4110.157417729359;5616.241807356037;5653.745581448845;5656.236408084856;5658.122990936411;5658.321001479849;5802.564807639444;5862.384449632812;5872.7357268923;5932.911006334908;5936.881262374728;5457.345118585716;5482.122860342406;5494.038543254915;5546.084895992116;5578.86052848682;5018.949810501921;5025.346704928336;5027.84916452507;5033.2701758245585;5044.520770526794;5964.045752679724;6012.729427175875;6057.061155520902;6075.878482430415;6077.939220607737;5740.770369185186;5798.159266906359;5814.04068328738;5867.471927526543;5954.7320370582565;6140.846478838065;6156.107364432221;6163.044728067157;6163.3836616338;6165.691715414301;5809.651420914759;5809.883802323845;5811.56413268998;5811.709414529341;5821.359650438533;5776.075827867521;5836.620619659709;5843.561732870136;5864.706764661835;5879.029960056543;5804.738786754522;5805.854853628524;5811.244538210006;5813.76744930198;5832.562557808096;5738.110592858114;5745.971270143623;5807.245058142415;5811.651300921789;5816.127580862904;5565.666060036411;5593.993081245415;5602.663840169603;5627.212190293444;5636.5208957237455;5750.079987202028;5751.884962300647;5757.769689212385;5761.683107428964;5772.365039845529;5503.532199762904;5629.6903670298525;5644.3508996465935;5647.407022262603;5649.4633009864 02:55:28 INFO - PROCESS | 9294 | |1;ext.html;582.7494177503672;604.5858586867994;619.7459041792864;638.3999040901555;639.0318667219167;33263.50104748428;33819.15452113695;36100.99999999996;44753.104937901306;45638.543614563845;47001.529984700144;47494.287585686245;47495;47506.287405688854;47521.76239118808;8804.383693141466;8933.508657023862;8938.1508756668;8939.284857211407;8939.597718102668;8251.876221856646;8441.57792110392;8449.915500844974;8832.160944710242;10485.318454300446;10530.262881598253;10858.402787846666;10863.945680271627;10869.728256793564;10873.565057397695;10617.256792024562;10631.255812093157;10692.091172250368;10700.892991070106;10703.036726694634;10602.840957385646;10633.361998280128;10661;10667.306625069346;10682.946585267024;43817.561824381664;43873.34189987153;44244.778776106235;44260;44311;3701.796401197933;3791.9241615167543;3822.503074600284;4199.454070970784;4400.427944367212;33421.498677519856;33578.32843343144;33599.32801343984;33739;33832;4496.797644106023;4504.166729155117;4566.680332376735;4568.771561421916;4727.739974301412;359222;360956;361094;361870;363023;37399.62600374016;63665;64002;64067;64096;36758.63241367552;39778;39872.60127398689;39888.40167397491;39888.40167397491;14104.224267665171;14147.22190279524;14197.716045679028;14200.715985680228;14217.360218789972;12195.268283902995;12283.078769092353;12296.938515307365;12324.445399957023;12324.938375308066;8676.69631562905;8805.69180078694;9226.81546369069;9233.584488698025;9298.86051709225;3598.712103031751;3605.7115430765475;3625.564932208099;3629.129009037812;3666.6883314917995;1069.1233188785122;1110.228391268077;1132.2074547816562;1140.7205234717546;1163.8952494275557;34472;34569;34606.480902786476;34820.65179348174;34849;1134.126722423729;1144.988550114505;1147.05941128274;1156.525824411987;1196.9640910772691;17918.462446126636;17929.910350448426;17980.370687026152;18035.639287214446;18108.456746297634;167019;167920;168777.15611422108;168951;169085.15457422636;61774;62428;62645.37354626395;62683;62742.68628656828;1291.6318849127954;1327.3429652322163;1340.7921772125337;1420.609332433589;1421.076300404745;30065.849670751508;36823;37049;37339.6266037347;37384.252314954094;58890.705546471996;59137;59587;59704;59737.103943440015;453483;456078;456288;457177;458757;30754.077377678706;31323.843380783863;46352.536474636174;48243;50582;43267;54346.18480722713;55274.170887437525;57044.714776425855;57714.42285577259;44824.32763508615;45570.54429455663;45999;46517.06965860732;47313.053738925715;43924.780376097915;44815.55184448114;45403.77298113488;45636.31545526753;46998.29502557533;45369.319460207465;45988.08023839571;46436.53563464322;46664.30003550017;46718.53281467142;38452.80773596114;40434.79782601068;40472.1905561893;40581;41206.587934120274;30221.697783022766;30463.847680761453;30495.237619059702;30724.385512290075;30899.536506951965 02:55:28 INFO - PROCESS | 9294 | |2;jquery.html;411.61925219172275;418.0906528300945;422.82030137191686;429.96775241856847;432.25436122688365;18534.814651853478;19452.221911123557;20102.095405706743;20198;20408.693869591967;19647.90176049121;19743;19904.60190796183;20353.38939831804;20449.59100817983;5558.666480011192;5857.062869940811;5859.560532960024;5861.150133230679;5863.208466856962;5621.943780562204;5775.27809023872;5808.186853840466;5814.5057670098095;5857;5779.306483222019;5783.074708046714;5786.884262314772;5787.739551720183;5788.681622510781;5580.358258800229;5691.630044047124;5775.711214439282;5785;5793.13103034544;5213.426523082458;5224.346956630421;5224.50367215114;5225.242339860737;5227.895442091175;23625;23718.169864054675;23773.762262377502;23782.64326035111;23964.64053039206;2461.9876900615563;2535.4802265535523;2537.4037101281183;2573.4853029394008;3083.7378822800088;14090.577282681434;14815.777763333559;15439.536813895602;15555.22223888801;15755.369785208577;1947.9707804382945;1963.391348681913;1963.890401922909;2012.7584689837167;2027.7465316835396;59354;75849.62075189644;78918.60540697318;82022.58988705078;87705.12294877034;10578.418186999788;10593.523291451904;11164.832527511931;11300.660980170607;11433.428328583537;16161.59596010109;16181.11003894797;16195.109268990318;16197.433089842034;16209.35162593483;8287.212714792086;8463.957680211559;8560.657573696983;8654.82690346202;8728.607212675444;8227.13615070421;8300.958495207486;8338.166183381612;8451.830963380698;8480.10958849312;6831.146106736658;6843.418309443654;6853.17761868579;6973.616451095137;7032.156141263081;1947.8052194780691;2010.959780804405;2048.989755051245;2064.5251592133895;2072.637288474511;968.6900191938512;994.4232345239743;1004.382304882492;1005.3264312910368;1050.5115121468555;20241.89879050625;20265;20660.276890308767;21083.262085826922;21144.365669029645;980.6077568972325;1002.6691191906654;1019.4444028004755;1029.2229366827996;1046.3251202974038;10575;11340.886591134147;11390.65828025144;11396.715082122848;11432.714182145346;454436;477353;480729;482029;483295;72121.6393918027;75893.62053189699;94018.52990735002;95745;96756.51621741986;1021.4331046269243;1049.459528342904;1076.3380520979697;1112.6662001399548;1116.3748300951493;17970.281188752302;18147.909260453613;18380.448586542425;18498.722519161955;19041.143148558072;40088.198236034536;43397.349039763794;44309.33535996898;44390.77804610956;45682.771586141855;50351;57137;58383.12425313709;58513.70743146257;59987.40012599818;8731.301495880187;8925.955370223108;9006.504642244478;9012.54937253148;9505.477198754135;9506.429614223169;12964.28696421668;13930.79103813464;14027.579172624837;14045.438182472586;11890.702732431759;11978.101642376681;12071.155019148926;12190.329531875832;12283.85032619306;5416.0521908666615;9861.372873475797;11895.226810257305;11996;12124.27254364741;11880.881191187977;11919.52321907114;12203.267803931793;12235.265884046985;12238.694032648898;8566.100559441169;8853.822923541364;8857.291416686778;9002.874640669916;9142.131497507726;9474.85787713171;11500.309981400807;11644.35956022427;11995.64013079609;11997.100217483898 02:55:28 INFO - PROCESS | 9294 | |3;mootools.html;1494.7234761569107;1530.341952960227;1654.6856097341504;1711.4523352527196;1770.7963584187814;8304.128066553016;8851.645934162625;8859.55702214889;8860.46837189769;8862.158094980983;7645.082590089183;7846.607669616511;8289;8521.19048690375;8696.956515217431;2455.5211733711935;2478.157426474998;2479.876006199692;2482.8262021658493;2488.552060629095;2428.7449817769143;2526.87554038453;2527.443962328294;2528.936776580582;2532.11376018393;2427.5023620157826;2439.6706444630013;2492.800575953919;2498.57524220882;2504.611785173301;2373.774491423312;2385.60637494814;2407.4703565215623;2434.720007199177;2444.4255599934;2385.0459816073535;2409.8072154227793;2430.1008626808016;2431.2098567965304;2436.987815060931;8721.825563488757;8775.47347159166;8817.29461643067;8847.557622118868;8877.422967507091;5394.7842086316505;5549.916751248694;5556.388797232301;5557.41647127054;5557.694326812024;3489.668481494254;3497.667721566447;3525.964740352615;3570.6607872252353;3672.3022625701033;1210.056156198167;1221.5907670930249;1254.8180513825534;1268.0489632775418;1284.2808027504627;12103.152779305452;12171.087168462313;12175.208611440228;12179.39103044853;12211.572594959134;4693.388654268877;4842.080004799077;4854.368932038812;4898.657094003457;4997.125503036954;10289.897101029044;10295.43375114361;10295.691129266133;10300.22748293881;10308.175345972304;5529.557635389159;5615.298087739033;5622.409646987007;5624.3250809903075;5624.718764061862;4504.617107545895;4678.789454474557;4975.950240497548;5044.4198917125;5119.923201151985;3939.8227079781477;4025.295573274665;4034.0318323602123;4113.526944401372;4118.711690181659;1414.7877818327333;1419.176877411099;1420.6803469219342;1430.7281616492833;1438.5971927860217;945.6548359848606;996.566493575297;1001.1490233301636;1013.1034034879185;1022.7340891368298;6064.575479716377;6114.449699526975;6123.663198524035;6173.703522260286;6314.0844577536;959.3332633819568;966.4249771386154;991.2714155095998;1005.4017859373661;1023.2632504596678;4019.256437559061;4316.115196384733;4327.870163895025;4341.5007274163245;4356.128774245164;10377.16982641402;10625.893741062491;10688.198385121146;10703.625373111903;10711.196660250356;10684.626038088785;10691.839622405514;10692.198085143646;10706.785864282827;10713.517891694892;7801.687932482637;7890.921090789018;7983.441159118922;8039.196080391914;8224.38317126218;5956.583039187215;6032.125341825323;6050.122732203894;6090.878182436415;6103.176071230327;9609.471479068718;9639.469829159463;9659.32384733062;9748.561314740711;9752.853707194256;9682.370645907993;9940.155086817413;9960.601575936882;10160.644377446753;10176.592936282466;6998.195207551197;7146.32109949554;7230;7290.088738907637;7549.320561149523;8398.454100483448;8705.825883482421;8707.172818582225;8708.825823483368;8720.345974051845;7649.541027538366;7696.307332340116;7753.65108570127;7836.09884863248;7848.058233012075;7612.276833700789;7622.885656715042;7634.580098094658;7673.347765439777;7731.458797884094;6998.230194678683;7187;7199.748008819666;7281.162666293444;7288;5203.401608815035;5206.349206349207;5251.579873610026;5276.683398996072;5278.4721527846905;5285.207218917193;5420.430854760193;5455.208994695826;5499.670019798825;5534.612577119563 02:55:28 INFO - PROCESS | 9294 | |4;prototype.html;349.1132523390588;351.3973535386811;359.03061733320044;359.5092698466592;360.46470990579;5396.892062158754;5412.485813847683;5420.403755586883;5430.511253987145;5434.483724046219;5099.169960671826;5148.304978827857;5181.378234611842;5225.8954820903555;5294.126469132598;4171.416001759756;4221.852235171769;4239.173361194553;4245.936310955338;4252.80862361193;4224.8664424465605;4252.532221455653;4252.766097864616;4257.297545904922;4266.338717498793;4073.490813648294;4186.267403204442;4205.179989901971;4225.535191128974;4228.703990720651;4173.4157217989505;4193.601607847249;4213.5786421357925;4224.809883555232;4227.239096962546;3751.8499260029566;3776.3580191367532;3781.6785573226307;3784.583695793488;3786.2995345861104;5005.324281222025;5186.662866913639;5210.452902445227;5212;5247.947520524784;4856.660033797635;4862.489438608931;4867.4889136640495;4876.561109500162;4883.560479556857;5574.2441131044;5579.972100139514;5606.579506536985;5609.775608975636;5634.295713035871;3967.583403742623;4063.7764922929227;4130.669546436278;4191.413202151702;4195.202911446815;5733.971330143323;5809.647092927329;5818.476337129637;5823.621464604787;5826.563007774434;4171.144915292358;4214.3889136075095;4216.8313267469575;4222.9577704222565;4231.597998190167;4197.4753155855515;4262.6376757975295;4298.527162012176;4298.871033868989;4314.503832059353;4796.9760151199025;4810.807567697323;4812.783424745895;4832.540908613676;4846.29728689338;5586.217929489874;5587.469190426903;5592.580556458201;5638.464345887134;5638.718064096779;1363.2093385836192;1397.3083323754604;1433.6129245103764;1459.168274083762;1464.2020099046044;1007.7228762090338;1008.9154159278804;1024.4621573673733;1030.644427672452;1032.5405194688292;5245.895082098413;5252.422233554306;5263.6841789492755;5282.577393808486;5286.656367336111;5508.614396992172;5527.834164975057;5529.364123125812;5535.308086489189;5535.861603459945;5053.5957123430035;5240.34495688039;5254.842354729364;5278.9208161877605;5287.576993840484;2905.709429057077;2909.898153564615;2915.2566095645475;2916.927076823054;2943.3524624582556;5725.227094342294;5733.627314224562;5759.539236861041;5773.845230953826;5822.719001819593;5305.893882122413;5507.862303442446;5539.750711218005;5586.776528938878;5593.4617980055;5750.281214848144;5760.164776107441;5765.423457654201;5800;5804.767809287581;5497.972510137423;5505.229267902417;5507.504324610804;5539.58453116026;5561.972190139023;5728.885422291448;5732.936142988604;5744.971275143765;5745.885082298247;5758.733078722675;6034.758609655564;6068.9089663654195;6078.361772014052;6080.787172448943;6082.422169893853;4103.768869339246;4175.728577642565;4191.706580539333;4193.266178418704;4213.756941702267;5761.683107429131;5772.892894093542;5782.971085144547;5795.275590551181;5825.242718446744;5360.490753378423;5492.890142197213;5555.2778138841695;5559.305086864142;5573.609847310811;5470.316210473691;5594.440555944373;5637.210790489253;5666.093425051972;5686.374498805211;5329.947970031488;5520.944790552043;5568.443155684561;5608.2148499209325;5629.380768115422;5700.287464066992;5704.201411802268;5704.486596206361;5706.828795136153;5717.656940583578;5562.415946325739;5577.693226872561;5585.357683866408;5616.410276921028;5628.240187574625 02:55:28 INFO - PROCESS | 9294 | |5;yui.html;740.7814694665074;758.9468737188397;767.8118860879082;768.7539987204093;775.0234704272618;15171.08973461593;15348.539543813675;15352.385904563833;15367.69264614707;15416.845831541696;13985.720285594307;14383.712325753504;14388.352524136413;14404.495842645509;14411.783823242633;699.7655785311902;710.8578284343126;804.4610111225463;825.6160885188386;830.7923019245188;832.567065126134;835.5279267214034;835.6657337065162;835.7826964989085;836.1471299274737;891.3270480786997;891.5720454181965;892.2014796756898;893.2675206330812;893.4728510178993;739.6930273936337;757.3827330725496;843.2158092973532;866.5060915278294;888.8533391990314;636.6816591704148;637.8564822914853;641.2305233719555;641.7208514296296;642.3383914567955;14051.508197213048;14102.294885255696;14102.576922692335;14145.363458644282;14148.92925535376;13142.540011099565;13527.188368697909;13830.23933683647;13865.930670346685;14031.859681403157;12878.678033049155;13004;13069.281189534571;13098.803517947239;13107;3791.4312853071983;3958.7228893977435;3961.980190099031;3980.601939805996;4055.858044968412;56104.438955610734;62469.68765156191;62684.37315626831;62880.37119628837;62926.68536657288;11274.718132046764;11300.378479183559;11319.603813866475;11372.943135284271;11510.482028308747;18573.071346432625;18712.625747485246;18793.624127517647;18827.81172188288;18891.716624250646;8445.408821382567;8484;8495;8526.531040792815;8561.272291855137;4438.533953934855;4452.799624016927;4604.700694454849;4702.059588082398;4730.337752714623;3471.062813040465;3574.3566158091794;3581.7134629230122;3596.496490491333;3655.8484077515495;628.4752231886426;634.3149398649448;634.4416913116428;638.7955854126635;645.95155363347;668.4585485756553;679.3953381490477;698.0611078099947;708.922018577956;764.9158592554815;9190.448573085636;9215.631374744935;9415.340926135243;9597.520123993772;9719.951400242953;687.848673291875;699.5452955578914;779.4660657449665;779.7855589712874;785.8271180340316;4642.675012749075;4655.557722016403;4701.3888194535175;4723.622110231173;4749.738764367993;54975;66271.00593491101;79642.60178699186;89737.55131224303;95985.52007239919;50535.49464505308;56595.434045659014;79354.6032269835;82247.588762057;85383.57308213419;70895.64552177206;73279.63360183059;73760;74148.62925685337;75509.24490755131;9161.77095572616;9186.265098791948;9308.255339572683;9344.859827102735;9346.719598412059;47061.05877882492;48569.54686517695;48876;49528.25707614316;50572.49427505678;61324.38675613187;66704.6664766673;67884.6605766968;68629.65685171542;69002;11606.76786464249;12073.939630301793;12112.273263604213;12164.817527737268;12294.077944154404;13232.40454179545;13402.655702211963;13432.39554220043;13472.720091591284;13588.524401645895;11768;12204.87795122073;12423.937880310541;12640;12698.619041428772;11952.820707689218;11979.700507487383;12347.814782778087;12350.81473777876;12413.627591172279;11589.188756787282;11727.824082638597;11839.58561450345;11899.940500297444;11922.821157682469;9566.952165239407;9641.469719165514;9958.302918795614;10146.949265253626;10195.176808696739;9554.140127388568;9767.9023209767;9823.165030972448;9838.36050656705;10022.749431264278 02:55:28 INFO - PROCESS | 9294 | __end_tp_report 02:55:28 INFO - PROCESS | 9294 | __start_cc_report 02:55:28 INFO - PROCESS | 9294 | _x_x_mozilla_cycle_collect,1029 02:55:28 INFO - PROCESS | 9294 | __end_cc_report 02:55:28 INFO - PROCESS | 9294 | __startTimestamp1480676128486__endTimestamp 02:55:28 INFO - PROCESS | 9294 | 02:55:28 INFO - PROCESS | 9294 | ------- Summary: start ------- 02:55:28 INFO - PROCESS | 9294 | Number of tests: 6 02:55:28 INFO - PROCESS | 9294 | 02:55:28 INFO - PROCESS | 9294 | [#0] dojo.html Cycles:165 Average:5449.25 Median:5653.75 stddev:605.90 (10.7%) stddev-sans-first:580.13 02:55:28 INFO - PROCESS | 9294 | Values: 3143.7 3178.7 3182.5 3207.0 3229.2 5404.1 5472.6 5482.5 5484.8 5486.7 5488.3 5520.9 5524.9 5530.9 5540.3 4974.7 5001.8 5036.3 5067.4 5108.5 4896.5 5035.4 5086.4 5094.6 5095.4 4877.4 4928.6 4969.5 5015.0 5027.4 4964.5 5000.8 5007.4 5057.6 5080.5 4977.6 4982.5 5012.7 5032.8 5033.6 5290.9 5337.1 5373.2 5390.3 5392.1 5756.3 5780.8 5792.2 5867.7 5868.7 5897.4 5897.4 5916.3 5923.5 5930.7 5385.6 5412.6 5440.8 5464.2 5469.7 5967.9 5988.7 5996.6 5997.3 5997.5 5776.7 5777.9 5783.7 5790.0 5801.2 5629.6 5666.0 5757.1 5825.8 5826.5 5808.4 5809.5 5814.3 5833.4 5846.8 5750.1 5798.5 5801.2 5801.4 5812.0 4477.3 4502.3 4524.1 4531.9 4535.0 4032.9 4079.5 4094.3 4094.4 4110.2 5616.2 5653.7 5656.2 5658.1 5658.3 5802.6 5862.4 5872.7 5932.9 5936.9 5457.3 5482.1 5494.0 5546.1 5578.9 5018.9 5025.3 5027.8 5033.3 5044.5 5964.0 6012.7 6057.1 6075.9 6077.9 5740.8 5798.2 5814.0 5867.5 5954.7 6140.8 6156.1 6163.0 6163.4 6165.7 5809.7 5809.9 5811.6 5811.7 5821.4 5776.1 5836.6 5843.6 5864.7 5879.0 5804.7 5805.9 5811.2 5813.8 5832.6 5738.1 5746.0 5807.2 5811.7 5816.1 5565.7 5594.0 5602.7 5627.2 5636.5 5750.1 5751.9 5757.8 5761.7 5772.4 5503.5 5629.7 5644.4 5647.4 5649.5 02:55:28 INFO - PROCESS | 9294 | 02:55:28 INFO - PROCESS | 9294 | [#1] ext.html Cycles:180 Average:51755.70 Median:21137.66 stddev:92663.68 (438.4%) stddev-sans-first:92843.97 02:55:28 INFO - PROCESS | 9294 | Values: 582.7 604.6 619.7 638.4 639.0 33263.5 33819.2 36101.0 44753.1 45638.5 47001.5 47494.3 47495.0 47506.3 47521.8 8804.4 8933.5 8938.2 8939.3 8939.6 8251.9 8441.6 8449.9 8832.2 10485.3 10530.3 10858.4 10863.9 10869.7 10873.6 10617.3 10631.3 10692.1 10700.9 10703.0 10602.8 10633.4 10661.0 10667.3 10682.9 43817.6 43873.3 44244.8 44260.0 44311.0 3701.8 3791.9 3822.5 4199.5 4400.4 33421.5 33578.3 33599.3 33739.0 33832.0 4496.8 4504.2 4566.7 4568.8 4727.7 359222.0 360956.0 361094.0 361870.0 363023.0 37399.6 63665.0 64002.0 64067.0 64096.0 36758.6 39778.0 39872.6 39888.4 39888.4 14104.2 14147.2 14197.7 14200.7 14217.4 12195.3 12283.1 12296.9 12324.4 12324.9 8676.7 8805.7 9226.8 9233.6 9298.9 3598.7 3605.7 3625.6 3629.1 3666.7 1069.1 1110.2 1132.2 1140.7 1163.9 34472.0 34569.0 34606.5 34820.7 34849.0 1134.1 1145.0 1147.1 1156.5 1197.0 17918.5 17929.9 17980.4 18035.6 18108.5 167019.0 167920.0 168777.2 168951.0 169085.2 61774.0 62428.0 62645.4 62683.0 62742.7 1291.6 1327.3 1340.8 1420.6 1421.1 30065.8 36823.0 37049.0 37339.6 37384.3 58890.7 59137.0 59587.0 59704.0 59737.1 453483.0 456078.0 456288.0 457177.0 458757.0 30754.1 31323.8 46352.5 48243.0 50582.0 43267.0 54346.2 55274.2 57044.7 57714.4 44824.3 45570.5 45999.0 46517.1 47313.1 43924.8 44815.6 45403.8 45636.3 46998.3 45369.3 45988.1 46436.5 46664.3 46718.5 38452.8 40434.8 40472.2 40581.0 41206.6 30221.7 30463.8 30495.2 30724.4 30899.5 02:55:28 INFO - PROCESS | 9294 | 02:55:28 INFO - PROCESS | 9294 | [#2] jquery.html Cycles:180 Average:28742.55 Median:2555.44 stddev:78290.73 (3063.7%) stddev-sans-first:78481.45 02:55:28 INFO - PROCESS | 9294 | Values: 411.6 418.1 422.8 430.0 432.3 18534.8 19452.2 20102.1 20198.0 20408.7 19647.9 19743.0 19904.6 20353.4 20449.6 5558.7 5857.1 5859.6 5861.2 5863.2 5621.9 5775.3 5808.2 5814.5 5857.0 5779.3 5783.1 5786.9 5787.7 5788.7 5580.4 5691.6 5775.7 5785.0 5793.1 5213.4 5224.3 5224.5 5225.2 5227.9 23625.0 23718.2 23773.8 23782.6 23964.6 2462.0 2535.5 2537.4 2573.5 3083.7 14090.6 14815.8 15439.5 15555.2 15755.4 1948.0 1963.4 1963.9 2012.8 2027.7 59354.0 75849.6 78918.6 82022.6 87705.1 10578.4 10593.5 11164.8 11300.7 11433.4 16161.6 16181.1 16195.1 16197.4 16209.4 8287.2 8464.0 8560.7 8654.8 8728.6 8227.1 8301.0 8338.2 8451.8 8480.1 6831.1 6843.4 6853.2 6973.6 7032.2 1947.8 2011.0 2049.0 2064.5 2072.6 968.7 994.4 1004.4 1005.3 1050.5 20241.9 20265.0 20660.3 21083.3 21144.4 980.6 1002.7 1019.4 1029.2 1046.3 10575.0 11340.9 11390.7 11396.7 11432.7 454436.0 477353.0 480729.0 482029.0 483295.0 72121.6 75893.6 94018.5 95745.0 96756.5 1021.4 1049.5 1076.3 1112.7 1116.4 17970.3 18147.9 18380.4 18498.7 19041.1 40088.2 43397.3 44309.3 44390.8 45682.8 50351.0 57137.0 58383.1 58513.7 59987.4 8731.3 8926.0 9006.5 9012.5 9505.5 9506.4 12964.3 13930.8 14027.6 14045.4 11890.7 11978.1 12071.2 12190.3 12283.9 5416.1 9861.4 11895.2 11996.0 12124.3 11880.9 11919.5 12203.3 12235.3 12238.7 8566.1 8853.8 8857.3 9002.9 9142.1 9474.9 11500.3 11644.4 11995.6 11997.1 02:55:28 INFO - PROCESS | 9294 | 02:55:28 INFO - PROCESS | 9294 | [#3] mootools.html Cycles:180 Average:5829.69 Median:5082.17 stddev:3175.64 (62.5%) stddev-sans-first:3167.83 02:55:28 INFO - PROCESS | 9294 | Values: 1494.7 1530.3 1654.7 1711.5 1770.8 8304.1 8851.6 8859.6 8860.5 8862.2 7645.1 7846.6 8289.0 8521.2 8697.0 2455.5 2478.2 2479.9 2482.8 2488.6 2428.7 2526.9 2527.4 2528.9 2532.1 2427.5 2439.7 2492.8 2498.6 2504.6 2373.8 2385.6 2407.5 2434.7 2444.4 2385.0 2409.8 2430.1 2431.2 2437.0 8721.8 8775.5 8817.3 8847.6 8877.4 5394.8 5549.9 5556.4 5557.4 5557.7 3489.7 3497.7 3526.0 3570.7 3672.3 1210.1 1221.6 1254.8 1268.0 1284.3 12103.2 12171.1 12175.2 12179.4 12211.6 4693.4 4842.1 4854.4 4898.7 4997.1 10289.9 10295.4 10295.7 10300.2 10308.2 5529.6 5615.3 5622.4 5624.3 5624.7 4504.6 4678.8 4976.0 5044.4 5119.9 3939.8 4025.3 4034.0 4113.5 4118.7 1414.8 1419.2 1420.7 1430.7 1438.6 945.7 996.6 1001.1 1013.1 1022.7 6064.6 6114.4 6123.7 6173.7 6314.1 959.3 966.4 991.3 1005.4 1023.3 4019.3 4316.1 4327.9 4341.5 4356.1 10377.2 10625.9 10688.2 10703.6 10711.2 10684.6 10691.8 10692.2 10706.8 10713.5 7801.7 7890.9 7983.4 8039.2 8224.4 5956.6 6032.1 6050.1 6090.9 6103.2 9609.5 9639.5 9659.3 9748.6 9752.9 9682.4 9940.2 9960.6 10160.6 10176.6 6998.2 7146.3 7230.0 7290.1 7549.3 8398.5 8705.8 8707.2 8708.8 8720.3 7649.5 7696.3 7753.7 7836.1 7848.1 7612.3 7622.9 7634.6 7673.3 7731.5 6998.2 7187.0 7199.7 7281.2 7288.0 5203.4 5206.3 5251.6 5276.7 5278.5 5285.2 5420.4 5455.2 5499.7 5534.6 02:55:28 INFO - PROCESS | 9294 | 02:55:28 INFO - PROCESS | 9294 | [#4] prototype.html Cycles:180 Average:4715.31 Median:5280.75 stddev:1359.03 (25.7%) stddev-sans-first:1322.74 02:55:28 INFO - PROCESS | 9294 | Values: 349.1 351.4 359.0 359.5 360.5 5396.9 5412.5 5420.4 5430.5 5434.5 5099.2 5148.3 5181.4 5225.9 5294.1 4171.4 4221.9 4239.2 4245.9 4252.8 4224.9 4252.5 4252.8 4257.3 4266.3 4073.5 4186.3 4205.2 4225.5 4228.7 4173.4 4193.6 4213.6 4224.8 4227.2 3751.8 3776.4 3781.7 3784.6 3786.3 5005.3 5186.7 5210.5 5212.0 5247.9 4856.7 4862.5 4867.5 4876.6 4883.6 5574.2 5580.0 5606.6 5609.8 5634.3 3967.6 4063.8 4130.7 4191.4 4195.2 5734.0 5809.6 5818.5 5823.6 5826.6 4171.1 4214.4 4216.8 4223.0 4231.6 4197.5 4262.6 4298.5 4298.9 4314.5 4797.0 4810.8 4812.8 4832.5 4846.3 5586.2 5587.5 5592.6 5638.5 5638.7 1363.2 1397.3 1433.6 1459.2 1464.2 1007.7 1008.9 1024.5 1030.6 1032.5 5245.9 5252.4 5263.7 5282.6 5286.7 5508.6 5527.8 5529.4 5535.3 5535.9 5053.6 5240.3 5254.8 5278.9 5287.6 2905.7 2909.9 2915.3 2916.9 2943.4 5725.2 5733.6 5759.5 5773.8 5822.7 5305.9 5507.9 5539.8 5586.8 5593.5 5750.3 5760.2 5765.4 5800.0 5804.8 5498.0 5505.2 5507.5 5539.6 5562.0 5728.9 5732.9 5745.0 5745.9 5758.7 6034.8 6068.9 6078.4 6080.8 6082.4 4103.8 4175.7 4191.7 4193.3 4213.8 5761.7 5772.9 5783.0 5795.3 5825.2 5360.5 5492.9 5555.3 5559.3 5573.6 5470.3 5594.4 5637.2 5666.1 5686.4 5329.9 5520.9 5568.4 5608.2 5629.4 5700.3 5704.2 5704.5 5706.8 5717.7 5562.4 5577.7 5585.4 5616.4 5628.2 02:55:28 INFO - PROCESS | 9294 | 02:55:28 INFO - PROCESS | 9294 | [#5] yui.html Cycles:180 Average:17545.49 Median:56349.94 stddev:23124.64 (41.0%) stddev-sans-first:23155.08 02:55:28 INFO - PROCESS | 9294 | Values: 740.8 758.9 767.8 768.8 775.0 15171.1 15348.5 15352.4 15367.7 15416.8 13985.7 14383.7 14388.4 14404.5 14411.8 699.8 710.9 804.5 825.6 830.8 832.6 835.5 835.7 835.8 836.1 891.3 891.6 892.2 893.3 893.5 739.7 757.4 843.2 866.5 888.9 636.7 637.9 641.2 641.7 642.3 14051.5 14102.3 14102.6 14145.4 14148.9 13142.5 13527.2 13830.2 13865.9 14031.9 12878.7 13004.0 13069.3 13098.8 13107.0 3791.4 3958.7 3962.0 3980.6 4055.9 56104.4 62469.7 62684.4 62880.4 62926.7 11274.7 11300.4 11319.6 11372.9 11510.5 18573.1 18712.6 18793.6 18827.8 18891.7 8445.4 8484.0 8495.0 8526.5 8561.3 4438.5 4452.8 4604.7 4702.1 4730.3 3471.1 3574.4 3581.7 3596.5 3655.8 628.5 634.3 634.4 638.8 646.0 668.5 679.4 698.1 708.9 764.9 9190.4 9215.6 9415.3 9597.5 9720.0 687.8 699.5 779.5 779.8 785.8 4642.7 4655.6 4701.4 4723.6 4749.7 54975.0 66271.0 79642.6 89737.6 95985.5 50535.5 56595.4 79354.6 82247.6 85383.6 70895.6 73279.6 73760.0 74148.6 75509.2 9161.8 9186.3 9308.3 9344.9 9346.7 47061.1 48569.5 48876.0 49528.3 50572.5 61324.4 66704.7 67884.7 68629.7 69002.0 11606.8 12073.9 12112.3 12164.8 12294.1 13232.4 13402.7 13432.4 13472.7 13588.5 11768.0 12204.9 12423.9 12640.0 12698.6 11952.8 11979.7 12347.8 12350.8 12413.6 11589.2 11727.8 11839.6 11899.9 11922.8 9567.0 9641.5 9958.3 10146.9 10195.2 9554.1 9767.9 9823.2 9838.4 10022.7 02:55:28 INFO - PROCESS | 9294 | -------- Summary: end -------- 02:55:28 INFO - PROCESS | 9294 | 02:55:29 INFO - TEST-INFO | 9294: exit 0 02:55:29 INFO - TEST-OK | dromaeo_css | took 1115620ms 02:55:29 INFO - TEST-START | kraken 02:55:29 INFO - operating with platform_type : linux_ 02:55:29 INFO - Initialising browser for kraken test... 02:55:29 INFO - TEST-INFO | started process 9612 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4oPL4Q/profile http://localhost:44801/getInfo.html) 02:55:33 INFO - PROCESS | 9612 | __metrics Screen width/height:1600/1200 02:55:33 INFO - PROCESS | 9612 | colorDepth:24 02:55:33 INFO - PROCESS | 9612 | Browser inner width/height: 1024/697 02:55:33 INFO - PROCESS | 9612 | __metrics 02:55:34 INFO - PROCESS | 9612 | 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" 02:55:34 INFO - PROCESS | 9612 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:55:34 INFO - PROCESS | 9612 | console.error: PushService: 02:55:34 INFO - PROCESS | 9612 | stateChangeProcessEnqueue: Error transitioning state 02:55:34 INFO - PROCESS | 9612 | UnknownError 02:55:35 INFO - TEST-INFO | 9612: exit 0 02:55:35 INFO - Browser initialized. 02:55:35 INFO - Running cycle 1/1 for kraken test... 02:55:35 INFO - TEST-INFO | started process 9703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4oPL4Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:55:47 INFO - PROCESS | 9703 | RSS: Main: 144859136 02:55:47 INFO - PROCESS | 9703 | 02:55:49 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44801/tests/kraken/driver.html?testName=audio-beat-detection) 02:55:50 INFO - PROCESS | 9703 | RSS: Main: 186241024 02:55:50 INFO - PROCESS | 9703 | 02:55:53 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44801/tests/kraken/driver.html?testName=audio-dft) 02:55:53 INFO - PROCESS | 9703 | RSS: Main: 175697920 02:55:53 INFO - PROCESS | 9703 | 02:55:56 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44801/tests/kraken/driver.html?testName=audio-fft) 02:55:57 INFO - PROCESS | 9703 | RSS: Main: 267100160 02:55:57 INFO - PROCESS | 9703 | 02:55:59 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44801/tests/kraken/driver.html?testName=audio-oscillator) 02:55:59 INFO - PROCESS | 9703 | RSS: Main: 173084672 02:55:59 INFO - PROCESS | 9703 | 02:56:01 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44801/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:56:02 INFO - PROCESS | 9703 | RSS: Main: 175902720 02:56:02 INFO - PROCESS | 9703 | 02:56:05 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44801/tests/kraken/driver.html?testName=imaging-darkroom) 02:56:05 INFO - PROCESS | 9703 | RSS: Main: 214593536 02:56:05 INFO - PROCESS | 9703 | 02:56:09 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44801/tests/kraken/driver.html?testName=imaging-desaturate) 02:56:09 INFO - PROCESS | 9703 | RSS: Main: 213065728 02:56:09 INFO - PROCESS | 9703 | 02:56:12 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44801/tests/kraken/driver.html?testName=json-parse-financial) 02:56:13 INFO - PROCESS | 9703 | RSS: Main: 211668992 02:56:13 INFO - PROCESS | 9703 | 02:56:14 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44801/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:56:15 INFO - PROCESS | 9703 | RSS: Main: 174166016 02:56:15 INFO - PROCESS | 9703 | 02:56:16 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44801/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:56:17 INFO - PROCESS | 9703 | RSS: Main: 181030912 02:56:17 INFO - PROCESS | 9703 | 02:56:19 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44801/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:56:20 INFO - PROCESS | 9703 | RSS: Main: 190078976 02:56:20 INFO - PROCESS | 9703 | 02:56:22 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:56:23 INFO - PROCESS | 9703 | RSS: Main: 199131136 02:56:23 INFO - PROCESS | 9703 | 02:56:26 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:56:26 INFO - PROCESS | 9703 | RSS: Main: 195391488 02:56:26 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | Cycle 1(1): loaded http://localhost:44801/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44801/tests/kraken/driver.html?testName=ai-astar) 02:56:28 INFO - PROCESS | 9703 | RSS: Main: 246173696 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | __start_tp_report 02:56:28 INFO - PROCESS | 9703 | _x_x_mozilla_page_load 02:56:28 INFO - PROCESS | 9703 | _x_x_mozilla_page_load_details 02:56:28 INFO - PROCESS | 9703 | |i|pagename|runs| 02:56:28 INFO - PROCESS | 9703 | |0;ai-astar;101;112;113;110;112;111;112;112;112;112 02:56:28 INFO - PROCESS | 9703 | |1;audio-beat-detection;147;122;119;155;127;122;121;118;145;120 02:56:28 INFO - PROCESS | 9703 | |2;audio-dft;160;160;159;159;159;160;161;158;159;159 02:56:28 INFO - PROCESS | 9703 | |3;audio-fft;75;76;74;109;75;77;75;76;97;74 02:56:28 INFO - PROCESS | 9703 | |4;audio-oscillator;82;82;113;83;83;83;98;82;82;101 02:56:28 INFO - PROCESS | 9703 | |5;imaging-gaussian-blur;117;117;117;117;117;121;117;116;117;117 02:56:28 INFO - PROCESS | 9703 | |6;imaging-darkroom;146;146;146;145;146;146;146;145;146;146 02:56:28 INFO - PROCESS | 9703 | |7;imaging-desaturate;84;85;85;84;85;85;84;84;84;84 02:56:28 INFO - PROCESS | 9703 | |8;json-parse-financial;48;50;51;50;49;49;50;54;50;50 02:56:28 INFO - PROCESS | 9703 | |9;json-stringify-tinderbox;59;60;58;60;61;59;59;59;59;59 02:56:28 INFO - PROCESS | 9703 | |10;stanford-crypto-aes;75;75;75;76;84;75;75;74;75;75 02:56:28 INFO - PROCESS | 9703 | |11;stanford-crypto-ccm;127;132;127;125;125;125;124;136;172;137 02:56:28 INFO - PROCESS | 9703 | |12;stanford-crypto-pbkdf2;156;155;155;154;153;158;162;158;155;153 02:56:28 INFO - PROCESS | 9703 | |13;stanford-crypto-sha256-iterative;65;63;64;63;63;63;65;63;62;62 02:56:28 INFO - PROCESS | 9703 | __end_tp_report 02:56:28 INFO - PROCESS | 9703 | __start_cc_report 02:56:28 INFO - PROCESS | 9703 | _x_x_mozilla_cycle_collect,1600 02:56:28 INFO - PROCESS | 9703 | __end_cc_report 02:56:28 INFO - PROCESS | 9703 | __startTimestamp1480676188564__endTimestamp 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | ------- Summary: start ------- 02:56:28 INFO - PROCESS | 9703 | Number of tests: 14 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#0] ai-astar Cycles:10 Average:110.70 Median:112.00 stddev:3.50 (3.1%) stddev-sans-first:0.83 02:56:28 INFO - PROCESS | 9703 | Values: 101.0 112.0 113.0 110.0 112.0 111.0 112.0 112.0 112.0 112.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#1] audio-beat-detection Cycles:10 Average:129.60 Median:124.50 stddev:13.83 (11.1%) stddev-sans-first:13.15 02:56:28 INFO - PROCESS | 9703 | Values: 147.0 122.0 119.0 155.0 127.0 122.0 121.0 118.0 145.0 120.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#2] audio-dft Cycles:10 Average:159.40 Median:159.50 stddev:0.84 (0.5%) stddev-sans-first:0.87 02:56:28 INFO - PROCESS | 9703 | Values: 160.0 160.0 159.0 159.0 159.0 160.0 161.0 158.0 159.0 159.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:12.07 (16.0%) stddev-sans-first:12.62 02:56:28 INFO - PROCESS | 9703 | Values: 75.0 76.0 74.0 109.0 75.0 77.0 75.0 76.0 97.0 74.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#4] audio-oscillator Cycles:10 Average:88.90 Median:82.50 stddev:11.08 (13.4%) stddev-sans-first:11.47 02:56:28 INFO - PROCESS | 9703 | Values: 82.0 82.0 113.0 83.0 83.0 83.0 98.0 82.0 82.0 101.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:1.34 (1.1%) stddev-sans-first:1.41 02:56:28 INFO - PROCESS | 9703 | Values: 117.0 117.0 117.0 117.0 117.0 121.0 117.0 116.0 117.0 117.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 02:56:28 INFO - PROCESS | 9703 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 02:56:28 INFO - PROCESS | 9703 | Values: 84.0 85.0 85.0 84.0 85.0 85.0 84.0 84.0 84.0 84.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#8] json-parse-financial Cycles:10 Average:50.10 Median:50.00 stddev:1.60 (3.2%) stddev-sans-first:1.50 02:56:28 INFO - PROCESS | 9703 | Values: 48.0 50.0 51.0 50.0 49.0 49.0 50.0 54.0 50.0 50.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.00 stddev:0.82 (1.4%) stddev-sans-first:0.87 02:56:28 INFO - PROCESS | 9703 | Values: 59.0 60.0 58.0 60.0 61.0 59.0 59.0 59.0 59.0 59.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.00 stddev:2.88 (3.8%) stddev-sans-first:3.04 02:56:28 INFO - PROCESS | 9703 | Values: 75.0 75.0 75.0 76.0 84.0 75.0 75.0 74.0 75.0 75.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#11] stanford-crypto-ccm Cycles:10 Average:133.00 Median:129.50 stddev:14.50 (11.2%) stddev-sans-first:15.22 02:56:28 INFO - PROCESS | 9703 | Values: 127.0 132.0 127.0 125.0 125.0 125.0 124.0 136.0 172.0 137.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:155.50 stddev:2.77 (1.8%) stddev-sans-first:2.93 02:56:28 INFO - PROCESS | 9703 | Values: 156.0 155.0 155.0 154.0 153.0 158.0 162.0 158.0 155.0 153.0 02:56:28 INFO - PROCESS | 9703 | 02:56:28 INFO - PROCESS | 9703 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:63.00 stddev:1.06 (1.7%) stddev-sans-first:0.93 02:56:28 INFO - PROCESS | 9703 | Values: 65.0 63.0 64.0 63.0 63.0 63.0 65.0 63.0 62.0 62.0 02:56:28 INFO - PROCESS | 9703 | -------- Summary: end -------- 02:56:28 INFO - PROCESS | 9703 | 02:56:29 INFO - TEST-INFO | 9703: exit 0 02:56:29 INFO - TEST-OK | kraken | took 60369ms 02:56:29 INFO - SUITE-END | took 1175s 02:56:29 INFO - Completed test suite (00:19:36) 02:56:29 INFO - javascript benchmark 02:56:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.654198038216, 3178.6821317868207, 3182.5385319128713, 3206.9679303206963, 3229.160418291245, 5404.054290499162, 5472.616916815825, 5482.479164479373, 5484.780608775649, 5486.725663716808, 5488.313960754906, 5520.889582208353, 5524.889502209953, 5530.861728456791, 5540.252065971093, 4974.676646018006, 5001.8499445016705, 5036.269740887569, 5067.417247016585, 5108.489151084899, 4896.534829191221, 5035.395752509704, 5086.440491545927, 5094.566961808232, 5095.414027386861, 4877.365942427479, 4928.5564299213065, 4969.478204788499, 5015.047141043208, 5027.396712394518, 4964.528369804862, 5000.849974500771, 5007.399112106534, 5057.645964782467, 5080.49195080489, 4977.576905962997, 4982.476839931791, 5012.699238045692, 5032.823851165228, 5033.647644664875, 5290.867728306785, 5337.092694241988, 5373.247745315659, 5390.272313237702, 5392.083345831179, 5756.309242890838, 5780.797672081457, 5792.189093526909, 5867.677277749722, 5868.735906884158, 5897.380775018604, 5897.380775018647, 5916.349201587822, 5923.496502797224, 5930.7034648267845, 5385.649932754398, 5412.648177868426, 5440.782368705247, 5464.207689884945, 5469.726513674301, 5967.880642387128, 5988.730507127189, 5996.550258730613, 5997.310309314485, 5997.520198384206, 5776.68228247442, 5777.88444231113, 5783.71081445926, 5789.9710501447225, 5801.245838041028, 5629.634073785191, 5666.0, 5757.136429535603, 5825.796097136665, 5826.533877289807, 5808.39011903744, 5809.506191973645, 5814.30228372598, 5833.445822646841, 5846.824595262064, 5750.108733146369, 5798.478136967693, 5801.245838041028, 5801.361850196475, 5812.0, 4477.283634618446, 4502.257127573979, 4524.072565124142, 4531.909361812745, 4534.977325113419, 4032.8991775205855, 4079.4696689430184, 4094.2630326541507, 4094.4267802507675, 4110.157417729359, 5616.241807356037, 5653.745581448845, 5656.236408084856, 5658.122990936411, 5658.321001479849, 5802.564807639444, 5862.384449632812, 5872.7357268923, 5932.911006334908, 5936.881262374728, 5457.345118585716, 5482.122860342406, 5494.038543254915, 5546.084895992116, 5578.86052848682, 5018.949810501921, 5025.346704928336, 5027.84916452507, 5033.2701758245585, 5044.520770526794, 5964.045752679724, 6012.729427175875, 6057.061155520902, 6075.878482430415, 6077.939220607737, 5740.770369185186, 5798.159266906359, 5814.04068328738, 5867.471927526543, 5954.7320370582565, 6140.846478838065, 6156.107364432221, 6163.044728067157, 6163.3836616338, 6165.691715414301, 5809.651420914759, 5809.883802323845, 5811.56413268998, 5811.709414529341, 5821.359650438533, 5776.075827867521, 5836.620619659709, 5843.561732870136, 5864.706764661835, 5879.029960056543, 5804.738786754522, 5805.854853628524, 5811.244538210006, 5813.76744930198, 5832.562557808096, 5738.110592858114, 5745.971270143623, 5807.245058142415, 5811.651300921789, 5816.127580862904, 5565.666060036411, 5593.993081245415, 5602.663840169603, 5627.212190293444, 5636.5208957237455, 5750.079987202028, 5751.884962300647, 5757.769689212385, 5761.683107428964, 5772.365039845529, 5503.532199762904, 5629.6903670298525, 5644.3508996465935, 5647.407022262603, 5649.4633009864], "value": 5409.147421052, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.7494177503672, 604.5858586867994, 619.7459041792864, 638.3999040901555, 639.0318667219167, 33263.50104748428, 33819.15452113695, 36100.99999999996, 44753.104937901306, 45638.543614563845, 47001.529984700144, 47494.287585686245, 47495.0, 47506.287405688854, 47521.76239118808, 8804.383693141466, 8933.508657023862, 8938.1508756668, 8939.284857211407, 8939.597718102668, 8251.876221856646, 8441.57792110392, 8449.915500844974, 8832.160944710242, 10485.318454300446, 10530.262881598253, 10858.402787846666, 10863.945680271627, 10869.728256793564, 10873.565057397695, 10617.256792024562, 10631.255812093157, 10692.091172250368, 10700.892991070106, 10703.036726694634, 10602.840957385646, 10633.361998280128, 10661.0, 10667.306625069346, 10682.946585267024, 43817.561824381664, 43873.34189987153, 44244.778776106235, 44260.0, 44311.0, 3701.796401197933, 3791.9241615167543, 3822.503074600284, 4199.454070970784, 4400.427944367212, 33421.498677519856, 33578.32843343144, 33599.32801343984, 33739.0, 33832.0, 4496.797644106023, 4504.166729155117, 4566.680332376735, 4568.771561421916, 4727.739974301412, 359222.0, 360956.0, 361094.0, 361870.0, 363023.0, 37399.62600374016, 63665.0, 64002.0, 64067.0, 64096.0, 36758.63241367552, 39778.0, 39872.60127398689, 39888.40167397491, 39888.40167397491, 14104.224267665171, 14147.22190279524, 14197.716045679028, 14200.715985680228, 14217.360218789972, 12195.268283902995, 12283.078769092353, 12296.938515307365, 12324.445399957023, 12324.938375308066, 8676.69631562905, 8805.69180078694, 9226.81546369069, 9233.584488698025, 9298.86051709225, 3598.712103031751, 3605.7115430765475, 3625.564932208099, 3629.129009037812, 3666.6883314917995, 1069.1233188785122, 1110.228391268077, 1132.2074547816562, 1140.7205234717546, 1163.8952494275557, 34472.0, 34569.0, 34606.480902786476, 34820.65179348174, 34849.0, 1134.126722423729, 1144.988550114505, 1147.05941128274, 1156.525824411987, 1196.9640910772691, 17918.462446126636, 17929.910350448426, 17980.370687026152, 18035.639287214446, 18108.456746297634, 167019.0, 167920.0, 168777.15611422108, 168951.0, 169085.15457422636, 61774.0, 62428.0, 62645.37354626395, 62683.0, 62742.68628656828, 1291.6318849127954, 1327.3429652322163, 1340.7921772125337, 1420.609332433589, 1421.076300404745, 30065.849670751508, 36823.0, 37049.0, 37339.6266037347, 37384.252314954094, 58890.705546471996, 59137.0, 59587.0, 59704.0, 59737.103943440015, 453483.0, 456078.0, 456288.0, 457177.0, 458757.0, 30754.077377678706, 31323.843380783863, 46352.536474636174, 48243.0, 50582.0, 43267.0, 54346.18480722713, 55274.170887437525, 57044.714776425855, 57714.42285577259, 44824.32763508615, 45570.54429455663, 45999.0, 46517.06965860732, 47313.053738925715, 43924.780376097915, 44815.55184448114, 45403.77298113488, 45636.31545526753, 46998.29502557533, 45369.319460207465, 45988.08023839571, 46436.53563464322, 46664.30003550017, 46718.53281467142, 38452.80773596114, 40434.79782601068, 40472.1905561893, 40581.0, 41206.587934120274, 30221.697783022766, 30463.847680761453, 30495.237619059702, 30724.385512290075, 30899.536506951965], "value": 19727.17584751871, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.61925219172275, 418.0906528300945, 422.82030137191686, 429.96775241856847, 432.25436122688365, 18534.814651853478, 19452.221911123557, 20102.095405706743, 20198.0, 20408.693869591967, 19647.90176049121, 19743.0, 19904.60190796183, 20353.38939831804, 20449.59100817983, 5558.666480011192, 5857.062869940811, 5859.560532960024, 5861.150133230679, 5863.208466856962, 5621.943780562204, 5775.27809023872, 5808.186853840466, 5814.5057670098095, 5857.0, 5779.306483222019, 5783.074708046714, 5786.884262314772, 5787.739551720183, 5788.681622510781, 5580.358258800229, 5691.630044047124, 5775.711214439282, 5785.0, 5793.13103034544, 5213.426523082458, 5224.346956630421, 5224.50367215114, 5225.242339860737, 5227.895442091175, 23625.0, 23718.169864054675, 23773.762262377502, 23782.64326035111, 23964.64053039206, 2461.9876900615563, 2535.4802265535523, 2537.4037101281183, 2573.4853029394008, 3083.7378822800088, 14090.577282681434, 14815.777763333559, 15439.536813895602, 15555.22223888801, 15755.369785208577, 1947.9707804382945, 1963.391348681913, 1963.890401922909, 2012.7584689837167, 2027.7465316835396, 59354.0, 75849.62075189644, 78918.60540697318, 82022.58988705078, 87705.12294877034, 10578.418186999788, 10593.523291451904, 11164.832527511931, 11300.660980170607, 11433.428328583537, 16161.59596010109, 16181.11003894797, 16195.109268990318, 16197.433089842034, 16209.35162593483, 8287.212714792086, 8463.957680211559, 8560.657573696983, 8654.82690346202, 8728.607212675444, 8227.13615070421, 8300.958495207486, 8338.166183381612, 8451.830963380698, 8480.10958849312, 6831.146106736658, 6843.418309443654, 6853.17761868579, 6973.616451095137, 7032.156141263081, 1947.8052194780691, 2010.959780804405, 2048.989755051245, 2064.5251592133895, 2072.637288474511, 968.6900191938512, 994.4232345239743, 1004.382304882492, 1005.3264312910368, 1050.5115121468555, 20241.89879050625, 20265.0, 20660.276890308767, 21083.262085826922, 21144.365669029645, 980.6077568972325, 1002.6691191906654, 1019.4444028004755, 1029.2229366827996, 1046.3251202974038, 10575.0, 11340.886591134147, 11390.65828025144, 11396.715082122848, 11432.714182145346, 454436.0, 477353.0, 480729.0, 482029.0, 483295.0, 72121.6393918027, 75893.62053189699, 94018.52990735002, 95745.0, 96756.51621741986, 1021.4331046269243, 1049.459528342904, 1076.3380520979697, 1112.6662001399548, 1116.3748300951493, 17970.281188752302, 18147.909260453613, 18380.448586542425, 18498.722519161955, 19041.143148558072, 40088.198236034536, 43397.349039763794, 44309.33535996898, 44390.77804610956, 45682.771586141855, 50351.0, 57137.0, 58383.12425313709, 58513.70743146257, 59987.40012599818, 8731.301495880187, 8925.955370223108, 9006.504642244478, 9012.54937253148, 9505.477198754135, 9506.429614223169, 12964.28696421668, 13930.79103813464, 14027.579172624837, 14045.438182472586, 11890.702732431759, 11978.101642376681, 12071.155019148926, 12190.329531875832, 12283.85032619306, 5416.0521908666615, 9861.372873475797, 11895.226810257305, 11996.0, 12124.27254364741, 11880.881191187977, 11919.52321907114, 12203.267803931793, 12235.265884046985, 12238.694032648898, 8566.100559441169, 8853.822923541364, 8857.291416686778, 9002.874640669916, 9142.131497507726, 9474.85787713171, 11500.309981400807, 11644.35956022427, 11995.64013079609, 11997.100217483898], "value": 9578.052828546233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.7234761569107, 1530.341952960227, 1654.6856097341504, 1711.4523352527196, 1770.7963584187814, 8304.128066553016, 8851.645934162625, 8859.55702214889, 8860.46837189769, 8862.158094980983, 7645.082590089183, 7846.607669616511, 8289.0, 8521.19048690375, 8696.956515217431, 2455.5211733711935, 2478.157426474998, 2479.876006199692, 2482.8262021658493, 2488.552060629095, 2428.7449817769143, 2526.87554038453, 2527.443962328294, 2528.936776580582, 2532.11376018393, 2427.5023620157826, 2439.6706444630013, 2492.800575953919, 2498.57524220882, 2504.611785173301, 2373.774491423312, 2385.60637494814, 2407.4703565215623, 2434.720007199177, 2444.4255599934, 2385.0459816073535, 2409.8072154227793, 2430.1008626808016, 2431.2098567965304, 2436.987815060931, 8721.825563488757, 8775.47347159166, 8817.29461643067, 8847.557622118868, 8877.422967507091, 5394.7842086316505, 5549.916751248694, 5556.388797232301, 5557.41647127054, 5557.694326812024, 3489.668481494254, 3497.667721566447, 3525.964740352615, 3570.6607872252353, 3672.3022625701033, 1210.056156198167, 1221.5907670930249, 1254.8180513825534, 1268.0489632775418, 1284.2808027504627, 12103.152779305452, 12171.087168462313, 12175.208611440228, 12179.39103044853, 12211.572594959134, 4693.388654268877, 4842.080004799077, 4854.368932038812, 4898.657094003457, 4997.125503036954, 10289.897101029044, 10295.43375114361, 10295.691129266133, 10300.22748293881, 10308.175345972304, 5529.557635389159, 5615.298087739033, 5622.409646987007, 5624.3250809903075, 5624.718764061862, 4504.617107545895, 4678.789454474557, 4975.950240497548, 5044.4198917125, 5119.923201151985, 3939.8227079781477, 4025.295573274665, 4034.0318323602123, 4113.526944401372, 4118.711690181659, 1414.7877818327333, 1419.176877411099, 1420.6803469219342, 1430.7281616492833, 1438.5971927860217, 945.6548359848606, 996.566493575297, 1001.1490233301636, 1013.1034034879185, 1022.7340891368298, 6064.575479716377, 6114.449699526975, 6123.663198524035, 6173.703522260286, 6314.0844577536, 959.3332633819568, 966.4249771386154, 991.2714155095998, 1005.4017859373661, 1023.2632504596678, 4019.256437559061, 4316.115196384733, 4327.870163895025, 4341.5007274163245, 4356.128774245164, 10377.16982641402, 10625.893741062491, 10688.198385121146, 10703.625373111903, 10711.196660250356, 10684.626038088785, 10691.839622405514, 10692.198085143646, 10706.785864282827, 10713.517891694892, 7801.687932482637, 7890.921090789018, 7983.441159118922, 8039.196080391914, 8224.38317126218, 5956.583039187215, 6032.125341825323, 6050.122732203894, 6090.878182436415, 6103.176071230327, 9609.471479068718, 9639.469829159463, 9659.32384733062, 9748.561314740711, 9752.853707194256, 9682.370645907993, 9940.155086817413, 9960.601575936882, 10160.644377446753, 10176.592936282466, 6998.195207551197, 7146.32109949554, 7230.0, 7290.088738907637, 7549.320561149523, 8398.454100483448, 8705.825883482421, 8707.172818582225, 8708.825823483368, 8720.345974051845, 7649.541027538366, 7696.307332340116, 7753.65108570127, 7836.09884863248, 7848.058233012075, 7612.276833700789, 7622.885656715042, 7634.580098094658, 7673.347765439777, 7731.458797884094, 6998.230194678683, 7187.0, 7199.748008819666, 7281.162666293444, 7288.0, 5203.401608815035, 5206.349206349207, 5251.579873610026, 5276.683398996072, 5278.4721527846905, 5285.207218917193, 5420.430854760193, 5455.208994695826, 5499.670019798825, 5534.612577119563], "value": 4748.617302253154, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.1132523390588, 351.3973535386811, 359.03061733320044, 359.5092698466592, 360.46470990579, 5396.892062158754, 5412.485813847683, 5420.403755586883, 5430.511253987145, 5434.483724046219, 5099.169960671826, 5148.304978827857, 5181.378234611842, 5225.8954820903555, 5294.126469132598, 4171.416001759756, 4221.852235171769, 4239.173361194553, 4245.936310955338, 4252.80862361193, 4224.8664424465605, 4252.532221455653, 4252.766097864616, 4257.297545904922, 4266.338717498793, 4073.490813648294, 4186.267403204442, 4205.179989901971, 4225.535191128974, 4228.703990720651, 4173.4157217989505, 4193.601607847249, 4213.5786421357925, 4224.809883555232, 4227.239096962546, 3751.8499260029566, 3776.3580191367532, 3781.6785573226307, 3784.583695793488, 3786.2995345861104, 5005.324281222025, 5186.662866913639, 5210.452902445227, 5212.0, 5247.947520524784, 4856.660033797635, 4862.489438608931, 4867.4889136640495, 4876.561109500162, 4883.560479556857, 5574.2441131044, 5579.972100139514, 5606.579506536985, 5609.775608975636, 5634.295713035871, 3967.583403742623, 4063.7764922929227, 4130.669546436278, 4191.413202151702, 4195.202911446815, 5733.971330143323, 5809.647092927329, 5818.476337129637, 5823.621464604787, 5826.563007774434, 4171.144915292358, 4214.3889136075095, 4216.8313267469575, 4222.9577704222565, 4231.597998190167, 4197.4753155855515, 4262.6376757975295, 4298.527162012176, 4298.871033868989, 4314.503832059353, 4796.9760151199025, 4810.807567697323, 4812.783424745895, 4832.540908613676, 4846.29728689338, 5586.217929489874, 5587.469190426903, 5592.580556458201, 5638.464345887134, 5638.718064096779, 1363.2093385836192, 1397.3083323754604, 1433.6129245103764, 1459.168274083762, 1464.2020099046044, 1007.7228762090338, 1008.9154159278804, 1024.4621573673733, 1030.644427672452, 1032.5405194688292, 5245.895082098413, 5252.422233554306, 5263.6841789492755, 5282.577393808486, 5286.656367336111, 5508.614396992172, 5527.834164975057, 5529.364123125812, 5535.308086489189, 5535.861603459945, 5053.5957123430035, 5240.34495688039, 5254.842354729364, 5278.9208161877605, 5287.576993840484, 2905.709429057077, 2909.898153564615, 2915.2566095645475, 2916.927076823054, 2943.3524624582556, 5725.227094342294, 5733.627314224562, 5759.539236861041, 5773.845230953826, 5822.719001819593, 5305.893882122413, 5507.862303442446, 5539.750711218005, 5586.776528938878, 5593.4617980055, 5750.281214848144, 5760.164776107441, 5765.423457654201, 5800.0, 5804.767809287581, 5497.972510137423, 5505.229267902417, 5507.504324610804, 5539.58453116026, 5561.972190139023, 5728.885422291448, 5732.936142988604, 5744.971275143765, 5745.885082298247, 5758.733078722675, 6034.758609655564, 6068.9089663654195, 6078.361772014052, 6080.787172448943, 6082.422169893853, 4103.768869339246, 4175.728577642565, 4191.706580539333, 4193.266178418704, 4213.756941702267, 5761.683107429131, 5772.892894093542, 5782.971085144547, 5795.275590551181, 5825.242718446744, 5360.490753378423, 5492.890142197213, 5555.2778138841695, 5559.305086864142, 5573.609847310811, 5470.316210473691, 5594.440555944373, 5637.210790489253, 5666.093425051972, 5686.374498805211, 5329.947970031488, 5520.944790552043, 5568.443155684561, 5608.2148499209325, 5629.380768115422, 5700.287464066992, 5704.201411802268, 5704.486596206361, 5706.828795136153, 5717.656940583578, 5562.415946325739, 5577.693226872561, 5585.357683866408, 5616.410276921028, 5628.240187574625], "value": 4290.355283377289, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.7814694665074, 758.9468737188397, 767.8118860879082, 768.7539987204093, 775.0234704272618, 15171.08973461593, 15348.539543813675, 15352.385904563833, 15367.69264614707, 15416.845831541696, 13985.720285594307, 14383.712325753504, 14388.352524136413, 14404.495842645509, 14411.783823242633, 699.7655785311902, 710.8578284343126, 804.4610111225463, 825.6160885188386, 830.7923019245188, 832.567065126134, 835.5279267214034, 835.6657337065162, 835.7826964989085, 836.1471299274737, 891.3270480786997, 891.5720454181965, 892.2014796756898, 893.2675206330812, 893.4728510178993, 739.6930273936337, 757.3827330725496, 843.2158092973532, 866.5060915278294, 888.8533391990314, 636.6816591704148, 637.8564822914853, 641.2305233719555, 641.7208514296296, 642.3383914567955, 14051.508197213048, 14102.294885255696, 14102.576922692335, 14145.363458644282, 14148.92925535376, 13142.540011099565, 13527.188368697909, 13830.23933683647, 13865.930670346685, 14031.859681403157, 12878.678033049155, 13004.0, 13069.281189534571, 13098.803517947239, 13107.0, 3791.4312853071983, 3958.7228893977435, 3961.980190099031, 3980.601939805996, 4055.858044968412, 56104.438955610734, 62469.68765156191, 62684.37315626831, 62880.37119628837, 62926.68536657288, 11274.718132046764, 11300.378479183559, 11319.603813866475, 11372.943135284271, 11510.482028308747, 18573.071346432625, 18712.625747485246, 18793.624127517647, 18827.81172188288, 18891.716624250646, 8445.408821382567, 8484.0, 8495.0, 8526.531040792815, 8561.272291855137, 4438.533953934855, 4452.799624016927, 4604.700694454849, 4702.059588082398, 4730.337752714623, 3471.062813040465, 3574.3566158091794, 3581.7134629230122, 3596.496490491333, 3655.8484077515495, 628.4752231886426, 634.3149398649448, 634.4416913116428, 638.7955854126635, 645.95155363347, 668.4585485756553, 679.3953381490477, 698.0611078099947, 708.922018577956, 764.9158592554815, 9190.448573085636, 9215.631374744935, 9415.340926135243, 9597.520123993772, 9719.951400242953, 687.848673291875, 699.5452955578914, 779.4660657449665, 779.7855589712874, 785.8271180340316, 4642.675012749075, 4655.557722016403, 4701.3888194535175, 4723.622110231173, 4749.738764367993, 54975.0, 66271.00593491101, 79642.60178699186, 89737.55131224303, 95985.52007239919, 50535.49464505308, 56595.434045659014, 79354.6032269835, 82247.588762057, 85383.57308213419, 70895.64552177206, 73279.63360183059, 73760.0, 74148.62925685337, 75509.24490755131, 9161.77095572616, 9186.265098791948, 9308.255339572683, 9344.859827102735, 9346.719598412059, 47061.05877882492, 48569.54686517695, 48876.0, 49528.25707614316, 50572.49427505678, 61324.38675613187, 66704.6664766673, 67884.6605766968, 68629.65685171542, 69002.0, 11606.76786464249, 12073.939630301793, 12112.273263604213, 12164.817527737268, 12294.077944154404, 13232.40454179545, 13402.655702211963, 13432.39554220043, 13472.720091591284, 13588.524401645895, 11768.0, 12204.87795122073, 12423.937880310541, 12640.0, 12698.619041428772, 11952.820707689218, 11979.700507487383, 12347.814782778087, 12350.81473777876, 12413.627591172279, 11589.188756787282, 11727.824082638597, 11839.58561450345, 11899.940500297444, 11922.821157682469, 9566.952165239407, 9641.469719165514, 9958.302918795614, 10146.949265253626, 10195.176808696739, 9554.140127388568, 9767.9023209767, 9823.165030972448, 9838.36050656705, 10022.749431264278], "value": 7110.465717734037, "unit": "score"}], "name": "dromaeo_css", "value": 7273.533274483547, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 113.0, 110.0, 112.0, 111.0, 112.0, 112.0, 112.0, 112.0], "value": 110.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 119.0, 155.0, 127.0, 122.0, 121.0, 118.0, 145.0, 120.0], "value": 129.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 159.0, 159.0, 159.0, 160.0, 161.0, 158.0, 159.0, 159.0], "value": 159.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 74.0, 109.0, 75.0, 77.0, 75.0, 76.0, 97.0, 74.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 113.0, 83.0, 83.0, 83.0, 98.0, 82.0, 82.0, 101.0], "value": 88.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 121.0, 117.0, 116.0, 117.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 50.0, 51.0, 50.0, 49.0, 49.0, 50.0, 54.0, 50.0, 50.0], "value": 50.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 58.0, 60.0, 61.0, 59.0, 59.0, 59.0, 59.0, 59.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 76.0, 84.0, 75.0, 75.0, 74.0, 75.0, 75.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 132.0, 127.0, 125.0, 125.0, 125.0, 124.0, 136.0, 172.0, 137.0], "value": 133.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 155.0, 155.0, 154.0, 153.0, 158.0, 162.0, 158.0, 155.0, 153.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 64.0, 63.0, 63.0, 63.0, 65.0, 63.0, 62.0, 62.0], "value": 63.3, "unit": "score"}], "name": "kraken", "value": 1454.4, "alertThreshold": 2.0}]} 02:56:29 INFO - Return code: 0 02:56:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:56:29 INFO - # TBPL SUCCESS # 02:56:29 INFO - Running post-action listener: _resource_record_post_action 02:56:29 INFO - [mozharness: 2016-12-02 10:56:29.882731Z] Finished run-tests step (success) 02:56:29 INFO - Running post-run listener: _resource_record_post_run 02:56:29 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 356917248; Read time: 24; Write time: 305008 02:56:29 INFO - TinderboxPrint: CPU usage
13.0% 02:56:29 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 02:56:29 INFO - TinderboxPrint: I/O write bytes / time
356,917,248 / 305,008 02:56:29 INFO - TinderboxPrint: CPU idle
8,276.3 (87.0%) 02:56:29 INFO - TinderboxPrint: CPU user
1,190.1 (12.5%) 02:56:29 INFO - TinderboxPrint: Swap in / out
0 / 0 02:56:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110669824; Read time: 0; Write time: 86720 02:56:29 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 245035008; Read time: 16; Write time: 218228 02:56:30 INFO - Running post-run listener: _upload_blobber_files 02:56:30 INFO - Blob upload gear active. 02:56:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:56:30 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 02:56:30 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'] 02:56:30 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 02:56:30 INFO - (blobuploader) - INFO - Open directory for files ... 02:56:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:56:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:56:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:31 INFO - (blobuploader) - INFO - Done attempting. 02:56:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:56:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:56:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:35 INFO - (blobuploader) - INFO - Done attempting. 02:56:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:56:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:56:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:56:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:56:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:56:36 INFO - (blobuploader) - INFO - Done attempting. 02:56:36 INFO - (blobuploader) - INFO - Iteration through files over. 02:56:36 INFO - Return code: 0 02:56:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:56:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:56:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/517f3322eb198134ba9b510e54f4b10b156af197f5275facda3ad765c18311952d940ef3a8a74217665f86a2da94d158be127419c7878362f38c218962918b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df08b7224b3695381652c5a575e6a32a2ce68e6f0a520c7779f50697d2a273e6545eeb0d1ff3d9ad4275eb232c263e49941f74277e127c48648e3c19a8f99514", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7c1a48c2cbe48bfe5df4e50140e4c3043394482d0898f6fd76fa795855742495ecc7630ae5df19aa59aa0e7ea235ccf8a4e1c11dc6754392c5f7f55421c9ae3"} 02:56:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:56:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:56:36 INFO - Contents: 02:56:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/517f3322eb198134ba9b510e54f4b10b156af197f5275facda3ad765c18311952d940ef3a8a74217665f86a2da94d158be127419c7878362f38c218962918b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df08b7224b3695381652c5a575e6a32a2ce68e6f0a520c7779f50697d2a273e6545eeb0d1ff3d9ad4275eb232c263e49941f74277e127c48648e3c19a8f99514", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7c1a48c2cbe48bfe5df4e50140e4c3043394482d0898f6fd76fa795855742495ecc7630ae5df19aa59aa0e7ea235ccf8a4e1c11dc6754392c5f7f55421c9ae3"} 02:56:36 INFO - Running post-run listener: copy_logs_to_upload_dir 02:56:36 INFO - Copying logs to upload dir... 02:56:36 INFO - mkdir: /builds/slave/test/build/upload/logs 02:56:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.213819 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-12-02 02:56:35.655989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 02:56:35.659820) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669 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/517f3322eb198134ba9b510e54f4b10b156af197f5275facda3ad765c18311952d940ef3a8a74217665f86a2da94d158be127419c7878362f38c218962918b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df08b7224b3695381652c5a575e6a32a2ce68e6f0a520c7779f50697d2a273e6545eeb0d1ff3d9ad4275eb232c263e49941f74277e127c48648e3c19a8f99514", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7c1a48c2cbe48bfe5df4e50140e4c3043394482d0898f6fd76fa795855742495ecc7630ae5df19aa59aa0e7ea235ccf8a4e1c11dc6754392c5f7f55421c9ae3"} build_url:https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011769 build_url: 'https://queue.taskcluster.net/v1/task/P4_O-v0vRZSitbuCoYv79Q/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/517f3322eb198134ba9b510e54f4b10b156af197f5275facda3ad765c18311952d940ef3a8a74217665f86a2da94d158be127419c7878362f38c218962918b65", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/df08b7224b3695381652c5a575e6a32a2ce68e6f0a520c7779f50697d2a273e6545eeb0d1ff3d9ad4275eb232c263e49941f74277e127c48648e3c19a8f99514", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e7c1a48c2cbe48bfe5df4e50140e4c3043394482d0898f6fd76fa795855742495ecc7630ae5df19aa59aa0e7ea235ccf8a4e1c11dc6754392c5f7f55421c9ae3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-02 02:56:35.686059) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 02:56:35.686442) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1480674957.93012-570883669 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004426 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-02 02:56:35.771699) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 02:56:35.772070) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-02 02:56:35.772450) ========= ========= Total master_lag: 0.15 =========