builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-011 starttime: 1479936336.51 results: success (0) buildid: 20161123104536 builduid: c0172d0e94b549c1b2e9a78bc3f1c51e revision: 6824ecd27c27cb6194dbca2cef13d12e9ddb3603 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:36.505430) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:36.505949) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:36.506263) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:36.527208) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:36.527637) ========= 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=5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-23 13:25:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-11-23 13:25:36 (114 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.083685 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:36.627917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:36.628215) ========= 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=5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014935 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:36.677731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 13:25:36.678091) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6824ecd27c27cb6194dbca2cef13d12e9ddb3603 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6824ecd27c27cb6194dbca2cef13d12e9ddb3603 --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=5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-23 13:25:36,978 truncating revision to first 12 chars 2016-11-23 13:25:36,978 Setting DEBUG logging. 2016-11-23 13:25:36,978 attempt 1/10 2016-11-23 13:25:36,978 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6824ecd27c27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-23 13:25:38,348 unpacking tar archive at: mozilla-aurora-6824ecd27c27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.739030 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-23 13:25:38.431182) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:38.431505) ========= script_repo_revision: 6824ecd27c27cb6194dbca2cef13d12e9ddb3603 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:38.431944) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:38.432233) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-23 13:25:38.441402) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-23 13:25:38.441767) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 13:25:38 INFO - MultiFileLogger online at 20161123 13:25:38 in /builds/slave/test 13:25:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:25:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:38 INFO - {'append_to_log': False, 13:25:38 INFO - 'base_work_dir': '/builds/slave/test', 13:25:38 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:25:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:38 INFO - 'branch': 'Mozilla-Aurora', 13:25:38 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:38 INFO - 'config_files': ('talos/linux_config.py',), 13:25:38 INFO - 'default_actions': ('clobber', 13:25:38 INFO - 'read-buildbot-config', 13:25:38 INFO - 'download-and-extract', 13:25:38 INFO - 'populate-webroot', 13:25:38 INFO - 'create-virtualenv', 13:25:38 INFO - 'install', 13:25:38 INFO - 'run-tests'), 13:25:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:38 INFO - 'download_minidump_stackwalk': True, 13:25:38 INFO - 'download_symbols': 'ondemand', 13:25:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:38 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:38 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:38 INFO - 'installer_path': 'installer.exe', 13:25:38 INFO - 'log_level': 'info', 13:25:38 INFO - 'log_name': 'talos', 13:25:38 INFO - 'log_to_console': True, 13:25:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 13:25:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 13:25:38 INFO - 'opt_config_files': (), 13:25:38 INFO - 'pip_index': False, 13:25:38 INFO - 'sps_profile': False, 13:25:38 INFO - 'sps_profile_interval': 0, 13:25:38 INFO - 'suite': 'dromaeojs', 13:25:38 INFO - 'system_bits': '32', 13:25:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:38 INFO - 'title': 'talos-linux64-ix-011', 13:25:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:38 INFO - 'use_talos_json': True, 13:25:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:38 INFO - 'work_dir': 'build'} 13:25:38 INFO - [mozharness: 2016-11-23 21:25:38.833545Z] Running clobber step. 13:25:38 INFO - Running pre-action listener: _resource_record_pre_action 13:25:38 INFO - Running main action method: clobber 13:25:38 INFO - rmtree: /builds/slave/test/build 13:25:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:25:39 INFO - Running post-action listener: _resource_record_post_action 13:25:39 INFO - [mozharness: 2016-11-23 21:25:39.819873Z] Finished clobber step (success) 13:25:39 INFO - [mozharness: 2016-11-23 21:25:39.819970Z] Running read-buildbot-config step. 13:25:39 INFO - Running pre-action listener: _resource_record_pre_action 13:25:39 INFO - Running main action method: read_buildbot_config 13:25:39 INFO - Using buildbot properties: 13:25:39 INFO - { 13:25:39 INFO - "project": "", 13:25:39 INFO - "product": "firefox", 13:25:39 INFO - "script_repo_revision": "production", 13:25:39 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 13:25:39 INFO - "repository": "", 13:25:39 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 13:25:39 INFO - "buildid": "20161123104536", 13:25:39 INFO - "pgo_build": "True", 13:25:39 INFO - "basedir": "/builds/slave/test", 13:25:39 INFO - "buildnumber": 920, 13:25:39 INFO - "slavename": "talos-linux64-ix-011", 13:25:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 13:25:39 INFO - "platform": "ubuntu64_hw", 13:25:39 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 13:25:39 INFO - "branch": "mozilla-aurora", 13:25:39 INFO - "repo_path": "releases/mozilla-aurora", 13:25:39 INFO - "revision": "6824ecd27c27cb6194dbca2cef13d12e9ddb3603", 13:25:39 INFO - "stage_platform": "linux64-pgo", 13:25:39 INFO - "builduid": "c0172d0e94b549c1b2e9a78bc3f1c51e", 13:25:39 INFO - "slavebuilddir": "test" 13:25:39 INFO - } 13:25:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 13:25:39 INFO - Running post-action listener: _resource_record_post_action 13:25:39 INFO - [mozharness: 2016-11-23 21:25:39.822375Z] Finished read-buildbot-config step (success) 13:25:39 INFO - [mozharness: 2016-11-23 21:25:39.822462Z] Running download-and-extract step. 13:25:39 INFO - Running pre-action listener: _resource_record_pre_action 13:25:39 INFO - Running main action method: download_and_extract 13:25:39 INFO - mkdir: /builds/slave/test/build/tests 13:25: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:25:39 INFO - trying https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 13:25:39 INFO - Downloading https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 13:25:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 13:25:40 INFO - Downloaded 1361 bytes. 13:25:40 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 13:25:40 INFO - Using the following test package requirements: 13:25:40 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 13:25:40 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:25:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 13:25:40 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:25:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 13:25:40 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:25:40 INFO - u'jsshell-linux-x86_64.zip'], 13:25:40 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:25:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 13:25:40 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 13:25:40 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:25:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 13:25:40 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:25:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 13:25:40 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:25:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 13:25:40 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 13:25:40 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 13:25:40 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 13:25:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 13:25:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:25:40 INFO - Fetch https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 13:25:40 INFO - Http code: 200 13:25:40 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 13:25:40 INFO - x-amz-cf-id: yjqq4Q2bSr83VLT_DFApfKY-MjjSa40HeY7s2bsQsaWgMztRbKKj1w== 13:25:40 INFO - x-amz-version-id: HJJO0sbLlFxEc8sPmeVTQh.RUyEgz1o8 13:25:41 INFO - Expected file size: 21949740 13:25:41 INFO - Obtained file size: 21949740 13:25:45 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 13:25:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 13:25:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 13:25:45 INFO - Fetch https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 13:25:45 INFO - Http code: 200 13:25:45 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 13:25:45 INFO - x-amz-cf-id: o5ZHj-bitiAvo1hXn6TYx5peufpqpt--MU1h3HOi-kPVw85QPsCyqQ== 13:25:45 INFO - x-amz-version-id: HJJO0sbLlFxEc8sPmeVTQh.RUyEgz1o8 13:25:46 INFO - Expected file size: 21949740 13:25:46 INFO - Obtained file size: 21949740 13:25:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 13:25:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 13:25:50 INFO - Fetch https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 13:25:51 INFO - Http code: 200 13:25:51 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 13:25:51 INFO - x-amz-cf-id: etrD6v_4nYti0XTKq5Twp3VyBiUanE8FaqGhFksqnjDEvP23YQLm8Q== 13:25:51 INFO - x-amz-version-id: AJKoZj7DefSzYGVqtQl8c7Yt1TPmu_1U 13:25:51 INFO - Expected file size: 14409038 13:25:51 INFO - Obtained file size: 14409038 13:25:51 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:25:51 INFO - trying https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:25:51 INFO - Downloading https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:25:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 13:25:52 INFO - Downloaded 63954867 bytes. 13:25:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:25:52 INFO - mkdir: /builds/slave/test/properties 13:25:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:25:52 INFO - Writing to file /builds/slave/test/properties/build_url 13:25:52 INFO - Contents: 13:25:52 INFO - build_url:https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 13:25:53 INFO - Running post-action listener: _resource_record_post_action 13:25:53 INFO - Running post-action listener: set_extra_try_arguments 13:25:53 INFO - [mozharness: 2016-11-23 21:25:53.424851Z] Finished download-and-extract step (success) 13:25:53 INFO - [mozharness: 2016-11-23 21:25:53.425110Z] Running populate-webroot step. 13:25:53 INFO - Running pre-action listener: _resource_record_pre_action 13:25:53 INFO - Running main action method: populate_webroot 13:25:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:25:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:25:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:25:53 INFO - '--tppagecycles', 13:25:53 INFO - '7'], 13:25:53 INFO - 'tests': ['tsvgm']}}, 13:25:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:25:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:25:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:25:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:25:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:53 INFO - 'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:53 INFO - 'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['damp', 'tps']}, 13:25:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:53 INFO - 'tests': ['damp', 'tps']}, 13:25:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['dromaeo_dom']}, 13:25:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:25:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['basic_compositor_video']}, 13:25:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:25:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['a11yr', 13:25:53 INFO - 'ts_paint', 13:25:53 INFO - 'tpaint', 13:25:53 INFO - 'sessionrestore', 13:25:53 INFO - 'sessionrestore_no_auto_restore', 13:25:53 INFO - 'tabpaint']}, 13:25:53 INFO - 'other-e10s': {'tests': ['a11yr', 13:25:53 INFO - 'ts_paint', 13:25:53 INFO - 'tpaint', 13:25:53 INFO - 'sessionrestore', 13:25:53 INFO - 'sessionrestore_no_auto_restore', 13:25:53 INFO - 'tabpaint']}, 13:25:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:25:53 INFO - 'ts_paint', 13:25:53 INFO - 'tpaint', 13:25:53 INFO - 'sessionrestore', 13:25:53 INFO - 'sessionrestore_no_auto_restore', 13:25:53 INFO - 'tabpaint']}, 13:25:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:25:53 INFO - 'ts_paint', 13:25:53 INFO - 'tpaint', 13:25:53 INFO - 'sessionrestore', 13:25:53 INFO - 'sessionrestore_no_auto_restore', 13:25:53 INFO - 'tabpaint']}, 13:25:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['a11yr', 13:25:53 INFO - 'ts_paint', 13:25:53 INFO - 'tpaint', 13:25:53 INFO - 'sessionrestore', 13:25:53 INFO - 'sessionrestore_no_auto_restore', 13:25:53 INFO - 'tabpaint']}, 13:25:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['a11yr', 13:25:53 INFO - 'ts_paint', 13:25:53 INFO - 'tpaint', 13:25:53 INFO - 'sessionrestore', 13:25:53 INFO - 'sessionrestore_no_auto_restore', 13:25:53 INFO - 'tabpaint']}, 13:25:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['tsvgx', 13:25:53 INFO - 'tsvgr_opacity', 13:25:53 INFO - 'tart', 13:25:53 INFO - 'tscrollx', 13:25:53 INFO - 'cart']}, 13:25:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:25:53 INFO - 'tsvgr_opacity', 13:25:53 INFO - 'tart', 13:25:53 INFO - 'tscrollx', 13:25:53 INFO - 'cart']}, 13:25:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:53 INFO - 'talos_options': ['--disable-e10s'], 13:25:53 INFO - 'tests': ['tp5o']}, 13:25:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:53 INFO - 'tests': ['tp5o']}, 13:25:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:53 INFO - 'talos_options': ['--disable-e10s', 13:25:53 INFO - '--xperf_path', 13:25:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:53 INFO - 'tests': ['tp5n']}, 13:25:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:53 INFO - 'talos_options': ['--xperf_path', 13:25:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:53 INFO - 'tests': ['tp5n']}}, 13:25:53 INFO - 'talos.zip': {'path': '', 13:25:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:25:53 INFO - Running post-action listener: _resource_record_post_action 13:25:53 INFO - [mozharness: 2016-11-23 21:25:53.443291Z] Finished populate-webroot step (success) 13:25:53 INFO - [mozharness: 2016-11-23 21:25:53.443378Z] Running create-virtualenv step. 13:25:53 INFO - Running pre-action listener: _resource_record_pre_action 13:25:53 INFO - Running main action method: create_virtualenv 13:25:53 INFO - Creating virtualenv /builds/slave/test/build/venv 13:25:53 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:25:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:25:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:25:53 INFO - Using real prefix '/usr' 13:25:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:25:54 INFO - Installing distribute.............................................................................................................................................................................................done. 13:25:56 INFO - Installing pip.................done. 13:25:56 INFO - Return code: 0 13:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:25:56 INFO - Reading from file tmpfile_stdout 13:25:56 INFO - Output received: 13:25:56 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:25:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:25: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:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:56 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 0x7f0c6643ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', '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:25:56 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:25:56 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:25:56 INFO - Using env: {'DISPLAY': ':0', 13:25:56 INFO - 'HOME': '/home/cltbld', 13:25:56 INFO - 'LANG': 'en_US.UTF-8', 13:25:56 INFO - 'LANGUAGE': 'en_US:en', 13:25:56 INFO - 'LOGNAME': 'cltbld', 13:25:56 INFO - 'MAIL': '/var/mail/cltbld', 13:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:56 INFO - 'MOZ_NO_REMOTE': '1', 13:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:56 INFO - 'NO_EM_RESTART': '1', 13:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:56 INFO - 'PWD': '/builds/slave/test', 13:25:56 INFO - 'SHELL': '/bin/bash', 13:25:56 INFO - 'SHLVL': '1', 13:25:56 INFO - 'TERM': 'linux', 13:25:56 INFO - 'TMOUT': '86400', 13:25:56 INFO - 'USER': 'cltbld', 13:25:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:56 INFO - '_': '/tools/buildbot/bin/python'} 13:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:56 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:25:56 INFO - Cleaning up... 13:25:56 INFO - Return code: 0 13:25:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:25: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:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25: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:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:56 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 0x7f0c6643ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', '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:25:56 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:25:56 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:25:56 INFO - Using env: {'DISPLAY': ':0', 13:25:56 INFO - 'HOME': '/home/cltbld', 13:25:56 INFO - 'LANG': 'en_US.UTF-8', 13:25:56 INFO - 'LANGUAGE': 'en_US:en', 13:25:56 INFO - 'LOGNAME': 'cltbld', 13:25:56 INFO - 'MAIL': '/var/mail/cltbld', 13:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:56 INFO - 'MOZ_NO_REMOTE': '1', 13:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:56 INFO - 'NO_EM_RESTART': '1', 13:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:56 INFO - 'PWD': '/builds/slave/test', 13:25:56 INFO - 'SHELL': '/bin/bash', 13:25:56 INFO - 'SHLVL': '1', 13:25:56 INFO - 'TERM': 'linux', 13:25:56 INFO - 'TMOUT': '86400', 13:25:56 INFO - 'USER': 'cltbld', 13:25:56 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:56 INFO - '_': '/tools/buildbot/bin/python'} 13:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:56 INFO - Downloading/unpacking psutil>=3.1.1 13:25:56 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:25:56 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:25:56 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:25:56 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:25:56 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:25:56 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:25:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:25:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:58 INFO - Installing collected packages: psutil 13:25:58 INFO - Running setup.py install for psutil 13:25:58 INFO - building 'psutil._psutil_linux' extension 13:25:58 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:25:58 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:25:58 INFO - building 'psutil._psutil_posix' extension 13:25:58 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:25:59 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:25:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:25:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:25:59 INFO - Successfully installed psutil 13:25:59 INFO - Cleaning up... 13:25:59 INFO - Return code: 0 13:25:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:25:59 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:25:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:25:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:59 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:25:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:25:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:25:59 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 0x7f0c6643ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', '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:25:59 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:25:59 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:25:59 INFO - Using env: {'DISPLAY': ':0', 13:25:59 INFO - 'HOME': '/home/cltbld', 13:25:59 INFO - 'LANG': 'en_US.UTF-8', 13:25:59 INFO - 'LANGUAGE': 'en_US:en', 13:25:59 INFO - 'LOGNAME': 'cltbld', 13:25:59 INFO - 'MAIL': '/var/mail/cltbld', 13:25:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:25:59 INFO - 'MOZ_NO_REMOTE': '1', 13:25:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:25:59 INFO - 'NO_EM_RESTART': '1', 13:25:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:25:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:25:59 INFO - 'PWD': '/builds/slave/test', 13:25:59 INFO - 'SHELL': '/bin/bash', 13:25:59 INFO - 'SHLVL': '1', 13:25:59 INFO - 'TERM': 'linux', 13:25:59 INFO - 'TMOUT': '86400', 13:25:59 INFO - 'USER': 'cltbld', 13:25:59 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:25:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:25:59 INFO - '_': '/tools/buildbot/bin/python'} 13:25:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:25:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:25:59 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:25:59 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:25:59 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:25:59 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:25:59 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:25:59 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:26:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:26:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:26:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:26:01 INFO - Installing collected packages: mozsystemmonitor 13:26:01 INFO - Running setup.py install for mozsystemmonitor 13:26:01 INFO - Successfully installed mozsystemmonitor 13:26:01 INFO - Cleaning up... 13:26:01 INFO - Return code: 0 13:26:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:01 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 0x7f0c6643ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', '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:26:01 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:26:01 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:26:01 INFO - Using env: {'DISPLAY': ':0', 13:26:01 INFO - 'HOME': '/home/cltbld', 13:26:01 INFO - 'LANG': 'en_US.UTF-8', 13:26:01 INFO - 'LANGUAGE': 'en_US:en', 13:26:01 INFO - 'LOGNAME': 'cltbld', 13:26:01 INFO - 'MAIL': '/var/mail/cltbld', 13:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:01 INFO - 'MOZ_NO_REMOTE': '1', 13:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:01 INFO - 'NO_EM_RESTART': '1', 13:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:01 INFO - 'PWD': '/builds/slave/test', 13:26:01 INFO - 'SHELL': '/bin/bash', 13:26:01 INFO - 'SHLVL': '1', 13:26:01 INFO - 'TERM': 'linux', 13:26:01 INFO - 'TMOUT': '86400', 13:26:01 INFO - 'USER': 'cltbld', 13:26:01 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:01 INFO - '_': '/tools/buildbot/bin/python'} 13:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:01 INFO - Downloading/unpacking jsonschema==2.5.1 13:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:01 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:26:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:26:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:26:03 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:26:03 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:26:03 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:26:03 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:26:03 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:26:03 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:26:04 INFO - Downloading functools32-3.2.3-2.tar.gz 13:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:26:04 INFO - warning: no files found matching '*.txt' 13:26:04 INFO - no previously-included directories found matching 'build' 13:26:04 INFO - no previously-included directories found matching 'dist' 13:26:04 INFO - no previously-included directories found matching '.git*' 13:26:04 INFO - Installing collected packages: jsonschema, functools32 13:26:04 INFO - Running setup.py install for functools32 13:26:04 INFO - warning: no files found matching '*.txt' 13:26:04 INFO - no previously-included directories found matching 'build' 13:26:04 INFO - no previously-included directories found matching 'dist' 13:26:04 INFO - no previously-included directories found matching '.git*' 13:26:04 INFO - Successfully installed jsonschema functools32 13:26:04 INFO - Cleaning up... 13:26:04 INFO - Return code: 0 13:26:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:26:04 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:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:04 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:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:04 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 0x7f0c6643ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', '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:26:04 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:26:04 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:26:04 INFO - Using env: {'DISPLAY': ':0', 13:26:04 INFO - 'HOME': '/home/cltbld', 13:26:04 INFO - 'LANG': 'en_US.UTF-8', 13:26:04 INFO - 'LANGUAGE': 'en_US:en', 13:26:04 INFO - 'LOGNAME': 'cltbld', 13:26:04 INFO - 'MAIL': '/var/mail/cltbld', 13:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:04 INFO - 'MOZ_NO_REMOTE': '1', 13:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:04 INFO - 'NO_EM_RESTART': '1', 13:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:04 INFO - 'PWD': '/builds/slave/test', 13:26:04 INFO - 'SHELL': '/bin/bash', 13:26:04 INFO - 'SHLVL': '1', 13:26:04 INFO - 'TERM': 'linux', 13:26:04 INFO - 'TMOUT': '86400', 13:26:04 INFO - 'USER': 'cltbld', 13:26:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:04 INFO - '_': '/tools/buildbot/bin/python'} 13:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:26:04 INFO - Cleaning up... 13:26:04 INFO - Return code: 0 13:26:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:26:04 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:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:04 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:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:04 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 0x7f0c6643ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', '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:26:04 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:26:04 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:26:04 INFO - Using env: {'DISPLAY': ':0', 13:26:04 INFO - 'HOME': '/home/cltbld', 13:26:04 INFO - 'LANG': 'en_US.UTF-8', 13:26:04 INFO - 'LANGUAGE': 'en_US:en', 13:26:04 INFO - 'LOGNAME': 'cltbld', 13:26:04 INFO - 'MAIL': '/var/mail/cltbld', 13:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:04 INFO - 'MOZ_NO_REMOTE': '1', 13:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:04 INFO - 'NO_EM_RESTART': '1', 13:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:04 INFO - 'PWD': '/builds/slave/test', 13:26:04 INFO - 'SHELL': '/bin/bash', 13:26:04 INFO - 'SHLVL': '1', 13:26:04 INFO - 'TERM': 'linux', 13:26:04 INFO - 'TMOUT': '86400', 13:26:04 INFO - 'USER': 'cltbld', 13:26:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:04 INFO - '_': '/tools/buildbot/bin/python'} 13:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:04 INFO - Downloading/unpacking blobuploader==1.2.4 13:26:04 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:26:04 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:26:04 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:26:04 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:26:04 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:26:04 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:26:06 INFO - Downloading blobuploader-1.2.4.tar.gz 13:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:26:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:26:06 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:26:06 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:26:06 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:26:06 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:26:06 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:26:06 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:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:26:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:26:07 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:26:07 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:26:07 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:26:07 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:26:07 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:26:07 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:26:07 INFO - Downloading docopt-0.6.1.tar.gz 13:26:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:26:07 INFO - Installing collected packages: blobuploader, requests, docopt 13:26:07 INFO - Running setup.py install for blobuploader 13:26:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:26:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:26:07 INFO - Running setup.py install for requests 13:26:07 INFO - Running setup.py install for docopt 13:26:07 INFO - Successfully installed blobuploader requests docopt 13:26:07 INFO - Cleaning up... 13:26:08 INFO - Return code: 0 13:26:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:08 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:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:08 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:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:08 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 0x7f0c6643ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', '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:26:08 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:26:08 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:26:08 INFO - Using env: {'DISPLAY': ':0', 13:26:08 INFO - 'HOME': '/home/cltbld', 13:26:08 INFO - 'LANG': 'en_US.UTF-8', 13:26:08 INFO - 'LANGUAGE': 'en_US:en', 13:26:08 INFO - 'LOGNAME': 'cltbld', 13:26:08 INFO - 'MAIL': '/var/mail/cltbld', 13:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:08 INFO - 'MOZ_NO_REMOTE': '1', 13:26:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:08 INFO - 'NO_EM_RESTART': '1', 13:26:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:08 INFO - 'PWD': '/builds/slave/test', 13:26:08 INFO - 'SHELL': '/bin/bash', 13:26:08 INFO - 'SHLVL': '1', 13:26:08 INFO - 'TERM': 'linux', 13:26:08 INFO - 'TMOUT': '86400', 13:26:08 INFO - 'USER': 'cltbld', 13:26:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:08 INFO - '_': '/tools/buildbot/bin/python'} 13:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:08 INFO - Running setup.py (path:/tmp/pip-dxWXvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:08 INFO - Running setup.py (path:/tmp/pip-CTQ_lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:08 INFO - Running setup.py (path:/tmp/pip-Zr00OS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:08 INFO - Running setup.py (path:/tmp/pip-ZmibVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:08 INFO - Running setup.py (path:/tmp/pip-oB7uID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:08 INFO - Running setup.py (path:/tmp/pip-CfQg0M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:08 INFO - Running setup.py (path:/tmp/pip-orXixE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:08 INFO - Running setup.py (path:/tmp/pip-qw5wR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:08 INFO - Running setup.py (path:/tmp/pip-4gY9IU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:08 INFO - Running setup.py (path:/tmp/pip-_3rZLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:08 INFO - Running setup.py (path:/tmp/pip-OFNCZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:09 INFO - Running setup.py (path:/tmp/pip-8WG2Be-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:09 INFO - Running setup.py (path:/tmp/pip-QRYgQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:09 INFO - Running setup.py (path:/tmp/pip-SfQdGn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:09 INFO - Running setup.py (path:/tmp/pip-Hmy3TI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:09 INFO - Running setup.py (path:/tmp/pip-uvHLsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:09 INFO - Running setup.py (path:/tmp/pip-ov5R1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:26:09 INFO - Running setup.py install for manifestparser 13:26:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:26:09 INFO - Running setup.py install for mozcrash 13:26:09 INFO - Running setup.py install for mozdebug 13:26:09 INFO - Running setup.py install for mozdevice 13:26:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:26:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:26:09 INFO - Running setup.py install for mozfile 13:26:10 INFO - Running setup.py install for mozhttpd 13:26:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Running setup.py install for mozinfo 13:26:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Running setup.py install for mozInstall 13:26:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Running setup.py install for mozleak 13:26:10 INFO - Running setup.py install for mozlog 13:26:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Running setup.py install for moznetwork 13:26:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Running setup.py install for mozprocess 13:26:10 INFO - Running setup.py install for mozprofile 13:26:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Running setup.py install for mozrunner 13:26:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:26:10 INFO - Running setup.py install for mozscreenshot 13:26:11 INFO - Running setup.py install for moztest 13:26:11 INFO - Running setup.py install for mozversion 13:26:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:26:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:26:11 INFO - Cleaning up... 13:26:11 INFO - Return code: 0 13:26:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:11 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:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:11 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:26:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:11 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 0x7f0c6643ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', '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:26:11 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:26:11 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:26:11 INFO - Using env: {'DISPLAY': ':0', 13:26:11 INFO - 'HOME': '/home/cltbld', 13:26:11 INFO - 'LANG': 'en_US.UTF-8', 13:26:11 INFO - 'LANGUAGE': 'en_US:en', 13:26:11 INFO - 'LOGNAME': 'cltbld', 13:26:11 INFO - 'MAIL': '/var/mail/cltbld', 13:26:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:11 INFO - 'MOZ_NO_REMOTE': '1', 13:26:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:11 INFO - 'NO_EM_RESTART': '1', 13:26:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:11 INFO - 'PWD': '/builds/slave/test', 13:26:11 INFO - 'SHELL': '/bin/bash', 13:26:11 INFO - 'SHLVL': '1', 13:26:11 INFO - 'TERM': 'linux', 13:26:11 INFO - 'TMOUT': '86400', 13:26:11 INFO - 'USER': 'cltbld', 13:26:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:26:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:11 INFO - '_': '/tools/buildbot/bin/python'} 13:26:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:11 INFO - Running setup.py (path:/tmp/pip-eRKCC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:11 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:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:11 INFO - Running setup.py (path:/tmp/pip-CgJmbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:11 INFO - Running setup.py (path:/tmp/pip-MErE7U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:11 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:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:11 INFO - Running setup.py (path:/tmp/pip-vJ9UL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:11 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:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:11 INFO - Running setup.py (path:/tmp/pip-8F2Jlp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:11 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:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:11 INFO - Running setup.py (path:/tmp/pip-L9GesH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:11 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:26:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:11 INFO - Running setup.py (path:/tmp/pip-8og3u7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:12 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:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:12 INFO - Running setup.py (path:/tmp/pip-Xp7U6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:12 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:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:12 INFO - Running setup.py (path:/tmp/pip-XRf_S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:12 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:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:12 INFO - Running setup.py (path:/tmp/pip-GtTCWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:12 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:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:12 INFO - Running setup.py (path:/tmp/pip-E5w7rH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:12 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:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:12 INFO - Running setup.py (path:/tmp/pip-jfc3yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:12 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:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:12 INFO - Running setup.py (path:/tmp/pip-onoGvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:12 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:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:12 INFO - Running setup.py (path:/tmp/pip-y91H8M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:12 INFO - Running setup.py (path:/tmp/pip-ic5Zn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:12 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:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:12 INFO - Running setup.py (path:/tmp/pip-788O5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:12 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:26:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:12 INFO - Running setup.py (path:/tmp/pip-y0eTke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:12 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:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:26:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:26:12 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:26:12 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:26:12 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:26:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:26:12 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:26:12 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:26:12 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:26:12 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:26:12 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:26:12 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:26:14 INFO - Downloading blessings-1.6.tar.gz 13:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:26:14 INFO - Installing collected packages: blessings 13:26:14 INFO - Running setup.py install for blessings 13:26:14 INFO - Successfully installed blessings 13:26:14 INFO - Cleaning up... 13:26:14 INFO - Return code: 0 13:26:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:26:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:15 INFO - Reading from file tmpfile_stdout 13:26:15 INFO - Current package versions: 13:26:15 INFO - argparse == 1.2.1 13:26:15 INFO - blessings == 1.6 13:26:15 INFO - blobuploader == 1.2.4 13:26:15 INFO - docopt == 0.6.1 13:26:15 INFO - functools32 == 3.2.3-2 13:26:15 INFO - jsonschema == 2.5.1 13:26:15 INFO - manifestparser == 1.1 13:26:15 INFO - mozInstall == 1.12 13:26:15 INFO - mozcrash == 1.0 13:26:15 INFO - mozdebug == 0.1 13:26:15 INFO - mozdevice == 0.48 13:26:15 INFO - mozfile == 1.2 13:26:15 INFO - mozhttpd == 0.7 13:26:15 INFO - mozinfo == 0.9 13:26:15 INFO - mozleak == 0.1 13:26:15 INFO - mozlog == 3.4 13:26:15 INFO - moznetwork == 0.27 13:26:15 INFO - mozprocess == 0.23 13:26:15 INFO - mozprofile == 0.28 13:26:15 INFO - mozrunner == 6.13 13:26:15 INFO - mozscreenshot == 0.1 13:26:15 INFO - mozsystemmonitor == 0.3 13:26:15 INFO - moztest == 0.7 13:26:15 INFO - mozversion == 1.4 13:26:15 INFO - psutil == 3.1.1 13:26:15 INFO - requests == 1.2.3 13:26:15 INFO - wsgiref == 0.1.2 13:26:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:15 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:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:15 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:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:15 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 0x7f0c6643ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', '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:26:15 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:26:15 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:26:15 INFO - Using env: {'DISPLAY': ':0', 13:26:15 INFO - 'HOME': '/home/cltbld', 13:26:15 INFO - 'LANG': 'en_US.UTF-8', 13:26:15 INFO - 'LANGUAGE': 'en_US:en', 13:26:15 INFO - 'LOGNAME': 'cltbld', 13:26:15 INFO - 'MAIL': '/var/mail/cltbld', 13:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:15 INFO - 'MOZ_NO_REMOTE': '1', 13:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:15 INFO - 'NO_EM_RESTART': '1', 13:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:15 INFO - 'PWD': '/builds/slave/test', 13:26:15 INFO - 'SHELL': '/bin/bash', 13:26:15 INFO - 'SHLVL': '1', 13:26:15 INFO - 'TERM': 'linux', 13:26:15 INFO - 'TMOUT': '86400', 13:26:15 INFO - 'USER': 'cltbld', 13:26:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:15 INFO - '_': '/tools/buildbot/bin/python'} 13:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:15 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:26:15 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:26:15 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:26:15 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:26:15 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:26:15 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:26:15 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:26:15 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:26:15 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:26:15 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:26:15 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:26:15 INFO - Cleaning up... 13:26:15 INFO - Return code: 0 13:26:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:26:15 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:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:15 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:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:15 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 0x7f0c6643ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15b5ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', '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:26:15 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:26:15 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:26:15 INFO - Using env: {'DISPLAY': ':0', 13:26:15 INFO - 'HOME': '/home/cltbld', 13:26:15 INFO - 'LANG': 'en_US.UTF-8', 13:26:15 INFO - 'LANGUAGE': 'en_US:en', 13:26:15 INFO - 'LOGNAME': 'cltbld', 13:26:15 INFO - 'MAIL': '/var/mail/cltbld', 13:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:15 INFO - 'MOZ_NO_REMOTE': '1', 13:26:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:15 INFO - 'NO_EM_RESTART': '1', 13:26:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:15 INFO - 'PWD': '/builds/slave/test', 13:26:15 INFO - 'SHELL': '/bin/bash', 13:26:15 INFO - 'SHLVL': '1', 13:26:15 INFO - 'TERM': 'linux', 13:26:15 INFO - 'TMOUT': '86400', 13:26:15 INFO - 'USER': 'cltbld', 13:26:15 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:15 INFO - '_': '/tools/buildbot/bin/python'} 13:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:26:15 INFO - Cleaning up... 13:26:15 INFO - Return code: 0 13:26:15 INFO - Running post-action listener: _resource_record_post_action 13:26:15 INFO - Running post-action listener: _start_resource_monitoring 13:26:15 INFO - Starting resource monitoring. 13:26:15 INFO - [mozharness: 2016-11-23 21:26:15.686799Z] Finished create-virtualenv step (success) 13:26:15 INFO - [mozharness: 2016-11-23 21:26:15.687251Z] Running install step. 13:26:15 INFO - Running pre-action listener: _resource_record_pre_action 13:26:15 INFO - Running main action method: install 13:26:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:15 INFO - Reading from file tmpfile_stdout 13:26:15 INFO - Detecting whether we're running mozinstall >=1.0... 13:26:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:26:15 INFO - Reading from file tmpfile_stdout 13:26:15 INFO - Output received: 13:26:15 INFO - Usage: mozinstall [options] installer 13:26:15 INFO - Options: 13:26:15 INFO - -h, --help show this help message and exit 13:26:15 INFO - -d DEST, --destination=DEST 13:26:15 INFO - Directory to install application into. [default: 13:26:15 INFO - "/builds/slave/test"] 13:26:15 INFO - --app=APP Application being installed. [default: firefox] 13:26:15 INFO - mkdir: /builds/slave/test/build/application 13:26:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 13:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 13:26:32 INFO - Reading from file tmpfile_stdout 13:26:32 INFO - Output received: 13:26:32 INFO - /builds/slave/test/build/application/firefox/firefox 13:26:32 INFO - Running post-action listener: _resource_record_post_action 13:26:32 INFO - [mozharness: 2016-11-23 21:26:32.686289Z] Finished install step (success) 13:26:32 INFO - [mozharness: 2016-11-23 21:26:32.686528Z] Running run-tests step. 13:26:32 INFO - Running pre-action listener: _resource_record_pre_action 13:26:32 INFO - Running main action method: run_tests 13:26:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:26:32 INFO - Python 2.7.3 13:26:32 INFO - Return code: 0 13:26:32 INFO - grabbing minidump binary from tooltool 13:26:32 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:26:32 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 0x15b2f60>, '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 0x15b3d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15b41d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:26:32 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:26:32 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:26:32 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:26:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:26:32 INFO - Return code: 0 13:26:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 13:26:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:26:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:26:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 13:26:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:26:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:26:32 INFO - Using env: {'DISPLAY': ':0', 13:26:32 INFO - 'HOME': '/home/cltbld', 13:26:32 INFO - 'LANG': 'en_US.UTF-8', 13:26:32 INFO - 'LANGUAGE': 'en_US:en', 13:26:32 INFO - 'LOGNAME': 'cltbld', 13:26:32 INFO - 'MAIL': '/var/mail/cltbld', 13:26:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:26:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 13:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:32 INFO - 'MOZ_NO_REMOTE': '1', 13:26:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:26:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 13:26:32 INFO - 'NO_EM_RESTART': '1', 13:26:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 13:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:32 INFO - 'PWD': '/builds/slave/test', 13:26:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:26:32 INFO - 'SHELL': '/bin/bash', 13:26:32 INFO - 'SHLVL': '1', 13:26:32 INFO - 'TERM': 'linux', 13:26:32 INFO - 'TMOUT': '86400', 13:26:32 INFO - 'USER': 'cltbld', 13:26:32 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683', 13:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:32 INFO - '_': '/tools/buildbot/bin/python'} 13:26:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:26:32 INFO - mozversion application_buildid: 20161123104536 13:26:32 INFO - mozversion application_changeset: 6824ecd27c27cb6194dbca2cef13d12e9ddb3603 13:26:32 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:26:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:26:32 INFO - mozversion application_name: Firefox 13:26:32 INFO - mozversion application_remotingname: firefox-dev 13:26:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:26:32 INFO - mozversion application_vendor: Mozilla 13:26:32 INFO - mozversion application_version: 52.0a2 13:26:32 INFO - mozversion platform_buildid: 20161123104536 13:26:32 INFO - mozversion platform_changeset: 6824ecd27c27cb6194dbca2cef13d12e9ddb3603 13:26:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:26:32 INFO - mozversion platform_version: 52.0a2 13:26:32 INFO - using testdate: 1479936392 13:26:32 INFO - actual date: 1479936392 13:26:32 INFO - starting webserver on 'localhost:60726' 13:26:32 INFO - SUITE-START | Running 2 tests 13:26:32 INFO - TEST-START | dromaeo_css 13:26:32 INFO - operating with platform_type : linux_ 13:26:32 INFO - Initialising browser for dromaeo_css test... 13:26:32 INFO - TEST-INFO | started process 9021 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTTDgi0/profile http://localhost:60726/getInfo.html) 13:26:36 ERROR - PROCESS | 9021 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 13:26:37 INFO - PROCESS | 9021 | __metrics Screen width/height:1600/1200 13:26:37 INFO - PROCESS | 9021 | colorDepth:24 13:26:37 INFO - PROCESS | 9021 | Browser inner width/height: 1024/697 13:26:37 INFO - PROCESS | 9021 | __metrics 13:26:37 INFO - PROCESS | 9021 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:26:37 INFO - PROCESS | 9021 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:26:38 INFO - PROCESS | 9021 | console.error: PushService: 13:26:38 INFO - PROCESS | 9021 | stateChangeProcessEnqueue: Error transitioning state 13:26:38 INFO - PROCESS | 9021 | UnknownError 13:26:39 INFO - TEST-INFO | 9021: exit 0 13:26:39 INFO - Browser initialized. 13:26:39 INFO - Running cycle 1/1 for dromaeo_css test... 13:26:39 INFO - TEST-INFO | started process 9115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTTDgi0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:26:50 INFO - PROCESS | 9115 | RSS: Main: 144179200 13:26:50 INFO - PROCESS | 9115 | 13:27:42 INFO - PROCESS | 9115 | 1479936462375 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:29:52 INFO - PROCESS | 9115 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60726/tests/dromaeo/cssquery-ext.html) 13:29:53 INFO - PROCESS | 9115 | RSS: Main: 242466816 13:29:53 INFO - PROCESS | 9115 | 13:32:56 INFO - PROCESS | 9115 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-ext.html (next: http://localhost:60726/tests/dromaeo/cssquery-jquery.html) 13:32:56 INFO - PROCESS | 9115 | RSS: Main: 241078272 13:32:56 INFO - PROCESS | 9115 | 13:35:58 INFO - PROCESS | 9115 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60726/tests/dromaeo/cssquery-mootools.html) 13:35:59 INFO - PROCESS | 9115 | RSS: Main: 224436224 13:35:59 INFO - PROCESS | 9115 | 13:39:01 INFO - PROCESS | 9115 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60726/tests/dromaeo/cssquery-prototype.html) 13:39:01 INFO - PROCESS | 9115 | RSS: Main: 219140096 13:39:01 INFO - PROCESS | 9115 | 13:42:04 INFO - PROCESS | 9115 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60726/tests/dromaeo/cssquery-yui.html) 13:42:05 INFO - PROCESS | 9115 | RSS: Main: 177180672 13:42:05 INFO - PROCESS | 9115 | 13:45:07 INFO - PROCESS | 9115 | Cycle 1(1): loaded http://localhost:60726/tests/dromaeo/cssquery-yui.html (next: http://localhost:60726/tests/dromaeo/cssquery-dojo.html) 13:45:07 INFO - PROCESS | 9115 | RSS: Main: 266653696 13:45:07 INFO - PROCESS | 9115 | 13:45:07 INFO - PROCESS | 9115 | __start_tp_report 13:45:07 INFO - PROCESS | 9115 | _x_x_mozilla_page_load 13:45:07 INFO - PROCESS | 9115 | _x_x_mozilla_page_load_details 13:45:07 INFO - PROCESS | 9115 | |i|pagename|runs| 13:45:07 INFO - PROCESS | 9115 | |0;dojo.html;3162.4623813951625;3200.31193293442;3218.9034328970138;3221.710046095851;3226.257960669046;5427.620066595335;5490;5491.505764481196;5512.39363669996;5527.032769265377;5475.589330800196;5479.17812328151;5493.587980901429;5494.066008778507;5496.725163741817;4996.7251801151015;5015.724135172564;5050.318207042039;5076.390833100015;5090.287359769635;4903.8528844134735;5028.899422011557;5084.618653600976;5088.898222035557;5117.8464646060675;4887.047025829965;4939.654224204307;4965.875853103666;4973.850784476472;4985.426675932278;5018.974905125469;5062.443131255577;5067.949320506785;5122.513361230677;5135.255387968724;4955.479674634147;5026.522480364396;5066.0374528839775;5077.213031980049;5082.567981721558;5350.063738845686;5381.381141168777;5390.0836857734275;5391.29913111293;5396.757145928443;5813.069908814569;5829.883402331972;5830.212921255618;5912.142739302777;5921.644701317891;5952.434518720715;5955.464008239236;5966.134910437962;5966.731497082642;5971.253593300838;5363.946360536423;5411.810586629449;5438.972805135949;5486.1222204447095;5549.278593782863;5937.346891841894;5973.313068997121;5975.43233392827;5980.581359304894;5985.132155837467;5746;5756;5760.567957403127;5763.106718458645;5769.451902069297;5752.25220721312;5789.623674461147;5808.332041815161;5832.562557808182;5849.298084229835;5814.970925145347;5821.94178058214;5841.7371218295275;5860.70696465175;5867.237259156283;5798.623089499169;5855.795047173328;5856.941430585724;5859.384764599741;5860.238169037998;4457.465104187519;4486.551344865553;4537.954620453753;4571.337156112345;4599.885002874888;4083.4079058536345;4088.1414902870138;4088.591140885947;4109.56849530795;4130.173965206911;5636.408177141423;5638.43615638441;5639.520640745583;5641.830745077655;5654.180143879114;5744.741486633112;5812.854678633068;5864.736086876101;5867.237259156368;5892;5653.717314134359;5693.4875861172695;5702.600817942704;5716.742746576414;5727.255456790674;5184.274201611777;5186.325777648882;5190.8183213587345;5194.142966410575;5196.636235463557;5922.437368449991;6048.879022419439;6166.537509686791;6182.690865456799;6186.226721659793;5695.088785794253;5737.655740655574;5773;5807.941920580909;5832.825015249549;5940.138679891305;5943.791967281124;5948.196993405835;5948.613340132878;6007.939920600738;5642.294713160855;5694.1458781183155;5704.401037890962;5706.686132262766;5707.543396528351;5796.304443466811;5851.268591426072;5913.319968203712;5913.940860591339;5975.16347711312;5779.595428319977;5786.392428794916;5790.218320526675;5792.884142317214;5800.796972105956;5668.433156684298;5791.710414479344;5803;5808.448197421239;5809.215755873072;5562.471565201299;5578.693171875586;5610.7194640268635;5614.04561224601;5627.099664053731;5755.280589926259;5762.855928601818;5763.567732420001;5776.133579963039;5779.104238842986;5464.3442786865835;5496.285482887199;5627.380988091225;5629.4652008059165;5633.211350410864 13:45:07 INFO - PROCESS | 9115 | |1;ext.html;585.420433770567;617.6232498176113;645.7029766307498;669.0399277037449;674.9358810912962;35017.12457188572;37505.81247093764;37653.81173094137;46238.768806156004;47163.76418117913;46471.53528464714;46938.7653061735;46945.53054469454;46988;47022.29466558004;8708.91291087089;8833.293336533063;8849.115088491131;8853.291736661084;8865.822683546357;8355.874661880076;8537.871931921027;8549.102344253857;8682.826343473127;8794.51630160341;10509.947450262738;10751.677449676523;10760.300580462244;10976.286541374786;10978.835317470244;10542.894571054307;10623.468826558641;10639.468026598717;10642.361458312525;10651.946740266327;10424;10462.581496740122;10463.424511651856;10467.528961196764;10477.84283235752;44258.77870610626;44580.77709611464;44628.3305750414;44657;44659.33011004805;3770.057485628593;3779.981100094482;3808.619138086197;3861.6331448512346;3866.149447121629;33351.33297334064;33473.49789753131;33566.83216583926;33692;33767.493487597705;4562.315652652095;4591.6556258280425;4597.908041839144;4693.9530604693855;4706.647001474903;357989.9999999974;360377;361460;362236.9999999974;362283;64112;64348.67825660935;64387.67806161033;64407.677961609894;64457.67771161208;40010;40522.39216411756;40554;43470.13059738788;66714;19409;19551.90224048899;19577.8042219576;19580.314688985818;19588.510287242647;14743.63140921464;14822;14849.257537123316;14851.554453366416;14861.405543778345;18749.7187542187;19022;20089.799102008794;21148;21617;7300;7386.778396648109;7510.286522780327;7533.1336896256535;7751.689932402754;946.3186505715873;1041.4063983529315;1064.4518073192312;1132.7054965708976;1151.78691941991;34087.488687669706;34527.82736086303;34656;34816.82591587026;34989.825050874584;1112.9610463633735;1158.449736375215;1162.5349860056044;1165.1901928159848;1180.3449085757486;16534.917325413295;17350.9178898533;17510.562235944202;17550.82449175492;17561.824381756018;622399;626585;627788;631230;631873;61934.69032654808;62593;62636;62658;62659;1425.2303755971866;1437.9496717614834;1440.5318271561785;1454.2801313349748;1474.827512127861;30528;31982.20044498813;32305.838470807495;32619.34761304713;32736.672633274316;53469.7326513365;54240.45759542354;54253;54262.18606720981;54375;539133;539222;539339;540562;545046;27432.588511172748;30448.086557403312;31130;31162;31232.531512026882;38428;47040.7647961758;50019.74990125026;50298;53746;42640;43461;43646.64621656468;44032;44608.33087503755;42997.35503967381;43356;43620.34569481524;44111.77944110259;44619.776901115285;42775;43456.13087738291;43655.56344436515;44408.555914441735;44470.777646111565;36649.267014659024;38144.80927595344;38392.2321553573;39322.21355572815;39408;29238.26904327409;29379;29631.555526667547;29680.257993550335;29724 13:45:07 INFO - PROCESS | 9115 | |2;jquery.html;423.55103590194415;429.8957917003792;433.07754482951316;434.80868417896136;441.9359192917027;18162.27350905964;18436;19766.505837354056;19836.60326793463;19993.200271989102;19140.138693758814;19718.70421943672;19809.702854457195;19965;19995.500112497193;5583.274174357338;5860.472557469827;5862.736176872051;5866.061430171173;5868.677222752747;5638.520725738317;5758.539316854642;5777.59556831022;5799.507041901423;5841.6202946808535;5784.595078344518;5800.4489573490455;5807.477327040566;5813.30240371156;5816.069428891378;5608.663480191181;5740.1102829061565;5784.2769653793275;5794.855128621797;5798.565107616924;5206.635535512516;5218.582513398919;5219.086659834552;5219.347581552306;5219.582433405319;23415.4146146346;23796.286111416684;23893.163739269043;23948.88025559861;24081.75918240813;2462.6675398821108;2720.442309326603;2747.5466548019554;2750.683671377777;2973.762099032094;10619.25665203436;14578.927105364512;14644.487442939553;14892.106473611619;15494.147821869792;1918.88486690799;1946.532832120281;1961.4998175465307;1993.1230258686132;2008.2268326694327;64142.3585764141;80671;84144.15855841486;92698.53650731771;95121.9999999993;9656.565454554562;10250.487475626189;10322.948385258025;10548.208884333706;11816.231944923553;14467.204303763394;14507.927460362842;14526.418943242363;14546;14626.63433414152;8194.795130121795;8304.8339033219;8373.748787536384;8435.283000944866;8476.067632560413;8574.614142363484;8609.784755381166;8627.870581941275;8655.870161947576;8820.426672266281;4408.236705317899;4427.512973572904;4437.689361744711;4451.243288640939;4502.707324023993;2053.188990348804;2084.47888027993;2102.947426314324;2104.9263275785274;2114.228306668055;910.0626354854511;972.7568107973007;1019.576875596634;1033.9689809305733;1083.5070043130356;19993.400197994084;20285.797142028685;20382.28661996823;20560;20694.068766905526;1009.5557954499997;1041.3910508264748;1043.118564812732;1086.6196831109207;1096.17786660005;10680.57277708883;11300.773984520263;11442.226454899504;11501.309921404743;11608.187426880206;504728;505599;506182;507865;510958;73304.63347683227;92922;96288.51855740676;97417;98367;951.8905325887473;968.2689569375077;986.9210463163073;992.0575453319232;994.8607194992852;17211.741823872904;17260.654786904444;17333.13334333253;17394;18252.08739563043;43508.56491435045;44192.55807441884;44320.335194972744;44740.32889506725;46308;58769.70615146897;60371;60679;60802.391976081446;60970;8775.91224087751;8813.779655508408;8889.599968001326;8940.910590894007;9183.54082295896;12061.819072714092;13119;13780.035397522479;14524.927375363479;14612.561623151323;12194.57318993831;12218;12279.75440491203;12316.568920087753;12744.61766147017;11963.880361196625;12375.566855160387;12513.124081314221;12701.809472857729;12851.228926264454;12233.204841685261;12303.261804291771;12309.138360314691;12450.75098498043;12601;9240.768980775534;9247.115218304518;9248.16766491019;9477.09967553109;9574;11252.66242012741;11292.661220163409;11385.203035787416;11516.136289778467;11678.474468649101 13:45:07 INFO - PROCESS | 9115 | |3;mootools.html;1513.43246282644;1547.288247406193;1681.5207665815237;1759.8328158824906;1792.1845560270078;8487.40588158829;9011.18899299063;9017.278617710585;9029.142231488006;9048.773780655478;7859.174786647392;8059.8791018134625;8585.785355366119;8838.823223535526;8948.91051089489;2495.413577809213;2525.6464095026713;2528.3931856354525;2531.0508559290265;2532.8733563321853;2417.359399759065;2530.1903390914913;2532.531131943468;2547.8726063696836;2549.1715192562397;2478.578641630918;2479.5164942836154;2512.761287677677;2515.5723527000364;2515.5723527000364;2423.1882319422925;2435.768601982809;2458.4591389894194;2462.852228866274;2463.9753602463925;2433.6471211674384;2444.4011217251887;2470.629405589158;2471.567475691747;2494.787943024845;8984.281257499384;8997.370184087116;9062.184403403726;9067.455952642797;9082.364234503588;5484.287042684466;5633.971830140823;5635.239242702224;5648.63283886546;5652.18043383707;3639.727020473475;3792.962070379316;3809.3714537101346;3835.6547910688173;3880.2433525462548;1296.0927350854345;1343.4626149540165;1349.925754083525;1350.797380392949;1404.7190561887562;12530.122891397516;12532.561360352343;12536.874631253662;12548.309842958633;12555.372231388394;5001.274815151783;5146.87132821675;5201.219817027476;5230.189320655304;5253.32080638877;10028.047335503115;10096.091351778376;10102.949485252526;10117.44354060519;10131.949340253252;5648.491635752802;5657.179708942181;5662.178984047372;5665.745041473144;5669;5069.873253168626;5229.47705229474;5267.789288428497;5274.472552744694;5282.7622756976025;3865.4588357629955;3953.189596132786;3985.561588225293;4020.798960051986;4041.9797901010306;1256.3278645924386;1259.477316913489;1262.0156278103095;1278.4758249117817;1279.7952327627536;892.3842548641417;992.8510723391405;1000.8999100089933;1006.6929586476049;1018.5009345420839;5966.224390829251;6016.127661489059;6021.217241758631;6337.397947195009;6488.935110648928;954.9427034377959;957.5212393803098;988.7577543501889;1010.7725761703558;1044.4882007816268;4005.35914253718;4087.1825634873144;4266.189424009428;4295.914081718348;4298.290782020994;11024.724381890517;11354.26197297173;11448.141389395661;11472.598459053894;11474.139439542068;11271.436428178558;11298.20912536131;11301.152413569016;11310.660680179608;11325.660230193107;8386.67511487402;8476.830463390697;8561.443506172203;8641.654333826576;8661.480311181349;5857.297124345106;6066.884135561109;6084.817455476343;6131.233595800525;6206;10375.221858360805;10395.116415104498;10451.320664156805;10453.216008799523;10501.89498105009;9493.0981556752;9671.661491847752;9754.463504507321;9780.853287200556;10589.9470502647;8003.39974501903;8016.358691304798;8063.8790418144945;8069.7175598853755;8089.150639183036;8270.25567698886;8445.1977062179;8632.30941524664;8717.215450609476;8722.215000649972;7707.576083315472;7885.093214280202;7889.0927543333255;7966.92033079685;8090.959545202236;7760.534367937942;7765.145833958147;7771.92228077712;7861.921380786119;7909.960450197712;7225.9277407227355;7279.708811647687;7322.780316590511;7335.926640733524;7343.816404589928;5331.360236771612;5389.595780316414;5406.729663516887;5484.067708489487;5514.420985796433;5239.869003274796;5355.062863998707;5375.543078838343;5444.8366549003595;5566.248556444828 13:45:07 INFO - PROCESS | 9115 | |4;prototype.html;336.6717450485775;358.5249544353732;366.03002044581854;367.32045715426466;369.4421423650288;5265.604614777082;5389.51494365507;5483.533899618532;5513.7794488220525;5521.5306698930635;5305.8938821223555;5372.785088596461;5388.541973932221;5482.643628164166;5493.725313734317;4298.935515967263;4315.805788739514;4316.697831151829;4332.371806088116;4346.717463364887;4118.485189351331;4189.748615083089;4216.894577635553;4233.26436161174;4323.113761678848;4102.507699076115;4194.937075943863;4227.661787057028;4255.787210639471;4257.212415703105;4232.36514522824;4244.172386384656;4249.086446414005;4254.808533615979;4257.616814486695;3755.962440375589;3800.714946379005;3804.2771873343977;3812.942805857914;3831.9042023949346;5188.143956247215;5205.27126202332;5216.165413533854;5228.738563071831;5236.685798852043;4806.591439727627;4818.469968303484;4848.757562121879;4872.585830204437;4874.2201247800185;5331.760070796823;5512.779488820443;5552.91670624941;5560.36055853578;5571.582131340166;4162.791860406998;4165.12532368203;4167.395727619509;4176.686748493875;4176.791160441966;5713.857153571153;5739.311282646026;5781.768729250825;5790.536757059425;5803.941960580424;4039.8182081805803;4232.449781528443;4250.42619246404;4260.616544510947;4287.206866729603;4279.015826359955;4299.570042995675;4300.526942036374;4303.376010478526;4305.461817272841;4653;4761.40482439695;4770.785314660849;4901.877453063631;4921.729304888266;5636.985342638364;5638.830835074954;5659.943400566024;5676.318841739017;5741.569382296345;1460.3355473259642;1484.829244636859;1496.9550913472613;1497.7004599080228;1499.475183685723;1037.5953378182514;1054.3989925742253;1055.5988724284723;1074.7796701676139;1078.6494389323502;5328.268312798356;5333.213373519914;5342.98483288174;5344.946550534522;5377.70934975603;5531.917021244684;5575.219469274305;5606.878624275161;5619.381867994517;5623.522000629992;5320.813771518056;5600.299962504687;5628.296462942132;5635.549156067505;5640.943590564124;2987.939281555017;3005.4590173768493;3008.217863355543;3022.199117233935;3026.3644634626535;5588.580856435784;5827.562932780059;5833.4749872511675;5862.765489380377;5882.176495290577;5690.430956904359;5710.800731846276;5727.656340619576;5729.395769184635;5730.713464326767;5838.1393117371335;5839.379584657539;5846.356900740915;5851.507865494272;5852;5348.197770334481;5603.523700485504;5604.299462567179;5612.298462692163;5628.577856660685;5569.331680198402;5571.804986825442;5584.804531841366;5585.581081418829;5612.579056570855;5723.370429252862;5833.4749872511675;5843.912341314799;5871.970640146772;6034;4161.91676166481;4206.684498662674;4224.55642157569;4243.278642630698;4245.341971994346;5546.750396232099;5670.489655930821;5711.171880077449;5870.383609720918;5875.443007602903;5656.632318899258;5672.517835983823;5685.260916080883;5703.458171473703;5719.57103217252;5586.664800112007;5698.430156984268;5701.600887937804;5718.628289161191;5721.914171287517;5564.777408903598;5607;5622.409646987171;5656.773729050957;5657.603967722384;5723.170140329712;5731.761554721736;5771.7114144293455;5789.363170051375;5794.536437084938;5448.891022179455;5575.553955683617;5576.86057848557;5599.580031497735;5657.179708942098 13:45:07 INFO - PROCESS | 9115 | |5;yui.html;757.8560073586021;767.9347255483284;787.8069872881144;826.8470332988402;854.786303424144;14732.852671473296;15720.764188537181;15735.291911863966;15736.213189340517;15747.763783543242;11231.831522527149;13268.336583170827;13795;15319.157446340447;15345.462908798194;844.4511067805929;862.4006315610653;867.9609417576193;868.2229404682805;869.74342568942;856.4475913036088;861.6553378648528;863.3050394432479;863.874738162966;863.9006514250879;906.8957069936943;908.7001289574457;909.4815954905706;909.6952520905504;910.2399496420497;902.4314681750456;902.5667679513805;903.2909166304453;903.3721563513361;904.4076130134739;659.8977158540434;661.8577005943697;661.8709351676425;662.2814246542507;662.493192707579;13563.52527661537;13569.59291221255;13641.727165456636;13823.101498402571;14057.226852523107;15041.849581504155;15221.238938053164;15440.691186176213;15451.922740386226;15454.304556294994;11913.285202887855;12029.458674359676;12265.57070502528;12351.629451116482;12504;3933.171941779504;3941.743786653887;3948.881533553998;3956.960430395688;3965.7025723070883;61161.38838611646;62251.377486225014;62312.688436557524;63206.36793632097;65296;11392.601258955896;11607.30356178632;11706.531738730526;11876.10929180315;12030.39848007596;21311.78688213129;21507.462313441974;21608.459788505097;21741;22055.889720551615;8187.631556579968;8207.179282071864;8260.752177434686;8313.501189928502;8348.916510834813;4458.598726114666;4571.4514258288555;4678.883027924261;4684.765761711969;4862.465128835825;3535.9823200884343;3623.148560088377;3663.7618554793853;3671.100580357776;3672.026912868092;620.2092332276294;626.8150895485843;630.574362305442;630.6878095342835;640.6092283706935;698.0785363320368;703.7255470366562;746.2015643261658;761.9123800762873;777.8638738220789;9333.90666093344;9630.27772917034;9728.562214700356;9864.408135511892;9912.107910288109;701.130598058404;707.8018154916632;717.6053170756063;735.6615956659996;740.5519660605256;4457.866264012085;4702.95297047032;4735.881602959954;4763.976180119146;4781.019890922353;86644.56677716572;88171.55914220389;88317.55841220882;89183;91520;43699.56300437018;56855.816185253636;67432;68280.6585967067;81456.59271703604;65728.99999999904;67755;69478;69580.3041969584;72186.27813721901;10142;10629.734256643645;10818.67543973682;10860.185486088418;10903;33699.15752106217;41064.79467602643;41655.37516937309;43288.567114328456;47028.7648561755;40927.38608920928;52555.47444525659;61246.69376653088;63982.3601763995;65314;13010.349482526026;13170.934145329595;13251.271180085188;13347.799783003456;13366.86633133695;14441.205733684328;14754.262286885827;14784.186869722269;15136.470223542123;15233;13956.651083722989;14060.437582496586;14235.430582776573;14816.036957597722;14853.331600078238;14025.158490490603;14104.36530356157;14154.858451415766;14346.56960291193;15172.696546068795;13397.196168229937;13474.258915759727;13657.521986730417;14472.131672099707;14487.058341207789;10829.24195306321;11453.541858325574;11578.36319002463;12231.755364892475;12299.815502767644;10625.309354891908;11941.16411851162;12070.215435996632;12120.15158938901;12175.512979480722 13:45:07 INFO - PROCESS | 9115 | __end_tp_report 13:45:07 INFO - PROCESS | 9115 | __start_cc_report 13:45:07 INFO - PROCESS | 9115 | _x_x_mozilla_cycle_collect,1002 13:45:07 INFO - PROCESS | 9115 | __end_cc_report 13:45:07 INFO - PROCESS | 9115 | __startTimestamp1479937507625__endTimestamp 13:45:07 INFO - PROCESS | 9115 | 13:45:07 INFO - PROCESS | 9115 | ------- Summary: start ------- 13:45:07 INFO - PROCESS | 9115 | Number of tests: 6 13:45:07 INFO - PROCESS | 9115 | 13:45:07 INFO - PROCESS | 9115 | [#0] dojo.html Cycles:165 Average:5458.68 Median:5668.43 stddev:594.45 (10.5%) stddev-sans-first:568.33 13:45:07 INFO - PROCESS | 9115 | Values: 3162.5 3200.3 3218.9 3221.7 3226.3 5427.6 5490.0 5491.5 5512.4 5527.0 5475.6 5479.2 5493.6 5494.1 5496.7 4996.7 5015.7 5050.3 5076.4 5090.3 4903.9 5028.9 5084.6 5088.9 5117.8 4887.0 4939.7 4965.9 4973.9 4985.4 5019.0 5062.4 5067.9 5122.5 5135.3 4955.5 5026.5 5066.0 5077.2 5082.6 5350.1 5381.4 5390.1 5391.3 5396.8 5813.1 5829.9 5830.2 5912.1 5921.6 5952.4 5955.5 5966.1 5966.7 5971.3 5363.9 5411.8 5439.0 5486.1 5549.3 5937.3 5973.3 5975.4 5980.6 5985.1 5746.0 5756.0 5760.6 5763.1 5769.5 5752.3 5789.6 5808.3 5832.6 5849.3 5815.0 5821.9 5841.7 5860.7 5867.2 5798.6 5855.8 5856.9 5859.4 5860.2 4457.5 4486.6 4538.0 4571.3 4599.9 4083.4 4088.1 4088.6 4109.6 4130.2 5636.4 5638.4 5639.5 5641.8 5654.2 5744.7 5812.9 5864.7 5867.2 5892.0 5653.7 5693.5 5702.6 5716.7 5727.3 5184.3 5186.3 5190.8 5194.1 5196.6 5922.4 6048.9 6166.5 6182.7 6186.2 5695.1 5737.7 5773.0 5807.9 5832.8 5940.1 5943.8 5948.2 5948.6 6007.9 5642.3 5694.1 5704.4 5706.7 5707.5 5796.3 5851.3 5913.3 5913.9 5975.2 5779.6 5786.4 5790.2 5792.9 5800.8 5668.4 5791.7 5803.0 5808.4 5809.2 5562.5 5578.7 5610.7 5614.0 5627.1 5755.3 5762.9 5763.6 5776.1 5779.1 5464.3 5496.3 5627.4 5629.5 5633.2 13:45:07 INFO - PROCESS | 9115 | 13:45:07 INFO - PROCESS | 9115 | [#1] ext.html Cycles:180 Average:66880.13 Median:21594.18 stddev:138985.03 (643.6%) stddev-sans-first:139285.79 13:45:07 INFO - PROCESS | 9115 | Values: 585.4 617.6 645.7 669.0 674.9 35017.1 37505.8 37653.8 46238.8 47163.8 46471.5 46938.8 46945.5 46988.0 47022.3 8708.9 8833.3 8849.1 8853.3 8865.8 8355.9 8537.9 8549.1 8682.8 8794.5 10509.9 10751.7 10760.3 10976.3 10978.8 10542.9 10623.5 10639.5 10642.4 10651.9 10424.0 10462.6 10463.4 10467.5 10477.8 44258.8 44580.8 44628.3 44657.0 44659.3 3770.1 3780.0 3808.6 3861.6 3866.1 33351.3 33473.5 33566.8 33692.0 33767.5 4562.3 4591.7 4597.9 4694.0 4706.6 357990.0 360377.0 361460.0 362237.0 362283.0 64112.0 64348.7 64387.7 64407.7 64457.7 40010.0 40522.4 40554.0 43470.1 66714.0 19409.0 19551.9 19577.8 19580.3 19588.5 14743.6 14822.0 14849.3 14851.6 14861.4 18749.7 19022.0 20089.8 21148.0 21617.0 7300.0 7386.8 7510.3 7533.1 7751.7 946.3 1041.4 1064.5 1132.7 1151.8 34087.5 34527.8 34656.0 34816.8 34989.8 1113.0 1158.4 1162.5 1165.2 1180.3 16534.9 17350.9 17510.6 17550.8 17561.8 622399.0 626585.0 627788.0 631230.0 631873.0 61934.7 62593.0 62636.0 62658.0 62659.0 1425.2 1437.9 1440.5 1454.3 1474.8 30528.0 31982.2 32305.8 32619.3 32736.7 53469.7 54240.5 54253.0 54262.2 54375.0 539133.0 539222.0 539339.0 540562.0 545046.0 27432.6 30448.1 31130.0 31162.0 31232.5 38428.0 47040.8 50019.7 50298.0 53746.0 42640.0 43461.0 43646.6 44032.0 44608.3 42997.4 43356.0 43620.3 44111.8 44619.8 42775.0 43456.1 43655.6 44408.6 44470.8 36649.3 38144.8 38392.2 39322.2 39408.0 29238.3 29379.0 29631.6 29680.3 29724.0 13:45:07 INFO - PROCESS | 9115 | 13:45:07 INFO - PROCESS | 9115 | [#2] jquery.html Cycles:180 Average:29963.25 Median:2862.22 stddev:83562.25 (2919.5%) stddev-sans-first:83767.23 13:45:07 INFO - PROCESS | 9115 | Values: 423.6 429.9 433.1 434.8 441.9 18162.3 18436.0 19766.5 19836.6 19993.2 19140.1 19718.7 19809.7 19965.0 19995.5 5583.3 5860.5 5862.7 5866.1 5868.7 5638.5 5758.5 5777.6 5799.5 5841.6 5784.6 5800.4 5807.5 5813.3 5816.1 5608.7 5740.1 5784.3 5794.9 5798.6 5206.6 5218.6 5219.1 5219.3 5219.6 23415.4 23796.3 23893.2 23948.9 24081.8 2462.7 2720.4 2747.5 2750.7 2973.8 10619.3 14578.9 14644.5 14892.1 15494.1 1918.9 1946.5 1961.5 1993.1 2008.2 64142.4 80671.0 84144.2 92698.5 95122.0 9656.6 10250.5 10322.9 10548.2 11816.2 14467.2 14507.9 14526.4 14546.0 14626.6 8194.8 8304.8 8373.7 8435.3 8476.1 8574.6 8609.8 8627.9 8655.9 8820.4 4408.2 4427.5 4437.7 4451.2 4502.7 2053.2 2084.5 2102.9 2104.9 2114.2 910.1 972.8 1019.6 1034.0 1083.5 19993.4 20285.8 20382.3 20560.0 20694.1 1009.6 1041.4 1043.1 1086.6 1096.2 10680.6 11300.8 11442.2 11501.3 11608.2 504728.0 505599.0 506182.0 507865.0 510958.0 73304.6 92922.0 96288.5 97417.0 98367.0 951.9 968.3 986.9 992.1 994.9 17211.7 17260.7 17333.1 17394.0 18252.1 43508.6 44192.6 44320.3 44740.3 46308.0 58769.7 60371.0 60679.0 60802.4 60970.0 8775.9 8813.8 8889.6 8940.9 9183.5 12061.8 13119.0 13780.0 14524.9 14612.6 12194.6 12218.0 12279.8 12316.6 12744.6 11963.9 12375.6 12513.1 12701.8 12851.2 12233.2 12303.3 12309.1 12450.8 12601.0 9240.8 9247.1 9248.2 9477.1 9574.0 11252.7 11292.7 11385.2 11516.1 11678.5 13:45:07 INFO - PROCESS | 9115 | 13:45:07 INFO - PROCESS | 9115 | [#3] mootools.html Cycles:180 Average:5987.52 Median:5229.83 stddev:3302.37 (63.1%) stddev-sans-first:3294.51 13:45:07 INFO - PROCESS | 9115 | Values: 1513.4 1547.3 1681.5 1759.8 1792.2 8487.4 9011.2 9017.3 9029.1 9048.8 7859.2 8059.9 8585.8 8838.8 8948.9 2495.4 2525.6 2528.4 2531.1 2532.9 2417.4 2530.2 2532.5 2547.9 2549.2 2478.6 2479.5 2512.8 2515.6 2515.6 2423.2 2435.8 2458.5 2462.9 2464.0 2433.6 2444.4 2470.6 2471.6 2494.8 8984.3 8997.4 9062.2 9067.5 9082.4 5484.3 5634.0 5635.2 5648.6 5652.2 3639.7 3793.0 3809.4 3835.7 3880.2 1296.1 1343.5 1349.9 1350.8 1404.7 12530.1 12532.6 12536.9 12548.3 12555.4 5001.3 5146.9 5201.2 5230.2 5253.3 10028.0 10096.1 10102.9 10117.4 10131.9 5648.5 5657.2 5662.2 5665.7 5669.0 5069.9 5229.5 5267.8 5274.5 5282.8 3865.5 3953.2 3985.6 4020.8 4042.0 1256.3 1259.5 1262.0 1278.5 1279.8 892.4 992.9 1000.9 1006.7 1018.5 5966.2 6016.1 6021.2 6337.4 6488.9 954.9 957.5 988.8 1010.8 1044.5 4005.4 4087.2 4266.2 4295.9 4298.3 11024.7 11354.3 11448.1 11472.6 11474.1 11271.4 11298.2 11301.2 11310.7 11325.7 8386.7 8476.8 8561.4 8641.7 8661.5 5857.3 6066.9 6084.8 6131.2 6206.0 10375.2 10395.1 10451.3 10453.2 10501.9 9493.1 9671.7 9754.5 9780.9 10589.9 8003.4 8016.4 8063.9 8069.7 8089.2 8270.3 8445.2 8632.3 8717.2 8722.2 7707.6 7885.1 7889.1 7966.9 8091.0 7760.5 7765.1 7771.9 7861.9 7910.0 7225.9 7279.7 7322.8 7335.9 7343.8 5331.4 5389.6 5406.7 5484.1 5514.4 5239.9 5355.1 5375.5 5444.8 5566.2 13:45:07 INFO - PROCESS | 9115 | 13:45:07 INFO - PROCESS | 9115 | [#4] prototype.html Cycles:180 Average:4755.28 Median:5383.13 stddev:1358.11 (25.2%) stddev-sans-first:1320.80 13:45:07 INFO - PROCESS | 9115 | Values: 336.7 358.5 366.0 367.3 369.4 5265.6 5389.5 5483.5 5513.8 5521.5 5305.9 5372.8 5388.5 5482.6 5493.7 4298.9 4315.8 4316.7 4332.4 4346.7 4118.5 4189.7 4216.9 4233.3 4323.1 4102.5 4194.9 4227.7 4255.8 4257.2 4232.4 4244.2 4249.1 4254.8 4257.6 3756.0 3800.7 3804.3 3812.9 3831.9 5188.1 5205.3 5216.2 5228.7 5236.7 4806.6 4818.5 4848.8 4872.6 4874.2 5331.8 5512.8 5552.9 5560.4 5571.6 4162.8 4165.1 4167.4 4176.7 4176.8 5713.9 5739.3 5781.8 5790.5 5803.9 4039.8 4232.4 4250.4 4260.6 4287.2 4279.0 4299.6 4300.5 4303.4 4305.5 4653.0 4761.4 4770.8 4901.9 4921.7 5637.0 5638.8 5659.9 5676.3 5741.6 1460.3 1484.8 1497.0 1497.7 1499.5 1037.6 1054.4 1055.6 1074.8 1078.6 5328.3 5333.2 5343.0 5344.9 5377.7 5531.9 5575.2 5606.9 5619.4 5623.5 5320.8 5600.3 5628.3 5635.5 5640.9 2987.9 3005.5 3008.2 3022.2 3026.4 5588.6 5827.6 5833.5 5862.8 5882.2 5690.4 5710.8 5727.7 5729.4 5730.7 5838.1 5839.4 5846.4 5851.5 5852.0 5348.2 5603.5 5604.3 5612.3 5628.6 5569.3 5571.8 5584.8 5585.6 5612.6 5723.4 5833.5 5843.9 5872.0 6034.0 4161.9 4206.7 4224.6 4243.3 4245.3 5546.8 5670.5 5711.2 5870.4 5875.4 5656.6 5672.5 5685.3 5703.5 5719.6 5586.7 5698.4 5701.6 5718.6 5721.9 5564.8 5607.0 5622.4 5656.8 5657.6 5723.2 5731.8 5771.7 5789.4 5794.5 5448.9 5575.6 5576.9 5599.6 5657.2 13:45:07 INFO - PROCESS | 9115 | 13:45:07 INFO - PROCESS | 9115 | [#5] yui.html Cycles:180 Average:17584.96 Median:24078.71 stddev:22386.25 (93.0%) stddev-sans-first:22413.39 13:45:07 INFO - PROCESS | 9115 | Values: 757.9 767.9 787.8 826.8 854.8 14732.9 15720.8 15735.3 15736.2 15747.8 11231.8 13268.3 13795.0 15319.2 15345.5 844.5 862.4 868.0 868.2 869.7 856.4 861.7 863.3 863.9 863.9 906.9 908.7 909.5 909.7 910.2 902.4 902.6 903.3 903.4 904.4 659.9 661.9 661.9 662.3 662.5 13563.5 13569.6 13641.7 13823.1 14057.2 15041.8 15221.2 15440.7 15451.9 15454.3 11913.3 12029.5 12265.6 12351.6 12504.0 3933.2 3941.7 3948.9 3957.0 3965.7 61161.4 62251.4 62312.7 63206.4 65296.0 11392.6 11607.3 11706.5 11876.1 12030.4 21311.8 21507.5 21608.5 21741.0 22055.9 8187.6 8207.2 8260.8 8313.5 8348.9 4458.6 4571.5 4678.9 4684.8 4862.5 3536.0 3623.1 3663.8 3671.1 3672.0 620.2 626.8 630.6 630.7 640.6 698.1 703.7 746.2 761.9 777.9 9333.9 9630.3 9728.6 9864.4 9912.1 701.1 707.8 717.6 735.7 740.6 4457.9 4703.0 4735.9 4764.0 4781.0 86644.6 88171.6 88317.6 89183.0 91520.0 43699.6 56855.8 67432.0 68280.7 81456.6 65729.0 67755.0 69478.0 69580.3 72186.3 10142.0 10629.7 10818.7 10860.2 10903.0 33699.2 41064.8 41655.4 43288.6 47028.8 40927.4 52555.5 61246.7 63982.4 65314.0 13010.3 13170.9 13251.3 13347.8 13366.9 14441.2 14754.3 14784.2 15136.5 15233.0 13956.7 14060.4 14235.4 14816.0 14853.3 14025.2 14104.4 14154.9 14346.6 15172.7 13397.2 13474.3 13657.5 14472.1 14487.1 10829.2 11453.5 11578.4 12231.8 12299.8 10625.3 11941.2 12070.2 12120.2 12175.5 13:45:07 INFO - PROCESS | 9115 | -------- Summary: end -------- 13:45:07 INFO - PROCESS | 9115 | 13:45:08 INFO - TEST-INFO | 9115: exit 0 13:45:08 INFO - TEST-OK | dromaeo_css | took 1115413ms 13:45:08 INFO - TEST-START | kraken 13:45:08 INFO - operating with platform_type : linux_ 13:45:08 INFO - Initialising browser for kraken test... 13:45:08 INFO - TEST-INFO | started process 9432 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBAL9AE/profile http://localhost:60726/getInfo.html) 13:45:11 ERROR - PROCESS | 9432 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5373: TypeError: parent.firstChild is null 13:45:12 INFO - PROCESS | 9432 | __metrics Screen width/height:1600/1200 13:45:12 INFO - PROCESS | 9432 | colorDepth:24 13:45:12 INFO - PROCESS | 9432 | Browser inner width/height: 1024/697 13:45:12 INFO - PROCESS | 9432 | __metrics 13:45:13 INFO - PROCESS | 9432 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:45:13 INFO - PROCESS | 9432 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:45:14 INFO - PROCESS | 9432 | console.error: PushService: 13:45:14 INFO - PROCESS | 9432 | stateChangeProcessEnqueue: Error transitioning state 13:45:14 INFO - PROCESS | 9432 | UnknownError 13:45:14 INFO - TEST-INFO | 9432: exit 0 13:45:14 INFO - Browser initialized. 13:45:14 INFO - Running cycle 1/1 for kraken test... 13:45:14 INFO - TEST-INFO | started process 9527 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBAL9AE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:26 INFO - PROCESS | 9527 | RSS: Main: 144482304 13:45:26 INFO - PROCESS | 9527 | 13:45:28 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60726/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:29 INFO - PROCESS | 9527 | RSS: Main: 186372096 13:45:29 INFO - PROCESS | 9527 | 13:45:32 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60726/tests/kraken/driver.html?testName=audio-dft) 13:45:32 INFO - PROCESS | 9527 | RSS: Main: 176107520 13:45:32 INFO - PROCESS | 9527 | 13:45:35 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60726/tests/kraken/driver.html?testName=audio-fft) 13:45:36 INFO - PROCESS | 9527 | RSS: Main: 266915840 13:45:36 INFO - PROCESS | 9527 | 13:45:38 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60726/tests/kraken/driver.html?testName=audio-oscillator) 13:45:38 INFO - PROCESS | 9527 | RSS: Main: 172965888 13:45:38 INFO - PROCESS | 9527 | 13:45:41 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60726/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:45:41 INFO - PROCESS | 9527 | RSS: Main: 176193536 13:45:41 INFO - PROCESS | 9527 | 13:45:44 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60726/tests/kraken/driver.html?testName=imaging-darkroom) 13:45:45 INFO - PROCESS | 9527 | RSS: Main: 214757376 13:45:45 INFO - PROCESS | 9527 | 13:45:48 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60726/tests/kraken/driver.html?testName=imaging-desaturate) 13:45:49 INFO - PROCESS | 9527 | RSS: Main: 212832256 13:45:49 INFO - PROCESS | 9527 | 13:45:51 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60726/tests/kraken/driver.html?testName=json-parse-financial) 13:45:52 INFO - PROCESS | 9527 | RSS: Main: 211619840 13:45:52 INFO - PROCESS | 9527 | 13:45:53 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60726/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:45:54 INFO - PROCESS | 9527 | RSS: Main: 173940736 13:45:54 INFO - PROCESS | 9527 | 13:45:56 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:45:56 INFO - PROCESS | 9527 | RSS: Main: 181219328 13:45:56 INFO - PROCESS | 9527 | 13:45:58 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:45:59 INFO - PROCESS | 9527 | RSS: Main: 190857216 13:45:59 INFO - PROCESS | 9527 | 13:46:01 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:46:02 INFO - PROCESS | 9527 | RSS: Main: 198529024 13:46:02 INFO - PROCESS | 9527 | 13:46:05 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:46:05 INFO - PROCESS | 9527 | RSS: Main: 195252224 13:46:05 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | Cycle 1(1): loaded http://localhost:60726/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60726/tests/kraken/driver.html?testName=ai-astar) 13:46:07 INFO - PROCESS | 9527 | RSS: Main: 246542336 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | __start_tp_report 13:46:07 INFO - PROCESS | 9527 | _x_x_mozilla_page_load 13:46:07 INFO - PROCESS | 9527 | _x_x_mozilla_page_load_details 13:46:07 INFO - PROCESS | 9527 | |i|pagename|runs| 13:46:07 INFO - PROCESS | 9527 | |0;ai-astar;104;110;110;110;110;109;111;110;110;109 13:46:07 INFO - PROCESS | 9527 | |1;audio-beat-detection;151;120;121;166;122;120;124;126;168;120 13:46:07 INFO - PROCESS | 9527 | |2;audio-dft;161;161;160;159;160;159;159;160;159;162 13:46:07 INFO - PROCESS | 9527 | |3;audio-fft;74;74;75;114;77;76;76;75;98;74 13:46:07 INFO - PROCESS | 9527 | |4;audio-oscillator;82;81;117;81;82;82;99;82;81;107 13:46:07 INFO - PROCESS | 9527 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 13:46:07 INFO - PROCESS | 9527 | |6;imaging-darkroom;146;146;147;147;146;145;145;146;145;145 13:46:07 INFO - PROCESS | 9527 | |7;imaging-desaturate;86;85;84;85;85;84;85;84;85;85 13:46:07 INFO - PROCESS | 9527 | |8;json-parse-financial;50;52;52;50;50;50;51;51;50;50 13:46:07 INFO - PROCESS | 9527 | |9;json-stringify-tinderbox;59;58;58;58;59;59;59;58;58;62 13:46:07 INFO - PROCESS | 9527 | |10;stanford-crypto-aes;75;78;81;75;75;75;83;83;75;75 13:46:07 INFO - PROCESS | 9527 | |11;stanford-crypto-ccm;125;126;127;137;130;133;126;129;173;129 13:46:07 INFO - PROCESS | 9527 | |12;stanford-crypto-pbkdf2;156;154;154;155;156;154;158;155;155;160 13:46:07 INFO - PROCESS | 9527 | |13;stanford-crypto-sha256-iterative;62;63;64;62;62;61;62;60;60;61 13:46:07 INFO - PROCESS | 9527 | __end_tp_report 13:46:07 INFO - PROCESS | 9527 | __start_cc_report 13:46:07 INFO - PROCESS | 9527 | _x_x_mozilla_cycle_collect,1633 13:46:07 INFO - PROCESS | 9527 | __end_cc_report 13:46:07 INFO - PROCESS | 9527 | __startTimestamp1479937567789__endTimestamp 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | ------- Summary: start ------- 13:46:07 INFO - PROCESS | 9527 | Number of tests: 14 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#0] ai-astar Cycles:10 Average:109.30 Median:110.00 stddev:1.95 (1.8%) stddev-sans-first:0.60 13:46:07 INFO - PROCESS | 9527 | Values: 104.0 110.0 110.0 110.0 110.0 109.0 111.0 110.0 110.0 109.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:125.00 stddev:19.81 (15.9%) stddev-sans-first:20.02 13:46:07 INFO - PROCESS | 9527 | Values: 151.0 120.0 121.0 166.0 122.0 120.0 124.0 126.0 168.0 120.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.05 (0.7%) stddev-sans-first:1.05 13:46:07 INFO - PROCESS | 9527 | Values: 161.0 161.0 160.0 159.0 160.0 159.0 159.0 160.0 159.0 162.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:13.59 (18.0%) stddev-sans-first:14.15 13:46:07 INFO - PROCESS | 9527 | Values: 74.0 74.0 75.0 114.0 77.0 76.0 76.0 75.0 98.0 74.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#4] audio-oscillator Cycles:10 Average:89.40 Median:82.00 stddev:13.31 (16.2%) stddev-sans-first:13.85 13:46:07 INFO - PROCESS | 9527 | Values: 82.0 81.0 117.0 81.0 82.0 82.0 99.0 82.0 81.0 107.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 13:46:07 INFO - PROCESS | 9527 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#6] imaging-darkroom Cycles:10 Average:145.80 Median:146.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 13:46:07 INFO - PROCESS | 9527 | Values: 146.0 146.0 147.0 147.0 146.0 145.0 145.0 146.0 145.0 145.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 13:46:07 INFO - PROCESS | 9527 | Values: 86.0 85.0 84.0 85.0 85.0 84.0 85.0 84.0 85.0 85.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#8] json-parse-financial Cycles:10 Average:50.60 Median:50.50 stddev:0.84 (1.7%) stddev-sans-first:0.87 13:46:07 INFO - PROCESS | 9527 | Values: 50.0 52.0 52.0 50.0 50.0 50.0 51.0 51.0 50.0 50.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#9] json-stringify-tinderbox Cycles:10 Average:58.80 Median:59.00 stddev:1.23 (2.1%) stddev-sans-first:1.30 13:46:07 INFO - PROCESS | 9527 | Values: 59.0 58.0 58.0 58.0 59.0 59.0 59.0 58.0 58.0 62.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#10] stanford-crypto-aes Cycles:10 Average:77.50 Median:76.50 stddev:3.50 (4.6%) stddev-sans-first:3.60 13:46:07 INFO - PROCESS | 9527 | Values: 75.0 78.0 81.0 75.0 75.0 75.0 83.0 83.0 75.0 75.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#11] stanford-crypto-ccm Cycles:10 Average:133.50 Median:129.50 stddev:14.35 (11.1%) stddev-sans-first:14.88 13:46:07 INFO - PROCESS | 9527 | Values: 125.0 126.0 127.0 137.0 130.0 133.0 126.0 129.0 173.0 129.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.70 Median:155.50 stddev:1.95 (1.3%) stddev-sans-first:2.06 13:46:07 INFO - PROCESS | 9527 | Values: 156.0 154.0 154.0 155.0 156.0 154.0 158.0 155.0 155.0 160.0 13:46:07 INFO - PROCESS | 9527 | 13:46:07 INFO - PROCESS | 9527 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.70 Median:62.00 stddev:1.25 (2.0%) stddev-sans-first:1.32 13:46:07 INFO - PROCESS | 9527 | Values: 62.0 63.0 64.0 62.0 62.0 61.0 62.0 60.0 60.0 61.0 13:46:07 INFO - PROCESS | 9527 | -------- Summary: end -------- 13:46:07 INFO - PROCESS | 9527 | 13:46:08 INFO - TEST-INFO | 9527: exit 0 13:46:08 INFO - TEST-OK | kraken | took 60468ms 13:46:08 INFO - SUITE-END | took 1175s 13:46:08 INFO - Completed test suite (00:19:35) 13:46:08 INFO - javascript benchmark 13:46:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3162.4623813951625, 3200.31193293442, 3218.9034328970138, 3221.710046095851, 3226.257960669046, 5427.620066595335, 5490.0, 5491.505764481196, 5512.39363669996, 5527.032769265377, 5475.589330800196, 5479.17812328151, 5493.587980901429, 5494.066008778507, 5496.725163741817, 4996.7251801151015, 5015.724135172564, 5050.318207042039, 5076.390833100015, 5090.287359769635, 4903.8528844134735, 5028.899422011557, 5084.618653600976, 5088.898222035557, 5117.8464646060675, 4887.047025829965, 4939.654224204307, 4965.875853103666, 4973.850784476472, 4985.426675932278, 5018.974905125469, 5062.443131255577, 5067.949320506785, 5122.513361230677, 5135.255387968724, 4955.479674634147, 5026.522480364396, 5066.0374528839775, 5077.213031980049, 5082.567981721558, 5350.063738845686, 5381.381141168777, 5390.0836857734275, 5391.29913111293, 5396.757145928443, 5813.069908814569, 5829.883402331972, 5830.212921255618, 5912.142739302777, 5921.644701317891, 5952.434518720715, 5955.464008239236, 5966.134910437962, 5966.731497082642, 5971.253593300838, 5363.946360536423, 5411.810586629449, 5438.972805135949, 5486.1222204447095, 5549.278593782863, 5937.346891841894, 5973.313068997121, 5975.43233392827, 5980.581359304894, 5985.132155837467, 5746.0, 5756.0, 5760.567957403127, 5763.106718458645, 5769.451902069297, 5752.25220721312, 5789.623674461147, 5808.332041815161, 5832.562557808182, 5849.298084229835, 5814.970925145347, 5821.94178058214, 5841.7371218295275, 5860.70696465175, 5867.237259156283, 5798.623089499169, 5855.795047173328, 5856.941430585724, 5859.384764599741, 5860.238169037998, 4457.465104187519, 4486.551344865553, 4537.954620453753, 4571.337156112345, 4599.885002874888, 4083.4079058536345, 4088.1414902870138, 4088.591140885947, 4109.56849530795, 4130.173965206911, 5636.408177141423, 5638.43615638441, 5639.520640745583, 5641.830745077655, 5654.180143879114, 5744.741486633112, 5812.854678633068, 5864.736086876101, 5867.237259156368, 5892.0, 5653.717314134359, 5693.4875861172695, 5702.600817942704, 5716.742746576414, 5727.255456790674, 5184.274201611777, 5186.325777648882, 5190.8183213587345, 5194.142966410575, 5196.636235463557, 5922.437368449991, 6048.879022419439, 6166.537509686791, 6182.690865456799, 6186.226721659793, 5695.088785794253, 5737.655740655574, 5773.0, 5807.941920580909, 5832.825015249549, 5940.138679891305, 5943.791967281124, 5948.196993405835, 5948.613340132878, 6007.939920600738, 5642.294713160855, 5694.1458781183155, 5704.401037890962, 5706.686132262766, 5707.543396528351, 5796.304443466811, 5851.268591426072, 5913.319968203712, 5913.940860591339, 5975.16347711312, 5779.595428319977, 5786.392428794916, 5790.218320526675, 5792.884142317214, 5800.796972105956, 5668.433156684298, 5791.710414479344, 5803.0, 5808.448197421239, 5809.215755873072, 5562.471565201299, 5578.693171875586, 5610.7194640268635, 5614.04561224601, 5627.099664053731, 5755.280589926259, 5762.855928601818, 5763.567732420001, 5776.133579963039, 5779.104238842986, 5464.3442786865835, 5496.285482887199, 5627.380988091225, 5629.4652008059165, 5633.211350410864], "value": 5420.000978096011, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [585.420433770567, 617.6232498176113, 645.7029766307498, 669.0399277037449, 674.9358810912962, 35017.12457188572, 37505.81247093764, 37653.81173094137, 46238.768806156004, 47163.76418117913, 46471.53528464714, 46938.7653061735, 46945.53054469454, 46988.0, 47022.29466558004, 8708.91291087089, 8833.293336533063, 8849.115088491131, 8853.291736661084, 8865.822683546357, 8355.874661880076, 8537.871931921027, 8549.102344253857, 8682.826343473127, 8794.51630160341, 10509.947450262738, 10751.677449676523, 10760.300580462244, 10976.286541374786, 10978.835317470244, 10542.894571054307, 10623.468826558641, 10639.468026598717, 10642.361458312525, 10651.946740266327, 10424.0, 10462.581496740122, 10463.424511651856, 10467.528961196764, 10477.84283235752, 44258.77870610626, 44580.77709611464, 44628.3305750414, 44657.0, 44659.33011004805, 3770.057485628593, 3779.981100094482, 3808.619138086197, 3861.6331448512346, 3866.149447121629, 33351.33297334064, 33473.49789753131, 33566.83216583926, 33692.0, 33767.493487597705, 4562.315652652095, 4591.6556258280425, 4597.908041839144, 4693.9530604693855, 4706.647001474903, 357989.9999999974, 360377.0, 361460.0, 362236.9999999974, 362283.0, 64112.0, 64348.67825660935, 64387.67806161033, 64407.677961609894, 64457.67771161208, 40010.0, 40522.39216411756, 40554.0, 43470.13059738788, 66714.0, 19409.0, 19551.90224048899, 19577.8042219576, 19580.314688985818, 19588.510287242647, 14743.63140921464, 14822.0, 14849.257537123316, 14851.554453366416, 14861.405543778345, 18749.7187542187, 19022.0, 20089.799102008794, 21148.0, 21617.0, 7300.0, 7386.778396648109, 7510.286522780327, 7533.1336896256535, 7751.689932402754, 946.3186505715873, 1041.4063983529315, 1064.4518073192312, 1132.7054965708976, 1151.78691941991, 34087.488687669706, 34527.82736086303, 34656.0, 34816.82591587026, 34989.825050874584, 1112.9610463633735, 1158.449736375215, 1162.5349860056044, 1165.1901928159848, 1180.3449085757486, 16534.917325413295, 17350.9178898533, 17510.562235944202, 17550.82449175492, 17561.824381756018, 622399.0, 626585.0, 627788.0, 631230.0, 631873.0, 61934.69032654808, 62593.0, 62636.0, 62658.0, 62659.0, 1425.2303755971866, 1437.9496717614834, 1440.5318271561785, 1454.2801313349748, 1474.827512127861, 30528.0, 31982.20044498813, 32305.838470807495, 32619.34761304713, 32736.672633274316, 53469.7326513365, 54240.45759542354, 54253.0, 54262.18606720981, 54375.0, 539133.0, 539222.0, 539339.0, 540562.0, 545046.0, 27432.588511172748, 30448.086557403312, 31130.0, 31162.0, 31232.531512026882, 38428.0, 47040.7647961758, 50019.74990125026, 50298.0, 53746.0, 42640.0, 43461.0, 43646.64621656468, 44032.0, 44608.33087503755, 42997.35503967381, 43356.0, 43620.34569481524, 44111.77944110259, 44619.776901115285, 42775.0, 43456.13087738291, 43655.56344436515, 44408.555914441735, 44470.777646111565, 36649.267014659024, 38144.80927595344, 38392.2321553573, 39322.21355572815, 39408.0, 29238.26904327409, 29379.0, 29631.555526667547, 29680.257993550335, 29724.0], "value": 21369.185027013686, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [423.55103590194415, 429.8957917003792, 433.07754482951316, 434.80868417896136, 441.9359192917027, 18162.27350905964, 18436.0, 19766.505837354056, 19836.60326793463, 19993.200271989102, 19140.138693758814, 19718.70421943672, 19809.702854457195, 19965.0, 19995.500112497193, 5583.274174357338, 5860.472557469827, 5862.736176872051, 5866.061430171173, 5868.677222752747, 5638.520725738317, 5758.539316854642, 5777.59556831022, 5799.507041901423, 5841.6202946808535, 5784.595078344518, 5800.4489573490455, 5807.477327040566, 5813.30240371156, 5816.069428891378, 5608.663480191181, 5740.1102829061565, 5784.2769653793275, 5794.855128621797, 5798.565107616924, 5206.635535512516, 5218.582513398919, 5219.086659834552, 5219.347581552306, 5219.582433405319, 23415.4146146346, 23796.286111416684, 23893.163739269043, 23948.88025559861, 24081.75918240813, 2462.6675398821108, 2720.442309326603, 2747.5466548019554, 2750.683671377777, 2973.762099032094, 10619.25665203436, 14578.927105364512, 14644.487442939553, 14892.106473611619, 15494.147821869792, 1918.88486690799, 1946.532832120281, 1961.4998175465307, 1993.1230258686132, 2008.2268326694327, 64142.3585764141, 80671.0, 84144.15855841486, 92698.53650731771, 95121.9999999993, 9656.565454554562, 10250.487475626189, 10322.948385258025, 10548.208884333706, 11816.231944923553, 14467.204303763394, 14507.927460362842, 14526.418943242363, 14546.0, 14626.63433414152, 8194.795130121795, 8304.8339033219, 8373.748787536384, 8435.283000944866, 8476.067632560413, 8574.614142363484, 8609.784755381166, 8627.870581941275, 8655.870161947576, 8820.426672266281, 4408.236705317899, 4427.512973572904, 4437.689361744711, 4451.243288640939, 4502.707324023993, 2053.188990348804, 2084.47888027993, 2102.947426314324, 2104.9263275785274, 2114.228306668055, 910.0626354854511, 972.7568107973007, 1019.576875596634, 1033.9689809305733, 1083.5070043130356, 19993.400197994084, 20285.797142028685, 20382.28661996823, 20560.0, 20694.068766905526, 1009.5557954499997, 1041.3910508264748, 1043.118564812732, 1086.6196831109207, 1096.17786660005, 10680.57277708883, 11300.773984520263, 11442.226454899504, 11501.309921404743, 11608.187426880206, 504728.0, 505599.0, 506182.0, 507865.0, 510958.0, 73304.63347683227, 92922.0, 96288.51855740676, 97417.0, 98367.0, 951.8905325887473, 968.2689569375077, 986.9210463163073, 992.0575453319232, 994.8607194992852, 17211.741823872904, 17260.654786904444, 17333.13334333253, 17394.0, 18252.08739563043, 43508.56491435045, 44192.55807441884, 44320.335194972744, 44740.32889506725, 46308.0, 58769.70615146897, 60371.0, 60679.0, 60802.391976081446, 60970.0, 8775.91224087751, 8813.779655508408, 8889.599968001326, 8940.910590894007, 9183.54082295896, 12061.819072714092, 13119.0, 13780.035397522479, 14524.927375363479, 14612.561623151323, 12194.57318993831, 12218.0, 12279.75440491203, 12316.568920087753, 12744.61766147017, 11963.880361196625, 12375.566855160387, 12513.124081314221, 12701.809472857729, 12851.228926264454, 12233.204841685261, 12303.261804291771, 12309.138360314691, 12450.75098498043, 12601.0, 9240.768980775534, 9247.115218304518, 9248.16766491019, 9477.09967553109, 9574.0, 11252.66242012741, 11292.661220163409, 11385.203035787416, 11516.136289778467, 11678.474468649101], "value": 9551.877140655934, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1513.43246282644, 1547.288247406193, 1681.5207665815237, 1759.8328158824906, 1792.1845560270078, 8487.40588158829, 9011.18899299063, 9017.278617710585, 9029.142231488006, 9048.773780655478, 7859.174786647392, 8059.8791018134625, 8585.785355366119, 8838.823223535526, 8948.91051089489, 2495.413577809213, 2525.6464095026713, 2528.3931856354525, 2531.0508559290265, 2532.8733563321853, 2417.359399759065, 2530.1903390914913, 2532.531131943468, 2547.8726063696836, 2549.1715192562397, 2478.578641630918, 2479.5164942836154, 2512.761287677677, 2515.5723527000364, 2515.5723527000364, 2423.1882319422925, 2435.768601982809, 2458.4591389894194, 2462.852228866274, 2463.9753602463925, 2433.6471211674384, 2444.4011217251887, 2470.629405589158, 2471.567475691747, 2494.787943024845, 8984.281257499384, 8997.370184087116, 9062.184403403726, 9067.455952642797, 9082.364234503588, 5484.287042684466, 5633.971830140823, 5635.239242702224, 5648.63283886546, 5652.18043383707, 3639.727020473475, 3792.962070379316, 3809.3714537101346, 3835.6547910688173, 3880.2433525462548, 1296.0927350854345, 1343.4626149540165, 1349.925754083525, 1350.797380392949, 1404.7190561887562, 12530.122891397516, 12532.561360352343, 12536.874631253662, 12548.309842958633, 12555.372231388394, 5001.274815151783, 5146.87132821675, 5201.219817027476, 5230.189320655304, 5253.32080638877, 10028.047335503115, 10096.091351778376, 10102.949485252526, 10117.44354060519, 10131.949340253252, 5648.491635752802, 5657.179708942181, 5662.178984047372, 5665.745041473144, 5669.0, 5069.873253168626, 5229.47705229474, 5267.789288428497, 5274.472552744694, 5282.7622756976025, 3865.4588357629955, 3953.189596132786, 3985.561588225293, 4020.798960051986, 4041.9797901010306, 1256.3278645924386, 1259.477316913489, 1262.0156278103095, 1278.4758249117817, 1279.7952327627536, 892.3842548641417, 992.8510723391405, 1000.8999100089933, 1006.6929586476049, 1018.5009345420839, 5966.224390829251, 6016.127661489059, 6021.217241758631, 6337.397947195009, 6488.935110648928, 954.9427034377959, 957.5212393803098, 988.7577543501889, 1010.7725761703558, 1044.4882007816268, 4005.35914253718, 4087.1825634873144, 4266.189424009428, 4295.914081718348, 4298.290782020994, 11024.724381890517, 11354.26197297173, 11448.141389395661, 11472.598459053894, 11474.139439542068, 11271.436428178558, 11298.20912536131, 11301.152413569016, 11310.660680179608, 11325.660230193107, 8386.67511487402, 8476.830463390697, 8561.443506172203, 8641.654333826576, 8661.480311181349, 5857.297124345106, 6066.884135561109, 6084.817455476343, 6131.233595800525, 6206.0, 10375.221858360805, 10395.116415104498, 10451.320664156805, 10453.216008799523, 10501.89498105009, 9493.0981556752, 9671.661491847752, 9754.463504507321, 9780.853287200556, 10589.9470502647, 8003.39974501903, 8016.358691304798, 8063.8790418144945, 8069.7175598853755, 8089.150639183036, 8270.25567698886, 8445.1977062179, 8632.30941524664, 8717.215450609476, 8722.215000649972, 7707.576083315472, 7885.093214280202, 7889.0927543333255, 7966.92033079685, 8090.959545202236, 7760.534367937942, 7765.145833958147, 7771.92228077712, 7861.921380786119, 7909.960450197712, 7225.9277407227355, 7279.708811647687, 7322.780316590511, 7335.926640733524, 7343.816404589928, 5331.360236771612, 5389.595780316414, 5406.729663516887, 5484.067708489487, 5514.420985796433, 5239.869003274796, 5355.062863998707, 5375.543078838343, 5444.8366549003595, 5566.248556444828], "value": 4847.025690833671, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.6717450485775, 358.5249544353732, 366.03002044581854, 367.32045715426466, 369.4421423650288, 5265.604614777082, 5389.51494365507, 5483.533899618532, 5513.7794488220525, 5521.5306698930635, 5305.8938821223555, 5372.785088596461, 5388.541973932221, 5482.643628164166, 5493.725313734317, 4298.935515967263, 4315.805788739514, 4316.697831151829, 4332.371806088116, 4346.717463364887, 4118.485189351331, 4189.748615083089, 4216.894577635553, 4233.26436161174, 4323.113761678848, 4102.507699076115, 4194.937075943863, 4227.661787057028, 4255.787210639471, 4257.212415703105, 4232.36514522824, 4244.172386384656, 4249.086446414005, 4254.808533615979, 4257.616814486695, 3755.962440375589, 3800.714946379005, 3804.2771873343977, 3812.942805857914, 3831.9042023949346, 5188.143956247215, 5205.27126202332, 5216.165413533854, 5228.738563071831, 5236.685798852043, 4806.591439727627, 4818.469968303484, 4848.757562121879, 4872.585830204437, 4874.2201247800185, 5331.760070796823, 5512.779488820443, 5552.91670624941, 5560.36055853578, 5571.582131340166, 4162.791860406998, 4165.12532368203, 4167.395727619509, 4176.686748493875, 4176.791160441966, 5713.857153571153, 5739.311282646026, 5781.768729250825, 5790.536757059425, 5803.941960580424, 4039.8182081805803, 4232.449781528443, 4250.42619246404, 4260.616544510947, 4287.206866729603, 4279.015826359955, 4299.570042995675, 4300.526942036374, 4303.376010478526, 4305.461817272841, 4653.0, 4761.40482439695, 4770.785314660849, 4901.877453063631, 4921.729304888266, 5636.985342638364, 5638.830835074954, 5659.943400566024, 5676.318841739017, 5741.569382296345, 1460.3355473259642, 1484.829244636859, 1496.9550913472613, 1497.7004599080228, 1499.475183685723, 1037.5953378182514, 1054.3989925742253, 1055.5988724284723, 1074.7796701676139, 1078.6494389323502, 5328.268312798356, 5333.213373519914, 5342.98483288174, 5344.946550534522, 5377.70934975603, 5531.917021244684, 5575.219469274305, 5606.878624275161, 5619.381867994517, 5623.522000629992, 5320.813771518056, 5600.299962504687, 5628.296462942132, 5635.549156067505, 5640.943590564124, 2987.939281555017, 3005.4590173768493, 3008.217863355543, 3022.199117233935, 3026.3644634626535, 5588.580856435784, 5827.562932780059, 5833.4749872511675, 5862.765489380377, 5882.176495290577, 5690.430956904359, 5710.800731846276, 5727.656340619576, 5729.395769184635, 5730.713464326767, 5838.1393117371335, 5839.379584657539, 5846.356900740915, 5851.507865494272, 5852.0, 5348.197770334481, 5603.523700485504, 5604.299462567179, 5612.298462692163, 5628.577856660685, 5569.331680198402, 5571.804986825442, 5584.804531841366, 5585.581081418829, 5612.579056570855, 5723.370429252862, 5833.4749872511675, 5843.912341314799, 5871.970640146772, 6034.0, 4161.91676166481, 4206.684498662674, 4224.55642157569, 4243.278642630698, 4245.341971994346, 5546.750396232099, 5670.489655930821, 5711.171880077449, 5870.383609720918, 5875.443007602903, 5656.632318899258, 5672.517835983823, 5685.260916080883, 5703.458171473703, 5719.57103217252, 5586.664800112007, 5698.430156984268, 5701.600887937804, 5718.628289161191, 5721.914171287517, 5564.777408903598, 5607.0, 5622.409646987171, 5656.773729050957, 5657.603967722384, 5723.170140329712, 5731.761554721736, 5771.7114144293455, 5789.363170051375, 5794.536437084938, 5448.891022179455, 5575.553955683617, 5576.86057848557, 5599.580031497735, 5657.179708942098], "value": 4334.4859689913865, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.8560073586021, 767.9347255483284, 787.8069872881144, 826.8470332988402, 854.786303424144, 14732.852671473296, 15720.764188537181, 15735.291911863966, 15736.213189340517, 15747.763783543242, 11231.831522527149, 13268.336583170827, 13795.0, 15319.157446340447, 15345.462908798194, 844.4511067805929, 862.4006315610653, 867.9609417576193, 868.2229404682805, 869.74342568942, 856.4475913036088, 861.6553378648528, 863.3050394432479, 863.874738162966, 863.9006514250879, 906.8957069936943, 908.7001289574457, 909.4815954905706, 909.6952520905504, 910.2399496420497, 902.4314681750456, 902.5667679513805, 903.2909166304453, 903.3721563513361, 904.4076130134739, 659.8977158540434, 661.8577005943697, 661.8709351676425, 662.2814246542507, 662.493192707579, 13563.52527661537, 13569.59291221255, 13641.727165456636, 13823.101498402571, 14057.226852523107, 15041.849581504155, 15221.238938053164, 15440.691186176213, 15451.922740386226, 15454.304556294994, 11913.285202887855, 12029.458674359676, 12265.57070502528, 12351.629451116482, 12504.0, 3933.171941779504, 3941.743786653887, 3948.881533553998, 3956.960430395688, 3965.7025723070883, 61161.38838611646, 62251.377486225014, 62312.688436557524, 63206.36793632097, 65296.0, 11392.601258955896, 11607.30356178632, 11706.531738730526, 11876.10929180315, 12030.39848007596, 21311.78688213129, 21507.462313441974, 21608.459788505097, 21741.0, 22055.889720551615, 8187.631556579968, 8207.179282071864, 8260.752177434686, 8313.501189928502, 8348.916510834813, 4458.598726114666, 4571.4514258288555, 4678.883027924261, 4684.765761711969, 4862.465128835825, 3535.9823200884343, 3623.148560088377, 3663.7618554793853, 3671.100580357776, 3672.026912868092, 620.2092332276294, 626.8150895485843, 630.574362305442, 630.6878095342835, 640.6092283706935, 698.0785363320368, 703.7255470366562, 746.2015643261658, 761.9123800762873, 777.8638738220789, 9333.90666093344, 9630.27772917034, 9728.562214700356, 9864.408135511892, 9912.107910288109, 701.130598058404, 707.8018154916632, 717.6053170756063, 735.6615956659996, 740.5519660605256, 4457.866264012085, 4702.95297047032, 4735.881602959954, 4763.976180119146, 4781.019890922353, 86644.56677716572, 88171.55914220389, 88317.55841220882, 89183.0, 91520.0, 43699.56300437018, 56855.816185253636, 67432.0, 68280.6585967067, 81456.59271703604, 65728.99999999904, 67755.0, 69478.0, 69580.3041969584, 72186.27813721901, 10142.0, 10629.734256643645, 10818.67543973682, 10860.185486088418, 10903.0, 33699.15752106217, 41064.79467602643, 41655.37516937309, 43288.567114328456, 47028.7648561755, 40927.38608920928, 52555.47444525659, 61246.69376653088, 63982.3601763995, 65314.0, 13010.349482526026, 13170.934145329595, 13251.271180085188, 13347.799783003456, 13366.86633133695, 14441.205733684328, 14754.262286885827, 14784.186869722269, 15136.470223542123, 15233.0, 13956.651083722989, 14060.437582496586, 14235.430582776573, 14816.036957597722, 14853.331600078238, 14025.158490490603, 14104.36530356157, 14154.858451415766, 14346.56960291193, 15172.696546068795, 13397.196168229937, 13474.258915759727, 13657.521986730417, 14472.131672099707, 14487.058341207789, 10829.24195306321, 11453.541858325574, 11578.36319002463, 12231.755364892475, 12299.815502767644, 10625.309354891908, 11941.16411851162, 12070.215435996632, 12120.15158938901, 12175.512979480722], "value": 7384.411617411732, "unit": "score"}], "name": "dromaeo_css", "value": 7454.896898246166, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 110.0, 110.0, 110.0, 110.0, 109.0, 111.0, 110.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 120.0, 121.0, 166.0, 122.0, 120.0, 124.0, 126.0, 168.0, 120.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 160.0, 159.0, 160.0, 159.0, 159.0, 160.0, 159.0, 162.0], "value": 160.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 114.0, 77.0, 76.0, 76.0, 75.0, 98.0, 74.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 117.0, 81.0, 82.0, 82.0, 99.0, 82.0, 81.0, 107.0], "value": 89.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 146.0, 145.0, 145.0, 146.0, 145.0, 145.0], "value": 145.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 52.0, 50.0, 50.0, 50.0, 51.0, 51.0, 50.0, 50.0], "value": 50.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 58.0, 58.0, 58.0, 59.0, 59.0, 59.0, 58.0, 58.0, 62.0], "value": 58.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 78.0, 81.0, 75.0, 75.0, 75.0, 83.0, 83.0, 75.0, 75.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 126.0, 127.0, 137.0, 130.0, 133.0, 126.0, 129.0, 173.0, 129.0], "value": 133.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 154.0, 154.0, 155.0, 156.0, 154.0, 158.0, 155.0, 155.0, 160.0], "value": 155.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 62.0, 62.0, 61.0, 62.0, 60.0, 60.0, 61.0], "value": 61.7, "unit": "score"}], "name": "kraken", "value": 1459.1000000000001, "alertThreshold": 2.0}]} 13:46:09 INFO - Return code: 0 13:46:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:46:09 ERROR - # TBPL SUCCESS # 13:46:09 INFO - Running post-action listener: _resource_record_post_action 13:46:09 INFO - [mozharness: 2016-11-23 21:46:09.073919Z] Finished run-tests step (success) 13:46:09 INFO - Running post-run listener: _resource_record_post_run 13:46:09 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 270336; Write bytes: 370966528; Read time: 96; Write time: 248288 13:46:09 INFO - TinderboxPrint: CPU usage
13.0% 13:46:09 INFO - TinderboxPrint: I/O read bytes / time
270,336 / 96 13:46:09 INFO - TinderboxPrint: I/O write bytes / time
370,966,528 / 248,288 13:46:09 INFO - TinderboxPrint: CPU idle
8,285.5 (87.0%) 13:46:09 INFO - TinderboxPrint: CPU user
1,189.8 (12.5%) 13:46:09 INFO - TinderboxPrint: Swap in / out
0 / 0 13:46:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 123891712; Read time: 0; Write time: 101772 13:46:09 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 270336; Write bytes: 246161408; Read time: 96; Write time: 146456 13:46:09 INFO - Running post-run listener: _upload_blobber_files 13:46:09 INFO - Blob upload gear active. 13:46:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:46:09 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:46:09 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:46:09 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:46:10 INFO - (blobuploader) - INFO - Open directory for files ... 13:46:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:46:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:46:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:11 INFO - (blobuploader) - INFO - Done attempting. 13:46:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:46:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:46:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:12 INFO - (blobuploader) - INFO - Done attempting. 13:46:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:46:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:46:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:15 INFO - (blobuploader) - INFO - Done attempting. 13:46:15 INFO - (blobuploader) - INFO - Iteration through files over. 13:46:15 INFO - Return code: 0 13:46:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:46:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:46:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab7ff99e70138613349f3bbd9ee3b71f99c0b657eafeb5f98cf19bf66ec545216923dafcd3a991b47d3102603364d7bca7ad556d0018f5ede408521cfb513ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35b7684e9d3f3b9397fc7618a03b28d9255d9b0fc7075493b87143bda823059262ba8b156eb46a6c60abbd73c6638d73821a2330e0966941d5f43821cca5387d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30f39ada791e32b67f24d3d008dd4abbb3de8f92fb4ba1025cbffea4eead952941c8025c6d7b8701cbedf7a00e28149ec81cfe4a31dda33bfc236e95b3a87722"} 13:46:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:46:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:46:15 INFO - Contents: 13:46:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab7ff99e70138613349f3bbd9ee3b71f99c0b657eafeb5f98cf19bf66ec545216923dafcd3a991b47d3102603364d7bca7ad556d0018f5ede408521cfb513ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35b7684e9d3f3b9397fc7618a03b28d9255d9b0fc7075493b87143bda823059262ba8b156eb46a6c60abbd73c6638d73821a2330e0966941d5f43821cca5387d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30f39ada791e32b67f24d3d008dd4abbb3de8f92fb4ba1025cbffea4eead952941c8025c6d7b8701cbedf7a00e28149ec81cfe4a31dda33bfc236e95b3a87722"} 13:46:15 INFO - Running post-run listener: copy_logs_to_upload_dir 13:46:15 INFO - Copying logs to upload dir... 13:46:15 INFO - mkdir: /builds/slave/test/build/upload/logs 13:46:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.673019 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-11-23 13:46:15.131980) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 13:46:15.136086) ========= 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=5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab7ff99e70138613349f3bbd9ee3b71f99c0b657eafeb5f98cf19bf66ec545216923dafcd3a991b47d3102603364d7bca7ad556d0018f5ede408521cfb513ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35b7684e9d3f3b9397fc7618a03b28d9255d9b0fc7075493b87143bda823059262ba8b156eb46a6c60abbd73c6638d73821a2330e0966941d5f43821cca5387d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30f39ada791e32b67f24d3d008dd4abbb3de8f92fb4ba1025cbffea4eead952941c8025c6d7b8701cbedf7a00e28149ec81cfe4a31dda33bfc236e95b3a87722"} build_url:https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011705 build_url: 'https://queue.taskcluster.net/v1/task/IzErdqvEQAeteTomGJ9Btw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ab7ff99e70138613349f3bbd9ee3b71f99c0b657eafeb5f98cf19bf66ec545216923dafcd3a991b47d3102603364d7bca7ad556d0018f5ede408521cfb513ba5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/35b7684e9d3f3b9397fc7618a03b28d9255d9b0fc7075493b87143bda823059262ba8b156eb46a6c60abbd73c6638d73821a2330e0966941d5f43821cca5387d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30f39ada791e32b67f24d3d008dd4abbb3de8f92fb4ba1025cbffea4eead952941c8025c6d7b8701cbedf7a00e28149ec81cfe4a31dda33bfc236e95b3a87722"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-23 13:46:15.163089) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:46:15.163439) ========= 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=5cf47e208febbcd81da23b2e0000026f-1479935888.669285-1447755683 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004432 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-23 13:46:15.246958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 13:46:15.247288) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-23 13:46:15.247610) ========= ========= Total master_lag: 0.18 =========