builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-038 starttime: 1475845078.68 results: success (0) buildid: 20161007030207 builduid: 661d743ecc7042c1b4b9c598d9e3e9bd revision: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:58.675513) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:58.676267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:58.676604) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:58.710348) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:58.710949) ========= 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=8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 05:57:58-- 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: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-10-07 05:57:58 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.071620 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:58.798026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:58.798423) ========= 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=8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017285 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:58.850333) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:58.850844) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 --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 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 --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=8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 05:57:59,069 truncating revision to first 12 chars 2016-10-07 05:57:59,069 Setting DEBUG logging. 2016-10-07 05:57:59,069 attempt 1/10 2016-10-07 05:57:59,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4b9944879c9a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 05:57:59,381 unpacking tar archive at: mozilla-central-4b9944879c9a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.677603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:59.545374) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:59.545782) ========= script_repo_revision: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:59.546644) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:59.547006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 05:57:59.558231) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-07 05:57:59.558684) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:57:59 INFO - MultiFileLogger online at 20161007 05:57:59 in /builds/slave/test 05:57:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:57:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:59 INFO - {'append_to_log': False, 05:57:59 INFO - 'base_work_dir': '/builds/slave/test', 05:57:59 INFO - 'blob_upload_branch': 'Firefox', 05:57:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:59 INFO - 'branch': 'Firefox', 05:57:59 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:59 INFO - 'config_files': ('talos/linux_config.py',), 05:57:59 INFO - 'default_actions': ('clobber', 05:57:59 INFO - 'read-buildbot-config', 05:57:59 INFO - 'download-and-extract', 05:57:59 INFO - 'populate-webroot', 05:57:59 INFO - 'create-virtualenv', 05:57:59 INFO - 'install', 05:57:59 INFO - 'run-tests'), 05:57:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:59 INFO - 'download_minidump_stackwalk': True, 05:57:59 INFO - 'download_symbols': 'ondemand', 05:57:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:59 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:59 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:59 INFO - 'installer_path': 'installer.exe', 05:57:59 INFO - 'log_level': 'info', 05:57:59 INFO - 'log_name': 'talos', 05:57:59 INFO - 'log_to_console': True, 05:57:59 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:57:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:57:59 INFO - 'opt_config_files': (), 05:57:59 INFO - 'pip_index': False, 05:57:59 INFO - 'sps_profile': False, 05:57:59 INFO - 'sps_profile_interval': 0, 05:57:59 INFO - 'suite': 'dromaeojs', 05:57:59 INFO - 'system_bits': '32', 05:57:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:59 INFO - 'title': 'talos-linux64-ix-038', 05:57:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:59 INFO - 'use_talos_json': True, 05:57:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:59 INFO - 'work_dir': 'build'} 05:57:59 INFO - [mozharness: 2016-10-07 12:57:59.862984Z] Running clobber step. 05:57:59 INFO - Running pre-action listener: _resource_record_pre_action 05:57:59 INFO - Running main action method: clobber 05:57:59 INFO - rmtree: /builds/slave/test/build 05:57:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:58:00 INFO - Running post-action listener: _resource_record_post_action 05:58:00 INFO - [mozharness: 2016-10-07 12:58:00.829622Z] Finished clobber step (success) 05:58:00 INFO - [mozharness: 2016-10-07 12:58:00.829723Z] Running read-buildbot-config step. 05:58:00 INFO - Running pre-action listener: _resource_record_pre_action 05:58:00 INFO - Running main action method: read_buildbot_config 05:58:00 INFO - Using buildbot properties: 05:58:00 INFO - { 05:58:00 INFO - "project": "", 05:58:00 INFO - "product": "firefox", 05:58:00 INFO - "script_repo_revision": "production", 05:58:00 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:58:00 INFO - "repository": "", 05:58:00 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 05:58:00 INFO - "buildid": "20161007030207", 05:58:00 INFO - "stage_platform": "linux64-pgo", 05:58:00 INFO - "basedir": "/builds/slave/test", 05:58:00 INFO - "nightly_build": "True", 05:58:00 INFO - "buildnumber": 24, 05:58:00 INFO - "slavename": "talos-linux64-ix-038", 05:58:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:58:00 INFO - "platform": "ubuntu64_hw", 05:58:00 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:58:00 INFO - "branch": "mozilla-central", 05:58:00 INFO - "repo_path": "mozilla-central", 05:58:00 INFO - "revision": "4b9944879c9a60a9aba4a744a7401bc38e0f39c4", 05:58:00 INFO - "pgo_build": "True", 05:58:00 INFO - "builduid": "661d743ecc7042c1b4b9c598d9e3e9bd", 05:58:00 INFO - "slavebuilddir": "test" 05:58:00 INFO - } 05:58:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:58:00 INFO - Running post-action listener: _resource_record_post_action 05:58:00 INFO - [mozharness: 2016-10-07 12:58:00.832265Z] Finished read-buildbot-config step (success) 05:58:00 INFO - [mozharness: 2016-10-07 12:58:00.832355Z] Running download-and-extract step. 05:58:00 INFO - Running pre-action listener: _resource_record_pre_action 05:58:00 INFO - Running main action method: download_and_extract 05:58:00 INFO - mkdir: /builds/slave/test/build/tests 05:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:00 INFO - trying https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:58:00 INFO - Downloading https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/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 05:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/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 05:58:01 INFO - Downloaded 1361 bytes. 05:58:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:58:01 INFO - Using the following test package requirements: 05:58:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:58:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:58:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:01 INFO - u'jsshell-linux-x86_64.zip'], 05:58:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:58:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:58:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:58:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:58:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:58:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:58:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:58:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:58:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:58:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:01 INFO - Fetch https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:58:01 INFO - Http code: 200 05:58:01 INFO - via: 1.1 fc7da6323a08a2c16d48dd4939ce0898.cloudfront.net (CloudFront) 05:58:01 INFO - x-amz-cf-id: lHb8egdCVH8gVmFWBB2qWJibBq_nzAAiWeI5_mSSQg4-aZDhuyNffg== 05:58:01 INFO - x-amz-version-id: Ta5bmO6LzN_s0qMeAWHYp0rifvLky6Uu 05:58:02 INFO - Expected file size: 22022012 05:58:02 INFO - Obtained file size: 22022012 05:58:06 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 05:58:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:58:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:58:06 INFO - Fetch https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:58:07 INFO - Http code: 200 05:58:07 INFO - via: 1.1 5574699f9d8b8aad21acf2edbb25dc62.cloudfront.net (CloudFront) 05:58:07 INFO - x-amz-cf-id: uvWZII6tL2QOu82Frk_qo-R7gCh8eNopEqE2iHohuZjb8g1lA0T5PQ== 05:58:07 INFO - x-amz-version-id: Ta5bmO6LzN_s0qMeAWHYp0rifvLky6Uu 05:58:07 INFO - Expected file size: 22022012 05:58:07 INFO - Obtained file size: 22022012 05:58:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:58:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:58:11 INFO - Fetch https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:58:12 INFO - Http code: 200 05:58:12 INFO - via: 1.1 990c804118e679d7ea0f4d3ca3cc4534.cloudfront.net (CloudFront) 05:58:12 INFO - x-amz-cf-id: K7eP4clMyH63UwOvvkJQj_40j28w3HbZ3I4Rbip0O30FgiiigvYEWg== 05:58:12 INFO - x-amz-version-id: ZJBgSFM.AJonOYNDzt4j9oxQFk9jJg4_ 05:58:12 INFO - Expected file size: 14409006 05:58:12 INFO - Obtained file size: 14409006 05:58:13 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')]} 05:58:13 INFO - trying https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:58:13 INFO - Downloading https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/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 05:58:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/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 05:58:14 INFO - Downloaded 59714024 bytes. 05:58:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:58:14 INFO - mkdir: /builds/slave/test/properties 05:58:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:14 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:14 INFO - Contents: 05:58:14 INFO - build_url:https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:58:15 INFO - Running post-action listener: _resource_record_post_action 05:58:15 INFO - Running post-action listener: set_extra_try_arguments 05:58:15 INFO - [mozharness: 2016-10-07 12:58:15.528131Z] Finished download-and-extract step (success) 05:58:15 INFO - [mozharness: 2016-10-07 12:58:15.528358Z] Running populate-webroot step. 05:58:15 INFO - Running pre-action listener: _resource_record_pre_action 05:58:15 INFO - Running main action method: populate_webroot 05:58:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:15 INFO - '--tppagecycles', 05:58:15 INFO - '7'], 05:58:15 INFO - 'tests': ['tsvgm']}}, 05:58:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:15 INFO - 'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:15 INFO - 'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['damp', 'tps']}, 05:58:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:15 INFO - 'tests': ['damp', 'tps']}, 05:58:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['dromaeo_dom']}, 05:58:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['basic_compositor_video']}, 05:58:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:58:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['a11yr', 05:58:15 INFO - 'ts_paint', 05:58:15 INFO - 'tpaint', 05:58:15 INFO - 'sessionrestore', 05:58:15 INFO - 'sessionrestore_no_auto_restore', 05:58:15 INFO - 'tabpaint']}, 05:58:15 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:15 INFO - 'ts_paint', 05:58:15 INFO - 'tpaint', 05:58:15 INFO - 'sessionrestore', 05:58:15 INFO - 'sessionrestore_no_auto_restore', 05:58:15 INFO - 'tabpaint']}, 05:58:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:15 INFO - 'ts_paint', 05:58:15 INFO - 'tpaint', 05:58:15 INFO - 'sessionrestore', 05:58:15 INFO - 'sessionrestore_no_auto_restore', 05:58:15 INFO - 'tabpaint']}, 05:58:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:15 INFO - 'ts_paint', 05:58:15 INFO - 'tpaint', 05:58:15 INFO - 'sessionrestore', 05:58:15 INFO - 'sessionrestore_no_auto_restore', 05:58:15 INFO - 'tabpaint']}, 05:58:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['a11yr', 05:58:15 INFO - 'ts_paint', 05:58:15 INFO - 'tpaint', 05:58:15 INFO - 'sessionrestore', 05:58:15 INFO - 'sessionrestore_no_auto_restore', 05:58:15 INFO - 'tabpaint']}, 05:58:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['a11yr', 05:58:15 INFO - 'ts_paint', 05:58:15 INFO - 'tpaint', 05:58:15 INFO - 'sessionrestore', 05:58:15 INFO - 'sessionrestore_no_auto_restore', 05:58:15 INFO - 'tabpaint']}, 05:58:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['tsvgx', 05:58:15 INFO - 'tsvgr_opacity', 05:58:15 INFO - 'tart', 05:58:15 INFO - 'tscrollx', 05:58:15 INFO - 'cart']}, 05:58:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:15 INFO - 'tsvgr_opacity', 05:58:15 INFO - 'tart', 05:58:15 INFO - 'tscrollx', 05:58:15 INFO - 'cart']}, 05:58:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:15 INFO - 'talos_options': ['--disable-e10s'], 05:58:15 INFO - 'tests': ['tp5o']}, 05:58:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:15 INFO - 'tests': ['tp5o']}, 05:58:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:15 INFO - 'talos_options': ['--disable-e10s', 05:58:15 INFO - '--xperf_path', 05:58:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:15 INFO - 'tests': ['tp5n']}, 05:58:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:15 INFO - 'talos_options': ['--xperf_path', 05:58:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:15 INFO - 'tests': ['tp5n']}}, 05:58:15 INFO - 'talos.zip': {'path': '', 05:58:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:15 INFO - Running post-action listener: _resource_record_post_action 05:58:15 INFO - [mozharness: 2016-10-07 12:58:15.550159Z] Finished populate-webroot step (success) 05:58:15 INFO - [mozharness: 2016-10-07 12:58:15.550248Z] Running create-virtualenv step. 05:58:15 INFO - Running pre-action listener: _resource_record_pre_action 05:58:15 INFO - Running main action method: create_virtualenv 05:58:15 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:15 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 05:58:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:15 INFO - Using real prefix '/usr' 05:58:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:16 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:18 INFO - Installing pip.................done. 05:58:18 INFO - Return code: 0 05:58:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:58:18 INFO - Reading from file tmpfile_stdout 05:58:18 INFO - Output received: 05:58:18 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) 05:58:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06bc22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11be790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, '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': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', '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 05:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:58:18 INFO - Using env: {'DISPLAY': ':0', 05:58:18 INFO - 'HOME': '/home/cltbld', 05:58:18 INFO - 'LANG': 'en_US.UTF-8', 05:58:18 INFO - 'LANGUAGE': 'en_US:en', 05:58:18 INFO - 'LOGNAME': 'cltbld', 05:58:18 INFO - 'MAIL': '/var/mail/cltbld', 05:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:18 INFO - 'MOZ_NO_REMOTE': '1', 05:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:18 INFO - 'NO_EM_RESTART': '1', 05:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:18 INFO - 'PWD': '/builds/slave/test', 05:58:18 INFO - 'SHELL': '/bin/bash', 05:58:18 INFO - 'SHLVL': '1', 05:58:18 INFO - 'TERM': 'linux', 05:58:18 INFO - 'TMOUT': '86400', 05:58:18 INFO - 'USER': 'cltbld', 05:58:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:18 INFO - '_': '/tools/buildbot/bin/python'} 05:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:18 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 05:58:18 INFO - Cleaning up... 05:58:18 INFO - Return code: 0 05:58:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd06bc22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11be790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, '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': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', '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 05:58:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:58:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:58:18 INFO - Using env: {'DISPLAY': ':0', 05:58:18 INFO - 'HOME': '/home/cltbld', 05:58:18 INFO - 'LANG': 'en_US.UTF-8', 05:58:18 INFO - 'LANGUAGE': 'en_US:en', 05:58:18 INFO - 'LOGNAME': 'cltbld', 05:58:18 INFO - 'MAIL': '/var/mail/cltbld', 05:58:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:18 INFO - 'MOZ_NO_REMOTE': '1', 05:58:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:18 INFO - 'NO_EM_RESTART': '1', 05:58:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:18 INFO - 'PWD': '/builds/slave/test', 05:58:18 INFO - 'SHELL': '/bin/bash', 05:58:18 INFO - 'SHLVL': '1', 05:58:18 INFO - 'TERM': 'linux', 05:58:18 INFO - 'TMOUT': '86400', 05:58:18 INFO - 'USER': 'cltbld', 05:58:18 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:18 INFO - '_': '/tools/buildbot/bin/python'} 05:58:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:18 INFO - Downloading/unpacking psutil>=3.1.1 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:20 INFO - Installing collected packages: psutil 05:58:20 INFO - Running setup.py install for psutil 05:58:20 INFO - building 'psutil._psutil_linux' extension 05:58:20 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:58:21 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 05:58:21 INFO - building 'psutil._psutil_posix' extension 05:58:21 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 05:58:21 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 05:58:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:21 INFO - Successfully installed psutil 05:58:21 INFO - Cleaning up... 05:58:21 INFO - Return code: 0 05:58:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd06bc22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11be790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, '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': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', '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 05:58:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:58:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:58:21 INFO - Using env: {'DISPLAY': ':0', 05:58:21 INFO - 'HOME': '/home/cltbld', 05:58:21 INFO - 'LANG': 'en_US.UTF-8', 05:58:21 INFO - 'LANGUAGE': 'en_US:en', 05:58:21 INFO - 'LOGNAME': 'cltbld', 05:58:21 INFO - 'MAIL': '/var/mail/cltbld', 05:58:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:21 INFO - 'MOZ_NO_REMOTE': '1', 05:58:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:21 INFO - 'NO_EM_RESTART': '1', 05:58:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:21 INFO - 'PWD': '/builds/slave/test', 05:58:21 INFO - 'SHELL': '/bin/bash', 05:58:21 INFO - 'SHLVL': '1', 05:58:21 INFO - 'TERM': 'linux', 05:58:21 INFO - 'TMOUT': '86400', 05:58:21 INFO - 'USER': 'cltbld', 05:58:21 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:21 INFO - '_': '/tools/buildbot/bin/python'} 05:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:23 INFO - Installing collected packages: mozsystemmonitor 05:58:23 INFO - Running setup.py install for mozsystemmonitor 05:58:23 INFO - Successfully installed mozsystemmonitor 05:58:23 INFO - Cleaning up... 05:58:23 INFO - Return code: 0 05:58:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd06bc22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11be790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, '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': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', '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 05:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:58:23 INFO - Using env: {'DISPLAY': ':0', 05:58:23 INFO - 'HOME': '/home/cltbld', 05:58:23 INFO - 'LANG': 'en_US.UTF-8', 05:58:23 INFO - 'LANGUAGE': 'en_US:en', 05:58:23 INFO - 'LOGNAME': 'cltbld', 05:58:23 INFO - 'MAIL': '/var/mail/cltbld', 05:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:23 INFO - 'MOZ_NO_REMOTE': '1', 05:58:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:23 INFO - 'NO_EM_RESTART': '1', 05:58:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:23 INFO - 'PWD': '/builds/slave/test', 05:58:23 INFO - 'SHELL': '/bin/bash', 05:58:23 INFO - 'SHLVL': '1', 05:58:23 INFO - 'TERM': 'linux', 05:58:23 INFO - 'TMOUT': '86400', 05:58:23 INFO - 'USER': 'cltbld', 05:58:23 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:23 INFO - '_': '/tools/buildbot/bin/python'} 05:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:23 INFO - Downloading/unpacking jsonschema==2.5.1 05:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:25 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:26 INFO - warning: no files found matching '*.txt' 05:58:26 INFO - no previously-included directories found matching 'build' 05:58:26 INFO - no previously-included directories found matching 'dist' 05:58:26 INFO - no previously-included directories found matching '.git*' 05:58:26 INFO - Installing collected packages: jsonschema, functools32 05:58:26 INFO - Running setup.py install for functools32 05:58:26 INFO - warning: no files found matching '*.txt' 05:58:26 INFO - no previously-included directories found matching 'build' 05:58:26 INFO - no previously-included directories found matching 'dist' 05:58:26 INFO - no previously-included directories found matching '.git*' 05:58:26 INFO - Successfully installed jsonschema functools32 05:58:26 INFO - Cleaning up... 05:58:26 INFO - Return code: 0 05:58:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:58:26 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')]} 05:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:26 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')]} 05:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:26 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 0x7fd06bc22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11be790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, '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': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', '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 05:58:26 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 05:58:26 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 05:58:26 INFO - Using env: {'DISPLAY': ':0', 05:58:26 INFO - 'HOME': '/home/cltbld', 05:58:26 INFO - 'LANG': 'en_US.UTF-8', 05:58:26 INFO - 'LANGUAGE': 'en_US:en', 05:58:26 INFO - 'LOGNAME': 'cltbld', 05:58:26 INFO - 'MAIL': '/var/mail/cltbld', 05:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:26 INFO - 'MOZ_NO_REMOTE': '1', 05:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:26 INFO - 'NO_EM_RESTART': '1', 05:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:26 INFO - 'PWD': '/builds/slave/test', 05:58:26 INFO - 'SHELL': '/bin/bash', 05:58:26 INFO - 'SHLVL': '1', 05:58:26 INFO - 'TERM': 'linux', 05:58:26 INFO - 'TMOUT': '86400', 05:58:26 INFO - 'USER': 'cltbld', 05:58:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:26 INFO - '_': '/tools/buildbot/bin/python'} 05:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:58:26 INFO - Cleaning up... 05:58:26 INFO - Return code: 0 05:58:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:26 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')]} 05:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:26 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')]} 05:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:26 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 0x7fd06bc22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11be790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, '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': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', '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 05:58:26 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 05:58:26 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 05:58:26 INFO - Using env: {'DISPLAY': ':0', 05:58:26 INFO - 'HOME': '/home/cltbld', 05:58:26 INFO - 'LANG': 'en_US.UTF-8', 05:58:26 INFO - 'LANGUAGE': 'en_US:en', 05:58:26 INFO - 'LOGNAME': 'cltbld', 05:58:26 INFO - 'MAIL': '/var/mail/cltbld', 05:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:26 INFO - 'MOZ_NO_REMOTE': '1', 05:58:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:26 INFO - 'NO_EM_RESTART': '1', 05:58:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:26 INFO - 'PWD': '/builds/slave/test', 05:58:26 INFO - 'SHELL': '/bin/bash', 05:58:26 INFO - 'SHLVL': '1', 05:58:26 INFO - 'TERM': 'linux', 05:58:26 INFO - 'TMOUT': '86400', 05:58:26 INFO - 'USER': 'cltbld', 05:58:26 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:26 INFO - '_': '/tools/buildbot/bin/python'} 05:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:26 INFO - Downloading/unpacking blobuploader==1.2.4 05:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:28 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 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 05:58:29 INFO - Downloading docopt-0.6.1.tar.gz 05:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:29 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:29 INFO - Running setup.py install for blobuploader 05:58:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:29 INFO - Running setup.py install for requests 05:58:29 INFO - Running setup.py install for docopt 05:58:30 INFO - Successfully installed blobuploader requests docopt 05:58:30 INFO - Cleaning up... 05:58:30 INFO - Return code: 0 05:58:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:30 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 0x7fd06bc22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11be790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, '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': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', '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 05:58:30 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 05:58:30 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 05:58:30 INFO - Using env: {'DISPLAY': ':0', 05:58:30 INFO - 'HOME': '/home/cltbld', 05:58:30 INFO - 'LANG': 'en_US.UTF-8', 05:58:30 INFO - 'LANGUAGE': 'en_US:en', 05:58:30 INFO - 'LOGNAME': 'cltbld', 05:58:30 INFO - 'MAIL': '/var/mail/cltbld', 05:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:30 INFO - 'MOZ_NO_REMOTE': '1', 05:58:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:30 INFO - 'NO_EM_RESTART': '1', 05:58:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:30 INFO - 'PWD': '/builds/slave/test', 05:58:30 INFO - 'SHELL': '/bin/bash', 05:58:30 INFO - 'SHLVL': '1', 05:58:30 INFO - 'TERM': 'linux', 05:58:30 INFO - 'TMOUT': '86400', 05:58:30 INFO - 'USER': 'cltbld', 05:58:30 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:30 INFO - '_': '/tools/buildbot/bin/python'} 05:58:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:30 INFO - Running setup.py (path:/tmp/pip-mRIcJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:30 INFO - Running setup.py (path:/tmp/pip-fGjlzU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:30 INFO - Running setup.py (path:/tmp/pip-hA7voF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:30 INFO - Running setup.py (path:/tmp/pip-KhQwhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:30 INFO - Running setup.py (path:/tmp/pip-pgdLhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:30 INFO - Running setup.py (path:/tmp/pip-RDdheM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:30 INFO - Running setup.py (path:/tmp/pip-It24Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:30 INFO - Running setup.py (path:/tmp/pip-fCIusS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:30 INFO - Running setup.py (path:/tmp/pip-SbU0Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:31 INFO - Running setup.py (path:/tmp/pip-koGsLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:31 INFO - Running setup.py (path:/tmp/pip-wVwylz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:31 INFO - Running setup.py (path:/tmp/pip-HuTCic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:31 INFO - Running setup.py (path:/tmp/pip-IHDYfV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:31 INFO - Running setup.py (path:/tmp/pip-Q5DDZH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:31 INFO - Running setup.py (path:/tmp/pip-FNZ1kv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:31 INFO - Running setup.py (path:/tmp/pip-KJ04J5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:31 INFO - Running setup.py (path:/tmp/pip-fk5aEu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:31 INFO - Running setup.py install for manifestparser 05:58:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:31 INFO - Running setup.py install for mozcrash 05:58:31 INFO - Running setup.py install for mozdebug 05:58:31 INFO - Running setup.py install for mozdevice 05:58:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Running setup.py install for mozfile 05:58:32 INFO - Running setup.py install for mozhttpd 05:58:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Running setup.py install for mozinfo 05:58:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Running setup.py install for mozInstall 05:58:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Running setup.py install for mozleak 05:58:32 INFO - Running setup.py install for mozlog 05:58:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Running setup.py install for moznetwork 05:58:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Running setup.py install for mozprocess 05:58:32 INFO - Running setup.py install for mozprofile 05:58:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:32 INFO - Running setup.py install for mozrunner 05:58:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Running setup.py install for mozscreenshot 05:58:33 INFO - Running setup.py install for moztest 05:58:33 INFO - Running setup.py install for mozversion 05:58:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:33 INFO - Cleaning up... 05:58:33 INFO - Return code: 0 05:58:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:33 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 0x7fd06bc22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11be790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, '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': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', '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 05:58:33 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 05:58:33 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 05:58:33 INFO - Using env: {'DISPLAY': ':0', 05:58:33 INFO - 'HOME': '/home/cltbld', 05:58:33 INFO - 'LANG': 'en_US.UTF-8', 05:58:33 INFO - 'LANGUAGE': 'en_US:en', 05:58:33 INFO - 'LOGNAME': 'cltbld', 05:58:33 INFO - 'MAIL': '/var/mail/cltbld', 05:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:33 INFO - 'MOZ_NO_REMOTE': '1', 05:58:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:33 INFO - 'NO_EM_RESTART': '1', 05:58:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:33 INFO - 'PWD': '/builds/slave/test', 05:58:33 INFO - 'SHELL': '/bin/bash', 05:58:33 INFO - 'SHLVL': '1', 05:58:33 INFO - 'TERM': 'linux', 05:58:33 INFO - 'TMOUT': '86400', 05:58:33 INFO - 'USER': 'cltbld', 05:58:33 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:33 INFO - '_': '/tools/buildbot/bin/python'} 05:58:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:33 INFO - Running setup.py (path:/tmp/pip-dXWW9k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:33 INFO - Running setup.py (path:/tmp/pip-fTBlgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:33 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)) 05:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:33 INFO - Running setup.py (path:/tmp/pip-3NraX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:33 INFO - Running setup.py (path:/tmp/pip-9MmOw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:33 INFO - Running setup.py (path:/tmp/pip-WWPIPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:58:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:33 INFO - Running setup.py (path:/tmp/pip-nwe72X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:34 INFO - Running setup.py (path:/tmp/pip-Qmeln2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:34 INFO - Running setup.py (path:/tmp/pip-7ArlLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:34 INFO - Running setup.py (path:/tmp/pip-LA97Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:34 INFO - Running setup.py (path:/tmp/pip-hCGtwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:34 INFO - Running setup.py (path:/tmp/pip-ASHh27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:34 INFO - Running setup.py (path:/tmp/pip-8PRETr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:34 INFO - Running setup.py (path:/tmp/pip-8_C6vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:34 INFO - Running setup.py (path:/tmp/pip-To1etS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:34 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)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:34 INFO - Running setup.py (path:/tmp/pip-iEJisw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:34 INFO - Running setup.py (path:/tmp/pip-Mm1oXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:58:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:34 INFO - Running setup.py (path:/tmp/pip-kP9NCl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:36 INFO - Downloading blessings-1.6.tar.gz 05:58:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:36 INFO - Installing collected packages: blessings 05:58:36 INFO - Running setup.py install for blessings 05:58:36 INFO - Successfully installed blessings 05:58:36 INFO - Cleaning up... 05:58:37 INFO - Return code: 0 05:58:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:37 INFO - Reading from file tmpfile_stdout 05:58:37 INFO - Current package versions: 05:58:37 INFO - argparse == 1.2.1 05:58:37 INFO - blessings == 1.6 05:58:37 INFO - blobuploader == 1.2.4 05:58:37 INFO - docopt == 0.6.1 05:58:37 INFO - functools32 == 3.2.3-2 05:58:37 INFO - jsonschema == 2.5.1 05:58:37 INFO - manifestparser == 1.1 05:58:37 INFO - mozInstall == 1.12 05:58:37 INFO - mozcrash == 0.17 05:58:37 INFO - mozdebug == 0.1 05:58:37 INFO - mozdevice == 0.48 05:58:37 INFO - mozfile == 1.2 05:58:37 INFO - mozhttpd == 0.7 05:58:37 INFO - mozinfo == 0.9 05:58:37 INFO - mozleak == 0.1 05:58:37 INFO - mozlog == 3.4 05:58:37 INFO - moznetwork == 0.27 05:58:37 INFO - mozprocess == 0.23 05:58:37 INFO - mozprofile == 0.28 05:58:37 INFO - mozrunner == 6.12 05:58:37 INFO - mozscreenshot == 0.1 05:58:37 INFO - mozsystemmonitor == 0.3 05:58:37 INFO - moztest == 0.7 05:58:37 INFO - mozversion == 1.4 05:58:37 INFO - psutil == 3.1.1 05:58:37 INFO - requests == 1.2.3 05:58:37 INFO - wsgiref == 0.1.2 05:58:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:37 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')]} 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 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')]} 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 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 0x7fd06bc22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11be790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, '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': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', '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 05:58:37 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 05:58:37 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 05:58:37 INFO - Using env: {'DISPLAY': ':0', 05:58:37 INFO - 'HOME': '/home/cltbld', 05:58:37 INFO - 'LANG': 'en_US.UTF-8', 05:58:37 INFO - 'LANGUAGE': 'en_US:en', 05:58:37 INFO - 'LOGNAME': 'cltbld', 05:58:37 INFO - 'MAIL': '/var/mail/cltbld', 05:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:37 INFO - 'MOZ_NO_REMOTE': '1', 05:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:37 INFO - 'NO_EM_RESTART': '1', 05:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:37 INFO - 'PWD': '/builds/slave/test', 05:58:37 INFO - 'SHELL': '/bin/bash', 05:58:37 INFO - 'SHLVL': '1', 05:58:37 INFO - 'TERM': 'linux', 05:58:37 INFO - 'TMOUT': '86400', 05:58:37 INFO - 'USER': 'cltbld', 05:58:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:37 INFO - '_': '/tools/buildbot/bin/python'} 05:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 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)) 05:58:37 INFO - Cleaning up... 05:58:37 INFO - Return code: 0 05:58:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:37 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')]} 05:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 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')]} 05:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:37 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 0x7fd06bc22f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f18a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11be790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, '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': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', '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 05:58:37 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 05:58:37 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 05:58:37 INFO - Using env: {'DISPLAY': ':0', 05:58:37 INFO - 'HOME': '/home/cltbld', 05:58:37 INFO - 'LANG': 'en_US.UTF-8', 05:58:37 INFO - 'LANGUAGE': 'en_US:en', 05:58:37 INFO - 'LOGNAME': 'cltbld', 05:58:37 INFO - 'MAIL': '/var/mail/cltbld', 05:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:37 INFO - 'MOZ_NO_REMOTE': '1', 05:58:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:37 INFO - 'NO_EM_RESTART': '1', 05:58:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:37 INFO - 'PWD': '/builds/slave/test', 05:58:37 INFO - 'SHELL': '/bin/bash', 05:58:37 INFO - 'SHLVL': '1', 05:58:37 INFO - 'TERM': 'linux', 05:58:37 INFO - 'TMOUT': '86400', 05:58:37 INFO - 'USER': 'cltbld', 05:58:37 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:37 INFO - '_': '/tools/buildbot/bin/python'} 05:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:58:37 INFO - Cleaning up... 05:58:37 INFO - Return code: 0 05:58:37 INFO - Running post-action listener: _resource_record_post_action 05:58:37 INFO - Running post-action listener: _start_resource_monitoring 05:58:37 INFO - Starting resource monitoring. 05:58:37 INFO - [mozharness: 2016-10-07 12:58:37.727344Z] Finished create-virtualenv step (success) 05:58:37 INFO - [mozharness: 2016-10-07 12:58:37.727814Z] Running install step. 05:58:37 INFO - Running pre-action listener: _resource_record_pre_action 05:58:37 INFO - Running main action method: install 05:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:37 INFO - Reading from file tmpfile_stdout 05:58:37 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:37 INFO - Reading from file tmpfile_stdout 05:58:37 INFO - Output received: 05:58:38 INFO - Usage: mozinstall [options] installer 05:58:38 INFO - Options: 05:58:38 INFO - -h, --help show this help message and exit 05:58:38 INFO - -d DEST, --destination=DEST 05:58:38 INFO - Directory to install application into. [default: 05:58:38 INFO - "/builds/slave/test"] 05:58:38 INFO - --app=APP Application being installed. [default: firefox] 05:58:38 INFO - mkdir: /builds/slave/test/build/application 05:58:38 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'] 05:58:38 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 05:58:55 INFO - Reading from file tmpfile_stdout 05:58:55 INFO - Output received: 05:58:55 INFO - /builds/slave/test/build/application/firefox/firefox 05:58:55 INFO - Running post-action listener: _resource_record_post_action 05:58:55 INFO - [mozharness: 2016-10-07 12:58:55.019492Z] Finished install step (success) 05:58:55 INFO - [mozharness: 2016-10-07 12:58:55.019737Z] Running run-tests step. 05:58:55 INFO - Running pre-action listener: _resource_record_pre_action 05:58:55 INFO - Running main action method: run_tests 05:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:55 INFO - Python 2.7.3 05:58:55 INFO - Return code: 0 05:58:55 INFO - grabbing minidump binary from tooltool 05:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:55 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 0x11bb930>, '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 0x11bc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11bccc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:55 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 05:58:55 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 05:58:55 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 05:58:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:55 INFO - Return code: 0 05:58:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:58:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:58:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 05:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 05:58:55 INFO - Using env: {'DISPLAY': ':0', 05:58:55 INFO - 'HOME': '/home/cltbld', 05:58:55 INFO - 'LANG': 'en_US.UTF-8', 05:58:55 INFO - 'LANGUAGE': 'en_US:en', 05:58:55 INFO - 'LOGNAME': 'cltbld', 05:58:55 INFO - 'MAIL': '/var/mail/cltbld', 05:58:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:55 INFO - 'MOZ_NO_REMOTE': '1', 05:58:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:55 INFO - 'NO_EM_RESTART': '1', 05:58:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:55 INFO - 'PWD': '/builds/slave/test', 05:58:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:55 INFO - 'SHELL': '/bin/bash', 05:58:55 INFO - 'SHLVL': '1', 05:58:55 INFO - 'TERM': 'linux', 05:58:55 INFO - 'TMOUT': '86400', 05:58:55 INFO - 'USER': 'cltbld', 05:58:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554', 05:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:55 INFO - '_': '/tools/buildbot/bin/python'} 05:58:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 05:58:55 INFO - mozversion application_buildid: 20161007030207 05:58:55 INFO - mozversion application_changeset: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 05:58:55 INFO - mozversion application_display_name: Nightly 05:58:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:55 INFO - mozversion application_name: Firefox 05:58:55 INFO - mozversion application_remotingname: firefox 05:58:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:58:55 INFO - mozversion application_vendor: Mozilla 05:58:55 INFO - mozversion application_version: 52.0a1 05:58:55 INFO - mozversion platform_buildid: 20161007030207 05:58:55 INFO - mozversion platform_changeset: 4b9944879c9a60a9aba4a744a7401bc38e0f39c4 05:58:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:58:55 INFO - mozversion platform_version: 52.0a1 05:58:55 INFO - using testdate: 1475845135 05:58:55 INFO - actual date: 1475845135 05:58:55 INFO - starting webserver on 'localhost:35388' 05:58:55 INFO - SUITE-START | Running 2 tests 05:58:55 INFO - TEST-START | dromaeo_css 05:58:55 INFO - operating with platform_type : linux_ 05:58:55 INFO - Initialising browser for dromaeo_css test... 05:58:55 INFO - TEST-INFO | started process 2601 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQgGvMZ/profile http://localhost:35388/getInfo.html) 05:59:00 INFO - PROCESS | 2601 | __metrics Screen width/height:1600/1200 05:59:00 INFO - PROCESS | 2601 | colorDepth:24 05:59:00 INFO - PROCESS | 2601 | Browser inner width/height: 1024/697 05:59:00 INFO - PROCESS | 2601 | __metrics 05:59:00 INFO - PROCESS | 2601 | 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" 05:59:00 INFO - PROCESS | 2601 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:01 INFO - PROCESS | 2601 | console.error: PushService: 05:59:01 INFO - PROCESS | 2601 | stateChangeProcessEnqueue: Error transitioning state 05:59:01 INFO - PROCESS | 2601 | UnknownError 05:59:01 INFO - TEST-INFO | 2601: exit 0 05:59:01 INFO - Browser initialized. 05:59:01 INFO - Running cycle 1/1 for dromaeo_css test... 05:59:01 INFO - TEST-INFO | started process 2683 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQgGvMZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:14 INFO - PROCESS | 2683 | RSS: Main: 177266688 05:59:14 INFO - PROCESS | 2683 | 06:00:05 INFO - PROCESS | 2683 | 1475845205470 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] 06:02:16 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:35388/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35388/tests/dromaeo/cssquery-ext.html) 06:02:17 INFO - PROCESS | 2683 | RSS: Main: 314597376 06:02:17 INFO - PROCESS | 2683 | 06:05:20 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:35388/tests/dromaeo/cssquery-ext.html (next: http://localhost:35388/tests/dromaeo/cssquery-jquery.html) 06:05:20 INFO - PROCESS | 2683 | RSS: Main: 274599936 06:05:20 INFO - PROCESS | 2683 | 06:08:22 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:35388/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35388/tests/dromaeo/cssquery-mootools.html) 06:08:23 INFO - PROCESS | 2683 | RSS: Main: 244883456 06:08:23 INFO - PROCESS | 2683 | 06:11:25 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:35388/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35388/tests/dromaeo/cssquery-prototype.html) 06:11:26 INFO - PROCESS | 2683 | RSS: Main: 239742976 06:11:26 INFO - PROCESS | 2683 | 06:14:28 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:35388/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35388/tests/dromaeo/cssquery-yui.html) 06:14:29 INFO - PROCESS | 2683 | RSS: Main: 215982080 06:14:29 INFO - PROCESS | 2683 | 06:17:32 INFO - PROCESS | 2683 | Cycle 1(1): loaded http://localhost:35388/tests/dromaeo/cssquery-yui.html (next: http://localhost:35388/tests/dromaeo/cssquery-dojo.html) 06:17:32 INFO - PROCESS | 2683 | RSS: Main: 308305920 06:17:32 INFO - PROCESS | 2683 | 06:17:32 INFO - PROCESS | 2683 | __start_tp_report 06:17:32 INFO - PROCESS | 2683 | _x_x_mozilla_page_load 06:17:32 INFO - PROCESS | 2683 | _x_x_mozilla_page_load_details 06:17:32 INFO - PROCESS | 2683 | |i|pagename|runs| 06:17:32 INFO - PROCESS | 2683 | |0;dojo.html;2921.0360581008267;2960.4227175700735;2963.629546306712;2977.6724560298376;3006.8496575171234;5074.923876141861;5112.74436278186;5128.333316668837;5162.483751624835;5181.818636347723;5173.922391164136;5199.68801871887;5248.632595718302;5275.208718692198;5314.043472175007;4620.815167393317;4631.675782695213;4667.509911459299;4687.320338550908;4704.764761761915;4311.82752689892;4685.086408150412;4741.028089241714;4745.620350371962;4808.326834243191;4616.584507394317;4709.481956984729;4719.197736384788;4724.5984091352275;4817.831375901844;4651.046535460223;4675.111728771522;4721.268203428474;4769.713817170946;4824.083424149436;4677.7661116944355;4724.622030237572;4724.858254252378;4774.832880849153;4792.880177995543;5148.6910785353;5151.330327057459;5204.921926171072;5214.348206474191;5218.530332270114;5302.363716354023;5333.333333333333;5369.221462887898;5525;5537.003339398907;5534.308211473566;5547.694876781776;5580.162975553659;5626.606137570372;5632.295963004624;5196.558292545138;5198.948010519922;5201.817936372209;5202.0896343140175;5261.973690131601;5437.673739575638;5482.2873026506295;5680.943190568124;5683.77264909399;5686.545076393879;5316.441773613715;5349.866253343697;5363.436839131835;5376.301080859464;5388.622796404214;5453.345598528202;5467.5625949923915;5491.505764481216;5554.444555544414;5557.777688892399;5296.867578310573;5468.890622187534;5536.446355364431;5539.19681646159;5599.664020158803;5335.946640533545;5460.535854452337;5513.8345849624575;5527.806526771544;5546.639468434539;4287.099709061132;4292.184484947912;4296.2481565725875;4317.287647538121;4375.409319741858;3730.179360540731;3813.8474461021246;3816.2939856126704;3842.711796615265;3875.4380614810693;5086.567641750493;5169.043726910533;5186.844394668166;5199.480051994846;5234.555062819627;5484.945150548523;5493.917591236134;5494.230807686927;5497.862553436196;5499.367572729107;5190.896182076337;5203.661761985459;5204;5209;5271.551918086929;4662.044280922402;4703.082898834763;4703.905921881612;4732.337472753818;4741.478437371887;5672.234248376416;5677.148427735872;5682.48857602826;5682.886342273214;5735.713214339266;5476.616636835383;5480.3971563128825;5483.698396588226;5484.561235101262;5490.3411590609385;5484.294165697297;5572.609917305912;5601.495865372136;5617.32592088952;5662.943370566406;5322.175062865262;5351.625386222927;5353.223782551586;5412.675239485643;5417.8103766367985;5460.153676180198;5460.180972854104;5467.808626698046;5469.316335458067;5526.088195447706;5184.300119483822;5239.05696974533;5284.471552844839;5315.920261196163;5327.840164795062;5277.947220527745;5349.2778474906945;5352.4915133062295;5409.432009639088;5413.83758487246;5326.201069839555;5326.97336513315;5330.440303768049;5334.093204155225;5414.810481633124;5250.422453530032;5279.841604751864;5330.227117067926;5376.784928602812;5399.649022813504;5247.842564723064;5278.419373868948;5330.9733451332495;5392.325959255093;5401.864953376197 06:17:32 INFO - PROCESS | 2683 | |1;ext.html;551.1198338710717;591.778083218793;601.2604496469345;615.7752420366568;618.2179542878259;32178;32920.67079329209;42865.99999999996;43766;43909.7804510977;40845.59154408455;45276.54723452764;45307;45356.77321613396;45390;8106.148854370294;8882.156195161466;9032.45805251687;9048.140426659456;9049.773755656095;8138.755837324889;10626;10861.40262285574;10870.673879783579;11206.327620342765;10994.28537145087;11015.228933974626;11023.779524409507;11032.724181895477;11106.555737770519;10842.186835987293;10903.83644245337;10911.454427278684;10914.617988370368;10925.125989920787;10624.256302058859;10686.893131068746;10689.412082335468;10696.679099627023;10736.355818650827;42486.362704559455;42497.15005699869;42834;42866.57133428657;42909.785451072545;3539.699125574329;3597.3704601694863;3670.137517683342;3868.7678739275734;4106.938395924063;31966.680333196604;32234.677653223403;32278.838605807057;32475.675243247737;32495.350092998244;4224.8732538023905;4337.853168921642;4342.196693611692;4494.235979883428;4518.796654150571;320701.9999999977;321006;321533.3923330392;322416;324773;57053.14420283699;57351.71324143353;57355.71322143362;57366;57370.42629573734;61210;61254.081188782206;61262.38737612656;61325.38674613286;61351.6932415335;16377;16656.916715416588;16694.66610667804;16696.248668809934;16704.582385440463;10044.799104017879;10279.691609251584;12527.060470464752;12818.551350702866;12835.165714228546;16478.75281870773;16678.33286668544;16686.49940501787;17008.234629441704;17074.573135671708;6409.711562979677;6424.839379015562;6509.381608747161;6677.332266773284;6747.966260168668;952.3476418653106;1043.1915265669168;1059.3114475590928;1069.4278560969844;1113.1206346985953;31683.20791980219;31950;32129.839350803097;32261;32443.837780811416;1066.2749330455365;1074.5594306334365;1091.252492042953;1111.4720507758911;1166.1836714300025;15769.29038193284;16799.91600041992;16818.495445136665;16947.745783813254;17011.744823827652;504782;509002;511512;512286.08709998825;512530;56639.15041274384;56656;56709.7164514183;56771.432285676616;56824.01115960922;1195.9461824217758;1274.3182397417338;1302.2316833068346;1349.750296195207;1357;27493.587596185673;31106.53340199944;31233;31487.84256078705;31581.368372632878;48676.269855952894;49253.50746492489;49254.75372623114;49297;49382.50617493779;365309;365834;366378;366879;366944;26264.606030909934;27887;27965.580516291866;28801.423971520035;28959;45575.31637025514;46565.06869862516;46789.53210467852;47132.7643361781;48323.516764831904;36928;36980.44529332116;37008;37283.25433491369;37555;38099.42850857295;38253.42619860649;38528.03679908025;38887.41668875026;39095.609043910335;39959.2008159841;40105.39841902316;40542.39186412147;40843.38734919038;41347.379789303784;32039.519407208445;34260.48609270913;34805.825970870996;34925.65074349326;34956.47565286472;27527.13417363875;27754;27755.722442775314;27873.303167420978;28203.15390538287 06:17:32 INFO - PROCESS | 2683 | |2;jquery.html;375.33003588594363;386.48597365503883;406.0761766980121;409.62314670503133;418.0718804254554;13012.219266843984;14790.1125932444;18403;19149.138288777005;19204.615907681873;17688.1155942203;18405.90797046016;18447.354342598013;18713.25146994122;18731.90634046831;5576.944230557693;5801.970990145043;5809.477147056764;5812.680302583356;5814.8255552333285;5023.773930173151;6329.272133704614;6369.426751592356;6444.291127975919;6456.935430645681;6080.847978800543;6189.659568723719;6418.903716444257;6435.871282574346;6437.420632143107;6194.7831825886105;6227.782027629034;6265.4361107500545;6273.3412991635905;6299.307076221612;5347.973260133714;5460.726963651801;5670.376258611549;5707.400722924116;5728.484436400702;22042.228522001653;22081.356576164915;22163;22233.888830555905;22481.437964050867;2346.941326466852;2439.841410308342;2661.467706458716;3008.533677280025;3073.55433462149;13494;13998.72002559943;14432.350544225535;14798.408063677547;14809.407623695148;1877.3804644467293;1882.2282864025822;1892.3660573707825;1991.5519008223034;1994.6609076457037;76041.23958760397;76561.61719191368;77806;79368.60315698385;79926.60036699838;10276.537555809857;10441.269111162146;10553.683389498327;10798.67603971882;10852.457377131112;14639.560813175622;14647.560573182822;14649.12105273687;14670.853291467161;14675.853241467663;7621.004301946555;7823.804404889809;7895.486793358528;7988.081370642451;8089.878651820228;7529.134149572869;7557.848843023109;7723.575203363869;7738.4969976951315;7779.961100194576;6289.968550157311;6328.303886572473;6369.299377068519;6414.967925160345;6427.100205971168;1896.8956707381226;1953.394447721211;1965.7346258255238;1971.6648169811167;1978.3174804692646;850.2305413600701;965.4062751407834;1003.6838395905266;1021.2697920986382;1031.0565832263394;17555.385561505285;18812.81187188138;18920.81079189218;19153.425397238105;19558.511037224183;959.788846453779;970.6360114956891;986.4328011393477;995.4127065031666;998.4807899892161;10383.636572719919;10879.192282700991;10958.28771129874;10981.560737570408;11057.225994180491;433236;435957;439966;455862;460692;46000.30999535009;48489;52429.475705243225;61888.69055654693;84398.15601843903;992.8907820139779;1042.2391654092708;1051.4164638625637;1078.094400703413;1093.283899046126;12197.634070977885;15309;15747;16055;17550.73673894867;38777.806110969264;39299.41050884182;41220;42132.57867421409;42503.93740156521;50133;51288;53426.73286633542;53575.46424535705;54061.72969135129;7706.499077559941;7919.564423956507;7971.681132754857;7976.521408715495;8436.831263374821;8972.910270897208;11720.179587428798;11753.294802311888;11799.410029498662;11882.643520694393;9717.27120465982;10069.546870390703;10754.83867742;11244.83132752993;11292.661220163409;9716.417014979124;10265.486725663837;10325.32885362449;10613.41626210535;10702.625408110678;10319.329243599143;10380.688579342632;10945.671629851116;11262.704788949048;11272.210945233755;8049.195080492138;8239.176082391712;8368.790780230544;8373.655376494591;8504.91495085066;8375.078741338326;10676.359418434919;11099.944500277446;11343.092552595608;11800.3509806958 06:17:32 INFO - PROCESS | 2683 | |3;mootools.html;1458.854114588541;1502.1662977047738;1615.3780794394163;1741.6429631925457;1764.523578633768;7940.682372705092;8608.698695545658;8612.784680382994;8614.267787238085;8618.569071546413;7387.482876198668;7601.277878601538;7848.254415830487;8101.716439924604;8465.44974576652;2224.4883676754357;2243.842930994831;2247.9662805057856;2264.1283106004225;2265.161890100657;2204.3386983904843;2237.8097861681777;2269.0356598445596;2270.5231901300745;2275.4538910661404;2259.559385919746;2268.6256767633404;2272.420532764143;2275.180934863448;2287.7712228777073;2164.3074216250807;2166.7833216678364;2169.1323470611883;2174.9456263593456;2175.3147758456034;2200.460887082659;2201.625723626971;2211.1045026764027;2215.645496720533;2215.767344428844;8292.792680182984;8497.362697797627;8504.404691671585;8509.191626795444;8516.446430981967;4940.40715114185;5070.2394640803805;5070.340855688737;5076.466970968069;5079.974600127012;2980.6274215723033;3033.434382514405;3173.0639461358724;3181.2046988252937;3195.7123858852583;1063.3726101600016;1070.7376692710259;1073.4793625091825;1077.5959015369237;1087.7661302819852;11346.886531134665;11363.431828408546;11384.203105782515;11385.487653055632;11447.885521144764;4437.98071877295;4600.401947746838;4633.7683115844075;4640.489546149921;4652.744099074584;9320.114589114024;9392.8591071134;9407.247420206368;9415.199708024895;9415.952920235355;5097.668651537638;5103.387593488731;5107.438181799999;5111.105556527593;5122.436531981479;4668.649851261169;4690.273007683814;4726.598239149711;4738.407699037621;4793.712377257376;3498.177928186874;3586.569611646567;3594.4428613564937;3634.9273014539563;3684.392075307544;1102.7739313440725;1113.1929351220301;1116.9385683787307;1122.9045531129782;1129.7062763681502;812.2405550810012;877.4165180155126;917.3761841947406;922.064104933493;953.7615596100975;5638.154276858504;5680.431956804369;5742.569307301969;5879.7770700636775;6076.574639775174;892.1123482135317;929.9814003719888;960.9759756006016;965.5075911285295;997.9401235925868;3983.64147226751;4193.559676234013;4194.8112334945;4195.706300558993;4314.913701726011;10003.299769016245;10392.948035259926;10416.843747343795;10418.270721049605;10453.26827122094;10398.68803935883;10416.5833366666;10419.218558608134;10421.218408619385;10424.166066714644;7334.6699398526125;7603.7338693145475;7651.502652327692;7853.921460785434;7859.960700196577;5856.882862342644;5884.264466941632;5887.61730487517;5937.851553711192;6054.243219597551;9005;9103.499307537884;9374.812503750023;9416.387934784218;9694.36986595869;8622.82754344897;9333.766655833659;9586.856197157187;9615.807683846424;9699.6120155193;6848.14398200225;7093.858122837618;7245.420366370572;7275.308845659654;7472.925270747441;7282.745103921337;7585.279398457138;7864.134945155914;7928.722494712657;7948.721794737156;7067.646617669199;7075.50471467013;7095.254998225112;7102.467314951503;7289.01598284246;7138.928610714034;7141.714331426685;7214.96392518034;7267.709291628487;7334.523255988343;6399.8080057598345;6498.837529061811;6499.7400103995315;6507.056476810931;6507.577007494498;4846.612271018381;4933.654644174873;4941.925871112008;4977.9751101244265;5190.2214667800135;4751.548602882721;4907.190313598217;4955.578775804097;4956.801727930987;5020.447750747342 06:17:32 INFO - PROCESS | 2683 | |4;prototype.html;322.1366737144453;334.1362577736552;337.3354491651447;346.80058966094487;351.7397126126667;5155;5312.442193569677;5317.361916570012;5373.194020896867;5411.404745477994;5087.287779710843;5141.023205590945;5178.66338687985;5216.66091704039;5227;4143.97928010361;4152.397902304164;4162.313218318974;4166.895827604319;4170.541240463546;3932.547757007938;4126.112885729583;4192.203481338551;4205.179989901971;4218.101854165638;4113.71204015719;4129.194807012634;4138.627523522882;4145.129522800201;4155.39746736723;4108.548059713429;4118.052847844998;4119.423280740699;4130.132672138854;4132.73137246078;3665.9083522911874;3676;3678.1356381250384;3679.5400574928135;3697.7226707997006;5104.3619547556555;5131.666441681279;5162.586993040585;5172.431032586413;5184.948150518484;4702.294655801657;4707.529247075299;4719.457262414798;4729.574338309569;4746.006677195586;5330.241020463238;5473.808416705436;5480.725963701839;5516.613837031409;5566.86082847928;3928.351821949375;3941.487606611151;3946.579231476666;3946.7039972002217;3975.383815508601;5627.986962346817;5646.661200327993;5647.531641773127;5658.801941932013;5693.629914055615;4052.1895620875944;4080.755154690728;4114.177164567099;4116;4123.814428350672;3917.980410097988;4019.7588144711412;4080.8571699990357;4089.3865920111625;4157.97921010393;4637.791299391535;4640.443146822403;4668.323093151474;4672.159011377917;4681.953180468152;5459.918101228484;5487.396386397493;5487.478689524489;5522.641028333226;5546;1325.8143859859435;1338.3709656461447;1419.8793102586396;1437.367558274356;1439.8416174220827;893.7229458867772;903.7379160043514;915.3272344826547;938.2962777916563;957.913787759105;4756.167670657621;4758.976205118952;4764.904701906012;4785.545373189541;4799.360351806493;4967.230079337708;4980.356482360812;4995.325631039836;4997.650164488524;5004.524570165829;4440.444944381952;4724.873806786891;4737.3841400618385;4747.667663263607;4766.904661906742;2604.76557109861;2646.431017331283;2656.707762146162;2665.2137619402324;2666.346984750186;5137.537621614073;5138.199681173769;5139.8458046258675;5176.352955880515;5180.922286165711;4838.395200599925;5021.548060674557;5043.420006699203;5061.848144555669;5108.390856880071;5036.6726162799305;5094.6688465249645;5107;5112.693238405707;5129.538341549279;4942.975285123552;4968.894440974391;4969.254611808257;4970.826021089245;5054.974725126351;4910.852674419773;4930.728809915489;4936.136176169084;5210.97394513025;5625.774969001194;5896.6756828374855;5902.793402231073;5912.645241285537;5919.85200369977;5922.4373684501625;4117.114820313647;4151.7924103794085;4156.958430415657;4159.272127377757;4160.979195104005;5383.5962302826665;5551.583631227755;5604.982206405609;5664.660120392789;5817.592768506333;5378.865528361822;5389.83830485086;5523.861903452445;5530.142827861688;5548.167774833807;5542.722863856871;5553.16702494629;5556.833295001156;5560.110382338807;5578.246936663661;5318.414974352895;5495.230667706444;5514.145307477347;5515.779368825202;5595.63628364155;5561.249231353715;5567.860803479945;5587.804426845041;5593.496585307342;5594.13290939905;5473.972630136824;5474.644148130359;5483.861294095226;5485.424030476743;5522.530584900168 06:17:32 INFO - PROCESS | 2683 | |5;yui.html;726.3354031061575;757.5076200469696;767.7543186180425;776.2470403708408;826.3265438667486;15825.60435989101;17222.483325500256;17238.655226895455;17287.654246915055;17288.567785805346;14510.274486275697;14618.48835290765;14681.632959175999;14734.926325368358;14800.037997530153;656.2551504042898;663.1677245057446;794.467706636552;806.9999999999985;820.2863508747398;821.6425854753171;831.7005877883987;832.4713806732708;832.4755404095412;833.1168960901433;880.0495464897926;882.1178821178821;882.360288790628;882.704294061487;882.9028806831243;694.1254019934868;694.9270326615733;840.7015509494164;876.3733930239878;876.701921346742;625.6683957502531;628.779927025542;629.433509841142;629.4649547884308;629.527854109418;14051.859481405158;14080.366383512766;14124.223167725771;14134.15195088298;14162.575122746333;13839.238841863693;13985.58043258704;14076.366563504667;14393.928030359886;14616.123032618078;12938.288394138413;13027.544035958696;13117.934410327982;13197.406116724771;13323.333833308296;4409.338599210112;4415.315626077963;4458.08609235106;4639.86080417588;4641.628669706415;69643.30356696418;72908.90636640401;84602;84808.57595711981;85570;11642.301461912142;12156.851039272473;12295.815562766566;12613.810792838114;12865.485380584672;23184.42038949006;23424.297271081894;23673.7632623675;23707.1702490412;23885.92513336904;8550.572471376407;8665.480071195749;8676.175763302475;8743.300535957109;8859.468431894107;4455.1757924784015;4526.275795872711;4703.153432382204;4802.807887684523;5033.546980771748;3491.5635545556806;3628.6734193922675;3630.3283892479976;3631.364511210528;3631.5460567429072;574.5461085742301;590.4095904095905;593.8188852400059;599.1611743558965;604.8427408873637;557.7713137613559;591.2756872830748;651.6546230497844;653.1867824558456;655.2988302516262;8713.695020674246;9005.549722513848;9186.724398268063;9223.308251881135;9341.159295663423;516.7803683434526;598.3328588623654;616.2512547255017;632.8924382330921;657.0210386524141;4145.502539695256;4207.915841683149;4329.150675124762;4333.155034768253;4445.110977804452;77096;104212;116778;118490.4075479617;130553.34723326513;105836;109628;110319;111820.440897795;112362;96603.51698241464;96755;99552;100294;100602.99397006082;7778.805529861799;7844.686212551663;8000.799980000314;8214.137515561019;8314.708985185489;39881.40177897276;41823;53994;54095;55601.44398556124;76437.61781191059;80202.59898700469;82021.17978820135;84441;84541;11142.721431964266;11225.042620767163;11448.484818183035;11797;11910;13288;13299.80050299227;13463.326833658473;13470.191788492722;13737.969652275919;11294.322340659586;11533.884661153617;11554.48004839801;11674.533018679158;11685.182037257311;11369.943150284196;11868.169228153947;11876.703082423008;11889;12303.087743801994;11109.447522084403;11765.941170294094;11915.821262680893;12209.511619535118;12327;10006.799864002825;10161.542730576994;10284.640037598649;10363.222758293008;10420.531076101443;9923.454210018519;10163.84754228702;10188.286819922534;10298.845517317097;10392.792144157225 06:17:32 INFO - PROCESS | 2683 | __end_tp_report 06:17:32 INFO - PROCESS | 2683 | __start_cc_report 06:17:32 INFO - PROCESS | 2683 | _x_x_mozilla_cycle_collect,1313 06:17:32 INFO - PROCESS | 2683 | __end_cc_report 06:17:32 INFO - PROCESS | 2683 | __startTimestamp1475846252629__endTimestamp 06:17:32 INFO - PROCESS | 2683 | 06:17:32 INFO - PROCESS | 2683 | ------- Summary: start ------- 06:17:32 INFO - PROCESS | 2683 | Number of tests: 6 06:17:32 INFO - PROCESS | 2683 | 06:17:32 INFO - PROCESS | 2683 | [#0] dojo.html Cycles:165 Average:5110.12 Median:5296.87 stddev:563.60 (10.6%) stddev-sans-first:538.53 06:17:32 INFO - PROCESS | 2683 | Values: 2921.0 2960.4 2963.6 2977.7 3006.8 5074.9 5112.7 5128.3 5162.5 5181.8 5173.9 5199.7 5248.6 5275.2 5314.0 4620.8 4631.7 4667.5 4687.3 4704.8 4311.8 4685.1 4741.0 4745.6 4808.3 4616.6 4709.5 4719.2 4724.6 4817.8 4651.0 4675.1 4721.3 4769.7 4824.1 4677.8 4724.6 4724.9 4774.8 4792.9 5148.7 5151.3 5204.9 5214.3 5218.5 5302.4 5333.3 5369.2 5525.0 5537.0 5534.3 5547.7 5580.2 5626.6 5632.3 5196.6 5198.9 5201.8 5202.1 5262.0 5437.7 5482.3 5680.9 5683.8 5686.5 5316.4 5349.9 5363.4 5376.3 5388.6 5453.3 5467.6 5491.5 5554.4 5557.8 5296.9 5468.9 5536.4 5539.2 5599.7 5335.9 5460.5 5513.8 5527.8 5546.6 4287.1 4292.2 4296.2 4317.3 4375.4 3730.2 3813.8 3816.3 3842.7 3875.4 5086.6 5169.0 5186.8 5199.5 5234.6 5484.9 5493.9 5494.2 5497.9 5499.4 5190.9 5203.7 5204.0 5209.0 5271.6 4662.0 4703.1 4703.9 4732.3 4741.5 5672.2 5677.1 5682.5 5682.9 5735.7 5476.6 5480.4 5483.7 5484.6 5490.3 5484.3 5572.6 5601.5 5617.3 5662.9 5322.2 5351.6 5353.2 5412.7 5417.8 5460.2 5460.2 5467.8 5469.3 5526.1 5184.3 5239.1 5284.5 5315.9 5327.8 5277.9 5349.3 5352.5 5409.4 5413.8 5326.2 5327.0 5330.4 5334.1 5414.8 5250.4 5279.8 5330.2 5376.8 5399.6 5247.8 5278.4 5331.0 5392.3 5401.9 06:17:32 INFO - PROCESS | 2683 | 06:17:32 INFO - PROCESS | 2683 | [#1] ext.html Cycles:180 Average:56376.51 Median:3568.53 stddev:107756.50 (3019.6%) stddev-sans-first:107977.27 06:17:32 INFO - PROCESS | 2683 | Values: 551.1 591.8 601.3 615.8 618.2 32178.0 32920.7 42866.0 43766.0 43909.8 40845.6 45276.5 45307.0 45356.8 45390.0 8106.1 8882.2 9032.5 9048.1 9049.8 8138.8 10626.0 10861.4 10870.7 11206.3 10994.3 11015.2 11023.8 11032.7 11106.6 10842.2 10903.8 10911.5 10914.6 10925.1 10624.3 10686.9 10689.4 10696.7 10736.4 42486.4 42497.2 42834.0 42866.6 42909.8 3539.7 3597.4 3670.1 3868.8 4106.9 31966.7 32234.7 32278.8 32475.7 32495.4 4224.9 4337.9 4342.2 4494.2 4518.8 320702.0 321006.0 321533.4 322416.0 324773.0 57053.1 57351.7 57355.7 57366.0 57370.4 61210.0 61254.1 61262.4 61325.4 61351.7 16377.0 16656.9 16694.7 16696.2 16704.6 10044.8 10279.7 12527.1 12818.6 12835.2 16478.8 16678.3 16686.5 17008.2 17074.6 6409.7 6424.8 6509.4 6677.3 6748.0 952.3 1043.2 1059.3 1069.4 1113.1 31683.2 31950.0 32129.8 32261.0 32443.8 1066.3 1074.6 1091.3 1111.5 1166.2 15769.3 16799.9 16818.5 16947.7 17011.7 504782.0 509002.0 511512.0 512286.1 512530.0 56639.2 56656.0 56709.7 56771.4 56824.0 1195.9 1274.3 1302.2 1349.8 1357.0 27493.6 31106.5 31233.0 31487.8 31581.4 48676.3 49253.5 49254.8 49297.0 49382.5 365309.0 365834.0 366378.0 366879.0 366944.0 26264.6 27887.0 27965.6 28801.4 28959.0 45575.3 46565.1 46789.5 47132.8 48323.5 36928.0 36980.4 37008.0 37283.3 37555.0 38099.4 38253.4 38528.0 38887.4 39095.6 39959.2 40105.4 40542.4 40843.4 41347.4 32039.5 34260.5 34805.8 34925.7 34956.5 27527.1 27754.0 27755.7 27873.3 28203.2 06:17:32 INFO - PROCESS | 2683 | 06:17:32 INFO - PROCESS | 2683 | [#2] jquery.html Cycles:180 Average:26361.26 Median:39038.61 stddev:73010.37 (187.0%) stddev-sans-first:73189.11 06:17:32 INFO - PROCESS | 2683 | Values: 375.3 386.5 406.1 409.6 418.1 13012.2 14790.1 18403.0 19149.1 19204.6 17688.1 18405.9 18447.4 18713.3 18731.9 5576.9 5802.0 5809.5 5812.7 5814.8 5023.8 6329.3 6369.4 6444.3 6456.9 6080.8 6189.7 6418.9 6435.9 6437.4 6194.8 6227.8 6265.4 6273.3 6299.3 5348.0 5460.7 5670.4 5707.4 5728.5 22042.2 22081.4 22163.0 22233.9 22481.4 2346.9 2439.8 2661.5 3008.5 3073.6 13494.0 13998.7 14432.4 14798.4 14809.4 1877.4 1882.2 1892.4 1991.6 1994.7 76041.2 76561.6 77806.0 79368.6 79926.6 10276.5 10441.3 10553.7 10798.7 10852.5 14639.6 14647.6 14649.1 14670.9 14675.9 7621.0 7823.8 7895.5 7988.1 8089.9 7529.1 7557.8 7723.6 7738.5 7780.0 6290.0 6328.3 6369.3 6415.0 6427.1 1896.9 1953.4 1965.7 1971.7 1978.3 850.2 965.4 1003.7 1021.3 1031.1 17555.4 18812.8 18920.8 19153.4 19558.5 959.8 970.6 986.4 995.4 998.5 10383.6 10879.2 10958.3 10981.6 11057.2 433236.0 435957.0 439966.0 455862.0 460692.0 46000.3 48489.0 52429.5 61888.7 84398.2 992.9 1042.2 1051.4 1078.1 1093.3 12197.6 15309.0 15747.0 16055.0 17550.7 38777.8 39299.4 41220.0 42132.6 42503.9 50133.0 51288.0 53426.7 53575.5 54061.7 7706.5 7919.6 7971.7 7976.5 8436.8 8972.9 11720.2 11753.3 11799.4 11882.6 9717.3 10069.5 10754.8 11244.8 11292.7 9716.4 10265.5 10325.3 10613.4 10702.6 10319.3 10380.7 10945.7 11262.7 11272.2 8049.2 8239.2 8368.8 8373.7 8504.9 8375.1 10676.4 11099.9 11343.1 11800.4 06:17:32 INFO - PROCESS | 2683 | 06:17:32 INFO - PROCESS | 2683 | [#3] mootools.html Cycles:180 Average:5478.70 Median:5070.29 stddev:3049.57 (60.1%) stddev-sans-first:3043.16 06:17:32 INFO - PROCESS | 2683 | Values: 1458.9 1502.2 1615.4 1741.6 1764.5 7940.7 8608.7 8612.8 8614.3 8618.6 7387.5 7601.3 7848.3 8101.7 8465.4 2224.5 2243.8 2248.0 2264.1 2265.2 2204.3 2237.8 2269.0 2270.5 2275.5 2259.6 2268.6 2272.4 2275.2 2287.8 2164.3 2166.8 2169.1 2174.9 2175.3 2200.5 2201.6 2211.1 2215.6 2215.8 8292.8 8497.4 8504.4 8509.2 8516.4 4940.4 5070.2 5070.3 5076.5 5080.0 2980.6 3033.4 3173.1 3181.2 3195.7 1063.4 1070.7 1073.5 1077.6 1087.8 11346.9 11363.4 11384.2 11385.5 11447.9 4438.0 4600.4 4633.8 4640.5 4652.7 9320.1 9392.9 9407.2 9415.2 9416.0 5097.7 5103.4 5107.4 5111.1 5122.4 4668.6 4690.3 4726.6 4738.4 4793.7 3498.2 3586.6 3594.4 3634.9 3684.4 1102.8 1113.2 1116.9 1122.9 1129.7 812.2 877.4 917.4 922.1 953.8 5638.2 5680.4 5742.6 5879.8 6076.6 892.1 930.0 961.0 965.5 997.9 3983.6 4193.6 4194.8 4195.7 4314.9 10003.3 10392.9 10416.8 10418.3 10453.3 10398.7 10416.6 10419.2 10421.2 10424.2 7334.7 7603.7 7651.5 7853.9 7860.0 5856.9 5884.3 5887.6 5937.9 6054.2 9005.0 9103.5 9374.8 9416.4 9694.4 8622.8 9333.8 9586.9 9615.8 9699.6 6848.1 7093.9 7245.4 7275.3 7472.9 7282.7 7585.3 7864.1 7928.7 7948.7 7067.6 7075.5 7095.3 7102.5 7289.0 7138.9 7141.7 7215.0 7267.7 7334.5 6399.8 6498.8 6499.7 6507.1 6507.6 4846.6 4933.7 4941.9 4978.0 5190.2 4751.5 4907.2 4955.6 4956.8 5020.4 06:17:32 INFO - PROCESS | 2683 | 06:17:32 INFO - PROCESS | 2683 | [#4] prototype.html Cycles:180 Average:4509.58 Median:4996.49 stddev:1301.95 (26.1%) stddev-sans-first:1267.09 06:17:32 INFO - PROCESS | 2683 | Values: 322.1 334.1 337.3 346.8 351.7 5155.0 5312.4 5317.4 5373.2 5411.4 5087.3 5141.0 5178.7 5216.7 5227.0 4144.0 4152.4 4162.3 4166.9 4170.5 3932.5 4126.1 4192.2 4205.2 4218.1 4113.7 4129.2 4138.6 4145.1 4155.4 4108.5 4118.1 4119.4 4130.1 4132.7 3665.9 3676.0 3678.1 3679.5 3697.7 5104.4 5131.7 5162.6 5172.4 5184.9 4702.3 4707.5 4719.5 4729.6 4746.0 5330.2 5473.8 5480.7 5516.6 5566.9 3928.4 3941.5 3946.6 3946.7 3975.4 5628.0 5646.7 5647.5 5658.8 5693.6 4052.2 4080.8 4114.2 4116.0 4123.8 3918.0 4019.8 4080.9 4089.4 4158.0 4637.8 4640.4 4668.3 4672.2 4682.0 5459.9 5487.4 5487.5 5522.6 5546.0 1325.8 1338.4 1419.9 1437.4 1439.8 893.7 903.7 915.3 938.3 957.9 4756.2 4759.0 4764.9 4785.5 4799.4 4967.2 4980.4 4995.3 4997.7 5004.5 4440.4 4724.9 4737.4 4747.7 4766.9 2604.8 2646.4 2656.7 2665.2 2666.3 5137.5 5138.2 5139.8 5176.4 5180.9 4838.4 5021.5 5043.4 5061.8 5108.4 5036.7 5094.7 5107.0 5112.7 5129.5 4943.0 4968.9 4969.3 4970.8 5055.0 4910.9 4930.7 4936.1 5211.0 5625.8 5896.7 5902.8 5912.6 5919.9 5922.4 4117.1 4151.8 4157.0 4159.3 4161.0 5383.6 5551.6 5605.0 5664.7 5817.6 5378.9 5389.8 5523.9 5530.1 5548.2 5542.7 5553.2 5556.8 5560.1 5578.2 5318.4 5495.2 5514.1 5515.8 5595.6 5561.2 5567.9 5587.8 5593.5 5594.1 5474.0 5474.6 5483.9 5485.4 5522.5 06:17:32 INFO - PROCESS | 2683 | 06:17:32 INFO - PROCESS | 2683 | [#5] yui.html Cycles:180 Average:21314.55 Median:4371.25 stddev:31847.98 (728.6%) stddev-sans-first:31899.80 06:17:32 INFO - PROCESS | 2683 | Values: 726.3 757.5 767.8 776.2 826.3 15825.6 17222.5 17238.7 17287.7 17288.6 14510.3 14618.5 14681.6 14734.9 14800.0 656.3 663.2 794.5 807.0 820.3 821.6 831.7 832.5 832.5 833.1 880.0 882.1 882.4 882.7 882.9 694.1 694.9 840.7 876.4 876.7 625.7 628.8 629.4 629.5 629.5 14051.9 14080.4 14124.2 14134.2 14162.6 13839.2 13985.6 14076.4 14393.9 14616.1 12938.3 13027.5 13117.9 13197.4 13323.3 4409.3 4415.3 4458.1 4639.9 4641.6 69643.3 72908.9 84602.0 84808.6 85570.0 11642.3 12156.9 12295.8 12613.8 12865.5 23184.4 23424.3 23673.8 23707.2 23885.9 8550.6 8665.5 8676.2 8743.3 8859.5 4455.2 4526.3 4703.2 4802.8 5033.5 3491.6 3628.7 3630.3 3631.4 3631.5 574.5 590.4 593.8 599.2 604.8 557.8 591.3 651.7 653.2 655.3 8713.7 9005.5 9186.7 9223.3 9341.2 516.8 598.3 616.3 632.9 657.0 4145.5 4207.9 4329.2 4333.2 4445.1 77096.0 104212.0 116778.0 118490.4 130553.3 105836.0 109628.0 110319.0 111820.4 112362.0 96603.5 96755.0 99552.0 100294.0 100603.0 7778.8 7844.7 8000.8 8214.1 8314.7 39881.4 41823.0 53994.0 54095.0 55601.4 76437.6 80202.6 82021.2 84441.0 84541.0 11142.7 11225.0 11448.5 11797.0 11910.0 13288.0 13299.8 13463.3 13470.2 13738.0 11294.3 11533.9 11554.5 11674.5 11685.2 11369.9 11868.2 11876.7 11889.0 12303.1 11109.4 11765.9 11915.8 12209.5 12327.0 10006.8 10161.5 10284.6 10363.2 10420.5 9923.5 10163.8 10188.3 10298.8 10392.8 06:17:32 INFO - PROCESS | 2683 | -------- Summary: end -------- 06:17:32 INFO - PROCESS | 2683 | 06:17:33 INFO - TEST-INFO | 2683: exit 0 06:17:33 INFO - TEST-OK | dromaeo_css | took 1118296ms 06:17:33 INFO - TEST-START | kraken 06:17:33 INFO - operating with platform_type : linux_ 06:17:33 INFO - Initialising browser for kraken test... 06:17:33 INFO - TEST-INFO | started process 3095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd7Wa82/profile http://localhost:35388/getInfo.html) 06:17:38 INFO - PROCESS | 3095 | __metrics Screen width/height:1600/1200 06:17:38 INFO - PROCESS | 3095 | colorDepth:24 06:17:38 INFO - PROCESS | 3095 | Browser inner width/height: 1024/697 06:17:38 INFO - PROCESS | 3095 | __metrics 06:17:39 INFO - PROCESS | 3095 | 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" 06:17:39 INFO - PROCESS | 3095 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:17:39 INFO - PROCESS | 3095 | console.error: PushService: 06:17:39 INFO - PROCESS | 3095 | stateChangeProcessEnqueue: Error transitioning state 06:17:39 INFO - PROCESS | 3095 | UnknownError 06:17:40 INFO - TEST-INFO | 3095: exit 0 06:17:40 INFO - Browser initialized. 06:17:40 INFO - Running cycle 1/1 for kraken test... 06:17:40 INFO - TEST-INFO | started process 3178 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpd7Wa82/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:52 INFO - PROCESS | 3178 | RSS: Main: 177999872 06:17:52 INFO - PROCESS | 3178 | 06:17:55 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35388/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:56 INFO - PROCESS | 3178 | RSS: Main: 237432832 06:17:56 INFO - PROCESS | 3178 | 06:17:58 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35388/tests/kraken/driver.html?testName=audio-dft) 06:17:59 INFO - PROCESS | 3178 | RSS: Main: 222814208 06:17:59 INFO - PROCESS | 3178 | 06:18:02 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35388/tests/kraken/driver.html?testName=audio-fft) 06:18:02 INFO - PROCESS | 3178 | RSS: Main: 303927296 06:18:02 INFO - PROCESS | 3178 | 06:18:05 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35388/tests/kraken/driver.html?testName=audio-oscillator) 06:18:05 INFO - PROCESS | 3178 | RSS: Main: 215064576 06:18:05 INFO - PROCESS | 3178 | 06:18:07 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35388/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:18:08 INFO - PROCESS | 3178 | RSS: Main: 217694208 06:18:08 INFO - PROCESS | 3178 | 06:18:11 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35388/tests/kraken/driver.html?testName=imaging-darkroom) 06:18:12 INFO - PROCESS | 3178 | RSS: Main: 254025728 06:18:12 INFO - PROCESS | 3178 | 06:18:15 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35388/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:16 INFO - PROCESS | 3178 | RSS: Main: 252489728 06:18:16 INFO - PROCESS | 3178 | 06:18:18 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35388/tests/kraken/driver.html?testName=json-parse-financial) 06:18:19 INFO - PROCESS | 3178 | RSS: Main: 253685760 06:18:19 INFO - PROCESS | 3178 | 06:18:20 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35388/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:21 INFO - PROCESS | 3178 | RSS: Main: 214982656 06:18:21 INFO - PROCESS | 3178 | 06:18:23 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35388/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:23 INFO - PROCESS | 3178 | RSS: Main: 221564928 06:18:23 INFO - PROCESS | 3178 | 06:18:25 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35388/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:26 INFO - PROCESS | 3178 | RSS: Main: 228048896 06:18:26 INFO - PROCESS | 3178 | 06:18:29 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:29 INFO - PROCESS | 3178 | RSS: Main: 238280704 06:18:29 INFO - PROCESS | 3178 | 06:18:32 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:33 INFO - PROCESS | 3178 | RSS: Main: 234790912 06:18:33 INFO - PROCESS | 3178 | 06:18:34 INFO - PROCESS | 3178 | Cycle 1(1): loaded http://localhost:35388/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35388/tests/kraken/driver.html?testName=ai-astar) 06:18:35 INFO - PROCESS | 3178 | RSS: Main: 285126656 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | __start_tp_report 06:18:35 INFO - PROCESS | 3178 | _x_x_mozilla_page_load 06:18:35 INFO - PROCESS | 3178 | _x_x_mozilla_page_load_details 06:18:35 INFO - PROCESS | 3178 | |i|pagename|runs| 06:18:35 INFO - PROCESS | 3178 | |0;ai-astar;111;111;111;111;111;112;111;112;111;111 06:18:35 INFO - PROCESS | 3178 | |1;audio-beat-detection;147;124;122;164;127;125;122;126;156;128 06:18:35 INFO - PROCESS | 3178 | |2;audio-dft;164;161;160;160;160;162;162;161;162;163 06:18:35 INFO - PROCESS | 3178 | |3;audio-fft;75;74;76;110;77;76;76;76;99;75 06:18:35 INFO - PROCESS | 3178 | |4;audio-oscillator;83;82;109;82;83;82;109;83;83;122 06:18:35 INFO - PROCESS | 3178 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 06:18:35 INFO - PROCESS | 3178 | |6;imaging-darkroom;146;146;146;145;146;146;146;145;146;146 06:18:35 INFO - PROCESS | 3178 | |7;imaging-desaturate;95;95;94;95;95;95;94;94;95;94 06:18:35 INFO - PROCESS | 3178 | |8;json-parse-financial;54;50;50;51;51;51;51;51;51;52 06:18:35 INFO - PROCESS | 3178 | |9;json-stringify-tinderbox;60;61;61;60;61;61;60;61;61;62 06:18:35 INFO - PROCESS | 3178 | |10;stanford-crypto-aes;81;79;88;79;79;80;85;83;79;79 06:18:35 INFO - PROCESS | 3178 | |11;stanford-crypto-ccm;147;139;132;136;135;136;129;128;169;128 06:18:35 INFO - PROCESS | 3178 | |12;stanford-crypto-pbkdf2;174;170;168;170;168;166;167;166;164;165 06:18:35 INFO - PROCESS | 3178 | |13;stanford-crypto-sha256-iterative;67;66;68;70;67;69;65;72;66;66 06:18:35 INFO - PROCESS | 3178 | __end_tp_report 06:18:35 INFO - PROCESS | 3178 | __start_cc_report 06:18:35 INFO - PROCESS | 3178 | _x_x_mozilla_cycle_collect,1654 06:18:35 INFO - PROCESS | 3178 | __end_cc_report 06:18:35 INFO - PROCESS | 3178 | __startTimestamp1475846315237__endTimestamp 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | ------- Summary: start ------- 06:18:35 INFO - PROCESS | 3178 | Number of tests: 14 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#0] ai-astar Cycles:10 Average:111.20 Median:111.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:18:35 INFO - PROCESS | 3178 | Values: 111.0 111.0 111.0 111.0 111.0 112.0 111.0 112.0 111.0 111.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#1] audio-beat-detection Cycles:10 Average:134.10 Median:127.50 stddev:15.53 (12.2%) stddev-sans-first:15.76 06:18:35 INFO - PROCESS | 3178 | Values: 147.0 124.0 122.0 164.0 127.0 125.0 122.0 126.0 156.0 128.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.09 06:18:35 INFO - PROCESS | 3178 | Values: 164.0 161.0 160.0 160.0 160.0 162.0 162.0 161.0 162.0 163.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:12.47 (16.4%) stddev-sans-first:13.01 06:18:35 INFO - PROCESS | 3178 | Values: 75.0 74.0 76.0 110.0 77.0 76.0 76.0 76.0 99.0 75.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:82.50 stddev:15.28 (18.5%) stddev-sans-first:15.87 06:18:35 INFO - PROCESS | 3178 | Values: 83.0 82.0 109.0 82.0 83.0 82.0 109.0 83.0 83.0 122.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:18:35 INFO - PROCESS | 3178 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 06:18:35 INFO - PROCESS | 3178 | Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 145.0 146.0 146.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 06:18:35 INFO - PROCESS | 3178 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 94.0 94.0 95.0 94.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#8] json-parse-financial Cycles:10 Average:51.20 Median:51.00 stddev:1.14 (2.2%) stddev-sans-first:0.60 06:18:35 INFO - PROCESS | 3178 | Values: 54.0 50.0 50.0 51.0 51.0 51.0 51.0 51.0 51.0 52.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 06:18:35 INFO - PROCESS | 3178 | Values: 60.0 61.0 61.0 60.0 61.0 61.0 60.0 61.0 61.0 62.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.50 stddev:3.16 (3.9%) stddev-sans-first:3.35 06:18:35 INFO - PROCESS | 3178 | Values: 81.0 79.0 88.0 79.0 79.0 80.0 85.0 83.0 79.0 79.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#11] stanford-crypto-ccm Cycles:10 Average:137.90 Median:136.00 stddev:12.37 (9.1%) stddev-sans-first:12.67 06:18:35 INFO - PROCESS | 3178 | Values: 147.0 139.0 132.0 136.0 135.0 136.0 129.0 128.0 169.0 128.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:168.00 stddev:2.94 (1.7%) stddev-sans-first:2.09 06:18:35 INFO - PROCESS | 3178 | Values: 174.0 170.0 168.0 170.0 168.0 166.0 167.0 166.0 164.0 165.0 06:18:35 INFO - PROCESS | 3178 | 06:18:35 INFO - PROCESS | 3178 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.50 stddev:2.17 (3.2%) stddev-sans-first:2.29 06:18:35 INFO - PROCESS | 3178 | Values: 67.0 66.0 68.0 70.0 67.0 69.0 65.0 72.0 66.0 66.0 06:18:35 INFO - PROCESS | 3178 | -------- Summary: end -------- 06:18:35 INFO - PROCESS | 3178 | 06:18:36 INFO - TEST-INFO | 3178: exit 0 06:18:36 INFO - TEST-OK | kraken | took 62937ms 06:18:36 INFO - SUITE-END | took 1181s 06:18:36 INFO - Completed test suite (00:19:41) 06:18:36 INFO - javascript benchmark 06:18:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2921.0360581008267, 2960.4227175700735, 2963.629546306712, 2977.6724560298376, 3006.8496575171234, 5074.923876141861, 5112.74436278186, 5128.333316668837, 5162.483751624835, 5181.818636347723, 5173.922391164136, 5199.68801871887, 5248.632595718302, 5275.208718692198, 5314.043472175007, 4620.815167393317, 4631.675782695213, 4667.509911459299, 4687.320338550908, 4704.764761761915, 4311.82752689892, 4685.086408150412, 4741.028089241714, 4745.620350371962, 4808.326834243191, 4616.584507394317, 4709.481956984729, 4719.197736384788, 4724.5984091352275, 4817.831375901844, 4651.046535460223, 4675.111728771522, 4721.268203428474, 4769.713817170946, 4824.083424149436, 4677.7661116944355, 4724.622030237572, 4724.858254252378, 4774.832880849153, 4792.880177995543, 5148.6910785353, 5151.330327057459, 5204.921926171072, 5214.348206474191, 5218.530332270114, 5302.363716354023, 5333.333333333333, 5369.221462887898, 5525.0, 5537.003339398907, 5534.308211473566, 5547.694876781776, 5580.162975553659, 5626.606137570372, 5632.295963004624, 5196.558292545138, 5198.948010519922, 5201.817936372209, 5202.0896343140175, 5261.973690131601, 5437.673739575638, 5482.2873026506295, 5680.943190568124, 5683.77264909399, 5686.545076393879, 5316.441773613715, 5349.866253343697, 5363.436839131835, 5376.301080859464, 5388.622796404214, 5453.345598528202, 5467.5625949923915, 5491.505764481216, 5554.444555544414, 5557.777688892399, 5296.867578310573, 5468.890622187534, 5536.446355364431, 5539.19681646159, 5599.664020158803, 5335.946640533545, 5460.535854452337, 5513.8345849624575, 5527.806526771544, 5546.639468434539, 4287.099709061132, 4292.184484947912, 4296.2481565725875, 4317.287647538121, 4375.409319741858, 3730.179360540731, 3813.8474461021246, 3816.2939856126704, 3842.711796615265, 3875.4380614810693, 5086.567641750493, 5169.043726910533, 5186.844394668166, 5199.480051994846, 5234.555062819627, 5484.945150548523, 5493.917591236134, 5494.230807686927, 5497.862553436196, 5499.367572729107, 5190.896182076337, 5203.661761985459, 5204.0, 5209.0, 5271.551918086929, 4662.044280922402, 4703.082898834763, 4703.905921881612, 4732.337472753818, 4741.478437371887, 5672.234248376416, 5677.148427735872, 5682.48857602826, 5682.886342273214, 5735.713214339266, 5476.616636835383, 5480.3971563128825, 5483.698396588226, 5484.561235101262, 5490.3411590609385, 5484.294165697297, 5572.609917305912, 5601.495865372136, 5617.32592088952, 5662.943370566406, 5322.175062865262, 5351.625386222927, 5353.223782551586, 5412.675239485643, 5417.8103766367985, 5460.153676180198, 5460.180972854104, 5467.808626698046, 5469.316335458067, 5526.088195447706, 5184.300119483822, 5239.05696974533, 5284.471552844839, 5315.920261196163, 5327.840164795062, 5277.947220527745, 5349.2778474906945, 5352.4915133062295, 5409.432009639088, 5413.83758487246, 5326.201069839555, 5326.97336513315, 5330.440303768049, 5334.093204155225, 5414.810481633124, 5250.422453530032, 5279.841604751864, 5330.227117067926, 5376.784928602812, 5399.649022813504, 5247.842564723064, 5278.419373868948, 5330.9733451332495, 5392.325959255093, 5401.864953376197], "value": 5073.003924267038, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.1198338710717, 591.778083218793, 601.2604496469345, 615.7752420366568, 618.2179542878259, 32178.0, 32920.67079329209, 42865.99999999996, 43766.0, 43909.7804510977, 40845.59154408455, 45276.54723452764, 45307.0, 45356.77321613396, 45390.0, 8106.148854370294, 8882.156195161466, 9032.45805251687, 9048.140426659456, 9049.773755656095, 8138.755837324889, 10626.0, 10861.40262285574, 10870.673879783579, 11206.327620342765, 10994.28537145087, 11015.228933974626, 11023.779524409507, 11032.724181895477, 11106.555737770519, 10842.186835987293, 10903.83644245337, 10911.454427278684, 10914.617988370368, 10925.125989920787, 10624.256302058859, 10686.893131068746, 10689.412082335468, 10696.679099627023, 10736.355818650827, 42486.362704559455, 42497.15005699869, 42834.0, 42866.57133428657, 42909.785451072545, 3539.699125574329, 3597.3704601694863, 3670.137517683342, 3868.7678739275734, 4106.938395924063, 31966.680333196604, 32234.677653223403, 32278.838605807057, 32475.675243247737, 32495.350092998244, 4224.8732538023905, 4337.853168921642, 4342.196693611692, 4494.235979883428, 4518.796654150571, 320701.9999999977, 321006.0, 321533.3923330392, 322416.0, 324773.0, 57053.14420283699, 57351.71324143353, 57355.71322143362, 57366.0, 57370.42629573734, 61210.0, 61254.081188782206, 61262.38737612656, 61325.38674613286, 61351.6932415335, 16377.0, 16656.916715416588, 16694.66610667804, 16696.248668809934, 16704.582385440463, 10044.799104017879, 10279.691609251584, 12527.060470464752, 12818.551350702866, 12835.165714228546, 16478.75281870773, 16678.33286668544, 16686.49940501787, 17008.234629441704, 17074.573135671708, 6409.711562979677, 6424.839379015562, 6509.381608747161, 6677.332266773284, 6747.966260168668, 952.3476418653106, 1043.1915265669168, 1059.3114475590928, 1069.4278560969844, 1113.1206346985953, 31683.20791980219, 31950.0, 32129.839350803097, 32261.0, 32443.837780811416, 1066.2749330455365, 1074.5594306334365, 1091.252492042953, 1111.4720507758911, 1166.1836714300025, 15769.29038193284, 16799.91600041992, 16818.495445136665, 16947.745783813254, 17011.744823827652, 504782.0, 509002.0, 511512.0, 512286.08709998825, 512530.0, 56639.15041274384, 56656.0, 56709.7164514183, 56771.432285676616, 56824.01115960922, 1195.9461824217758, 1274.3182397417338, 1302.2316833068346, 1349.750296195207, 1357.0, 27493.587596185673, 31106.53340199944, 31233.0, 31487.84256078705, 31581.368372632878, 48676.269855952894, 49253.50746492489, 49254.75372623114, 49297.0, 49382.50617493779, 365309.0, 365834.0, 366378.0, 366879.0, 366944.0, 26264.606030909934, 27887.0, 27965.580516291866, 28801.423971520035, 28959.0, 45575.31637025514, 46565.06869862516, 46789.53210467852, 47132.7643361781, 48323.516764831904, 36928.0, 36980.44529332116, 37008.0, 37283.25433491369, 37555.0, 38099.42850857295, 38253.42619860649, 38528.03679908025, 38887.41668875026, 39095.609043910335, 39959.2008159841, 40105.39841902316, 40542.39186412147, 40843.38734919038, 41347.379789303784, 32039.519407208445, 34260.48609270913, 34805.825970870996, 34925.65074349326, 34956.47565286472, 27527.13417363875, 27754.0, 27755.722442775314, 27873.303167420978, 28203.15390538287], "value": 19942.990131819082, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.33003588594363, 386.48597365503883, 406.0761766980121, 409.62314670503133, 418.0718804254554, 13012.219266843984, 14790.1125932444, 18403.0, 19149.138288777005, 19204.615907681873, 17688.1155942203, 18405.90797046016, 18447.354342598013, 18713.25146994122, 18731.90634046831, 5576.944230557693, 5801.970990145043, 5809.477147056764, 5812.680302583356, 5814.8255552333285, 5023.773930173151, 6329.272133704614, 6369.426751592356, 6444.291127975919, 6456.935430645681, 6080.847978800543, 6189.659568723719, 6418.903716444257, 6435.871282574346, 6437.420632143107, 6194.7831825886105, 6227.782027629034, 6265.4361107500545, 6273.3412991635905, 6299.307076221612, 5347.973260133714, 5460.726963651801, 5670.376258611549, 5707.400722924116, 5728.484436400702, 22042.228522001653, 22081.356576164915, 22163.0, 22233.888830555905, 22481.437964050867, 2346.941326466852, 2439.841410308342, 2661.467706458716, 3008.533677280025, 3073.55433462149, 13494.0, 13998.72002559943, 14432.350544225535, 14798.408063677547, 14809.407623695148, 1877.3804644467293, 1882.2282864025822, 1892.3660573707825, 1991.5519008223034, 1994.6609076457037, 76041.23958760397, 76561.61719191368, 77806.0, 79368.60315698385, 79926.60036699838, 10276.537555809857, 10441.269111162146, 10553.683389498327, 10798.67603971882, 10852.457377131112, 14639.560813175622, 14647.560573182822, 14649.12105273687, 14670.853291467161, 14675.853241467663, 7621.004301946555, 7823.804404889809, 7895.486793358528, 7988.081370642451, 8089.878651820228, 7529.134149572869, 7557.848843023109, 7723.575203363869, 7738.4969976951315, 7779.961100194576, 6289.968550157311, 6328.303886572473, 6369.299377068519, 6414.967925160345, 6427.100205971168, 1896.8956707381226, 1953.394447721211, 1965.7346258255238, 1971.6648169811167, 1978.3174804692646, 850.2305413600701, 965.4062751407834, 1003.6838395905266, 1021.2697920986382, 1031.0565832263394, 17555.385561505285, 18812.81187188138, 18920.81079189218, 19153.425397238105, 19558.511037224183, 959.788846453779, 970.6360114956891, 986.4328011393477, 995.4127065031666, 998.4807899892161, 10383.636572719919, 10879.192282700991, 10958.28771129874, 10981.560737570408, 11057.225994180491, 433236.0, 435957.0, 439966.0, 455862.0, 460692.0, 46000.30999535009, 48489.0, 52429.475705243225, 61888.69055654693, 84398.15601843903, 992.8907820139779, 1042.2391654092708, 1051.4164638625637, 1078.094400703413, 1093.283899046126, 12197.634070977885, 15309.0, 15747.0, 16055.0, 17550.73673894867, 38777.806110969264, 39299.41050884182, 41220.0, 42132.57867421409, 42503.93740156521, 50133.0, 51288.0, 53426.73286633542, 53575.46424535705, 54061.72969135129, 7706.499077559941, 7919.564423956507, 7971.681132754857, 7976.521408715495, 8436.831263374821, 8972.910270897208, 11720.179587428798, 11753.294802311888, 11799.410029498662, 11882.643520694393, 9717.27120465982, 10069.546870390703, 10754.83867742, 11244.83132752993, 11292.661220163409, 9716.417014979124, 10265.486725663837, 10325.32885362449, 10613.41626210535, 10702.625408110678, 10319.329243599143, 10380.688579342632, 10945.671629851116, 11262.704788949048, 11272.210945233755, 8049.195080492138, 8239.176082391712, 8368.790780230544, 8373.655376494591, 8504.91495085066, 8375.078741338326, 10676.359418434919, 11099.944500277446, 11343.092552595608, 11800.3509806958], "value": 9019.575363446256, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1458.854114588541, 1502.1662977047738, 1615.3780794394163, 1741.6429631925457, 1764.523578633768, 7940.682372705092, 8608.698695545658, 8612.784680382994, 8614.267787238085, 8618.569071546413, 7387.482876198668, 7601.277878601538, 7848.254415830487, 8101.716439924604, 8465.44974576652, 2224.4883676754357, 2243.842930994831, 2247.9662805057856, 2264.1283106004225, 2265.161890100657, 2204.3386983904843, 2237.8097861681777, 2269.0356598445596, 2270.5231901300745, 2275.4538910661404, 2259.559385919746, 2268.6256767633404, 2272.420532764143, 2275.180934863448, 2287.7712228777073, 2164.3074216250807, 2166.7833216678364, 2169.1323470611883, 2174.9456263593456, 2175.3147758456034, 2200.460887082659, 2201.625723626971, 2211.1045026764027, 2215.645496720533, 2215.767344428844, 8292.792680182984, 8497.362697797627, 8504.404691671585, 8509.191626795444, 8516.446430981967, 4940.40715114185, 5070.2394640803805, 5070.340855688737, 5076.466970968069, 5079.974600127012, 2980.6274215723033, 3033.434382514405, 3173.0639461358724, 3181.2046988252937, 3195.7123858852583, 1063.3726101600016, 1070.7376692710259, 1073.4793625091825, 1077.5959015369237, 1087.7661302819852, 11346.886531134665, 11363.431828408546, 11384.203105782515, 11385.487653055632, 11447.885521144764, 4437.98071877295, 4600.401947746838, 4633.7683115844075, 4640.489546149921, 4652.744099074584, 9320.114589114024, 9392.8591071134, 9407.247420206368, 9415.199708024895, 9415.952920235355, 5097.668651537638, 5103.387593488731, 5107.438181799999, 5111.105556527593, 5122.436531981479, 4668.649851261169, 4690.273007683814, 4726.598239149711, 4738.407699037621, 4793.712377257376, 3498.177928186874, 3586.569611646567, 3594.4428613564937, 3634.9273014539563, 3684.392075307544, 1102.7739313440725, 1113.1929351220301, 1116.9385683787307, 1122.9045531129782, 1129.7062763681502, 812.2405550810012, 877.4165180155126, 917.3761841947406, 922.064104933493, 953.7615596100975, 5638.154276858504, 5680.431956804369, 5742.569307301969, 5879.7770700636775, 6076.574639775174, 892.1123482135317, 929.9814003719888, 960.9759756006016, 965.5075911285295, 997.9401235925868, 3983.64147226751, 4193.559676234013, 4194.8112334945, 4195.706300558993, 4314.913701726011, 10003.299769016245, 10392.948035259926, 10416.843747343795, 10418.270721049605, 10453.26827122094, 10398.68803935883, 10416.5833366666, 10419.218558608134, 10421.218408619385, 10424.166066714644, 7334.6699398526125, 7603.7338693145475, 7651.502652327692, 7853.921460785434, 7859.960700196577, 5856.882862342644, 5884.264466941632, 5887.61730487517, 5937.851553711192, 6054.243219597551, 9005.0, 9103.499307537884, 9374.812503750023, 9416.387934784218, 9694.36986595869, 8622.82754344897, 9333.766655833659, 9586.856197157187, 9615.807683846424, 9699.6120155193, 6848.14398200225, 7093.858122837618, 7245.420366370572, 7275.308845659654, 7472.925270747441, 7282.745103921337, 7585.279398457138, 7864.134945155914, 7928.722494712657, 7948.721794737156, 7067.646617669199, 7075.50471467013, 7095.254998225112, 7102.467314951503, 7289.01598284246, 7138.928610714034, 7141.714331426685, 7214.96392518034, 7267.709291628487, 7334.523255988343, 6399.8080057598345, 6498.837529061811, 6499.7400103995315, 6507.056476810931, 6507.577007494498, 4846.612271018381, 4933.654644174873, 4941.925871112008, 4977.9751101244265, 5190.2214667800135, 4751.548602882721, 4907.190313598217, 4955.578775804097, 4956.801727930987, 5020.447750747342], "value": 4413.01077362942, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.1366737144453, 334.1362577736552, 337.3354491651447, 346.80058966094487, 351.7397126126667, 5155.0, 5312.442193569677, 5317.361916570012, 5373.194020896867, 5411.404745477994, 5087.287779710843, 5141.023205590945, 5178.66338687985, 5216.66091704039, 5227.0, 4143.97928010361, 4152.397902304164, 4162.313218318974, 4166.895827604319, 4170.541240463546, 3932.547757007938, 4126.112885729583, 4192.203481338551, 4205.179989901971, 4218.101854165638, 4113.71204015719, 4129.194807012634, 4138.627523522882, 4145.129522800201, 4155.39746736723, 4108.548059713429, 4118.052847844998, 4119.423280740699, 4130.132672138854, 4132.73137246078, 3665.9083522911874, 3676.0, 3678.1356381250384, 3679.5400574928135, 3697.7226707997006, 5104.3619547556555, 5131.666441681279, 5162.586993040585, 5172.431032586413, 5184.948150518484, 4702.294655801657, 4707.529247075299, 4719.457262414798, 4729.574338309569, 4746.006677195586, 5330.241020463238, 5473.808416705436, 5480.725963701839, 5516.613837031409, 5566.86082847928, 3928.351821949375, 3941.487606611151, 3946.579231476666, 3946.7039972002217, 3975.383815508601, 5627.986962346817, 5646.661200327993, 5647.531641773127, 5658.801941932013, 5693.629914055615, 4052.1895620875944, 4080.755154690728, 4114.177164567099, 4116.0, 4123.814428350672, 3917.980410097988, 4019.7588144711412, 4080.8571699990357, 4089.3865920111625, 4157.97921010393, 4637.791299391535, 4640.443146822403, 4668.323093151474, 4672.159011377917, 4681.953180468152, 5459.918101228484, 5487.396386397493, 5487.478689524489, 5522.641028333226, 5546.0, 1325.8143859859435, 1338.3709656461447, 1419.8793102586396, 1437.367558274356, 1439.8416174220827, 893.7229458867772, 903.7379160043514, 915.3272344826547, 938.2962777916563, 957.913787759105, 4756.167670657621, 4758.976205118952, 4764.904701906012, 4785.545373189541, 4799.360351806493, 4967.230079337708, 4980.356482360812, 4995.325631039836, 4997.650164488524, 5004.524570165829, 4440.444944381952, 4724.873806786891, 4737.3841400618385, 4747.667663263607, 4766.904661906742, 2604.76557109861, 2646.431017331283, 2656.707762146162, 2665.2137619402324, 2666.346984750186, 5137.537621614073, 5138.199681173769, 5139.8458046258675, 5176.352955880515, 5180.922286165711, 4838.395200599925, 5021.548060674557, 5043.420006699203, 5061.848144555669, 5108.390856880071, 5036.6726162799305, 5094.6688465249645, 5107.0, 5112.693238405707, 5129.538341549279, 4942.975285123552, 4968.894440974391, 4969.254611808257, 4970.826021089245, 5054.974725126351, 4910.852674419773, 4930.728809915489, 4936.136176169084, 5210.97394513025, 5625.774969001194, 5896.6756828374855, 5902.793402231073, 5912.645241285537, 5919.85200369977, 5922.4373684501625, 4117.114820313647, 4151.7924103794085, 4156.958430415657, 4159.272127377757, 4160.979195104005, 5383.5962302826665, 5551.583631227755, 5604.982206405609, 5664.660120392789, 5817.592768506333, 5378.865528361822, 5389.83830485086, 5523.861903452445, 5530.142827861688, 5548.167774833807, 5542.722863856871, 5553.16702494629, 5556.833295001156, 5560.110382338807, 5578.246936663661, 5318.414974352895, 5495.230667706444, 5514.145307477347, 5515.779368825202, 5595.63628364155, 5561.249231353715, 5567.860803479945, 5587.804426845041, 5593.496585307342, 5594.13290939905, 5473.972630136824, 5474.644148130359, 5483.861294095226, 5485.424030476743, 5522.530584900168], "value": 4099.117328381825, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [726.3354031061575, 757.5076200469696, 767.7543186180425, 776.2470403708408, 826.3265438667486, 15825.60435989101, 17222.483325500256, 17238.655226895455, 17287.654246915055, 17288.567785805346, 14510.274486275697, 14618.48835290765, 14681.632959175999, 14734.926325368358, 14800.037997530153, 656.2551504042898, 663.1677245057446, 794.467706636552, 806.9999999999985, 820.2863508747398, 821.6425854753171, 831.7005877883987, 832.4713806732708, 832.4755404095412, 833.1168960901433, 880.0495464897926, 882.1178821178821, 882.360288790628, 882.704294061487, 882.9028806831243, 694.1254019934868, 694.9270326615733, 840.7015509494164, 876.3733930239878, 876.701921346742, 625.6683957502531, 628.779927025542, 629.433509841142, 629.4649547884308, 629.527854109418, 14051.859481405158, 14080.366383512766, 14124.223167725771, 14134.15195088298, 14162.575122746333, 13839.238841863693, 13985.58043258704, 14076.366563504667, 14393.928030359886, 14616.123032618078, 12938.288394138413, 13027.544035958696, 13117.934410327982, 13197.406116724771, 13323.333833308296, 4409.338599210112, 4415.315626077963, 4458.08609235106, 4639.86080417588, 4641.628669706415, 69643.30356696418, 72908.90636640401, 84602.0, 84808.57595711981, 85570.0, 11642.301461912142, 12156.851039272473, 12295.815562766566, 12613.810792838114, 12865.485380584672, 23184.42038949006, 23424.297271081894, 23673.7632623675, 23707.1702490412, 23885.92513336904, 8550.572471376407, 8665.480071195749, 8676.175763302475, 8743.300535957109, 8859.468431894107, 4455.1757924784015, 4526.275795872711, 4703.153432382204, 4802.807887684523, 5033.546980771748, 3491.5635545556806, 3628.6734193922675, 3630.3283892479976, 3631.364511210528, 3631.5460567429072, 574.5461085742301, 590.4095904095905, 593.8188852400059, 599.1611743558965, 604.8427408873637, 557.7713137613559, 591.2756872830748, 651.6546230497844, 653.1867824558456, 655.2988302516262, 8713.695020674246, 9005.549722513848, 9186.724398268063, 9223.308251881135, 9341.159295663423, 516.7803683434526, 598.3328588623654, 616.2512547255017, 632.8924382330921, 657.0210386524141, 4145.502539695256, 4207.915841683149, 4329.150675124762, 4333.155034768253, 4445.110977804452, 77096.0, 104212.0, 116778.0, 118490.4075479617, 130553.34723326513, 105836.0, 109628.0, 110319.0, 111820.440897795, 112362.0, 96603.51698241464, 96755.0, 99552.0, 100294.0, 100602.99397006082, 7778.805529861799, 7844.686212551663, 8000.799980000314, 8214.137515561019, 8314.708985185489, 39881.40177897276, 41823.0, 53994.0, 54095.0, 55601.44398556124, 76437.61781191059, 80202.59898700469, 82021.17978820135, 84441.0, 84541.0, 11142.721431964266, 11225.042620767163, 11448.484818183035, 11797.0, 11910.0, 13288.0, 13299.80050299227, 13463.326833658473, 13470.191788492722, 13737.969652275919, 11294.322340659586, 11533.884661153617, 11554.48004839801, 11674.533018679158, 11685.182037257311, 11369.943150284196, 11868.169228153947, 11876.703082423008, 11889.0, 12303.087743801994, 11109.447522084403, 11765.941170294094, 11915.821262680893, 12209.511619535118, 12327.0, 10006.799864002825, 10161.542730576994, 10284.640037598649, 10363.222758293008, 10420.531076101443, 9923.454210018519, 10163.84754228702, 10188.286819922534, 10298.845517317097, 10392.792144157225], "value": 7390.4377730064, "unit": "score"}], "name": "dromaeo_css", "value": 7042.566423406203, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 111.0, 111.0, 112.0, 111.0, 112.0, 111.0, 111.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 124.0, 122.0, 164.0, 127.0, 125.0, 122.0, 126.0, 156.0, 128.0], "value": 134.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 161.0, 160.0, 160.0, 160.0, 162.0, 162.0, 161.0, 162.0, 163.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 110.0, 77.0, 76.0, 76.0, 76.0, 99.0, 75.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 109.0, 82.0, 83.0, 82.0, 109.0, 83.0, 83.0, 122.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0, 146.0, 146.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 50.0, 50.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0, 52.0], "value": 51.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 61.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 88.0, 79.0, 79.0, 80.0, 85.0, 83.0, 79.0, 79.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 139.0, 132.0, 136.0, 135.0, 136.0, 129.0, 128.0, 169.0, 128.0], "value": 137.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 170.0, 168.0, 170.0, 168.0, 166.0, 167.0, 166.0, 164.0, 165.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 68.0, 70.0, 67.0, 69.0, 65.0, 72.0, 66.0, 66.0], "value": 67.6, "unit": "score"}], "name": "kraken", "value": 1503.8000000000002, "alertThreshold": 2.0}]} 06:18:36 INFO - Return code: 0 06:18:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:18:37 INFO - # TBPL SUCCESS # 06:18:37 INFO - Running post-action listener: _resource_record_post_action 06:18:37 INFO - [mozharness: 2016-10-07 13:18:37.060575Z] Finished run-tests step (success) 06:18:37 INFO - Running post-run listener: _resource_record_post_run 06:18:37 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 399712256; Read time: 8; Write time: 757912 06:18:37 INFO - TinderboxPrint: CPU usage
13.1% 06:18:37 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 06:18:37 INFO - TinderboxPrint: I/O write bytes / time
399,712,256 / 757,912 06:18:37 INFO - TinderboxPrint: CPU idle
8,307.8 (86.8%) 06:18:37 INFO - TinderboxPrint: CPU user
1,202.6 (12.6%) 06:18:37 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:37 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 112709632; Read time: 0; Write time: 214688 06:18:37 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 287002624; Read time: 0; Write time: 543224 06:18:37 INFO - Running post-run listener: _upload_blobber_files 06:18:37 INFO - Blob upload gear active. 06:18:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18:37 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 06:18:37 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18:37 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:38 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:18:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:18:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:38 INFO - (blobuploader) - INFO - Done attempting. 06:18:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:42 INFO - (blobuploader) - INFO - Done attempting. 06:18:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:18:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:18:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:45 INFO - (blobuploader) - INFO - Done attempting. 06:18:45 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:45 INFO - Return code: 0 06:18:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10411bcabffc2ae05784b1b6bcd3faef8707da84cae4b5a4b6aa0a6b1e7bf15b3710d9daa8a834680691faf8cfc75be43149668165ecfe4bdad118f9cd61b921", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d414fe66107cc346ed3cd0d21663dcc141259724ff18efeac309307e65d4d7d8ed59036cbfe49d9e7d8c32fda28cb6e40e2061e0641fd40b1529b2f52df974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbb9df6ea974d439d72747f82ca3a13530904d0ebdd624d4ac22dca43fb9d4323b04ee05e3a58c65bba6e74b63ac6503cf172883a24b046d1feb26383785a3f0"} 06:18:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:45 INFO - Contents: 06:18:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10411bcabffc2ae05784b1b6bcd3faef8707da84cae4b5a4b6aa0a6b1e7bf15b3710d9daa8a834680691faf8cfc75be43149668165ecfe4bdad118f9cd61b921", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d414fe66107cc346ed3cd0d21663dcc141259724ff18efeac309307e65d4d7d8ed59036cbfe49d9e7d8c32fda28cb6e40e2061e0641fd40b1529b2f52df974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbb9df6ea974d439d72747f82ca3a13530904d0ebdd624d4ac22dca43fb9d4323b04ee05e3a58c65bba6e74b63ac6503cf172883a24b046d1feb26383785a3f0"} 06:18:45 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:45 INFO - Copying logs to upload dir... 06:18:45 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.493814 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-10-07 06:18:45.087437) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 06:18:45.091707) ========= 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=8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554 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/sha512/10411bcabffc2ae05784b1b6bcd3faef8707da84cae4b5a4b6aa0a6b1e7bf15b3710d9daa8a834680691faf8cfc75be43149668165ecfe4bdad118f9cd61b921", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d414fe66107cc346ed3cd0d21663dcc141259724ff18efeac309307e65d4d7d8ed59036cbfe49d9e7d8c32fda28cb6e40e2061e0641fd40b1529b2f52df974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbb9df6ea974d439d72747f82ca3a13530904d0ebdd624d4ac22dca43fb9d4323b04ee05e3a58c65bba6e74b63ac6503cf172883a24b046d1feb26383785a3f0"} build_url:https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011499 build_url: 'https://queue.taskcluster.net/v1/task/HT4bSp0_Tr-GWcOg6-APTw/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/sha512/10411bcabffc2ae05784b1b6bcd3faef8707da84cae4b5a4b6aa0a6b1e7bf15b3710d9daa8a834680691faf8cfc75be43149668165ecfe4bdad118f9cd61b921", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/11d414fe66107cc346ed3cd0d21663dcc141259724ff18efeac309307e65d4d7d8ed59036cbfe49d9e7d8c32fda28cb6e40e2061e0641fd40b1529b2f52df974", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bbb9df6ea974d439d72747f82ca3a13530904d0ebdd624d4ac22dca43fb9d4323b04ee05e3a58c65bba6e74b63ac6503cf172883a24b046d1feb26383785a3f0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 06:18:45.120481) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 06:18:45.120883) ========= 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=8783db0840cc980e80bb0bd400000236-1475844071.974171-1474586554 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 06:18:45.200987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 06:18:45.204367) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 06:18:45.204727) ========= ========= Total master_lag: 0.19 =========