builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-040 starttime: 1475967359.67 results: success (0) buildid: 20161008142718 builduid: 4806348b5c71422d85cfa3c96283e40a revision: 45b16e0dbff0b07763c0d9b3ff6f5a4069198ee5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 15:55:59.666305) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-08 15:55:59.666732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 15:55:59.667002) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-08 15:55:59.690743) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 15:55:59.690992) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-08 15:55:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 70.8M=0s 2016-10-08 15:56:00 (70.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110661 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 15:55:59.815597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 15:55:59.815902) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021248 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 15:55:59.864994) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 15:55:59.865366) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45b16e0dbff0b07763c0d9b3ff6f5a4069198ee5 --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 45b16e0dbff0b07763c0d9b3ff6f5a4069198ee5 --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=9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-08 15:56:00,167 truncating revision to first 12 chars 2016-10-08 15:56:00,167 Setting DEBUG logging. 2016-10-08 15:56:00,167 attempt 1/10 2016-10-08 15:56:00,167 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45b16e0dbff0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-08 15:56:00,476 unpacking tar archive at: mozilla-central-45b16e0dbff0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.735815 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 15:56:00.614291) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 15:56:00.614647) ========= script_repo_revision: 45b16e0dbff0b07763c0d9b3ff6f5a4069198ee5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-08 15:56:00.615056) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 15:56:00.615335) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-08 15:56:00.626327) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-08 15:56:00.626749) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:56:01 INFO - MultiFileLogger online at 20161008 15:56:01 in /builds/slave/test 15:56:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:56:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:56:01 INFO - {'append_to_log': False, 15:56:01 INFO - 'base_work_dir': '/builds/slave/test', 15:56:01 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:56:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:56:01 INFO - 'branch': 'Firefox-Non-PGO', 15:56:01 INFO - 'buildbot_json_path': 'buildprops.json', 15:56:01 INFO - 'config_files': ('talos/linux_config.py',), 15:56:01 INFO - 'default_actions': ('clobber', 15:56:01 INFO - 'read-buildbot-config', 15:56:01 INFO - 'download-and-extract', 15:56:01 INFO - 'populate-webroot', 15:56:01 INFO - 'create-virtualenv', 15:56:01 INFO - 'install', 15:56:01 INFO - 'run-tests'), 15:56:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:56:01 INFO - 'download_minidump_stackwalk': True, 15:56:01 INFO - 'download_symbols': 'ondemand', 15:56:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:56:01 INFO - 'tooltool.py': '/tools/tooltool.py', 15:56:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:56:01 INFO - '/tools/misc-python/virtualenv.py')}, 15:56:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:56:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:56:01 INFO - 'installer_path': 'installer.exe', 15:56:01 INFO - 'log_level': 'info', 15:56:01 INFO - 'log_name': 'talos', 15:56:01 INFO - 'log_to_console': True, 15:56:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:56:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:56:01 INFO - 'opt_config_files': (), 15:56:01 INFO - 'pip_index': False, 15:56:01 INFO - 'sps_profile': False, 15:56:01 INFO - 'sps_profile_interval': 0, 15:56:01 INFO - 'suite': 'dromaeojs-e10s', 15:56:01 INFO - 'system_bits': '32', 15:56:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:56:01 INFO - 'title': 'talos-linux64-ix-040', 15:56:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:56:01 INFO - 'use_talos_json': True, 15:56:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:56:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:56:01 INFO - 'work_dir': 'build'} 15:56:01 INFO - [mozharness: 2016-10-08 22:56:01.025201Z] Running clobber step. 15:56:01 INFO - Running pre-action listener: _resource_record_pre_action 15:56:01 INFO - Running main action method: clobber 15:56:01 INFO - rmtree: /builds/slave/test/build 15:56:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:56:01 INFO - Running post-action listener: _resource_record_post_action 15:56:01 INFO - [mozharness: 2016-10-08 22:56:01.474437Z] Finished clobber step (success) 15:56:01 INFO - [mozharness: 2016-10-08 22:56:01.474541Z] Running read-buildbot-config step. 15:56:01 INFO - Running pre-action listener: _resource_record_pre_action 15:56:01 INFO - Running main action method: read_buildbot_config 15:56:01 INFO - Using buildbot properties: 15:56:01 INFO - { 15:56:01 INFO - "project": "", 15:56:01 INFO - "product": "firefox", 15:56:01 INFO - "script_repo_revision": "production", 15:56:01 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:56:01 INFO - "repository": "", 15:56:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:56:01 INFO - "buildid": "20161008142718", 15:56:01 INFO - "pgo_build": "False", 15:56:01 INFO - "basedir": "/builds/slave/test", 15:56:01 INFO - "buildnumber": 481, 15:56:01 INFO - "slavename": "talos-linux64-ix-040", 15:56:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:56:01 INFO - "platform": "ubuntu64_hw", 15:56:01 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:56:01 INFO - "branch": "mozilla-central", 15:56:01 INFO - "repo_path": "mozilla-central", 15:56:01 INFO - "revision": "45b16e0dbff0b07763c0d9b3ff6f5a4069198ee5", 15:56:01 INFO - "stage_platform": "linux64", 15:56:01 INFO - "builduid": "4806348b5c71422d85cfa3c96283e40a", 15:56:01 INFO - "slavebuilddir": "test" 15:56:01 INFO - } 15:56:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:56:01 INFO - Running post-action listener: _resource_record_post_action 15:56:01 INFO - [mozharness: 2016-10-08 22:56:01.477075Z] Finished read-buildbot-config step (success) 15:56:01 INFO - [mozharness: 2016-10-08 22:56:01.477163Z] Running download-and-extract step. 15:56:01 INFO - Running pre-action listener: _resource_record_pre_action 15:56:01 INFO - Running main action method: download_and_extract 15:56:01 INFO - mkdir: /builds/slave/test/build/tests 15:56:01 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')]} 15:56:01 INFO - trying https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:56:01 INFO - Downloading https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/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 15:56:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/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 15:56:02 INFO - Downloaded 1361 bytes. 15:56:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:56:02 INFO - Using the following test package requirements: 15:56:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:56:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:56:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:56:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:02 INFO - u'jsshell-linux-x86_64.zip'], 15:56:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:56:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:56:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:56:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:56:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:56:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:56:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:56:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:56:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:56:02 INFO - Fetch https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:56:02 INFO - Http code: 200 15:56:02 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 15:56:02 INFO - x-amz-cf-id: WL5C4xDVSII4ekl59XEDGKFe05EZNmfZkiroUjth_hCRkWJZ31j7zQ== 15:56:02 INFO - x-amz-version-id: PKCAbyryYSkyzoqzZF9RLy5NuxZ7m3ys 15:56:03 INFO - Expected file size: 20538438 15:56:03 INFO - Obtained file size: 20538438 15:56:07 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 15:56:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:56:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:56:07 INFO - Fetch https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:56:08 INFO - Http code: 200 15:56:08 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 15:56:08 INFO - x-amz-cf-id: irQXriSfGRn1xiMa-fOps3sECSz9lw2C6k7wfae2eWgZLGVvTrBA4Q== 15:56:08 INFO - x-amz-version-id: PKCAbyryYSkyzoqzZF9RLy5NuxZ7m3ys 15:56:08 INFO - Expected file size: 20538438 15:56:08 INFO - Obtained file size: 20538438 15:56:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:56:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:56:13 INFO - Fetch https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:56:13 INFO - Http code: 200 15:56:13 INFO - via: 1.1 49c80a47c1441dd194a8337982f1cd7e.cloudfront.net (CloudFront) 15:56:13 INFO - x-amz-cf-id: xDpVxbPZtcVwIfJuD7lLDhiftSNYHuT6gdmgaeafJmkGQU4sG4Ep4Q== 15:56:13 INFO - x-amz-version-id: SHVwTbXCt6HHBP90wkLHQXmLzDAl1jBg 15:56:14 INFO - Expected file size: 14409006 15:56:14 INFO - Obtained file size: 14409006 15:56:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:14 INFO - trying https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:56:14 INFO - Downloading https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/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 15:56:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/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 15:56:15 INFO - Downloaded 55861393 bytes. 15:56:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:56:15 INFO - mkdir: /builds/slave/test/properties 15:56:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:56:15 INFO - Writing to file /builds/slave/test/properties/build_url 15:56:15 INFO - Contents: 15:56:15 INFO - build_url:https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:56:16 INFO - Running post-action listener: _resource_record_post_action 15:56:16 INFO - Running post-action listener: set_extra_try_arguments 15:56:16 INFO - [mozharness: 2016-10-08 22:56:16.108157Z] Finished download-and-extract step (success) 15:56:16 INFO - [mozharness: 2016-10-08 22:56:16.108383Z] Running populate-webroot step. 15:56:16 INFO - Running pre-action listener: _resource_record_pre_action 15:56:16 INFO - Running main action method: populate_webroot 15:56:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:56:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:56:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:56:16 INFO - '--tppagecycles', 15:56:16 INFO - '7'], 15:56:16 INFO - 'tests': ['tsvgm']}}, 15:56:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:56:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:56:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:56:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:56:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['damp', 'tps']}, 15:56:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:16 INFO - 'tests': ['damp', 'tps']}, 15:56:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['dromaeo_dom']}, 15:56:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:56:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['basic_compositor_video']}, 15:56:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:56:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['a11yr', 15:56:16 INFO - 'ts_paint', 15:56:16 INFO - 'tpaint', 15:56:16 INFO - 'sessionrestore', 15:56:16 INFO - 'sessionrestore_no_auto_restore', 15:56:16 INFO - 'tabpaint']}, 15:56:16 INFO - 'other-e10s': {'tests': ['a11yr', 15:56:16 INFO - 'ts_paint', 15:56:16 INFO - 'tpaint', 15:56:16 INFO - 'sessionrestore', 15:56:16 INFO - 'sessionrestore_no_auto_restore', 15:56:16 INFO - 'tabpaint']}, 15:56:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:56:16 INFO - 'ts_paint', 15:56:16 INFO - 'tpaint', 15:56:16 INFO - 'sessionrestore', 15:56:16 INFO - 'sessionrestore_no_auto_restore', 15:56:16 INFO - 'tabpaint']}, 15:56:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:56:16 INFO - 'ts_paint', 15:56:16 INFO - 'tpaint', 15:56:16 INFO - 'sessionrestore', 15:56:16 INFO - 'sessionrestore_no_auto_restore', 15:56:16 INFO - 'tabpaint']}, 15:56:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['a11yr', 15:56:16 INFO - 'ts_paint', 15:56:16 INFO - 'tpaint', 15:56:16 INFO - 'sessionrestore', 15:56:16 INFO - 'sessionrestore_no_auto_restore', 15:56:16 INFO - 'tabpaint']}, 15:56:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['a11yr', 15:56:16 INFO - 'ts_paint', 15:56:16 INFO - 'tpaint', 15:56:16 INFO - 'sessionrestore', 15:56:16 INFO - 'sessionrestore_no_auto_restore', 15:56:16 INFO - 'tabpaint']}, 15:56:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['tsvgx', 15:56:16 INFO - 'tsvgr_opacity', 15:56:16 INFO - 'tart', 15:56:16 INFO - 'tscrollx', 15:56:16 INFO - 'cart']}, 15:56:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:56:16 INFO - 'tsvgr_opacity', 15:56:16 INFO - 'tart', 15:56:16 INFO - 'tscrollx', 15:56:16 INFO - 'cart']}, 15:56:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-e10s'], 15:56:16 INFO - 'tests': ['tp5o']}, 15:56:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:16 INFO - 'tests': ['tp5o']}, 15:56:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:16 INFO - 'talos_options': ['--disable-e10s', 15:56:16 INFO - '--xperf_path', 15:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:16 INFO - 'tests': ['tp5n']}, 15:56:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:16 INFO - 'talos_options': ['--xperf_path', 15:56:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:16 INFO - 'tests': ['tp5n']}}, 15:56:16 INFO - 'talos.zip': {'path': '', 15:56:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:56:16 INFO - Running post-action listener: _resource_record_post_action 15:56:16 INFO - [mozharness: 2016-10-08 22:56:16.127148Z] Finished populate-webroot step (success) 15:56:16 INFO - [mozharness: 2016-10-08 22:56:16.127237Z] Running create-virtualenv step. 15:56:16 INFO - Running pre-action listener: _resource_record_pre_action 15:56:16 INFO - Running main action method: create_virtualenv 15:56:16 INFO - Creating virtualenv /builds/slave/test/build/venv 15:56:16 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 15:56:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:56:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:56:16 INFO - Using real prefix '/usr' 15:56:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:56:16 INFO - Installing distribute.............................................................................................................................................................................................done. 15:56:18 INFO - Installing pip.................done. 15:56:18 INFO - Return code: 0 15:56:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:56:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:56:18 INFO - Reading from file tmpfile_stdout 15:56:18 INFO - Output received: 15:56: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) 15:56:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56: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')]} 15:56:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56: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 0x7fcbd828af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', '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 15:56: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 15:56: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 15:56:18 INFO - Using env: {'DISPLAY': ':0', 15:56:18 INFO - 'HOME': '/home/cltbld', 15:56:18 INFO - 'LANG': 'en_US.UTF-8', 15:56:18 INFO - 'LANGUAGE': 'en_US:en', 15:56:18 INFO - 'LOGNAME': 'cltbld', 15:56:18 INFO - 'MAIL': '/var/mail/cltbld', 15:56:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:18 INFO - 'MOZ_NO_REMOTE': '1', 15:56:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:18 INFO - 'NO_EM_RESTART': '1', 15:56:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:18 INFO - 'PWD': '/builds/slave/test', 15:56:18 INFO - 'SHELL': '/bin/bash', 15:56:18 INFO - 'SHLVL': '1', 15:56:18 INFO - 'TERM': 'linux', 15:56:18 INFO - 'TMOUT': '86400', 15:56:18 INFO - 'USER': 'cltbld', 15:56:18 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:18 INFO - '_': '/tools/buildbot/bin/python'} 15:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:19 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 15:56:19 INFO - Cleaning up... 15:56:19 INFO - Return code: 0 15:56:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:56:19 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')]} 15:56:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:19 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')]} 15:56:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:19 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 0x7fcbd828af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', '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 15:56:19 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 15:56:19 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 15:56:19 INFO - Using env: {'DISPLAY': ':0', 15:56:19 INFO - 'HOME': '/home/cltbld', 15:56:19 INFO - 'LANG': 'en_US.UTF-8', 15:56:19 INFO - 'LANGUAGE': 'en_US:en', 15:56:19 INFO - 'LOGNAME': 'cltbld', 15:56:19 INFO - 'MAIL': '/var/mail/cltbld', 15:56:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:19 INFO - 'MOZ_NO_REMOTE': '1', 15:56:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:19 INFO - 'NO_EM_RESTART': '1', 15:56:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:19 INFO - 'PWD': '/builds/slave/test', 15:56:19 INFO - 'SHELL': '/bin/bash', 15:56:19 INFO - 'SHLVL': '1', 15:56:19 INFO - 'TERM': 'linux', 15:56:19 INFO - 'TMOUT': '86400', 15:56:19 INFO - 'USER': 'cltbld', 15:56:19 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:19 INFO - '_': '/tools/buildbot/bin/python'} 15:56:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:19 INFO - Downloading/unpacking psutil>=3.1.1 15:56:19 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 15:56:19 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 15:56:19 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 15:56:19 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 15:56:19 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 15:56:19 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 15:56:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:56:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:21 INFO - Installing collected packages: psutil 15:56:21 INFO - Running setup.py install for psutil 15:56:21 INFO - building 'psutil._psutil_linux' extension 15:56:21 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 15:56: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 15:56:21 INFO - building 'psutil._psutil_posix' extension 15:56: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 15:56: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 15:56:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:22 INFO - Successfully installed psutil 15:56:22 INFO - Cleaning up... 15:56:22 INFO - Return code: 0 15:56:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd828af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', '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 15:56:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:56:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:56:22 INFO - Using env: {'DISPLAY': ':0', 15:56:22 INFO - 'HOME': '/home/cltbld', 15:56:22 INFO - 'LANG': 'en_US.UTF-8', 15:56:22 INFO - 'LANGUAGE': 'en_US:en', 15:56:22 INFO - 'LOGNAME': 'cltbld', 15:56:22 INFO - 'MAIL': '/var/mail/cltbld', 15:56:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:22 INFO - 'MOZ_NO_REMOTE': '1', 15:56:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:22 INFO - 'NO_EM_RESTART': '1', 15:56:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:22 INFO - 'PWD': '/builds/slave/test', 15:56:22 INFO - 'SHELL': '/bin/bash', 15:56:22 INFO - 'SHLVL': '1', 15:56:22 INFO - 'TERM': 'linux', 15:56:22 INFO - 'TMOUT': '86400', 15:56:22 INFO - 'USER': 'cltbld', 15:56:22 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:22 INFO - '_': '/tools/buildbot/bin/python'} 15:56:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:56:22 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 15:56:22 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 15:56:22 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 15:56:22 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 15:56:22 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 15:56:22 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 15:56:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:56:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:56:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:56:24 INFO - Installing collected packages: mozsystemmonitor 15:56:24 INFO - Running setup.py install for mozsystemmonitor 15:56:24 INFO - Successfully installed mozsystemmonitor 15:56:24 INFO - Cleaning up... 15:56:24 INFO - Return code: 0 15:56:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:56:24 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')]} 15:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:24 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')]} 15:56:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcbd828af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', '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 15:56:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:56:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:56:24 INFO - Using env: {'DISPLAY': ':0', 15:56:24 INFO - 'HOME': '/home/cltbld', 15:56:24 INFO - 'LANG': 'en_US.UTF-8', 15:56:24 INFO - 'LANGUAGE': 'en_US:en', 15:56:24 INFO - 'LOGNAME': 'cltbld', 15:56:24 INFO - 'MAIL': '/var/mail/cltbld', 15:56:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:24 INFO - 'MOZ_NO_REMOTE': '1', 15:56:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:24 INFO - 'NO_EM_RESTART': '1', 15:56:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:24 INFO - 'PWD': '/builds/slave/test', 15:56:24 INFO - 'SHELL': '/bin/bash', 15:56:24 INFO - 'SHLVL': '1', 15:56:24 INFO - 'TERM': 'linux', 15:56:24 INFO - 'TMOUT': '86400', 15:56:24 INFO - 'USER': 'cltbld', 15:56:24 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:24 INFO - '_': '/tools/buildbot/bin/python'} 15:56:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:24 INFO - Downloading/unpacking jsonschema==2.5.1 15:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:56:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56:26 INFO - Downloading functools32-3.2.3-2.tar.gz 15:56:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:56:26 INFO - warning: no files found matching '*.txt' 15:56:26 INFO - no previously-included directories found matching 'build' 15:56:26 INFO - no previously-included directories found matching 'dist' 15:56:26 INFO - no previously-included directories found matching '.git*' 15:56:26 INFO - Installing collected packages: jsonschema, functools32 15:56:27 INFO - Running setup.py install for functools32 15:56:27 INFO - warning: no files found matching '*.txt' 15:56:27 INFO - no previously-included directories found matching 'build' 15:56:27 INFO - no previously-included directories found matching 'dist' 15:56:27 INFO - no previously-included directories found matching '.git*' 15:56:27 INFO - Successfully installed jsonschema functools32 15:56:27 INFO - Cleaning up... 15:56:27 INFO - Return code: 0 15:56:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:27 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 0x7fcbd828af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', '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 15:56:27 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 15:56:27 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 15:56:27 INFO - Using env: {'DISPLAY': ':0', 15:56:27 INFO - 'HOME': '/home/cltbld', 15:56:27 INFO - 'LANG': 'en_US.UTF-8', 15:56:27 INFO - 'LANGUAGE': 'en_US:en', 15:56:27 INFO - 'LOGNAME': 'cltbld', 15:56:27 INFO - 'MAIL': '/var/mail/cltbld', 15:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:27 INFO - 'MOZ_NO_REMOTE': '1', 15:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:27 INFO - 'NO_EM_RESTART': '1', 15:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:27 INFO - 'PWD': '/builds/slave/test', 15:56:27 INFO - 'SHELL': '/bin/bash', 15:56:27 INFO - 'SHLVL': '1', 15:56:27 INFO - 'TERM': 'linux', 15:56:27 INFO - 'TMOUT': '86400', 15:56:27 INFO - 'USER': 'cltbld', 15:56:27 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:27 INFO - '_': '/tools/buildbot/bin/python'} 15:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:56:27 INFO - Cleaning up... 15:56:27 INFO - Return code: 0 15:56:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:27 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 0x7fcbd828af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', '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 15:56:27 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 15:56:27 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 15:56:27 INFO - Using env: {'DISPLAY': ':0', 15:56:27 INFO - 'HOME': '/home/cltbld', 15:56:27 INFO - 'LANG': 'en_US.UTF-8', 15:56:27 INFO - 'LANGUAGE': 'en_US:en', 15:56:27 INFO - 'LOGNAME': 'cltbld', 15:56:27 INFO - 'MAIL': '/var/mail/cltbld', 15:56:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:27 INFO - 'MOZ_NO_REMOTE': '1', 15:56:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:27 INFO - 'NO_EM_RESTART': '1', 15:56:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:27 INFO - 'PWD': '/builds/slave/test', 15:56:27 INFO - 'SHELL': '/bin/bash', 15:56:27 INFO - 'SHLVL': '1', 15:56:27 INFO - 'TERM': 'linux', 15:56:27 INFO - 'TMOUT': '86400', 15:56:27 INFO - 'USER': 'cltbld', 15:56:27 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:27 INFO - '_': '/tools/buildbot/bin/python'} 15:56:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:27 INFO - Downloading/unpacking blobuploader==1.2.4 15:56:27 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 15:56:27 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 15:56:27 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 15:56:27 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 15:56:27 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 15:56:27 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 15:56:29 INFO - Downloading blobuploader-1.2.4.tar.gz 15:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:56:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:56:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:30 INFO - Downloading docopt-0.6.1.tar.gz 15:56:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:56:30 INFO - Installing collected packages: blobuploader, requests, docopt 15:56:30 INFO - Running setup.py install for blobuploader 15:56:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:56:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:56:30 INFO - Running setup.py install for requests 15:56:30 INFO - Running setup.py install for docopt 15:56:30 INFO - Successfully installed blobuploader requests docopt 15:56:30 INFO - Cleaning up... 15:56:30 INFO - Return code: 0 15:56:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56: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')]} 15:56:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56: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 0x7fcbd828af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', '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 15:56: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 15:56: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 15:56:30 INFO - Using env: {'DISPLAY': ':0', 15:56:30 INFO - 'HOME': '/home/cltbld', 15:56:30 INFO - 'LANG': 'en_US.UTF-8', 15:56:30 INFO - 'LANGUAGE': 'en_US:en', 15:56:30 INFO - 'LOGNAME': 'cltbld', 15:56:30 INFO - 'MAIL': '/var/mail/cltbld', 15:56:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:30 INFO - 'MOZ_NO_REMOTE': '1', 15:56:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:30 INFO - 'NO_EM_RESTART': '1', 15:56:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:30 INFO - 'PWD': '/builds/slave/test', 15:56:30 INFO - 'SHELL': '/bin/bash', 15:56:30 INFO - 'SHLVL': '1', 15:56:30 INFO - 'TERM': 'linux', 15:56:30 INFO - 'TMOUT': '86400', 15:56:30 INFO - 'USER': 'cltbld', 15:56:30 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:30 INFO - '_': '/tools/buildbot/bin/python'} 15:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:31 INFO - Running setup.py (path:/tmp/pip-m0rwG7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:31 INFO - Running setup.py (path:/tmp/pip-og2DiF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:31 INFO - Running setup.py (path:/tmp/pip-Zrglng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:31 INFO - Running setup.py (path:/tmp/pip-FLC1kN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:31 INFO - Running setup.py (path:/tmp/pip-xmG0hp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:31 INFO - Running setup.py (path:/tmp/pip-B9B7M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:31 INFO - Running setup.py (path:/tmp/pip-PTpBdI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:31 INFO - Running setup.py (path:/tmp/pip-3YUcgs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:31 INFO - Running setup.py (path:/tmp/pip-TFPY4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:31 INFO - Running setup.py (path:/tmp/pip-ZVkfnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:31 INFO - Running setup.py (path:/tmp/pip-HNGGq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:31 INFO - Running setup.py (path:/tmp/pip-tdxp2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:32 INFO - Running setup.py (path:/tmp/pip-TjASma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:32 INFO - Running setup.py (path:/tmp/pip-e5xE2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:32 INFO - Running setup.py (path:/tmp/pip-K5Kktb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:32 INFO - Running setup.py (path:/tmp/pip-PnL9iL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:32 INFO - Running setup.py (path:/tmp/pip-mG5dkZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:56:32 INFO - Running setup.py install for manifestparser 15:56:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:56:32 INFO - Running setup.py install for mozcrash 15:56:32 INFO - Running setup.py install for mozdebug 15:56:32 INFO - Running setup.py install for mozdevice 15:56:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:56:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:56:32 INFO - Running setup.py install for mozfile 15:56:32 INFO - Running setup.py install for mozhttpd 15:56:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozinfo 15:56:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozInstall 15:56:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozleak 15:56:33 INFO - Running setup.py install for mozlog 15:56:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for moznetwork 15:56:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozprocess 15:56:33 INFO - Running setup.py install for mozprofile 15:56:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozrunner 15:56:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:56:33 INFO - Running setup.py install for mozscreenshot 15:56:33 INFO - Running setup.py install for moztest 15:56:34 INFO - Running setup.py install for mozversion 15:56:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:56:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:56:34 INFO - Cleaning up... 15:56:34 INFO - Return code: 0 15:56:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:34 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 0x7fcbd828af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', '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 15:56:34 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 15:56:34 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 15:56:34 INFO - Using env: {'DISPLAY': ':0', 15:56:34 INFO - 'HOME': '/home/cltbld', 15:56:34 INFO - 'LANG': 'en_US.UTF-8', 15:56:34 INFO - 'LANGUAGE': 'en_US:en', 15:56:34 INFO - 'LOGNAME': 'cltbld', 15:56:34 INFO - 'MAIL': '/var/mail/cltbld', 15:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:34 INFO - 'MOZ_NO_REMOTE': '1', 15:56:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:34 INFO - 'NO_EM_RESTART': '1', 15:56:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:34 INFO - 'PWD': '/builds/slave/test', 15:56:34 INFO - 'SHELL': '/bin/bash', 15:56:34 INFO - 'SHLVL': '1', 15:56:34 INFO - 'TERM': 'linux', 15:56:34 INFO - 'TMOUT': '86400', 15:56:34 INFO - 'USER': 'cltbld', 15:56:34 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:34 INFO - '_': '/tools/buildbot/bin/python'} 15:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:34 INFO - Running setup.py (path:/tmp/pip-FAWygU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:34 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)) 15:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:34 INFO - Running setup.py (path:/tmp/pip-bjbpsg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:34 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)) 15:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:34 INFO - Running setup.py (path:/tmp/pip-dp8M13-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:34 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)) 15:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:34 INFO - Running setup.py (path:/tmp/pip-FfGV3w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:34 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)) 15:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:34 INFO - Running setup.py (path:/tmp/pip-9xAbOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:34 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)) 15:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:34 INFO - Running setup.py (path:/tmp/pip-qGvd9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56: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)) 15:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:34 INFO - Running setup.py (path:/tmp/pip-W4kLIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56: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)) 15:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:34 INFO - Running setup.py (path:/tmp/pip-pX7mRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56: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)) 15:56:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:34 INFO - Running setup.py (path:/tmp/pip-FU0stC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:35 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)) 15:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:35 INFO - Running setup.py (path:/tmp/pip-XWPhQa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:35 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)) 15:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:35 INFO - Running setup.py (path:/tmp/pip-tznQh1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:35 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)) 15:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:35 INFO - Running setup.py (path:/tmp/pip-tzrFpm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:35 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)) 15:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:35 INFO - Running setup.py (path:/tmp/pip-vI_kKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:35 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)) 15:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:35 INFO - Running setup.py (path:/tmp/pip-mpPvyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:35 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)) 15:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:35 INFO - Running setup.py (path:/tmp/pip-9vVtuG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:35 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)) 15:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:35 INFO - Running setup.py (path:/tmp/pip-pHxxlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:35 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)) 15:56:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:35 INFO - Running setup.py (path:/tmp/pip-H6y2Ac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:35 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)) 15:56:35 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)) 15:56:35 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)) 15:56:35 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)) 15:56:35 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)) 15:56:35 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)) 15:56:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:37 INFO - Downloading blessings-1.6.tar.gz 15:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:56:37 INFO - Installing collected packages: blessings 15:56:37 INFO - Running setup.py install for blessings 15:56:37 INFO - Successfully installed blessings 15:56:37 INFO - Cleaning up... 15:56:37 INFO - Return code: 0 15:56:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:56:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:38 INFO - Reading from file tmpfile_stdout 15:56:38 INFO - Current package versions: 15:56:38 INFO - argparse == 1.2.1 15:56:38 INFO - blessings == 1.6 15:56:38 INFO - blobuploader == 1.2.4 15:56:38 INFO - docopt == 0.6.1 15:56:38 INFO - functools32 == 3.2.3-2 15:56:38 INFO - jsonschema == 2.5.1 15:56:38 INFO - manifestparser == 1.1 15:56:38 INFO - mozInstall == 1.12 15:56:38 INFO - mozcrash == 0.17 15:56:38 INFO - mozdebug == 0.1 15:56:38 INFO - mozdevice == 0.48 15:56:38 INFO - mozfile == 1.2 15:56:38 INFO - mozhttpd == 0.7 15:56:38 INFO - mozinfo == 0.9 15:56:38 INFO - mozleak == 0.1 15:56:38 INFO - mozlog == 3.4 15:56:38 INFO - moznetwork == 0.27 15:56:38 INFO - mozprocess == 0.23 15:56:38 INFO - mozprofile == 0.28 15:56:38 INFO - mozrunner == 6.12 15:56:38 INFO - mozscreenshot == 0.1 15:56:38 INFO - mozsystemmonitor == 0.3 15:56:38 INFO - moztest == 0.7 15:56:38 INFO - mozversion == 1.4 15:56:38 INFO - psutil == 3.1.1 15:56:38 INFO - requests == 1.2.3 15:56:38 INFO - wsgiref == 0.1.2 15:56:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:38 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 0x7fcbd828af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', '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 15:56:38 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 15:56:38 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 15:56:38 INFO - Using env: {'DISPLAY': ':0', 15:56:38 INFO - 'HOME': '/home/cltbld', 15:56:38 INFO - 'LANG': 'en_US.UTF-8', 15:56:38 INFO - 'LANGUAGE': 'en_US:en', 15:56:38 INFO - 'LOGNAME': 'cltbld', 15:56:38 INFO - 'MAIL': '/var/mail/cltbld', 15:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:38 INFO - 'MOZ_NO_REMOTE': '1', 15:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:38 INFO - 'NO_EM_RESTART': '1', 15:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:38 INFO - 'PWD': '/builds/slave/test', 15:56:38 INFO - 'SHELL': '/bin/bash', 15:56:38 INFO - 'SHLVL': '1', 15:56:38 INFO - 'TERM': 'linux', 15:56:38 INFO - 'TMOUT': '86400', 15:56:38 INFO - 'USER': 'cltbld', 15:56:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:38 INFO - '_': '/tools/buildbot/bin/python'} 15:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 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)) 15:56:38 INFO - Cleaning up... 15:56:38 INFO - Return code: 0 15:56:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcbd828af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18388a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1905ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, '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': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', '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 15:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:56:38 INFO - Using env: {'DISPLAY': ':0', 15:56:38 INFO - 'HOME': '/home/cltbld', 15:56:38 INFO - 'LANG': 'en_US.UTF-8', 15:56:38 INFO - 'LANGUAGE': 'en_US:en', 15:56:38 INFO - 'LOGNAME': 'cltbld', 15:56:38 INFO - 'MAIL': '/var/mail/cltbld', 15:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:38 INFO - 'MOZ_NO_REMOTE': '1', 15:56:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:38 INFO - 'NO_EM_RESTART': '1', 15:56:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:38 INFO - 'PWD': '/builds/slave/test', 15:56:38 INFO - 'SHELL': '/bin/bash', 15:56:38 INFO - 'SHLVL': '1', 15:56:38 INFO - 'TERM': 'linux', 15:56:38 INFO - 'TMOUT': '86400', 15:56:38 INFO - 'USER': 'cltbld', 15:56:38 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:38 INFO - '_': '/tools/buildbot/bin/python'} 15:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:56:38 INFO - Cleaning up... 15:56:38 INFO - Return code: 0 15:56:38 INFO - Running post-action listener: _resource_record_post_action 15:56:38 INFO - Running post-action listener: _start_resource_monitoring 15:56:38 INFO - Starting resource monitoring. 15:56:38 INFO - [mozharness: 2016-10-08 22:56:38.501612Z] Finished create-virtualenv step (success) 15:56:38 INFO - [mozharness: 2016-10-08 22:56:38.502064Z] Running install step. 15:56:38 INFO - Running pre-action listener: _resource_record_pre_action 15:56:38 INFO - Running main action method: install 15:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:38 INFO - Reading from file tmpfile_stdout 15:56:38 INFO - Detecting whether we're running mozinstall >=1.0... 15:56:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:56:38 INFO - Reading from file tmpfile_stdout 15:56:38 INFO - Output received: 15:56:38 INFO - Usage: mozinstall [options] installer 15:56:38 INFO - Options: 15:56:38 INFO - -h, --help show this help message and exit 15:56:38 INFO - -d DEST, --destination=DEST 15:56:38 INFO - Directory to install application into. [default: 15:56:38 INFO - "/builds/slave/test"] 15:56:38 INFO - --app=APP Application being installed. [default: firefox] 15:56:38 INFO - mkdir: /builds/slave/test/build/application 15:56: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'] 15:56: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 15:56:54 INFO - Reading from file tmpfile_stdout 15:56:54 INFO - Output received: 15:56:54 INFO - /builds/slave/test/build/application/firefox/firefox 15:56:54 INFO - Running post-action listener: _resource_record_post_action 15:56:54 INFO - [mozharness: 2016-10-08 22:56:54.939306Z] Finished install step (success) 15:56:54 INFO - [mozharness: 2016-10-08 22:56:54.939550Z] Running run-tests step. 15:56:54 INFO - Running pre-action listener: _resource_record_pre_action 15:56:54 INFO - Running main action method: run_tests 15:56:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:56:54 INFO - Python 2.7.3 15:56:54 INFO - Return code: 0 15:56:54 INFO - grabbing minidump binary from tooltool 15:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:54 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 0x1902f60>, '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 0x1903d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x19041d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:56:54 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 15:56:54 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 15:56:54 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 15:56:54 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:56:55 INFO - Return code: 0 15:56:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:56:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:56:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:56:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:56:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:56:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:56:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-040 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:56:55 INFO - Using env: {'DISPLAY': ':0', 15:56:55 INFO - 'HOME': '/home/cltbld', 15:56:55 INFO - 'LANG': 'en_US.UTF-8', 15:56:55 INFO - 'LANGUAGE': 'en_US:en', 15:56:55 INFO - 'LOGNAME': 'cltbld', 15:56:55 INFO - 'MAIL': '/var/mail/cltbld', 15:56:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:56:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:55 INFO - 'MOZ_NO_REMOTE': '1', 15:56:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:56:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:56:55 INFO - 'NO_EM_RESTART': '1', 15:56:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:55 INFO - 'PWD': '/builds/slave/test', 15:56:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:56:55 INFO - 'SHELL': '/bin/bash', 15:56:55 INFO - 'SHLVL': '1', 15:56:55 INFO - 'TERM': 'linux', 15:56:55 INFO - 'TMOUT': '86400', 15:56:55 INFO - 'USER': 'cltbld', 15:56:55 INFO - 'XDG_SESSION_COOKIE': '9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979', 15:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:55 INFO - '_': '/tools/buildbot/bin/python'} 15:56:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-040', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:56:55 INFO - mozversion application_buildid: 20161008142718 15:56:55 INFO - mozversion application_changeset: 45b16e0dbff0b07763c0d9b3ff6f5a4069198ee5 15:56:55 INFO - mozversion application_display_name: Nightly 15:56:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:56:55 INFO - mozversion application_name: Firefox 15:56:55 INFO - mozversion application_remotingname: firefox 15:56:55 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 15:56:55 INFO - mozversion application_vendor: Mozilla 15:56:55 INFO - mozversion application_version: 52.0a1 15:56:55 INFO - mozversion platform_buildid: 20161008142718 15:56:55 INFO - mozversion platform_changeset: 45b16e0dbff0b07763c0d9b3ff6f5a4069198ee5 15:56:55 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 15:56:55 INFO - mozversion platform_version: 52.0a1 15:56:55 INFO - using testdate: 1475967415 15:56:55 INFO - actual date: 1475967415 15:56:55 INFO - starting webserver on 'localhost:41343' 15:56:55 INFO - SUITE-START | Running 2 tests 15:56:55 INFO - TEST-START | dromaeo_css 15:56:55 INFO - operating with platform_type : linux_ 15:56:55 INFO - Initialising browser for dromaeo_css test... 15:56:55 INFO - TEST-INFO | started process 6796 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZbsolt/profile http://localhost:41343/getInfo.html) 15:57:00 INFO - PROCESS | 6796 | __metrics Screen width/height:1600/1200 15:57:00 INFO - PROCESS | 6796 | colorDepth:24 15:57:00 INFO - PROCESS | 6796 | Browser inner width/height: 1024/697 15:57:00 INFO - PROCESS | 6796 | __metrics 15:57:00 ERROR - PROCESS | 6796 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 15:57:01 INFO - TEST-INFO | 6796: exit 0 15:57:01 INFO - Browser initialized. 15:57:01 INFO - Running cycle 1/1 for dromaeo_css test... 15:57:01 INFO - TEST-INFO | started process 6917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZbsolt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:57:13 INFO - PROCESS | 6917 | RSS: Main: 185663488 15:57:13 INFO - PROCESS | 6917 | 15:58:03 INFO - PROCESS | 6917 | 1475967483679 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] 16:00:17 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41343/tests/dromaeo/cssquery-ext.html) 16:00:18 INFO - PROCESS | 6917 | RSS: Main: 198406144 16:00:18 INFO - PROCESS | 6917 | 16:03:20 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-ext.html (next: http://localhost:41343/tests/dromaeo/cssquery-jquery.html) 16:03:21 INFO - PROCESS | 6917 | RSS: Main: 196259840 16:03:21 INFO - PROCESS | 6917 | 16:06:23 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41343/tests/dromaeo/cssquery-mootools.html) 16:06:24 INFO - PROCESS | 6917 | RSS: Main: 198238208 16:06:24 INFO - PROCESS | 6917 | 16:09:26 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41343/tests/dromaeo/cssquery-prototype.html) 16:09:26 INFO - PROCESS | 6917 | RSS: Main: 195063808 16:09:26 INFO - PROCESS | 6917 | 16:12:29 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41343/tests/dromaeo/cssquery-yui.html) 16:12:30 INFO - PROCESS | 6917 | RSS: Main: 198344704 16:12:30 INFO - PROCESS | 6917 | 16:15:33 INFO - PROCESS | 6917 | Cycle 1(1): loaded http://localhost:41343/tests/dromaeo/cssquery-yui.html (next: http://localhost:41343/tests/dromaeo/cssquery-dojo.html) 16:15:33 INFO - PROCESS | 6917 | RSS: Main: 199053312 16:15:33 INFO - PROCESS | 6917 | 16:15:33 INFO - PROCESS | 6917 | __start_tp_report 16:15:33 INFO - PROCESS | 6917 | _x_x_mozilla_page_load 16:15:33 INFO - PROCESS | 6917 | _x_x_mozilla_page_load_details 16:15:33 INFO - PROCESS | 6917 | |i|pagename|runs| 16:15:33 INFO - PROCESS | 6917 | |0;dojo.html;2591.805614578907;2600.7919366450687;2611;2618.2145356393085;2619.711831698513;4594.081183763244;4649.116667833109;4649.488556258813;4688.578027977482;4704.247320428732;4655.674102812796;4753.595944344726;4765.094632019914;4795.568398844103;4805.90388192236;4344.239758042346;4371.693981421302;4438.556144385551;4455.2871540553515;4500.97749511252;4363.52001279859;4397.472303323606;4434.379186913835;4449.799759010836;4474.284114541674;4297.806598703066;4337.024169561855;4373.7813109344725;4373.956260437387;4486.641068714512;4353.194658988065;4359.782010899442;4388.341748737715;4407.867763967086;4409.867703968886;4290.849820256276;4324.913501729948;4328.567143285678;4334.176506463762;4365.847195348148;4552.385427967215;4613.976930115328;4627.768611569408;4678.929816052762;4750.406199225097;4986.925196122061;5013.097642424362;5033.395992480889;5059.721715305656;5070.340855688737;5030.622703297267;5043.445221025684;5053.267276244924;5066.088104141253;5108.7445627718835;4649.86050418488;4724.126036683225;4729.314249433813;4735.905281894377;4790.976045119822;5215.921761173586;5235.345581802275;5259.342582177228;5282.788688452419;5306.495882891119;5045.899082018339;5051.191809310492;5057.645964782503;5060.468650791688;5076.720780357042;4903.779329930162;5036.445990941067;5100.183970564692;5117.616178786606;5140.922886156711;4956.553910148104;5056.898862022739;5060.443351231362;5072.898542029138;5128.333316668809;4987.600991920638;5002.474740152305;5013.8718788272345;5014.473480284518;5082.313887625123;4256.5105012923295;4298.720583162084;4348.847790327323;4354.934675979863;4411.073674528385;3722.050877026341;3729.9440508392395;3772.830222639988;3819.770813751128;3877.5734669186368;4351.69538132334;4413.889652758707;4415.712978656377;4417.690761646654;4464.352668862996;5065.11360511909;5091.643584949018;5098.949010509921;5105.642605017687;5110.540051395318;4335.544767799399;4389.758563279051;4391.560843915647;4402.889927751832;4439.378487011821;4656.534346565317;4662.463816661128;4662.883427914329;4698.201305778026;4707.152712511781;4848.32123502717;4849.781759820746;4857.587105096107;4859.041943616822;4897.730624815669;4984.22744474607;5048.621353398583;5071.0872043032605;5165.690058596496;5211.426743058185;4847.3698419205275;4883.8290659826735;4883.877903052452;4909.3372394727685;4929.6549241554185;5049.798008079636;5054;5084.771185296597;5101.46434624374;5162.97418512905;4981.726005069756;5035.967626636604;5128.487151284841;5143.691378517301;5196.194589838581;4959.7272150032095;4986.227134794112;5012.04771093491;5034.823781167642;5095.337606111182;4974.651774375904;5003.749812509287;5014.247862820606;5020.87447813793;5061.974690126526;4751.762411879461;4850.902981940271;4897.534734200245;4908.092002979461;4914.680545764514;5016.54851063406;5036.773345199548;5037.093323201859;5081.974590127025;5083.593312535062;4918.213085906238;4918.360613120271;4929.383827021622;4936.03747269279;4990.126727822544 16:15:33 INFO - PROCESS | 6917 | |1;ext.html;531.1634176172529;552.0559842669036;553.8172403106975;564.1903867949492;575.8531574448515;36836.63163368365;38678;38689.226215475675;42605.36091958623;42657;40355.192896142056;40847.387289190614;40857.59142408575;40911.18177636446;40934.795326023406;7429.145648250439;7504.4371672124535;7505.962470187669;7534.547927124363;7556.50882692626;7427.071616047994;7566.092068951733;7575.053118360205;7587.544747315151;7587.544747315179;7606.809829754273;7625.237476252358;7661.846763064736;7662.616869156548;7674.232576742309;7576.772696819105;7604.657790399446;7630.961845190794;7635.121960974503;7637.045369328834;7454.291842274975;7563.092428908566;7590;7595.126560445564;7603.961980190119;37729;37952.620473795185;38136.237275254614;38361.808190958865;38375.04062398434;2954.9556756648453;2994.550817377411;3092.1651154188467;3369.3261347730554;3406.9659303407143;27697.307567310778;27969.580456293173;28296.292592685142;28352;28443.857780711172;3420.1620602952435;3443.810590417526;3546.4503002034467;3648.343298206322;3723.385641369171;241346;242579;244266;245358;245943.99999999822;50197.24704129441;50894.491055088976;50926.23610645843;51085.23372149421;51152;53154.73422632862;53184;53559.19661205085;53637;53870.730646346514;13544.796828047587;13802.37889294984;13825.446982120602;13835.169889806644;13848.861511384757;10035.548400322003;10129.59481620727;10144.797104058025;10152;10190.643327483502;15445.536633901002;15612.267853125657;15718.528444146694;15750.76373854393;15825.208739562975;3005.3989202159655;5200.869978250498;5659.377468478464;5663.093904975184;5815.651060936358;787.6534324897027;878.9560521973875;889.2441424789007;945.7257395355407;973.7419583810296;27686.307842304104;27828.443431131265;27875;27948.86025569859;28414.147575572766;913.9352654157832;941.0589410589411;946.5220063867703;957.0238356875948;958.1568219966524;13940.930295348458;14711.33798979027;14718.852811471748;14920.850791491946;15022.474213402696;355601;359921;361584;362710;364537;47507.76246118816;48326.516734832905;48335;48418.5158148421;48419.757901210265;1133.5919069135105;1145.9656210313703;1149.0462915779883;1160.031373802884;1165.5279611757421;25291.241262762145;26390.604140938285;27388.178354649393;27610;27817.44365112727;41189.382159268236;41551.7922410386;41563.7921810389;41574.58425415828;41595.58404415917;315231;315649;316331;316398;316862;24520.386990325384;25017.499650007263;25071.87464062668;25113.372165696004;25124.24627261185;39956.600433995285;40601;40780;41704.58295417128;41974.58025419707;34227;35231.373646697044;36245;36693;36752.448713269856;34983.475247870796;35186.648133518334;35417.645823542465;35535.822320888234;35818.28363432769;34521.82739086288;34635;34858.65141348656;34915.30169396649;35482.645173547935;29078.854605726836;32331.35337293194;32435.837820810746;32450.83774581112;32652.673473264964;24467.877660611583;24514.877425612758;24559.50880982406;24789.87605061963;24913.750862491866 16:15:33 INFO - PROCESS | 6917 | |2;jquery.html;344.99827500862506;352.1197007481297;355;359.1398600352157;382.269864558693;15174.786017118631;15490.457833975814;16760.32958681651;16893.83106168938;17049.147542622883;12795.232286062843;14908.552743417687;15896.125713085776;16007.759883601726;16889.746653800205;4992.375953005874;5255.605829562779;5258.0272649559765;5259.76331065103;5264;4987.975060124694;5028.396592408916;5165.328507294046;5169.974150129244;5215.217717342391;5232.973835130819;5237.764300606482;5250.921236181442;5251.159814429692;5259.184826351902;4952.579030782388;5173.456787037382;5195.844124676266;5201.479852014787;5223.529882310591;4533.138703646297;4549.45406551216;4565.977170114162;4567.2692369221095;4576.931346029813;16644.66710665792;20310.492237694027;20702.482437939023;20746.377608671763;20797;1868.6449574580922;1931.9323823666246;1958.3243780895568;2052.794720527935;2270.6594010898334;12845.550405735754;13036.348182590833;13183.274919879403;13608.591742247749;14021;1725.775649165613;1726.4475367882283;1743.2416898649128;1775.9644807103787;1798.9460316190534;69037.65481172562;69165.35433070867;69593;70104.6494767528;70858.29141708568;9073.500957447404;9287.164155226063;9436.339456237998;9508.334416590773;9744.269179811543;13204.537841175512;13291.933540332237;13325;13350.799738003938;13365.264910429825;5937.584369094208;6275.246970363585;6703.4972377070935;6868.690908909111;7077.063018847224;6654.367835055662;6663.933360666429;6812.965935170391;6853.691583878638;6880.036794848726;5840.445157710011;5963.880722385528;5970.432808883149;5993.820185394445;6099.969500152471;1696.4401747423321;1709.3162734906136;1737.426649205759;1738.782652168479;1759.4105974498686;848.6732607945862;862.6549380247951;890.692711014699;923.9974627529072;939.8402271613842;16224.918875405783;16431.917840410722;16466.917665411835;16512.504624861274;16759.1620418981;823.1603764160523;847.8473874702613;850.7362717557577;859.5573279760928;863.8617821148586;9860.605575776888;10039.749006274902;10156.4921753912;10176.440295783656;10177.389356638625;275493;278439;343781;347734;349699;80048.19951800407;82497.58751206206;82673;83298.58350708208;84246;903.8508646073324;919.7148883846163;940.8165407745424;943.0757857299884;945.645382981382;15487.84512154864;15578.298976545855;15791.131487768283;15939.442119526224;16113.597160071093;24929.87535062313;27409;36285.63714362928;39048.219035619695;39388.803055984536;40486;42051;46733.532664674276;47373.289400659705;52495.21257181222;6365.745370185141;6668.599884006975;6979.4765392594745;7069.151701795818;7620.54276743375;10976.725581860197;11726;11744.941275293912;11754.76490470203;12071;5501.944980550144;9748.757785709186;9770.75573110678;9903.613494110687;10099.14157296638;5015.974920125376;6965.651717414008;9882.209423246266;9968.255555277652;10305.124064454605;9976.20190384753;9987.650432234837;10060.547275372479;10224.795504090025;10490.108340791117;7119.750808721877;7244.927550724426;7249.311315425026;7312.81717957034;7423.517471364344;8074.878876816735;10123.24075694311;10166.8474972874;10477.895221047997;10579.36523808574 16:15:33 INFO - PROCESS | 6917 | |3;mootools.html;1368.493657346782;1391.09578773797;1470.6468454824442;1617;1668.824773398793;6895.724171033153;7155.785326440215;7159.284071592838;7743.186965368633;7747.573883436416;7405.259474052592;7824.5305281682995;7827;7853.842923141534;7857.096433910102;2136.2843447445125;2141.122139922632;2154.310620601408;2157.9568408631817;2158.7733288004692;2039.9184032638677;2065.493953981269;2171.0881429799524;2171.6525355943054;2173.9456513587206;2108.1356643776053;2128.2231985325398;2134.658454647257;2136.166894910986;2136.594047131048;2074.1495986645405;2083.510375061859;2092.61286661968;2095.0153427888945;2098.129276350313;2035.6030574038068;2112.23959374625;2118.3433135727973;2126.1389137399224;2126.776688447706;7682.846343073107;7852;7865.960670196612;7886.960565197137;7909.723159689441;4408.14041261954;4533.886652833673;4540.046590216059;4542.341360502709;4544.204764166291;2798.8460634665084;2812.2125804774696;2920.8977685780897;2926.3708302714804;2932.5747766573727;859.3772940381939;913.1279627955287;933.0902370189079;938.2775263047415;939.9389039712397;10166.288359814816;10169.644062457852;10209.183265338756;10218.33580817252;10330.225233107472;3845.4808600839087;3990.1221731219084;4038.2932986727205;4152.045029643199;4168.624823765876;8751.912480875237;8752.299816014704;8775.166359195866;8783.989841168348;8785.956070219609;4435.933460998088;4493.842715504941;4504.6396288296855;4505.301678239878;4521.796519156645;3589.246258285737;3705.388610879175;3985.8405663773124;4097.8770636880945;4109.876703698894;3465.428204346305;3479.808610526445;3569.714422846166;3588.4258518636893;3616.72874534411;1167.1829719196596;1168.7487190254137;1181.3148373943263;1184.3012622552562;1186.4305133535952;779.3297763923022;788.731831177391;792.6472719639705;793.2583034862422;800.8838718385801;4873.415190177201;4987.451380348159;4998.275250088789;4999.800007999712;5121.385433747974;360.43771716122933;363.6817784438616;377.8450835157572;379.0240131660929;392.25080097014563;3312.453445181518;3356.4965255211914;3411.522386865841;3504.842282097312;3523.7709548879243;9075.954620226856;9459.337846350689;9525.523723813782;9532.52337383142;9549.713508594614;8687.34844886636;9363;9453.960064392912;9484.383515071637;9496.762580935532;6696.631685257357;7157.856842863113;7199.1001124859395;7237.927620723725;7258.383037441771;5003.374578177728;5065.189569668983;5197.896042079213;5392.406835248198;5453.291072160594;8494.70268540598;8495.872561911452;8548.786280343042;8599.484030958163;8612.31101511865;8455.830883382421;8685.609147588248;8766.91233087661;8877.73366798997;8880.200781929658;6669.266380698023;6764.154480689914;6776.15298087739;6812.965935170292;6860.759873404407;7247.710091596277;7327.194008659149;7333.449991250571;7335.486515943832;7343.155537113087;6487.416132548094;6583.144191255106;6711.463082953254;6741.86516269662;6944.895826562504;6545.696654112565;6635.23694775107;6686.465082793267;6721;6888.724451021903;5831.0378787499585;5848.444397782204;5923.052311630118;5926.525877929842;5940.316863560746;4286.314189729628;4474.843380481798;4480.9103817922805;4543.7955292011275;4575.611073058827;4283.5502272260965;4311.417958575677;4336.219480493542;4393.165298593385;4416.8012439440945 16:15:33 INFO - PROCESS | 6917 | |4;prototype.html;269.43553255928833;271.5153451089805;271.9401731619044;275.0181850792671;281.5087672012338;4934.420985284711;5050.242463630458;5064.84805455836;5066.316047333618;5087.982403519301;4912.7297998610065;4943.8516844494725;4966.708655749504;4972.9751351243285;4979.825706100287;3872.67082298005;3882.437046628237;3883.3786594144945;3885.5920128386397;3896.27918835015;3863.961360386388;3867.994321476422;3876.8643097491595;3878.631530004645;3909;3606.9278614427694;3819.694424446038;3844.0774214188673;3861.961380386202;3869.6323849234277;3809.8095095245126;3818.694504439652;3824.7760716570847;3825.5791862895057;3833.5591406987996;3166.730827879633;3376.9155771105675;3379.1552111972005;3379.239671074013;3401.6768407001296;4789.305550695164;4793.5925446337105;4885.389326334208;4909.386326709161;4911.361523002022;4403.471583409979;4408.625266852321;4410.713303635285;4416.160929423431;4416.984093658444;5000.774965126578;5249.973750131225;5262.500062494095;5270.2358158067245;5292.682439053669;3721.60923103073;3724.2179142380132;3740.2706472237924;3743.12036671382;3746.737728359016;5512.80705175321;5541.030319694038;5550.139728342073;5554;5563.831595364978;3801.6049888570024;3812.8284227209842;3821.2739579479808;3821.4267859820693;3839.2705385976574;3794.715396345285;3796.1079146400575;3803.9729273096664;3820.7898565578603;3850.9807450963126;4366.14860102277;4383.912321753547;4385.912281754411;4391.912161756811;4392.3411488277015;5184.507471790174;5213.957208558303;5247.344081989751;5255.395629502656;5264.92102618461;1297.4939773488347;1325.5029363988504;1329.5678904356123;1340.6782372230593;1342.4630147940707;817.3869597801648;835.8746188071838;849.8512760266929;859.2824991132475;861.4745005546612;4073.551909289976;4075.286824805647;4079.714419990572;4135.937960930589;4148.460700108966;4671.11248862715;4698.929516057262;4746.769018561271;4780.948191397887;4784.976075119602;4150.750954942653;4160.979195104005;4171.3325867860995;4171.561985991488;4174.705841189241;2383.6662867198606;2522.2685421228007;2530.0891678995545;2555.658279403291;2578.710644677661;4507.977460112678;4875.293082503017;4938.9012219755405;5008.774605142778;5075.314832497639;5492;5529.677535435127;5538.723063846872;5540.9168862467095;5549.556035517229;5071.884185479189;5089.847304580869;5092.821751238689;5103.234514822806;5133.997740880985;5154.252633368215;5418.701971391453;5442.727863606725;5445.378823082606;5452.427495113115;5364.785408583769;5370.275012873212;5387.542058924879;5388.194954690066;5395.433479484597;4921.335619691439;5101.897962040664;5119.436861945258;5139.177731562932;5142.305788718625;3620.5517792883056;3681.3925702258825;3683.557973043252;3689.9077523062138;3712.777233366007;5375.919361209507;5389.919151212656;5398.946010540001;5438.782448702166;5439.211314359317;5164.457731938242;5271.736413179402;5289.391719952255;5300.231466437422;5311.814086506954;5241.790328386975;5262.947370526245;5269.841904742864;5272.971770504868;5273.762680679455;5210.108389843673;5217.2434996925995;5223.921641175461;5237.607179461632;5240.5807535397835;5110.540051395392;5175.922361164661;5210.27056212123;5250.737463126905;5268.446813084724;5123.87190320245;5128.923066154085;5130.256112863689;5144.9742751286;5147.253648221062 16:15:33 INFO - PROCESS | 6917 | |5;yui.html;593.4451288045677;646.6055706019329;682.3415404135009;697.9356481365917;735.3124828285556;12057.336846473441;12747.10770246082;13014.154079984793;13143.27711975841;14680.045797023186;12865.16376435531;13095.869041309585;13099;13099.47602095915;13273.269970151638;603.1887111834576;749.8912657664636;761.5240474703311;765.6439755513685;766.9769906902774;621.0776996160698;744.8696478116335;768.4735955870219;776.9611519424035;779.4388040610751;816.4570560577209;817.9304759095484;821.1829229916242;822.2188920525494;822.5517093184229;812.6505602590884;813.1055838577577;813.3411936331561;813.9267465928036;814.0882211922655;593.8129489210928;599.2629066248495;600;600.5555888642417;600.6066026752484;12343.38283085851;12374.505019799197;12391.380430978415;12393.442295096742;12410.81383779244;12385.256884586954;12561.748765024648;12639.241645501208;13058.412371443213;13067.477300907953;10122.228242229645;10158.593656253815;10274.22943279257;10328.845067323997;10562.68311950635;3288.9835550822095;3356.513305570703;3364.3775901458307;3368.747343949189;3372.5278461015478;62717.68641156811;62904.685476572784;63585;63645.36354636487;64584.67707661479;10247.79672370444;10276;10382.480875956171;10396.896031039743;10507.054365107024;19795.604087918447;19842.50393740168;19859.900700496404;19861.801381985995;19917.402477925687;6648.13574235356;6657.034729964128;6710.228323742735;6868.313168683092;7039.014537964689;3460.602030766444;3486.3201675673;3496.17839807645;3537.4340105582983;3539.734519911017;2755.3662657588866;2843.7440630342953;2852.500812357829;2860.914172574826;2867.3691787806647;487.9971658242275;489.22213680247864;491.7295487481871;491.85643379143636;498.10092782527886;547.3103889099763;565.0309718832141;583.096200888621;623.9095331176954;631.6336524815596;7203.96398018017;7215.098112735908;7303.233160518175;7384.963075184697;7566.373229755629;545.8826352334268;550.4055619930466;571.7655761137913;573.060181302664;589.345826132992;3379.797212167278;3537;3550.7039930425726;3695.667389934865;3742.644448777362;51116.23325650118;52170.47829521732;88241.11758882458;89031;91335;75434;75709.24290757132;75945.62027189939;78026;78741;66922.33077669161;69600.3039969614;69745.65127174332;70870;71313.6434317825;7302.853942921006;7926.881096783668;8103.270705636521;8136.7152149674475;8343.207395297437;42527;43485;43785.34321985109;43869.561304386545;44873.32690009718;54944.45055549553;59831;60687.089693655515;62197.689011554656;63451.36548634455;9638.807223855343;9676.70969870905;9720.75698107553;10056.84914726265;10252.128569071712;11422.143339249424;11621.709457263298;11645.126615503701;12164.391780410768;12281.324527151093;9890.554925028247;10442.895571044191;10501.31741436804;10620.150387969099;11039.558417663204;10334.586616535255;10396.168306535308;10412.843807342744;10495.370277783357;10900.836487452536;9728.951355243462;10093.444860532742;10485.318454300446;10698.62554810578;10729.409882456539;8728.607212675572;8973.955130224307;9155.450672959643;9591.376560523544;9965.35225210359;8661.393702440768;9120.954395227982;9374.859377109486;9376.390534615228;9465.242780577675 16:15:33 INFO - PROCESS | 6917 | __end_tp_report 16:15:33 INFO - PROCESS | 6917 | __start_cc_report 16:15:33 INFO - PROCESS | 6917 | _x_x_mozilla_cycle_collect,336 16:15:33 INFO - PROCESS | 6917 | __end_cc_report 16:15:33 INFO - PROCESS | 6917 | __startTimestamp1475968533659__endTimestamp 16:15:33 INFO - PROCESS | 6917 | 16:15:33 INFO - PROCESS | 6917 | ------- Summary: start ------- 16:15:33 INFO - PROCESS | 6917 | Number of tests: 6 16:15:33 INFO - PROCESS | 6917 | 16:15:33 INFO - PROCESS | 6917 | [#0] dojo.html Cycles:165 Average:4711.80 Median:4883.83 stddev:500.87 (10.3%) stddev-sans-first:473.99 16:15:33 INFO - PROCESS | 6917 | Values: 2591.8 2600.8 2611.0 2618.2 2619.7 4594.1 4649.1 4649.5 4688.6 4704.2 4655.7 4753.6 4765.1 4795.6 4805.9 4344.2 4371.7 4438.6 4455.3 4501.0 4363.5 4397.5 4434.4 4449.8 4474.3 4297.8 4337.0 4373.8 4374.0 4486.6 4353.2 4359.8 4388.3 4407.9 4409.9 4290.8 4324.9 4328.6 4334.2 4365.8 4552.4 4614.0 4627.8 4678.9 4750.4 4986.9 5013.1 5033.4 5059.7 5070.3 5030.6 5043.4 5053.3 5066.1 5108.7 4649.9 4724.1 4729.3 4735.9 4791.0 5215.9 5235.3 5259.3 5282.8 5306.5 5045.9 5051.2 5057.6 5060.5 5076.7 4903.8 5036.4 5100.2 5117.6 5140.9 4956.6 5056.9 5060.4 5072.9 5128.3 4987.6 5002.5 5013.9 5014.5 5082.3 4256.5 4298.7 4348.8 4354.9 4411.1 3722.1 3729.9 3772.8 3819.8 3877.6 4351.7 4413.9 4415.7 4417.7 4464.4 5065.1 5091.6 5098.9 5105.6 5110.5 4335.5 4389.8 4391.6 4402.9 4439.4 4656.5 4662.5 4662.9 4698.2 4707.2 4848.3 4849.8 4857.6 4859.0 4897.7 4984.2 5048.6 5071.1 5165.7 5211.4 4847.4 4883.8 4883.9 4909.3 4929.7 5049.8 5054.0 5084.8 5101.5 5163.0 4981.7 5036.0 5128.5 5143.7 5196.2 4959.7 4986.2 5012.0 5034.8 5095.3 4974.7 5003.7 5014.2 5020.9 5062.0 4751.8 4850.9 4897.5 4908.1 4914.7 5016.5 5036.8 5037.1 5082.0 5083.6 4918.2 4918.4 4929.4 4936.0 4990.1 16:15:33 INFO - PROCESS | 6917 | 16:15:33 INFO - PROCESS | 6917 | [#1] ext.html Cycles:180 Average:45906.67 Median:363623.50 stddev:81715.17 (22.5%) stddev-sans-first:81873.38 16:15:33 INFO - PROCESS | 6917 | Values: 531.2 552.1 553.8 564.2 575.9 36836.6 38678.0 38689.2 42605.4 42657.0 40355.2 40847.4 40857.6 40911.2 40934.8 7429.1 7504.4 7506.0 7534.5 7556.5 7427.1 7566.1 7575.1 7587.5 7587.5 7606.8 7625.2 7661.8 7662.6 7674.2 7576.8 7604.7 7631.0 7635.1 7637.0 7454.3 7563.1 7590.0 7595.1 7604.0 37729.0 37952.6 38136.2 38361.8 38375.0 2955.0 2994.6 3092.2 3369.3 3407.0 27697.3 27969.6 28296.3 28352.0 28443.9 3420.2 3443.8 3546.5 3648.3 3723.4 241346.0 242579.0 244266.0 245358.0 245944.0 50197.2 50894.5 50926.2 51085.2 51152.0 53154.7 53184.0 53559.2 53637.0 53870.7 13544.8 13802.4 13825.4 13835.2 13848.9 10035.5 10129.6 10144.8 10152.0 10190.6 15445.5 15612.3 15718.5 15750.8 15825.2 3005.4 5200.9 5659.4 5663.1 5815.7 787.7 879.0 889.2 945.7 973.7 27686.3 27828.4 27875.0 27948.9 28414.1 913.9 941.1 946.5 957.0 958.2 13940.9 14711.3 14718.9 14920.9 15022.5 355601.0 359921.0 361584.0 362710.0 364537.0 47507.8 48326.5 48335.0 48418.5 48419.8 1133.6 1146.0 1149.0 1160.0 1165.5 25291.2 26390.6 27388.2 27610.0 27817.4 41189.4 41551.8 41563.8 41574.6 41595.6 315231.0 315649.0 316331.0 316398.0 316862.0 24520.4 25017.5 25071.9 25113.4 25124.2 39956.6 40601.0 40780.0 41704.6 41974.6 34227.0 35231.4 36245.0 36693.0 36752.4 34983.5 35186.6 35417.6 35535.8 35818.3 34521.8 34635.0 34858.7 34915.3 35482.6 29078.9 32331.4 32435.8 32450.8 32652.7 24467.9 24514.9 24559.5 24789.9 24913.8 16:15:33 INFO - PROCESS | 6917 | 16:15:33 INFO - PROCESS | 6917 | [#2] jquery.html Cycles:180 Average:22134.45 Median:47053.41 stddev:53666.67 (114.1%) stddev-sans-first:53792.28 16:15:33 INFO - PROCESS | 6917 | Values: 345.0 352.1 355.0 359.1 382.3 15174.8 15490.5 16760.3 16893.8 17049.1 12795.2 14908.6 15896.1 16007.8 16889.7 4992.4 5255.6 5258.0 5259.8 5264.0 4988.0 5028.4 5165.3 5170.0 5215.2 5233.0 5237.8 5250.9 5251.2 5259.2 4952.6 5173.5 5195.8 5201.5 5223.5 4533.1 4549.5 4566.0 4567.3 4576.9 16644.7 20310.5 20702.5 20746.4 20797.0 1868.6 1931.9 1958.3 2052.8 2270.7 12845.6 13036.3 13183.3 13608.6 14021.0 1725.8 1726.4 1743.2 1776.0 1798.9 69037.7 69165.4 69593.0 70104.6 70858.3 9073.5 9287.2 9436.3 9508.3 9744.3 13204.5 13291.9 13325.0 13350.8 13365.3 5937.6 6275.2 6703.5 6868.7 7077.1 6654.4 6663.9 6813.0 6853.7 6880.0 5840.4 5963.9 5970.4 5993.8 6100.0 1696.4 1709.3 1737.4 1738.8 1759.4 848.7 862.7 890.7 924.0 939.8 16224.9 16431.9 16466.9 16512.5 16759.2 823.2 847.8 850.7 859.6 863.9 9860.6 10039.7 10156.5 10176.4 10177.4 275493.0 278439.0 343781.0 347734.0 349699.0 80048.2 82497.6 82673.0 83298.6 84246.0 903.9 919.7 940.8 943.1 945.6 15487.8 15578.3 15791.1 15939.4 16113.6 24929.9 27409.0 36285.6 39048.2 39388.8 40486.0 42051.0 46733.5 47373.3 52495.2 6365.7 6668.6 6979.5 7069.2 7620.5 10976.7 11726.0 11744.9 11754.8 12071.0 5501.9 9748.8 9770.8 9903.6 10099.1 5016.0 6965.7 9882.2 9968.3 10305.1 9976.2 9987.7 10060.5 10224.8 10490.1 7119.8 7244.9 7249.3 7312.8 7423.5 8074.9 10123.2 10166.8 10477.9 10579.4 16:15:33 INFO - PROCESS | 6917 | 16:15:33 INFO - PROCESS | 6917 | [#3] mootools.html Cycles:180 Average:4988.96 Median:4930.43 stddev:2815.92 (57.1%) stddev-sans-first:2810.68 16:15:33 INFO - PROCESS | 6917 | Values: 1368.5 1391.1 1470.6 1617.0 1668.8 6895.7 7155.8 7159.3 7743.2 7747.6 7405.3 7824.5 7827.0 7853.8 7857.1 2136.3 2141.1 2154.3 2158.0 2158.8 2039.9 2065.5 2171.1 2171.7 2173.9 2108.1 2128.2 2134.7 2136.2 2136.6 2074.1 2083.5 2092.6 2095.0 2098.1 2035.6 2112.2 2118.3 2126.1 2126.8 7682.8 7852.0 7866.0 7887.0 7909.7 4408.1 4533.9 4540.0 4542.3 4544.2 2798.8 2812.2 2920.9 2926.4 2932.6 859.4 913.1 933.1 938.3 939.9 10166.3 10169.6 10209.2 10218.3 10330.2 3845.5 3990.1 4038.3 4152.0 4168.6 8751.9 8752.3 8775.2 8784.0 8786.0 4435.9 4493.8 4504.6 4505.3 4521.8 3589.2 3705.4 3985.8 4097.9 4109.9 3465.4 3479.8 3569.7 3588.4 3616.7 1167.2 1168.7 1181.3 1184.3 1186.4 779.3 788.7 792.6 793.3 800.9 4873.4 4987.5 4998.3 4999.8 5121.4 360.4 363.7 377.8 379.0 392.3 3312.5 3356.5 3411.5 3504.8 3523.8 9076.0 9459.3 9525.5 9532.5 9549.7 8687.3 9363.0 9454.0 9484.4 9496.8 6696.6 7157.9 7199.1 7237.9 7258.4 5003.4 5065.2 5197.9 5392.4 5453.3 8494.7 8495.9 8548.8 8599.5 8612.3 8455.8 8685.6 8766.9 8877.7 8880.2 6669.3 6764.2 6776.2 6813.0 6860.8 7247.7 7327.2 7333.4 7335.5 7343.2 6487.4 6583.1 6711.5 6741.9 6944.9 6545.7 6635.2 6686.5 6721.0 6888.7 5831.0 5848.4 5923.1 5926.5 5940.3 4286.3 4474.8 4480.9 4543.8 4575.6 4283.6 4311.4 4336.2 4393.2 4416.8 16:15:33 INFO - PROCESS | 6917 | 16:15:33 INFO - PROCESS | 6917 | [#4] prototype.html Cycles:180 Average:4284.51 Median:4910.37 stddev:1282.98 (26.1%) stddev-sans-first:1250.68 16:15:33 INFO - PROCESS | 6917 | Values: 269.4 271.5 271.9 275.0 281.5 4934.4 5050.2 5064.8 5066.3 5088.0 4912.7 4943.9 4966.7 4973.0 4979.8 3872.7 3882.4 3883.4 3885.6 3896.3 3864.0 3868.0 3876.9 3878.6 3909.0 3606.9 3819.7 3844.1 3862.0 3869.6 3809.8 3818.7 3824.8 3825.6 3833.6 3166.7 3376.9 3379.2 3379.2 3401.7 4789.3 4793.6 4885.4 4909.4 4911.4 4403.5 4408.6 4410.7 4416.2 4417.0 5000.8 5250.0 5262.5 5270.2 5292.7 3721.6 3724.2 3740.3 3743.1 3746.7 5512.8 5541.0 5550.1 5554.0 5563.8 3801.6 3812.8 3821.3 3821.4 3839.3 3794.7 3796.1 3804.0 3820.8 3851.0 4366.1 4383.9 4385.9 4391.9 4392.3 5184.5 5214.0 5247.3 5255.4 5264.9 1297.5 1325.5 1329.6 1340.7 1342.5 817.4 835.9 849.9 859.3 861.5 4073.6 4075.3 4079.7 4135.9 4148.5 4671.1 4698.9 4746.8 4780.9 4785.0 4150.8 4161.0 4171.3 4171.6 4174.7 2383.7 2522.3 2530.1 2555.7 2578.7 4508.0 4875.3 4938.9 5008.8 5075.3 5492.0 5529.7 5538.7 5540.9 5549.6 5071.9 5089.8 5092.8 5103.2 5134.0 5154.3 5418.7 5442.7 5445.4 5452.4 5364.8 5370.3 5387.5 5388.2 5395.4 4921.3 5101.9 5119.4 5139.2 5142.3 3620.6 3681.4 3683.6 3689.9 3712.8 5375.9 5389.9 5398.9 5438.8 5439.2 5164.5 5271.7 5289.4 5300.2 5311.8 5241.8 5262.9 5269.8 5273.0 5273.8 5210.1 5217.2 5223.9 5237.6 5240.6 5110.5 5175.9 5210.3 5250.7 5268.4 5123.9 5128.9 5130.3 5145.0 5147.3 16:15:33 INFO - PROCESS | 6917 | 16:15:33 INFO - PROCESS | 6917 | [#5] yui.html Cycles:180 Average:16472.51 Median:557.72 stddev:22829.06 (4093.3%) stddev-sans-first:22861.97 16:15:33 INFO - PROCESS | 6917 | Values: 593.4 646.6 682.3 697.9 735.3 12057.3 12747.1 13014.2 13143.3 14680.0 12865.2 13095.9 13099.0 13099.5 13273.3 603.2 749.9 761.5 765.6 767.0 621.1 744.9 768.5 777.0 779.4 816.5 817.9 821.2 822.2 822.6 812.7 813.1 813.3 813.9 814.1 593.8 599.3 600.0 600.6 600.6 12343.4 12374.5 12391.4 12393.4 12410.8 12385.3 12561.7 12639.2 13058.4 13067.5 10122.2 10158.6 10274.2 10328.8 10562.7 3289.0 3356.5 3364.4 3368.7 3372.5 62717.7 62904.7 63585.0 63645.4 64584.7 10247.8 10276.0 10382.5 10396.9 10507.1 19795.6 19842.5 19859.9 19861.8 19917.4 6648.1 6657.0 6710.2 6868.3 7039.0 3460.6 3486.3 3496.2 3537.4 3539.7 2755.4 2843.7 2852.5 2860.9 2867.4 488.0 489.2 491.7 491.9 498.1 547.3 565.0 583.1 623.9 631.6 7204.0 7215.1 7303.2 7385.0 7566.4 545.9 550.4 571.8 573.1 589.3 3379.8 3537.0 3550.7 3695.7 3742.6 51116.2 52170.5 88241.1 89031.0 91335.0 75434.0 75709.2 75945.6 78026.0 78741.0 66922.3 69600.3 69745.7 70870.0 71313.6 7302.9 7926.9 8103.3 8136.7 8343.2 42527.0 43485.0 43785.3 43869.6 44873.3 54944.5 59831.0 60687.1 62197.7 63451.4 9638.8 9676.7 9720.8 10056.8 10252.1 11422.1 11621.7 11645.1 12164.4 12281.3 9890.6 10442.9 10501.3 10620.2 11039.6 10334.6 10396.2 10412.8 10495.4 10900.8 9729.0 10093.4 10485.3 10698.6 10729.4 8728.6 8974.0 9155.5 9591.4 9965.4 8661.4 9121.0 9374.9 9376.4 9465.2 16:15:33 INFO - PROCESS | 6917 | -------- Summary: end -------- 16:15:33 INFO - PROCESS | 6917 | 16:15:34 INFO - TEST-INFO | 6917: exit 0 16:15:34 INFO - TEST-OK | dromaeo_css | took 1119578ms 16:15:34 INFO - TEST-START | kraken 16:15:34 INFO - operating with platform_type : linux_ 16:15:34 INFO - Initialising browser for kraken test... 16:15:34 INFO - TEST-INFO | started process 7279 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3j0Khm/profile http://localhost:41343/getInfo.html) 16:15:39 INFO - PROCESS | 7279 | __metrics Screen width/height:1600/1200 16:15:39 INFO - PROCESS | 7279 | colorDepth:24 16:15:39 INFO - PROCESS | 7279 | Browser inner width/height: 1024/697 16:15:39 INFO - PROCESS | 7279 | __metrics 16:15:40 ERROR - PROCESS | 7279 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 16:15:41 INFO - TEST-INFO | 7279: exit 0 16:15:41 INFO - Browser initialized. 16:15:41 INFO - Running cycle 1/1 for kraken test... 16:15:41 INFO - TEST-INFO | started process 7401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3j0Khm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:15:53 INFO - PROCESS | 7401 | RSS: Main: 185872384 16:15:53 INFO - PROCESS | 7401 | 16:15:56 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41343/tests/kraken/driver.html?testName=audio-beat-detection) 16:15:57 INFO - PROCESS | 7401 | RSS: Main: 198987776 16:15:57 INFO - PROCESS | 7401 | 16:16:00 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41343/tests/kraken/driver.html?testName=audio-dft) 16:16:01 INFO - PROCESS | 7401 | RSS: Main: 197476352 16:16:01 INFO - PROCESS | 7401 | 16:16:03 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41343/tests/kraken/driver.html?testName=audio-fft) 16:16:04 INFO - PROCESS | 7401 | RSS: Main: 193097728 16:16:04 INFO - PROCESS | 7401 | 16:16:06 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41343/tests/kraken/driver.html?testName=audio-oscillator) 16:16:07 INFO - PROCESS | 7401 | RSS: Main: 194064384 16:16:07 INFO - PROCESS | 7401 | 16:16:09 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41343/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:16:10 INFO - PROCESS | 7401 | RSS: Main: 193933312 16:16:10 INFO - PROCESS | 7401 | 16:16:13 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41343/tests/kraken/driver.html?testName=imaging-darkroom) 16:16:14 INFO - PROCESS | 7401 | RSS: Main: 194826240 16:16:14 INFO - PROCESS | 7401 | 16:16:17 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41343/tests/kraken/driver.html?testName=imaging-desaturate) 16:16:18 INFO - PROCESS | 7401 | RSS: Main: 191954944 16:16:18 INFO - PROCESS | 7401 | 16:16:21 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41343/tests/kraken/driver.html?testName=json-parse-financial) 16:16:21 INFO - PROCESS | 7401 | RSS: Main: 193294336 16:16:21 INFO - PROCESS | 7401 | 16:16:23 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41343/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:16:24 INFO - PROCESS | 7401 | RSS: Main: 193359872 16:16:24 INFO - PROCESS | 7401 | 16:16:26 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:16:26 INFO - PROCESS | 7401 | RSS: Main: 193175552 16:16:26 INFO - PROCESS | 7401 | 16:16:29 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:16:29 INFO - PROCESS | 7401 | RSS: Main: 193351680 16:16:29 INFO - PROCESS | 7401 | 16:16:32 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:16:33 INFO - PROCESS | 7401 | RSS: Main: 194301952 16:16:33 INFO - PROCESS | 7401 | 16:16:36 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:16:37 INFO - PROCESS | 7401 | RSS: Main: 193978368 16:16:37 INFO - PROCESS | 7401 | 16:16:38 INFO - PROCESS | 7401 | Cycle 1(1): loaded http://localhost:41343/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41343/tests/kraken/driver.html?testName=ai-astar) 16:16:39 INFO - PROCESS | 7401 | RSS: Main: 196866048 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | __start_tp_report 16:16:39 INFO - PROCESS | 7401 | _x_x_mozilla_page_load 16:16:39 INFO - PROCESS | 7401 | _x_x_mozilla_page_load_details 16:16:39 INFO - PROCESS | 7401 | |i|pagename|runs| 16:16:39 INFO - PROCESS | 7401 | |0;ai-astar;105;115;114;114;115;115;114;115;114;113 16:16:39 INFO - PROCESS | 7401 | |1;audio-beat-detection;154;128;128;181;136;130;133;129;171;131 16:16:39 INFO - PROCESS | 7401 | |2;audio-dft;170;166;163;162;162;164;166;164;163;163 16:16:39 INFO - PROCESS | 7401 | |3;audio-fft;76;77;77;107;76;78;77;76;100;77 16:16:39 INFO - PROCESS | 7401 | |4;audio-oscillator;83;83;125;84;85;84;116;84;84;110 16:16:39 INFO - PROCESS | 7401 | |5;imaging-gaussian-blur;118;118;118;118;118;117;120;118;118;119 16:16:39 INFO - PROCESS | 7401 | |6;imaging-darkroom;148;148;148;148;149;149;150;149;150;150 16:16:39 INFO - PROCESS | 7401 | |7;imaging-desaturate;96;96;95;95;95;95;95;96;96;95 16:16:39 INFO - PROCESS | 7401 | |8;json-parse-financial;66;66;66;67;67;69;67;66;67;67 16:16:39 INFO - PROCESS | 7401 | |9;json-stringify-tinderbox;66;67;67;65;66;67;67;67;66;66 16:16:39 INFO - PROCESS | 7401 | |10;stanford-crypto-aes;84;89;86;86;84;90;90;85;90;83 16:16:39 INFO - PROCESS | 7401 | |11;stanford-crypto-ccm;151;143;152;142;147;143;152;159;183;153 16:16:39 INFO - PROCESS | 7401 | |12;stanford-crypto-pbkdf2;180;173;172;175;182;175;178;180;175;176 16:16:39 INFO - PROCESS | 7401 | |13;stanford-crypto-sha256-iterative;71;72;71;74;70;71;71;73;70;72 16:16:39 INFO - PROCESS | 7401 | __end_tp_report 16:16:39 INFO - PROCESS | 7401 | __start_cc_report 16:16:39 INFO - PROCESS | 7401 | _x_x_mozilla_cycle_collect,869 16:16:39 INFO - PROCESS | 7401 | __end_cc_report 16:16:39 INFO - PROCESS | 7401 | __startTimestamp1475968599112__endTimestamp 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | ------- Summary: start ------- 16:16:39 INFO - PROCESS | 7401 | Number of tests: 14 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:3.03 (2.6%) stddev-sans-first:0.71 16:16:39 INFO - PROCESS | 7401 | Values: 105.0 115.0 114.0 114.0 115.0 115.0 114.0 115.0 114.0 113.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#1] audio-beat-detection Cycles:10 Average:142.10 Median:134.50 stddev:19.58 (14.6%) stddev-sans-first:20.28 16:16:39 INFO - PROCESS | 7401 | Values: 154.0 128.0 128.0 181.0 136.0 130.0 133.0 129.0 171.0 131.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#2] audio-dft Cycles:10 Average:164.30 Median:164.00 stddev:2.45 (1.5%) stddev-sans-first:1.50 16:16:39 INFO - PROCESS | 7401 | Values: 170.0 166.0 163.0 162.0 162.0 164.0 166.0 164.0 163.0 163.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#3] audio-fft Cycles:10 Average:82.10 Median:77.00 stddev:11.42 (14.8%) stddev-sans-first:11.89 16:16:39 INFO - PROCESS | 7401 | Values: 76.0 77.0 77.0 107.0 76.0 78.0 77.0 76.0 100.0 77.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:84.00 stddev:16.41 (19.5%) stddev-sans-first:16.93 16:16:39 INFO - PROCESS | 7401 | Values: 83.0 83.0 125.0 84.0 85.0 84.0 116.0 84.0 84.0 110.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 16:16:39 INFO - PROCESS | 7401 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 120.0 118.0 118.0 119.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#6] imaging-darkroom Cycles:10 Average:148.90 Median:149.00 stddev:0.88 (0.6%) stddev-sans-first:0.87 16:16:39 INFO - PROCESS | 7401 | Values: 148.0 148.0 148.0 148.0 149.0 149.0 150.0 149.0 150.0 150.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:16:39 INFO - PROCESS | 7401 | Values: 96.0 96.0 95.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 16:16:39 INFO - PROCESS | 7401 | Values: 66.0 66.0 66.0 67.0 67.0 69.0 67.0 66.0 67.0 67.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 16:16:39 INFO - PROCESS | 7401 | Values: 66.0 67.0 67.0 65.0 66.0 67.0 67.0 67.0 66.0 66.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.50 stddev:2.79 (3.2%) stddev-sans-first:2.78 16:16:39 INFO - PROCESS | 7401 | Values: 84.0 89.0 86.0 86.0 84.0 90.0 90.0 85.0 90.0 83.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#11] stanford-crypto-ccm Cycles:10 Average:152.50 Median:152.00 stddev:12.00 (7.9%) stddev-sans-first:12.72 16:16:39 INFO - PROCESS | 7401 | Values: 151.0 143.0 152.0 142.0 147.0 143.0 152.0 159.0 183.0 153.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.60 Median:177.00 stddev:3.27 (1.8%) stddev-sans-first:3.23 16:16:39 INFO - PROCESS | 7401 | Values: 180.0 173.0 172.0 175.0 182.0 175.0 178.0 180.0 175.0 176.0 16:16:39 INFO - PROCESS | 7401 | 16:16:39 INFO - PROCESS | 7401 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.50 Median:71.50 stddev:1.27 (1.8%) stddev-sans-first:1.33 16:16:39 INFO - PROCESS | 7401 | Values: 71.0 72.0 71.0 74.0 70.0 71.0 71.0 73.0 70.0 72.0 16:16:39 INFO - PROCESS | 7401 | -------- Summary: end -------- 16:16:39 INFO - PROCESS | 7401 | 16:16:40 INFO - TEST-INFO | 7401: exit 0 16:16:40 INFO - TEST-OK | kraken | took 65601ms 16:16:40 INFO - SUITE-END | took 1185s 16:16:40 INFO - Completed test suite (00:19:45) 16:16:40 INFO - javascript benchmark 16:16:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6270.898492839602, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2591.805614578907, 2600.7919366450687, 2611.0, 2618.2145356393085, 2619.711831698513, 4594.081183763244, 4649.116667833109, 4649.488556258813, 4688.578027977482, 4704.247320428732, 4655.674102812796, 4753.595944344726, 4765.094632019914, 4795.568398844103, 4805.90388192236, 4344.239758042346, 4371.693981421302, 4438.556144385551, 4455.2871540553515, 4500.97749511252, 4363.52001279859, 4397.472303323606, 4434.379186913835, 4449.799759010836, 4474.284114541674, 4297.806598703066, 4337.024169561855, 4373.7813109344725, 4373.956260437387, 4486.641068714512, 4353.194658988065, 4359.782010899442, 4388.341748737715, 4407.867763967086, 4409.867703968886, 4290.849820256276, 4324.913501729948, 4328.567143285678, 4334.176506463762, 4365.847195348148, 4552.385427967215, 4613.976930115328, 4627.768611569408, 4678.929816052762, 4750.406199225097, 4986.925196122061, 5013.097642424362, 5033.395992480889, 5059.721715305656, 5070.340855688737, 5030.622703297267, 5043.445221025684, 5053.267276244924, 5066.088104141253, 5108.7445627718835, 4649.86050418488, 4724.126036683225, 4729.314249433813, 4735.905281894377, 4790.976045119822, 5215.921761173586, 5235.345581802275, 5259.342582177228, 5282.788688452419, 5306.495882891119, 5045.899082018339, 5051.191809310492, 5057.645964782503, 5060.468650791688, 5076.720780357042, 4903.779329930162, 5036.445990941067, 5100.183970564692, 5117.616178786606, 5140.922886156711, 4956.553910148104, 5056.898862022739, 5060.443351231362, 5072.898542029138, 5128.333316668809, 4987.600991920638, 5002.474740152305, 5013.8718788272345, 5014.473480284518, 5082.313887625123, 4256.5105012923295, 4298.720583162084, 4348.847790327323, 4354.934675979863, 4411.073674528385, 3722.050877026341, 3729.9440508392395, 3772.830222639988, 3819.770813751128, 3877.5734669186368, 4351.69538132334, 4413.889652758707, 4415.712978656377, 4417.690761646654, 4464.352668862996, 5065.11360511909, 5091.643584949018, 5098.949010509921, 5105.642605017687, 5110.540051395318, 4335.544767799399, 4389.758563279051, 4391.560843915647, 4402.889927751832, 4439.378487011821, 4656.534346565317, 4662.463816661128, 4662.883427914329, 4698.201305778026, 4707.152712511781, 4848.32123502717, 4849.781759820746, 4857.587105096107, 4859.041943616822, 4897.730624815669, 4984.22744474607, 5048.621353398583, 5071.0872043032605, 5165.690058596496, 5211.426743058185, 4847.3698419205275, 4883.8290659826735, 4883.877903052452, 4909.3372394727685, 4929.6549241554185, 5049.798008079636, 5054.0, 5084.771185296597, 5101.46434624374, 5162.97418512905, 4981.726005069756, 5035.967626636604, 5128.487151284841, 5143.691378517301, 5196.194589838581, 4959.7272150032095, 4986.227134794112, 5012.04771093491, 5034.823781167642, 5095.337606111182, 4974.651774375904, 5003.749812509287, 5014.247862820606, 5020.87447813793, 5061.974690126526, 4751.762411879461, 4850.902981940271, 4897.534734200245, 4908.092002979461, 4914.680545764514, 5016.54851063406, 5036.773345199548, 5037.093323201859, 5081.974590127025, 5083.593312535062, 4918.213085906238, 4918.360613120271, 4929.383827021622, 4936.03747269279, 4990.126727822544], "value": 4678.9643276941215, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.1634176172529, 552.0559842669036, 553.8172403106975, 564.1903867949492, 575.8531574448515, 36836.63163368365, 38678.0, 38689.226215475675, 42605.36091958623, 42657.0, 40355.192896142056, 40847.387289190614, 40857.59142408575, 40911.18177636446, 40934.795326023406, 7429.145648250439, 7504.4371672124535, 7505.962470187669, 7534.547927124363, 7556.50882692626, 7427.071616047994, 7566.092068951733, 7575.053118360205, 7587.544747315151, 7587.544747315179, 7606.809829754273, 7625.237476252358, 7661.846763064736, 7662.616869156548, 7674.232576742309, 7576.772696819105, 7604.657790399446, 7630.961845190794, 7635.121960974503, 7637.045369328834, 7454.291842274975, 7563.092428908566, 7590.0, 7595.126560445564, 7603.961980190119, 37729.0, 37952.620473795185, 38136.237275254614, 38361.808190958865, 38375.04062398434, 2954.9556756648453, 2994.550817377411, 3092.1651154188467, 3369.3261347730554, 3406.9659303407143, 27697.307567310778, 27969.580456293173, 28296.292592685142, 28352.0, 28443.857780711172, 3420.1620602952435, 3443.810590417526, 3546.4503002034467, 3648.343298206322, 3723.385641369171, 241346.0, 242579.0, 244266.0, 245358.0, 245943.99999999822, 50197.24704129441, 50894.491055088976, 50926.23610645843, 51085.23372149421, 51152.0, 53154.73422632862, 53184.0, 53559.19661205085, 53637.0, 53870.730646346514, 13544.796828047587, 13802.37889294984, 13825.446982120602, 13835.169889806644, 13848.861511384757, 10035.548400322003, 10129.59481620727, 10144.797104058025, 10152.0, 10190.643327483502, 15445.536633901002, 15612.267853125657, 15718.528444146694, 15750.76373854393, 15825.208739562975, 3005.3989202159655, 5200.869978250498, 5659.377468478464, 5663.093904975184, 5815.651060936358, 787.6534324897027, 878.9560521973875, 889.2441424789007, 945.7257395355407, 973.7419583810296, 27686.307842304104, 27828.443431131265, 27875.0, 27948.86025569859, 28414.147575572766, 913.9352654157832, 941.0589410589411, 946.5220063867703, 957.0238356875948, 958.1568219966524, 13940.930295348458, 14711.33798979027, 14718.852811471748, 14920.850791491946, 15022.474213402696, 355601.0, 359921.0, 361584.0, 362710.0, 364537.0, 47507.76246118816, 48326.516734832905, 48335.0, 48418.5158148421, 48419.757901210265, 1133.5919069135105, 1145.9656210313703, 1149.0462915779883, 1160.031373802884, 1165.5279611757421, 25291.241262762145, 26390.604140938285, 27388.178354649393, 27610.0, 27817.44365112727, 41189.382159268236, 41551.7922410386, 41563.7921810389, 41574.58425415828, 41595.58404415917, 315231.0, 315649.0, 316331.0, 316398.0, 316862.0, 24520.386990325384, 25017.499650007263, 25071.87464062668, 25113.372165696004, 25124.24627261185, 39956.600433995285, 40601.0, 40780.0, 41704.58295417128, 41974.58025419707, 34227.0, 35231.373646697044, 36245.0, 36693.0, 36752.448713269856, 34983.475247870796, 35186.648133518334, 35417.645823542465, 35535.822320888234, 35818.28363432769, 34521.82739086288, 34635.0, 34858.65141348656, 34915.30169396649, 35482.645173547935, 29078.854605726836, 32331.35337293194, 32435.837820810746, 32450.83774581112, 32652.673473264964, 24467.877660611583, 24514.877425612758, 24559.50880982406, 24789.87605061963, 24913.750862491866], "value": 16940.6168684254, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.99827500862506, 352.1197007481297, 355.0, 359.1398600352157, 382.269864558693, 15174.786017118631, 15490.457833975814, 16760.32958681651, 16893.83106168938, 17049.147542622883, 12795.232286062843, 14908.552743417687, 15896.125713085776, 16007.759883601726, 16889.746653800205, 4992.375953005874, 5255.605829562779, 5258.0272649559765, 5259.76331065103, 5264.0, 4987.975060124694, 5028.396592408916, 5165.328507294046, 5169.974150129244, 5215.217717342391, 5232.973835130819, 5237.764300606482, 5250.921236181442, 5251.159814429692, 5259.184826351902, 4952.579030782388, 5173.456787037382, 5195.844124676266, 5201.479852014787, 5223.529882310591, 4533.138703646297, 4549.45406551216, 4565.977170114162, 4567.2692369221095, 4576.931346029813, 16644.66710665792, 20310.492237694027, 20702.482437939023, 20746.377608671763, 20797.0, 1868.6449574580922, 1931.9323823666246, 1958.3243780895568, 2052.794720527935, 2270.6594010898334, 12845.550405735754, 13036.348182590833, 13183.274919879403, 13608.591742247749, 14021.0, 1725.775649165613, 1726.4475367882283, 1743.2416898649128, 1775.9644807103787, 1798.9460316190534, 69037.65481172562, 69165.35433070867, 69593.0, 70104.6494767528, 70858.29141708568, 9073.500957447404, 9287.164155226063, 9436.339456237998, 9508.334416590773, 9744.269179811543, 13204.537841175512, 13291.933540332237, 13325.0, 13350.799738003938, 13365.264910429825, 5937.584369094208, 6275.246970363585, 6703.4972377070935, 6868.690908909111, 7077.063018847224, 6654.367835055662, 6663.933360666429, 6812.965935170391, 6853.691583878638, 6880.036794848726, 5840.445157710011, 5963.880722385528, 5970.432808883149, 5993.820185394445, 6099.969500152471, 1696.4401747423321, 1709.3162734906136, 1737.426649205759, 1738.782652168479, 1759.4105974498686, 848.6732607945862, 862.6549380247951, 890.692711014699, 923.9974627529072, 939.8402271613842, 16224.918875405783, 16431.917840410722, 16466.917665411835, 16512.504624861274, 16759.1620418981, 823.1603764160523, 847.8473874702613, 850.7362717557577, 859.5573279760928, 863.8617821148586, 9860.605575776888, 10039.749006274902, 10156.4921753912, 10176.440295783656, 10177.389356638625, 275493.0, 278439.0, 343781.0, 347734.0, 349699.0, 80048.19951800407, 82497.58751206206, 82673.0, 83298.58350708208, 84246.0, 903.8508646073324, 919.7148883846163, 940.8165407745424, 943.0757857299884, 945.645382981382, 15487.84512154864, 15578.298976545855, 15791.131487768283, 15939.442119526224, 16113.597160071093, 24929.87535062313, 27409.0, 36285.63714362928, 39048.219035619695, 39388.803055984536, 40486.0, 42051.0, 46733.532664674276, 47373.289400659705, 52495.21257181222, 6365.745370185141, 6668.599884006975, 6979.4765392594745, 7069.151701795818, 7620.54276743375, 10976.725581860197, 11726.0, 11744.941275293912, 11754.76490470203, 12071.0, 5501.944980550144, 9748.757785709186, 9770.75573110678, 9903.613494110687, 10099.14157296638, 5015.974920125376, 6965.651717414008, 9882.209423246266, 9968.255555277652, 10305.124064454605, 9976.20190384753, 9987.650432234837, 10060.547275372479, 10224.795504090025, 10490.108340791117, 7119.750808721877, 7244.927550724426, 7249.311315425026, 7312.81717957034, 7423.517471364344, 8074.878876816735, 10123.24075694311, 10166.8474972874, 10477.895221047997, 10579.36523808574], "value": 8029.107488465909, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1368.493657346782, 1391.09578773797, 1470.6468454824442, 1617.0, 1668.824773398793, 6895.724171033153, 7155.785326440215, 7159.284071592838, 7743.186965368633, 7747.573883436416, 7405.259474052592, 7824.5305281682995, 7827.0, 7853.842923141534, 7857.096433910102, 2136.2843447445125, 2141.122139922632, 2154.310620601408, 2157.9568408631817, 2158.7733288004692, 2039.9184032638677, 2065.493953981269, 2171.0881429799524, 2171.6525355943054, 2173.9456513587206, 2108.1356643776053, 2128.2231985325398, 2134.658454647257, 2136.166894910986, 2136.594047131048, 2074.1495986645405, 2083.510375061859, 2092.61286661968, 2095.0153427888945, 2098.129276350313, 2035.6030574038068, 2112.23959374625, 2118.3433135727973, 2126.1389137399224, 2126.776688447706, 7682.846343073107, 7852.0, 7865.960670196612, 7886.960565197137, 7909.723159689441, 4408.14041261954, 4533.886652833673, 4540.046590216059, 4542.341360502709, 4544.204764166291, 2798.8460634665084, 2812.2125804774696, 2920.8977685780897, 2926.3708302714804, 2932.5747766573727, 859.3772940381939, 913.1279627955287, 933.0902370189079, 938.2775263047415, 939.9389039712397, 10166.288359814816, 10169.644062457852, 10209.183265338756, 10218.33580817252, 10330.225233107472, 3845.4808600839087, 3990.1221731219084, 4038.2932986727205, 4152.045029643199, 4168.624823765876, 8751.912480875237, 8752.299816014704, 8775.166359195866, 8783.989841168348, 8785.956070219609, 4435.933460998088, 4493.842715504941, 4504.6396288296855, 4505.301678239878, 4521.796519156645, 3589.246258285737, 3705.388610879175, 3985.8405663773124, 4097.8770636880945, 4109.876703698894, 3465.428204346305, 3479.808610526445, 3569.714422846166, 3588.4258518636893, 3616.72874534411, 1167.1829719196596, 1168.7487190254137, 1181.3148373943263, 1184.3012622552562, 1186.4305133535952, 779.3297763923022, 788.731831177391, 792.6472719639705, 793.2583034862422, 800.8838718385801, 4873.415190177201, 4987.451380348159, 4998.275250088789, 4999.800007999712, 5121.385433747974, 360.43771716122933, 363.6817784438616, 377.8450835157572, 379.0240131660929, 392.25080097014563, 3312.453445181518, 3356.4965255211914, 3411.522386865841, 3504.842282097312, 3523.7709548879243, 9075.954620226856, 9459.337846350689, 9525.523723813782, 9532.52337383142, 9549.713508594614, 8687.34844886636, 9363.0, 9453.960064392912, 9484.383515071637, 9496.762580935532, 6696.631685257357, 7157.856842863113, 7199.1001124859395, 7237.927620723725, 7258.383037441771, 5003.374578177728, 5065.189569668983, 5197.896042079213, 5392.406835248198, 5453.291072160594, 8494.70268540598, 8495.872561911452, 8548.786280343042, 8599.484030958163, 8612.31101511865, 8455.830883382421, 8685.609147588248, 8766.91233087661, 8877.73366798997, 8880.200781929658, 6669.266380698023, 6764.154480689914, 6776.15298087739, 6812.965935170292, 6860.759873404407, 7247.710091596277, 7327.194008659149, 7333.449991250571, 7335.486515943832, 7343.155537113087, 6487.416132548094, 6583.144191255106, 6711.463082953254, 6741.86516269662, 6944.895826562504, 6545.696654112565, 6635.23694775107, 6686.465082793267, 6721.0, 6888.724451021903, 5831.0378787499585, 5848.444397782204, 5923.052311630118, 5926.525877929842, 5940.316863560746, 4286.314189729628, 4474.843380481798, 4480.9103817922805, 4543.7955292011275, 4575.611073058827, 4283.5502272260965, 4311.417958575677, 4336.219480493542, 4393.165298593385, 4416.8012439440945], "value": 3944.0227492973545, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.43553255928833, 271.5153451089805, 271.9401731619044, 275.0181850792671, 281.5087672012338, 4934.420985284711, 5050.242463630458, 5064.84805455836, 5066.316047333618, 5087.982403519301, 4912.7297998610065, 4943.8516844494725, 4966.708655749504, 4972.9751351243285, 4979.825706100287, 3872.67082298005, 3882.437046628237, 3883.3786594144945, 3885.5920128386397, 3896.27918835015, 3863.961360386388, 3867.994321476422, 3876.8643097491595, 3878.631530004645, 3909.0, 3606.9278614427694, 3819.694424446038, 3844.0774214188673, 3861.961380386202, 3869.6323849234277, 3809.8095095245126, 3818.694504439652, 3824.7760716570847, 3825.5791862895057, 3833.5591406987996, 3166.730827879633, 3376.9155771105675, 3379.1552111972005, 3379.239671074013, 3401.6768407001296, 4789.305550695164, 4793.5925446337105, 4885.389326334208, 4909.386326709161, 4911.361523002022, 4403.471583409979, 4408.625266852321, 4410.713303635285, 4416.160929423431, 4416.984093658444, 5000.774965126578, 5249.973750131225, 5262.500062494095, 5270.2358158067245, 5292.682439053669, 3721.60923103073, 3724.2179142380132, 3740.2706472237924, 3743.12036671382, 3746.737728359016, 5512.80705175321, 5541.030319694038, 5550.139728342073, 5554.0, 5563.831595364978, 3801.6049888570024, 3812.8284227209842, 3821.2739579479808, 3821.4267859820693, 3839.2705385976574, 3794.715396345285, 3796.1079146400575, 3803.9729273096664, 3820.7898565578603, 3850.9807450963126, 4366.14860102277, 4383.912321753547, 4385.912281754411, 4391.912161756811, 4392.3411488277015, 5184.507471790174, 5213.957208558303, 5247.344081989751, 5255.395629502656, 5264.92102618461, 1297.4939773488347, 1325.5029363988504, 1329.5678904356123, 1340.6782372230593, 1342.4630147940707, 817.3869597801648, 835.8746188071838, 849.8512760266929, 859.2824991132475, 861.4745005546612, 4073.551909289976, 4075.286824805647, 4079.714419990572, 4135.937960930589, 4148.460700108966, 4671.11248862715, 4698.929516057262, 4746.769018561271, 4780.948191397887, 4784.976075119602, 4150.750954942653, 4160.979195104005, 4171.3325867860995, 4171.561985991488, 4174.705841189241, 2383.6662867198606, 2522.2685421228007, 2530.0891678995545, 2555.658279403291, 2578.710644677661, 4507.977460112678, 4875.293082503017, 4938.9012219755405, 5008.774605142778, 5075.314832497639, 5492.0, 5529.677535435127, 5538.723063846872, 5540.9168862467095, 5549.556035517229, 5071.884185479189, 5089.847304580869, 5092.821751238689, 5103.234514822806, 5133.997740880985, 5154.252633368215, 5418.701971391453, 5442.727863606725, 5445.378823082606, 5452.427495113115, 5364.785408583769, 5370.275012873212, 5387.542058924879, 5388.194954690066, 5395.433479484597, 4921.335619691439, 5101.897962040664, 5119.436861945258, 5139.177731562932, 5142.305788718625, 3620.5517792883056, 3681.3925702258825, 3683.557973043252, 3689.9077523062138, 3712.777233366007, 5375.919361209507, 5389.919151212656, 5398.946010540001, 5438.782448702166, 5439.211314359317, 5164.457731938242, 5271.736413179402, 5289.391719952255, 5300.231466437422, 5311.814086506954, 5241.790328386975, 5262.947370526245, 5269.841904742864, 5272.971770504868, 5273.762680679455, 5210.108389843673, 5217.2434996925995, 5223.921641175461, 5237.607179461632, 5240.5807535397835, 5110.540051395392, 5175.922361164661, 5210.27056212123, 5250.737463126905, 5268.446813084724, 5123.87190320245, 5128.923066154085, 5130.256112863689, 5144.9742751286, 5147.253648221062], "value": 3865.855412714966, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.4451288045677, 646.6055706019329, 682.3415404135009, 697.9356481365917, 735.3124828285556, 12057.336846473441, 12747.10770246082, 13014.154079984793, 13143.27711975841, 14680.045797023186, 12865.16376435531, 13095.869041309585, 13099.0, 13099.47602095915, 13273.269970151638, 603.1887111834576, 749.8912657664636, 761.5240474703311, 765.6439755513685, 766.9769906902774, 621.0776996160698, 744.8696478116335, 768.4735955870219, 776.9611519424035, 779.4388040610751, 816.4570560577209, 817.9304759095484, 821.1829229916242, 822.2188920525494, 822.5517093184229, 812.6505602590884, 813.1055838577577, 813.3411936331561, 813.9267465928036, 814.0882211922655, 593.8129489210928, 599.2629066248495, 600.0, 600.5555888642417, 600.6066026752484, 12343.38283085851, 12374.505019799197, 12391.380430978415, 12393.442295096742, 12410.81383779244, 12385.256884586954, 12561.748765024648, 12639.241645501208, 13058.412371443213, 13067.477300907953, 10122.228242229645, 10158.593656253815, 10274.22943279257, 10328.845067323997, 10562.68311950635, 3288.9835550822095, 3356.513305570703, 3364.3775901458307, 3368.747343949189, 3372.5278461015478, 62717.68641156811, 62904.685476572784, 63585.0, 63645.36354636487, 64584.67707661479, 10247.79672370444, 10276.0, 10382.480875956171, 10396.896031039743, 10507.054365107024, 19795.604087918447, 19842.50393740168, 19859.900700496404, 19861.801381985995, 19917.402477925687, 6648.13574235356, 6657.034729964128, 6710.228323742735, 6868.313168683092, 7039.014537964689, 3460.602030766444, 3486.3201675673, 3496.17839807645, 3537.4340105582983, 3539.734519911017, 2755.3662657588866, 2843.7440630342953, 2852.500812357829, 2860.914172574826, 2867.3691787806647, 487.9971658242275, 489.22213680247864, 491.7295487481871, 491.85643379143636, 498.10092782527886, 547.3103889099763, 565.0309718832141, 583.096200888621, 623.9095331176954, 631.6336524815596, 7203.96398018017, 7215.098112735908, 7303.233160518175, 7384.963075184697, 7566.373229755629, 545.8826352334268, 550.4055619930466, 571.7655761137913, 573.060181302664, 589.345826132992, 3379.797212167278, 3537.0, 3550.7039930425726, 3695.667389934865, 3742.644448777362, 51116.23325650118, 52170.47829521732, 88241.11758882458, 89031.0, 91335.0, 75434.0, 75709.24290757132, 75945.62027189939, 78026.0, 78741.0, 66922.33077669161, 69600.3039969614, 69745.65127174332, 70870.0, 71313.6434317825, 7302.853942921006, 7926.881096783668, 8103.270705636521, 8136.7152149674475, 8343.207395297437, 42527.0, 43485.0, 43785.34321985109, 43869.561304386545, 44873.32690009718, 54944.45055549553, 59831.0, 60687.089693655515, 62197.689011554656, 63451.36548634455, 9638.807223855343, 9676.70969870905, 9720.75698107553, 10056.84914726265, 10252.128569071712, 11422.143339249424, 11621.709457263298, 11645.126615503701, 12164.391780410768, 12281.324527151093, 9890.554925028247, 10442.895571044191, 10501.31741436804, 10620.150387969099, 11039.558417663204, 10334.586616535255, 10396.168306535308, 10412.843807342744, 10495.370277783357, 10900.836487452536, 9728.951355243462, 10093.444860532742, 10485.318454300446, 10698.62554810578, 10729.409882456539, 8728.607212675572, 8973.955130224307, 9155.450672959643, 9591.376560523544, 9965.35225210359, 8661.393702440768, 9120.954395227982, 9374.859377109486, 9376.390534615228, 9465.242780577675], "value": 6266.118733343004, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1578.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 114.0, 115.0, 115.0, 114.0, 115.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 128.0, 128.0, 181.0, 136.0, 130.0, 133.0, 129.0, 171.0, 131.0], "value": 142.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 163.0, 162.0, 162.0, 164.0, 166.0, 164.0, 163.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 107.0, 76.0, 78.0, 77.0, 76.0, 100.0, 77.0], "value": 82.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 125.0, 84.0, 85.0, 84.0, 116.0, 84.0, 84.0, 110.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 120.0, 118.0, 118.0, 119.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 150.0, 149.0, 150.0, 150.0], "value": 148.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 67.0, 67.0, 69.0, 67.0, 66.0, 67.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 65.0, 66.0, 67.0, 67.0, 67.0, 66.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 89.0, 86.0, 86.0, 84.0, 90.0, 90.0, 85.0, 90.0, 83.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 143.0, 152.0, 142.0, 147.0, 143.0, 152.0, 159.0, 183.0, 153.0], "value": 152.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [180.0, 173.0, 172.0, 175.0, 182.0, 175.0, 178.0, 180.0, 175.0, 176.0], "value": 176.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 72.0, 71.0, 74.0, 70.0, 71.0, 71.0, 73.0, 70.0, 72.0], "value": 71.5, "unit": "score"}]}]} 16:16:40 INFO - Return code: 0 16:16:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:16:40 ERROR - # TBPL SUCCESS # 16:16:40 INFO - Running post-action listener: _resource_record_post_action 16:16:40 INFO - [mozharness: 2016-10-08 23:16:40.936574Z] Finished run-tests step (success) 16:16:40 INFO - Running post-run listener: _resource_record_post_run 16:16:41 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 421888; Write bytes: 402624512; Read time: 44; Write time: 214416 16:16:41 INFO - TinderboxPrint: CPU usage
13.4% 16:16:41 INFO - TinderboxPrint: I/O read bytes / time
421,888 / 44 16:16:41 INFO - TinderboxPrint: I/O write bytes / time
402,624,512 / 214,416 16:16:41 INFO - TinderboxPrint: CPU idle
8,299.6 (86.6%) 16:16:41 INFO - TinderboxPrint: CPU user
1,224.1 (12.8%) 16:16:41 INFO - TinderboxPrint: Swap in / out
0 / 0 16:16:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110665728; Read time: 0; Write time: 55188 16:16:41 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 417792; Write bytes: 291061760; Read time: 32; Write time: 159184 16:16:41 INFO - Running post-run listener: _upload_blobber_files 16:16:41 INFO - Blob upload gear active. 16:16:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:16:41 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 16:16:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:16:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:16:41 INFO - (blobuploader) - INFO - Open directory for files ... 16:16:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:16:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:16:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:42 INFO - (blobuploader) - INFO - Done attempting. 16:16:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:16:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:46 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:16:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:46 INFO - (blobuploader) - INFO - Done attempting. 16:16:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:16:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:16:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:16:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:16:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:16:47 INFO - (blobuploader) - INFO - Done attempting. 16:16:47 INFO - (blobuploader) - INFO - Iteration through files over. 16:16:47 INFO - Return code: 0 16:16:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:16:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:16:47 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dbc019d2dac80891de7d38a5e974c281506e7dbabf155e4696719e74efa689b14acc8ee8eb2c375716be6d0af2f6168e72f6814c432051b8709c66dc71f887a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cb179ca028f4d61a6d597491a5ea40296b18705b5558a5ee8840fd215b452a0001e109d7952ba098025fd4357edb12f143c93c4a84729738afd71bd762afdcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d75b72e9f42735f99c76f46e8c1bd12ceae1be2659151b49f70ce182bf7ebbf7a6e145d89610afa31ca5a066d8f63e259ffb21f8b95b4b1d1f2ca7e35fdac756"} 16:16:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:16:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:16:47 INFO - Contents: 16:16:47 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dbc019d2dac80891de7d38a5e974c281506e7dbabf155e4696719e74efa689b14acc8ee8eb2c375716be6d0af2f6168e72f6814c432051b8709c66dc71f887a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cb179ca028f4d61a6d597491a5ea40296b18705b5558a5ee8840fd215b452a0001e109d7952ba098025fd4357edb12f143c93c4a84729738afd71bd762afdcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d75b72e9f42735f99c76f46e8c1bd12ceae1be2659151b49f70ce182bf7ebbf7a6e145d89610afa31ca5a066d8f63e259ffb21f8b95b4b1d1f2ca7e35fdac756"} 16:16:47 INFO - Running post-run listener: copy_logs_to_upload_dir 16:16:47 INFO - Copying logs to upload dir... 16:16:47 INFO - mkdir: /builds/slave/test/build/upload/logs 16:16:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.622830 ========= master_lag: 0.25 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-10-08 16:16:47.501082) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 16:16:47.504501) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dbc019d2dac80891de7d38a5e974c281506e7dbabf155e4696719e74efa689b14acc8ee8eb2c375716be6d0af2f6168e72f6814c432051b8709c66dc71f887a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cb179ca028f4d61a6d597491a5ea40296b18705b5558a5ee8840fd215b452a0001e109d7952ba098025fd4357edb12f143c93c4a84729738afd71bd762afdcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d75b72e9f42735f99c76f46e8c1bd12ceae1be2659151b49f70ce182bf7ebbf7a6e145d89610afa31ca5a066d8f63e259ffb21f8b95b4b1d1f2ca7e35fdac756"} build_url:https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/S92-B2OJQYWc5RlMH4KW4A/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8dbc019d2dac80891de7d38a5e974c281506e7dbabf155e4696719e74efa689b14acc8ee8eb2c375716be6d0af2f6168e72f6814c432051b8709c66dc71f887a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6cb179ca028f4d61a6d597491a5ea40296b18705b5558a5ee8840fd215b452a0001e109d7952ba098025fd4357edb12f143c93c4a84729738afd71bd762afdcb", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d75b72e9f42735f99c76f46e8c1bd12ceae1be2659151b49f70ce182bf7ebbf7a6e145d89610afa31ca5a066d8f63e259ffb21f8b95b4b1d1f2ca7e35fdac756"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-08 16:16:47.529184) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 16:16:47.529470) ========= 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=9e0dfe3369c33a1556e63f89000001d8-1475963325.674809-1918880979 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-08 16:16:47.579042) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 16:16:47.579371) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-08 16:16:47.579649) ========= ========= Total master_lag: 0.36 =========