builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-013 starttime: 1478013132.43 results: success (0) buildid: 20161101063618 builduid: 55d5d7bb87824ab381947e26fc0efdd1 revision: 3e73fd638e687a4d7f46613586e5156b8e2af846 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:12.428064) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:12.428457) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:12.428733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:12.447906) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:12.448231) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-01 08:12:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2016-11-01 08:12:12 (18.4 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.110755 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:12.572681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:12.573011) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017051 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:12.626114) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:12.629500) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3e73fd638e687a4d7f46613586e5156b8e2af846 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3e73fd638e687a4d7f46613586e5156b8e2af846 --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=9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-01 08:12:12,830 truncating revision to first 12 chars 2016-11-01 08:12:12,831 Setting DEBUG logging. 2016-11-01 08:12:12,831 attempt 1/10 2016-11-01 08:12:12,831 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3e73fd638e68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-01 08:12:13,176 unpacking tar archive at: mozilla-central-3e73fd638e68/testing/mozharness/ program finished with exit code 0 elapsedTime=0.638969 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:13.282047) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:13.285345) ========= script_repo_revision: 3e73fd638e687a4d7f46613586e5156b8e2af846 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:13.285804) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:13.286079) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-01 08:12:13.297573) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-01 08:12:13.297980) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:12:13 INFO - MultiFileLogger online at 20161101 08:12:13 in /builds/slave/test 08:12:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:12:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:12:13 INFO - {'append_to_log': False, 08:12:13 INFO - 'base_work_dir': '/builds/slave/test', 08:12:13 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:12:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:12:13 INFO - 'branch': 'Firefox-Non-PGO', 08:12:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:12:13 INFO - 'config_files': ('talos/linux_config.py',), 08:12:13 INFO - 'default_actions': ('clobber', 08:12:13 INFO - 'read-buildbot-config', 08:12:13 INFO - 'download-and-extract', 08:12:13 INFO - 'populate-webroot', 08:12:13 INFO - 'create-virtualenv', 08:12:13 INFO - 'install', 08:12:13 INFO - 'run-tests'), 08:12:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:12:13 INFO - 'download_minidump_stackwalk': True, 08:12:13 INFO - 'download_symbols': 'ondemand', 08:12:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:12:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:12:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:12:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:12:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:12:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:12:13 INFO - 'installer_path': 'installer.exe', 08:12:13 INFO - 'log_level': 'info', 08:12:13 INFO - 'log_name': 'talos', 08:12:13 INFO - 'log_to_console': True, 08:12:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:12:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:12:13 INFO - 'opt_config_files': (), 08:12:13 INFO - 'pip_index': False, 08:12:13 INFO - 'sps_profile': False, 08:12:13 INFO - 'sps_profile_interval': 0, 08:12:13 INFO - 'suite': 'dromaeojs', 08:12:13 INFO - 'system_bits': '32', 08:12:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:12:13 INFO - 'title': 'talos-linux64-ix-013', 08:12:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:12:13 INFO - 'use_talos_json': True, 08:12:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:12:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:12:13 INFO - 'work_dir': 'build'} 08:12:13 INFO - [mozharness: 2016-11-01 15:12:13.593345Z] Running clobber step. 08:12:13 INFO - Running pre-action listener: _resource_record_pre_action 08:12:13 INFO - Running main action method: clobber 08:12:13 INFO - rmtree: /builds/slave/test/build 08:12:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:12:14 INFO - Running post-action listener: _resource_record_post_action 08:12:14 INFO - [mozharness: 2016-11-01 15:12:14.047694Z] Finished clobber step (success) 08:12:14 INFO - [mozharness: 2016-11-01 15:12:14.047795Z] Running read-buildbot-config step. 08:12:14 INFO - Running pre-action listener: _resource_record_pre_action 08:12:14 INFO - Running main action method: read_buildbot_config 08:12:14 INFO - Using buildbot properties: 08:12:14 INFO - { 08:12:14 INFO - "project": "", 08:12:14 INFO - "product": "firefox", 08:12:14 INFO - "script_repo_revision": "production", 08:12:14 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:12:14 INFO - "repository": "", 08:12:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:12:14 INFO - "buildid": "20161101063618", 08:12:14 INFO - "pgo_build": "False", 08:12:14 INFO - "basedir": "/builds/slave/test", 08:12:14 INFO - "buildnumber": 795, 08:12:14 INFO - "slavename": "talos-linux64-ix-013", 08:12:14 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:12:14 INFO - "platform": "ubuntu64_hw", 08:12:14 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:12:14 INFO - "branch": "mozilla-central", 08:12:14 INFO - "repo_path": "mozilla-central", 08:12:14 INFO - "revision": "3e73fd638e687a4d7f46613586e5156b8e2af846", 08:12:14 INFO - "stage_platform": "linux64", 08:12:14 INFO - "builduid": "55d5d7bb87824ab381947e26fc0efdd1", 08:12:14 INFO - "slavebuilddir": "test" 08:12:14 INFO - } 08:12:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:12:14 INFO - Running post-action listener: _resource_record_post_action 08:12:14 INFO - [mozharness: 2016-11-01 15:12:14.050229Z] Finished read-buildbot-config step (success) 08:12:14 INFO - [mozharness: 2016-11-01 15:12:14.050318Z] Running download-and-extract step. 08:12:14 INFO - Running pre-action listener: _resource_record_pre_action 08:12:14 INFO - Running main action method: download_and_extract 08:12:14 INFO - mkdir: /builds/slave/test/build/tests 08:12: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')]} 08:12:14 INFO - trying https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:12:14 INFO - Downloading https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/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 08:12:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/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 08:12:14 INFO - Downloaded 1361 bytes. 08:12:14 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:12:14 INFO - Using the following test package requirements: 08:12:14 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:12:14 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:12:14 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:12:14 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:14 INFO - u'jsshell-linux-x86_64.zip'], 08:12:14 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:12:14 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:12:14 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:12:14 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:12:14 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:12:14 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:12:14 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:12:14 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:12:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:12:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:12:14 INFO - Fetch https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:12:15 INFO - Http code: 200 08:12:15 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 08:12:15 INFO - x-amz-cf-id: Fw1lupswvmV3mbh1D6SkMUBjEF-hILYoUyOsXr35CTk1LWMLXm5meg== 08:12:15 INFO - x-amz-version-id: kObBpVk6PW0HJRXAbKtiFpIc8IhnyWbl 08:12:15 INFO - Expected file size: 20452283 08:12:15 INFO - Obtained file size: 20452283 08:12:19 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 08:12:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:12:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:12:19 INFO - Fetch https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:12:19 INFO - Http code: 200 08:12:19 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 08:12:19 INFO - x-amz-cf-id: E8cRKNP3pLfVmMu1JRMRkWujschN_vVmuupigWpburONwLBRmQ1CRA== 08:12:19 INFO - x-amz-version-id: kObBpVk6PW0HJRXAbKtiFpIc8IhnyWbl 08:12:20 INFO - Expected file size: 20452283 08:12:20 INFO - Obtained file size: 20452283 08:12:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:12:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:12:24 INFO - Fetch https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:12:25 INFO - Http code: 200 08:12:25 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 08:12:25 INFO - x-amz-cf-id: U9pmFwiiTZfT0b0-gWa7Raqf7lgeu0AV_pDLch7Y-ecKizx0rtSbkg== 08:12:25 INFO - x-amz-version-id: NzBtSgA9tPdx9X6aCCjZjEgLlM25CaxC 08:12:25 INFO - Expected file size: 14409038 08:12:25 INFO - Obtained file size: 14409038 08:12:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:25 INFO - trying https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:12:25 INFO - Downloading https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/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 08:12:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/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 08:12:26 INFO - Downloaded 55808068 bytes. 08:12:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:12:26 INFO - mkdir: /builds/slave/test/properties 08:12:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:12:26 INFO - Writing to file /builds/slave/test/properties/build_url 08:12:26 INFO - Contents: 08:12:26 INFO - build_url:https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:12:27 INFO - Running post-action listener: _resource_record_post_action 08:12:27 INFO - Running post-action listener: set_extra_try_arguments 08:12:27 INFO - [mozharness: 2016-11-01 15:12:27.542589Z] Finished download-and-extract step (success) 08:12:27 INFO - [mozharness: 2016-11-01 15:12:27.542813Z] Running populate-webroot step. 08:12:27 INFO - Running pre-action listener: _resource_record_pre_action 08:12:27 INFO - Running main action method: populate_webroot 08:12:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:12:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:12:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:12:27 INFO - '--tppagecycles', 08:12:27 INFO - '7'], 08:12:27 INFO - 'tests': ['tsvgm']}}, 08:12:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:12:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:12:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:12:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:12:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:27 INFO - 'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:12:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:27 INFO - 'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['damp', 'tps']}, 08:12:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:27 INFO - 'tests': ['damp', 'tps']}, 08:12:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['dromaeo_dom']}, 08:12:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:12:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['basic_compositor_video']}, 08:12:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:12:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['a11yr', 08:12:27 INFO - 'ts_paint', 08:12:27 INFO - 'tpaint', 08:12:27 INFO - 'sessionrestore', 08:12:27 INFO - 'sessionrestore_no_auto_restore', 08:12:27 INFO - 'tabpaint']}, 08:12:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:12:27 INFO - 'ts_paint', 08:12:27 INFO - 'tpaint', 08:12:27 INFO - 'sessionrestore', 08:12:27 INFO - 'sessionrestore_no_auto_restore', 08:12:27 INFO - 'tabpaint']}, 08:12:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:12:27 INFO - 'ts_paint', 08:12:27 INFO - 'tpaint', 08:12:27 INFO - 'sessionrestore', 08:12:27 INFO - 'sessionrestore_no_auto_restore', 08:12:27 INFO - 'tabpaint']}, 08:12:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:12:27 INFO - 'ts_paint', 08:12:27 INFO - 'tpaint', 08:12:27 INFO - 'sessionrestore', 08:12:27 INFO - 'sessionrestore_no_auto_restore', 08:12:27 INFO - 'tabpaint']}, 08:12:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['a11yr', 08:12:27 INFO - 'ts_paint', 08:12:27 INFO - 'tpaint', 08:12:27 INFO - 'sessionrestore', 08:12:27 INFO - 'sessionrestore_no_auto_restore', 08:12:27 INFO - 'tabpaint']}, 08:12:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['a11yr', 08:12:27 INFO - 'ts_paint', 08:12:27 INFO - 'tpaint', 08:12:27 INFO - 'sessionrestore', 08:12:27 INFO - 'sessionrestore_no_auto_restore', 08:12:27 INFO - 'tabpaint']}, 08:12:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['tsvgx', 08:12:27 INFO - 'tsvgr_opacity', 08:12:27 INFO - 'tart', 08:12:27 INFO - 'tscrollx', 08:12:27 INFO - 'cart']}, 08:12:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:12:27 INFO - 'tsvgr_opacity', 08:12:27 INFO - 'tart', 08:12:27 INFO - 'tscrollx', 08:12:27 INFO - 'cart']}, 08:12:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:27 INFO - 'talos_options': ['--disable-e10s'], 08:12:27 INFO - 'tests': ['tp5o']}, 08:12:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:27 INFO - 'tests': ['tp5o']}, 08:12:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:27 INFO - 'talos_options': ['--disable-e10s', 08:12:27 INFO - '--xperf_path', 08:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:27 INFO - 'tests': ['tp5n']}, 08:12:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:12:27 INFO - 'talos_options': ['--xperf_path', 08:12:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:12:27 INFO - 'tests': ['tp5n']}}, 08:12:27 INFO - 'talos.zip': {'path': '', 08:12:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:12:27 INFO - Running post-action listener: _resource_record_post_action 08:12:27 INFO - [mozharness: 2016-11-01 15:12:27.565253Z] Finished populate-webroot step (success) 08:12:27 INFO - [mozharness: 2016-11-01 15:12:27.565340Z] Running create-virtualenv step. 08:12:27 INFO - Running pre-action listener: _resource_record_pre_action 08:12:27 INFO - Running main action method: create_virtualenv 08:12:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:12:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:12:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:12:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:12:27 INFO - Using real prefix '/usr' 08:12:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:12:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:12:30 INFO - Installing pip.................done. 08:12:30 INFO - Return code: 0 08:12:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:12:30 INFO - Reading from file tmpfile_stdout 08:12:30 INFO - Output received: 08:12:30 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:12:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:30 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 0x7fa00f610f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:12:30 INFO - Using env: {'DISPLAY': ':0', 08:12:30 INFO - 'HOME': '/home/cltbld', 08:12:30 INFO - 'LANG': 'en_US.UTF-8', 08:12:30 INFO - 'LANGUAGE': 'en_US:en', 08:12:30 INFO - 'LOGNAME': 'cltbld', 08:12:30 INFO - 'MAIL': '/var/mail/cltbld', 08:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:30 INFO - 'MOZ_NO_REMOTE': '1', 08:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:30 INFO - 'NO_EM_RESTART': '1', 08:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:30 INFO - 'PWD': '/builds/slave/test', 08:12:30 INFO - 'SHELL': '/bin/bash', 08:12:30 INFO - 'SHLVL': '1', 08:12:30 INFO - 'TERM': 'linux', 08:12:30 INFO - 'TMOUT': '86400', 08:12:30 INFO - 'USER': 'cltbld', 08:12:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:30 INFO - '_': '/tools/buildbot/bin/python'} 08:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:30 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:12:30 INFO - Cleaning up... 08:12:30 INFO - Return code: 0 08:12:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:30 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 0x7fa00f610f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:12:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:12:30 INFO - Using env: {'DISPLAY': ':0', 08:12:30 INFO - 'HOME': '/home/cltbld', 08:12:30 INFO - 'LANG': 'en_US.UTF-8', 08:12:30 INFO - 'LANGUAGE': 'en_US:en', 08:12:30 INFO - 'LOGNAME': 'cltbld', 08:12:30 INFO - 'MAIL': '/var/mail/cltbld', 08:12:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:30 INFO - 'MOZ_NO_REMOTE': '1', 08:12:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:30 INFO - 'NO_EM_RESTART': '1', 08:12:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:30 INFO - 'PWD': '/builds/slave/test', 08:12:30 INFO - 'SHELL': '/bin/bash', 08:12:30 INFO - 'SHLVL': '1', 08:12:30 INFO - 'TERM': 'linux', 08:12:30 INFO - 'TMOUT': '86400', 08:12:30 INFO - 'USER': 'cltbld', 08:12:30 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:12:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:30 INFO - '_': '/tools/buildbot/bin/python'} 08:12:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:30 INFO - Downloading/unpacking psutil>=3.1.1 08:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:12:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:32 INFO - Installing collected packages: psutil 08:12:32 INFO - Running setup.py install for psutil 08:12:32 INFO - building 'psutil._psutil_linux' extension 08:12:32 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:12:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:12:33 INFO - building 'psutil._psutil_posix' extension 08:12:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:12:33 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:12:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:12:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:12:33 INFO - Successfully installed psutil 08:12:33 INFO - Cleaning up... 08:12:33 INFO - Return code: 0 08:12:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:33 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 0x7fa00f610f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:12:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:12:33 INFO - Using env: {'DISPLAY': ':0', 08:12:33 INFO - 'HOME': '/home/cltbld', 08:12:33 INFO - 'LANG': 'en_US.UTF-8', 08:12:33 INFO - 'LANGUAGE': 'en_US:en', 08:12:33 INFO - 'LOGNAME': 'cltbld', 08:12:33 INFO - 'MAIL': '/var/mail/cltbld', 08:12:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:33 INFO - 'MOZ_NO_REMOTE': '1', 08:12:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:33 INFO - 'NO_EM_RESTART': '1', 08:12:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:33 INFO - 'PWD': '/builds/slave/test', 08:12:33 INFO - 'SHELL': '/bin/bash', 08:12:33 INFO - 'SHLVL': '1', 08:12:33 INFO - 'TERM': 'linux', 08:12:33 INFO - 'TMOUT': '86400', 08:12:33 INFO - 'USER': 'cltbld', 08:12:33 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:12:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:33 INFO - '_': '/tools/buildbot/bin/python'} 08:12:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:12:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:12:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:12:35 INFO - Installing collected packages: mozsystemmonitor 08:12:35 INFO - Running setup.py install for mozsystemmonitor 08:12:35 INFO - Successfully installed mozsystemmonitor 08:12:35 INFO - Cleaning up... 08:12:35 INFO - Return code: 0 08:12:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa00f610f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:12:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:12:35 INFO - Using env: {'DISPLAY': ':0', 08:12:35 INFO - 'HOME': '/home/cltbld', 08:12:35 INFO - 'LANG': 'en_US.UTF-8', 08:12:35 INFO - 'LANGUAGE': 'en_US:en', 08:12:35 INFO - 'LOGNAME': 'cltbld', 08:12:35 INFO - 'MAIL': '/var/mail/cltbld', 08:12:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:35 INFO - 'MOZ_NO_REMOTE': '1', 08:12:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:35 INFO - 'NO_EM_RESTART': '1', 08:12:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:35 INFO - 'PWD': '/builds/slave/test', 08:12:35 INFO - 'SHELL': '/bin/bash', 08:12:35 INFO - 'SHLVL': '1', 08:12:35 INFO - 'TERM': 'linux', 08:12:35 INFO - 'TMOUT': '86400', 08:12:35 INFO - 'USER': 'cltbld', 08:12:35 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:12:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:35 INFO - '_': '/tools/buildbot/bin/python'} 08:12:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:35 INFO - Downloading/unpacking jsonschema==2.5.1 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:12:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:38 INFO - Downloading functools32-3.2.3-2.tar.gz 08:12:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:12:38 INFO - warning: no files found matching '*.txt' 08:12:38 INFO - no previously-included directories found matching 'build' 08:12:38 INFO - no previously-included directories found matching 'dist' 08:12:38 INFO - no previously-included directories found matching '.git*' 08:12:38 INFO - Installing collected packages: jsonschema, functools32 08:12:38 INFO - Running setup.py install for functools32 08:12:38 INFO - warning: no files found matching '*.txt' 08:12:38 INFO - no previously-included directories found matching 'build' 08:12:38 INFO - no previously-included directories found matching 'dist' 08:12:38 INFO - no previously-included directories found matching '.git*' 08:12:38 INFO - Successfully installed jsonschema functools32 08:12:38 INFO - Cleaning up... 08:12:38 INFO - Return code: 0 08:12:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa00f610f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:12:38 INFO - Using env: {'DISPLAY': ':0', 08:12:38 INFO - 'HOME': '/home/cltbld', 08:12:38 INFO - 'LANG': 'en_US.UTF-8', 08:12:38 INFO - 'LANGUAGE': 'en_US:en', 08:12:38 INFO - 'LOGNAME': 'cltbld', 08:12:38 INFO - 'MAIL': '/var/mail/cltbld', 08:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:38 INFO - 'MOZ_NO_REMOTE': '1', 08:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:38 INFO - 'NO_EM_RESTART': '1', 08:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:38 INFO - 'PWD': '/builds/slave/test', 08:12:38 INFO - 'SHELL': '/bin/bash', 08:12:38 INFO - 'SHLVL': '1', 08:12:38 INFO - 'TERM': 'linux', 08:12:38 INFO - 'TMOUT': '86400', 08:12:38 INFO - 'USER': 'cltbld', 08:12:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:38 INFO - '_': '/tools/buildbot/bin/python'} 08:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:12:38 INFO - Cleaning up... 08:12:38 INFO - Return code: 0 08:12:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fa00f610f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:12:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:12:38 INFO - Using env: {'DISPLAY': ':0', 08:12:38 INFO - 'HOME': '/home/cltbld', 08:12:38 INFO - 'LANG': 'en_US.UTF-8', 08:12:38 INFO - 'LANGUAGE': 'en_US:en', 08:12:38 INFO - 'LOGNAME': 'cltbld', 08:12:38 INFO - 'MAIL': '/var/mail/cltbld', 08:12:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:38 INFO - 'MOZ_NO_REMOTE': '1', 08:12:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:38 INFO - 'NO_EM_RESTART': '1', 08:12:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:38 INFO - 'PWD': '/builds/slave/test', 08:12:38 INFO - 'SHELL': '/bin/bash', 08:12:38 INFO - 'SHLVL': '1', 08:12:38 INFO - 'TERM': 'linux', 08:12:38 INFO - 'TMOUT': '86400', 08:12:38 INFO - 'USER': 'cltbld', 08:12:38 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:12:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:38 INFO - '_': '/tools/buildbot/bin/python'} 08:12:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:38 INFO - Downloading/unpacking blobuploader==1.2.4 08:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:40 INFO - Downloading blobuploader-1.2.4.tar.gz 08:12:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:12:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:12:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:12:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:12:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:12:41 INFO - Downloading docopt-0.6.1.tar.gz 08:12:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:12:41 INFO - Installing collected packages: blobuploader, requests, docopt 08:12:41 INFO - Running setup.py install for blobuploader 08:12:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:12:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:12:41 INFO - Running setup.py install for requests 08:12:41 INFO - Running setup.py install for docopt 08:12:42 INFO - Successfully installed blobuploader requests docopt 08:12:42 INFO - Cleaning up... 08:12:42 INFO - Return code: 0 08:12:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12: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')]} 08:12:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12: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')]} 08:12:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:42 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 0x7fa00f610f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:12:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:42 INFO - Using env: {'DISPLAY': ':0', 08:12:42 INFO - 'HOME': '/home/cltbld', 08:12:42 INFO - 'LANG': 'en_US.UTF-8', 08:12:42 INFO - 'LANGUAGE': 'en_US:en', 08:12:42 INFO - 'LOGNAME': 'cltbld', 08:12:42 INFO - 'MAIL': '/var/mail/cltbld', 08:12:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:42 INFO - 'MOZ_NO_REMOTE': '1', 08:12:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:42 INFO - 'NO_EM_RESTART': '1', 08:12:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:42 INFO - 'PWD': '/builds/slave/test', 08:12:42 INFO - 'SHELL': '/bin/bash', 08:12:42 INFO - 'SHLVL': '1', 08:12:42 INFO - 'TERM': 'linux', 08:12:42 INFO - 'TMOUT': '86400', 08:12:42 INFO - 'USER': 'cltbld', 08:12:42 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:12:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:42 INFO - '_': '/tools/buildbot/bin/python'} 08:12:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:42 INFO - Running setup.py (path:/tmp/pip-35Eayt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:42 INFO - Running setup.py (path:/tmp/pip-r7C0kr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:42 INFO - Running setup.py (path:/tmp/pip-cmTzLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:42 INFO - Running setup.py (path:/tmp/pip-_a8fuY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:42 INFO - Running setup.py (path:/tmp/pip-4DqWBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:42 INFO - Running setup.py (path:/tmp/pip-coT340-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:42 INFO - Running setup.py (path:/tmp/pip-BrnzHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:42 INFO - Running setup.py (path:/tmp/pip-L9mopo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:42 INFO - Running setup.py (path:/tmp/pip-Bm6UQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:42 INFO - Running setup.py (path:/tmp/pip-jKw_LQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:43 INFO - Running setup.py (path:/tmp/pip-CwkYIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:43 INFO - Running setup.py (path:/tmp/pip-tiP0A_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:43 INFO - Running setup.py (path:/tmp/pip-xG44Vf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:43 INFO - Running setup.py (path:/tmp/pip-BWBApz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:43 INFO - Running setup.py (path:/tmp/pip-fm4ZRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:43 INFO - Running setup.py (path:/tmp/pip-YfzKjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:43 INFO - Running setup.py (path:/tmp/pip-Woimqa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:12:43 INFO - Running setup.py install for manifestparser 08:12:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:12:43 INFO - Running setup.py install for mozcrash 08:12:43 INFO - Running setup.py install for mozdebug 08:12:43 INFO - Running setup.py install for mozdevice 08:12:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:12:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:12:43 INFO - Running setup.py install for mozfile 08:12:44 INFO - Running setup.py install for mozhttpd 08:12:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Running setup.py install for mozinfo 08:12:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Running setup.py install for mozInstall 08:12:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Running setup.py install for mozleak 08:12:44 INFO - Running setup.py install for mozlog 08:12:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Running setup.py install for moznetwork 08:12:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Running setup.py install for mozprocess 08:12:44 INFO - Running setup.py install for mozprofile 08:12:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:12:44 INFO - Running setup.py install for mozrunner 08:12:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:12:45 INFO - Running setup.py install for mozscreenshot 08:12:45 INFO - Running setup.py install for moztest 08:12:45 INFO - Running setup.py install for mozversion 08:12:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:12:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:12:45 INFO - Cleaning up... 08:12:45 INFO - Return code: 0 08:12:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:45 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 0x7fa00f610f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:12:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:45 INFO - Using env: {'DISPLAY': ':0', 08:12:45 INFO - 'HOME': '/home/cltbld', 08:12:45 INFO - 'LANG': 'en_US.UTF-8', 08:12:45 INFO - 'LANGUAGE': 'en_US:en', 08:12:45 INFO - 'LOGNAME': 'cltbld', 08:12:45 INFO - 'MAIL': '/var/mail/cltbld', 08:12:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:45 INFO - 'MOZ_NO_REMOTE': '1', 08:12:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:45 INFO - 'NO_EM_RESTART': '1', 08:12:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:45 INFO - 'PWD': '/builds/slave/test', 08:12:45 INFO - 'SHELL': '/bin/bash', 08:12:45 INFO - 'SHLVL': '1', 08:12:45 INFO - 'TERM': 'linux', 08:12:45 INFO - 'TMOUT': '86400', 08:12:45 INFO - 'USER': 'cltbld', 08:12:45 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:12:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:45 INFO - '_': '/tools/buildbot/bin/python'} 08:12:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:12:45 INFO - Running setup.py (path:/tmp/pip-_N6fqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:12:45 INFO - Running setup.py (path:/tmp/pip-6YE10r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:12:45 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)) 08:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:12:45 INFO - Running setup.py (path:/tmp/pip-bMAqGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:12:45 INFO - Running setup.py (path:/tmp/pip-ZJ8di9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:12:45 INFO - Running setup.py (path:/tmp/pip-9Tdpq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:12:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:12:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:12:45 INFO - Running setup.py (path:/tmp/pip-wQVh9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:12:46 INFO - Running setup.py (path:/tmp/pip-yYyqTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:12:46 INFO - Running setup.py (path:/tmp/pip-z1ZwWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:12:46 INFO - Running setup.py (path:/tmp/pip-IMJslq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:12:46 INFO - Running setup.py (path:/tmp/pip-GxfSd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:12:46 INFO - Running setup.py (path:/tmp/pip-BahITC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:12:46 INFO - Running setup.py (path:/tmp/pip-6Ujlq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:12:46 INFO - Running setup.py (path:/tmp/pip-5pYi7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:12:46 INFO - Running setup.py (path:/tmp/pip-gT_JOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:12:46 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)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:46 INFO - Running setup.py (path:/tmp/pip-OtqxE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:12:46 INFO - Running setup.py (path:/tmp/pip-EgE7iJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:12:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:12:46 INFO - Running setup.py (path:/tmp/pip-lIAyxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:12:46 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)) 08:12:46 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)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:12:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:12:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12: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 08:12:48 INFO - Downloading blessings-1.6.tar.gz 08:12:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:12:48 INFO - Installing collected packages: blessings 08:12:48 INFO - Running setup.py install for blessings 08:12:48 INFO - Successfully installed blessings 08:12:48 INFO - Cleaning up... 08:12:49 INFO - Return code: 0 08:12:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:49 INFO - Reading from file tmpfile_stdout 08:12:49 INFO - Current package versions: 08:12:49 INFO - argparse == 1.2.1 08:12:49 INFO - blessings == 1.6 08:12:49 INFO - blobuploader == 1.2.4 08:12:49 INFO - docopt == 0.6.1 08:12:49 INFO - functools32 == 3.2.3-2 08:12:49 INFO - jsonschema == 2.5.1 08:12:49 INFO - manifestparser == 1.1 08:12:49 INFO - mozInstall == 1.12 08:12:49 INFO - mozcrash == 0.17 08:12:49 INFO - mozdebug == 0.1 08:12:49 INFO - mozdevice == 0.48 08:12:49 INFO - mozfile == 1.2 08:12:49 INFO - mozhttpd == 0.7 08:12:49 INFO - mozinfo == 0.9 08:12:49 INFO - mozleak == 0.1 08:12:49 INFO - mozlog == 3.4 08:12:49 INFO - moznetwork == 0.27 08:12:49 INFO - mozprocess == 0.23 08:12:49 INFO - mozprofile == 0.28 08:12:49 INFO - mozrunner == 6.12 08:12:49 INFO - mozscreenshot == 0.1 08:12:49 INFO - mozsystemmonitor == 0.3 08:12:49 INFO - moztest == 0.7 08:12:49 INFO - mozversion == 1.4 08:12:49 INFO - psutil == 3.1.1 08:12:49 INFO - requests == 1.2.3 08:12:49 INFO - wsgiref == 0.1.2 08:12:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:49 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 0x7fa00f610f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:12:49 INFO - Using env: {'DISPLAY': ':0', 08:12:49 INFO - 'HOME': '/home/cltbld', 08:12:49 INFO - 'LANG': 'en_US.UTF-8', 08:12:49 INFO - 'LANGUAGE': 'en_US:en', 08:12:49 INFO - 'LOGNAME': 'cltbld', 08:12:49 INFO - 'MAIL': '/var/mail/cltbld', 08:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:49 INFO - 'MOZ_NO_REMOTE': '1', 08:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:49 INFO - 'NO_EM_RESTART': '1', 08:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:49 INFO - 'PWD': '/builds/slave/test', 08:12:49 INFO - 'SHELL': '/bin/bash', 08:12:49 INFO - 'SHLVL': '1', 08:12:49 INFO - 'TERM': 'linux', 08:12:49 INFO - 'TMOUT': '86400', 08:12:49 INFO - 'USER': 'cltbld', 08:12:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:49 INFO - '_': '/tools/buildbot/bin/python'} 08:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:12:49 INFO - Cleaning up... 08:12:49 INFO - Return code: 0 08:12:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:12:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:12:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:12:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:12:49 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 0x7fa00f610f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17f08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18bdca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, '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': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:12:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:12:49 INFO - Using env: {'DISPLAY': ':0', 08:12:49 INFO - 'HOME': '/home/cltbld', 08:12:49 INFO - 'LANG': 'en_US.UTF-8', 08:12:49 INFO - 'LANGUAGE': 'en_US:en', 08:12:49 INFO - 'LOGNAME': 'cltbld', 08:12:49 INFO - 'MAIL': '/var/mail/cltbld', 08:12:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:12:49 INFO - 'MOZ_NO_REMOTE': '1', 08:12:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:12:49 INFO - 'NO_EM_RESTART': '1', 08:12:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:12:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:12:49 INFO - 'PWD': '/builds/slave/test', 08:12:49 INFO - 'SHELL': '/bin/bash', 08:12:49 INFO - 'SHLVL': '1', 08:12:49 INFO - 'TERM': 'linux', 08:12:49 INFO - 'TMOUT': '86400', 08:12:49 INFO - 'USER': 'cltbld', 08:12:49 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:12:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:12:49 INFO - '_': '/tools/buildbot/bin/python'} 08:12:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:12:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:12:49 INFO - Cleaning up... 08:12:49 INFO - Return code: 0 08:12:49 INFO - Running post-action listener: _resource_record_post_action 08:12:49 INFO - Running post-action listener: _start_resource_monitoring 08:12:49 INFO - Starting resource monitoring. 08:12:49 INFO - [mozharness: 2016-11-01 15:12:49.726804Z] Finished create-virtualenv step (success) 08:12:49 INFO - [mozharness: 2016-11-01 15:12:49.727260Z] Running install step. 08:12:49 INFO - Running pre-action listener: _resource_record_pre_action 08:12:49 INFO - Running main action method: install 08:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:12:49 INFO - Reading from file tmpfile_stdout 08:12:49 INFO - Detecting whether we're running mozinstall >=1.0... 08:12:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:12:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:12:50 INFO - Reading from file tmpfile_stdout 08:12:50 INFO - Output received: 08:12:50 INFO - Usage: mozinstall [options] installer 08:12:50 INFO - Options: 08:12:50 INFO - -h, --help show this help message and exit 08:12:50 INFO - -d DEST, --destination=DEST 08:12:50 INFO - Directory to install application into. [default: 08:12:50 INFO - "/builds/slave/test"] 08:12:50 INFO - --app=APP Application being installed. [default: firefox] 08:12:50 INFO - mkdir: /builds/slave/test/build/application 08:12:50 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'] 08:12:50 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 08:13:06 INFO - Reading from file tmpfile_stdout 08:13:06 INFO - Output received: 08:13:06 INFO - /builds/slave/test/build/application/firefox/firefox 08:13:06 INFO - Running post-action listener: _resource_record_post_action 08:13:06 INFO - [mozharness: 2016-11-01 15:13:06.116872Z] Finished install step (success) 08:13:06 INFO - [mozharness: 2016-11-01 15:13:06.117116Z] Running run-tests step. 08:13:06 INFO - Running pre-action listener: _resource_record_pre_action 08:13:06 INFO - Running main action method: run_tests 08:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:13:06 INFO - Python 2.7.3 08:13:06 INFO - Return code: 0 08:13:06 INFO - grabbing minidump binary from tooltool 08:13:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:13:06 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 0x18baf60>, '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 0x18bbd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18bc1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:13:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:13:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:13:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:13:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:13:06 INFO - Return code: 0 08:13:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:13:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:13:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:13:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:13:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:13:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:13:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-013 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:13:06 INFO - Using env: {'DISPLAY': ':0', 08:13:06 INFO - 'HOME': '/home/cltbld', 08:13:06 INFO - 'LANG': 'en_US.UTF-8', 08:13:06 INFO - 'LANGUAGE': 'en_US:en', 08:13:06 INFO - 'LOGNAME': 'cltbld', 08:13:06 INFO - 'MAIL': '/var/mail/cltbld', 08:13:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:13:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:13:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:13:06 INFO - 'MOZ_NO_REMOTE': '1', 08:13:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:13:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:13:06 INFO - 'NO_EM_RESTART': '1', 08:13:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:13:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:13:06 INFO - 'PWD': '/builds/slave/test', 08:13:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:13:06 INFO - 'SHELL': '/bin/bash', 08:13:06 INFO - 'SHLVL': '1', 08:13:06 INFO - 'TERM': 'linux', 08:13:06 INFO - 'TMOUT': '86400', 08:13:06 INFO - 'USER': 'cltbld', 08:13:06 INFO - 'XDG_SESSION_COOKIE': '9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833', 08:13:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:13:06 INFO - '_': '/tools/buildbot/bin/python'} 08:13:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-013', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:13:06 INFO - mozversion application_buildid: 20161101063618 08:13:06 INFO - mozversion application_changeset: 3e73fd638e687a4d7f46613586e5156b8e2af846 08:13:06 INFO - mozversion application_display_name: Nightly 08:13:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:13:06 INFO - mozversion application_name: Firefox 08:13:06 INFO - mozversion application_remotingname: firefox 08:13:06 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:13:06 INFO - mozversion application_vendor: Mozilla 08:13:06 INFO - mozversion application_version: 52.0a1 08:13:06 INFO - mozversion platform_buildid: 20161101063618 08:13:06 INFO - mozversion platform_changeset: 3e73fd638e687a4d7f46613586e5156b8e2af846 08:13:06 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:13:06 INFO - mozversion platform_version: 52.0a1 08:13:06 INFO - using testdate: 1478013186 08:13:06 INFO - actual date: 1478013186 08:13:06 INFO - starting webserver on 'localhost:59687' 08:13:06 INFO - SUITE-START | Running 2 tests 08:13:06 INFO - TEST-START | dromaeo_css 08:13:06 INFO - operating with platform_type : linux_ 08:13:06 INFO - Initialising browser for dromaeo_css test... 08:13:06 INFO - TEST-INFO | started process 9325 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNdjlTZ/profile http://localhost:59687/getInfo.html) 08:13:10 INFO - PROCESS | 9325 | __metrics Screen width/height:1600/1200 08:13:10 INFO - PROCESS | 9325 | colorDepth:24 08:13:10 INFO - PROCESS | 9325 | Browser inner width/height: 1024/697 08:13:10 INFO - PROCESS | 9325 | __metrics 08:13:11 INFO - PROCESS | 9325 | 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" 08:13:11 INFO - PROCESS | 9325 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:13:12 INFO - PROCESS | 9325 | console.error: PushService: 08:13:12 INFO - PROCESS | 9325 | stateChangeProcessEnqueue: Error transitioning state 08:13:12 INFO - PROCESS | 9325 | UnknownError 08:13:12 INFO - TEST-INFO | 9325: exit 0 08:13:12 INFO - Browser initialized. 08:13:12 INFO - Running cycle 1/1 for dromaeo_css test... 08:13:12 INFO - TEST-INFO | started process 9406 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNdjlTZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:13:25 INFO - PROCESS | 9406 | RSS: Main: 174125056 08:13:25 INFO - PROCESS | 9406 | 08:14:15 INFO - PROCESS | 9406 | 1478013255973 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:16:30 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:59687/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59687/tests/dromaeo/cssquery-ext.html) 08:16:32 INFO - PROCESS | 9406 | RSS: Main: 368652288 08:16:32 INFO - PROCESS | 9406 | 08:19:35 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:59687/tests/dromaeo/cssquery-ext.html (next: http://localhost:59687/tests/dromaeo/cssquery-jquery.html) 08:19:36 INFO - PROCESS | 9406 | RSS: Main: 276992000 08:19:36 INFO - PROCESS | 9406 | 08:22:38 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:59687/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59687/tests/dromaeo/cssquery-mootools.html) 08:22:39 INFO - PROCESS | 9406 | RSS: Main: 225603584 08:22:39 INFO - PROCESS | 9406 | 08:25:41 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:59687/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59687/tests/dromaeo/cssquery-prototype.html) 08:25:41 INFO - PROCESS | 9406 | RSS: Main: 221974528 08:25:41 INFO - PROCESS | 9406 | 08:28:45 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:59687/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59687/tests/dromaeo/cssquery-yui.html) 08:28:45 INFO - PROCESS | 9406 | RSS: Main: 220803072 08:28:45 INFO - PROCESS | 9406 | 08:31:48 INFO - PROCESS | 9406 | Cycle 1(1): loaded http://localhost:59687/tests/dromaeo/cssquery-yui.html (next: http://localhost:59687/tests/dromaeo/cssquery-dojo.html) 08:31:49 INFO - PROCESS | 9406 | RSS: Main: 313958400 08:31:49 INFO - PROCESS | 9406 | 08:31:49 INFO - PROCESS | 9406 | __start_tp_report 08:31:49 INFO - PROCESS | 9406 | _x_x_mozilla_page_load 08:31:49 INFO - PROCESS | 9406 | _x_x_mozilla_page_load_details 08:31:49 INFO - PROCESS | 9406 | |i|pagename|runs| 08:31:49 INFO - PROCESS | 9406 | |0;dojo.html;2590.857502837344;2594.07910191882;2633.236361455178;2641.907533236336;2642.894284228631;4658.138244424784;4730.976345118278;4734.692245004072;4748;4750.049990001996;4739.289106634006;4744.501827308135;4757.833475828346;4766.070616229837;4770.022145460181;4357.607815296623;4383.189110014641;4399.27411977025;4424.225760491917;4447.84432544861;4422.6240769534625;4423.447069116361;4454.955450445503;4456.153330867141;4460.197164510387;4341.934870976938;4366.585174408442;4375.562443755631;4413.3159360299205;4459.353393757903;4409.052053808415;4436.534163912807;4444.733316001018;4481.193385190681;4484.372187893698;4254;4289.957100428987;4301.2902871026245;4309.698321117523;4327.1345730853955;4681.648876334254;4693.155232058228;4696.342512048316;4698.412698412699;4776.641751868624;4993.875153121201;5036.194208926554;5038.39539255288;5047.419546752097;5085.084684756743;4898.730569818658;4977.278294647256;4979.6265280104135;5063.366691204255;5110.97444512775;4674.789634466457;4688.765561721901;4694.342792009122;4703.717776933395;4768.737719425396;5156.690598564098;5158.948410515847;5159.845204643867;5184.8963020739375;5224.7126408047925;4841.15279826029;4937.8271760488215;4948.233023881304;4961.70229786214;5015.3229314042865;4957.876053098629;5013.724245166551;5015.699058056528;5059.62052846038;5063.316452278895;5014.774335154927;5017.623678224148;5022.824201153016;5070.239464080418;5085.949140508622;4948.925766113512;4960.950390496121;4962.727050012284;5007.874803129951;5027.296178535008;4159.480064991876;4245.915081698348;4247.277962746341;4273.230818452646;4282.8715138545895;3751.7186211033736;3770.5286839145106;3778.0366006668673;3795.962040379616;3801.201747632973;4300.032492689183;4313.41768861206;4321.5678432157165;4327.350897365421;4332.220200363965;5055.87360315995;5069.188929771219;5070.569001634829;5072.365954255718;5073.441921388644;4317.6114149726045;4323.675724320626;4324.200022995756;4324.654027677778;4329.285667864767;4517.3901523293935;4530.275155975029;4554.134714404253;4558.33904083906;4559.658025648089;4741.217699079613;4784.138855006132;4786.688865223749;4790.928136077892;4801.711897286034;5073.543381095719;5078.568321692697;5083.796648134034;5084.51697088776;5127.820526281562;4671.15919134559;4721.220998535203;4724.433068031721;4777.617790576676;4779.402574678165;4936.185529387611;4961;4973.975130124326;4977.60179185657;5044.772985215747;5048.823291184791;5055.1406260936465;5056.418511871182;5057.216131499624;5121.103806833715;4797.928031079467;4844.539768721966;4906.656534042583;4914.533119353656;4920.1389756791705;4902;4902.950970490392;4904.754762261801;4907.460179380194;4913.48408417111;4828.66199366041;4833.685810422311;4834.274858771212;4835.564799168092;4837.854864353934;4925.778339974638;4938.43208031081;4966.130927087817;4978.4274808397495;5034.672746271481;4832.154372984784;4838;4869.952960113593;4887.682300650446;4927.827526036572 08:31:49 INFO - PROCESS | 9406 | |1;ext.html;566.2751677852349;578.8379253808934;585.2041223935447;588.3293045927643;599.4574909706716;29952.550711739314;38728.80635596821;39923.20153596933;39933;43827.78086109573;40120.39819402711;40735.59264407362;40775.796121019426;40864.59135408645;41093.38359924604;7699.153093159748;7857.960710196469;7860.606969651523;7860.646270917794;7863.056433228021;7682.807929801744;7764.572948487831;7768.495047821873;7776.183500732426;7778.299953004229;7692.384609231248;7712.652930618107;7721.884171737428;7740.961295193516;7767.922320776805;7805.492642978245;7845.960770196112;7848.960755196216;7878.172791856887;7889.408294377916;7633.122190948056;7691.230876912264;7702.229777022309;7703.961480192619;7705.345045671124;38463.807680961414;38712.22575548473;38753.80623096895;38813.611863881284;38869.805650971844;2991.9551206731917;3247.058353077605;3382.8815991440183;3459.4810778383444;3535;28237.435251295065;28907.56638650422;28957;29094.27264318388;29260.268493287625;3321.7342612590933;3364.310316385135;3441.15691655546;3514.5606799150105;3539.9734077117605;244849;245766;246503;247180;247380;51217.48782512127;51579.74210128925;51617.225741613904;56147.71926140343;58041;54334.47986241676;59105.704471478224;59328.70335648294;59349;59399.70300148472;14935.701285974219;15004.324805383783;15075.170865602497;15082.396704131932;15191;10848.915108489087;10948.616798412017;10957.616483423042;10966.451677416097;10969.341839489656;18154;18734.812651873308;18780.906095469436;18783;18813.15340809667;7223.573236925862;7330.115039029323;7438.628068596657;7512.361449276873;7582.867337301074;782.6282515805061;842.9578521073922;890.4479222881855;918.2837386838144;947.0387556630026;25678.48643027129;26305.605415918395;26756.331091722863;26880.90869549988;26972;739.4010851210537;919.5723988345452;964.9131578158;991.4893829677721;1035.5288343803702;13359.53241636538;13700.246486443142;14120.50578229757;14132.293385330693;14176.645583860485;394330;396400;396500;396807;397532;48982.755086224344;49527.50472495229;49582.25626615604;49588;49615.046194456176;1063.6543123484898;1099.3349023840462;1144.6508814811561;1159.750653609478;1177.1230433327225;25635.487290253717;28240.341646602385;28670;28690;29207.269818254714;42019.1596168081;42614.5738542623;42630;42654.573454266305;42694.78652606717;295344;296178;296449;297026;297239;24520.6321905168;24938.628375439526;25342.493150137263;26100.34749131287;37485.25029499449;40110;40213.1957360857;40246.39630405605;40881;41218.79390603028;34873.30253394969;34970.776022839076;34987.30025399529;35257;35579.15366770601;34504.82747586246;34965.650343496236;35037.299254015285;35046.47430288497;35319;34507.48238776471;34519.121075343886;35172.472412914336;35261.294774104885;35556.64443355533;30390.84804575963;31388.215294617818;31824.36351273008;31961.200969975936;32523.51214731828;24272.635910461006;24995.87502062478;25099;25276.241712748648;25541.87229063843 08:31:49 INFO - PROCESS | 9406 | |2;jquery.html;341.882050692511;364.32417864860685;368.3241252302026;369.2596344329619;385.8630186283869;12469.376531173439;13031.67420814479;16637.750433743502;16932.4073657422;17972.73040904384;15728.921355393208;15893.125878076702;16010.19949002551;17536.473905782816;17918.820811791877;3960.3663413853787;5012.423571289303;5164.741762911839;5249.580033597322;5254.369475662907;5065.138926382524;5209.244659524366;5215.608829337796;5215.6349055566125;5217.373915130171;4979.128652485819;5174.068667639824;5177.430482646906;5182.689038657673;5189.42916279209;5169.534741873212;5186.636935414523;5191.506806853343;5208.401033881077;5223.608229382811;4666.883327916829;4673.252279635276;4674.041821426599;4686.742229177394;4933.925991110136;12387.814182787266;12399.25604463726;12635.178713383693;12641.557545485955;12651.240925544405;1770.5219590710565;1853.0456814740285;1900.8954507502083;1925.7303977443169;1964.479412955568;8968.10318968098;9012.143846334588;9250.21574192773;9474.526273686357;12967.157134786303;1661.750737389389;1686.8924169646828;1689.5239605216161;1690.8429290663428;1712.760213570101;64877.0268445969;65701.67149164272;67829.3217067828;67886.9999999995;68322.65838670774;9957.502124893726;10027.548760305805;10066.396016239049;10265;10291.948540257401;13819.654508637163;13853;13875.098118622258;13880.652983675489;13890.513832015831;7208.711651533985;7340;7451.701931922662;7606.885896711554;7620.542767433861;7096.574205547684;7146.464015198881;7305.3425191732995;7308.524945878501;7311.561306321638;4221.873343799691;4306.332518459643;4380.452443444569;4424.646028317727;4439.200943830077;1792.4085051932832;1815.546113471632;1844.557306246518;1852.8702990790784;1889.9433017009512;386.2063459590568;390.65231943570245;416.8416001919251;848.2737628925108;877.2411863737948;10564.313319634199;10655.147588192925;10709.143268538499;10720.624778132884;11109.55561777536;402.6698107551838;410.71455338539425;416.5917400947089;423.55103590194494;446.3906767262663;5554.527865131428;5659.434056594308;5777.24895763548;5801.651900885876;6004.369541198112;431436;434918;435845;440124;442867;74596.62701686457;78148.60925695449;78397;81266.18733812704;81411;422.2947677378785;433.3240145373228;434.8695391382636;435.2187822857978;436.607053651716;9446.480443575669;9914.20686345105;10015.798104227248;10043.548040338057;10115.443650599287;34282;35231;35417;36096.819515903306;40211.195776084896;46711.76644116758;51629.741851290506;51717;51781.7410912943;53318;7258.129024517092;7295.124585049828;7314.7074117036855;7318.780436586911;7753.883691744515;9829.4102353859;11054.557817687202;11623.59317423886;11778;12333.198342107735;9794.412335259907;9879.160271377013;10050.69847904564;10153.369635809502;10579.62971296001;9758.707238782848;9936.950315248378;10068.44623545712;10170.89829101729;10730.141588673043;9863.21094312439;10151;10336.689899303034;10433.686989390331;10648.307859989076;7449.962750186214;7631.847363052819;7704.26809453101;8016.799580010313;8058.3553315733425;9633;10073.647422340184;10135;10242.743931401774;10263.846042309222 08:31:49 INFO - PROCESS | 9406 | |3;mootools.html;1210.2556927489586;1315.7960516120002;1377.6900197455573;1420.9644758881034;1668.7413450915112;6035.21542199514;6680.064790929274;6907.274736152701;6920.792376228708;7114.750983715571;6936.202336731278;6984.8253793655185;7006.369426751591;7009.299070092989;7013.614251216181;2088.540521085363;2106.09437941685;2108.9578208435823;2112.524681946565;2117.269542008005;2070.2133189388087;2127.957440851182;2134.9146034158616;2142.689310050042;2145.6245157097446;2088.8642238254542;2097.454661787931;2117.3647905628327;2118.046878904491;2130.7230060092165;1996.3711430899293;2035.0435295411132;2036.134642776814;2043.7854025327276;2044.91820327186;2020.3130935482006;2053.0453339197197;2085.48905518149;2086.1655337864822;2089.7387826521685;6836.213835408942;6909.205441374256;6914;6917.481188910801;6920.930790692079;4209.3054645983375;4323;4379.7372157670325;4410.294352903552;4420.027593929331;2624.238970698495;2828.5757136429493;2891.4361699468614;2897.463969165711;2898.289918969866;945.9716208513755;958.4249450329816;970.7864269860619;981.6367943860746;983.0513554419947;9068.047854975199;9152.90847091534;9164.587593558306;9169.266458683289;9179.449233046038;3586.4082426399873;3632.328019316382;3665.780053196763;3680.5767336756617;3681.6686498214754;7145.1068616422945;7147.9285207148305;7152.749653762094;7153.213146553875;7159.57042577447;4076.7146299759324;4113.71204015722;4114.238865809834;4114.876553703393;4122.793860307032;3535.5757309122555;3579.2125732338845;3805.9809700951873;3810.4855844460644;4025.255327764373;3120.89076882308;3158.57359256502;3246.6753324667343;3249.707526322595;3259.983700081532;970.0590427285522;980.3578655980344;987.0524296675129;987.3088837813559;999.4253304350028;761.9923800762032;766.2567309709573;834.6536187482127;835.4110352201683;845.7166849105496;4501.88745281364;4650.86047418578;4716.103940251342;4716.740579268105;4939.555440010345;394.8400897636462;396.8710169195023;406.2383031815346;422.05670326819535;427.22885192227704;3276.3447310537986;3363.1760218746563;3391.660833916638;3410.795352278871;3440.4323286657923;7957.641906114239;8353.081161072278;8360.749177524684;8426.662933482592;8436.704715334934;8170.325083357898;8316.085230624627;8323.084460709317;8329.66681332752;8367.246947774729;6508.730797494538;6553.246376666649;6659.467242620579;6667.333266673294;6670.366315200048;4840.975795121002;4843.370361852936;4847.830325938575;4849.248366503198;4887.242477416006;7615.276548727862;7666.731664391719;7697.384209263358;7732.420068494998;7738.574378409242;7667.156612772479;7856.410769192219;7874.330681892104;7892.763217103496;7917.683292668229;5470.835874923759;5675.460831221028;5859.736311866061;5905.616134951214;6035.577509574287;6067.878642427215;6374.553781235269;6618.602883826793;6624.205095388585;6801.863962720817;5739.885202295847;5820.912686309624;5863.237779088691;5874.118882167709;5965.343812180743;5773.191753154646;5819.185314056121;5888.882222355614;5916.053431450947;6019.398060194121;5823.82528524145;5825.3592104867585;5864.032434648406;5881;5893.233879595625;4053.493313335833;4061.9593804061583;4161.313383291844;4180.47744031996;4315.374270730789;4197.4753155855515;4230.344296634026;4288.442502474658;4322.589354011364;4460.776961151864 08:31:49 INFO - PROCESS | 9406 | |4;prototype.html;298.9491786396312;300.60320377102227;302.5612861351041;306.8895197728817;308.434023566755;4666.323383109447;4745.786439610217;4748.430188377395;4797.85740340077;4804.111239420709;4618.4688760792515;4682.705474317585;4687.71873687579;4736.881577960553;4739.952600473995;3566.7146628269807;3659.14010207601;3673.210259794144;3738.009592326142;3762.5861155272964;3756.7745935243975;3766.6233376662253;3770.660640542351;3776.7922764247955;3781.470594116826;3721.274351501458;3736.8131593420358;3744.7191460640424;3749.400095984643;3762.5861155272896;3524.4713293006125;3620.4026335654585;3669.5963444021136;3732.402815549526;3743.887683369503;3316.933661326784;3320.269540701042;3338.1821453743746;3347.748918831073;3349.112485191426;4622.451478754621;4629.629629629621;4629.736036094545;4642.373279607277;4644.954885150814;4184.895377615553;4250.298700714378;4285.485741710983;4287.314029755255;4287.464066991626;4898.485659005789;4923.950760492385;4948.282499037656;4956.479569645207;4960.627952903546;3573.8391772370046;3575.374309495854;3580.5498772996716;3590.2460483298537;3595.1191957970464;5171.21593050397;5183.2743415921805;5192.896876764917;5195.142801437796;5195.376115257424;3424.1610805352348;3593.7843729376323;3595.48316178676;3601.1814033912706;3611.855525778992;3640.508531348287;3642.9453558196647;3651.068977410743;3654.6295139322756;3674.4488326751202;4197.727147735387;4198.748075115503;4206.642435392964;4215.283401821697;4221.514525829569;4743.881402964885;4921.876953076202;4997.2254300582745;5007.8247261346405;5020.2720605511995;1248.1325478792153;1265.2724683307135;1268.429206856918;1270.8220849081135;1272.2620879889641;774.5430196184166;791.7822598785265;797.7168105322643;805.3838813307824;820.1962077164293;4187.304141822506;4197.706160568731;4318.157959197989;4403.625691816167;4418.160549495586;5090.338256026767;5092.9236061459105;5103.923441148386;5104.719240441737;5115.514026167508;4381.956180438155;4382.978085109554;4394.472663280363;4406.823727050946;4425.800838962255;2594.286571192937;2681.088429933832;2691.9730802692116;2705.972940270572;2706.6616672915884;4825.734584597811;4830;4830.2513110467935;4830.275458681155;4840.75796210188;5177.7152256625495;5208.91643342666;5210.921836172461;5235.319408476874;5240.842774716764;4596.517365676623;4842.346283251716;4867.148249056401;4876.146674331978;4903.509649035068;5139.588832893285;5147.268230532984;5160.303359046481;5164.845054648216;5172.224166375074;4872.4153101628035;5046.59627229828;5047.4352950585435;5047.570956468741;5062.139436295912;4829.251466022772;4854.344663470386;4857.247126695368;4871.853844384674;4895.8041678332465;3621.4567814827988;3628.2924829657964;3628.310620982005;3635.654612811779;3648.543932008499;5114.7495102154935;5157.200633901752;5158.329417175743;5166.741662916915;5187.314122910145;4803.759812009455;4954.851354459372;5030.9245361320345;5031.874203144951;5041.319421878;5010.724410157476;5036.672616280077;5038.496150384932;5046.77289521965;5059.190529515407;4980.750962451935;4986.063796841174;4989.875253118701;4992.625553083606;5007.39911210657;4826.276058591099;4839.612830973584;4951.084049450863;5061.721605311744;5095.694258344512;4814.20565606671;4935.259711043373;4965.8013679452415;4971.279164521052;4971.776270067928 08:31:49 INFO - PROCESS | 9406 | |5;yui.html;691.3190507350259;693.8993845892347;712.7754757251467;725.4994054102672;747.2826086956521;12144.96767774739;13103.73792524149;13125;13167.078304518676;13183.340832958362;12410.937945310283;12588.811167832468;12627.55803546876;12694.80957785634;12696.682582935431;618.77724019353;636.5098873867142;775.0466925681416;781.5935713429013;804.6861723927673;794.737736546941;803.3733687723555;804.5132694719698;804.7304153108715;805.2028491793112;843.1105184030845;843.1568431568431;843.6288033265344;849.1126772522698;850.0224741547208;636.2460484326042;653.1639501438167;805.899262592176;843.2326582809644;844.3034496540348;606.5996442348073;608.3186830749545;609.5062998970848;611.2725856231115;612.7334609444906;12727.936360318232;12786.808197877039;12788.936055319664;12813.10308278421;12822.871771282355;11950.46222919962;12044.397780111047;12317.076219283499;12379.133460657758;12710.110292279544;11225.887741122566;11277.887221127765;11400.771984560346;11418.486168122372;11584.192560087553;4033.334499807528;4037.9394309085387;4061.959380406188;4085.611866872642;4117.394216255662;52651;57551.71224143936;57787.42212577863;58044;58148;9708.466034368037;9863.852042219372;9923.900760992297;10037.749056273651;10322.948385258025;18068;18343.54141146482;18353.81646183521;18395.816041839676;18494.907525462288;6395.584287021329;6464.741410343628;6543.214814222229;6558.1802274715665;6692.765753198614;3497.143199915986;3497.5977762557122;3508.964910350915;3544.503769472276;3576.7496275260482;2669.3726974161054;2758.8344699318104;2768.045024466556;2770.8614569271454;2784.4152727926958;475.9262314341283;482.1441940555542;482.62596487722294;485.7110019538369;511.8694732843101;601.6089541797779;614.7418084404561;644.3685188515282;647.685872351909;663.3532306001609;7862.01724784402;7935.920640793518;8122.675092996332;8200.343972482187;8320.583970801435;568.5252813900357;581.1805354450205;633.7496688807895;652.324843786688;660.7720336483906;3613.6928361089076;3794.667222371032;4064.837406503766;4073.2260870434525;4094.2220978014084;62129.68935155295;64268;64900;67066.66466667636;67355.3264467349;49656.75171624119;52051.47948520466;55214.17178742322;58029.70985145132;58551;52536.21195681991;52866.207006894925;53054.469455304956;53144;53200.73399633054;8387.874181887399;8944.642214311354;8945.016048234818;9017.368784185044;9082.091790821129;27020.864895675397;33208.003759887244;34865;35459.82270088633;39454.408183876694;48299;49375.50624493709;49405.75297123491;49713.25430118479;51511.2273315893;10471.581136754749;10620.52207650642;10702.464876756287;10795.892041079489;11001.779964400826;11381.487833047368;11417.543298267976;12362.3818809061;12630.557930472389;12801.61595152147;11045.779084418427;11317.20779545457;11810.763784724086;11953.521859125538;11954.880451195724;11708.70728231801;11745;11933.641990740292;12019.827748914933;12427.44076516541;11072.944635276772;11177;11335.943320283346;11488.368139752394;11937.4031298433;9327.440353578808;9790.657326993522;9874.654387096418;9892.258080643836;10102.242331824995;9687.854682179632;10140.442275674908;10267.58929642806;10401.635942741968;10491.632792852213 08:31:49 INFO - PROCESS | 9406 | __end_tp_report 08:31:49 INFO - PROCESS | 9406 | __start_cc_report 08:31:49 INFO - PROCESS | 9406 | _x_x_mozilla_cycle_collect,2241 08:31:49 INFO - PROCESS | 9406 | __end_cc_report 08:31:49 INFO - PROCESS | 9406 | __startTimestamp1478014309086__endTimestamp 08:31:49 INFO - PROCESS | 9406 | 08:31:49 INFO - PROCESS | 9406 | ------- Summary: start ------- 08:31:49 INFO - PROCESS | 9406 | Number of tests: 6 08:31:49 INFO - PROCESS | 9406 | 08:31:49 INFO - PROCESS | 9406 | [#0] dojo.html Cycles:165 Average:4669.56 Median:4786.69 stddev:483.58 (10.1%) stddev-sans-first:456.74 08:31:49 INFO - PROCESS | 9406 | Values: 2590.9 2594.1 2633.2 2641.9 2642.9 4658.1 4731.0 4734.7 4748.0 4750.0 4739.3 4744.5 4757.8 4766.1 4770.0 4357.6 4383.2 4399.3 4424.2 4447.8 4422.6 4423.4 4455.0 4456.2 4460.2 4341.9 4366.6 4375.6 4413.3 4459.4 4409.1 4436.5 4444.7 4481.2 4484.4 4254.0 4290.0 4301.3 4309.7 4327.1 4681.6 4693.2 4696.3 4698.4 4776.6 4993.9 5036.2 5038.4 5047.4 5085.1 4898.7 4977.3 4979.6 5063.4 5111.0 4674.8 4688.8 4694.3 4703.7 4768.7 5156.7 5158.9 5159.8 5184.9 5224.7 4841.2 4937.8 4948.2 4961.7 5015.3 4957.9 5013.7 5015.7 5059.6 5063.3 5014.8 5017.6 5022.8 5070.2 5085.9 4948.9 4961.0 4962.7 5007.9 5027.3 4159.5 4245.9 4247.3 4273.2 4282.9 3751.7 3770.5 3778.0 3796.0 3801.2 4300.0 4313.4 4321.6 4327.4 4332.2 5055.9 5069.2 5070.6 5072.4 5073.4 4317.6 4323.7 4324.2 4324.7 4329.3 4517.4 4530.3 4554.1 4558.3 4559.7 4741.2 4784.1 4786.7 4790.9 4801.7 5073.5 5078.6 5083.8 5084.5 5127.8 4671.2 4721.2 4724.4 4777.6 4779.4 4936.2 4961.0 4974.0 4977.6 5044.8 5048.8 5055.1 5056.4 5057.2 5121.1 4797.9 4844.5 4906.7 4914.5 4920.1 4902.0 4903.0 4904.8 4907.5 4913.5 4828.7 4833.7 4834.3 4835.6 4837.9 4925.8 4938.4 4966.1 4978.4 5034.7 4832.2 4838.0 4870.0 4887.7 4927.8 08:31:49 INFO - PROCESS | 9406 | 08:31:49 INFO - PROCESS | 9406 | [#1] ext.html Cycles:180 Average:46932.94 Median:36532.20 stddev:84046.74 (230.1%) stddev-sans-first:84210.41 08:31:49 INFO - PROCESS | 9406 | Values: 566.3 578.8 585.2 588.3 599.5 29952.6 38728.8 39923.2 39933.0 43827.8 40120.4 40735.6 40775.8 40864.6 41093.4 7699.2 7858.0 7860.6 7860.6 7863.1 7682.8 7764.6 7768.5 7776.2 7778.3 7692.4 7712.7 7721.9 7741.0 7767.9 7805.5 7846.0 7849.0 7878.2 7889.4 7633.1 7691.2 7702.2 7704.0 7705.3 38463.8 38712.2 38753.8 38813.6 38869.8 2992.0 3247.1 3382.9 3459.5 3535.0 28237.4 28907.6 28957.0 29094.3 29260.3 3321.7 3364.3 3441.2 3514.6 3540.0 244849.0 245766.0 246503.0 247180.0 247380.0 51217.5 51579.7 51617.2 56147.7 58041.0 54334.5 59105.7 59328.7 59349.0 59399.7 14935.7 15004.3 15075.2 15082.4 15191.0 10848.9 10948.6 10957.6 10966.5 10969.3 18154.0 18734.8 18780.9 18783.0 18813.2 7223.6 7330.1 7438.6 7512.4 7582.9 782.6 843.0 890.4 918.3 947.0 25678.5 26305.6 26756.3 26880.9 26972.0 739.4 919.6 964.9 991.5 1035.5 13359.5 13700.2 14120.5 14132.3 14176.6 394330.0 396400.0 396500.0 396807.0 397532.0 48982.8 49527.5 49582.3 49588.0 49615.0 1063.7 1099.3 1144.7 1159.8 1177.1 25635.5 28240.3 28670.0 28690.0 29207.3 42019.2 42614.6 42630.0 42654.6 42694.8 295344.0 296178.0 296449.0 297026.0 297239.0 24520.6 24938.6 25342.5 26100.3 37485.3 40110.0 40213.2 40246.4 40881.0 41218.8 34873.3 34970.8 34987.3 35257.0 35579.2 34504.8 34965.7 35037.3 35046.5 35319.0 34507.5 34519.1 35172.5 35261.3 35556.6 30390.8 31388.2 31824.4 31961.2 32523.5 24272.6 24995.9 25099.0 25276.2 25541.9 08:31:49 INFO - PROCESS | 9406 | 08:31:49 INFO - PROCESS | 9406 | [#2] jquery.html Cycles:180 Average:24816.66 Median:217676.61 stddev:72022.92 (33.1%) stddev-sans-first:72201.52 08:31:49 INFO - PROCESS | 9406 | Values: 341.9 364.3 368.3 369.3 385.9 12469.4 13031.7 16637.8 16932.4 17972.7 15728.9 15893.1 16010.2 17536.5 17918.8 3960.4 5012.4 5164.7 5249.6 5254.4 5065.1 5209.2 5215.6 5215.6 5217.4 4979.1 5174.1 5177.4 5182.7 5189.4 5169.5 5186.6 5191.5 5208.4 5223.6 4666.9 4673.3 4674.0 4686.7 4933.9 12387.8 12399.3 12635.2 12641.6 12651.2 1770.5 1853.0 1900.9 1925.7 1964.5 8968.1 9012.1 9250.2 9474.5 12967.2 1661.8 1686.9 1689.5 1690.8 1712.8 64877.0 65701.7 67829.3 67887.0 68322.7 9957.5 10027.5 10066.4 10265.0 10291.9 13819.7 13853.0 13875.1 13880.7 13890.5 7208.7 7340.0 7451.7 7606.9 7620.5 7096.6 7146.5 7305.3 7308.5 7311.6 4221.9 4306.3 4380.5 4424.6 4439.2 1792.4 1815.5 1844.6 1852.9 1889.9 386.2 390.7 416.8 848.3 877.2 10564.3 10655.1 10709.1 10720.6 11109.6 402.7 410.7 416.6 423.6 446.4 5554.5 5659.4 5777.2 5801.7 6004.4 431436.0 434918.0 435845.0 440124.0 442867.0 74596.6 78148.6 78397.0 81266.2 81411.0 422.3 433.3 434.9 435.2 436.6 9446.5 9914.2 10015.8 10043.5 10115.4 34282.0 35231.0 35417.0 36096.8 40211.2 46711.8 51629.7 51717.0 51781.7 53318.0 7258.1 7295.1 7314.7 7318.8 7753.9 9829.4 11054.6 11623.6 11778.0 12333.2 9794.4 9879.2 10050.7 10153.4 10579.6 9758.7 9937.0 10068.4 10170.9 10730.1 9863.2 10151.0 10336.7 10433.7 10648.3 7450.0 7631.8 7704.3 8016.8 8058.4 9633.0 10073.6 10135.0 10242.7 10263.8 08:31:49 INFO - PROCESS | 9406 | 08:31:49 INFO - PROCESS | 9406 | [#3] mootools.html Cycles:180 Average:4551.22 Median:5573.15 stddev:2440.95 (43.8%) stddev-sans-first:2434.89 08:31:49 INFO - PROCESS | 9406 | Values: 1210.3 1315.8 1377.7 1421.0 1668.7 6035.2 6680.1 6907.3 6920.8 7114.8 6936.2 6984.8 7006.4 7009.3 7013.6 2088.5 2106.1 2109.0 2112.5 2117.3 2070.2 2128.0 2134.9 2142.7 2145.6 2088.9 2097.5 2117.4 2118.0 2130.7 1996.4 2035.0 2036.1 2043.8 2044.9 2020.3 2053.0 2085.5 2086.2 2089.7 6836.2 6909.2 6914.0 6917.5 6920.9 4209.3 4323.0 4379.7 4410.3 4420.0 2624.2 2828.6 2891.4 2897.5 2898.3 946.0 958.4 970.8 981.6 983.1 9068.0 9152.9 9164.6 9169.3 9179.4 3586.4 3632.3 3665.8 3680.6 3681.7 7145.1 7147.9 7152.7 7153.2 7159.6 4076.7 4113.7 4114.2 4114.9 4122.8 3535.6 3579.2 3806.0 3810.5 4025.3 3120.9 3158.6 3246.7 3249.7 3260.0 970.1 980.4 987.1 987.3 999.4 762.0 766.3 834.7 835.4 845.7 4501.9 4650.9 4716.1 4716.7 4939.6 394.8 396.9 406.2 422.1 427.2 3276.3 3363.2 3391.7 3410.8 3440.4 7957.6 8353.1 8360.7 8426.7 8436.7 8170.3 8316.1 8323.1 8329.7 8367.2 6508.7 6553.2 6659.5 6667.3 6670.4 4841.0 4843.4 4847.8 4849.2 4887.2 7615.3 7666.7 7697.4 7732.4 7738.6 7667.2 7856.4 7874.3 7892.8 7917.7 5470.8 5675.5 5859.7 5905.6 6035.6 6067.9 6374.6 6618.6 6624.2 6801.9 5739.9 5820.9 5863.2 5874.1 5965.3 5773.2 5819.2 5888.9 5916.1 6019.4 5823.8 5825.4 5864.0 5881.0 5893.2 4053.5 4062.0 4161.3 4180.5 4315.4 4197.5 4230.3 4288.4 4322.6 4460.8 08:31:49 INFO - PROCESS | 9406 | 08:31:49 INFO - PROCESS | 9406 | [#4] prototype.html Cycles:180 Average:4139.43 Median:4738.42 stddev:1207.58 (25.5%) stddev-sans-first:1176.06 08:31:49 INFO - PROCESS | 9406 | Values: 298.9 300.6 302.6 306.9 308.4 4666.3 4745.8 4748.4 4797.9 4804.1 4618.5 4682.7 4687.7 4736.9 4740.0 3566.7 3659.1 3673.2 3738.0 3762.6 3756.8 3766.6 3770.7 3776.8 3781.5 3721.3 3736.8 3744.7 3749.4 3762.6 3524.5 3620.4 3669.6 3732.4 3743.9 3316.9 3320.3 3338.2 3347.7 3349.1 4622.5 4629.6 4629.7 4642.4 4645.0 4184.9 4250.3 4285.5 4287.3 4287.5 4898.5 4924.0 4948.3 4956.5 4960.6 3573.8 3575.4 3580.5 3590.2 3595.1 5171.2 5183.3 5192.9 5195.1 5195.4 3424.2 3593.8 3595.5 3601.2 3611.9 3640.5 3642.9 3651.1 3654.6 3674.4 4197.7 4198.7 4206.6 4215.3 4221.5 4743.9 4921.9 4997.2 5007.8 5020.3 1248.1 1265.3 1268.4 1270.8 1272.3 774.5 791.8 797.7 805.4 820.2 4187.3 4197.7 4318.2 4403.6 4418.2 5090.3 5092.9 5103.9 5104.7 5115.5 4382.0 4383.0 4394.5 4406.8 4425.8 2594.3 2681.1 2692.0 2706.0 2706.7 4825.7 4830.0 4830.3 4830.3 4840.8 5177.7 5208.9 5210.9 5235.3 5240.8 4596.5 4842.3 4867.1 4876.1 4903.5 5139.6 5147.3 5160.3 5164.8 5172.2 4872.4 5046.6 5047.4 5047.6 5062.1 4829.3 4854.3 4857.2 4871.9 4895.8 3621.5 3628.3 3628.3 3635.7 3648.5 5114.7 5157.2 5158.3 5166.7 5187.3 4803.8 4954.9 5030.9 5031.9 5041.3 5010.7 5036.7 5038.5 5046.8 5059.2 4980.8 4986.1 4989.9 4992.6 5007.4 4826.3 4839.6 4951.1 5061.7 5095.7 4814.2 4935.3 4965.8 4971.3 4971.8 08:31:49 INFO - PROCESS | 9406 | 08:31:49 INFO - PROCESS | 9406 | [#5] yui.html Cycles:180 Average:14593.93 Median:24392.36 stddev:17987.84 (73.7%) stddev-sans-first:18008.00 08:31:49 INFO - PROCESS | 9406 | Values: 691.3 693.9 712.8 725.5 747.3 12145.0 13103.7 13125.0 13167.1 13183.3 12410.9 12588.8 12627.6 12694.8 12696.7 618.8 636.5 775.0 781.6 804.7 794.7 803.4 804.5 804.7 805.2 843.1 843.2 843.6 849.1 850.0 636.2 653.2 805.9 843.2 844.3 606.6 608.3 609.5 611.3 612.7 12727.9 12786.8 12788.9 12813.1 12822.9 11950.5 12044.4 12317.1 12379.1 12710.1 11225.9 11277.9 11400.8 11418.5 11584.2 4033.3 4037.9 4062.0 4085.6 4117.4 52651.0 57551.7 57787.4 58044.0 58148.0 9708.5 9863.9 9923.9 10037.7 10322.9 18068.0 18343.5 18353.8 18395.8 18494.9 6395.6 6464.7 6543.2 6558.2 6692.8 3497.1 3497.6 3509.0 3544.5 3576.7 2669.4 2758.8 2768.0 2770.9 2784.4 475.9 482.1 482.6 485.7 511.9 601.6 614.7 644.4 647.7 663.4 7862.0 7935.9 8122.7 8200.3 8320.6 568.5 581.2 633.7 652.3 660.8 3613.7 3794.7 4064.8 4073.2 4094.2 62129.7 64268.0 64900.0 67066.7 67355.3 49656.8 52051.5 55214.2 58029.7 58551.0 52536.2 52866.2 53054.5 53144.0 53200.7 8387.9 8944.6 8945.0 9017.4 9082.1 27020.9 33208.0 34865.0 35459.8 39454.4 48299.0 49375.5 49405.8 49713.3 51511.2 10471.6 10620.5 10702.5 10795.9 11001.8 11381.5 11417.5 12362.4 12630.6 12801.6 11045.8 11317.2 11810.8 11953.5 11954.9 11708.7 11745.0 11933.6 12019.8 12427.4 11072.9 11177.0 11335.9 11488.4 11937.4 9327.4 9790.7 9874.7 9892.3 10102.2 9687.9 10140.4 10267.6 10401.6 10491.6 08:31:49 INFO - PROCESS | 9406 | -------- Summary: end -------- 08:31:49 INFO - PROCESS | 9406 | 08:31:50 INFO - TEST-INFO | 9406: exit 0 08:31:50 INFO - TEST-OK | dromaeo_css | took 1123685ms 08:31:50 INFO - TEST-START | kraken 08:31:50 INFO - operating with platform_type : linux_ 08:31:50 INFO - Initialising browser for kraken test... 08:31:50 INFO - TEST-INFO | started process 9715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo7Toi1/profile http://localhost:59687/getInfo.html) 08:31:54 INFO - PROCESS | 9715 | __metrics Screen width/height:1600/1200 08:31:54 INFO - PROCESS | 9715 | colorDepth:24 08:31:54 INFO - PROCESS | 9715 | Browser inner width/height: 1024/697 08:31:54 INFO - PROCESS | 9715 | __metrics 08:31:54 INFO - PROCESS | 9715 | 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" 08:31:54 INFO - PROCESS | 9715 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:31:55 INFO - PROCESS | 9715 | console.error: PushService: 08:31:55 INFO - PROCESS | 9715 | stateChangeProcessEnqueue: Error transitioning state 08:31:55 INFO - PROCESS | 9715 | UnknownError 08:31:56 INFO - TEST-INFO | 9715: exit 0 08:31:56 INFO - Browser initialized. 08:31:56 INFO - Running cycle 1/1 for kraken test... 08:31:56 INFO - TEST-INFO | started process 9795 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpo7Toi1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:32:08 INFO - PROCESS | 9795 | RSS: Main: 173924352 08:32:08 INFO - PROCESS | 9795 | 08:32:11 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59687/tests/kraken/driver.html?testName=audio-beat-detection) 08:32:12 INFO - PROCESS | 9795 | RSS: Main: 239190016 08:32:12 INFO - PROCESS | 9795 | 08:32:15 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59687/tests/kraken/driver.html?testName=audio-dft) 08:32:15 INFO - PROCESS | 9795 | RSS: Main: 217513984 08:32:15 INFO - PROCESS | 9795 | 08:32:18 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59687/tests/kraken/driver.html?testName=audio-fft) 08:32:19 INFO - PROCESS | 9795 | RSS: Main: 298754048 08:32:19 INFO - PROCESS | 9795 | 08:32:21 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59687/tests/kraken/driver.html?testName=audio-oscillator) 08:32:22 INFO - PROCESS | 9795 | RSS: Main: 209657856 08:32:22 INFO - PROCESS | 9795 | 08:32:24 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59687/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:32:25 INFO - PROCESS | 9795 | RSS: Main: 213057536 08:32:25 INFO - PROCESS | 9795 | 08:32:28 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59687/tests/kraken/driver.html?testName=imaging-darkroom) 08:32:28 INFO - PROCESS | 9795 | RSS: Main: 248897536 08:32:28 INFO - PROCESS | 9795 | 08:32:32 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59687/tests/kraken/driver.html?testName=imaging-desaturate) 08:32:33 INFO - PROCESS | 9795 | RSS: Main: 247971840 08:32:33 INFO - PROCESS | 9795 | 08:32:35 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59687/tests/kraken/driver.html?testName=json-parse-financial) 08:32:36 INFO - PROCESS | 9795 | RSS: Main: 247672832 08:32:36 INFO - PROCESS | 9795 | 08:32:38 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59687/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:32:38 INFO - PROCESS | 9795 | RSS: Main: 209854464 08:32:38 INFO - PROCESS | 9795 | 08:32:40 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59687/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:32:41 INFO - PROCESS | 9795 | RSS: Main: 217698304 08:32:41 INFO - PROCESS | 9795 | 08:32:43 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59687/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:32:43 INFO - PROCESS | 9795 | RSS: Main: 226353152 08:32:43 INFO - PROCESS | 9795 | 08:32:46 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:32:47 INFO - PROCESS | 9795 | RSS: Main: 235094016 08:32:47 INFO - PROCESS | 9795 | 08:32:50 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:32:51 INFO - PROCESS | 9795 | RSS: Main: 232251392 08:32:51 INFO - PROCESS | 9795 | 08:32:52 INFO - PROCESS | 9795 | Cycle 1(1): loaded http://localhost:59687/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59687/tests/kraken/driver.html?testName=ai-astar) 08:32:53 INFO - PROCESS | 9795 | RSS: Main: 283488256 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | __start_tp_report 08:32:53 INFO - PROCESS | 9795 | _x_x_mozilla_page_load 08:32:53 INFO - PROCESS | 9795 | _x_x_mozilla_page_load_details 08:32:53 INFO - PROCESS | 9795 | |i|pagename|runs| 08:32:53 INFO - PROCESS | 9795 | |0;ai-astar;107;114;114;113;114;115;114;116;113;114 08:32:53 INFO - PROCESS | 9795 | |1;audio-beat-detection;153;131;131;172;130;130;129;129;163;134 08:32:53 INFO - PROCESS | 9795 | |2;audio-dft;162;160;161;161;160;160;161;162;162;163 08:32:53 INFO - PROCESS | 9795 | |3;audio-fft;76;75;75;105;76;77;80;76;115;74 08:32:53 INFO - PROCESS | 9795 | |4;audio-oscillator;84;83;133;84;85;84;103;84;82;111 08:32:53 INFO - PROCESS | 9795 | |5;imaging-gaussian-blur;118;118;118;118;118;118;118;117;118;117 08:32:53 INFO - PROCESS | 9795 | |6;imaging-darkroom;146;147;147;147;146;147;147;152;146;147 08:32:53 INFO - PROCESS | 9795 | |7;imaging-desaturate;85;86;86;86;85;86;85;85;86;85 08:32:53 INFO - PROCESS | 9795 | |8;json-parse-financial;65;65;64;63;64;65;67;63;66;65 08:32:53 INFO - PROCESS | 9795 | |9;json-stringify-tinderbox;66;66;66;67;66;66;65;65;65;67 08:32:53 INFO - PROCESS | 9795 | |10;stanford-crypto-aes;84;84;93;84;85;84;85;83;89;84 08:32:53 INFO - PROCESS | 9795 | |11;stanford-crypto-ccm;142;155;145;159;141;143;138;142;193;147 08:32:53 INFO - PROCESS | 9795 | |12;stanford-crypto-pbkdf2;186;177;175;176;177;178;177;180;176;178 08:32:53 INFO - PROCESS | 9795 | |13;stanford-crypto-sha256-iterative;72;69;69;70;70;69;68;70;69;69 08:32:53 INFO - PROCESS | 9795 | __end_tp_report 08:32:53 INFO - PROCESS | 9795 | __start_cc_report 08:32:53 INFO - PROCESS | 9795 | _x_x_mozilla_cycle_collect,1935 08:32:53 INFO - PROCESS | 9795 | __end_cc_report 08:32:53 INFO - PROCESS | 9795 | __startTimestamp1478014373195__endTimestamp 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | ------- Summary: start ------- 08:32:53 INFO - PROCESS | 9795 | Number of tests: 14 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.00 stddev:2.41 (2.1%) stddev-sans-first:0.93 08:32:53 INFO - PROCESS | 9795 | Values: 107.0 114.0 114.0 113.0 114.0 115.0 114.0 116.0 113.0 114.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:132.50 stddev:16.20 (12.2%) stddev-sans-first:16.51 08:32:53 INFO - PROCESS | 9795 | Values: 153.0 131.0 131.0 172.0 130.0 130.0 129.0 129.0 163.0 134.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 08:32:53 INFO - PROCESS | 9795 | Values: 162.0 160.0 161.0 161.0 160.0 160.0 161.0 162.0 162.0 163.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.00 stddev:14.56 (19.2%) stddev-sans-first:15.23 08:32:53 INFO - PROCESS | 9795 | Values: 76.0 75.0 75.0 105.0 76.0 77.0 80.0 76.0 115.0 74.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#4] audio-oscillator Cycles:10 Average:93.30 Median:84.00 stddev:17.10 (20.4%) stddev-sans-first:17.80 08:32:53 INFO - PROCESS | 9795 | Values: 84.0 83.0 133.0 84.0 85.0 84.0 103.0 84.0 82.0 111.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:32:53 INFO - PROCESS | 9795 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 117.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:1.75 (1.2%) stddev-sans-first:1.80 08:32:53 INFO - PROCESS | 9795 | Values: 146.0 147.0 147.0 147.0 146.0 147.0 147.0 152.0 146.0 147.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:86.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 08:32:53 INFO - PROCESS | 9795 | Values: 85.0 86.0 86.0 86.0 85.0 86.0 85.0 85.0 86.0 85.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 08:32:53 INFO - PROCESS | 9795 | Values: 65.0 65.0 64.0 63.0 64.0 65.0 67.0 63.0 66.0 65.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 08:32:53 INFO - PROCESS | 9795 | Values: 66.0 66.0 66.0 67.0 66.0 66.0 65.0 65.0 65.0 67.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:84.50 stddev:3.10 (3.7%) stddev-sans-first:3.24 08:32:53 INFO - PROCESS | 9795 | Values: 84.0 84.0 93.0 84.0 85.0 84.0 85.0 83.0 89.0 84.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#11] stanford-crypto-ccm Cycles:10 Average:150.50 Median:146.00 stddev:16.29 (11.2%) stddev-sans-first:16.99 08:32:53 INFO - PROCESS | 9795 | Values: 142.0 155.0 145.0 159.0 141.0 143.0 138.0 142.0 193.0 147.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.00 Median:177.50 stddev:3.13 (1.8%) stddev-sans-first:1.45 08:32:53 INFO - PROCESS | 9795 | Values: 186.0 177.0 175.0 176.0 177.0 178.0 177.0 180.0 176.0 178.0 08:32:53 INFO - PROCESS | 9795 | 08:32:53 INFO - PROCESS | 9795 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.50 stddev:1.08 (1.6%) stddev-sans-first:0.67 08:32:53 INFO - PROCESS | 9795 | Values: 72.0 69.0 69.0 70.0 70.0 69.0 68.0 70.0 69.0 69.0 08:32:53 INFO - PROCESS | 9795 | -------- Summary: end -------- 08:32:53 INFO - PROCESS | 9795 | 08:32:54 INFO - TEST-INFO | 9795: exit 0 08:32:54 INFO - TEST-OK | kraken | took 64437ms 08:32:54 INFO - SUITE-END | took 1188s 08:32:54 INFO - Completed test suite (00:19:48) 08:32:54 INFO - javascript benchmark 08:32:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.857502837344, 2594.07910191882, 2633.236361455178, 2641.907533236336, 2642.894284228631, 4658.138244424784, 4730.976345118278, 4734.692245004072, 4748.0, 4750.049990001996, 4739.289106634006, 4744.501827308135, 4757.833475828346, 4766.070616229837, 4770.022145460181, 4357.607815296623, 4383.189110014641, 4399.27411977025, 4424.225760491917, 4447.84432544861, 4422.6240769534625, 4423.447069116361, 4454.955450445503, 4456.153330867141, 4460.197164510387, 4341.934870976938, 4366.585174408442, 4375.562443755631, 4413.3159360299205, 4459.353393757903, 4409.052053808415, 4436.534163912807, 4444.733316001018, 4481.193385190681, 4484.372187893698, 4254.0, 4289.957100428987, 4301.2902871026245, 4309.698321117523, 4327.1345730853955, 4681.648876334254, 4693.155232058228, 4696.342512048316, 4698.412698412699, 4776.641751868624, 4993.875153121201, 5036.194208926554, 5038.39539255288, 5047.419546752097, 5085.084684756743, 4898.730569818658, 4977.278294647256, 4979.6265280104135, 5063.366691204255, 5110.97444512775, 4674.789634466457, 4688.765561721901, 4694.342792009122, 4703.717776933395, 4768.737719425396, 5156.690598564098, 5158.948410515847, 5159.845204643867, 5184.8963020739375, 5224.7126408047925, 4841.15279826029, 4937.8271760488215, 4948.233023881304, 4961.70229786214, 5015.3229314042865, 4957.876053098629, 5013.724245166551, 5015.699058056528, 5059.62052846038, 5063.316452278895, 5014.774335154927, 5017.623678224148, 5022.824201153016, 5070.239464080418, 5085.949140508622, 4948.925766113512, 4960.950390496121, 4962.727050012284, 5007.874803129951, 5027.296178535008, 4159.480064991876, 4245.915081698348, 4247.277962746341, 4273.230818452646, 4282.8715138545895, 3751.7186211033736, 3770.5286839145106, 3778.0366006668673, 3795.962040379616, 3801.201747632973, 4300.032492689183, 4313.41768861206, 4321.5678432157165, 4327.350897365421, 4332.220200363965, 5055.87360315995, 5069.188929771219, 5070.569001634829, 5072.365954255718, 5073.441921388644, 4317.6114149726045, 4323.675724320626, 4324.200022995756, 4324.654027677778, 4329.285667864767, 4517.3901523293935, 4530.275155975029, 4554.134714404253, 4558.33904083906, 4559.658025648089, 4741.217699079613, 4784.138855006132, 4786.688865223749, 4790.928136077892, 4801.711897286034, 5073.543381095719, 5078.568321692697, 5083.796648134034, 5084.51697088776, 5127.820526281562, 4671.15919134559, 4721.220998535203, 4724.433068031721, 4777.617790576676, 4779.402574678165, 4936.185529387611, 4961.0, 4973.975130124326, 4977.60179185657, 5044.772985215747, 5048.823291184791, 5055.1406260936465, 5056.418511871182, 5057.216131499624, 5121.103806833715, 4797.928031079467, 4844.539768721966, 4906.656534042583, 4914.533119353656, 4920.1389756791705, 4902.0, 4902.950970490392, 4904.754762261801, 4907.460179380194, 4913.48408417111, 4828.66199366041, 4833.685810422311, 4834.274858771212, 4835.564799168092, 4837.854864353934, 4925.778339974638, 4938.43208031081, 4966.130927087817, 4978.4274808397495, 5034.672746271481, 4832.154372984784, 4838.0, 4869.952960113593, 4887.682300650446, 4927.827526036572], "value": 4638.63243660131, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [566.2751677852349, 578.8379253808934, 585.2041223935447, 588.3293045927643, 599.4574909706716, 29952.550711739314, 38728.80635596821, 39923.20153596933, 39933.0, 43827.78086109573, 40120.39819402711, 40735.59264407362, 40775.796121019426, 40864.59135408645, 41093.38359924604, 7699.153093159748, 7857.960710196469, 7860.606969651523, 7860.646270917794, 7863.056433228021, 7682.807929801744, 7764.572948487831, 7768.495047821873, 7776.183500732426, 7778.299953004229, 7692.384609231248, 7712.652930618107, 7721.884171737428, 7740.961295193516, 7767.922320776805, 7805.492642978245, 7845.960770196112, 7848.960755196216, 7878.172791856887, 7889.408294377916, 7633.122190948056, 7691.230876912264, 7702.229777022309, 7703.961480192619, 7705.345045671124, 38463.807680961414, 38712.22575548473, 38753.80623096895, 38813.611863881284, 38869.805650971844, 2991.9551206731917, 3247.058353077605, 3382.8815991440183, 3459.4810778383444, 3535.0, 28237.435251295065, 28907.56638650422, 28957.0, 29094.27264318388, 29260.268493287625, 3321.7342612590933, 3364.310316385135, 3441.15691655546, 3514.5606799150105, 3539.9734077117605, 244849.0, 245766.0, 246503.0, 247180.0, 247380.0, 51217.48782512127, 51579.74210128925, 51617.225741613904, 56147.71926140343, 58041.0, 54334.47986241676, 59105.704471478224, 59328.70335648294, 59349.0, 59399.70300148472, 14935.701285974219, 15004.324805383783, 15075.170865602497, 15082.396704131932, 15191.0, 10848.915108489087, 10948.616798412017, 10957.616483423042, 10966.451677416097, 10969.341839489656, 18154.0, 18734.812651873308, 18780.906095469436, 18783.0, 18813.15340809667, 7223.573236925862, 7330.115039029323, 7438.628068596657, 7512.361449276873, 7582.867337301074, 782.6282515805061, 842.9578521073922, 890.4479222881855, 918.2837386838144, 947.0387556630026, 25678.48643027129, 26305.605415918395, 26756.331091722863, 26880.90869549988, 26972.0, 739.4010851210537, 919.5723988345452, 964.9131578158, 991.4893829677721, 1035.5288343803702, 13359.53241636538, 13700.246486443142, 14120.50578229757, 14132.293385330693, 14176.645583860485, 394330.0, 396400.0, 396500.0, 396807.0, 397532.0, 48982.755086224344, 49527.50472495229, 49582.25626615604, 49588.0, 49615.046194456176, 1063.6543123484898, 1099.3349023840462, 1144.6508814811561, 1159.750653609478, 1177.1230433327225, 25635.487290253717, 28240.341646602385, 28670.0, 28690.0, 29207.269818254714, 42019.1596168081, 42614.5738542623, 42630.0, 42654.573454266305, 42694.78652606717, 295344.0, 296178.0, 296449.0, 297026.0, 297239.0, 24520.6321905168, 24938.628375439526, 25342.493150137263, 26100.34749131287, 37485.25029499449, 40110.0, 40213.1957360857, 40246.39630405605, 40881.0, 41218.79390603028, 34873.30253394969, 34970.776022839076, 34987.30025399529, 35257.0, 35579.15366770601, 34504.82747586246, 34965.650343496236, 35037.299254015285, 35046.47430288497, 35319.0, 34507.48238776471, 34519.121075343886, 35172.472412914336, 35261.294774104885, 35556.64443355533, 30390.84804575963, 31388.215294617818, 31824.36351273008, 31961.200969975936, 32523.51214731828, 24272.635910461006, 24995.87502062478, 25099.0, 25276.241712748648, 25541.87229063843], "value": 17467.732038677415, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.882050692511, 364.32417864860685, 368.3241252302026, 369.2596344329619, 385.8630186283869, 12469.376531173439, 13031.67420814479, 16637.750433743502, 16932.4073657422, 17972.73040904384, 15728.921355393208, 15893.125878076702, 16010.19949002551, 17536.473905782816, 17918.820811791877, 3960.3663413853787, 5012.423571289303, 5164.741762911839, 5249.580033597322, 5254.369475662907, 5065.138926382524, 5209.244659524366, 5215.608829337796, 5215.6349055566125, 5217.373915130171, 4979.128652485819, 5174.068667639824, 5177.430482646906, 5182.689038657673, 5189.42916279209, 5169.534741873212, 5186.636935414523, 5191.506806853343, 5208.401033881077, 5223.608229382811, 4666.883327916829, 4673.252279635276, 4674.041821426599, 4686.742229177394, 4933.925991110136, 12387.814182787266, 12399.25604463726, 12635.178713383693, 12641.557545485955, 12651.240925544405, 1770.5219590710565, 1853.0456814740285, 1900.8954507502083, 1925.7303977443169, 1964.479412955568, 8968.10318968098, 9012.143846334588, 9250.21574192773, 9474.526273686357, 12967.157134786303, 1661.750737389389, 1686.8924169646828, 1689.5239605216161, 1690.8429290663428, 1712.760213570101, 64877.0268445969, 65701.67149164272, 67829.3217067828, 67886.9999999995, 68322.65838670774, 9957.502124893726, 10027.548760305805, 10066.396016239049, 10265.0, 10291.948540257401, 13819.654508637163, 13853.0, 13875.098118622258, 13880.652983675489, 13890.513832015831, 7208.711651533985, 7340.0, 7451.701931922662, 7606.885896711554, 7620.542767433861, 7096.574205547684, 7146.464015198881, 7305.3425191732995, 7308.524945878501, 7311.561306321638, 4221.873343799691, 4306.332518459643, 4380.452443444569, 4424.646028317727, 4439.200943830077, 1792.4085051932832, 1815.546113471632, 1844.557306246518, 1852.8702990790784, 1889.9433017009512, 386.2063459590568, 390.65231943570245, 416.8416001919251, 848.2737628925108, 877.2411863737948, 10564.313319634199, 10655.147588192925, 10709.143268538499, 10720.624778132884, 11109.55561777536, 402.6698107551838, 410.71455338539425, 416.5917400947089, 423.55103590194494, 446.3906767262663, 5554.527865131428, 5659.434056594308, 5777.24895763548, 5801.651900885876, 6004.369541198112, 431436.0, 434918.0, 435845.0, 440124.0, 442867.0, 74596.62701686457, 78148.60925695449, 78397.0, 81266.18733812704, 81411.0, 422.2947677378785, 433.3240145373228, 434.8695391382636, 435.2187822857978, 436.607053651716, 9446.480443575669, 9914.20686345105, 10015.798104227248, 10043.548040338057, 10115.443650599287, 34282.0, 35231.0, 35417.0, 36096.819515903306, 40211.195776084896, 46711.76644116758, 51629.741851290506, 51717.0, 51781.7410912943, 53318.0, 7258.129024517092, 7295.124585049828, 7314.7074117036855, 7318.780436586911, 7753.883691744515, 9829.4102353859, 11054.557817687202, 11623.59317423886, 11778.0, 12333.198342107735, 9794.412335259907, 9879.160271377013, 10050.69847904564, 10153.369635809502, 10579.62971296001, 9758.707238782848, 9936.950315248378, 10068.44623545712, 10170.89829101729, 10730.141588673043, 9863.21094312439, 10151.0, 10336.689899303034, 10433.686989390331, 10648.307859989076, 7449.962750186214, 7631.847363052819, 7704.26809453101, 8016.799580010313, 8058.3553315733425, 9633.0, 10073.647422340184, 10135.0, 10242.743931401774, 10263.846042309222], "value": 7330.579695328631, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1210.2556927489586, 1315.7960516120002, 1377.6900197455573, 1420.9644758881034, 1668.7413450915112, 6035.21542199514, 6680.064790929274, 6907.274736152701, 6920.792376228708, 7114.750983715571, 6936.202336731278, 6984.8253793655185, 7006.369426751591, 7009.299070092989, 7013.614251216181, 2088.540521085363, 2106.09437941685, 2108.9578208435823, 2112.524681946565, 2117.269542008005, 2070.2133189388087, 2127.957440851182, 2134.9146034158616, 2142.689310050042, 2145.6245157097446, 2088.8642238254542, 2097.454661787931, 2117.3647905628327, 2118.046878904491, 2130.7230060092165, 1996.3711430899293, 2035.0435295411132, 2036.134642776814, 2043.7854025327276, 2044.91820327186, 2020.3130935482006, 2053.0453339197197, 2085.48905518149, 2086.1655337864822, 2089.7387826521685, 6836.213835408942, 6909.205441374256, 6914.0, 6917.481188910801, 6920.930790692079, 4209.3054645983375, 4323.0, 4379.7372157670325, 4410.294352903552, 4420.027593929331, 2624.238970698495, 2828.5757136429493, 2891.4361699468614, 2897.463969165711, 2898.289918969866, 945.9716208513755, 958.4249450329816, 970.7864269860619, 981.6367943860746, 983.0513554419947, 9068.047854975199, 9152.90847091534, 9164.587593558306, 9169.266458683289, 9179.449233046038, 3586.4082426399873, 3632.328019316382, 3665.780053196763, 3680.5767336756617, 3681.6686498214754, 7145.1068616422945, 7147.9285207148305, 7152.749653762094, 7153.213146553875, 7159.57042577447, 4076.7146299759324, 4113.71204015722, 4114.238865809834, 4114.876553703393, 4122.793860307032, 3535.5757309122555, 3579.2125732338845, 3805.9809700951873, 3810.4855844460644, 4025.255327764373, 3120.89076882308, 3158.57359256502, 3246.6753324667343, 3249.707526322595, 3259.983700081532, 970.0590427285522, 980.3578655980344, 987.0524296675129, 987.3088837813559, 999.4253304350028, 761.9923800762032, 766.2567309709573, 834.6536187482127, 835.4110352201683, 845.7166849105496, 4501.88745281364, 4650.86047418578, 4716.103940251342, 4716.740579268105, 4939.555440010345, 394.8400897636462, 396.8710169195023, 406.2383031815346, 422.05670326819535, 427.22885192227704, 3276.3447310537986, 3363.1760218746563, 3391.660833916638, 3410.795352278871, 3440.4323286657923, 7957.641906114239, 8353.081161072278, 8360.749177524684, 8426.662933482592, 8436.704715334934, 8170.325083357898, 8316.085230624627, 8323.084460709317, 8329.66681332752, 8367.246947774729, 6508.730797494538, 6553.246376666649, 6659.467242620579, 6667.333266673294, 6670.366315200048, 4840.975795121002, 4843.370361852936, 4847.830325938575, 4849.248366503198, 4887.242477416006, 7615.276548727862, 7666.731664391719, 7697.384209263358, 7732.420068494998, 7738.574378409242, 7667.156612772479, 7856.410769192219, 7874.330681892104, 7892.763217103496, 7917.683292668229, 5470.835874923759, 5675.460831221028, 5859.736311866061, 5905.616134951214, 6035.577509574287, 6067.878642427215, 6374.553781235269, 6618.602883826793, 6624.205095388585, 6801.863962720817, 5739.885202295847, 5820.912686309624, 5863.237779088691, 5874.118882167709, 5965.343812180743, 5773.191753154646, 5819.185314056121, 5888.882222355614, 5916.053431450947, 6019.398060194121, 5823.82528524145, 5825.3592104867585, 5864.032434648406, 5881.0, 5893.233879595625, 4053.493313335833, 4061.9593804061583, 4161.313383291844, 4180.47744031996, 4315.374270730789, 4197.4753155855515, 4230.344296634026, 4288.442502474658, 4322.589354011364, 4460.776961151864], "value": 3681.42657341728, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.9491786396312, 300.60320377102227, 302.5612861351041, 306.8895197728817, 308.434023566755, 4666.323383109447, 4745.786439610217, 4748.430188377395, 4797.85740340077, 4804.111239420709, 4618.4688760792515, 4682.705474317585, 4687.71873687579, 4736.881577960553, 4739.952600473995, 3566.7146628269807, 3659.14010207601, 3673.210259794144, 3738.009592326142, 3762.5861155272964, 3756.7745935243975, 3766.6233376662253, 3770.660640542351, 3776.7922764247955, 3781.470594116826, 3721.274351501458, 3736.8131593420358, 3744.7191460640424, 3749.400095984643, 3762.5861155272896, 3524.4713293006125, 3620.4026335654585, 3669.5963444021136, 3732.402815549526, 3743.887683369503, 3316.933661326784, 3320.269540701042, 3338.1821453743746, 3347.748918831073, 3349.112485191426, 4622.451478754621, 4629.629629629621, 4629.736036094545, 4642.373279607277, 4644.954885150814, 4184.895377615553, 4250.298700714378, 4285.485741710983, 4287.314029755255, 4287.464066991626, 4898.485659005789, 4923.950760492385, 4948.282499037656, 4956.479569645207, 4960.627952903546, 3573.8391772370046, 3575.374309495854, 3580.5498772996716, 3590.2460483298537, 3595.1191957970464, 5171.21593050397, 5183.2743415921805, 5192.896876764917, 5195.142801437796, 5195.376115257424, 3424.1610805352348, 3593.7843729376323, 3595.48316178676, 3601.1814033912706, 3611.855525778992, 3640.508531348287, 3642.9453558196647, 3651.068977410743, 3654.6295139322756, 3674.4488326751202, 4197.727147735387, 4198.748075115503, 4206.642435392964, 4215.283401821697, 4221.514525829569, 4743.881402964885, 4921.876953076202, 4997.2254300582745, 5007.8247261346405, 5020.2720605511995, 1248.1325478792153, 1265.2724683307135, 1268.429206856918, 1270.8220849081135, 1272.2620879889641, 774.5430196184166, 791.7822598785265, 797.7168105322643, 805.3838813307824, 820.1962077164293, 4187.304141822506, 4197.706160568731, 4318.157959197989, 4403.625691816167, 4418.160549495586, 5090.338256026767, 5092.9236061459105, 5103.923441148386, 5104.719240441737, 5115.514026167508, 4381.956180438155, 4382.978085109554, 4394.472663280363, 4406.823727050946, 4425.800838962255, 2594.286571192937, 2681.088429933832, 2691.9730802692116, 2705.972940270572, 2706.6616672915884, 4825.734584597811, 4830.0, 4830.2513110467935, 4830.275458681155, 4840.75796210188, 5177.7152256625495, 5208.91643342666, 5210.921836172461, 5235.319408476874, 5240.842774716764, 4596.517365676623, 4842.346283251716, 4867.148249056401, 4876.146674331978, 4903.509649035068, 5139.588832893285, 5147.268230532984, 5160.303359046481, 5164.845054648216, 5172.224166375074, 4872.4153101628035, 5046.59627229828, 5047.4352950585435, 5047.570956468741, 5062.139436295912, 4829.251466022772, 4854.344663470386, 4857.247126695368, 4871.853844384674, 4895.8041678332465, 3621.4567814827988, 3628.2924829657964, 3628.310620982005, 3635.654612811779, 3648.543932008499, 5114.7495102154935, 5157.200633901752, 5158.329417175743, 5166.741662916915, 5187.314122910145, 4803.759812009455, 4954.851354459372, 5030.9245361320345, 5031.874203144951, 5041.319421878, 5010.724410157476, 5036.672616280077, 5038.496150384932, 5046.77289521965, 5059.190529515407, 4980.750962451935, 4986.063796841174, 4989.875253118701, 4992.625553083606, 5007.39911210657, 4826.276058591099, 4839.612830973584, 4951.084049450863, 5061.721605311744, 5095.694258344512, 4814.20565606671, 4935.259711043373, 4965.8013679452415, 4971.279164521052, 4971.776270067928], "value": 3754.0064378046113, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.3190507350259, 693.8993845892347, 712.7754757251467, 725.4994054102672, 747.2826086956521, 12144.96767774739, 13103.73792524149, 13125.0, 13167.078304518676, 13183.340832958362, 12410.937945310283, 12588.811167832468, 12627.55803546876, 12694.80957785634, 12696.682582935431, 618.77724019353, 636.5098873867142, 775.0466925681416, 781.5935713429013, 804.6861723927673, 794.737736546941, 803.3733687723555, 804.5132694719698, 804.7304153108715, 805.2028491793112, 843.1105184030845, 843.1568431568431, 843.6288033265344, 849.1126772522698, 850.0224741547208, 636.2460484326042, 653.1639501438167, 805.899262592176, 843.2326582809644, 844.3034496540348, 606.5996442348073, 608.3186830749545, 609.5062998970848, 611.2725856231115, 612.7334609444906, 12727.936360318232, 12786.808197877039, 12788.936055319664, 12813.10308278421, 12822.871771282355, 11950.46222919962, 12044.397780111047, 12317.076219283499, 12379.133460657758, 12710.110292279544, 11225.887741122566, 11277.887221127765, 11400.771984560346, 11418.486168122372, 11584.192560087553, 4033.334499807528, 4037.9394309085387, 4061.959380406188, 4085.611866872642, 4117.394216255662, 52651.0, 57551.71224143936, 57787.42212577863, 58044.0, 58148.0, 9708.466034368037, 9863.852042219372, 9923.900760992297, 10037.749056273651, 10322.948385258025, 18068.0, 18343.54141146482, 18353.81646183521, 18395.816041839676, 18494.907525462288, 6395.584287021329, 6464.741410343628, 6543.214814222229, 6558.1802274715665, 6692.765753198614, 3497.143199915986, 3497.5977762557122, 3508.964910350915, 3544.503769472276, 3576.7496275260482, 2669.3726974161054, 2758.8344699318104, 2768.045024466556, 2770.8614569271454, 2784.4152727926958, 475.9262314341283, 482.1441940555542, 482.62596487722294, 485.7110019538369, 511.8694732843101, 601.6089541797779, 614.7418084404561, 644.3685188515282, 647.685872351909, 663.3532306001609, 7862.01724784402, 7935.920640793518, 8122.675092996332, 8200.343972482187, 8320.583970801435, 568.5252813900357, 581.1805354450205, 633.7496688807895, 652.324843786688, 660.7720336483906, 3613.6928361089076, 3794.667222371032, 4064.837406503766, 4073.2260870434525, 4094.2220978014084, 62129.68935155295, 64268.0, 64900.0, 67066.66466667636, 67355.3264467349, 49656.75171624119, 52051.47948520466, 55214.17178742322, 58029.70985145132, 58551.0, 52536.21195681991, 52866.207006894925, 53054.469455304956, 53144.0, 53200.73399633054, 8387.874181887399, 8944.642214311354, 8945.016048234818, 9017.368784185044, 9082.091790821129, 27020.864895675397, 33208.003759887244, 34865.0, 35459.82270088633, 39454.408183876694, 48299.0, 49375.50624493709, 49405.75297123491, 49713.25430118479, 51511.2273315893, 10471.581136754749, 10620.52207650642, 10702.464876756287, 10795.892041079489, 11001.779964400826, 11381.487833047368, 11417.543298267976, 12362.3818809061, 12630.557930472389, 12801.61595152147, 11045.779084418427, 11317.20779545457, 11810.763784724086, 11953.521859125538, 11954.880451195724, 11708.70728231801, 11745.0, 11933.641990740292, 12019.827748914933, 12427.44076516541, 11072.944635276772, 11177.0, 11335.943320283346, 11488.368139752394, 11937.4031298433, 9327.440353578808, 9790.657326993522, 9874.654387096418, 9892.258080643836, 10102.242331824995, 9687.854682179632, 10140.442275674908, 10267.58929642806, 10401.635942741968, 10491.632792852213], "value": 6251.2147769299145, "unit": "score"}], "name": "dromaeo_css", "value": 6096.056200250446, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 114.0, 113.0, 114.0, 115.0, 114.0, 116.0, 113.0, 114.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 131.0, 131.0, 172.0, 130.0, 130.0, 129.0, 129.0, 163.0, 134.0], "value": 140.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 161.0, 161.0, 160.0, 160.0, 161.0, 162.0, 162.0, 163.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 105.0, 76.0, 77.0, 80.0, 76.0, 115.0, 74.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 133.0, 84.0, 85.0, 84.0, 103.0, 84.0, 82.0, 111.0], "value": 93.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0, 117.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 152.0, 146.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 86.0, 86.0, 85.0, 86.0, 85.0, 85.0, 86.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 63.0, 64.0, 65.0, 67.0, 63.0, 66.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 66.0, 66.0, 65.0, 65.0, 65.0, 67.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 93.0, 84.0, 85.0, 84.0, 85.0, 83.0, 89.0, 84.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 155.0, 145.0, 159.0, 141.0, 143.0, 138.0, 142.0, 193.0, 147.0], "value": 150.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 177.0, 175.0, 176.0, 177.0, 178.0, 177.0, 180.0, 176.0, 178.0], "value": 178.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 69.0, 70.0, 70.0, 69.0, 68.0, 70.0, 69.0, 69.0], "value": 69.5, "unit": "score"}], "name": "kraken", "value": 1555.6, "alertThreshold": 2.0}]} 08:32:54 INFO - Return code: 0 08:32:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:32:55 INFO - # TBPL SUCCESS # 08:32:55 INFO - Running post-action listener: _resource_record_post_action 08:32:55 INFO - [mozharness: 2016-11-01 15:32:55.008637Z] Finished run-tests step (success) 08:32:55 INFO - Running post-run listener: _resource_record_post_run 08:32:55 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 391749632; Read time: 8; Write time: 321060 08:32:55 INFO - TinderboxPrint: CPU usage
13.0% 08:32:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:32:55 INFO - TinderboxPrint: I/O write bytes / time
391,749,632 / 321,060 08:32:55 INFO - TinderboxPrint: CPU idle
8,362.1 (87.0%) 08:32:55 INFO - TinderboxPrint: CPU user
1,203.9 (12.5%) 08:32:55 INFO - TinderboxPrint: Swap in / out
0 / 0 08:32:55 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99151872; Read time: 0; Write time: 73200 08:32:55 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 292597760; Read time: 0; Write time: 247860 08:32:55 INFO - Running post-run listener: _upload_blobber_files 08:32:55 INFO - Blob upload gear active. 08:32:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:32:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:32:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:32:56 INFO - (blobuploader) - INFO - Open directory for files ... 08:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:32:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:56 INFO - (blobuploader) - INFO - Done attempting. 08:32:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:32:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:32:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:32:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:32:59 INFO - (blobuploader) - INFO - Done attempting. 08:32:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:32:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:32:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:33:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:33:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:33:01 INFO - (blobuploader) - INFO - Done attempting. 08:33:01 INFO - (blobuploader) - INFO - Iteration through files over. 08:33:01 INFO - Return code: 0 08:33:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:33:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:33:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeef0f8a1e4b38aeafda6d7adc29042e815e2f11233e17487d59b57ff5e600a0d87c9acf5fe3b9b64df463c77b4cbee37f3e82890fc917ede80a830a280eafc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2a0690cba2f02afc8977074bb1aeb664ce0cbd3146f95e6bf65145687eeddbf9ecf1472d010af985c4d1ba2ad453f6ebb26a16280bfff2879908d7e2796d884", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c178fb0e871609d9eeda16c28dc152e4f4a6475d27a9733c00e579c434485e4bc066d3dcd19bf24c1b27f823bfdf09cecf7c8b9285092e1a12ccb9f9944f419"} 08:33:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:33:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:33:01 INFO - Contents: 08:33:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeef0f8a1e4b38aeafda6d7adc29042e815e2f11233e17487d59b57ff5e600a0d87c9acf5fe3b9b64df463c77b4cbee37f3e82890fc917ede80a830a280eafc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2a0690cba2f02afc8977074bb1aeb664ce0cbd3146f95e6bf65145687eeddbf9ecf1472d010af985c4d1ba2ad453f6ebb26a16280bfff2879908d7e2796d884", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c178fb0e871609d9eeda16c28dc152e4f4a6475d27a9733c00e579c434485e4bc066d3dcd19bf24c1b27f823bfdf09cecf7c8b9285092e1a12ccb9f9944f419"} 08:33:01 INFO - Running post-run listener: copy_logs_to_upload_dir 08:33:01 INFO - Copying logs to upload dir... 08:33:01 INFO - mkdir: /builds/slave/test/build/upload/logs 08:33:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.690301 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-01 08:33:01.005666) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-01 08:33:01.008796) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeef0f8a1e4b38aeafda6d7adc29042e815e2f11233e17487d59b57ff5e600a0d87c9acf5fe3b9b64df463c77b4cbee37f3e82890fc917ede80a830a280eafc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2a0690cba2f02afc8977074bb1aeb664ce0cbd3146f95e6bf65145687eeddbf9ecf1472d010af985c4d1ba2ad453f6ebb26a16280bfff2879908d7e2796d884", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c178fb0e871609d9eeda16c28dc152e4f4a6475d27a9733c00e579c434485e4bc066d3dcd19bf24c1b27f823bfdf09cecf7c8b9285092e1a12ccb9f9944f419"} build_url:https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011324 build_url: 'https://queue.taskcluster.net/v1/task/fgm5Gql0RVSodvMTjVoq9Q/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/Firefox-Non-PGO/sha512/aeef0f8a1e4b38aeafda6d7adc29042e815e2f11233e17487d59b57ff5e600a0d87c9acf5fe3b9b64df463c77b4cbee37f3e82890fc917ede80a830a280eafc3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e2a0690cba2f02afc8977074bb1aeb664ce0cbd3146f95e6bf65145687eeddbf9ecf1472d010af985c4d1ba2ad453f6ebb26a16280bfff2879908d7e2796d884", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2c178fb0e871609d9eeda16c28dc152e4f4a6475d27a9733c00e579c434485e4bc066d3dcd19bf24c1b27f823bfdf09cecf7c8b9285092e1a12ccb9f9944f419"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-01 08:33:01.034838) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:33:01.035177) ========= 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=9c3a94c35cc88655b05d2c08000001b2-1478013097.132481-91805833 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-01 08:33:01.118404) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-01 08:33:01.118720) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-01 08:33:01.119021) ========= ========= Total master_lag: 0.17 =========