builder: larch_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1475564960.2 results: success (0) buildid: 20161003231102 builduid: 0f8bf41fade849249f4e7272cd3ffe16 revision: 0149927a63f3f49827f5477809cafbf070983b73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:20.198185) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:20.198634) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:20.198937) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:20.216535) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:20.216954) ========= 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=d2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-04 00:09:20-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 551K=0.02s 2016-10-04 00:09:20 (551 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.097621 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:20.328259) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:20.328578) ========= 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=d2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017195 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:20.380499) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 00:09:20.380876) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 0149927a63f3f49827f5477809cafbf070983b73 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 0149927a63f3f49827f5477809cafbf070983b73 --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=d2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-04 00:09:20,767 truncating revision to first 12 chars 2016-10-04 00:09:20,767 Setting DEBUG logging. 2016-10-04 00:09:20,767 attempt 1/10 2016-10-04 00:09:20,767 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/0149927a63f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-04 00:09:21,568 unpacking tar archive at: larch-0149927a63f3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.140101 ========= master_lag: 0.44 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-04 00:09:21.956542) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:21.956874) ========= script_repo_revision: 0149927a63f3f49827f5477809cafbf070983b73 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:21.957273) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:21.957553) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-04 00:09:21.970807) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-04 00:09:21.971101) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 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', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] 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=d2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:09:22 INFO - MultiFileLogger online at 20161004 00:09:22 in /builds/slave/test 00:09:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 00:09:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:09:22 INFO - {'append_to_log': False, 00:09:22 INFO - 'base_work_dir': '/builds/slave/test', 00:09:22 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 00:09:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:09:22 INFO - 'branch': 'Larch-Non-PGO', 00:09:22 INFO - 'buildbot_json_path': 'buildprops.json', 00:09:22 INFO - 'config_files': ('talos/linux_config.py',), 00:09:22 INFO - 'default_actions': ('clobber', 00:09:22 INFO - 'read-buildbot-config', 00:09:22 INFO - 'download-and-extract', 00:09:22 INFO - 'populate-webroot', 00:09:22 INFO - 'create-virtualenv', 00:09:22 INFO - 'install', 00:09:22 INFO - 'run-tests'), 00:09:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:09:22 INFO - 'download_minidump_stackwalk': True, 00:09:22 INFO - 'download_symbols': 'ondemand', 00:09:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:09:22 INFO - 'tooltool.py': '/tools/tooltool.py', 00:09:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:09:22 INFO - '/tools/misc-python/virtualenv.py')}, 00:09:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:09:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:09:22 INFO - 'installer_path': 'installer.exe', 00:09:22 INFO - 'log_level': 'info', 00:09:22 INFO - 'log_name': 'talos', 00:09:22 INFO - 'log_to_console': True, 00:09:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:09:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:09:22 INFO - 'opt_config_files': (), 00:09:22 INFO - 'pip_index': False, 00:09:22 INFO - 'sps_profile': False, 00:09:22 INFO - 'sps_profile_interval': 0, 00:09:22 INFO - 'suite': 'dromaeojs', 00:09:22 INFO - 'system_bits': '32', 00:09:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:09:22 INFO - 'title': 'talos-linux64-ix-043', 00:09:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:09:22 INFO - 'use_talos_json': True, 00:09:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:09:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:09:22 INFO - 'work_dir': 'build'} 00:09:22 INFO - [mozharness: 2016-10-04 07:09:22.457494Z] Running clobber step. 00:09:22 INFO - Running pre-action listener: _resource_record_pre_action 00:09:22 INFO - Running main action method: clobber 00:09:22 INFO - rmtree: /builds/slave/test/build 00:09:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:09:22 INFO - Running post-action listener: _resource_record_post_action 00:09:22 INFO - [mozharness: 2016-10-04 07:09:22.931792Z] Finished clobber step (success) 00:09:22 INFO - [mozharness: 2016-10-04 07:09:22.931893Z] Running read-buildbot-config step. 00:09:22 INFO - Running pre-action listener: _resource_record_pre_action 00:09:22 INFO - Running main action method: read_buildbot_config 00:09:22 INFO - Using buildbot properties: 00:09:22 INFO - { 00:09:22 INFO - "project": "", 00:09:22 INFO - "product": "firefox", 00:09:22 INFO - "script_repo_revision": "production", 00:09:22 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs", 00:09:22 INFO - "repository": "", 00:09:22 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs", 00:09:22 INFO - "buildid": "20161003231102", 00:09:22 INFO - "pgo_build": "False", 00:09:22 INFO - "basedir": "/builds/slave/test", 00:09:22 INFO - "buildnumber": 4, 00:09:22 INFO - "slavename": "talos-linux64-ix-043", 00:09:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:09:22 INFO - "platform": "ubuntu64_hw", 00:09:22 INFO - "scheduler": "tests-larch-linux64-talos", 00:09:22 INFO - "branch": "larch", 00:09:22 INFO - "repo_path": "projects/larch", 00:09:22 INFO - "revision": "0149927a63f3f49827f5477809cafbf070983b73", 00:09:22 INFO - "stage_platform": "linux64", 00:09:22 INFO - "builduid": "0f8bf41fade849249f4e7272cd3ffe16", 00:09:22 INFO - "slavebuilddir": "test" 00:09:22 INFO - } 00:09:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 00:09:22 INFO - Running post-action listener: _resource_record_post_action 00:09:22 INFO - [mozharness: 2016-10-04 07:09:22.934373Z] Finished read-buildbot-config step (success) 00:09:22 INFO - [mozharness: 2016-10-04 07:09:22.934461Z] Running download-and-extract step. 00:09:22 INFO - Running pre-action listener: _resource_record_pre_action 00:09:22 INFO - Running main action method: download_and_extract 00:09:22 INFO - mkdir: /builds/slave/test/build/tests 00:09: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')]} 00:09:22 INFO - trying https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:09:22 INFO - Downloading https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:09:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 00:09:23 INFO - Downloaded 1361 bytes. 00:09:23 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 00:09:23 INFO - Using the following test package requirements: 00:09:23 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:09:23 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:09:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:09:23 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:09:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:09:23 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:09:23 INFO - u'jsshell-linux-x86_64.zip'], 00:09:23 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:09:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:09:23 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 00:09:23 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:09:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:09:23 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:09:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:09:23 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:09:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:09:23 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 00:09:23 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:09:23 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:09:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:09:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:09:23 INFO - Fetch https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:09:24 INFO - Http code: 200 00:09:24 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 00:09:24 INFO - x-amz-cf-id: MLw4eYw5TFoCdfiHgfVBA9upRJ5ctifK273cytuL9SAZJWZYAP8heQ== 00:09:24 INFO - x-amz-version-id: QALh0_nR_pDttlS192z_424i.92K6JRg 00:09:24 INFO - Expected file size: 20420581 00:09:24 INFO - Obtained file size: 20420581 00:09:28 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 00:09:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 00:09:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:09:28 INFO - Fetch https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:09:28 INFO - Http code: 200 00:09:28 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 00:09:28 INFO - x-amz-cf-id: 1vs7Jsvz-A81CImn-5aklpYHRdXKaYob8QDgZxjttinL7rTubNLkWg== 00:09:28 INFO - x-amz-version-id: QALh0_nR_pDttlS192z_424i.92K6JRg 00:09:29 INFO - Expected file size: 20420581 00:09:29 INFO - Obtained file size: 20420581 00:09:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 00:09:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:09:33 INFO - Fetch https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:09:34 INFO - Http code: 200 00:09:34 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 00:09:34 INFO - x-amz-cf-id: dcUU5aeE0d7piNvUyOjNyDdO7G1SMCTFNYoCHArwEzMXoNewgzHt7w== 00:09:34 INFO - x-amz-version-id: lFxbCfYL_m03oDY0yOZECeoif9l19r1k 00:09:34 INFO - Expected file size: 14408522 00:09:34 INFO - Obtained file size: 14408522 00:09:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:34 INFO - trying https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:09:34 INFO - Downloading https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:09:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 00:09:35 INFO - Downloaded 55825162 bytes. 00:09:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:09:35 INFO - mkdir: /builds/slave/test/properties 00:09:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:09:35 INFO - Writing to file /builds/slave/test/properties/build_url 00:09:35 INFO - Contents: 00:09:35 INFO - build_url:https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 00:09:36 INFO - Running post-action listener: _resource_record_post_action 00:09:36 INFO - Running post-action listener: set_extra_try_arguments 00:09:36 INFO - [mozharness: 2016-10-04 07:09:36.523805Z] Finished download-and-extract step (success) 00:09:36 INFO - [mozharness: 2016-10-04 07:09:36.524031Z] Running populate-webroot step. 00:09:36 INFO - Running pre-action listener: _resource_record_pre_action 00:09:36 INFO - Running main action method: populate_webroot 00:09:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:09:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:09:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:09:36 INFO - '--tppagecycles', 00:09:36 INFO - '7'], 00:09:36 INFO - 'tests': ['tsvgm']}}, 00:09:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:09:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:09:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:09:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:09:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:36 INFO - 'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:09:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:09:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:36 INFO - 'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['damp', 'tps']}, 00:09:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:36 INFO - 'tests': ['damp', 'tps']}, 00:09:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['dromaeo_dom']}, 00:09:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:09:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['basic_compositor_video']}, 00:09:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:09:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['a11yr', 00:09:36 INFO - 'ts_paint', 00:09:36 INFO - 'tpaint', 00:09:36 INFO - 'sessionrestore', 00:09:36 INFO - 'sessionrestore_no_auto_restore', 00:09:36 INFO - 'tabpaint']}, 00:09:36 INFO - 'other-e10s': {'tests': ['a11yr', 00:09:36 INFO - 'ts_paint', 00:09:36 INFO - 'tpaint', 00:09:36 INFO - 'sessionrestore', 00:09:36 INFO - 'sessionrestore_no_auto_restore', 00:09:36 INFO - 'tabpaint']}, 00:09:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:09:36 INFO - 'ts_paint', 00:09:36 INFO - 'tpaint', 00:09:36 INFO - 'sessionrestore', 00:09:36 INFO - 'sessionrestore_no_auto_restore', 00:09:36 INFO - 'tabpaint']}, 00:09:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:09:36 INFO - 'ts_paint', 00:09:36 INFO - 'tpaint', 00:09:36 INFO - 'sessionrestore', 00:09:36 INFO - 'sessionrestore_no_auto_restore', 00:09:36 INFO - 'tabpaint']}, 00:09:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['a11yr', 00:09:36 INFO - 'ts_paint', 00:09:36 INFO - 'tpaint', 00:09:36 INFO - 'sessionrestore', 00:09:36 INFO - 'sessionrestore_no_auto_restore', 00:09:36 INFO - 'tabpaint']}, 00:09:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['a11yr', 00:09:36 INFO - 'ts_paint', 00:09:36 INFO - 'tpaint', 00:09:36 INFO - 'sessionrestore', 00:09:36 INFO - 'sessionrestore_no_auto_restore', 00:09:36 INFO - 'tabpaint']}, 00:09:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['tsvgx', 00:09:36 INFO - 'tsvgr_opacity', 00:09:36 INFO - 'tart', 00:09:36 INFO - 'tscrollx', 00:09:36 INFO - 'cart']}, 00:09:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:09:36 INFO - 'tsvgr_opacity', 00:09:36 INFO - 'tart', 00:09:36 INFO - 'tscrollx', 00:09:36 INFO - 'cart']}, 00:09:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:36 INFO - 'talos_options': ['--disable-e10s'], 00:09:36 INFO - 'tests': ['tp5o']}, 00:09:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:36 INFO - 'tests': ['tp5o']}, 00:09:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:36 INFO - 'talos_options': ['--disable-e10s', 00:09:36 INFO - '--xperf_path', 00:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:09:36 INFO - 'tests': ['tp5n']}, 00:09:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:09:36 INFO - 'talos_options': ['--xperf_path', 00:09:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:09:36 INFO - 'tests': ['tp5n']}}, 00:09:36 INFO - 'talos.zip': {'path': '', 00:09:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:09:36 INFO - Running post-action listener: _resource_record_post_action 00:09:36 INFO - [mozharness: 2016-10-04 07:09:36.540217Z] Finished populate-webroot step (success) 00:09:36 INFO - [mozharness: 2016-10-04 07:09:36.540305Z] Running create-virtualenv step. 00:09:36 INFO - Running pre-action listener: _resource_record_pre_action 00:09:36 INFO - Running main action method: create_virtualenv 00:09:36 INFO - Creating virtualenv /builds/slave/test/build/venv 00:09:36 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 00:09:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:09:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:09:36 INFO - Using real prefix '/usr' 00:09:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:09:37 INFO - Installing distribute.............................................................................................................................................................................................done. 00:09:39 INFO - Installing pip.................done. 00:09:39 INFO - Return code: 0 00:09:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:09:39 INFO - Reading from file tmpfile_stdout 00:09:39 INFO - Output received: 00:09:39 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) 00:09:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:09:39 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')]} 00:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:39 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')]} 00:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:39 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 0x7f636eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', '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 00:09:39 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 00:09:39 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 00:09:39 INFO - Using env: {'DISPLAY': ':0', 00:09:39 INFO - 'HOME': '/home/cltbld', 00:09:39 INFO - 'LANG': 'en_US.UTF-8', 00:09:39 INFO - 'LANGUAGE': 'en_US:en', 00:09:39 INFO - 'LOGNAME': 'cltbld', 00:09:39 INFO - 'MAIL': '/var/mail/cltbld', 00:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:39 INFO - 'MOZ_NO_REMOTE': '1', 00:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:09:39 INFO - 'NO_EM_RESTART': '1', 00:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:39 INFO - 'PWD': '/builds/slave/test', 00:09:39 INFO - 'SHELL': '/bin/bash', 00:09:39 INFO - 'SHLVL': '1', 00:09:39 INFO - 'TERM': 'linux', 00:09:39 INFO - 'TMOUT': '86400', 00:09:39 INFO - 'USER': 'cltbld', 00:09:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:39 INFO - '_': '/tools/buildbot/bin/python'} 00:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:39 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 00:09:39 INFO - Cleaning up... 00:09:39 INFO - Return code: 0 00:09:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:09:39 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')]} 00:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:39 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')]} 00:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:39 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 0x7f636eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', '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 00:09:39 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 00:09:39 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 00:09:39 INFO - Using env: {'DISPLAY': ':0', 00:09:39 INFO - 'HOME': '/home/cltbld', 00:09:39 INFO - 'LANG': 'en_US.UTF-8', 00:09:39 INFO - 'LANGUAGE': 'en_US:en', 00:09:39 INFO - 'LOGNAME': 'cltbld', 00:09:39 INFO - 'MAIL': '/var/mail/cltbld', 00:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:39 INFO - 'MOZ_NO_REMOTE': '1', 00:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:09:39 INFO - 'NO_EM_RESTART': '1', 00:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:39 INFO - 'PWD': '/builds/slave/test', 00:09:39 INFO - 'SHELL': '/bin/bash', 00:09:39 INFO - 'SHLVL': '1', 00:09:39 INFO - 'TERM': 'linux', 00:09:39 INFO - 'TMOUT': '86400', 00:09:39 INFO - 'USER': 'cltbld', 00:09:39 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:39 INFO - '_': '/tools/buildbot/bin/python'} 00:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:39 INFO - Downloading/unpacking psutil>=3.1.1 00:09:39 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 00:09:39 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 00:09:39 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 00:09:39 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 00:09:39 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 00:09:39 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 00:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:09:41 INFO - Installing collected packages: psutil 00:09:41 INFO - Running setup.py install for psutil 00:09:41 INFO - building 'psutil._psutil_linux' extension 00:09:41 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 00:09:42 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 00:09:42 INFO - building 'psutil._psutil_posix' extension 00:09:42 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 00:09:42 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 00:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:09:42 INFO - Successfully installed psutil 00:09:42 INFO - Cleaning up... 00:09:42 INFO - Return code: 0 00:09:42 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f636eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', '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 00:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 00:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 00:09:42 INFO - Using env: {'DISPLAY': ':0', 00:09:42 INFO - 'HOME': '/home/cltbld', 00:09:42 INFO - 'LANG': 'en_US.UTF-8', 00:09:42 INFO - 'LANGUAGE': 'en_US:en', 00:09:42 INFO - 'LOGNAME': 'cltbld', 00:09:42 INFO - 'MAIL': '/var/mail/cltbld', 00:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:42 INFO - 'MOZ_NO_REMOTE': '1', 00:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:09:42 INFO - 'NO_EM_RESTART': '1', 00:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:42 INFO - 'PWD': '/builds/slave/test', 00:09:42 INFO - 'SHELL': '/bin/bash', 00:09:42 INFO - 'SHLVL': '1', 00:09:42 INFO - 'TERM': 'linux', 00:09:42 INFO - 'TMOUT': '86400', 00:09:42 INFO - 'USER': 'cltbld', 00:09:42 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:42 INFO - '_': '/tools/buildbot/bin/python'} 00:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:42 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:09:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:09:44 INFO - Installing collected packages: mozsystemmonitor 00:09:44 INFO - Running setup.py install for mozsystemmonitor 00:09:44 INFO - Successfully installed mozsystemmonitor 00:09:44 INFO - Cleaning up... 00:09:44 INFO - Return code: 0 00:09:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:09:44 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')]} 00:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:44 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')]} 00:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:44 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 0x7f636eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', '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 00:09:44 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 00:09:44 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 00:09:44 INFO - Using env: {'DISPLAY': ':0', 00:09:44 INFO - 'HOME': '/home/cltbld', 00:09:44 INFO - 'LANG': 'en_US.UTF-8', 00:09:44 INFO - 'LANGUAGE': 'en_US:en', 00:09:44 INFO - 'LOGNAME': 'cltbld', 00:09:44 INFO - 'MAIL': '/var/mail/cltbld', 00:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:44 INFO - 'MOZ_NO_REMOTE': '1', 00:09:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:09:44 INFO - 'NO_EM_RESTART': '1', 00:09:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:44 INFO - 'PWD': '/builds/slave/test', 00:09:44 INFO - 'SHELL': '/bin/bash', 00:09:44 INFO - 'SHLVL': '1', 00:09:44 INFO - 'TERM': 'linux', 00:09:44 INFO - 'TMOUT': '86400', 00:09:44 INFO - 'USER': 'cltbld', 00:09:44 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:44 INFO - '_': '/tools/buildbot/bin/python'} 00:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:44 INFO - Downloading/unpacking jsonschema==2.5.1 00:09:44 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 00:09:44 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 00:09:44 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 00:09:44 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 00:09:44 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 00:09:44 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 00:09:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:09:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:09:46 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 00:09:46 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 00:09:46 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 00:09:46 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 00:09:46 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 00:09:46 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 00:09:46 INFO - Downloading functools32-3.2.3-2.tar.gz 00:09:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:09:47 INFO - warning: no files found matching '*.txt' 00:09:47 INFO - no previously-included directories found matching 'build' 00:09:47 INFO - no previously-included directories found matching 'dist' 00:09:47 INFO - no previously-included directories found matching '.git*' 00:09:47 INFO - Installing collected packages: jsonschema, functools32 00:09:47 INFO - Running setup.py install for functools32 00:09:47 INFO - warning: no files found matching '*.txt' 00:09:47 INFO - no previously-included directories found matching 'build' 00:09:47 INFO - no previously-included directories found matching 'dist' 00:09:47 INFO - no previously-included directories found matching '.git*' 00:09:47 INFO - Successfully installed jsonschema functools32 00:09:47 INFO - Cleaning up... 00:09:47 INFO - Return code: 0 00:09:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:47 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 0x7f636eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', '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 00:09:47 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 00:09:47 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 00:09:47 INFO - Using env: {'DISPLAY': ':0', 00:09:47 INFO - 'HOME': '/home/cltbld', 00:09:47 INFO - 'LANG': 'en_US.UTF-8', 00:09:47 INFO - 'LANGUAGE': 'en_US:en', 00:09:47 INFO - 'LOGNAME': 'cltbld', 00:09:47 INFO - 'MAIL': '/var/mail/cltbld', 00:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:47 INFO - 'MOZ_NO_REMOTE': '1', 00:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:09:47 INFO - 'NO_EM_RESTART': '1', 00:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:47 INFO - 'PWD': '/builds/slave/test', 00:09:47 INFO - 'SHELL': '/bin/bash', 00:09:47 INFO - 'SHLVL': '1', 00:09:47 INFO - 'TERM': 'linux', 00:09:47 INFO - 'TMOUT': '86400', 00:09:47 INFO - 'USER': 'cltbld', 00:09:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:47 INFO - '_': '/tools/buildbot/bin/python'} 00:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:09:47 INFO - Cleaning up... 00:09:47 INFO - Return code: 0 00:09:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:47 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 0x7f636eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', '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 00:09:47 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 00:09:47 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 00:09:47 INFO - Using env: {'DISPLAY': ':0', 00:09:47 INFO - 'HOME': '/home/cltbld', 00:09:47 INFO - 'LANG': 'en_US.UTF-8', 00:09:47 INFO - 'LANGUAGE': 'en_US:en', 00:09:47 INFO - 'LOGNAME': 'cltbld', 00:09:47 INFO - 'MAIL': '/var/mail/cltbld', 00:09:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:47 INFO - 'MOZ_NO_REMOTE': '1', 00:09:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:09:47 INFO - 'NO_EM_RESTART': '1', 00:09:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:09:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:47 INFO - 'PWD': '/builds/slave/test', 00:09:47 INFO - 'SHELL': '/bin/bash', 00:09:47 INFO - 'SHLVL': '1', 00:09:47 INFO - 'TERM': 'linux', 00:09:47 INFO - 'TMOUT': '86400', 00:09:47 INFO - 'USER': 'cltbld', 00:09:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:09:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:47 INFO - '_': '/tools/buildbot/bin/python'} 00:09:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:47 INFO - Downloading/unpacking blobuploader==1.2.4 00:09:47 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 00:09:47 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 00:09:47 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 00:09:47 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 00:09:47 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 00:09:47 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 00:09:49 INFO - Downloading blobuploader-1.2.4.tar.gz 00:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:09:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:09:49 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 00:09:49 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 00:09:49 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 00:09:49 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 00:09:49 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 00:09:49 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 00:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:09:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:09:50 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 00:09:50 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 00:09:50 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 00:09:50 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 00:09:50 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 00:09:50 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 00:09:50 INFO - Downloading docopt-0.6.1.tar.gz 00:09:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:09:50 INFO - Installing collected packages: blobuploader, requests, docopt 00:09:50 INFO - Running setup.py install for blobuploader 00:09:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:09:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:09:50 INFO - Running setup.py install for requests 00:09:50 INFO - Running setup.py install for docopt 00:09:50 INFO - Successfully installed blobuploader requests docopt 00:09:50 INFO - Cleaning up... 00:09:50 INFO - Return code: 0 00:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:09:50 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')]} 00:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:50 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')]} 00:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:50 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 0x7f636eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', '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 00:09:50 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 00:09:50 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 00:09:50 INFO - Using env: {'DISPLAY': ':0', 00:09:50 INFO - 'HOME': '/home/cltbld', 00:09:50 INFO - 'LANG': 'en_US.UTF-8', 00:09:50 INFO - 'LANGUAGE': 'en_US:en', 00:09:50 INFO - 'LOGNAME': 'cltbld', 00:09:50 INFO - 'MAIL': '/var/mail/cltbld', 00:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:50 INFO - 'MOZ_NO_REMOTE': '1', 00:09:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:09:50 INFO - 'NO_EM_RESTART': '1', 00:09:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:50 INFO - 'PWD': '/builds/slave/test', 00:09:50 INFO - 'SHELL': '/bin/bash', 00:09:50 INFO - 'SHLVL': '1', 00:09:50 INFO - 'TERM': 'linux', 00:09:50 INFO - 'TMOUT': '86400', 00:09:50 INFO - 'USER': 'cltbld', 00:09:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:50 INFO - '_': '/tools/buildbot/bin/python'} 00:09:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:09:51 INFO - Running setup.py (path:/tmp/pip-yT0WNn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:09:51 INFO - Running setup.py (path:/tmp/pip-johE2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:09:51 INFO - Running setup.py (path:/tmp/pip-XGYi_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:09:51 INFO - Running setup.py (path:/tmp/pip-s6T1MO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:09:51 INFO - Running setup.py (path:/tmp/pip-d56fB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:09:51 INFO - Running setup.py (path:/tmp/pip-psCJYC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:09:51 INFO - Running setup.py (path:/tmp/pip-cXVzFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:09:51 INFO - Running setup.py (path:/tmp/pip-322WYq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:09:51 INFO - Running setup.py (path:/tmp/pip-bipwyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:09:51 INFO - Running setup.py (path:/tmp/pip-PLfT5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:09:51 INFO - Running setup.py (path:/tmp/pip-KT13Yk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:09:51 INFO - Running setup.py (path:/tmp/pip-2va27B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:09:52 INFO - Running setup.py (path:/tmp/pip-UhBAje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:09:52 INFO - Running setup.py (path:/tmp/pip-R_ivvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:09:52 INFO - Running setup.py (path:/tmp/pip-vF68N8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:09:52 INFO - Running setup.py (path:/tmp/pip-OfSkfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:09:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:09:52 INFO - Running setup.py (path:/tmp/pip-mFQPwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:09:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:09:52 INFO - Running setup.py install for manifestparser 00:09:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:09:52 INFO - Running setup.py install for mozcrash 00:09:52 INFO - Running setup.py install for mozdebug 00:09:52 INFO - Running setup.py install for mozdevice 00:09:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:09:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:09:52 INFO - Running setup.py install for mozfile 00:09:52 INFO - Running setup.py install for mozhttpd 00:09:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:09:52 INFO - Running setup.py install for mozinfo 00:09:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Running setup.py install for mozInstall 00:09:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Running setup.py install for mozleak 00:09:53 INFO - Running setup.py install for mozlog 00:09:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Running setup.py install for moznetwork 00:09:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Running setup.py install for mozprocess 00:09:53 INFO - Running setup.py install for mozprofile 00:09:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Running setup.py install for mozrunner 00:09:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:09:53 INFO - Running setup.py install for mozscreenshot 00:09:53 INFO - Running setup.py install for moztest 00:09:54 INFO - Running setup.py install for mozversion 00:09:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:09:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:09:54 INFO - Cleaning up... 00:09:54 INFO - Return code: 0 00:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:54 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 0x7f636eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', '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 00:09:54 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 00:09:54 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 00:09:54 INFO - Using env: {'DISPLAY': ':0', 00:09:54 INFO - 'HOME': '/home/cltbld', 00:09:54 INFO - 'LANG': 'en_US.UTF-8', 00:09:54 INFO - 'LANGUAGE': 'en_US:en', 00:09:54 INFO - 'LOGNAME': 'cltbld', 00:09:54 INFO - 'MAIL': '/var/mail/cltbld', 00:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:54 INFO - 'MOZ_NO_REMOTE': '1', 00:09:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:09:54 INFO - 'NO_EM_RESTART': '1', 00:09:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:54 INFO - 'PWD': '/builds/slave/test', 00:09:54 INFO - 'SHELL': '/bin/bash', 00:09:54 INFO - 'SHLVL': '1', 00:09:54 INFO - 'TERM': 'linux', 00:09:54 INFO - 'TMOUT': '86400', 00:09:54 INFO - 'USER': 'cltbld', 00:09:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:54 INFO - '_': '/tools/buildbot/bin/python'} 00:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:09:54 INFO - Running setup.py (path:/tmp/pip-y12w9C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:09:54 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)) 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:09:54 INFO - Running setup.py (path:/tmp/pip-7Fnh_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:09:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:09:54 INFO - Running setup.py (path:/tmp/pip-D95wVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:09:54 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)) 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:09:54 INFO - Running setup.py (path:/tmp/pip-YkjxP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:09:54 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)) 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:09:54 INFO - Running setup.py (path:/tmp/pip-DlQKA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:09:54 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)) 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:09:54 INFO - Running setup.py (path:/tmp/pip-f6CzXA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:09:54 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)) 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:09:54 INFO - Running setup.py (path:/tmp/pip-PQdJxf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:09:54 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)) 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:09:54 INFO - Running setup.py (path:/tmp/pip-JtPMti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:09:54 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)) 00:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:09:54 INFO - Running setup.py (path:/tmp/pip-N1enRS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:09:55 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)) 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:09:55 INFO - Running setup.py (path:/tmp/pip-bdc5Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:09:55 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)) 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:09:55 INFO - Running setup.py (path:/tmp/pip-9aYNiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:09:55 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)) 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:09:55 INFO - Running setup.py (path:/tmp/pip-SjxARr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:09:55 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)) 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:09:55 INFO - Running setup.py (path:/tmp/pip-0L7nMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:09:55 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)) 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:09:55 INFO - Running setup.py (path:/tmp/pip-mNIDjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:09:55 INFO - Running setup.py (path:/tmp/pip-lZQiey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:09:55 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)) 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:09:55 INFO - Running setup.py (path:/tmp/pip-EoRo_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:09:55 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)) 00:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:09:55 INFO - Running setup.py (path:/tmp/pip-YO593e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:09:55 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)) 00:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 00:09:55 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)) 00:09:55 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)) 00:09:55 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)) 00:09:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:09:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:09:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:09:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:09:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:09:57 INFO - Downloading blessings-1.6.tar.gz 00:09:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:09:57 INFO - Installing collected packages: blessings 00:09:57 INFO - Running setup.py install for blessings 00:09:57 INFO - Successfully installed blessings 00:09:57 INFO - Cleaning up... 00:09:57 INFO - Return code: 0 00:09:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:09:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:09:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:09:57 INFO - Reading from file tmpfile_stdout 00:09:57 INFO - Current package versions: 00:09:57 INFO - argparse == 1.2.1 00:09:57 INFO - blessings == 1.6 00:09:57 INFO - blobuploader == 1.2.4 00:09:57 INFO - docopt == 0.6.1 00:09:57 INFO - functools32 == 3.2.3-2 00:09:57 INFO - jsonschema == 2.5.1 00:09:57 INFO - manifestparser == 1.1 00:09:57 INFO - mozInstall == 1.12 00:09:57 INFO - mozcrash == 0.17 00:09:57 INFO - mozdebug == 0.1 00:09:57 INFO - mozdevice == 0.48 00:09:57 INFO - mozfile == 1.2 00:09:57 INFO - mozhttpd == 0.7 00:09:57 INFO - mozinfo == 0.9 00:09:57 INFO - mozleak == 0.1 00:09:57 INFO - mozlog == 3.4 00:09:57 INFO - moznetwork == 0.27 00:09:57 INFO - mozprocess == 0.23 00:09:57 INFO - mozprofile == 0.28 00:09:57 INFO - mozrunner == 6.12 00:09:57 INFO - mozscreenshot == 0.1 00:09:57 INFO - mozsystemmonitor == 0.3 00:09:57 INFO - moztest == 0.7 00:09:57 INFO - mozversion == 1.4 00:09:57 INFO - psutil == 3.1.1 00:09:57 INFO - requests == 1.2.3 00:09:57 INFO - wsgiref == 0.1.2 00:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:58 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 0x7f636eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', '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 00:09:58 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 00:09:58 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 00:09:58 INFO - Using env: {'DISPLAY': ':0', 00:09:58 INFO - 'HOME': '/home/cltbld', 00:09:58 INFO - 'LANG': 'en_US.UTF-8', 00:09:58 INFO - 'LANGUAGE': 'en_US:en', 00:09:58 INFO - 'LOGNAME': 'cltbld', 00:09:58 INFO - 'MAIL': '/var/mail/cltbld', 00:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:58 INFO - 'MOZ_NO_REMOTE': '1', 00:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:09:58 INFO - 'NO_EM_RESTART': '1', 00:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:58 INFO - 'PWD': '/builds/slave/test', 00:09:58 INFO - 'SHELL': '/bin/bash', 00:09:58 INFO - 'SHLVL': '1', 00:09:58 INFO - 'TERM': 'linux', 00:09:58 INFO - 'TMOUT': '86400', 00:09:58 INFO - 'USER': 'cltbld', 00:09:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:58 INFO - '_': '/tools/buildbot/bin/python'} 00:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:58 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)) 00:09:58 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)) 00:09:58 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)) 00:09:58 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)) 00:09:58 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)) 00:09:58 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)) 00:09:58 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)) 00:09:58 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)) 00:09:58 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)) 00:09:58 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)) 00:09:58 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)) 00:09:58 INFO - Cleaning up... 00:09:58 INFO - Return code: 0 00:09:58 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:09:58 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')]} 00:09:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:09:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:58 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')]} 00:09:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:09:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:09:58 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 0x7f636eb29f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20b98a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2186ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, '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': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', '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 00:09:58 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 00:09:58 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 00:09:58 INFO - Using env: {'DISPLAY': ':0', 00:09:58 INFO - 'HOME': '/home/cltbld', 00:09:58 INFO - 'LANG': 'en_US.UTF-8', 00:09:58 INFO - 'LANGUAGE': 'en_US:en', 00:09:58 INFO - 'LOGNAME': 'cltbld', 00:09:58 INFO - 'MAIL': '/var/mail/cltbld', 00:09:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:09:58 INFO - 'MOZ_NO_REMOTE': '1', 00:09:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:09:58 INFO - 'NO_EM_RESTART': '1', 00:09:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:09:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:09:58 INFO - 'PWD': '/builds/slave/test', 00:09:58 INFO - 'SHELL': '/bin/bash', 00:09:58 INFO - 'SHLVL': '1', 00:09:58 INFO - 'TERM': 'linux', 00:09:58 INFO - 'TMOUT': '86400', 00:09:58 INFO - 'USER': 'cltbld', 00:09:58 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:09:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:09:58 INFO - '_': '/tools/buildbot/bin/python'} 00:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:09:58 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:09:58 INFO - Cleaning up... 00:09:58 INFO - Return code: 0 00:09:58 INFO - Running post-action listener: _resource_record_post_action 00:09:58 INFO - Running post-action listener: _start_resource_monitoring 00:09:58 INFO - Starting resource monitoring. 00:09:58 INFO - [mozharness: 2016-10-04 07:09:58.493611Z] Finished create-virtualenv step (success) 00:09:58 INFO - [mozharness: 2016-10-04 07:09:58.494120Z] Running install step. 00:09:58 INFO - Running pre-action listener: _resource_record_pre_action 00:09:58 INFO - Running main action method: install 00:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:09:58 INFO - Reading from file tmpfile_stdout 00:09:58 INFO - Detecting whether we're running mozinstall >=1.0... 00:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:09:58 INFO - Reading from file tmpfile_stdout 00:09:58 INFO - Output received: 00:09:58 INFO - Usage: mozinstall [options] installer 00:09:58 INFO - Options: 00:09:58 INFO - -h, --help show this help message and exit 00:09:58 INFO - -d DEST, --destination=DEST 00:09:58 INFO - Directory to install application into. [default: 00:09:58 INFO - "/builds/slave/test"] 00:09:58 INFO - --app=APP Application being installed. [default: firefox] 00:09:58 INFO - mkdir: /builds/slave/test/build/application 00:09:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 00:09:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 00:10:14 INFO - Reading from file tmpfile_stdout 00:10:14 INFO - Output received: 00:10:14 INFO - /builds/slave/test/build/application/firefox/firefox 00:10:14 INFO - Running post-action listener: _resource_record_post_action 00:10:14 INFO - [mozharness: 2016-10-04 07:10:14.936557Z] Finished install step (success) 00:10:14 INFO - [mozharness: 2016-10-04 07:10:14.936811Z] Running run-tests step. 00:10:14 INFO - Running pre-action listener: _resource_record_pre_action 00:10:14 INFO - Running main action method: run_tests 00:10:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:10:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:10:14 INFO - Python 2.7.3 00:10:14 INFO - Return code: 0 00:10:14 INFO - grabbing minidump binary from tooltool 00:10:14 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')]} 00:10:14 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 0x2183f60>, '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 0x2184d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21851d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:10:14 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 00:10:14 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 00:10:14 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 00:10:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:10:15 INFO - Return code: 0 00:10:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:10:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:10:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:10:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:10:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:10:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 00:10:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --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 00:10:15 INFO - Using env: {'DISPLAY': ':0', 00:10:15 INFO - 'HOME': '/home/cltbld', 00:10:15 INFO - 'LANG': 'en_US.UTF-8', 00:10:15 INFO - 'LANGUAGE': 'en_US:en', 00:10:15 INFO - 'LOGNAME': 'cltbld', 00:10:15 INFO - 'MAIL': '/var/mail/cltbld', 00:10:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:10:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:10:15 INFO - 'MOZ_NO_REMOTE': '1', 00:10:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:10:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:10:15 INFO - 'NO_EM_RESTART': '1', 00:10:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:10:15 INFO - 'PWD': '/builds/slave/test', 00:10:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:10:15 INFO - 'SHELL': '/bin/bash', 00:10:15 INFO - 'SHLVL': '1', 00:10:15 INFO - 'TERM': 'linux', 00:10:15 INFO - 'TMOUT': '86400', 00:10:15 INFO - 'USER': 'cltbld', 00:10:15 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196', 00:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:10:15 INFO - '_': '/tools/buildbot/bin/python'} 00:10:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--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 00:10:15 INFO - mozversion application_buildid: 20161003231102 00:10:15 INFO - mozversion application_changeset: 0149927a63f3f49827f5477809cafbf070983b73 00:10:15 INFO - mozversion application_display_name: Nightly 00:10:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:10:15 INFO - mozversion application_name: Firefox 00:10:15 INFO - mozversion application_remotingname: firefox 00:10:15 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 00:10:15 INFO - mozversion application_vendor: Mozilla 00:10:15 INFO - mozversion application_version: 52.0a1 00:10:15 INFO - mozversion platform_buildid: 20161003231102 00:10:15 INFO - mozversion platform_changeset: 0149927a63f3f49827f5477809cafbf070983b73 00:10:15 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 00:10:15 INFO - mozversion platform_version: 52.0a1 00:10:15 INFO - using testdate: 1475565015 00:10:15 INFO - actual date: 1475565015 00:10:15 INFO - starting webserver on 'localhost:37755' 00:10:15 INFO - SUITE-START | Running 2 tests 00:10:15 INFO - TEST-START | dromaeo_css 00:10:15 INFO - operating with platform_type : linux_ 00:10:15 INFO - Initialising browser for dromaeo_css test... 00:10:15 INFO - TEST-INFO | started process 7755 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBRnZcJ/profile http://localhost:37755/getInfo.html) 00:10:20 INFO - PROCESS | 7755 | __metrics Screen width/height:1600/1200 00:10:20 INFO - PROCESS | 7755 | colorDepth:24 00:10:20 INFO - PROCESS | 7755 | Browser inner width/height: 1024/697 00:10:20 INFO - PROCESS | 7755 | __metrics 00:10:20 INFO - PROCESS | 7755 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:10:20 INFO - PROCESS | 7755 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:10:21 INFO - PROCESS | 7755 | console.error: PushService: 00:10:21 INFO - PROCESS | 7755 | stateChangeProcessEnqueue: Error transitioning state 00:10:21 INFO - PROCESS | 7755 | UnknownError 00:10:22 INFO - TEST-INFO | 7755: exit 0 00:10:22 INFO - Browser initialized. 00:10:22 INFO - Running cycle 1/1 for dromaeo_css test... 00:10:22 INFO - TEST-INFO | started process 7837 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBRnZcJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:10:34 INFO - PROCESS | 7837 | RSS: Main: 177467392 00:10:34 INFO - PROCESS | 7837 | 00:11:26 INFO - PROCESS | 7837 | 1475565086466 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] 00:13:39 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37755/tests/dromaeo/cssquery-ext.html) 00:13:40 INFO - PROCESS | 7837 | RSS: Main: 264237056 00:13:40 INFO - PROCESS | 7837 | 00:16:43 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-ext.html (next: http://localhost:37755/tests/dromaeo/cssquery-jquery.html) 00:16:43 INFO - PROCESS | 7837 | RSS: Main: 274477056 00:16:43 INFO - PROCESS | 7837 | 00:19:46 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37755/tests/dromaeo/cssquery-mootools.html) 00:19:46 INFO - PROCESS | 7837 | RSS: Main: 221036544 00:19:46 INFO - PROCESS | 7837 | 00:22:49 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37755/tests/dromaeo/cssquery-prototype.html) 00:22:49 INFO - PROCESS | 7837 | RSS: Main: 242745344 00:22:49 INFO - PROCESS | 7837 | 00:25:52 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37755/tests/dromaeo/cssquery-yui.html) 00:25:53 INFO - PROCESS | 7837 | RSS: Main: 221532160 00:25:53 INFO - PROCESS | 7837 | 00:28:56 INFO - PROCESS | 7837 | Cycle 1(1): loaded http://localhost:37755/tests/dromaeo/cssquery-yui.html (next: http://localhost:37755/tests/dromaeo/cssquery-dojo.html) 00:28:56 INFO - PROCESS | 7837 | RSS: Main: 306757632 00:28:56 INFO - PROCESS | 7837 | 00:28:56 INFO - PROCESS | 7837 | __start_tp_report 00:28:56 INFO - PROCESS | 7837 | _x_x_mozilla_page_load 00:28:56 INFO - PROCESS | 7837 | _x_x_mozilla_page_load_details 00:28:56 INFO - PROCESS | 7837 | |i|pagename|runs| 00:28:56 INFO - PROCESS | 7837 | |0;dojo.html;2561.9487610247797;2565.5253778051074;2567.127176759902;2630.1452028090876;2643.5770276755725;4563.087382523492;4622.838200662969;4631.421072365954;4700.529947005302;4713.151632706115;4649.58153766161;4688.812447502096;4724.126036683216;4750.643701722376;4794.976025119879;4242.766647834368;4260.105377870651;4309.870703878889;4325.134973005396;4331.45856767904;4358.825646974117;4386.276264416383;4389.736615803046;4401.471823381183;4446.844360447385;4247.511536173318;4383.868483945486;4387.758673272969;4393.956060439403;4480.619147372461;4259.424977628011;4286.03564198056;4316.848910288125;4326.870193894189;4337.284348082562;4318.1363727254675;4318.676099292534;4326.351047342892;4366.4105345778235;4373.343998400265;4674.228752255874;4685.976570117162;4694.765261736934;4709.317149013408;4715.622750180011;4814.8796280093275;4869.829555965524;4884.169691152512;4967.701937883702;5015.14742493777;5057.974710126426;5063.113955057887;5073.518015788531;5097.006083813658;5109.463506331856;4708.034852855157;4709.411323584552;4717.9292310615365;4727.57451829337;4778.211595086772;4861.611071114302;4897.265410188429;4897.975510122426;5170.75457115644;5236.607254455931;4768;4769.165396055676;4771.856844294677;4775.976120119447;4841.588464980516;4942.9258561121615;4968.080905032581;5033.748312584356;5034.16936205522;5035.571976381975;4915.508449155127;4917.704937703749;4928.383952005999;4934.432540257844;4947.158982972904;4801.159797035505;4936.851894443173;4946.233333833262;4946.258061290835;5005.474425185376;4206.095689426788;4253.532111467736;4254.234237837219;4260.765657888784;4265.296226122655;3707.8146092695797;3724.944125838115;3741.28915506053;3769.981150094232;3813.866514671973;4306.0957198987935;4308.116836048603;4312.029793296546;4356.8910777230185;4362.280223763107;5048.469910659402;5053.494650534917;5063.3417655704525;5070.832979875327;5084.542391184737;4210.663146948237;4234.110836724322;4251.744895306291;4276.444062271885;4293.377460268243;4536.705114167568;4539.523350048264;4584.770761461914;4594.425696787902;4603.49361570227;4685.929711054337;4695.413073365829;4696.248600224016;4699.718016918996;4753.47711751714;4868.853934381974;4924.285978533164;5032.169692000779;5041.722705251246;5046.1926091825135;4604.700694454849;4637.25803871379;4639.327297541905;4655.743934083658;4664.067186562633;4870.099031679009;4888.266759985889;4982.078315511642;4983.053219888209;5048.419431765247;4793.065352256416;5008.599312054954;5069.7465126744255;5071.39143302806;5133.614978876524;4691.03833714081;4856.757162141949;4890.413150421972;4894.877628059185;4918.409790825124;4886.767603751;4913.189323761682;4920.237363208708;4933.4819843915875;4987.725675087905;4655.976720116378;4811.711297322172;4834.0331933612715;4843.370361852936;4900.264960255848;4785.736784476887;4818.084563932842;4889.022195560831;4889.682170658896;4941.703497790144;4747.8575642730775;4753.524647535219;4755.714657120584;4758.04839032188;4815.253635686474 00:28:56 INFO - PROCESS | 7837 | |1;ext.html;551.4568150371883;566.6033776356549;579.1255204640994;581.4708615160205;584.3922320786382;28501.714982850164;29234;30912.227194320127;38473.23053538927;39834.40248396277;40205.59794402062;40713.79643101788;40741.18517629646;40799.79600101995;40804.795976020076;7599.430042746802;7748.108967468757;7750.341220996222;7752.147263800977;7760.650770715331;7553.622318884034;7616.276453736886;7628.466007379486;7639.236076392372;7641.465097443182;7631.885521717151;7668.884966725504;7675.117361503443;7677.500962437423;7679.193684663113;7628.199039100898;7656.0047193865;7668.616569171575;7671.232876712284;7674.769756907246;7629.427792915553;7680.500767450154;7681.078270607507;7685.308322251024;7685.615719214017;37978.24043519114;38321.61678383236;38332.61667383318;38372.808135959145;38380.23239535194;2626.6716660417446;2676.397810492643;2745.3685652299882;2751.0508874438287;2758.5724212747054;28273.15180544587;28289;28358.574621380696;28458;29110.708892911225;3265.510173473998;3445.242046749711;3452.3267962747273;3456.2914602506426;3506.579210494757;242461;243768;243819;244106;244739.99999999822;50218.497815022114;50412.49587504152;50475.74762126166;50507;50514.242286365734;32969.505457418156;33724.83137584345;33747.15632109217;47272.290915636295;47604.52395476001;14920.850791492163;15312.464063757938;15331.463398780988;15347.232638368037;15347.769783453257;11001.17491188164;11019.283746556448;11021.063209627111;11028.28316159447;11029.96675914114;17648;17751.733723993893;17778.46664600064;17832.821671783116;17894.642107158044;6659.836577625686;6741.528093033538;6885.793426197222;6907.585544867324;6996.510244282953;774.5507605588745;940.2947789158131;977.9022097790164;986.0189111833771;1027.0705011964185;27163.64181790942;27686.723132768413;27878.3030424241;28186;28663.856680716464;926.120185823457;938.7183844846519;966.4394651102343;970.315927271272;995.6316163019729;14689.338979745937;14985.775213371808;15048;15048.774268385983;15323.61690957735;114298;114446.42776786063;115003;115371.42314288375;115697.4215128919;49179.754101229264;49358.75320623374;49414.25878611824;49431.50568494341;49482;1052.984205236922;1087.396494945297;1118.681175864891;1132.1678566253797;1178.293024185499;27579.72420275852;28592;29306.267343316587;29514;29742.405151897274;40709;41037.38443923403;41110.38334425046;41158.794206028775;41234.79382603068;241101;241155;241311;242601;242641;22080.668789967844;22784;24032.75967240375;24884.253472395856;25058.37354066163;40431.59568404396;40540;40883.79558102191;41042.9739256521;42083;35511;35609.46585801163;35745.642543574235;35756;36601.63398365982;34708.305833882674;34719.4792078114;35103.47344789881;35136;35186;34677.47983780195;35215;35255;35549.111272218404;36069.819650901576;30165.3966920656;32170;32462.837685812363;32511.674883250864;32547.34905301928;24228.878855606315;24262.393440164138;24668.259952201464;24928.252152435456;24975.87512062428 00:28:56 INFO - PROCESS | 7837 | |2;jquery.html;351.7414700195356;358.0743777335587;364.3532729405306;372.1849150360712;378.35112781579585;15447.227638618066;16545.834541654578;17335.47993560192;17451.127443627833;17467.47597572075;16567.585810354747;16749.330026798943;16952.660946781056;17025.744613830804;17123.657526849456;4897;5156.845294641167;5161.225816127573;5168.8707782305555;5173.430922598511;3641.4537819327047;3853.5183102112237;5041.647084704072;5639.971800140994;5914.438128377818;5998.670073145975;6001.729922153513;6003.339632640428;6005.039193729004;6011.669358185298;5776.942230577703;6019.969900150515;6027.035674292092;6054.878902421927;6058.091286307045;4565.56627120423;5308.416074231832;5308.973455132738;5314.229436731691;5316.149416093445;17824;19103.904480477646;19142.425727228205;19183.32858349965;19257.807421925743;1726.2231995602028;1862.9906850465798;2012.9597408051904;2241.9663705044436;2319.7100362454694;8477;9090.50002249876;9266.07339266068;9314.068593140699;9596.568154433067;1637.778899848517;1643.6301832087804;1658.3035125247304;1697.7962644482618;1718.9570260743455;61767.11726123843;68299;69107.65446172787;71068.64465677639;72522.2747772526;9465.47939863314;9568.09103135201;9638.95180524107;9707.951460242653;9858.359206651545;12872.935635321763;12979.675508112185;12990.415431305424;12996.610101696964;13003.609891703263;7261.782146535613;7351.558906465629;7362.4478164136835;7451.007824757317;7452.888206676904;7209.770314343181;7266.85627739818;7374.631268436557;7452.925470745332;7464.776056718307;3816.6183381662167;4038.9798051009557;4092.07928216149;4132.8140233688955;4181.310083836133;1618.4739959513206;1673.8577220936113;1685.2669088946348;1699.4731633193749;1785.660724462374;786.4769927997932;818.2799136759613;855.362754747717;924.2790623313691;941.6280569175137;15771.68456630861;16428.67142657164;16524.25640846165;16608.25262863174;17052.317907283817;810.6473683947502;820.885076089348;838.2078935406105;855.5593869157389;878.5168157513342;9056.13966673165;9088.81822363549;9403.811923761486;9492.667756628485;9495.240380769523;323497;345055;360828;361032;361197;47505;47907.520924791;72179.63910180416;72717.6364118176;77725;858.4806192253722;871.1375738019316;875.0287181228831;875.0330884372804;877.2587163846539;14068.437262509386;14215.218163001135;14460.638484037983;14494.85505144935;15035.699286014436;35530.467042993856;35815.28369432649;36963.63036369602;37127.81436092802;37221.813890930374;46323.30515042209;48960.75519622379;49269;49328.26007609961;50093.49906500888;7260.528065675714;7383.889241661487;7467.402607791255;7555.460559998667;7665.46341756094;8579.056303806452;10555.419451930218;11286.66140015801;11542.307461552333;12297.32364719949;6868.793936181923;9766.401590457257;10108.898911010796;10165.085142337226;10465.738356541147;10002.199824014207;10147.391156530632;10507.842382364424;10544;10565.154787616819;10030.147437467605;10259.17926565858;10442.373457592568;10447.320924139907;10985.780284394108;7436.107667079985;7468.663910123949;7751.806204844698;7752.418568607264;7759.495632783851;9476.810463790824;9957.850632240377;9993.700188994342;10130.594776208869;10397.376157430579 00:28:56 INFO - PROCESS | 7837 | |3;mootools.html;1319.0634649398926;1363.1684672349868;1398.5454727213657;1625.1224338857019;1658.2620733773467;7001.474889383291;7563.848723025536;7572.659230334634;7575.507592006516;7583.09002919649;6428.132202152708;6678.7996360109155;6894.44844412447;7059.117610298713;7070.5050646454765;1962.0189905047475;1980.8514361422879;1981.2273213446767;1983.6231116087897;1993.2824183294003;1943.7375954246208;1962.7939066397964;1986.6026794641057;1991.7709463411675;1995.092233033966;1722.9224684889148;1761.947141585748;1944.0862794486638;1999.4401567561033;2081.4067990622675;1981.7423734914512;1988.463114958953;2001.7197592337084;2002.5594369238745;2002.7496562929707;1963.577830766392;1965;1978.584497255578;1983.5338695406567;1985.2753744883014;7462.179160292363;7553;7556.168821429638;7561.39508839297;7561.584112873789;4156.605122513356;4365.781710914442;4373.715708478939;4374.715643483163;4375.540568240321;2620.9082682106036;2748.69764325924;2764.7649949754295;2773.833569985807;2799.9020034298906;783.7296132834163;814.5357146426539;822.0874828939872;822.3955392786297;828.200786241274;9478.526073696288;9719;9720.708378748579;9949.751256218507;9957.153641940444;3671.81640917953;3753.9812300938866;3781.697464202857;3827.119762454651;3889.5138107736534;7614.619269036637;7614.8096297593;7620.885686714703;7631.3894888408795;7632.694692212361;4246.7027308088755;4253.97873010633;4256.59562341577;4258.893527661771;4259.765712885821;3955.960440395617;3961.069148750041;3961.3859851723028;3963.7819919904105;3963.841446342172;3099.1167517257472;3143.764217683637;3252.3007553376137;3254.6257180424554;3318.7676862619387;953.3183773601908;955.5843208204315;961.8172547216006;965.4689920543673;982.6413359123868;785.0030461314099;796.8565658181583;798.5129071266523;813.89419375482;817.3665409307833;4699.154152252628;4762.261849413347;4810.254410566367;4889.755512224375;5058.519440653132;797.9905419644155;870.7648934787572;882.1311008656468;912.7353067610319;931.8817419097111;3438.4183275693463;3514.648535146516;3555.8577656893435;3613.9096522587147;3663.2856592964117;8606.741797746077;8608.096149904295;8787.121287871161;8812.647494100293;8817.735467935972;8677.696280630147;8750.081241469681;8783.692570759993;8844.115588441104;8868.733937981871;6561.901571476432;6682.264950855402;6685.364890335411;6695.4308883745425;6698.129243198353;5075.7969681212335;5128.461511541234;5197.584193264605;5257.8159764408065;5312.1766126250495;8339.541325226928;8350.457220280905;8434.536100514531;8438.66245350179;8504.659813607386;8192.508449493049;8487;8515.48907065578;8529.402941794015;8576.228139467477;6393.87212255743;6511.934880651323;6516.934830651633;6518.804435866931;6525.64108974011;6698.296678848846;6840.31596840312;6893.241743408121;6902.033715279765;6919.654017299215;5277.498637629419;5984.401559844155;6010.068439391901;6133.3866613338305;6222.937770622417;5979.1031345296815;6038.3357830637715;6056.757729690763;6105.328413874559;6220.066989951543;5487.176923461353;5641.435856414326;5671.971640141773;5741.081426971665;5810.82567522975;4230.471191101113;4332.501762297376;4414.095110502275;4423.977880110708;4499.460064792246;4301.483821941387;4367.956320436882;4391.209582275221;4413.933790993202;4529.8641040768825 00:28:56 INFO - PROCESS | 7837 | |4;prototype.html;275.52747038828414;277.25556879777787;284.5504103516444;287.1099591267072;287.26746795671033;4597.586217240448;4667.323238130473;4758.809647614095;4761.40482439695;4780.354652121962;4574.5882870541645;4682.812687492505;4696.647751418649;4704;4724.763761811912;3734.8692795752154;3740.6446387593137;3742.5134732484808;3743.4197699356505;3748.6813620842263;3538.168530395355;3674.1549443627982;3745.6628903398687;3751.624837516254;3761.981190094046;3588.659077387644;3690.9815450922843;3710.888673339791;3712.2761061593;3717.1006614840335;3701.4262789267705;3701.851925922987;3708.962910370902;3712.6844218241345;3714.665680088805;3259.951100733491;3265.2163480764684;3265.314284000363;3268.006516025223;3275.852586633607;4497.280435130396;4590.540945905383;4594.678372513926;4646.465656449518;4649.604783593399;4224.260754367973;4225.577442255781;4233.23801715691;4233.407322974786;4245.214635292481;4963.4292056413615;4965.708915681913;4966.975165124188;4968.627352948543;4973.651844370896;3421.264428147935;3548.520949671787;3566.983409728241;3571.357155711971;3575.0526110580718;5176.482351764831;5182.404023537266;5196.142636465017;5196.532312091892;5197.714125723083;3628.8387715931176;3637;3640.4903313536124;3641.672249497505;3642;3679.4480827875495;3685.576158741779;3690.1697118148204;3691.8892433227047;3693.8153092345815;3926.960730392717;4133.834646614162;4151.958480415217;4161.62545370912;4217.957820421818;4949;4958;4975.164156430872;4982.950170498321;4993.201087825931;1177.1053998960851;1203.8796120388067;1208.3173007250875;1241.993790031044;1254.4605819497522;831.0941074228998;848.6605357856906;852.8123812761182;852.9701460448979;858.9012263589642;4317.266064768934;4321.762303073361;4345.9574000219845;4349.869503914888;4350.60844523988;5055.9494405055475;5065.696058236517;5072.923906141411;5085.313482679865;5098.796048158107;4208.200441916026;4300.827966881289;4320.200762858881;4328.558795757381;4340.674449416307;2384.7464146381503;2397.868117253568;2406.6871306730013;2407.7592240776135;2421.4067553449518;4156.542780294165;4204.873853784391;4233.470816147981;4235.411720604773;4240.321548552217;4386.692931494828;4597.747123908151;4620.53794620542;4623.711262924874;4661.580457758818;4240.38514415408;4241.8366633018;4260.275753122039;4296.570342965679;4304.364341550191;4491.371208030943;4500.234960056864;4510.977445112753;4522.4573051234065;4524;4301;4445.844395446144;4468.687191896666;4482.977585112054;4482.977585112054;4244.554321796167;4259.74441533509;4282.40046393499;4289.978550107229;4293.935590966075;3184.7420268994083;3211.6627754085484;3219.597550306212;3244.351129774102;3246.4967929970894;4448.552371911795;4455.398521199597;4467.436397260933;4507.233770259129;4513.68404211702;4179.9582004179565;4371.803268852846;4390.429244198233;4401.691881568259;4405.29515277554;4381.737095774264;4403.82384704621;4408.867733967986;4409.316555933835;4411.757353345597;4337.783110844508;4340.8697739067875;4390.136679721824;4706.247000479907;4814.542618451242;4731.124741922756;4940.60475161979;4979.128652485728;4980.331588917608;4989.925151122663;4908.410990680998;4916.606671466203;4922.163232250455;4926.458089610212;4945.159322915185 00:28:56 INFO - PROCESS | 7837 | |5;yui.html;553.7508121345394;571.1632458448374;591.1841658511254;601.1463721515449;607.4957785038416;11487.25332853364;12565.685857853558;12637.936810315958;12639.620811375651;12639.873601263997;12350.62948111558;12775.233485990848;12837.935810320958;12904.419301131447;13279;749.2507492507492;771.3366504805863;772.1583474013353;773.5590713293425;774.0749803984213;619.5446346934999;636.6371168433994;756.0322786832835;782.6478084861807;785.0344076785557;810.9716159934403;811.7808191788214;812.9024517057961;813.0203105258149;813.032491335309;799.073075232733;802.7872613757359;807.7576726981882;808.0424696734359;808.1796976069294;475.6884240822267;483.86935527407405;577.6447484796862;588.6615196262167;593.5281451246269;12272.386380681019;12285.14004019719;12292.139550231488;12311.630651080482;12316.753664926651;12027.93986030073;12619.621411357582;12642.810357844639;12704.809427858498;13271.933640331834;11127;11174.45496850268;11242.156838237082;11398;11844.585439509576;4030.9630461910033;4130.979345103286;4145.66834653227;4146.460960075171;4156.521999970012;61204.77590448211;62555;63542.364576354106;63571.68214158899;63730.362696372904;10068.899311006797;10176.847347289797;10181.287309888237;10219.48902554884;10285.43430111351;19624.803751962583;19667.901660491607;19739.802601973795;19791;19979.800201998085;6539.313372095957;6625.933740662628;6646.567973081831;6660;6739.460843132636;3431.7083047941205;3537.5401197844117;3578.821058947094;3605.7836529808296;3653.2510835278704;2805.6072149899032;2910.301527633395;2911.083008852205;2913.2134323732475;2917.226934862263;497.2144012460304;501.6155411065413;506.4530307268142;507.8857257117193;514.3185279504596;463.53646353646354;518.7250757098743;528.9735513224323;529.1922880629523;538.8160930375636;7501.587412692245;7621.809454763676;7684.11632662251;7806.219378062262;7926;459.2789320766432;500.8797888506732;503.66757939760316;528.0600531054652;567.1521075991419;3598.47822065799;3623.7825730456257;3657.6890964267805;3667.504886840296;3689.612590677994;96417.51791241;99693.03683557875;101680;104730.47634761778;105156;86028.56985715032;87081.56459217664;91642;92683;93307.53346233226;77868.61065694636;79226;79456.20543794488;80323;80405.59797200977;6989.580625162506;7274.090738657668;7285.344319011315;7288.562686238843;7335.926640733524;43870.78064609784;43884.12231755411;44724.55275447334;45381.31928021016;45765;37646;37888;38066.42900356552;48391.758041210975;65106;9016.549172541478;9086.954565227132;9304.906950930676;9323.114304141096;9448.196903263024;9793.804123917624;10147.086762191439;10149.847752283575;10190.796184076426;10223.744406389602;8947.239484643618;9217.76955576116;9238.815223695623;9336.766580835534;9528.333016688764;9500.85748713756;10672.57309707603;11075.169362298022;11076.169287303323;11251.887481125084;11469.598564050219;11668.88331116678;11765.235259708434;12441.813372799596;12477.251364918135;9572.952135239559;9935.751606209902;10084.596616135272;10234.795304094025;10445.68662940113;9753.609855605697;10067.244956628136;10123.797524049625;10368.118709909742;10411.531481083219 00:28:56 INFO - PROCESS | 7837 | __end_tp_report 00:28:56 INFO - PROCESS | 7837 | __start_cc_report 00:28:56 INFO - PROCESS | 7837 | _x_x_mozilla_cycle_collect,1282 00:28:56 INFO - PROCESS | 7837 | __end_cc_report 00:28:56 INFO - PROCESS | 7837 | __startTimestamp1475566136549__endTimestamp 00:28:56 INFO - PROCESS | 7837 | 00:28:56 INFO - PROCESS | 7837 | ------- Summary: start ------- 00:28:56 INFO - PROCESS | 7837 | Number of tests: 6 00:28:56 INFO - PROCESS | 7837 | 00:28:56 INFO - PROCESS | 7837 | [#0] dojo.html Cycles:165 Average:4620.71 Median:4727.57 stddev:475.79 (10.1%) stddev-sans-first:449.01 00:28:56 INFO - PROCESS | 7837 | Values: 2561.9 2565.5 2567.1 2630.1 2643.6 4563.1 4622.8 4631.4 4700.5 4713.2 4649.6 4688.8 4724.1 4750.6 4795.0 4242.8 4260.1 4309.9 4325.1 4331.5 4358.8 4386.3 4389.7 4401.5 4446.8 4247.5 4383.9 4387.8 4394.0 4480.6 4259.4 4286.0 4316.8 4326.9 4337.3 4318.1 4318.7 4326.4 4366.4 4373.3 4674.2 4686.0 4694.8 4709.3 4715.6 4814.9 4869.8 4884.2 4967.7 5015.1 5058.0 5063.1 5073.5 5097.0 5109.5 4708.0 4709.4 4717.9 4727.6 4778.2 4861.6 4897.3 4898.0 5170.8 5236.6 4768.0 4769.2 4771.9 4776.0 4841.6 4942.9 4968.1 5033.7 5034.2 5035.6 4915.5 4917.7 4928.4 4934.4 4947.2 4801.2 4936.9 4946.2 4946.3 5005.5 4206.1 4253.5 4254.2 4260.8 4265.3 3707.8 3724.9 3741.3 3770.0 3813.9 4306.1 4308.1 4312.0 4356.9 4362.3 5048.5 5053.5 5063.3 5070.8 5084.5 4210.7 4234.1 4251.7 4276.4 4293.4 4536.7 4539.5 4584.8 4594.4 4603.5 4685.9 4695.4 4696.2 4699.7 4753.5 4868.9 4924.3 5032.2 5041.7 5046.2 4604.7 4637.3 4639.3 4655.7 4664.1 4870.1 4888.3 4982.1 4983.1 5048.4 4793.1 5008.6 5069.7 5071.4 5133.6 4691.0 4856.8 4890.4 4894.9 4918.4 4886.8 4913.2 4920.2 4933.5 4987.7 4656.0 4811.7 4834.0 4843.4 4900.3 4785.7 4818.1 4889.0 4889.7 4941.7 4747.9 4753.5 4755.7 4758.0 4815.3 00:28:56 INFO - PROCESS | 7837 | 00:28:56 INFO - PROCESS | 7837 | [#1] ext.html Cycles:180 Average:36655.17 Median:35119.74 stddev:54553.28 (155.3%) stddev-sans-first:54638.96 00:28:56 INFO - PROCESS | 7837 | Values: 551.5 566.6 579.1 581.5 584.4 28501.7 29234.0 30912.2 38473.2 39834.4 40205.6 40713.8 40741.2 40799.8 40804.8 7599.4 7748.1 7750.3 7752.1 7760.7 7553.6 7616.3 7628.5 7639.2 7641.5 7631.9 7668.9 7675.1 7677.5 7679.2 7628.2 7656.0 7668.6 7671.2 7674.8 7629.4 7680.5 7681.1 7685.3 7685.6 37978.2 38321.6 38332.6 38372.8 38380.2 2626.7 2676.4 2745.4 2751.1 2758.6 28273.2 28289.0 28358.6 28458.0 29110.7 3265.5 3445.2 3452.3 3456.3 3506.6 242461.0 243768.0 243819.0 244106.0 244740.0 50218.5 50412.5 50475.7 50507.0 50514.2 32969.5 33724.8 33747.2 47272.3 47604.5 14920.9 15312.5 15331.5 15347.2 15347.8 11001.2 11019.3 11021.1 11028.3 11030.0 17648.0 17751.7 17778.5 17832.8 17894.6 6659.8 6741.5 6885.8 6907.6 6996.5 774.6 940.3 977.9 986.0 1027.1 27163.6 27686.7 27878.3 28186.0 28663.9 926.1 938.7 966.4 970.3 995.6 14689.3 14985.8 15048.0 15048.8 15323.6 114298.0 114446.4 115003.0 115371.4 115697.4 49179.8 49358.8 49414.3 49431.5 49482.0 1053.0 1087.4 1118.7 1132.2 1178.3 27579.7 28592.0 29306.3 29514.0 29742.4 40709.0 41037.4 41110.4 41158.8 41234.8 241101.0 241155.0 241311.0 242601.0 242641.0 22080.7 22784.0 24032.8 24884.3 25058.4 40431.6 40540.0 40883.8 41043.0 42083.0 35511.0 35609.5 35745.6 35756.0 36601.6 34708.3 34719.5 35103.5 35136.0 35186.0 34677.5 35215.0 35255.0 35549.1 36069.8 30165.4 32170.0 32462.8 32511.7 32547.3 24228.9 24262.4 24668.3 24928.3 24975.9 00:28:56 INFO - PROCESS | 7837 | 00:28:56 INFO - PROCESS | 7837 | [#2] jquery.html Cycles:180 Average:22579.40 Median:26928.88 stddev:57897.39 (215.0%) stddev-sans-first:58035.76 00:28:56 INFO - PROCESS | 7837 | Values: 351.7 358.1 364.4 372.2 378.4 15447.2 16545.8 17335.5 17451.1 17467.5 16567.6 16749.3 16952.7 17025.7 17123.7 4897.0 5156.8 5161.2 5168.9 5173.4 3641.5 3853.5 5041.6 5640.0 5914.4 5998.7 6001.7 6003.3 6005.0 6011.7 5776.9 6020.0 6027.0 6054.9 6058.1 4565.6 5308.4 5309.0 5314.2 5316.1 17824.0 19103.9 19142.4 19183.3 19257.8 1726.2 1863.0 2013.0 2242.0 2319.7 8477.0 9090.5 9266.1 9314.1 9596.6 1637.8 1643.6 1658.3 1697.8 1719.0 61767.1 68299.0 69107.7 71068.6 72522.3 9465.5 9568.1 9639.0 9708.0 9858.4 12872.9 12979.7 12990.4 12996.6 13003.6 7261.8 7351.6 7362.4 7451.0 7452.9 7209.8 7266.9 7374.6 7452.9 7464.8 3816.6 4039.0 4092.1 4132.8 4181.3 1618.5 1673.9 1685.3 1699.5 1785.7 786.5 818.3 855.4 924.3 941.6 15771.7 16428.7 16524.3 16608.3 17052.3 810.6 820.9 838.2 855.6 878.5 9056.1 9088.8 9403.8 9492.7 9495.2 323497.0 345055.0 360828.0 361032.0 361197.0 47505.0 47907.5 72179.6 72717.6 77725.0 858.5 871.1 875.0 875.0 877.3 14068.4 14215.2 14460.6 14494.9 15035.7 35530.5 35815.3 36963.6 37127.8 37221.8 46323.3 48960.8 49269.0 49328.3 50093.5 7260.5 7383.9 7467.4 7555.5 7665.5 8579.1 10555.4 11286.7 11542.3 12297.3 6868.8 9766.4 10108.9 10165.1 10465.7 10002.2 10147.4 10507.8 10544.0 10565.2 10030.1 10259.2 10442.4 10447.3 10985.8 7436.1 7468.7 7751.8 7752.4 7759.5 9476.8 9957.9 9993.7 10130.6 10397.4 00:28:56 INFO - PROCESS | 7837 | 00:28:56 INFO - PROCESS | 7837 | [#3] mootools.html Cycles:180 Average:4741.82 Median:5894.96 stddev:2631.01 (44.6%) stddev-sans-first:2625.81 00:28:56 INFO - PROCESS | 7837 | Values: 1319.1 1363.2 1398.5 1625.1 1658.3 7001.5 7563.8 7572.7 7575.5 7583.1 6428.1 6678.8 6894.4 7059.1 7070.5 1962.0 1980.9 1981.2 1983.6 1993.3 1943.7 1962.8 1986.6 1991.8 1995.1 1722.9 1761.9 1944.1 1999.4 2081.4 1981.7 1988.5 2001.7 2002.6 2002.7 1963.6 1965.0 1978.6 1983.5 1985.3 7462.2 7553.0 7556.2 7561.4 7561.6 4156.6 4365.8 4373.7 4374.7 4375.5 2620.9 2748.7 2764.8 2773.8 2799.9 783.7 814.5 822.1 822.4 828.2 9478.5 9719.0 9720.7 9949.8 9957.2 3671.8 3754.0 3781.7 3827.1 3889.5 7614.6 7614.8 7620.9 7631.4 7632.7 4246.7 4254.0 4256.6 4258.9 4259.8 3956.0 3961.1 3961.4 3963.8 3963.8 3099.1 3143.8 3252.3 3254.6 3318.8 953.3 955.6 961.8 965.5 982.6 785.0 796.9 798.5 813.9 817.4 4699.2 4762.3 4810.3 4889.8 5058.5 798.0 870.8 882.1 912.7 931.9 3438.4 3514.6 3555.9 3613.9 3663.3 8606.7 8608.1 8787.1 8812.6 8817.7 8677.7 8750.1 8783.7 8844.1 8868.7 6561.9 6682.3 6685.4 6695.4 6698.1 5075.8 5128.5 5197.6 5257.8 5312.2 8339.5 8350.5 8434.5 8438.7 8504.7 8192.5 8487.0 8515.5 8529.4 8576.2 6393.9 6511.9 6516.9 6518.8 6525.6 6698.3 6840.3 6893.2 6902.0 6919.7 5277.5 5984.4 6010.1 6133.4 6222.9 5979.1 6038.3 6056.8 6105.3 6220.1 5487.2 5641.4 5672.0 5741.1 5810.8 4230.5 4332.5 4414.1 4424.0 4499.5 4301.5 4368.0 4391.2 4413.9 4529.9 00:28:56 INFO - PROCESS | 7837 | 00:28:56 INFO - PROCESS | 7837 | [#4] prototype.html Cycles:180 Average:3944.10 Median:4320.98 stddev:1127.23 (26.1%) stddev-sans-first:1096.24 00:28:56 INFO - PROCESS | 7837 | Values: 275.5 277.3 284.6 287.1 287.3 4597.6 4667.3 4758.8 4761.4 4780.4 4574.6 4682.8 4696.6 4704.0 4724.8 3734.9 3740.6 3742.5 3743.4 3748.7 3538.2 3674.2 3745.7 3751.6 3762.0 3588.7 3691.0 3710.9 3712.3 3717.1 3701.4 3701.9 3709.0 3712.7 3714.7 3260.0 3265.2 3265.3 3268.0 3275.9 4497.3 4590.5 4594.7 4646.5 4649.6 4224.3 4225.6 4233.2 4233.4 4245.2 4963.4 4965.7 4967.0 4968.6 4973.7 3421.3 3548.5 3567.0 3571.4 3575.1 5176.5 5182.4 5196.1 5196.5 5197.7 3628.8 3637.0 3640.5 3641.7 3642.0 3679.4 3685.6 3690.2 3691.9 3693.8 3927.0 4133.8 4152.0 4161.6 4218.0 4949.0 4958.0 4975.2 4983.0 4993.2 1177.1 1203.9 1208.3 1242.0 1254.5 831.1 848.7 852.8 853.0 858.9 4317.3 4321.8 4346.0 4349.9 4350.6 5055.9 5065.7 5072.9 5085.3 5098.8 4208.2 4300.8 4320.2 4328.6 4340.7 2384.7 2397.9 2406.7 2407.8 2421.4 4156.5 4204.9 4233.5 4235.4 4240.3 4386.7 4597.7 4620.5 4623.7 4661.6 4240.4 4241.8 4260.3 4296.6 4304.4 4491.4 4500.2 4511.0 4522.5 4524.0 4301.0 4445.8 4468.7 4483.0 4483.0 4244.6 4259.7 4282.4 4290.0 4293.9 3184.7 3211.7 3219.6 3244.4 3246.5 4448.6 4455.4 4467.4 4507.2 4513.7 4180.0 4371.8 4390.4 4401.7 4405.3 4381.7 4403.8 4408.9 4409.3 4411.8 4337.8 4340.9 4390.1 4706.2 4814.5 4731.1 4940.6 4979.1 4980.3 4989.9 4908.4 4916.6 4922.2 4926.5 4945.2 00:28:56 INFO - PROCESS | 7837 | 00:28:56 INFO - PROCESS | 7837 | [#5] yui.html Cycles:180 Average:17464.54 Median:24444.49 stddev:25960.31 (106.2%) stddev-sans-first:26002.08 00:28:56 INFO - PROCESS | 7837 | Values: 553.8 571.2 591.2 601.1 607.5 11487.3 12565.7 12637.9 12639.6 12639.9 12350.6 12775.2 12837.9 12904.4 13279.0 749.3 771.3 772.2 773.6 774.1 619.5 636.6 756.0 782.6 785.0 811.0 811.8 812.9 813.0 813.0 799.1 802.8 807.8 808.0 808.2 475.7 483.9 577.6 588.7 593.5 12272.4 12285.1 12292.1 12311.6 12316.8 12027.9 12619.6 12642.8 12704.8 13271.9 11127.0 11174.5 11242.2 11398.0 11844.6 4031.0 4131.0 4145.7 4146.5 4156.5 61204.8 62555.0 63542.4 63571.7 63730.4 10068.9 10176.8 10181.3 10219.5 10285.4 19624.8 19667.9 19739.8 19791.0 19979.8 6539.3 6625.9 6646.6 6660.0 6739.5 3431.7 3537.5 3578.8 3605.8 3653.3 2805.6 2910.3 2911.1 2913.2 2917.2 497.2 501.6 506.5 507.9 514.3 463.5 518.7 529.0 529.2 538.8 7501.6 7621.8 7684.1 7806.2 7926.0 459.3 500.9 503.7 528.1 567.2 3598.5 3623.8 3657.7 3667.5 3689.6 96417.5 99693.0 101680.0 104730.5 105156.0 86028.6 87081.6 91642.0 92683.0 93307.5 77868.6 79226.0 79456.2 80323.0 80405.6 6989.6 7274.1 7285.3 7288.6 7335.9 43870.8 43884.1 44724.6 45381.3 45765.0 37646.0 37888.0 38066.4 48391.8 65106.0 9016.5 9087.0 9304.9 9323.1 9448.2 9793.8 10147.1 10149.8 10190.8 10223.7 8947.2 9217.8 9238.8 9336.8 9528.3 9500.9 10672.6 11075.2 11076.2 11251.9 11469.6 11668.9 11765.2 12441.8 12477.3 9573.0 9935.8 10084.6 10234.8 10445.7 9753.6 10067.2 10123.8 10368.1 10411.5 00:28:56 INFO - PROCESS | 7837 | -------- Summary: end -------- 00:28:56 INFO - PROCESS | 7837 | 00:28:57 INFO - TEST-INFO | 7837: exit 0 00:28:57 INFO - TEST-OK | dromaeo_css | took 1122497ms 00:28:57 INFO - TEST-START | kraken 00:28:57 INFO - operating with platform_type : linux_ 00:28:57 INFO - Initialising browser for kraken test... 00:28:57 INFO - TEST-INFO | started process 8140 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfpZXpQ/profile http://localhost:37755/getInfo.html) 00:29:02 INFO - PROCESS | 8140 | __metrics Screen width/height:1600/1200 00:29:02 INFO - PROCESS | 8140 | colorDepth:24 00:29:02 INFO - PROCESS | 8140 | Browser inner width/height: 1024/697 00:29:02 INFO - PROCESS | 8140 | __metrics 00:29:03 INFO - PROCESS | 8140 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:29:03 INFO - PROCESS | 8140 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:29:04 INFO - PROCESS | 8140 | console.error: PushService: 00:29:04 INFO - PROCESS | 8140 | stateChangeProcessEnqueue: Error transitioning state 00:29:04 INFO - PROCESS | 8140 | UnknownError 00:29:04 INFO - TEST-INFO | 8140: exit 0 00:29:04 INFO - Browser initialized. 00:29:04 INFO - Running cycle 1/1 for kraken test... 00:29:04 INFO - TEST-INFO | started process 8222 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfpZXpQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:29:17 INFO - PROCESS | 8222 | RSS: Main: 177602560 00:29:17 INFO - PROCESS | 8222 | 00:29:19 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-beat-detection) 00:29:20 INFO - PROCESS | 8222 | RSS: Main: 236048384 00:29:20 INFO - PROCESS | 8222 | 00:29:23 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-dft) 00:29:24 INFO - PROCESS | 8222 | RSS: Main: 221442048 00:29:24 INFO - PROCESS | 8222 | 00:29:27 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-fft) 00:29:28 INFO - PROCESS | 8222 | RSS: Main: 302792704 00:29:28 INFO - PROCESS | 8222 | 00:29:30 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37755/tests/kraken/driver.html?testName=audio-oscillator) 00:29:30 INFO - PROCESS | 8222 | RSS: Main: 213008384 00:29:30 INFO - PROCESS | 8222 | 00:29:33 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37755/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:29:33 INFO - PROCESS | 8222 | RSS: Main: 216137728 00:29:33 INFO - PROCESS | 8222 | 00:29:37 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37755/tests/kraken/driver.html?testName=imaging-darkroom) 00:29:37 INFO - PROCESS | 8222 | RSS: Main: 252076032 00:29:37 INFO - PROCESS | 8222 | 00:29:41 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37755/tests/kraken/driver.html?testName=imaging-desaturate) 00:29:41 INFO - PROCESS | 8222 | RSS: Main: 246620160 00:29:41 INFO - PROCESS | 8222 | 00:29:44 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37755/tests/kraken/driver.html?testName=json-parse-financial) 00:29:45 INFO - PROCESS | 8222 | RSS: Main: 249106432 00:29:45 INFO - PROCESS | 8222 | 00:29:46 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37755/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:29:47 INFO - PROCESS | 8222 | RSS: Main: 212672512 00:29:47 INFO - PROCESS | 8222 | 00:29:49 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:29:50 INFO - PROCESS | 8222 | RSS: Main: 220078080 00:29:50 INFO - PROCESS | 8222 | 00:29:52 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:29:52 INFO - PROCESS | 8222 | RSS: Main: 228917248 00:29:52 INFO - PROCESS | 8222 | 00:29:55 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:29:56 INFO - PROCESS | 8222 | RSS: Main: 237936640 00:29:56 INFO - PROCESS | 8222 | 00:29:59 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:30:00 INFO - PROCESS | 8222 | RSS: Main: 234127360 00:30:00 INFO - PROCESS | 8222 | 00:30:01 INFO - PROCESS | 8222 | Cycle 1(1): loaded http://localhost:37755/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37755/tests/kraken/driver.html?testName=ai-astar) 00:30:02 INFO - PROCESS | 8222 | RSS: Main: 285220864 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | __start_tp_report 00:30:02 INFO - PROCESS | 8222 | _x_x_mozilla_page_load 00:30:02 INFO - PROCESS | 8222 | _x_x_mozilla_page_load_details 00:30:02 INFO - PROCESS | 8222 | |i|pagename|runs| 00:30:02 INFO - PROCESS | 8222 | |0;ai-astar;113;115;115;116;115;115;115;114;115;116 00:30:02 INFO - PROCESS | 8222 | |1;audio-beat-detection;155;130;129;172;129;130;131;127;170;128 00:30:02 INFO - PROCESS | 8222 | |2;audio-dft;163;163;161;163;163;162;164;161;161;162 00:30:02 INFO - PROCESS | 8222 | |3;audio-fft;75;76;76;111;78;76;76;77;106;77 00:30:02 INFO - PROCESS | 8222 | |4;audio-oscillator;86;84;117;83;84;84;107;84;84;120 00:30:02 INFO - PROCESS | 8222 | |5;imaging-gaussian-blur;117;118;117;117;117;118;118;117;119;118 00:30:02 INFO - PROCESS | 8222 | |6;imaging-darkroom;146;147;146;145;146;146;146;146;146;146 00:30:02 INFO - PROCESS | 8222 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 00:30:02 INFO - PROCESS | 8222 | |8;json-parse-financial;64;65;64;71;63;64;63;63;63;63 00:30:02 INFO - PROCESS | 8222 | |9;json-stringify-tinderbox;67;66;66;67;67;66;67;67;66;66 00:30:02 INFO - PROCESS | 8222 | |10;stanford-crypto-aes;83;84;85;90;83;84;84;83;82;82 00:30:02 INFO - PROCESS | 8222 | |11;stanford-crypto-ccm;139;138;137;138;138;139;144;150;180;139 00:30:02 INFO - PROCESS | 8222 | |12;stanford-crypto-pbkdf2;179;177;172;177;178;177;177;177;171;173 00:30:02 INFO - PROCESS | 8222 | |13;stanford-crypto-sha256-iterative;71;71;69;70;69;69;69;69;68;68 00:30:02 INFO - PROCESS | 8222 | __end_tp_report 00:30:02 INFO - PROCESS | 8222 | __start_cc_report 00:30:02 INFO - PROCESS | 8222 | _x_x_mozilla_cycle_collect,1963 00:30:02 INFO - PROCESS | 8222 | __end_cc_report 00:30:02 INFO - PROCESS | 8222 | __startTimestamp1475566202088__endTimestamp 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | ------- Summary: start ------- 00:30:02 INFO - PROCESS | 8222 | Number of tests: 14 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#0] ai-astar Cycles:10 Average:114.90 Median:115.00 stddev:0.88 (0.8%) stddev-sans-first:0.60 00:30:02 INFO - PROCESS | 8222 | Values: 113.0 115.0 115.0 116.0 115.0 115.0 115.0 114.0 115.0 116.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:130.50 stddev:18.21 (14.0%) stddev-sans-first:18.50 00:30:02 INFO - PROCESS | 8222 | Values: 155.0 130.0 129.0 172.0 129.0 130.0 131.0 127.0 170.0 128.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.06 (0.6%) stddev-sans-first:1.09 00:30:02 INFO - PROCESS | 8222 | Values: 163.0 163.0 161.0 163.0 163.0 162.0 164.0 161.0 161.0 162.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.00 stddev:13.62 (17.9%) stddev-sans-first:14.15 00:30:02 INFO - PROCESS | 8222 | Values: 75.0 76.0 76.0 111.0 78.0 76.0 76.0 77.0 106.0 77.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:84.00 stddev:15.11 (18.0%) stddev-sans-first:15.79 00:30:02 INFO - PROCESS | 8222 | Values: 86.0 84.0 117.0 83.0 84.0 84.0 107.0 84.0 84.0 120.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 00:30:02 INFO - PROCESS | 8222 | Values: 117.0 118.0 117.0 117.0 117.0 118.0 118.0 117.0 119.0 118.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 00:30:02 INFO - PROCESS | 8222 | Values: 146.0 147.0 146.0 145.0 146.0 146.0 146.0 146.0 146.0 146.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 00:30:02 INFO - PROCESS | 8222 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#8] json-parse-financial Cycles:10 Average:64.30 Median:64.00 stddev:2.45 (3.8%) stddev-sans-first:2.60 00:30:02 INFO - PROCESS | 8222 | Values: 64.0 65.0 64.0 71.0 63.0 64.0 63.0 63.0 63.0 63.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 00:30:02 INFO - PROCESS | 8222 | Values: 67.0 66.0 66.0 67.0 67.0 66.0 67.0 67.0 66.0 66.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:2.31 (2.7%) stddev-sans-first:2.42 00:30:02 INFO - PROCESS | 8222 | Values: 83.0 84.0 85.0 90.0 83.0 84.0 84.0 83.0 82.0 82.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:139.00 stddev:13.18 (9.5%) stddev-sans-first:13.85 00:30:02 INFO - PROCESS | 8222 | Values: 139.0 138.0 137.0 138.0 138.0 139.0 144.0 150.0 180.0 139.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.80 Median:177.00 stddev:2.74 (1.5%) stddev-sans-first:2.65 00:30:02 INFO - PROCESS | 8222 | Values: 179.0 177.0 172.0 177.0 178.0 177.0 177.0 177.0 171.0 173.0 00:30:02 INFO - PROCESS | 8222 | 00:30:02 INFO - PROCESS | 8222 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.06 (1.5%) stddev-sans-first:0.93 00:30:02 INFO - PROCESS | 8222 | Values: 71.0 71.0 69.0 70.0 69.0 69.0 69.0 69.0 68.0 68.0 00:30:02 INFO - PROCESS | 8222 | -------- Summary: end -------- 00:30:02 INFO - PROCESS | 8222 | 00:30:03 INFO - TEST-INFO | 8222: exit 0 00:30:03 INFO - TEST-OK | kraken | took 65784ms 00:30:03 INFO - SUITE-END | took 1188s 00:30:03 INFO - Completed test suite (00:19:48) 00:30:03 INFO - javascript benchmark 00:30:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2561.9487610247797, 2565.5253778051074, 2567.127176759902, 2630.1452028090876, 2643.5770276755725, 4563.087382523492, 4622.838200662969, 4631.421072365954, 4700.529947005302, 4713.151632706115, 4649.58153766161, 4688.812447502096, 4724.126036683216, 4750.643701722376, 4794.976025119879, 4242.766647834368, 4260.105377870651, 4309.870703878889, 4325.134973005396, 4331.45856767904, 4358.825646974117, 4386.276264416383, 4389.736615803046, 4401.471823381183, 4446.844360447385, 4247.511536173318, 4383.868483945486, 4387.758673272969, 4393.956060439403, 4480.619147372461, 4259.424977628011, 4286.03564198056, 4316.848910288125, 4326.870193894189, 4337.284348082562, 4318.1363727254675, 4318.676099292534, 4326.351047342892, 4366.4105345778235, 4373.343998400265, 4674.228752255874, 4685.976570117162, 4694.765261736934, 4709.317149013408, 4715.622750180011, 4814.8796280093275, 4869.829555965524, 4884.169691152512, 4967.701937883702, 5015.14742493777, 5057.974710126426, 5063.113955057887, 5073.518015788531, 5097.006083813658, 5109.463506331856, 4708.034852855157, 4709.411323584552, 4717.9292310615365, 4727.57451829337, 4778.211595086772, 4861.611071114302, 4897.265410188429, 4897.975510122426, 5170.75457115644, 5236.607254455931, 4768.0, 4769.165396055676, 4771.856844294677, 4775.976120119447, 4841.588464980516, 4942.9258561121615, 4968.080905032581, 5033.748312584356, 5034.16936205522, 5035.571976381975, 4915.508449155127, 4917.704937703749, 4928.383952005999, 4934.432540257844, 4947.158982972904, 4801.159797035505, 4936.851894443173, 4946.233333833262, 4946.258061290835, 5005.474425185376, 4206.095689426788, 4253.532111467736, 4254.234237837219, 4260.765657888784, 4265.296226122655, 3707.8146092695797, 3724.944125838115, 3741.28915506053, 3769.981150094232, 3813.866514671973, 4306.0957198987935, 4308.116836048603, 4312.029793296546, 4356.8910777230185, 4362.280223763107, 5048.469910659402, 5053.494650534917, 5063.3417655704525, 5070.832979875327, 5084.542391184737, 4210.663146948237, 4234.110836724322, 4251.744895306291, 4276.444062271885, 4293.377460268243, 4536.705114167568, 4539.523350048264, 4584.770761461914, 4594.425696787902, 4603.49361570227, 4685.929711054337, 4695.413073365829, 4696.248600224016, 4699.718016918996, 4753.47711751714, 4868.853934381974, 4924.285978533164, 5032.169692000779, 5041.722705251246, 5046.1926091825135, 4604.700694454849, 4637.25803871379, 4639.327297541905, 4655.743934083658, 4664.067186562633, 4870.099031679009, 4888.266759985889, 4982.078315511642, 4983.053219888209, 5048.419431765247, 4793.065352256416, 5008.599312054954, 5069.7465126744255, 5071.39143302806, 5133.614978876524, 4691.03833714081, 4856.757162141949, 4890.413150421972, 4894.877628059185, 4918.409790825124, 4886.767603751, 4913.189323761682, 4920.237363208708, 4933.4819843915875, 4987.725675087905, 4655.976720116378, 4811.711297322172, 4834.0331933612715, 4843.370361852936, 4900.264960255848, 4785.736784476887, 4818.084563932842, 4889.022195560831, 4889.682170658896, 4941.703497790144, 4747.8575642730775, 4753.524647535219, 4755.714657120584, 4758.04839032188, 4815.253635686474], "value": 4590.626430852765, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.4568150371883, 566.6033776356549, 579.1255204640994, 581.4708615160205, 584.3922320786382, 28501.714982850164, 29234.0, 30912.227194320127, 38473.23053538927, 39834.40248396277, 40205.59794402062, 40713.79643101788, 40741.18517629646, 40799.79600101995, 40804.795976020076, 7599.430042746802, 7748.108967468757, 7750.341220996222, 7752.147263800977, 7760.650770715331, 7553.622318884034, 7616.276453736886, 7628.466007379486, 7639.236076392372, 7641.465097443182, 7631.885521717151, 7668.884966725504, 7675.117361503443, 7677.500962437423, 7679.193684663113, 7628.199039100898, 7656.0047193865, 7668.616569171575, 7671.232876712284, 7674.769756907246, 7629.427792915553, 7680.500767450154, 7681.078270607507, 7685.308322251024, 7685.615719214017, 37978.24043519114, 38321.61678383236, 38332.61667383318, 38372.808135959145, 38380.23239535194, 2626.6716660417446, 2676.397810492643, 2745.3685652299882, 2751.0508874438287, 2758.5724212747054, 28273.15180544587, 28289.0, 28358.574621380696, 28458.0, 29110.708892911225, 3265.510173473998, 3445.242046749711, 3452.3267962747273, 3456.2914602506426, 3506.579210494757, 242461.0, 243768.0, 243819.0, 244106.0, 244739.99999999822, 50218.497815022114, 50412.49587504152, 50475.74762126166, 50507.0, 50514.242286365734, 32969.505457418156, 33724.83137584345, 33747.15632109217, 47272.290915636295, 47604.52395476001, 14920.850791492163, 15312.464063757938, 15331.463398780988, 15347.232638368037, 15347.769783453257, 11001.17491188164, 11019.283746556448, 11021.063209627111, 11028.28316159447, 11029.96675914114, 17648.0, 17751.733723993893, 17778.46664600064, 17832.821671783116, 17894.642107158044, 6659.836577625686, 6741.528093033538, 6885.793426197222, 6907.585544867324, 6996.510244282953, 774.5507605588745, 940.2947789158131, 977.9022097790164, 986.0189111833771, 1027.0705011964185, 27163.64181790942, 27686.723132768413, 27878.3030424241, 28186.0, 28663.856680716464, 926.120185823457, 938.7183844846519, 966.4394651102343, 970.315927271272, 995.6316163019729, 14689.338979745937, 14985.775213371808, 15048.0, 15048.774268385983, 15323.61690957735, 114298.0, 114446.42776786063, 115003.0, 115371.42314288375, 115697.4215128919, 49179.754101229264, 49358.75320623374, 49414.25878611824, 49431.50568494341, 49482.0, 1052.984205236922, 1087.396494945297, 1118.681175864891, 1132.1678566253797, 1178.293024185499, 27579.72420275852, 28592.0, 29306.267343316587, 29514.0, 29742.405151897274, 40709.0, 41037.38443923403, 41110.38334425046, 41158.794206028775, 41234.79382603068, 241101.0, 241155.0, 241311.0, 242601.0, 242641.0, 22080.668789967844, 22784.0, 24032.75967240375, 24884.253472395856, 25058.37354066163, 40431.59568404396, 40540.0, 40883.79558102191, 41042.9739256521, 42083.0, 35511.0, 35609.46585801163, 35745.642543574235, 35756.0, 36601.63398365982, 34708.305833882674, 34719.4792078114, 35103.47344789881, 35136.0, 35186.0, 34677.47983780195, 35215.0, 35255.0, 35549.111272218404, 36069.819650901576, 30165.3966920656, 32170.0, 32462.837685812363, 32511.674883250864, 32547.34905301928, 24228.878855606315, 24262.393440164138, 24668.259952201464, 24928.252152435456, 24975.87512062428], "value": 16345.104994491043, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.7414700195356, 358.0743777335587, 364.3532729405306, 372.1849150360712, 378.35112781579585, 15447.227638618066, 16545.834541654578, 17335.47993560192, 17451.127443627833, 17467.47597572075, 16567.585810354747, 16749.330026798943, 16952.660946781056, 17025.744613830804, 17123.657526849456, 4897.0, 5156.845294641167, 5161.225816127573, 5168.8707782305555, 5173.430922598511, 3641.4537819327047, 3853.5183102112237, 5041.647084704072, 5639.971800140994, 5914.438128377818, 5998.670073145975, 6001.729922153513, 6003.339632640428, 6005.039193729004, 6011.669358185298, 5776.942230577703, 6019.969900150515, 6027.035674292092, 6054.878902421927, 6058.091286307045, 4565.56627120423, 5308.416074231832, 5308.973455132738, 5314.229436731691, 5316.149416093445, 17824.0, 19103.904480477646, 19142.425727228205, 19183.32858349965, 19257.807421925743, 1726.2231995602028, 1862.9906850465798, 2012.9597408051904, 2241.9663705044436, 2319.7100362454694, 8477.0, 9090.50002249876, 9266.07339266068, 9314.068593140699, 9596.568154433067, 1637.778899848517, 1643.6301832087804, 1658.3035125247304, 1697.7962644482618, 1718.9570260743455, 61767.11726123843, 68299.0, 69107.65446172787, 71068.64465677639, 72522.2747772526, 9465.47939863314, 9568.09103135201, 9638.95180524107, 9707.951460242653, 9858.359206651545, 12872.935635321763, 12979.675508112185, 12990.415431305424, 12996.610101696964, 13003.609891703263, 7261.782146535613, 7351.558906465629, 7362.4478164136835, 7451.007824757317, 7452.888206676904, 7209.770314343181, 7266.85627739818, 7374.631268436557, 7452.925470745332, 7464.776056718307, 3816.6183381662167, 4038.9798051009557, 4092.07928216149, 4132.8140233688955, 4181.310083836133, 1618.4739959513206, 1673.8577220936113, 1685.2669088946348, 1699.4731633193749, 1785.660724462374, 786.4769927997932, 818.2799136759613, 855.362754747717, 924.2790623313691, 941.6280569175137, 15771.68456630861, 16428.67142657164, 16524.25640846165, 16608.25262863174, 17052.317907283817, 810.6473683947502, 820.885076089348, 838.2078935406105, 855.5593869157389, 878.5168157513342, 9056.13966673165, 9088.81822363549, 9403.811923761486, 9492.667756628485, 9495.240380769523, 323497.0, 345055.0, 360828.0, 361032.0, 361197.0, 47505.0, 47907.520924791, 72179.63910180416, 72717.6364118176, 77725.0, 858.4806192253722, 871.1375738019316, 875.0287181228831, 875.0330884372804, 877.2587163846539, 14068.437262509386, 14215.218163001135, 14460.638484037983, 14494.85505144935, 15035.699286014436, 35530.467042993856, 35815.28369432649, 36963.63036369602, 37127.81436092802, 37221.813890930374, 46323.30515042209, 48960.75519622379, 49269.0, 49328.26007609961, 50093.49906500888, 7260.528065675714, 7383.889241661487, 7467.402607791255, 7555.460559998667, 7665.46341756094, 8579.056303806452, 10555.419451930218, 11286.66140015801, 11542.307461552333, 12297.32364719949, 6868.793936181923, 9766.401590457257, 10108.898911010796, 10165.085142337226, 10465.738356541147, 10002.199824014207, 10147.391156530632, 10507.842382364424, 10544.0, 10565.154787616819, 10030.147437467605, 10259.17926565858, 10442.373457592568, 10447.320924139907, 10985.780284394108, 7436.107667079985, 7468.663910123949, 7751.806204844698, 7752.418568607264, 7759.495632783851, 9476.810463790824, 9957.850632240377, 9993.700188994342, 10130.594776208869, 10397.376157430579], "value": 7994.143346572273, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1319.0634649398926, 1363.1684672349868, 1398.5454727213657, 1625.1224338857019, 1658.2620733773467, 7001.474889383291, 7563.848723025536, 7572.659230334634, 7575.507592006516, 7583.09002919649, 6428.132202152708, 6678.7996360109155, 6894.44844412447, 7059.117610298713, 7070.5050646454765, 1962.0189905047475, 1980.8514361422879, 1981.2273213446767, 1983.6231116087897, 1993.2824183294003, 1943.7375954246208, 1962.7939066397964, 1986.6026794641057, 1991.7709463411675, 1995.092233033966, 1722.9224684889148, 1761.947141585748, 1944.0862794486638, 1999.4401567561033, 2081.4067990622675, 1981.7423734914512, 1988.463114958953, 2001.7197592337084, 2002.5594369238745, 2002.7496562929707, 1963.577830766392, 1965.0, 1978.584497255578, 1983.5338695406567, 1985.2753744883014, 7462.179160292363, 7553.0, 7556.168821429638, 7561.39508839297, 7561.584112873789, 4156.605122513356, 4365.781710914442, 4373.715708478939, 4374.715643483163, 4375.540568240321, 2620.9082682106036, 2748.69764325924, 2764.7649949754295, 2773.833569985807, 2799.9020034298906, 783.7296132834163, 814.5357146426539, 822.0874828939872, 822.3955392786297, 828.200786241274, 9478.526073696288, 9719.0, 9720.708378748579, 9949.751256218507, 9957.153641940444, 3671.81640917953, 3753.9812300938866, 3781.697464202857, 3827.119762454651, 3889.5138107736534, 7614.619269036637, 7614.8096297593, 7620.885686714703, 7631.3894888408795, 7632.694692212361, 4246.7027308088755, 4253.97873010633, 4256.59562341577, 4258.893527661771, 4259.765712885821, 3955.960440395617, 3961.069148750041, 3961.3859851723028, 3963.7819919904105, 3963.841446342172, 3099.1167517257472, 3143.764217683637, 3252.3007553376137, 3254.6257180424554, 3318.7676862619387, 953.3183773601908, 955.5843208204315, 961.8172547216006, 965.4689920543673, 982.6413359123868, 785.0030461314099, 796.8565658181583, 798.5129071266523, 813.89419375482, 817.3665409307833, 4699.154152252628, 4762.261849413347, 4810.254410566367, 4889.755512224375, 5058.519440653132, 797.9905419644155, 870.7648934787572, 882.1311008656468, 912.7353067610319, 931.8817419097111, 3438.4183275693463, 3514.648535146516, 3555.8577656893435, 3613.9096522587147, 3663.2856592964117, 8606.741797746077, 8608.096149904295, 8787.121287871161, 8812.647494100293, 8817.735467935972, 8677.696280630147, 8750.081241469681, 8783.692570759993, 8844.115588441104, 8868.733937981871, 6561.901571476432, 6682.264950855402, 6685.364890335411, 6695.4308883745425, 6698.129243198353, 5075.7969681212335, 5128.461511541234, 5197.584193264605, 5257.8159764408065, 5312.1766126250495, 8339.541325226928, 8350.457220280905, 8434.536100514531, 8438.66245350179, 8504.659813607386, 8192.508449493049, 8487.0, 8515.48907065578, 8529.402941794015, 8576.228139467477, 6393.87212255743, 6511.934880651323, 6516.934830651633, 6518.804435866931, 6525.64108974011, 6698.296678848846, 6840.31596840312, 6893.241743408121, 6902.033715279765, 6919.654017299215, 5277.498637629419, 5984.401559844155, 6010.068439391901, 6133.3866613338305, 6222.937770622417, 5979.1031345296815, 6038.3357830637715, 6056.757729690763, 6105.328413874559, 6220.066989951543, 5487.176923461353, 5641.435856414326, 5671.971640141773, 5741.081426971665, 5810.82567522975, 4230.471191101113, 4332.501762297376, 4414.095110502275, 4423.977880110708, 4499.460064792246, 4301.483821941387, 4367.956320436882, 4391.209582275221, 4413.933790993202, 4529.8641040768825], "value": 3825.8668275375985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [275.52747038828414, 277.25556879777787, 284.5504103516444, 287.1099591267072, 287.26746795671033, 4597.586217240448, 4667.323238130473, 4758.809647614095, 4761.40482439695, 4780.354652121962, 4574.5882870541645, 4682.812687492505, 4696.647751418649, 4704.0, 4724.763761811912, 3734.8692795752154, 3740.6446387593137, 3742.5134732484808, 3743.4197699356505, 3748.6813620842263, 3538.168530395355, 3674.1549443627982, 3745.6628903398687, 3751.624837516254, 3761.981190094046, 3588.659077387644, 3690.9815450922843, 3710.888673339791, 3712.2761061593, 3717.1006614840335, 3701.4262789267705, 3701.851925922987, 3708.962910370902, 3712.6844218241345, 3714.665680088805, 3259.951100733491, 3265.2163480764684, 3265.314284000363, 3268.006516025223, 3275.852586633607, 4497.280435130396, 4590.540945905383, 4594.678372513926, 4646.465656449518, 4649.604783593399, 4224.260754367973, 4225.577442255781, 4233.23801715691, 4233.407322974786, 4245.214635292481, 4963.4292056413615, 4965.708915681913, 4966.975165124188, 4968.627352948543, 4973.651844370896, 3421.264428147935, 3548.520949671787, 3566.983409728241, 3571.357155711971, 3575.0526110580718, 5176.482351764831, 5182.404023537266, 5196.142636465017, 5196.532312091892, 5197.714125723083, 3628.8387715931176, 3637.0, 3640.4903313536124, 3641.672249497505, 3642.0, 3679.4480827875495, 3685.576158741779, 3690.1697118148204, 3691.8892433227047, 3693.8153092345815, 3926.960730392717, 4133.834646614162, 4151.958480415217, 4161.62545370912, 4217.957820421818, 4949.0, 4958.0, 4975.164156430872, 4982.950170498321, 4993.201087825931, 1177.1053998960851, 1203.8796120388067, 1208.3173007250875, 1241.993790031044, 1254.4605819497522, 831.0941074228998, 848.6605357856906, 852.8123812761182, 852.9701460448979, 858.9012263589642, 4317.266064768934, 4321.762303073361, 4345.9574000219845, 4349.869503914888, 4350.60844523988, 5055.9494405055475, 5065.696058236517, 5072.923906141411, 5085.313482679865, 5098.796048158107, 4208.200441916026, 4300.827966881289, 4320.200762858881, 4328.558795757381, 4340.674449416307, 2384.7464146381503, 2397.868117253568, 2406.6871306730013, 2407.7592240776135, 2421.4067553449518, 4156.542780294165, 4204.873853784391, 4233.470816147981, 4235.411720604773, 4240.321548552217, 4386.692931494828, 4597.747123908151, 4620.53794620542, 4623.711262924874, 4661.580457758818, 4240.38514415408, 4241.8366633018, 4260.275753122039, 4296.570342965679, 4304.364341550191, 4491.371208030943, 4500.234960056864, 4510.977445112753, 4522.4573051234065, 4524.0, 4301.0, 4445.844395446144, 4468.687191896666, 4482.977585112054, 4482.977585112054, 4244.554321796167, 4259.74441533509, 4282.40046393499, 4289.978550107229, 4293.935590966075, 3184.7420268994083, 3211.6627754085484, 3219.597550306212, 3244.351129774102, 3246.4967929970894, 4448.552371911795, 4455.398521199597, 4467.436397260933, 4507.233770259129, 4513.68404211702, 4179.9582004179565, 4371.803268852846, 4390.429244198233, 4401.691881568259, 4405.29515277554, 4381.737095774264, 4403.82384704621, 4408.867733967986, 4409.316555933835, 4411.757353345597, 4337.783110844508, 4340.8697739067875, 4390.136679721824, 4706.247000479907, 4814.542618451242, 4731.124741922756, 4940.60475161979, 4979.128652485728, 4980.331588917608, 4989.925151122663, 4908.410990680998, 4916.606671466203, 4922.163232250455, 4926.458089610212, 4945.159322915185], "value": 3587.700701678488, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.7508121345394, 571.1632458448374, 591.1841658511254, 601.1463721515449, 607.4957785038416, 11487.25332853364, 12565.685857853558, 12637.936810315958, 12639.620811375651, 12639.873601263997, 12350.62948111558, 12775.233485990848, 12837.935810320958, 12904.419301131447, 13279.0, 749.2507492507492, 771.3366504805863, 772.1583474013353, 773.5590713293425, 774.0749803984213, 619.5446346934999, 636.6371168433994, 756.0322786832835, 782.6478084861807, 785.0344076785557, 810.9716159934403, 811.7808191788214, 812.9024517057961, 813.0203105258149, 813.032491335309, 799.073075232733, 802.7872613757359, 807.7576726981882, 808.0424696734359, 808.1796976069294, 475.6884240822267, 483.86935527407405, 577.6447484796862, 588.6615196262167, 593.5281451246269, 12272.386380681019, 12285.14004019719, 12292.139550231488, 12311.630651080482, 12316.753664926651, 12027.93986030073, 12619.621411357582, 12642.810357844639, 12704.809427858498, 13271.933640331834, 11127.0, 11174.45496850268, 11242.156838237082, 11398.0, 11844.585439509576, 4030.9630461910033, 4130.979345103286, 4145.66834653227, 4146.460960075171, 4156.521999970012, 61204.77590448211, 62555.0, 63542.364576354106, 63571.68214158899, 63730.362696372904, 10068.899311006797, 10176.847347289797, 10181.287309888237, 10219.48902554884, 10285.43430111351, 19624.803751962583, 19667.901660491607, 19739.802601973795, 19791.0, 19979.800201998085, 6539.313372095957, 6625.933740662628, 6646.567973081831, 6660.0, 6739.460843132636, 3431.7083047941205, 3537.5401197844117, 3578.821058947094, 3605.7836529808296, 3653.2510835278704, 2805.6072149899032, 2910.301527633395, 2911.083008852205, 2913.2134323732475, 2917.226934862263, 497.2144012460304, 501.6155411065413, 506.4530307268142, 507.8857257117193, 514.3185279504596, 463.53646353646354, 518.7250757098743, 528.9735513224323, 529.1922880629523, 538.8160930375636, 7501.587412692245, 7621.809454763676, 7684.11632662251, 7806.219378062262, 7926.0, 459.2789320766432, 500.8797888506732, 503.66757939760316, 528.0600531054652, 567.1521075991419, 3598.47822065799, 3623.7825730456257, 3657.6890964267805, 3667.504886840296, 3689.612590677994, 96417.51791241, 99693.03683557875, 101680.0, 104730.47634761778, 105156.0, 86028.56985715032, 87081.56459217664, 91642.0, 92683.0, 93307.53346233226, 77868.61065694636, 79226.0, 79456.20543794488, 80323.0, 80405.59797200977, 6989.580625162506, 7274.090738657668, 7285.344319011315, 7288.562686238843, 7335.926640733524, 43870.78064609784, 43884.12231755411, 44724.55275447334, 45381.31928021016, 45765.0, 37646.0, 37888.0, 38066.42900356552, 48391.758041210975, 65106.0, 9016.549172541478, 9086.954565227132, 9304.906950930676, 9323.114304141096, 9448.196903263024, 9793.804123917624, 10147.086762191439, 10149.847752283575, 10190.796184076426, 10223.744406389602, 8947.239484643618, 9217.76955576116, 9238.815223695623, 9336.766580835534, 9528.333016688764, 9500.85748713756, 10672.57309707603, 11075.169362298022, 11076.169287303323, 11251.887481125084, 11469.598564050219, 11668.88331116678, 11765.235259708434, 12441.813372799596, 12477.251364918135, 9572.952135239559, 9935.751606209902, 10084.596616135272, 10234.795304094025, 10445.68662940113, 9753.609855605697, 10067.244956628136, 10123.797524049625, 10368.118709909742, 10411.531481083219], "value": 6277.763067743012, "unit": "score"}], "name": "dromaeo_css", "value": 6103.409061188906, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 116.0, 115.0, 115.0, 115.0, 114.0, 115.0, 116.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 130.0, 129.0, 172.0, 129.0, 130.0, 131.0, 127.0, 170.0, 128.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 161.0, 163.0, 163.0, 162.0, 164.0, 161.0, 161.0, 162.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 111.0, 78.0, 76.0, 76.0, 77.0, 106.0, 77.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 117.0, 83.0, 84.0, 84.0, 107.0, 84.0, 84.0, 120.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0, 119.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 71.0, 63.0, 64.0, 63.0, 63.0, 63.0, 63.0], "value": 64.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 90.0, 83.0, 84.0, 84.0, 83.0, 82.0, 82.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 138.0, 137.0, 138.0, 138.0, 139.0, 144.0, 150.0, 180.0, 139.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 177.0, 172.0, 177.0, 178.0, 177.0, 177.0, 177.0, 171.0, 173.0], "value": 175.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1556.1, "alertThreshold": 2.0}]} 00:30:03 INFO - Return code: 0 00:30:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:30:03 INFO - # TBPL SUCCESS # 00:30:03 INFO - Running post-action listener: _resource_record_post_action 00:30:03 INFO - [mozharness: 2016-10-04 07:30:03.881087Z] Finished run-tests step (success) 00:30:03 INFO - Running post-run listener: _resource_record_post_run 00:30:03 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392245248; Read time: 12; Write time: 300540 00:30:03 INFO - TinderboxPrint: CPU usage
13.1% 00:30:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 00:30:03 INFO - TinderboxPrint: I/O write bytes / time
392,245,248 / 300,540 00:30:03 INFO - TinderboxPrint: CPU idle
8,353.1 (86.9%) 00:30:03 INFO - TinderboxPrint: CPU user
1,209.2 (12.6%) 00:30:03 INFO - TinderboxPrint: Swap in / out
0 / 0 00:30:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 102920192; Read time: 0; Write time: 97952 00:30:03 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 288710656; Read time: 0; Write time: 202588 00:30:04 INFO - Running post-run listener: _upload_blobber_files 00:30:04 INFO - Blob upload gear active. 00:30:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:30:04 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 00:30:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 00:30:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 00:30:04 INFO - (blobuploader) - INFO - Open directory for files ... 00:30:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:30:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:30:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:30:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:30:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:30:08 INFO - (blobuploader) - INFO - Done attempting. 00:30:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:30:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:30:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:30:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:30:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:30:09 INFO - (blobuploader) - INFO - Done attempting. 00:30:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:30:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:30:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:30:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:30:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:30:10 INFO - (blobuploader) - INFO - Done attempting. 00:30:10 INFO - (blobuploader) - INFO - Iteration through files over. 00:30:10 INFO - Return code: 0 00:30:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:30:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:30:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ec54a327f89616b1155273ef1cbf85f054a0ffbcbdbd758075a3c8ff6701f7ad914f142436525711ed48e0e984492441865ea3e39f92fdb9800db15622e3ce96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/7aa1c2155db2173d40dbc8cee928e079d81e32392504f40fa1b957b13a807169f93451932986f37df613defe2b6a3a8354748e4b8a7fb8810c187782e1424c42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/179e6ac81040125595b22359b264257caf6df01ac629c6d4cb47e42be3732ec2867c94b4b87bfbc359eabe5b5f82cb58b3f265d8afe82d93f260b0606324986e"} 00:30:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:30:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:30:10 INFO - Contents: 00:30:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ec54a327f89616b1155273ef1cbf85f054a0ffbcbdbd758075a3c8ff6701f7ad914f142436525711ed48e0e984492441865ea3e39f92fdb9800db15622e3ce96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/7aa1c2155db2173d40dbc8cee928e079d81e32392504f40fa1b957b13a807169f93451932986f37df613defe2b6a3a8354748e4b8a7fb8810c187782e1424c42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/179e6ac81040125595b22359b264257caf6df01ac629c6d4cb47e42be3732ec2867c94b4b87bfbc359eabe5b5f82cb58b3f265d8afe82d93f260b0606324986e"} 00:30:10 INFO - Running post-run listener: copy_logs_to_upload_dir 00:30:10 INFO - Copying logs to upload dir... 00:30:10 INFO - mkdir: /builds/slave/test/build/upload/logs 00:30:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.903421 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-10-04 00:30:09.884687) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 00:30:09.890140) ========= 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=d2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ec54a327f89616b1155273ef1cbf85f054a0ffbcbdbd758075a3c8ff6701f7ad914f142436525711ed48e0e984492441865ea3e39f92fdb9800db15622e3ce96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/7aa1c2155db2173d40dbc8cee928e079d81e32392504f40fa1b957b13a807169f93451932986f37df613defe2b6a3a8354748e4b8a7fb8810c187782e1424c42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/179e6ac81040125595b22359b264257caf6df01ac629c6d4cb47e42be3732ec2867c94b4b87bfbc359eabe5b5f82cb58b3f265d8afe82d93f260b0606324986e"} build_url:https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011281 build_url: 'https://queue.taskcluster.net/v1/task/fWqwIyMdR6ulKczZGOr4oQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/ec54a327f89616b1155273ef1cbf85f054a0ffbcbdbd758075a3c8ff6701f7ad914f142436525711ed48e0e984492441865ea3e39f92fdb9800db15622e3ce96", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/7aa1c2155db2173d40dbc8cee928e079d81e32392504f40fa1b957b13a807169f93451932986f37df613defe2b6a3a8354748e4b8a7fb8810c187782e1424c42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/179e6ac81040125595b22359b264257caf6df01ac629c6d4cb47e42be3732ec2867c94b4b87bfbc359eabe5b5f82cb58b3f265d8afe82d93f260b0606324986e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-04 00:30:09.915744) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:30:09.916069) ========= 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=d2a8c569965ab8367867b893000001a1-1475564959.691107-1093297196 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004487 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-04 00:30:10.000587) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 00:30:10.000906) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-04 00:30:10.001191) ========= ========= Total master_lag: 0.59 =========