builder: larch_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1475871075.19 results: success (0) buildid: 20161007113100 builduid: d87b637329c447ddab13a697c31a1695 revision: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:15.187611) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:15.188054) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:15.188324) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:15.209075) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:15.209346) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-07 13:11:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 19.5M=0.001s 2016-10-07 13:11:15 (19.5 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.180404 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:15.415561) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:15.415883) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.077403 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:15.504020) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 13:11:15.504364) ========= bash -c 'python archiver_client.py mozharness --repo projects/larch --rev 259c110bf47100196fd28e35c47c4e23bf9ad0a9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/larch --rev 259c110bf47100196fd28e35c47c4e23bf9ad0a9 --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=8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-07 13:11:15,567 truncating revision to first 12 chars 2016-10-07 13:11:15,567 Setting DEBUG logging. 2016-10-07 13:11:15,567 attempt 1/10 2016-10-07 13:11:15,567 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/larch/259c110bf471?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-07 13:11:16,808 unpacking tar archive at: larch-259c110bf471/testing/mozharness/ program finished with exit code 0 elapsedTime=1.624868 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-07 13:11:17.143941) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:17.144448) ========= script_repo_revision: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:17.145079) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:17.145517) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-07 13:11:17.153090) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-10-07 13:11:17.153376) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Larch-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Larch-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:11:17 INFO - MultiFileLogger online at 20161007 13:11:17 in /builds/slave/test 13:11:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Larch-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Larch-Non-PGO 13:11:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:11:17 INFO - {'append_to_log': False, 13:11:17 INFO - 'base_work_dir': '/builds/slave/test', 13:11:17 INFO - 'blob_upload_branch': 'Larch-Non-PGO', 13:11:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:11:17 INFO - 'branch': 'Larch-Non-PGO', 13:11:17 INFO - 'buildbot_json_path': 'buildprops.json', 13:11:17 INFO - 'config_files': ('talos/linux_config.py',), 13:11:17 INFO - 'default_actions': ('clobber', 13:11:17 INFO - 'read-buildbot-config', 13:11:17 INFO - 'download-and-extract', 13:11:17 INFO - 'populate-webroot', 13:11:17 INFO - 'create-virtualenv', 13:11:17 INFO - 'install', 13:11:17 INFO - 'run-tests'), 13:11:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:11:17 INFO - 'download_minidump_stackwalk': True, 13:11:17 INFO - 'download_symbols': 'ondemand', 13:11:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:11:17 INFO - 'tooltool.py': '/tools/tooltool.py', 13:11:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:11:17 INFO - '/tools/misc-python/virtualenv.py')}, 13:11:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:11:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:11:17 INFO - 'installer_path': 'installer.exe', 13:11:17 INFO - 'log_level': 'info', 13:11:17 INFO - 'log_name': 'talos', 13:11:17 INFO - 'log_to_console': True, 13:11:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:11:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:11:17 INFO - 'opt_config_files': (), 13:11:17 INFO - 'pip_index': False, 13:11:17 INFO - 'sps_profile': False, 13:11:17 INFO - 'sps_profile_interval': 0, 13:11:17 INFO - 'suite': 'dromaeojs-e10s', 13:11:17 INFO - 'system_bits': '32', 13:11:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:11:17 INFO - 'title': 'talos-linux64-ix-001', 13:11:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:11:17 INFO - 'use_talos_json': True, 13:11:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:11:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:11:17 INFO - 'work_dir': 'build'} 13:11:17 INFO - [mozharness: 2016-10-07 20:11:17.424470Z] Running clobber step. 13:11:17 INFO - Running pre-action listener: _resource_record_pre_action 13:11:17 INFO - Running main action method: clobber 13:11:17 INFO - rmtree: /builds/slave/test/build 13:11:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:11:22 INFO - Running post-action listener: _resource_record_post_action 13:11:22 INFO - [mozharness: 2016-10-07 20:11:22.326512Z] Finished clobber step (success) 13:11:22 INFO - [mozharness: 2016-10-07 20:11:22.326632Z] Running read-buildbot-config step. 13:11:22 INFO - Running pre-action listener: _resource_record_pre_action 13:11:22 INFO - Running main action method: read_buildbot_config 13:11:22 INFO - Using buildbot properties: 13:11:22 INFO - { 13:11:22 INFO - "project": "", 13:11:22 INFO - "product": "firefox", 13:11:22 INFO - "script_repo_revision": "production", 13:11:22 INFO - "builddir": "larch_ubuntu64_hw_test-dromaeojs-e10s", 13:11:22 INFO - "repository": "", 13:11:22 INFO - "buildername": "Ubuntu HW 12.04 x64 larch talos dromaeojs-e10s", 13:11:22 INFO - "buildid": "20161007113100", 13:11:22 INFO - "pgo_build": "False", 13:11:22 INFO - "basedir": "/builds/slave/test", 13:11:22 INFO - "buildnumber": 0, 13:11:22 INFO - "slavename": "talos-linux64-ix-001", 13:11:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:11:22 INFO - "platform": "ubuntu64_hw", 13:11:22 INFO - "scheduler": "tests-larch-linux64-talos", 13:11:22 INFO - "branch": "larch", 13:11:22 INFO - "repo_path": "projects/larch", 13:11:22 INFO - "revision": "259c110bf47100196fd28e35c47c4e23bf9ad0a9", 13:11:22 INFO - "stage_platform": "linux64", 13:11:22 INFO - "builduid": "d87b637329c447ddab13a697c31a1695", 13:11:22 INFO - "slavebuilddir": "test" 13:11:22 INFO - } 13:11:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 13:11:22 INFO - Running post-action listener: _resource_record_post_action 13:11:22 INFO - [mozharness: 2016-10-07 20:11:22.329577Z] Finished read-buildbot-config step (success) 13:11:22 INFO - [mozharness: 2016-10-07 20:11:22.329683Z] Running download-and-extract step. 13:11:22 INFO - Running pre-action listener: _resource_record_pre_action 13:11:22 INFO - Running main action method: download_and_extract 13:11:22 INFO - mkdir: /builds/slave/test/build/tests 13:11: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')]} 13:11:22 INFO - trying https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:11:22 INFO - Downloading https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/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 13:11:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/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 13:11:22 INFO - Downloaded 1361 bytes. 13:11:22 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 13:11:22 INFO - Using the following test package requirements: 13:11:22 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:11:22 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 13:11:22 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 13:11:22 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:22 INFO - u'jsshell-linux-x86_64.zip'], 13:11:22 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 13:11:22 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 13:11:22 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 13:11:22 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 13:11:22 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 13:11:22 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 13:11:22 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 13:11:22 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:11:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:11:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:11:22 INFO - Fetch https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:11:23 INFO - Http code: 200 13:11:23 INFO - via: 1.1 6cd88b9fd84ad5daa3b3867fb8c5c91a.cloudfront.net (CloudFront) 13:11:23 INFO - x-amz-cf-id: -sbvPzym1PB4wOOv8IJhs2f4AtEpolu3fVgQs8wemhwksrBl1shJug== 13:11:23 INFO - x-amz-version-id: ledFm5ZGJ2erqTUOPFQ9rO8tBW2GhDhI 13:11:23 INFO - Expected file size: 20420581 13:11:23 INFO - Obtained file size: 20420581 13:11:27 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 13:11:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 13:11:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:11:27 INFO - Fetch https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 13:11:28 INFO - Http code: 200 13:11:28 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 13:11:28 INFO - x-amz-cf-id: luhq-KIDRP8ypcZGoXu6arEowpZqOIjb1JPzBQvN_olRs3golXiDIA== 13:11:28 INFO - x-amz-version-id: ledFm5ZGJ2erqTUOPFQ9rO8tBW2GhDhI 13:11:28 INFO - Expected file size: 20420581 13:11:28 INFO - Obtained file size: 20420581 13:11:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 13:11:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:11:33 INFO - Fetch https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 13:11:34 INFO - Http code: 200 13:11:34 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 13:11:34 INFO - x-amz-cf-id: BiuIjG4CMqAyLAjE9vEzMICsGro3u2V4vfiex1nX4LD8mPAdBfp-qw== 13:11:34 INFO - x-amz-version-id: _3jg.7vNlViTEqE73kxi6GtNn8YImg3A 13:11:34 INFO - Expected file size: 14408522 13:11:34 INFO - Obtained file size: 14408522 13:11: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')]} 13:11:34 INFO - trying https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:11:34 INFO - Downloading https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/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 13:11:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/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 13:11:35 INFO - Downloaded 55812306 bytes. 13:11:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:11:35 INFO - mkdir: /builds/slave/test/properties 13:11:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:11:35 INFO - Writing to file /builds/slave/test/properties/build_url 13:11:35 INFO - Contents: 13:11:35 INFO - build_url:https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 13:11:36 INFO - Running post-action listener: _resource_record_post_action 13:11:36 INFO - Running post-action listener: set_extra_try_arguments 13:11:36 INFO - [mozharness: 2016-10-07 20:11:36.645611Z] Finished download-and-extract step (success) 13:11:36 INFO - [mozharness: 2016-10-07 20:11:36.645836Z] Running populate-webroot step. 13:11:36 INFO - Running pre-action listener: _resource_record_pre_action 13:11:36 INFO - Running main action method: populate_webroot 13:11:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:11:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:11:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:11:36 INFO - '--tppagecycles', 13:11:36 INFO - '7'], 13:11:36 INFO - 'tests': ['tsvgm']}}, 13:11:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:11:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:11:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:11:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:11:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:36 INFO - 'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:11:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:36 INFO - 'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['damp', 'tps']}, 13:11:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:36 INFO - 'tests': ['damp', 'tps']}, 13:11:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['dromaeo_dom']}, 13:11:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:11:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['basic_compositor_video']}, 13:11:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:11:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['a11yr', 13:11:36 INFO - 'ts_paint', 13:11:36 INFO - 'tpaint', 13:11:36 INFO - 'sessionrestore', 13:11:36 INFO - 'sessionrestore_no_auto_restore', 13:11:36 INFO - 'tabpaint']}, 13:11:36 INFO - 'other-e10s': {'tests': ['a11yr', 13:11:36 INFO - 'ts_paint', 13:11:36 INFO - 'tpaint', 13:11:36 INFO - 'sessionrestore', 13:11:36 INFO - 'sessionrestore_no_auto_restore', 13:11:36 INFO - 'tabpaint']}, 13:11:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:11:36 INFO - 'ts_paint', 13:11:36 INFO - 'tpaint', 13:11:36 INFO - 'sessionrestore', 13:11:36 INFO - 'sessionrestore_no_auto_restore', 13:11:36 INFO - 'tabpaint']}, 13:11:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:11:36 INFO - 'ts_paint', 13:11:36 INFO - 'tpaint', 13:11:36 INFO - 'sessionrestore', 13:11:36 INFO - 'sessionrestore_no_auto_restore', 13:11:36 INFO - 'tabpaint']}, 13:11:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['a11yr', 13:11:36 INFO - 'ts_paint', 13:11:36 INFO - 'tpaint', 13:11:36 INFO - 'sessionrestore', 13:11:36 INFO - 'sessionrestore_no_auto_restore', 13:11:36 INFO - 'tabpaint']}, 13:11:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['a11yr', 13:11:36 INFO - 'ts_paint', 13:11:36 INFO - 'tpaint', 13:11:36 INFO - 'sessionrestore', 13:11:36 INFO - 'sessionrestore_no_auto_restore', 13:11:36 INFO - 'tabpaint']}, 13:11:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['tsvgx', 13:11:36 INFO - 'tsvgr_opacity', 13:11:36 INFO - 'tart', 13:11:36 INFO - 'tscrollx', 13:11:36 INFO - 'cart']}, 13:11:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:11:36 INFO - 'tsvgr_opacity', 13:11:36 INFO - 'tart', 13:11:36 INFO - 'tscrollx', 13:11:36 INFO - 'cart']}, 13:11:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:36 INFO - 'talos_options': ['--disable-e10s'], 13:11:36 INFO - 'tests': ['tp5o']}, 13:11:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:36 INFO - 'tests': ['tp5o']}, 13:11:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:36 INFO - 'talos_options': ['--disable-e10s', 13:11:36 INFO - '--xperf_path', 13:11:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:36 INFO - 'tests': ['tp5n']}, 13:11:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:11:36 INFO - 'talos_options': ['--xperf_path', 13:11:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:11:36 INFO - 'tests': ['tp5n']}}, 13:11:36 INFO - 'talos.zip': {'path': '', 13:11:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:11:36 INFO - Running post-action listener: _resource_record_post_action 13:11:36 INFO - [mozharness: 2016-10-07 20:11:36.663260Z] Finished populate-webroot step (success) 13:11:36 INFO - [mozharness: 2016-10-07 20:11:36.663348Z] Running create-virtualenv step. 13:11:36 INFO - Running pre-action listener: _resource_record_pre_action 13:11:36 INFO - Running main action method: create_virtualenv 13:11:36 INFO - Creating virtualenv /builds/slave/test/build/venv 13:11:36 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:11:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:11:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:11:36 INFO - Using real prefix '/usr' 13:11:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:11:37 INFO - Installing distribute.............................................................................................................................................................................................done. 13:11:39 INFO - Installing pip.................done. 13:11:39 INFO - Return code: 0 13:11:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:11:39 INFO - Reading from file tmpfile_stdout 13:11:39 INFO - Output received: 13:11:39 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:11:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f79da970f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', '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 13:11:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:11:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:11:39 INFO - Using env: {'DISPLAY': ':0', 13:11:39 INFO - 'HOME': '/home/cltbld', 13:11:39 INFO - 'LANG': 'en_US.UTF-8', 13:11:39 INFO - 'LANGUAGE': 'en_US:en', 13:11:39 INFO - 'LOGNAME': 'cltbld', 13:11:39 INFO - 'MAIL': '/var/mail/cltbld', 13:11:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:39 INFO - 'MOZ_NO_REMOTE': '1', 13:11:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:39 INFO - 'NO_EM_RESTART': '1', 13:11:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:39 INFO - 'PWD': '/builds/slave/test', 13:11:39 INFO - 'SHELL': '/bin/bash', 13:11:39 INFO - 'SHLVL': '1', 13:11:39 INFO - 'TERM': 'linux', 13:11:39 INFO - 'TMOUT': '86400', 13:11:39 INFO - 'USER': 'cltbld', 13:11:39 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:11:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:39 INFO - '_': '/tools/buildbot/bin/python'} 13:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:40 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 13:11:40 INFO - Cleaning up... 13:11:40 INFO - Return code: 0 13:11:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:11:40 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')]} 13:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:40 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')]} 13:11:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:40 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 0x7f79da970f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', '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 13:11:40 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 13:11:40 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 13:11:40 INFO - Using env: {'DISPLAY': ':0', 13:11:40 INFO - 'HOME': '/home/cltbld', 13:11:40 INFO - 'LANG': 'en_US.UTF-8', 13:11:40 INFO - 'LANGUAGE': 'en_US:en', 13:11:40 INFO - 'LOGNAME': 'cltbld', 13:11:40 INFO - 'MAIL': '/var/mail/cltbld', 13:11:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:40 INFO - 'MOZ_NO_REMOTE': '1', 13:11:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:40 INFO - 'NO_EM_RESTART': '1', 13:11:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:40 INFO - 'PWD': '/builds/slave/test', 13:11:40 INFO - 'SHELL': '/bin/bash', 13:11:40 INFO - 'SHLVL': '1', 13:11:40 INFO - 'TERM': 'linux', 13:11:40 INFO - 'TMOUT': '86400', 13:11:40 INFO - 'USER': 'cltbld', 13:11:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:11:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:40 INFO - '_': '/tools/buildbot/bin/python'} 13:11:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:40 INFO - Downloading/unpacking psutil>=3.1.1 13:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:11:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:42 INFO - Installing collected packages: psutil 13:11:42 INFO - Running setup.py install for psutil 13:11:42 INFO - building 'psutil._psutil_linux' extension 13:11:42 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 13:11:43 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 13:11:43 INFO - building 'psutil._psutil_posix' extension 13:11:43 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 13:11:44 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 13:11:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:11:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:11:44 INFO - Successfully installed psutil 13:11:44 INFO - Cleaning up... 13:11:44 INFO - Return code: 0 13:11:44 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f79da970f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', '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 13:11:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:11:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:11:44 INFO - Using env: {'DISPLAY': ':0', 13:11:44 INFO - 'HOME': '/home/cltbld', 13:11:44 INFO - 'LANG': 'en_US.UTF-8', 13:11:44 INFO - 'LANGUAGE': 'en_US:en', 13:11:44 INFO - 'LOGNAME': 'cltbld', 13:11:44 INFO - 'MAIL': '/var/mail/cltbld', 13:11:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:44 INFO - 'MOZ_NO_REMOTE': '1', 13:11:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:44 INFO - 'NO_EM_RESTART': '1', 13:11:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:44 INFO - 'PWD': '/builds/slave/test', 13:11:44 INFO - 'SHELL': '/bin/bash', 13:11:44 INFO - 'SHLVL': '1', 13:11:44 INFO - 'TERM': 'linux', 13:11:44 INFO - 'TMOUT': '86400', 13:11:44 INFO - 'USER': 'cltbld', 13:11:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:11:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:44 INFO - '_': '/tools/buildbot/bin/python'} 13:11:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:11:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:11:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:11:46 INFO - Installing collected packages: mozsystemmonitor 13:11:46 INFO - Running setup.py install for mozsystemmonitor 13:11:46 INFO - Successfully installed mozsystemmonitor 13:11:46 INFO - Cleaning up... 13:11:46 INFO - Return code: 0 13:11:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:11:46 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')]} 13:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:46 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')]} 13:11:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:46 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 0x7f79da970f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', '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 13:11:46 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 13:11:46 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 13:11:46 INFO - Using env: {'DISPLAY': ':0', 13:11:46 INFO - 'HOME': '/home/cltbld', 13:11:46 INFO - 'LANG': 'en_US.UTF-8', 13:11:46 INFO - 'LANGUAGE': 'en_US:en', 13:11:46 INFO - 'LOGNAME': 'cltbld', 13:11:46 INFO - 'MAIL': '/var/mail/cltbld', 13:11:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:46 INFO - 'MOZ_NO_REMOTE': '1', 13:11:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:46 INFO - 'NO_EM_RESTART': '1', 13:11:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:46 INFO - 'PWD': '/builds/slave/test', 13:11:46 INFO - 'SHELL': '/bin/bash', 13:11:46 INFO - 'SHLVL': '1', 13:11:46 INFO - 'TERM': 'linux', 13:11:46 INFO - 'TMOUT': '86400', 13:11:46 INFO - 'USER': 'cltbld', 13:11:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:11:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:46 INFO - '_': '/tools/buildbot/bin/python'} 13:11:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:46 INFO - Downloading/unpacking jsonschema==2.5.1 13:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:11:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:11:48 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 13:11:48 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 13:11:48 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 13:11:48 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 13:11:48 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 13:11:48 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 13:11:49 INFO - Downloading functools32-3.2.3-2.tar.gz 13:11:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:11:49 INFO - warning: no files found matching '*.txt' 13:11:49 INFO - no previously-included directories found matching 'build' 13:11:49 INFO - no previously-included directories found matching 'dist' 13:11:49 INFO - no previously-included directories found matching '.git*' 13:11:49 INFO - Installing collected packages: jsonschema, functools32 13:11:49 INFO - Running setup.py install for functools32 13:11:49 INFO - warning: no files found matching '*.txt' 13:11:49 INFO - no previously-included directories found matching 'build' 13:11:49 INFO - no previously-included directories found matching 'dist' 13:11:49 INFO - no previously-included directories found matching '.git*' 13:11:49 INFO - Successfully installed jsonschema functools32 13:11:49 INFO - Cleaning up... 13:11:49 INFO - Return code: 0 13:11:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f79da970f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', '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 13:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:11:49 INFO - Using env: {'DISPLAY': ':0', 13:11:49 INFO - 'HOME': '/home/cltbld', 13:11:49 INFO - 'LANG': 'en_US.UTF-8', 13:11:49 INFO - 'LANGUAGE': 'en_US:en', 13:11:49 INFO - 'LOGNAME': 'cltbld', 13:11:49 INFO - 'MAIL': '/var/mail/cltbld', 13:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:49 INFO - 'MOZ_NO_REMOTE': '1', 13:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:49 INFO - 'NO_EM_RESTART': '1', 13:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:49 INFO - 'PWD': '/builds/slave/test', 13:11:49 INFO - 'SHELL': '/bin/bash', 13:11:49 INFO - 'SHLVL': '1', 13:11:49 INFO - 'TERM': 'linux', 13:11:49 INFO - 'TMOUT': '86400', 13:11:49 INFO - 'USER': 'cltbld', 13:11:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:49 INFO - '_': '/tools/buildbot/bin/python'} 13:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:11:49 INFO - Cleaning up... 13:11:49 INFO - Return code: 0 13:11:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f79da970f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', '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 13:11:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:11:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:11:49 INFO - Using env: {'DISPLAY': ':0', 13:11:49 INFO - 'HOME': '/home/cltbld', 13:11:49 INFO - 'LANG': 'en_US.UTF-8', 13:11:49 INFO - 'LANGUAGE': 'en_US:en', 13:11:49 INFO - 'LOGNAME': 'cltbld', 13:11:49 INFO - 'MAIL': '/var/mail/cltbld', 13:11:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:49 INFO - 'MOZ_NO_REMOTE': '1', 13:11:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:49 INFO - 'NO_EM_RESTART': '1', 13:11:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:49 INFO - 'PWD': '/builds/slave/test', 13:11:49 INFO - 'SHELL': '/bin/bash', 13:11:49 INFO - 'SHLVL': '1', 13:11:49 INFO - 'TERM': 'linux', 13:11:49 INFO - 'TMOUT': '86400', 13:11:49 INFO - 'USER': 'cltbld', 13:11:49 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:11:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:49 INFO - '_': '/tools/buildbot/bin/python'} 13:11:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:49 INFO - Downloading/unpacking blobuploader==1.2.4 13:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:11:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:11:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:11:51 INFO - Downloading blobuploader-1.2.4.tar.gz 13:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:11:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:11:51 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 13:11:51 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 13:11:51 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 13:11:51 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 13:11:51 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 13:11:51 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 13:11:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:11:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:11:52 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 13:11:52 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 13:11:52 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 13:11:52 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 13:11:52 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 13:11:52 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 13:11:52 INFO - Downloading docopt-0.6.1.tar.gz 13:11:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:11:52 INFO - Installing collected packages: blobuploader, requests, docopt 13:11:52 INFO - Running setup.py install for blobuploader 13:11:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:11:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:11:52 INFO - Running setup.py install for requests 13:11:52 INFO - Running setup.py install for docopt 13:11:52 INFO - Successfully installed blobuploader requests docopt 13:11:52 INFO - Cleaning up... 13:11:53 INFO - Return code: 0 13:11:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:11:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:53 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 0x7f79da970f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', '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 13:11:53 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 13:11:53 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 13:11:53 INFO - Using env: {'DISPLAY': ':0', 13:11:53 INFO - 'HOME': '/home/cltbld', 13:11:53 INFO - 'LANG': 'en_US.UTF-8', 13:11:53 INFO - 'LANGUAGE': 'en_US:en', 13:11:53 INFO - 'LOGNAME': 'cltbld', 13:11:53 INFO - 'MAIL': '/var/mail/cltbld', 13:11:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:53 INFO - 'MOZ_NO_REMOTE': '1', 13:11:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:53 INFO - 'NO_EM_RESTART': '1', 13:11:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:53 INFO - 'PWD': '/builds/slave/test', 13:11:53 INFO - 'SHELL': '/bin/bash', 13:11:53 INFO - 'SHLVL': '1', 13:11:53 INFO - 'TERM': 'linux', 13:11:53 INFO - 'TMOUT': '86400', 13:11:53 INFO - 'USER': 'cltbld', 13:11:53 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:11:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:53 INFO - '_': '/tools/buildbot/bin/python'} 13:11:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:11:53 INFO - Running setup.py (path:/tmp/pip-GjLly5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:11:53 INFO - Running setup.py (path:/tmp/pip-Vzi6NA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:11:53 INFO - Running setup.py (path:/tmp/pip-z7PC5X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:11:53 INFO - Running setup.py (path:/tmp/pip-0_4ZzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:11:53 INFO - Running setup.py (path:/tmp/pip-G_VqZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:11:53 INFO - Running setup.py (path:/tmp/pip-V1N5Fs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:11:53 INFO - Running setup.py (path:/tmp/pip-2me0wg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:11:53 INFO - Running setup.py (path:/tmp/pip-zHkaEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:11:53 INFO - Running setup.py (path:/tmp/pip-UgIxL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:11:53 INFO - Running setup.py (path:/tmp/pip-Ku4gqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:11:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:11:53 INFO - Running setup.py (path:/tmp/pip-SGulOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:11:54 INFO - Running setup.py (path:/tmp/pip-zfu5ov-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:11:54 INFO - Running setup.py (path:/tmp/pip-v8l7kn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:54 INFO - Running setup.py (path:/tmp/pip-iuXp7m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:54 INFO - Running setup.py (path:/tmp/pip-mmMwZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:54 INFO - Running setup.py (path:/tmp/pip-LQXxqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:54 INFO - Running setup.py (path:/tmp/pip-cht0Z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:11:54 INFO - Running setup.py install for manifestparser 13:11:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:11:54 INFO - Running setup.py install for mozcrash 13:11:54 INFO - Running setup.py install for mozdebug 13:11:54 INFO - Running setup.py install for mozdevice 13:11:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:11:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:11:54 INFO - Running setup.py install for mozfile 13:11:54 INFO - Running setup.py install for mozhttpd 13:11:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Running setup.py install for mozinfo 13:11:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Running setup.py install for mozInstall 13:11:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Running setup.py install for mozleak 13:11:55 INFO - Running setup.py install for mozlog 13:11:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Running setup.py install for moznetwork 13:11:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Running setup.py install for mozprocess 13:11:55 INFO - Running setup.py install for mozprofile 13:11:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Running setup.py install for mozrunner 13:11:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:11:55 INFO - Running setup.py install for mozscreenshot 13:11:56 INFO - Running setup.py install for moztest 13:11:56 INFO - Running setup.py install for mozversion 13:11:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:11:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:11:56 INFO - Cleaning up... 13:11:56 INFO - Return code: 0 13:11:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:11:56 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')]} 13:11:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:11:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:56 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')]} 13:11:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:11:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:11:56 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 0x7f79da970f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', '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 13:11:56 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 13:11:56 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 13:11:56 INFO - Using env: {'DISPLAY': ':0', 13:11:56 INFO - 'HOME': '/home/cltbld', 13:11:56 INFO - 'LANG': 'en_US.UTF-8', 13:11:56 INFO - 'LANGUAGE': 'en_US:en', 13:11:56 INFO - 'LOGNAME': 'cltbld', 13:11:56 INFO - 'MAIL': '/var/mail/cltbld', 13:11:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:11:56 INFO - 'MOZ_NO_REMOTE': '1', 13:11:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:11:56 INFO - 'NO_EM_RESTART': '1', 13:11:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:11:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:11:56 INFO - 'PWD': '/builds/slave/test', 13:11:56 INFO - 'SHELL': '/bin/bash', 13:11:56 INFO - 'SHLVL': '1', 13:11:56 INFO - 'TERM': 'linux', 13:11:56 INFO - 'TMOUT': '86400', 13:11:56 INFO - 'USER': 'cltbld', 13:11:56 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:11:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:11:56 INFO - '_': '/tools/buildbot/bin/python'} 13:11:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:11:56 INFO - Running setup.py (path:/tmp/pip-GYsTlj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:11:56 INFO - Running setup.py (path:/tmp/pip-TIUoTU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:11:56 INFO - Running setup.py (path:/tmp/pip-jLX5hJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:11:56 INFO - Running setup.py (path:/tmp/pip-S7RH3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:11:56 INFO - Running setup.py (path:/tmp/pip-p4mMQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:11:56 INFO - Running setup.py (path:/tmp/pip-UheWSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:11:56 INFO - Running setup.py (path:/tmp/pip-jCWb0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:11:56 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)) 13:11:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:11:56 INFO - Running setup.py (path:/tmp/pip-Vvjjub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:11:57 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)) 13:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:11:57 INFO - Running setup.py (path:/tmp/pip-nX6wDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:11:57 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)) 13:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:11:57 INFO - Running setup.py (path:/tmp/pip-CyYKZn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:11:57 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)) 13:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:11:57 INFO - Running setup.py (path:/tmp/pip-g74Hq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:11:57 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)) 13:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:11:57 INFO - Running setup.py (path:/tmp/pip-EXHxqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:11:57 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)) 13:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:11:57 INFO - Running setup.py (path:/tmp/pip-_CqNAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:11:57 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)) 13:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:11:57 INFO - Running setup.py (path:/tmp/pip-NnGrJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:11:57 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)) 13:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:57 INFO - Running setup.py (path:/tmp/pip-2vpUtR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:11:57 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)) 13:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:11:57 INFO - Running setup.py (path:/tmp/pip-OIGfGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:11:57 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)) 13:11:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:11:57 INFO - Running setup.py (path:/tmp/pip-PkF7XV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:11:57 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)) 13:11:57 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)) 13:11:57 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)) 13:11:57 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)) 13:11:57 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)) 13:11:57 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)) 13:11:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:11:57 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 13:11:57 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 13:11:57 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 13:11:57 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 13:11:57 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 13:11:57 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 13:11:59 INFO - Downloading blessings-1.6.tar.gz 13:11:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:11:59 INFO - Installing collected packages: blessings 13:11:59 INFO - Running setup.py install for blessings 13:11:59 INFO - Successfully installed blessings 13:11:59 INFO - Cleaning up... 13:11:59 INFO - Return code: 0 13:11:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:11:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:11:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:00 INFO - Reading from file tmpfile_stdout 13:12:00 INFO - Current package versions: 13:12:00 INFO - argparse == 1.2.1 13:12:00 INFO - blessings == 1.6 13:12:00 INFO - blobuploader == 1.2.4 13:12:00 INFO - docopt == 0.6.1 13:12:00 INFO - functools32 == 3.2.3-2 13:12:00 INFO - jsonschema == 2.5.1 13:12:00 INFO - manifestparser == 1.1 13:12:00 INFO - mozInstall == 1.12 13:12:00 INFO - mozcrash == 0.17 13:12:00 INFO - mozdebug == 0.1 13:12:00 INFO - mozdevice == 0.48 13:12:00 INFO - mozfile == 1.2 13:12:00 INFO - mozhttpd == 0.7 13:12:00 INFO - mozinfo == 0.9 13:12:00 INFO - mozleak == 0.1 13:12:00 INFO - mozlog == 3.4 13:12:00 INFO - moznetwork == 0.27 13:12:00 INFO - mozprocess == 0.23 13:12:00 INFO - mozprofile == 0.28 13:12:00 INFO - mozrunner == 6.12 13:12:00 INFO - mozscreenshot == 0.1 13:12:00 INFO - mozsystemmonitor == 0.3 13:12:00 INFO - moztest == 0.7 13:12:00 INFO - mozversion == 1.4 13:12:00 INFO - psutil == 3.1.1 13:12:00 INFO - requests == 1.2.3 13:12:00 INFO - wsgiref == 0.1.2 13:12:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:00 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 0x7f79da970f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', '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 13:12:00 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 13:12:00 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 13:12:00 INFO - Using env: {'DISPLAY': ':0', 13:12:00 INFO - 'HOME': '/home/cltbld', 13:12:00 INFO - 'LANG': 'en_US.UTF-8', 13:12:00 INFO - 'LANGUAGE': 'en_US:en', 13:12:00 INFO - 'LOGNAME': 'cltbld', 13:12:00 INFO - 'MAIL': '/var/mail/cltbld', 13:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:00 INFO - 'MOZ_NO_REMOTE': '1', 13:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:00 INFO - 'NO_EM_RESTART': '1', 13:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:00 INFO - 'PWD': '/builds/slave/test', 13:12:00 INFO - 'SHELL': '/bin/bash', 13:12:00 INFO - 'SHLVL': '1', 13:12:00 INFO - 'TERM': 'linux', 13:12:00 INFO - 'TMOUT': '86400', 13:12:00 INFO - 'USER': 'cltbld', 13:12:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:00 INFO - '_': '/tools/buildbot/bin/python'} 13:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:00 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)) 13:12:00 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)) 13:12:00 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)) 13:12:00 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)) 13:12:00 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)) 13:12:00 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)) 13:12:00 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)) 13:12:00 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)) 13:12:00 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)) 13:12:00 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)) 13:12:00 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)) 13:12:00 INFO - Cleaning up... 13:12:00 INFO - Return code: 0 13:12:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:12:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:12:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:12:00 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 0x7f79da970f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c058a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2cd2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, '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': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', '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 13:12:00 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 13:12:00 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 13:12:00 INFO - Using env: {'DISPLAY': ':0', 13:12:00 INFO - 'HOME': '/home/cltbld', 13:12:00 INFO - 'LANG': 'en_US.UTF-8', 13:12:00 INFO - 'LANGUAGE': 'en_US:en', 13:12:00 INFO - 'LOGNAME': 'cltbld', 13:12:00 INFO - 'MAIL': '/var/mail/cltbld', 13:12:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:00 INFO - 'MOZ_NO_REMOTE': '1', 13:12:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:00 INFO - 'NO_EM_RESTART': '1', 13:12:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:00 INFO - 'PWD': '/builds/slave/test', 13:12:00 INFO - 'SHELL': '/bin/bash', 13:12:00 INFO - 'SHLVL': '1', 13:12:00 INFO - 'TERM': 'linux', 13:12:00 INFO - 'TMOUT': '86400', 13:12:00 INFO - 'USER': 'cltbld', 13:12:00 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:12:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:00 INFO - '_': '/tools/buildbot/bin/python'} 13:12:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:12:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:12:00 INFO - Cleaning up... 13:12:00 INFO - Return code: 0 13:12:00 INFO - Running post-action listener: _resource_record_post_action 13:12:00 INFO - Running post-action listener: _start_resource_monitoring 13:12:00 INFO - Starting resource monitoring. 13:12:00 INFO - [mozharness: 2016-10-07 20:12:00.621970Z] Finished create-virtualenv step (success) 13:12:00 INFO - [mozharness: 2016-10-07 20:12:00.622458Z] Running install step. 13:12:00 INFO - Running pre-action listener: _resource_record_pre_action 13:12:00 INFO - Running main action method: install 13:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:12:00 INFO - Reading from file tmpfile_stdout 13:12:00 INFO - Detecting whether we're running mozinstall >=1.0... 13:12:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:12:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:12:00 INFO - Reading from file tmpfile_stdout 13:12:00 INFO - Output received: 13:12:00 INFO - Usage: mozinstall [options] installer 13:12:00 INFO - Options: 13:12:00 INFO - -h, --help show this help message and exit 13:12:00 INFO - -d DEST, --destination=DEST 13:12:00 INFO - Directory to install application into. [default: 13:12:00 INFO - "/builds/slave/test"] 13:12:00 INFO - --app=APP Application being installed. [default: firefox] 13:12:00 INFO - mkdir: /builds/slave/test/build/application 13:12:00 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'] 13:12:00 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 13:12:17 INFO - Reading from file tmpfile_stdout 13:12:17 INFO - Output received: 13:12:17 INFO - /builds/slave/test/build/application/firefox/firefox 13:12:17 INFO - Running post-action listener: _resource_record_post_action 13:12:17 INFO - [mozharness: 2016-10-07 20:12:17.047035Z] Finished install step (success) 13:12:17 INFO - [mozharness: 2016-10-07 20:12:17.047280Z] Running run-tests step. 13:12:17 INFO - Running pre-action listener: _resource_record_pre_action 13:12:17 INFO - Running main action method: run_tests 13:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:12:17 INFO - Python 2.7.3 13:12:17 INFO - Return code: 0 13:12:17 INFO - grabbing minidump binary from tooltool 13:12:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:12:17 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 0x2ccff60>, '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 0x2cd0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cd11d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:12:17 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 13:12:17 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 13:12:17 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 13:12:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:12:17 INFO - Return code: 0 13:12:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:12:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:12:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:12:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:12:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:12:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 13:12:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Larch-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 13:12:17 INFO - Using env: {'DISPLAY': ':0', 13:12:17 INFO - 'HOME': '/home/cltbld', 13:12:17 INFO - 'LANG': 'en_US.UTF-8', 13:12:17 INFO - 'LANGUAGE': 'en_US:en', 13:12:17 INFO - 'LOGNAME': 'cltbld', 13:12:17 INFO - 'MAIL': '/var/mail/cltbld', 13:12:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:12:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:12:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:12:17 INFO - 'MOZ_NO_REMOTE': '1', 13:12:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:12:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:12:17 INFO - 'NO_EM_RESTART': '1', 13:12:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:12:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:12:17 INFO - 'PWD': '/builds/slave/test', 13:12:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:12:17 INFO - 'SHELL': '/bin/bash', 13:12:17 INFO - 'SHLVL': '1', 13:12:17 INFO - 'TERM': 'linux', 13:12:17 INFO - 'TMOUT': '86400', 13:12:17 INFO - 'USER': 'cltbld', 13:12:17 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872', 13:12:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:12:17 INFO - '_': '/tools/buildbot/bin/python'} 13:12:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Larch-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 13:12:17 INFO - mozversion application_buildid: 20161007113100 13:12:17 INFO - mozversion application_changeset: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 13:12:17 INFO - mozversion application_display_name: Nightly 13:12:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:12:17 INFO - mozversion application_name: Firefox 13:12:17 INFO - mozversion application_remotingname: firefox 13:12:17 INFO - mozversion application_repository: https://hg.mozilla.org/projects/larch 13:12:17 INFO - mozversion application_vendor: Mozilla 13:12:17 INFO - mozversion application_version: 52.0a1 13:12:17 INFO - mozversion platform_buildid: 20161007113100 13:12:17 INFO - mozversion platform_changeset: 259c110bf47100196fd28e35c47c4e23bf9ad0a9 13:12:17 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/larch 13:12:17 INFO - mozversion platform_version: 52.0a1 13:12:17 INFO - using testdate: 1475871137 13:12:17 INFO - actual date: 1475871137 13:12:17 INFO - starting webserver on 'localhost:38615' 13:12:17 INFO - SUITE-START | Running 2 tests 13:12:17 INFO - TEST-START | dromaeo_css 13:12:17 INFO - operating with platform_type : linux_ 13:12:17 INFO - Initialising browser for dromaeo_css test... 13:12:17 INFO - TEST-INFO | started process 3303 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK6BG9x/profile http://localhost:38615/getInfo.html) 13:12:24 INFO - PROCESS | 3303 | __metrics Screen width/height:1600/1200 13:12:24 INFO - PROCESS | 3303 | colorDepth:24 13:12:24 INFO - PROCESS | 3303 | Browser inner width/height: 1024/697 13:12:24 INFO - PROCESS | 3303 | __metrics 13:12:24 ERROR - PROCESS | 3303 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 13:12:25 INFO - TEST-INFO | 3303: exit 0 13:12:25 INFO - Browser initialized. 13:12:25 INFO - Running cycle 1/1 for dromaeo_css test... 13:12:25 INFO - TEST-INFO | started process 3424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpK6BG9x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:12:38 INFO - PROCESS | 3424 | RSS: Main: 188698624 13:12:38 INFO - PROCESS | 3424 | 13:13:27 INFO - PROCESS | 3424 | 1475871207865 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] 13:15:41 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:38615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38615/tests/dromaeo/cssquery-ext.html) 13:15:43 INFO - PROCESS | 3424 | RSS: Main: 201338880 13:15:43 INFO - PROCESS | 3424 | 13:18:45 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:38615/tests/dromaeo/cssquery-ext.html (next: http://localhost:38615/tests/dromaeo/cssquery-jquery.html) 13:18:45 INFO - PROCESS | 3424 | RSS: Main: 203898880 13:18:45 INFO - PROCESS | 3424 | 13:21:48 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:38615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38615/tests/dromaeo/cssquery-mootools.html) 13:21:48 INFO - PROCESS | 3424 | RSS: Main: 200212480 13:21:48 INFO - PROCESS | 3424 | 13:24:50 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:38615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38615/tests/dromaeo/cssquery-prototype.html) 13:24:51 INFO - PROCESS | 3424 | RSS: Main: 196820992 13:24:51 INFO - PROCESS | 3424 | 13:27:54 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:38615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38615/tests/dromaeo/cssquery-yui.html) 13:27:54 INFO - PROCESS | 3424 | RSS: Main: 200028160 13:27:54 INFO - PROCESS | 3424 | 13:30:57 INFO - PROCESS | 3424 | Cycle 1(1): loaded http://localhost:38615/tests/dromaeo/cssquery-yui.html (next: http://localhost:38615/tests/dromaeo/cssquery-dojo.html) 13:30:57 INFO - PROCESS | 3424 | RSS: Main: 200654848 13:30:57 INFO - PROCESS | 3424 | 13:30:57 INFO - PROCESS | 3424 | __start_tp_report 13:30:57 INFO - PROCESS | 3424 | _x_x_mozilla_page_load 13:30:57 INFO - PROCESS | 3424 | _x_x_mozilla_page_load_details 13:30:57 INFO - PROCESS | 3424 | |i|pagename|runs| 13:30:57 INFO - PROCESS | 3424 | |0;dojo.html;2580.741925807419;2597.32469557915;2599.9350016249605;2621.3315604520844;2622.5541657918147;4592.862214133573;4621.768911554425;4629.213033784256;4641.767911604423;4656.41794775653;4662.930056049162;4689.882752931178;4725.881852953669;4749.216379297421;4752.548507891754;4273.572642735733;4306.418633484486;4355.194289056519;4395.05506316142;4443.866683999485;4411.514733379326;4412.161689279043;4420.469543654766;4426.712263702849;4437.711548749337;4216.051388437608;4252.574742525753;4294.184105020036;4394.62645675118;4443.866683999485;4324.22164010478;4345.109252603241;4367.388565600819;4416.823327066913;4424.734515929054;4305.9354109688065;4338.045629961435;4358.912821743547;4379.146066517031;4394.62645675118;4612.907741845178;4650.976745116287;4688.882777930545;4752.737871957173;4756.239001759702;5030.899382012376;5085.644004919657;5094.337736094284;5107;5150.716710580917;5137.7944882204665;5138.203578445347;5144.125498665236;5151.896962060738;5200.869978250574;4603.608693261111;4765.046990601859;4770.475247722782;4781.306710526954;4825.203841366206;5066.771995260222;5125.513076257749;5172.19830926207;5178.663386879841;5231.581473482112;4938.308636790852;4971.527704868032;4977.054359671651;4985.052839960396;5041.59667226621;4969.82605608802;4974.1543937530705;4986.800527978913;5069.467705890902;5076.543111120017;4943.4809345018975;4945.629077819178;5015.498450154955;5021.221710634857;5026.346574945233;4974.925376119361;4990.700557966534;5033.119204139261;5099.59203263738;5148.871278218075;4379.956200437955;4386.649068074546;4388.648908087345;4389.670774691911;4438.289873620205;3715.2198038412234;3809.3143234218105;3829.215010922754;3856.5950575189763;3916.549596796405;4192.727472714264;4302.354646802942;4344.956550434518;4349.934750978738;4405.07493426384;5082.059818933435;5106;5112.335396398519;5115.7442127893455;5174.379074511083;4324.2222067552475;4332.176886391576;4340.65274778017;4353.69524133314;4404.383386325917;4410.625096866802;4499.865004049884;4514.232580461329;4517.977410112929;4554.863354099382;4738.691985020962;4739.739314337745;4746.311784791117;4771.71369717825;4792.928106078341;5011.7494125294315;5034.270030845581;5054.570361519312;5065.986802639413;5114.284000239895;4566.657500687528;4614.607758340444;4624.953750462587;4660.184467718068;4683.039976804815;4973.055119527278;4974.0797952378925;4978.352814134284;5010.273510340907;5021.347224860745;5023.146065169003;5042.84871453857;5046.873828154326;5048.873778155428;5100.719460429712;4790.856274311776;4858.198397264412;4901.2893130496595;4906.730129842893;4973.602111830973;4916.213405855046;4955;4967.875803104951;5009.749512524287;5021.723805190603;4778.211595086772;4822.9758851205515;4839.576985122776;4855.247436647325;4886.828960986349;4841.152798260361;4848.80604775805;4865.172920603435;4881.389826271716;4885.804567817389;4761.500042495488;4774.116788394158;4799.640026997919;4829.13075646387;4852.0295940811275 13:30:57 INFO - PROCESS | 3424 | |1;ext.html;551.3576683164112;551.837208023633;558.3801979802421;558.6592178770949;570.4495162168506;36470.63529364706;38613.80693096537;38674;42346;42350.57649423505;38645.42031869524;39405;39421.40867886984;39513;39563;7466.440016998733;7672.616369181546;7702.383809295271;7706.306432421081;7707;7530.774076777706;7595.316421522062;7596.354309883639;7606.315431611154;7626.19924907885;7616.352610028154;7651.693932242703;7659.846803063935;7670.501417407879;7700.229977002283;7565.924340756632;7568.09182898053;7616.581088040156;7636.083669959585;7637.656305466239;7609.124950630638;7626.351760100398;7667.309942105181;7676.884846727304;7688.34649054831;37628.81185594082;37832.621673783186;37946.430803537965;37953.240935181144;37998.62001379979;2792.678841933163;2992.311768293305;3208.8235147066903;3222.7421806255443;3442.2599141184514;27235.45529089407;27537.724622753718;27680.584791228146;28266.29334266639;29063;3458.948115778265;3507.1232191952013;3510.473428985647;3529.7352698547456;3550.0947258449187;246839;246988.00601948675;247132;247691;247788;48923.75538122358;49298.50701493011;49357.50642493601;49423;49449.50550494521;52189.21716174261;52387.738061310214;52455;52488.212676809875;52534.21198682023;14952.476663316731;15132.243387830564;15210.847891520943;15253.771193432107;15265.23673816327;11077.50151243196;11108.888911110947;11110.05564527008;11119;11124.221304508606;14257.429702811978;14626.268686565629;14739.263036848115;14893;15059.623509412133;5657.745401456944;5862.941370586324;5909.438603332676;6005.879882402328;6068.33248342682;760.5322726523149;908.9545522723837;936.9812603747887;946.5551190940247;954.4178051388648;26536.60195097075;27916.860415697793;28096;30904.227394315323;31004.53493197604;935.8175155844544;942.9387089839139;967.4098799732299;983.5131609853169;1003.6988903328972;14317.21255330946;14384.273887133402;14487.92756036213;14526;14613.488527901685;188888;189616;189878;191000;191030;46859.29711054337;47070;47085.76457117761;47201.763991179825;47214.291785623245;1182.7693599748138;1198.2091819399154;1222.8899399054128;1232.5624403337044;1233;25954.480910382063;26581.33546661349;26823.329416764736;27286.04498842531;27336.589951150352;40869.38695919623;41613;41661.375079373225;41749.79125104355;41750;347167;347681;348938;349036;349456;23851.761482384954;24083.51832963296;24242;24919.377015574755;25005.499890001734;39614.40578391384;39821.2035759289;40013.39979900246;40048.39927401033;40403.59596403998;34258.828705856315;35057.298854022265;35459;35619.46570801492;35652.64347356597;35116.82441587776;35223.29553408969;35320.29359412849;35377.646223537435;35588.466173007946;34113.31773364569;34557.82721086378;34677.82661086678;35211.64788352084;35266.1183470405;30931.2267193313;31991;32299.35401292008;32710;32850.1787455306;24958.500829982935;24963.500729985662;25034.62448063244;25138.497230055662;25615.103471378414 13:30:57 INFO - PROCESS | 3424 | |2;jquery.html;354.5249365849761;355.95906470755864;360.1195078034207;368.16059384603113;382.69958082904924;15124.848751512482;16378.508644740661;16392.999999999985;16498.917505412486;16505.422310219146;15474.767878481833;16736.748948765748;17140.314387424518;17348.91812982444;17349.82650173501;4850.708957462554;5126.359205099344;5127.9230811537855;5129.461406552296;5135.3837539495125;3680.834362453696;3863.6715879150306;5051.090803655341;5638.238837756912;5985.132155837401;6005.639661620295;6008.699565021753;6025.3372129065765;6042.093685947099;6064.848378790543;5801.158831969362;5958.8808223835495;5983.700814959257;5991.700414979234;5994.13085102662;5061.16490779021;5236.607254455931;5240.79036838526;5245.501677340647;5250.18622113573;20065.699014514794;20369.592608147756;20514.589708205902;20527.17891284347;20543.5891282175;1815.1196669615226;1894.551548211614;1900.277894400119;1966.1545535419907;2394.7485514021128;12121.818172727417;12910.612681619567;13334.933325333408;13341.399637016357;13352.132111412824;1663.7005339038967;1727.637196188802;1743.302678928426;1758.3703586163128;1771.1498480729322;68555.3144468554;68644.65677671629;69157.65421172912;69179.99999999949;71202;8093.109757926623;8100.797480062928;8307.916920830836;9438.38650487716;9639.951800240953;12862.807057894139;12962.157459765085;12998.155119917175;13006.089573729938;13040.80438793419;7132.643367831588;7223.566586004857;7421.591812450259;7441.367483763833;7503;6899.103116594811;7005.649717514104;7116.786496405116;7257.600831954293;7329.963350183215;5638.6052976292085;5877.882442351129;5906.763729450774;6074.54440916933;6153.2000839890525;1585.714571377163;1614.386533117408;1626.5933516620844;1702.9659406811795;1748.8925844357518;838.3544670603601;845.1084106267946;879.2833840420037;909.3316412436853;964.9614015439304;16209.918950405172;16554.503364899072;16934.237959291862;17154;17231.483055508354;845.7631863078348;859.2009431228892;893.0622846011662;895.7491902267376;903.336048004716;9369;10047.141278863433;10109.292349535463;10124.240681948882;10239;328716;331468;331486;347479;356808;65687;67650.32349676538;67668.66165669239;68510;70410.64794676096;885.5660726244223;906.8437741879156;909.4316052467208;937.7093101138669;938.3056538161711;14876.404943802127;15086.849131508983;15285.465008724641;15566.37734490653;15576;33616.32767344688;33966;34270.314593708485;35013.824930875184;35533.82233088921;42706.57293427026;42914.35628465638;43258.78370608127;43759;44217.55782442135;7403;7587.58268295249;7615.923840761521;7793.454458187873;7793.688252470064;11711;11753.88246117562;11808.527658893549;12260.693482663004;12461.376931153587;10173.643922462677;10217.233707472118;10256.692299231036;10271.691849244535;10536.841947370642;10115.291929565154;10627.309224900357;10697.090747286567;10707.518161682587;10780.353178809297;9998.200143988319;10396.324238924446;10559.155267578422;10708.900450364948;10958.178136639624;7309.780706578811;7437.0331856858265;7581.734639287599;7720.420968427278;7750.961245193738;9698.515074246401;10232.744181395525;10319.587216511256;10358;10823.350598964087 13:30:57 INFO - PROCESS | 3424 | |3;mootools.html;1346.3537501999037;1377.3251106957591;1451.8983671143017;1638.7378019516873;1663.2681620087153;6483.708233129509;6714.664266786665;6911.20521140069;7512.248775122485;7520.059992500937;6951.756688515903;7237.1315442147015;7237.67430465629;7415.851682966338;7430.962845185766;1981.5343394302326;2025.5847551252032;2033.9593208135827;2035.3385149826292;2042.9897850510727;1954.15971132413;1997.1312479071578;1997.560536681935;2022.3932820153968;2046.447459186019;1958.343954775152;1983.6032793441298;2002;2003.0485519378324;2005.8896760678158;1948.1038722187811;1956.1295223625493;1956.5793354428865;1959.8040195980288;1967.0263219706337;1849.0847030719744;1852.8888266704041;1879.079251166932;1905.0569967865856;1906.8569857260761;7400.259974002611;7408.7406940757355;7471.962640186819;7479.139898911641;7481;4242.193983143224;4353.891152721176;4357.716748411375;4359.978200109011;4363.978180109079;2660.144895889449;2723.4689235599067;2737.20621019904;2777.750002499785;2795.24528377339;828.3249151941209;856.3748463621591;872.3936863879607;885.7696998780299;889.89321281446;9280.628774848998;9327;9364.157225849705;9373.06269373064;9404.623815047458;3460.9307813843584;3606.1705807664384;3854.094287842355;3859.1895701902354;3862.8841134766003;8132.6746930122135;8164.877526837102;8173.591320434073;8178.46839955401;8206.261436470746;4240.13077319155;4240.427542281753;4248.660107191417;4260.2320037184845;4273.743575385487;3536.2397084626414;3669.688076513473;3899.454076429302;3944.9211015779524;3955.248502784462;3403.931921361559;3433.9828300858335;3483.2162763378037;3556.110972256936;3572.1962558424666;1112.9666110016713;1117.3519358771894;1124.3478782306242;1132.4790596325784;1140.988590114105;702.8559145375186;710.7881062787934;786.2627668298434;807.7455601485514;847.2967437027253;4959.752012399438;4999.675021123615;5024.598032157419;5034.244863270539;5218.478152184751;364.7027672446947;379.58814686065926;819.7950512371907;939.3471537281661;957.5451660461365;3312.867485300561;3402.6597340265776;3407.931841363159;3448.827558622059;3491.1970246843366;8622.137786221454;8677.652893884175;8892.199702026848;8971.327150463741;8981.371304008657;8923.509206993547;8928.553572321358;8943.552822358855;8944.686935957341;8949.284057275403;6450.677466126769;6498.54510184292;6554.475641948633;6667.466602671678;6719.529632925648;4789.592884604847;4800.951990480051;4865.464798872192;4868.926966095441;4870.659053866337;8281.130481299619;8317.209865062809;8321.209485098905;8335.624896879533;8335.916640833513;8217.096119426738;8317.168283171635;8360.623771930155;8587.05542390349;8624.439411438487;5510.724463776875;5703;6008.789692360747;6120.234970628671;6133.938660613515;6856.142982127234;6990.9300906990275;7058.964705176441;7293.452991025801;7308.8903666443985;6148;6284.465820405134;6314.936850631435;6324.335944725922;6451.838704032437;6002.609830361012;6023.27720673522;6024.307204671519;6029.60807547508;6057.242844644419;5686.914696279477;5689.2319536862;5735.627184233012;5738.942610573841;5748.281464816898;4141.627253547195;4282.293421585404;4361.411209486806;4388.4295041645655;4462.040661257845;4534.365188873494;4536.11545748589;4551.590356867898;4597.103564804831;4613.054323863667 13:30:57 INFO - PROCESS | 3424 | |4;prototype.html;278.8772939906441;288.0781499202552;288.09107266573955;289.97825163112765;292.33493801601367;4941.950580494194;4965.354503914495;5023.693839601707;5031.874203144923;5032.6477146599755;4874.1973365315;4876.2929375240565;4884.291777692232;4887.877803054926;4913.0102308565;3605.441156620728;3685.852565897361;3729.440583912421;3755.9061023474496;3831.3103641344546;3848.576026870062;3854.094287842355;3857.691384689218;3861.4980052593123;3868.516435445569;3835;3838.309104361214;3838.7504812187117;3840;3851.903702407434;3557.1996300832366;3739.139997800494;3829.8659546915865;3855.7300988930647;3862.633049860259;3272.2146684795716;3274.0341599228286;3274.6889045540875;3276.950845737316;3280.917977050569;4810.422749270075;4814.277858321245;4820;4823.20417131173;4833.516648335173;4296.014270082263;4296.355546667994;4306.332518459643;4308.82764689412;4313.899955511356;4997.800087996476;5079.593632509391;5118.155504341779;5132.692038477666;5133.204353325241;3547.130952916526;3548.6628770266784;3550.5029295898594;3568.4825700273573;3568.8572457101686;5322.973385133049;5358.276632654581;5425.240466334716;5431.995080910045;5435.972820135914;3541.9822900885847;3626.963730362663;3628.854845806191;3634.345817752777;3636.7272454566014;3668.706503479715;3680.9263814723554;3683.557973043198;3688.61269566697;3690.132818787583;4218.725782824168;4244.766537840386;4250.42619246404;4285.5928686774705;4302.924268932767;4856.902861942812;5120.180771076684;5142.691438513626;5163.845084647466;5212.045482943896;1256.7109564800148;1284.1588759362446;1285.3932584269662;1288.2850018239778;1288.7229245712028;789.4684707886811;801.9759407217792;806.4717609965483;821.4783612406166;823.2343920154194;4316.913661726748;4361.825526978949;4448.799804008828;4515.571020753023;4533.297338912474;5343.65266257692;5347.946520534822;5354.625176237626;5357.11607584752;5359.330083739533;4524.3712263585085;4524.728516289033;4528.864134075983;4537.636989040869;4540.88647783808;2704.986475067612;2797.5800932193506;2834.14975507347;2835.681408145181;2836.8439735814313;4958.8760280993265;4975.950240497548;4977.751112444364;4983.778974151356;4985.252212168204;5201.713905735145;5427.185922111715;5437.157240627709;5438.211459338453;5444.537214336826;5038.470960549163;5059.241113832881;5060.2662613920775;5068;5075.56857667095;5301.787928482971;5405.459454054563;5419.864503387447;5423.349198096096;5447.031367904422;5141.588672906233;5230.97384513075;5274.835098940758;5291;5291.1798671206025;5013.523715247045;5016.667249728894;5018.272350509083;5019.573336266459;5046.747662616928;3628.14738536449;3642.9635703642625;3650.105724097613;3658.835352409095;3661.5240018797385;5160.870978225575;5319.654222475527;5362.570994320367;5376.946230537645;5379.596530260168;5189.481051894781;5196.922046169235;5201.47985201492;5207.713575753219;5212.791488340576;5181.611379146654;5195.064888319987;5202.297689811827;5206.817761378334;5211.76547055391;4914.2137258039975;5101.974490127525;5131.25596788471;5144.6655967362;5145.4340022598235;4997.300377947163;5080.418305094973;5147.9227811582105;5230.686158830483;5240.502152295526;5143.9712057587885;5145.485451454824;5146.408163061295;5146.588272938081;5158.690478571298 13:30:57 INFO - PROCESS | 3424 | |5;yui.html;589.8053642298042;606.9332373438921;607.7994261893575;661.4741280681855;681.9965900170498;12462.750744985105;12917.935410322934;12944.74110517789;12992.350382480874;13006.284654344006;12306.077044221696;12389.25664460133;12393.132480726354;12400.689982750413;12413.689657758538;738.5679377564131;747.8579069976687;758.8140905478166;778.5289899610739;783.6238605469379;779.6140910249435;781.4295564238109;781.9921800782005;783.4006984656742;784.1022029775903;809.0049239435498;815.7511958852577;816.4692949582759;817.4768148385009;818.6684392820918;812.0661239574507;812.2080971053206;814.4828034198326;814.5886327404622;815.955122468264;593.913882487037;596.4780816785313;596.7046312075507;597.2325561653255;597.3309892919914;13049.217046977212;13106.80339794904;13109.410076546483;13130.343482825916;13150;12413.813792793115;12742;13072.150310229805;13178.275194864278;13605.455781768718;9885.505724713807;11178.385188814613;11291.49188286529;11689.532418703242;11874.821877671842;4112.115895082572;4149.771762553059;4169.478815148106;4303.493777177994;4321.697481176319;57498.13752793711;58355.41644583542;58417.74240318392;58606.706966464895;59204.407955920324;10005.79988400228;10189.745256368502;10272.589096436208;10334.224933130045;10672.466376681135;18392.172352244183;18596.907015464836;18646.254149834127;18696.626067478574;18781.90609046946;6411.230652321751;6420.036994450869;6421.678916054178;6525.217391304348;6618.602883826986;3509.7192224621967;3545.7872527648424;3656.2687462507606;3673.4673472346362;3705.6850167735506;2654.376221587925;2720.047983205902;2720.9319767005586;2724.741149590786;2730.9726902730717;486.67392846792734;490.4164044786692;498.9226669866176;504.4022832942901;505.2850216943058;523.7957196693293;547.3623228938243;575.556821247637;576.1990832742407;582.490320969152;7918.841623167505;8007.959960200162;8031.156728543536;8076.596170191467;8101.918980810116;467.45774901115226;478.93294938708607;482.55604843544023;494.77240469384486;575.8646718021262;3780.2250538639514;3911.5892831252877;3950.4271880577157;4126.958730412717;4184.325731209951;52995;53574.196387054224;60308.69845650744;90079;90104.54947725219;78982;80244.59877700574;82134.58932705298;82406.17593824105;83136.16863831405;70444.64777676182;71134.28865711381;73315;74398.25601744022;74832;7759.806004849924;7934.951905612486;8023.598820058857;8091;8279.296259817984;41252.38121428121;41662.37506437345;42185.789071054445;42233.36649950192;42792.358114627685;34189;39170.608293916695;47403.52596474129;49274.75362623164;51829;10445.791084178425;11715.355655439032;11732.824007639721;11733.823992640288;11839.704007399883;12607.306598137191;12943.801380632261;12997.545085921947;13046.869531304945;13180.736385272048;12099.75800484003;12479.31363775001;12484.812727808909;12527.56153534622;12969.675758106123;11919.76160476803;12316.568920088112;12506.687332816753;12647.241165530098;12671.17637353569;11462.369569673749;11831.76336473283;12252.264864108181;12254.816177757162;12368.44342004594;9439.52802359893;9900.356476828983;9963.202943764627;9981.950090249502;10114.696559103239;8989.41568798026;9430.52847357643;9943.900560994587;9979;9985.850212246967 13:30:57 INFO - PROCESS | 3424 | __end_tp_report 13:30:57 INFO - PROCESS | 3424 | __start_cc_report 13:30:57 INFO - PROCESS | 3424 | _x_x_mozilla_cycle_collect,340 13:30:57 INFO - PROCESS | 3424 | __end_cc_report 13:30:57 INFO - PROCESS | 3424 | __startTimestamp1475872257895__endTimestamp 13:30:57 INFO - PROCESS | 3424 | 13:30:57 INFO - PROCESS | 3424 | ------- Summary: start ------- 13:30:57 INFO - PROCESS | 3424 | Number of tests: 6 13:30:57 INFO - PROCESS | 3424 | 13:30:57 INFO - PROCESS | 3424 | [#0] dojo.html Cycles:165 Average:4667.32 Median:4771.71 stddev:487.58 (10.2%) stddev-sans-first:460.78 13:30:57 INFO - PROCESS | 3424 | Values: 2580.7 2597.3 2599.9 2621.3 2622.6 4592.9 4621.8 4629.2 4641.8 4656.4 4662.9 4689.9 4725.9 4749.2 4752.5 4273.6 4306.4 4355.2 4395.1 4443.9 4411.5 4412.2 4420.5 4426.7 4437.7 4216.1 4252.6 4294.2 4394.6 4443.9 4324.2 4345.1 4367.4 4416.8 4424.7 4305.9 4338.0 4358.9 4379.1 4394.6 4612.9 4651.0 4688.9 4752.7 4756.2 5030.9 5085.6 5094.3 5107.0 5150.7 5137.8 5138.2 5144.1 5151.9 5200.9 4603.6 4765.0 4770.5 4781.3 4825.2 5066.8 5125.5 5172.2 5178.7 5231.6 4938.3 4971.5 4977.1 4985.1 5041.6 4969.8 4974.2 4986.8 5069.5 5076.5 4943.5 4945.6 5015.5 5021.2 5026.3 4974.9 4990.7 5033.1 5099.6 5148.9 4380.0 4386.6 4388.6 4389.7 4438.3 3715.2 3809.3 3829.2 3856.6 3916.5 4192.7 4302.4 4345.0 4349.9 4405.1 5082.1 5106.0 5112.3 5115.7 5174.4 4324.2 4332.2 4340.7 4353.7 4404.4 4410.6 4499.9 4514.2 4518.0 4554.9 4738.7 4739.7 4746.3 4771.7 4792.9 5011.7 5034.3 5054.6 5066.0 5114.3 4566.7 4614.6 4625.0 4660.2 4683.0 4973.1 4974.1 4978.4 5010.3 5021.3 5023.1 5042.8 5046.9 5048.9 5100.7 4790.9 4858.2 4901.3 4906.7 4973.6 4916.2 4955.0 4967.9 5009.7 5021.7 4778.2 4823.0 4839.6 4855.2 4886.8 4841.2 4848.8 4865.2 4881.4 4885.8 4761.5 4774.1 4799.6 4829.1 4852.0 13:30:57 INFO - PROCESS | 3424 | 13:30:57 INFO - PROCESS | 3424 | [#1] ext.html Cycles:180 Average:42040.39 Median:35418.32 stddev:70865.66 (200.1%) stddev-sans-first:70995.99 13:30:57 INFO - PROCESS | 3424 | Values: 551.4 551.8 558.4 558.7 570.4 36470.6 38613.8 38674.0 42346.0 42350.6 38645.4 39405.0 39421.4 39513.0 39563.0 7466.4 7672.6 7702.4 7706.3 7707.0 7530.8 7595.3 7596.4 7606.3 7626.2 7616.4 7651.7 7659.8 7670.5 7700.2 7565.9 7568.1 7616.6 7636.1 7637.7 7609.1 7626.4 7667.3 7676.9 7688.3 37628.8 37832.6 37946.4 37953.2 37998.6 2792.7 2992.3 3208.8 3222.7 3442.3 27235.5 27537.7 27680.6 28266.3 29063.0 3458.9 3507.1 3510.5 3529.7 3550.1 246839.0 246988.0 247132.0 247691.0 247788.0 48923.8 49298.5 49357.5 49423.0 49449.5 52189.2 52387.7 52455.0 52488.2 52534.2 14952.5 15132.2 15210.8 15253.8 15265.2 11077.5 11108.9 11110.1 11119.0 11124.2 14257.4 14626.3 14739.3 14893.0 15059.6 5657.7 5862.9 5909.4 6005.9 6068.3 760.5 909.0 937.0 946.6 954.4 26536.6 27916.9 28096.0 30904.2 31004.5 935.8 942.9 967.4 983.5 1003.7 14317.2 14384.3 14487.9 14526.0 14613.5 188888.0 189616.0 189878.0 191000.0 191030.0 46859.3 47070.0 47085.8 47201.8 47214.3 1182.8 1198.2 1222.9 1232.6 1233.0 25954.5 26581.3 26823.3 27286.0 27336.6 40869.4 41613.0 41661.4 41749.8 41750.0 347167.0 347681.0 348938.0 349036.0 349456.0 23851.8 24083.5 24242.0 24919.4 25005.5 39614.4 39821.2 40013.4 40048.4 40403.6 34258.8 35057.3 35459.0 35619.5 35652.6 35116.8 35223.3 35320.3 35377.6 35588.5 34113.3 34557.8 34677.8 35211.6 35266.1 30931.2 31991.0 32299.4 32710.0 32850.2 24958.5 24963.5 25034.6 25138.5 25615.1 13:30:57 INFO - PROCESS | 3424 | 13:30:57 INFO - PROCESS | 3424 | [#2] jquery.html Cycles:180 Average:22482.12 Median:2024.50 stddev:56049.90 (2768.6%) stddev-sans-first:56182.51 13:30:57 INFO - PROCESS | 3424 | Values: 354.5 356.0 360.1 368.2 382.7 15124.8 16378.5 16393.0 16498.9 16505.4 15474.8 16736.7 17140.3 17348.9 17349.8 4850.7 5126.4 5127.9 5129.5 5135.4 3680.8 3863.7 5051.1 5638.2 5985.1 6005.6 6008.7 6025.3 6042.1 6064.8 5801.2 5958.9 5983.7 5991.7 5994.1 5061.2 5236.6 5240.8 5245.5 5250.2 20065.7 20369.6 20514.6 20527.2 20543.6 1815.1 1894.6 1900.3 1966.2 2394.7 12121.8 12910.6 13334.9 13341.4 13352.1 1663.7 1727.6 1743.3 1758.4 1771.1 68555.3 68644.7 69157.7 69180.0 71202.0 8093.1 8100.8 8307.9 9438.4 9640.0 12862.8 12962.2 12998.2 13006.1 13040.8 7132.6 7223.6 7421.6 7441.4 7503.0 6899.1 7005.6 7116.8 7257.6 7330.0 5638.6 5877.9 5906.8 6074.5 6153.2 1585.7 1614.4 1626.6 1703.0 1748.9 838.4 845.1 879.3 909.3 965.0 16209.9 16554.5 16934.2 17154.0 17231.5 845.8 859.2 893.1 895.7 903.3 9369.0 10047.1 10109.3 10124.2 10239.0 328716.0 331468.0 331486.0 347479.0 356808.0 65687.0 67650.3 67668.7 68510.0 70410.6 885.6 906.8 909.4 937.7 938.3 14876.4 15086.8 15285.5 15566.4 15576.0 33616.3 33966.0 34270.3 35013.8 35533.8 42706.6 42914.4 43258.8 43759.0 44217.6 7403.0 7587.6 7615.9 7793.5 7793.7 11711.0 11753.9 11808.5 12260.7 12461.4 10173.6 10217.2 10256.7 10271.7 10536.8 10115.3 10627.3 10697.1 10707.5 10780.4 9998.2 10396.3 10559.2 10708.9 10958.2 7309.8 7437.0 7581.7 7720.4 7751.0 9698.5 10232.7 10319.6 10358.0 10823.4 13:30:57 INFO - PROCESS | 3424 | 13:30:57 INFO - PROCESS | 3424 | [#3] mootools.html Cycles:180 Average:4742.50 Median:5126.36 stddev:2629.63 (51.3%) stddev-sans-first:2624.62 13:30:57 INFO - PROCESS | 3424 | Values: 1346.4 1377.3 1451.9 1638.7 1663.3 6483.7 6714.7 6911.2 7512.2 7520.1 6951.8 7237.1 7237.7 7415.9 7431.0 1981.5 2025.6 2034.0 2035.3 2043.0 1954.2 1997.1 1997.6 2022.4 2046.4 1958.3 1983.6 2002.0 2003.0 2005.9 1948.1 1956.1 1956.6 1959.8 1967.0 1849.1 1852.9 1879.1 1905.1 1906.9 7400.3 7408.7 7472.0 7479.1 7481.0 4242.2 4353.9 4357.7 4360.0 4364.0 2660.1 2723.5 2737.2 2777.8 2795.2 828.3 856.4 872.4 885.8 889.9 9280.6 9327.0 9364.2 9373.1 9404.6 3460.9 3606.2 3854.1 3859.2 3862.9 8132.7 8164.9 8173.6 8178.5 8206.3 4240.1 4240.4 4248.7 4260.2 4273.7 3536.2 3669.7 3899.5 3944.9 3955.2 3403.9 3434.0 3483.2 3556.1 3572.2 1113.0 1117.4 1124.3 1132.5 1141.0 702.9 710.8 786.3 807.7 847.3 4959.8 4999.7 5024.6 5034.2 5218.5 364.7 379.6 819.8 939.3 957.5 3312.9 3402.7 3407.9 3448.8 3491.2 8622.1 8677.7 8892.2 8971.3 8981.4 8923.5 8928.6 8943.6 8944.7 8949.3 6450.7 6498.5 6554.5 6667.5 6719.5 4789.6 4801.0 4865.5 4868.9 4870.7 8281.1 8317.2 8321.2 8335.6 8335.9 8217.1 8317.2 8360.6 8587.1 8624.4 5510.7 5703.0 6008.8 6120.2 6133.9 6856.1 6990.9 7059.0 7293.5 7308.9 6148.0 6284.5 6314.9 6324.3 6451.8 6002.6 6023.3 6024.3 6029.6 6057.2 5686.9 5689.2 5735.6 5738.9 5748.3 4141.6 4282.3 4361.4 4388.4 4462.0 4534.4 4536.1 4551.6 4597.1 4613.1 13:30:57 INFO - PROCESS | 3424 | 13:30:57 INFO - PROCESS | 3424 | [#4] prototype.html Cycles:180 Average:4264.24 Median:4913.61 stddev:1271.80 (25.9%) stddev-sans-first:1239.69 13:30:57 INFO - PROCESS | 3424 | Values: 278.9 288.1 288.1 290.0 292.3 4942.0 4965.4 5023.7 5031.9 5032.6 4874.2 4876.3 4884.3 4887.9 4913.0 3605.4 3685.9 3729.4 3755.9 3831.3 3848.6 3854.1 3857.7 3861.5 3868.5 3835.0 3838.3 3838.8 3840.0 3851.9 3557.2 3739.1 3829.9 3855.7 3862.6 3272.2 3274.0 3274.7 3277.0 3280.9 4810.4 4814.3 4820.0 4823.2 4833.5 4296.0 4296.4 4306.3 4308.8 4313.9 4997.8 5079.6 5118.2 5132.7 5133.2 3547.1 3548.7 3550.5 3568.5 3568.9 5323.0 5358.3 5425.2 5432.0 5436.0 3542.0 3627.0 3628.9 3634.3 3636.7 3668.7 3680.9 3683.6 3688.6 3690.1 4218.7 4244.8 4250.4 4285.6 4302.9 4856.9 5120.2 5142.7 5163.8 5212.0 1256.7 1284.2 1285.4 1288.3 1288.7 789.5 802.0 806.5 821.5 823.2 4316.9 4361.8 4448.8 4515.6 4533.3 5343.7 5347.9 5354.6 5357.1 5359.3 4524.4 4524.7 4528.9 4537.6 4540.9 2705.0 2797.6 2834.1 2835.7 2836.8 4958.9 4976.0 4977.8 4983.8 4985.3 5201.7 5427.2 5437.2 5438.2 5444.5 5038.5 5059.2 5060.3 5068.0 5075.6 5301.8 5405.5 5419.9 5423.3 5447.0 5141.6 5231.0 5274.8 5291.0 5291.2 5013.5 5016.7 5018.3 5019.6 5046.7 3628.1 3643.0 3650.1 3658.8 3661.5 5160.9 5319.7 5362.6 5376.9 5379.6 5189.5 5196.9 5201.5 5207.7 5212.8 5181.6 5195.1 5202.3 5206.8 5211.8 4914.2 5102.0 5131.3 5144.7 5145.4 4997.3 5080.4 5147.9 5230.7 5240.5 5144.0 5145.5 5146.4 5146.6 5158.7 13:30:57 INFO - PROCESS | 3424 | 13:30:57 INFO - PROCESS | 3424 | [#5] yui.html Cycles:180 Average:16218.23 Median:484.61 stddev:21905.67 (4520.2%) stddev-sans-first:21935.69 13:30:57 INFO - PROCESS | 3424 | Values: 589.8 606.9 607.8 661.5 682.0 12462.8 12917.9 12944.7 12992.4 13006.3 12306.1 12389.3 12393.1 12400.7 12413.7 738.6 747.9 758.8 778.5 783.6 779.6 781.4 782.0 783.4 784.1 809.0 815.8 816.5 817.5 818.7 812.1 812.2 814.5 814.6 816.0 593.9 596.5 596.7 597.2 597.3 13049.2 13106.8 13109.4 13130.3 13150.0 12413.8 12742.0 13072.2 13178.3 13605.5 9885.5 11178.4 11291.5 11689.5 11874.8 4112.1 4149.8 4169.5 4303.5 4321.7 57498.1 58355.4 58417.7 58606.7 59204.4 10005.8 10189.7 10272.6 10334.2 10672.5 18392.2 18596.9 18646.3 18696.6 18781.9 6411.2 6420.0 6421.7 6525.2 6618.6 3509.7 3545.8 3656.3 3673.5 3705.7 2654.4 2720.0 2720.9 2724.7 2731.0 486.7 490.4 498.9 504.4 505.3 523.8 547.4 575.6 576.2 582.5 7918.8 8008.0 8031.2 8076.6 8101.9 467.5 478.9 482.6 494.8 575.9 3780.2 3911.6 3950.4 4127.0 4184.3 52995.0 53574.2 60308.7 90079.0 90104.5 78982.0 80244.6 82134.6 82406.2 83136.2 70444.6 71134.3 73315.0 74398.3 74832.0 7759.8 7935.0 8023.6 8091.0 8279.3 41252.4 41662.4 42185.8 42233.4 42792.4 34189.0 39170.6 47403.5 49274.8 51829.0 10445.8 11715.4 11732.8 11733.8 11839.7 12607.3 12943.8 12997.5 13046.9 13180.7 12099.8 12479.3 12484.8 12527.6 12969.7 11919.8 12316.6 12506.7 12647.2 12671.2 11462.4 11831.8 12252.3 12254.8 12368.4 9439.5 9900.4 9963.2 9982.0 10114.7 8989.4 9430.5 9943.9 9979.0 9985.9 13:30:57 INFO - PROCESS | 3424 | -------- Summary: end -------- 13:30:57 INFO - PROCESS | 3424 | 13:30:58 INFO - TEST-INFO | 3424: exit 0 13:30:58 INFO - TEST-OK | dromaeo_css | took 1121529ms 13:30:58 INFO - TEST-START | kraken 13:30:58 INFO - operating with platform_type : linux_ 13:30:58 INFO - Initialising browser for kraken test... 13:30:58 INFO - TEST-INFO | started process 3782 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaSlDYm/profile http://localhost:38615/getInfo.html) 13:31:03 INFO - PROCESS | 3782 | __metrics Screen width/height:1600/1200 13:31:03 INFO - PROCESS | 3782 | colorDepth:24 13:31:03 INFO - PROCESS | 3782 | Browser inner width/height: 1024/697 13:31:03 INFO - PROCESS | 3782 | __metrics 13:31:04 ERROR - PROCESS | 3782 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3079: TypeError: this.tabs is undefined 13:31:05 INFO - TEST-INFO | 3782: exit 0 13:31:05 INFO - Browser initialized. 13:31:05 INFO - Running cycle 1/1 for kraken test... 13:31:05 INFO - TEST-INFO | started process 3905 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaSlDYm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:31:17 INFO - PROCESS | 3905 | RSS: Main: 188932096 13:31:17 INFO - PROCESS | 3905 | 13:31:20 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38615/tests/kraken/driver.html?testName=audio-beat-detection) 13:31:21 INFO - PROCESS | 3905 | RSS: Main: 202407936 13:31:21 INFO - PROCESS | 3905 | 13:31:24 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38615/tests/kraken/driver.html?testName=audio-dft) 13:31:25 INFO - PROCESS | 3905 | RSS: Main: 200265728 13:31:25 INFO - PROCESS | 3905 | 13:31:28 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38615/tests/kraken/driver.html?testName=audio-fft) 13:31:28 INFO - PROCESS | 3905 | RSS: Main: 195846144 13:31:28 INFO - PROCESS | 3905 | 13:31:30 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38615/tests/kraken/driver.html?testName=audio-oscillator) 13:31:31 INFO - PROCESS | 3905 | RSS: Main: 195862528 13:31:31 INFO - PROCESS | 3905 | 13:31:33 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:31:34 INFO - PROCESS | 3905 | RSS: Main: 196030464 13:31:34 INFO - PROCESS | 3905 | 13:31:37 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38615/tests/kraken/driver.html?testName=imaging-darkroom) 13:31:38 INFO - PROCESS | 3905 | RSS: Main: 196825088 13:31:38 INFO - PROCESS | 3905 | 13:31:41 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38615/tests/kraken/driver.html?testName=imaging-desaturate) 13:31:42 INFO - PROCESS | 3905 | RSS: Main: 194531328 13:31:42 INFO - PROCESS | 3905 | 13:31:45 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38615/tests/kraken/driver.html?testName=json-parse-financial) 13:31:45 INFO - PROCESS | 3905 | RSS: Main: 195506176 13:31:45 INFO - PROCESS | 3905 | 13:31:47 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:31:48 INFO - PROCESS | 3905 | RSS: Main: 195960832 13:31:48 INFO - PROCESS | 3905 | 13:31:50 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38615/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:31:50 INFO - PROCESS | 3905 | RSS: Main: 195837952 13:31:50 INFO - PROCESS | 3905 | 13:31:53 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:31:53 INFO - PROCESS | 3905 | RSS: Main: 195813376 13:31:53 INFO - PROCESS | 3905 | 13:31:56 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:31:57 INFO - PROCESS | 3905 | RSS: Main: 196583424 13:31:57 INFO - PROCESS | 3905 | 13:32:00 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:32:01 INFO - PROCESS | 3905 | RSS: Main: 196198400 13:32:01 INFO - PROCESS | 3905 | 13:32:02 INFO - PROCESS | 3905 | Cycle 1(1): loaded http://localhost:38615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38615/tests/kraken/driver.html?testName=ai-astar) 13:32:03 INFO - PROCESS | 3905 | RSS: Main: 198893568 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | __start_tp_report 13:32:03 INFO - PROCESS | 3905 | _x_x_mozilla_page_load 13:32:03 INFO - PROCESS | 3905 | _x_x_mozilla_page_load_details 13:32:03 INFO - PROCESS | 3905 | |i|pagename|runs| 13:32:03 INFO - PROCESS | 3905 | |0;ai-astar;110;115;117;116;118;118;116;116;116;117 13:32:03 INFO - PROCESS | 3905 | |1;audio-beat-detection;157;129;128;171;129;130;136;131;171;132 13:32:03 INFO - PROCESS | 3905 | |2;audio-dft;170;171;162;163;164;163;162;162;164;163 13:32:03 INFO - PROCESS | 3905 | |3;audio-fft;76;76;75;105;77;77;77;76;102;76 13:32:03 INFO - PROCESS | 3905 | |4;audio-oscillator;85;84;103;84;84;83;112;86;84;107 13:32:03 INFO - PROCESS | 3905 | |5;imaging-gaussian-blur;118;118;118;118;118;118;120;118;118;120 13:32:03 INFO - PROCESS | 3905 | |6;imaging-darkroom;152;150;150;146;150;148;148;149;150;149 13:32:03 INFO - PROCESS | 3905 | |7;imaging-desaturate;96;96;96;96;96;96;97;95;97;96 13:32:03 INFO - PROCESS | 3905 | |8;json-parse-financial;62;64;63;65;64;64;64;64;63;64 13:32:03 INFO - PROCESS | 3905 | |9;json-stringify-tinderbox;66;66;67;67;67;68;66;66;67;66 13:32:03 INFO - PROCESS | 3905 | |10;stanford-crypto-aes;96;84;89;85;86;84;83;85;89;90 13:32:03 INFO - PROCESS | 3905 | |11;stanford-crypto-ccm;156;141;152;143;140;146;153;148;183;153 13:32:03 INFO - PROCESS | 3905 | |12;stanford-crypto-pbkdf2;182;179;172;172;173;180;176;172;178;176 13:32:03 INFO - PROCESS | 3905 | |13;stanford-crypto-sha256-iterative;71;71;70;76;74;73;72;71;73;70 13:32:03 INFO - PROCESS | 3905 | __end_tp_report 13:32:03 INFO - PROCESS | 3905 | __start_cc_report 13:32:03 INFO - PROCESS | 3905 | _x_x_mozilla_cycle_collect,872 13:32:03 INFO - PROCESS | 3905 | __end_cc_report 13:32:03 INFO - PROCESS | 3905 | __startTimestamp1475872323136__endTimestamp 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | ------- Summary: start ------- 13:32:03 INFO - PROCESS | 3905 | Number of tests: 14 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.50 stddev:2.28 (2.0%) stddev-sans-first:1.01 13:32:03 INFO - PROCESS | 3905 | Values: 110.0 115.0 117.0 116.0 118.0 118.0 116.0 116.0 116.0 117.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#1] audio-beat-detection Cycles:10 Average:141.40 Median:134.00 stddev:17.76 (13.3%) stddev-sans-first:17.92 13:32:03 INFO - PROCESS | 3905 | Values: 157.0 129.0 128.0 171.0 129.0 130.0 136.0 131.0 171.0 132.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:3.31 (2.0%) stddev-sans-first:2.82 13:32:03 INFO - PROCESS | 3905 | Values: 170.0 171.0 162.0 163.0 164.0 163.0 162.0 162.0 164.0 163.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.00 stddev:11.53 (15.2%) stddev-sans-first:12.04 13:32:03 INFO - PROCESS | 3905 | Values: 76.0 76.0 75.0 105.0 77.0 77.0 77.0 76.0 102.0 76.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:84.00 stddev:11.36 (13.5%) stddev-sans-first:11.83 13:32:03 INFO - PROCESS | 3905 | Values: 85.0 84.0 103.0 84.0 84.0 83.0 112.0 86.0 84.0 107.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#5] imaging-gaussian-blur Cycles:10 Average:118.40 Median:118.00 stddev:0.84 (0.7%) stddev-sans-first:0.88 13:32:03 INFO - PROCESS | 3905 | Values: 118.0 118.0 118.0 118.0 118.0 118.0 120.0 118.0 118.0 120.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#6] imaging-darkroom Cycles:10 Average:149.20 Median:150.00 stddev:1.62 (1.1%) stddev-sans-first:1.36 13:32:03 INFO - PROCESS | 3905 | Values: 152.0 150.0 150.0 146.0 150.0 148.0 148.0 149.0 150.0 149.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 13:32:03 INFO - PROCESS | 3905 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 97.0 95.0 97.0 96.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.60 13:32:03 INFO - PROCESS | 3905 | Values: 62.0 64.0 63.0 65.0 64.0 64.0 64.0 64.0 63.0 64.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#9] json-stringify-tinderbox Cycles:10 Average:66.60 Median:67.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 13:32:03 INFO - PROCESS | 3905 | Values: 66.0 66.0 67.0 67.0 67.0 68.0 66.0 66.0 67.0 66.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.50 stddev:3.96 (4.5%) stddev-sans-first:2.57 13:32:03 INFO - PROCESS | 3905 | Values: 96.0 84.0 89.0 85.0 86.0 84.0 83.0 85.0 89.0 90.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:152.50 stddev:12.36 (8.1%) stddev-sans-first:13.00 13:32:03 INFO - PROCESS | 3905 | Values: 156.0 141.0 152.0 143.0 140.0 146.0 153.0 148.0 183.0 153.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.00 Median:177.00 stddev:3.68 (2.1%) stddev-sans-first:3.20 13:32:03 INFO - PROCESS | 3905 | Values: 182.0 179.0 172.0 172.0 173.0 180.0 176.0 172.0 178.0 176.0 13:32:03 INFO - PROCESS | 3905 | 13:32:03 INFO - PROCESS | 3905 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.10 Median:72.50 stddev:1.91 (2.6%) stddev-sans-first:1.99 13:32:03 INFO - PROCESS | 3905 | Values: 71.0 71.0 70.0 76.0 74.0 73.0 72.0 71.0 73.0 70.0 13:32:03 INFO - PROCESS | 3905 | -------- Summary: end -------- 13:32:03 INFO - PROCESS | 3905 | 13:32:04 INFO - TEST-INFO | 3905: exit 0 13:32:04 INFO - TEST-OK | kraken | took 65468ms 13:32:04 INFO - SUITE-END | took 1186s 13:32:04 INFO - Completed test suite (00:19:47) 13:32:04 INFO - javascript benchmark 13:32:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6260.904677445822, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.741925807419, 2597.32469557915, 2599.9350016249605, 2621.3315604520844, 2622.5541657918147, 4592.862214133573, 4621.768911554425, 4629.213033784256, 4641.767911604423, 4656.41794775653, 4662.930056049162, 4689.882752931178, 4725.881852953669, 4749.216379297421, 4752.548507891754, 4273.572642735733, 4306.418633484486, 4355.194289056519, 4395.05506316142, 4443.866683999485, 4411.514733379326, 4412.161689279043, 4420.469543654766, 4426.712263702849, 4437.711548749337, 4216.051388437608, 4252.574742525753, 4294.184105020036, 4394.62645675118, 4443.866683999485, 4324.22164010478, 4345.109252603241, 4367.388565600819, 4416.823327066913, 4424.734515929054, 4305.9354109688065, 4338.045629961435, 4358.912821743547, 4379.146066517031, 4394.62645675118, 4612.907741845178, 4650.976745116287, 4688.882777930545, 4752.737871957173, 4756.239001759702, 5030.899382012376, 5085.644004919657, 5094.337736094284, 5107.0, 5150.716710580917, 5137.7944882204665, 5138.203578445347, 5144.125498665236, 5151.896962060738, 5200.869978250574, 4603.608693261111, 4765.046990601859, 4770.475247722782, 4781.306710526954, 4825.203841366206, 5066.771995260222, 5125.513076257749, 5172.19830926207, 5178.663386879841, 5231.581473482112, 4938.308636790852, 4971.527704868032, 4977.054359671651, 4985.052839960396, 5041.59667226621, 4969.82605608802, 4974.1543937530705, 4986.800527978913, 5069.467705890902, 5076.543111120017, 4943.4809345018975, 4945.629077819178, 5015.498450154955, 5021.221710634857, 5026.346574945233, 4974.925376119361, 4990.700557966534, 5033.119204139261, 5099.59203263738, 5148.871278218075, 4379.956200437955, 4386.649068074546, 4388.648908087345, 4389.670774691911, 4438.289873620205, 3715.2198038412234, 3809.3143234218105, 3829.215010922754, 3856.5950575189763, 3916.549596796405, 4192.727472714264, 4302.354646802942, 4344.956550434518, 4349.934750978738, 4405.07493426384, 5082.059818933435, 5106.0, 5112.335396398519, 5115.7442127893455, 5174.379074511083, 4324.2222067552475, 4332.176886391576, 4340.65274778017, 4353.69524133314, 4404.383386325917, 4410.625096866802, 4499.865004049884, 4514.232580461329, 4517.977410112929, 4554.863354099382, 4738.691985020962, 4739.739314337745, 4746.311784791117, 4771.71369717825, 4792.928106078341, 5011.7494125294315, 5034.270030845581, 5054.570361519312, 5065.986802639413, 5114.284000239895, 4566.657500687528, 4614.607758340444, 4624.953750462587, 4660.184467718068, 4683.039976804815, 4973.055119527278, 4974.0797952378925, 4978.352814134284, 5010.273510340907, 5021.347224860745, 5023.146065169003, 5042.84871453857, 5046.873828154326, 5048.873778155428, 5100.719460429712, 4790.856274311776, 4858.198397264412, 4901.2893130496595, 4906.730129842893, 4973.602111830973, 4916.213405855046, 4955.0, 4967.875803104951, 5009.749512524287, 5021.723805190603, 4778.211595086772, 4822.9758851205515, 4839.576985122776, 4855.247436647325, 4886.828960986349, 4841.152798260361, 4848.80604775805, 4865.172920603435, 4881.389826271716, 4885.804567817389, 4761.500042495488, 4774.116788394158, 4799.640026997919, 4829.13075646387, 4852.0295940811275], "value": 4636.0407345385665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.3576683164112, 551.837208023633, 558.3801979802421, 558.6592178770949, 570.4495162168506, 36470.63529364706, 38613.80693096537, 38674.0, 42346.0, 42350.57649423505, 38645.42031869524, 39405.0, 39421.40867886984, 39513.0, 39563.0, 7466.440016998733, 7672.616369181546, 7702.383809295271, 7706.306432421081, 7707.0, 7530.774076777706, 7595.316421522062, 7596.354309883639, 7606.315431611154, 7626.19924907885, 7616.352610028154, 7651.693932242703, 7659.846803063935, 7670.501417407879, 7700.229977002283, 7565.924340756632, 7568.09182898053, 7616.581088040156, 7636.083669959585, 7637.656305466239, 7609.124950630638, 7626.351760100398, 7667.309942105181, 7676.884846727304, 7688.34649054831, 37628.81185594082, 37832.621673783186, 37946.430803537965, 37953.240935181144, 37998.62001379979, 2792.678841933163, 2992.311768293305, 3208.8235147066903, 3222.7421806255443, 3442.2599141184514, 27235.45529089407, 27537.724622753718, 27680.584791228146, 28266.29334266639, 29063.0, 3458.948115778265, 3507.1232191952013, 3510.473428985647, 3529.7352698547456, 3550.0947258449187, 246839.0, 246988.00601948675, 247132.0, 247691.0, 247788.0, 48923.75538122358, 49298.50701493011, 49357.50642493601, 49423.0, 49449.50550494521, 52189.21716174261, 52387.738061310214, 52455.0, 52488.212676809875, 52534.21198682023, 14952.476663316731, 15132.243387830564, 15210.847891520943, 15253.771193432107, 15265.23673816327, 11077.50151243196, 11108.888911110947, 11110.05564527008, 11119.0, 11124.221304508606, 14257.429702811978, 14626.268686565629, 14739.263036848115, 14893.0, 15059.623509412133, 5657.745401456944, 5862.941370586324, 5909.438603332676, 6005.879882402328, 6068.33248342682, 760.5322726523149, 908.9545522723837, 936.9812603747887, 946.5551190940247, 954.4178051388648, 26536.60195097075, 27916.860415697793, 28096.0, 30904.227394315323, 31004.53493197604, 935.8175155844544, 942.9387089839139, 967.4098799732299, 983.5131609853169, 1003.6988903328972, 14317.21255330946, 14384.273887133402, 14487.92756036213, 14526.0, 14613.488527901685, 188888.0, 189616.0, 189878.0, 191000.0, 191030.0, 46859.29711054337, 47070.0, 47085.76457117761, 47201.763991179825, 47214.291785623245, 1182.7693599748138, 1198.2091819399154, 1222.8899399054128, 1232.5624403337044, 1233.0, 25954.480910382063, 26581.33546661349, 26823.329416764736, 27286.04498842531, 27336.589951150352, 40869.38695919623, 41613.0, 41661.375079373225, 41749.79125104355, 41750.0, 347167.0, 347681.0, 348938.0, 349036.0, 349456.0, 23851.761482384954, 24083.51832963296, 24242.0, 24919.377015574755, 25005.499890001734, 39614.40578391384, 39821.2035759289, 40013.39979900246, 40048.39927401033, 40403.59596403998, 34258.828705856315, 35057.298854022265, 35459.0, 35619.46570801492, 35652.64347356597, 35116.82441587776, 35223.29553408969, 35320.29359412849, 35377.646223537435, 35588.466173007946, 34113.31773364569, 34557.82721086378, 34677.82661086678, 35211.64788352084, 35266.1183470405, 30931.2267193313, 31991.0, 32299.35401292008, 32710.0, 32850.1787455306, 24958.500829982935, 24963.500729985662, 25034.62448063244, 25138.497230055662, 25615.103471378414], "value": 16799.697733533045, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.5249365849761, 355.95906470755864, 360.1195078034207, 368.16059384603113, 382.69958082904924, 15124.848751512482, 16378.508644740661, 16392.999999999985, 16498.917505412486, 16505.422310219146, 15474.767878481833, 16736.748948765748, 17140.314387424518, 17348.91812982444, 17349.82650173501, 4850.708957462554, 5126.359205099344, 5127.9230811537855, 5129.461406552296, 5135.3837539495125, 3680.834362453696, 3863.6715879150306, 5051.090803655341, 5638.238837756912, 5985.132155837401, 6005.639661620295, 6008.699565021753, 6025.3372129065765, 6042.093685947099, 6064.848378790543, 5801.158831969362, 5958.8808223835495, 5983.700814959257, 5991.700414979234, 5994.13085102662, 5061.16490779021, 5236.607254455931, 5240.79036838526, 5245.501677340647, 5250.18622113573, 20065.699014514794, 20369.592608147756, 20514.589708205902, 20527.17891284347, 20543.5891282175, 1815.1196669615226, 1894.551548211614, 1900.277894400119, 1966.1545535419907, 2394.7485514021128, 12121.818172727417, 12910.612681619567, 13334.933325333408, 13341.399637016357, 13352.132111412824, 1663.7005339038967, 1727.637196188802, 1743.302678928426, 1758.3703586163128, 1771.1498480729322, 68555.3144468554, 68644.65677671629, 69157.65421172912, 69179.99999999949, 71202.0, 8093.109757926623, 8100.797480062928, 8307.916920830836, 9438.38650487716, 9639.951800240953, 12862.807057894139, 12962.157459765085, 12998.155119917175, 13006.089573729938, 13040.80438793419, 7132.643367831588, 7223.566586004857, 7421.591812450259, 7441.367483763833, 7503.0, 6899.103116594811, 7005.649717514104, 7116.786496405116, 7257.600831954293, 7329.963350183215, 5638.6052976292085, 5877.882442351129, 5906.763729450774, 6074.54440916933, 6153.2000839890525, 1585.714571377163, 1614.386533117408, 1626.5933516620844, 1702.9659406811795, 1748.8925844357518, 838.3544670603601, 845.1084106267946, 879.2833840420037, 909.3316412436853, 964.9614015439304, 16209.918950405172, 16554.503364899072, 16934.237959291862, 17154.0, 17231.483055508354, 845.7631863078348, 859.2009431228892, 893.0622846011662, 895.7491902267376, 903.336048004716, 9369.0, 10047.141278863433, 10109.292349535463, 10124.240681948882, 10239.0, 328716.0, 331468.0, 331486.0, 347479.0, 356808.0, 65687.0, 67650.32349676538, 67668.66165669239, 68510.0, 70410.64794676096, 885.5660726244223, 906.8437741879156, 909.4316052467208, 937.7093101138669, 938.3056538161711, 14876.404943802127, 15086.849131508983, 15285.465008724641, 15566.37734490653, 15576.0, 33616.32767344688, 33966.0, 34270.314593708485, 35013.824930875184, 35533.82233088921, 42706.57293427026, 42914.35628465638, 43258.78370608127, 43759.0, 44217.55782442135, 7403.0, 7587.58268295249, 7615.923840761521, 7793.454458187873, 7793.688252470064, 11711.0, 11753.88246117562, 11808.527658893549, 12260.693482663004, 12461.376931153587, 10173.643922462677, 10217.233707472118, 10256.692299231036, 10271.691849244535, 10536.841947370642, 10115.291929565154, 10627.309224900357, 10697.090747286567, 10707.518161682587, 10780.353178809297, 9998.200143988319, 10396.324238924446, 10559.155267578422, 10708.900450364948, 10958.178136639624, 7309.780706578811, 7437.0331856858265, 7581.734639287599, 7720.420968427278, 7750.961245193738, 9698.515074246401, 10232.744181395525, 10319.587216511256, 10358.0, 10823.350598964087], "value": 8222.817983054101, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1346.3537501999037, 1377.3251106957591, 1451.8983671143017, 1638.7378019516873, 1663.2681620087153, 6483.708233129509, 6714.664266786665, 6911.20521140069, 7512.248775122485, 7520.059992500937, 6951.756688515903, 7237.1315442147015, 7237.67430465629, 7415.851682966338, 7430.962845185766, 1981.5343394302326, 2025.5847551252032, 2033.9593208135827, 2035.3385149826292, 2042.9897850510727, 1954.15971132413, 1997.1312479071578, 1997.560536681935, 2022.3932820153968, 2046.447459186019, 1958.343954775152, 1983.6032793441298, 2002.0, 2003.0485519378324, 2005.8896760678158, 1948.1038722187811, 1956.1295223625493, 1956.5793354428865, 1959.8040195980288, 1967.0263219706337, 1849.0847030719744, 1852.8888266704041, 1879.079251166932, 1905.0569967865856, 1906.8569857260761, 7400.259974002611, 7408.7406940757355, 7471.962640186819, 7479.139898911641, 7481.0, 4242.193983143224, 4353.891152721176, 4357.716748411375, 4359.978200109011, 4363.978180109079, 2660.144895889449, 2723.4689235599067, 2737.20621019904, 2777.750002499785, 2795.24528377339, 828.3249151941209, 856.3748463621591, 872.3936863879607, 885.7696998780299, 889.89321281446, 9280.628774848998, 9327.0, 9364.157225849705, 9373.06269373064, 9404.623815047458, 3460.9307813843584, 3606.1705807664384, 3854.094287842355, 3859.1895701902354, 3862.8841134766003, 8132.6746930122135, 8164.877526837102, 8173.591320434073, 8178.46839955401, 8206.261436470746, 4240.13077319155, 4240.427542281753, 4248.660107191417, 4260.2320037184845, 4273.743575385487, 3536.2397084626414, 3669.688076513473, 3899.454076429302, 3944.9211015779524, 3955.248502784462, 3403.931921361559, 3433.9828300858335, 3483.2162763378037, 3556.110972256936, 3572.1962558424666, 1112.9666110016713, 1117.3519358771894, 1124.3478782306242, 1132.4790596325784, 1140.988590114105, 702.8559145375186, 710.7881062787934, 786.2627668298434, 807.7455601485514, 847.2967437027253, 4959.752012399438, 4999.675021123615, 5024.598032157419, 5034.244863270539, 5218.478152184751, 364.7027672446947, 379.58814686065926, 819.7950512371907, 939.3471537281661, 957.5451660461365, 3312.867485300561, 3402.6597340265776, 3407.931841363159, 3448.827558622059, 3491.1970246843366, 8622.137786221454, 8677.652893884175, 8892.199702026848, 8971.327150463741, 8981.371304008657, 8923.509206993547, 8928.553572321358, 8943.552822358855, 8944.686935957341, 8949.284057275403, 6450.677466126769, 6498.54510184292, 6554.475641948633, 6667.466602671678, 6719.529632925648, 4789.592884604847, 4800.951990480051, 4865.464798872192, 4868.926966095441, 4870.659053866337, 8281.130481299619, 8317.209865062809, 8321.209485098905, 8335.624896879533, 8335.916640833513, 8217.096119426738, 8317.168283171635, 8360.623771930155, 8587.05542390349, 8624.439411438487, 5510.724463776875, 5703.0, 6008.789692360747, 6120.234970628671, 6133.938660613515, 6856.142982127234, 6990.9300906990275, 7058.964705176441, 7293.452991025801, 7308.8903666443985, 6148.0, 6284.465820405134, 6314.936850631435, 6324.335944725922, 6451.838704032437, 6002.609830361012, 6023.27720673522, 6024.307204671519, 6029.60807547508, 6057.242844644419, 5686.914696279477, 5689.2319536862, 5735.627184233012, 5738.942610573841, 5748.281464816898, 4141.627253547195, 4282.293421585404, 4361.411209486806, 4388.4295041645655, 4462.040661257845, 4534.365188873494, 4536.11545748589, 4551.590356867898, 4597.103564804831, 4613.054323863667], "value": 3821.840313517714, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [278.8772939906441, 288.0781499202552, 288.09107266573955, 289.97825163112765, 292.33493801601367, 4941.950580494194, 4965.354503914495, 5023.693839601707, 5031.874203144923, 5032.6477146599755, 4874.1973365315, 4876.2929375240565, 4884.291777692232, 4887.877803054926, 4913.0102308565, 3605.441156620728, 3685.852565897361, 3729.440583912421, 3755.9061023474496, 3831.3103641344546, 3848.576026870062, 3854.094287842355, 3857.691384689218, 3861.4980052593123, 3868.516435445569, 3835.0, 3838.309104361214, 3838.7504812187117, 3840.0, 3851.903702407434, 3557.1996300832366, 3739.139997800494, 3829.8659546915865, 3855.7300988930647, 3862.633049860259, 3272.2146684795716, 3274.0341599228286, 3274.6889045540875, 3276.950845737316, 3280.917977050569, 4810.422749270075, 4814.277858321245, 4820.0, 4823.20417131173, 4833.516648335173, 4296.014270082263, 4296.355546667994, 4306.332518459643, 4308.82764689412, 4313.899955511356, 4997.800087996476, 5079.593632509391, 5118.155504341779, 5132.692038477666, 5133.204353325241, 3547.130952916526, 3548.6628770266784, 3550.5029295898594, 3568.4825700273573, 3568.8572457101686, 5322.973385133049, 5358.276632654581, 5425.240466334716, 5431.995080910045, 5435.972820135914, 3541.9822900885847, 3626.963730362663, 3628.854845806191, 3634.345817752777, 3636.7272454566014, 3668.706503479715, 3680.9263814723554, 3683.557973043198, 3688.61269566697, 3690.132818787583, 4218.725782824168, 4244.766537840386, 4250.42619246404, 4285.5928686774705, 4302.924268932767, 4856.902861942812, 5120.180771076684, 5142.691438513626, 5163.845084647466, 5212.045482943896, 1256.7109564800148, 1284.1588759362446, 1285.3932584269662, 1288.2850018239778, 1288.7229245712028, 789.4684707886811, 801.9759407217792, 806.4717609965483, 821.4783612406166, 823.2343920154194, 4316.913661726748, 4361.825526978949, 4448.799804008828, 4515.571020753023, 4533.297338912474, 5343.65266257692, 5347.946520534822, 5354.625176237626, 5357.11607584752, 5359.330083739533, 4524.3712263585085, 4524.728516289033, 4528.864134075983, 4537.636989040869, 4540.88647783808, 2704.986475067612, 2797.5800932193506, 2834.14975507347, 2835.681408145181, 2836.8439735814313, 4958.8760280993265, 4975.950240497548, 4977.751112444364, 4983.778974151356, 4985.252212168204, 5201.713905735145, 5427.185922111715, 5437.157240627709, 5438.211459338453, 5444.537214336826, 5038.470960549163, 5059.241113832881, 5060.2662613920775, 5068.0, 5075.56857667095, 5301.787928482971, 5405.459454054563, 5419.864503387447, 5423.349198096096, 5447.031367904422, 5141.588672906233, 5230.97384513075, 5274.835098940758, 5291.0, 5291.1798671206025, 5013.523715247045, 5016.667249728894, 5018.272350509083, 5019.573336266459, 5046.747662616928, 3628.14738536449, 3642.9635703642625, 3650.105724097613, 3658.835352409095, 3661.5240018797385, 5160.870978225575, 5319.654222475527, 5362.570994320367, 5376.946230537645, 5379.596530260168, 5189.481051894781, 5196.922046169235, 5201.47985201492, 5207.713575753219, 5212.791488340576, 5181.611379146654, 5195.064888319987, 5202.297689811827, 5206.817761378334, 5211.76547055391, 4914.2137258039975, 5101.974490127525, 5131.25596788471, 5144.6655967362, 5145.4340022598235, 4997.300377947163, 5080.418305094973, 5147.9227811582105, 5230.686158830483, 5240.502152295526, 5143.9712057587885, 5145.485451454824, 5146.408163061295, 5146.588272938081, 5158.690478571298], "value": 3850.433078064836, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.8053642298042, 606.9332373438921, 607.7994261893575, 661.4741280681855, 681.9965900170498, 12462.750744985105, 12917.935410322934, 12944.74110517789, 12992.350382480874, 13006.284654344006, 12306.077044221696, 12389.25664460133, 12393.132480726354, 12400.689982750413, 12413.689657758538, 738.5679377564131, 747.8579069976687, 758.8140905478166, 778.5289899610739, 783.6238605469379, 779.6140910249435, 781.4295564238109, 781.9921800782005, 783.4006984656742, 784.1022029775903, 809.0049239435498, 815.7511958852577, 816.4692949582759, 817.4768148385009, 818.6684392820918, 812.0661239574507, 812.2080971053206, 814.4828034198326, 814.5886327404622, 815.955122468264, 593.913882487037, 596.4780816785313, 596.7046312075507, 597.2325561653255, 597.3309892919914, 13049.217046977212, 13106.80339794904, 13109.410076546483, 13130.343482825916, 13150.0, 12413.813792793115, 12742.0, 13072.150310229805, 13178.275194864278, 13605.455781768718, 9885.505724713807, 11178.385188814613, 11291.49188286529, 11689.532418703242, 11874.821877671842, 4112.115895082572, 4149.771762553059, 4169.478815148106, 4303.493777177994, 4321.697481176319, 57498.13752793711, 58355.41644583542, 58417.74240318392, 58606.706966464895, 59204.407955920324, 10005.79988400228, 10189.745256368502, 10272.589096436208, 10334.224933130045, 10672.466376681135, 18392.172352244183, 18596.907015464836, 18646.254149834127, 18696.626067478574, 18781.90609046946, 6411.230652321751, 6420.036994450869, 6421.678916054178, 6525.217391304348, 6618.602883826986, 3509.7192224621967, 3545.7872527648424, 3656.2687462507606, 3673.4673472346362, 3705.6850167735506, 2654.376221587925, 2720.047983205902, 2720.9319767005586, 2724.741149590786, 2730.9726902730717, 486.67392846792734, 490.4164044786692, 498.9226669866176, 504.4022832942901, 505.2850216943058, 523.7957196693293, 547.3623228938243, 575.556821247637, 576.1990832742407, 582.490320969152, 7918.841623167505, 8007.959960200162, 8031.156728543536, 8076.596170191467, 8101.918980810116, 467.45774901115226, 478.93294938708607, 482.55604843544023, 494.77240469384486, 575.8646718021262, 3780.2250538639514, 3911.5892831252877, 3950.4271880577157, 4126.958730412717, 4184.325731209951, 52995.0, 53574.196387054224, 60308.69845650744, 90079.0, 90104.54947725219, 78982.0, 80244.59877700574, 82134.58932705298, 82406.17593824105, 83136.16863831405, 70444.64777676182, 71134.28865711381, 73315.0, 74398.25601744022, 74832.0, 7759.806004849924, 7934.951905612486, 8023.598820058857, 8091.0, 8279.296259817984, 41252.38121428121, 41662.37506437345, 42185.789071054445, 42233.36649950192, 42792.358114627685, 34189.0, 39170.608293916695, 47403.52596474129, 49274.75362623164, 51829.0, 10445.791084178425, 11715.355655439032, 11732.824007639721, 11733.823992640288, 11839.704007399883, 12607.306598137191, 12943.801380632261, 12997.545085921947, 13046.869531304945, 13180.736385272048, 12099.75800484003, 12479.31363775001, 12484.812727808909, 12527.56153534622, 12969.675758106123, 11919.76160476803, 12316.568920088112, 12506.687332816753, 12647.241165530098, 12671.17637353569, 11462.369569673749, 11831.76336473283, 12252.264864108181, 12254.816177757162, 12368.44342004594, 9439.52802359893, 9900.356476828983, 9963.202943764627, 9981.950090249502, 10114.696559103239, 8989.41568798026, 9430.52847357643, 9943.900560994587, 9979.0, 9985.850212246967], "value": 6390.28937411922, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 115.0, 117.0, 116.0, 118.0, 118.0, 116.0, 116.0, 116.0, 117.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 129.0, 128.0, 171.0, 129.0, 130.0, 136.0, 131.0, 171.0, 132.0], "value": 141.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 171.0, 162.0, 163.0, 164.0, 163.0, 162.0, 162.0, 164.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 105.0, 77.0, 77.0, 77.0, 76.0, 102.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 103.0, 84.0, 84.0, 83.0, 112.0, 86.0, 84.0, 107.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 118.0, 120.0, 118.0, 118.0, 120.0], "value": 118.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 150.0, 150.0, 146.0, 150.0, 148.0, 148.0, 149.0, 150.0, 149.0], "value": 149.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 97.0, 95.0, 97.0, 96.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 65.0, 64.0, 64.0, 64.0, 64.0, 63.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 67.0, 67.0, 68.0, 66.0, 66.0, 67.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 84.0, 89.0, 85.0, 86.0, 84.0, 83.0, 85.0, 89.0, 90.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 141.0, 152.0, 143.0, 140.0, 146.0, 153.0, 148.0, 183.0, 153.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 179.0, 172.0, 172.0, 173.0, 180.0, 176.0, 172.0, 178.0, 176.0], "value": 176.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 70.0, 76.0, 74.0, 73.0, 72.0, 71.0, 73.0, 70.0], "value": 72.1, "unit": "score"}]}]} 13:32:04 INFO - Return code: 0 13:32:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:32:04 ERROR - # TBPL SUCCESS # 13:32:04 INFO - Running post-action listener: _resource_record_post_action 13:32:04 INFO - [mozharness: 2016-10-07 20:32:04.943472Z] Finished run-tests step (success) 13:32:04 INFO - Running post-run listener: _resource_record_post_run 13:32:05 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 7884800; Write bytes: 421158912; Read time: 1708; Write time: 306600 13:32:05 INFO - TinderboxPrint: CPU usage
13.4% 13:32:05 INFO - TinderboxPrint: I/O read bytes / time
7,884,800 / 1,708 13:32:05 INFO - TinderboxPrint: I/O write bytes / time
421,158,912 / 306,600 13:32:05 INFO - TinderboxPrint: CPU idle
8,317.0 (86.6%) 13:32:05 INFO - TinderboxPrint: CPU user
1,220.4 (12.7%) 13:32:05 INFO - TinderboxPrint: Swap in / out
0 / 0 13:32:05 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 5636096; Read time: 0; Write time: 916 13:32:05 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 5677056; Write bytes: 413634560; Read time: 1560; Write time: 304140 13:32:05 INFO - Running post-run listener: _upload_blobber_files 13:32:05 INFO - Blob upload gear active. 13:32:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:32:05 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 13:32:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Larch-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:32:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Larch-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:32:06 INFO - (blobuploader) - INFO - Open directory for files ... 13:32:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:32:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:32:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:09 INFO - (blobuploader) - INFO - Done attempting. 13:32:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:32:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:10 INFO - (blobuploader) - INFO - Done attempting. 13:32:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:32:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:32:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:32:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:32:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:32:10 INFO - (blobuploader) - INFO - Done attempting. 13:32:10 INFO - (blobuploader) - INFO - Iteration through files over. 13:32:10 INFO - Return code: 0 13:32:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:32:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:32:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/2cef406c71433aa435fbb69cd2dc006b778644b76e74d9de04f19de18e683af32c61e036983a518243bfb24f90b536f65161739963bf990a44b2dcd27ed0d285", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/313840ff316690f636295e14192fcb2a625d254b15e43fd90830d02f8f2b9263451d943aab26edc81cc012eb8a793a1f63073946d8ea03ad6193075a23fb7e2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/090aa1470bad056f1783c7b9ab500888b1fc88c160a94ef815ba8fe5feb3d1d9c68ae1bf20507afbf89f3f88cfadb5943ed1a35f8cb662848fa3948ba0da8cad"} 13:32:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:32:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:32:10 INFO - Contents: 13:32:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/2cef406c71433aa435fbb69cd2dc006b778644b76e74d9de04f19de18e683af32c61e036983a518243bfb24f90b536f65161739963bf990a44b2dcd27ed0d285", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/313840ff316690f636295e14192fcb2a625d254b15e43fd90830d02f8f2b9263451d943aab26edc81cc012eb8a793a1f63073946d8ea03ad6193075a23fb7e2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/090aa1470bad056f1783c7b9ab500888b1fc88c160a94ef815ba8fe5feb3d1d9c68ae1bf20507afbf89f3f88cfadb5943ed1a35f8cb662848fa3948ba0da8cad"} 13:32:10 INFO - Running post-run listener: copy_logs_to_upload_dir 13:32:10 INFO - Copying logs to upload dir... 13:32:10 INFO - mkdir: /builds/slave/test/build/upload/logs 13:32:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.800448 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-10-07 13:32:10.975653) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 13:32:10.979051) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872 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/Larch-Non-PGO/sha512/2cef406c71433aa435fbb69cd2dc006b778644b76e74d9de04f19de18e683af32c61e036983a518243bfb24f90b536f65161739963bf990a44b2dcd27ed0d285", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/313840ff316690f636295e14192fcb2a625d254b15e43fd90830d02f8f2b9263451d943aab26edc81cc012eb8a793a1f63073946d8ea03ad6193075a23fb7e2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/090aa1470bad056f1783c7b9ab500888b1fc88c160a94ef815ba8fe5feb3d1d9c68ae1bf20507afbf89f3f88cfadb5943ed1a35f8cb662848fa3948ba0da8cad"} build_url:https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011270 build_url: 'https://queue.taskcluster.net/v1/task/HmWIxuYTRfS3svN6UIExnw/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/Larch-Non-PGO/sha512/2cef406c71433aa435fbb69cd2dc006b778644b76e74d9de04f19de18e683af32c61e036983a518243bfb24f90b536f65161739963bf990a44b2dcd27ed0d285", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/313840ff316690f636295e14192fcb2a625d254b15e43fd90830d02f8f2b9263451d943aab26edc81cc012eb8a793a1f63073946d8ea03ad6193075a23fb7e2e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Larch-Non-PGO/sha512/090aa1470bad056f1783c7b9ab500888b1fc88c160a94ef815ba8fe5feb3d1d9c68ae1bf20507afbf89f3f88cfadb5943ed1a35f8cb662848fa3948ba0da8cad"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-07 13:32:11.003892) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:32:11.004226) ========= 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=8887e36bb8e381bfd44124ac000001a8-1475871074.163721-198777872 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004474 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-07 13:32:11.089701) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 13:32:11.090053) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-07 13:32:11.090373) ========= ========= Total master_lag: 0.17 =========