builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-015 starttime: 1485902381.45 results: success (0) buildid: 20170131125208 builduid: 1b90e62fbbdc4e409485f61c65b79836 revision: c2d975acbc8308d51d39e006f2fb873869fbd488 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:41.447556) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:41.448017) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:41.448292) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:41.464932) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:41.465285) ========= 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=20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-31 14:39:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.3M=0s 2017-01-31 14:39:41 (46.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131134 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:41.611451) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:41.611891) ========= 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=20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014259 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:41.662121) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:41.662467) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev c2d975acbc8308d51d39e006f2fb873869fbd488 --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-beta --rev c2d975acbc8308d51d39e006f2fb873869fbd488 --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=20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-31 14:39:41,732 truncating revision to first 12 chars 2017-01-31 14:39:41,732 Setting DEBUG logging. 2017-01-31 14:39:41,732 attempt 1/10 2017-01-31 14:39:41,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/c2d975acbc83?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-31 14:39:42,037 unpacking tar archive at: mozilla-beta-c2d975acbc83/testing/mozharness/ program finished with exit code 0 elapsedTime=0.601963 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:42.277698) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:42.278057) ========= script_repo_revision: c2d975acbc8308d51d39e006f2fb873869fbd488 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:42.278436) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:42.278720) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-31 14:39:42.288058) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-01-31 14:39:42.288383) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:39:42 INFO - MultiFileLogger online at 20170131 14:39:42 in /builds/slave/test 14:39:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 14:39:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:39:42 INFO - {'append_to_log': False, 14:39:42 INFO - 'base_work_dir': '/builds/slave/test', 14:39:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 14:39:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:39:42 INFO - 'branch': 'Mozilla-Beta', 14:39:42 INFO - 'buildbot_json_path': 'buildprops.json', 14:39:42 INFO - 'config_files': ('talos/linux_config.py',), 14:39:42 INFO - 'default_actions': ('clobber', 14:39:42 INFO - 'read-buildbot-config', 14:39:42 INFO - 'download-and-extract', 14:39:42 INFO - 'populate-webroot', 14:39:42 INFO - 'create-virtualenv', 14:39:42 INFO - 'install', 14:39:42 INFO - 'run-tests'), 14:39:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:39:42 INFO - 'download_minidump_stackwalk': True, 14:39:42 INFO - 'download_symbols': 'ondemand', 14:39:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:39:42 INFO - 'tooltool.py': '/tools/tooltool.py', 14:39:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:39:42 INFO - '/tools/misc-python/virtualenv.py')}, 14:39:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:39:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:39:42 INFO - 'installer_path': 'installer.exe', 14:39:42 INFO - 'log_level': 'info', 14:39:42 INFO - 'log_name': 'talos', 14:39:42 INFO - 'log_to_console': True, 14:39:42 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:39:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:39:42 INFO - 'opt_config_files': (), 14:39:42 INFO - 'pip_index': False, 14:39:42 INFO - 'sps_profile': False, 14:39:42 INFO - 'sps_profile_interval': 0, 14:39:42 INFO - 'suite': 'dromaeojs', 14:39:42 INFO - 'system_bits': '32', 14:39:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:39:42 INFO - 'title': 'talos-linux64-ix-015', 14:39:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:39:42 INFO - 'use_talos_json': True, 14:39:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:39:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:39:42 INFO - 'work_dir': 'build'} 14:39:42 INFO - [mozharness: 2017-01-31 22:39:42.456680Z] Running clobber step. 14:39:42 INFO - Running pre-action listener: _resource_record_pre_action 14:39:42 INFO - Running main action method: clobber 14:39:42 INFO - rmtree: /builds/slave/test/build 14:39:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:39:43 INFO - Running post-action listener: _resource_record_post_action 14:39:43 INFO - [mozharness: 2017-01-31 22:39:43.436250Z] Finished clobber step (success) 14:39:43 INFO - [mozharness: 2017-01-31 22:39:43.436348Z] Running read-buildbot-config step. 14:39:43 INFO - Running pre-action listener: _resource_record_pre_action 14:39:43 INFO - Running main action method: read_buildbot_config 14:39:43 INFO - Using buildbot properties: 14:39:43 INFO - { 14:39:43 INFO - "project": "", 14:39:43 INFO - "product": "firefox", 14:39:43 INFO - "script_repo_revision": "production", 14:39:43 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 14:39:43 INFO - "repository": "", 14:39:43 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 14:39:43 INFO - "buildid": "20170131125208", 14:39:43 INFO - "pgo_build": "True", 14:39:43 INFO - "basedir": "/builds/slave/test", 14:39:43 INFO - "buildnumber": 2, 14:39:43 INFO - "slavename": "talos-linux64-ix-015", 14:39:43 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:39:43 INFO - "platform": "ubuntu64_hw", 14:39:43 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 14:39:43 INFO - "branch": "mozilla-beta", 14:39:43 INFO - "repo_path": "releases/mozilla-beta", 14:39:43 INFO - "revision": "c2d975acbc8308d51d39e006f2fb873869fbd488", 14:39:43 INFO - "stage_platform": "linux64-pgo", 14:39:43 INFO - "builduid": "1b90e62fbbdc4e409485f61c65b79836", 14:39:43 INFO - "slavebuilddir": "test" 14:39:43 INFO - } 14:39:43 INFO - Found installer url https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 14:39:43 INFO - Running post-action listener: _resource_record_post_action 14:39:43 INFO - [mozharness: 2017-01-31 22:39:43.438751Z] Finished read-buildbot-config step (success) 14:39:43 INFO - [mozharness: 2017-01-31 22:39:43.438839Z] Running download-and-extract step. 14:39:43 INFO - Running pre-action listener: _resource_record_pre_action 14:39:43 INFO - Running main action method: download_and_extract 14:39:43 INFO - mkdir: /builds/slave/test/build/tests 14:39:43 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')]} 14:39:43 INFO - trying https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:39:43 INFO - Downloading https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:39:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:39:44 INFO - Downloaded 1327 bytes. 14:39:44 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 14:39:44 INFO - Using the following test package requirements: 14:39:44 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:39:44 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:39:44 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 14:39:44 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:39:44 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 14:39:44 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:39:44 INFO - u'jsshell-linux-x86_64.zip'], 14:39:44 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:39:44 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 14:39:44 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 14:39:44 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:39:44 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 14:39:44 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:39:44 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 14:39:44 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:39:44 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 14:39:44 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 14:39:44 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 14:39:44 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:39:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:39:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:44 INFO - Fetch https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:39:44 INFO - Http code: 200 14:39:44 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 14:39:44 INFO - x-amz-cf-id: Igy1lLF4SCMNmlys5peN7I13KMKLeGNn_Kng92QXPpfIovHZugF9Dg== 14:39:44 INFO - x-amz-version-id: AYkq9X235eehNcmZbDHjx9_eDyNbAL09 14:39:44 INFO - Expected file size: 21954303 14:39:44 INFO - Obtained file size: 21954303 14:39:48 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:39:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 14:39:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:39:48 INFO - Fetch https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 14:39:49 INFO - Http code: 200 14:39:49 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 14:39:49 INFO - x-amz-cf-id: 2NTarObdY1R5mkS8wFZvTQTtKYPoxFKSA_UameNTHvuTpE57Cv5uEA== 14:39:49 INFO - x-amz-version-id: AYkq9X235eehNcmZbDHjx9_eDyNbAL09 14:39:49 INFO - Expected file size: 21954303 14:39:49 INFO - Obtained file size: 21954303 14:39:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 14:39:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:39:54 INFO - Fetch https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 14:39:54 INFO - Http code: 200 14:39:54 INFO - via: 1.1 032d42677fbf05c24a4bb71369581429.cloudfront.net (CloudFront) 14:39:54 INFO - x-amz-cf-id: dcp-KJ2D4ReK8FwoOMdW2Tfl35X12PFlG8rO8MdN4BeKFo7al7mp9A== 14:39:54 INFO - x-amz-version-id: O7k6EIqTiizJCNHD2fA3CgCqUL4zcmoL 14:39:54 INFO - Expected file size: 14403005 14:39:54 INFO - Obtained file size: 14403005 14:39:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:39:55 INFO - trying https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:39:55 INFO - Downloading https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:39:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:39:56 INFO - Downloaded 57696826 bytes. 14:39:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:39:56 INFO - mkdir: /builds/slave/test/properties 14:39:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:39:56 INFO - Writing to file /builds/slave/test/properties/build_url 14:39:56 INFO - Contents: 14:39:56 INFO - build_url:https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 14:39:56 INFO - Running post-action listener: _resource_record_post_action 14:39:56 INFO - Running post-action listener: set_extra_try_arguments 14:39:56 INFO - [mozharness: 2017-01-31 22:39:56.858788Z] Finished download-and-extract step (success) 14:39:56 INFO - [mozharness: 2017-01-31 22:39:56.859016Z] Running populate-webroot step. 14:39:56 INFO - Running pre-action listener: _resource_record_pre_action 14:39:56 INFO - Running main action method: populate_webroot 14:39:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:39:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:39:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:39:56 INFO - '--tppagecycles', 14:39:56 INFO - '7'], 14:39:56 INFO - 'tests': ['tsvgm']}}, 14:39:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:39:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:39:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:39:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:39:56 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:56 INFO - 'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:56 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:39:56 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:56 INFO - 'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['damp', 'tps']}, 14:39:56 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:56 INFO - 'tests': ['damp', 'tps']}, 14:39:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['dromaeo_dom']}, 14:39:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:39:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['basic_compositor_video']}, 14:39:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:39:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['a11yr', 14:39:56 INFO - 'ts_paint', 14:39:56 INFO - 'tpaint', 14:39:56 INFO - 'sessionrestore', 14:39:56 INFO - 'sessionrestore_no_auto_restore', 14:39:56 INFO - 'tabpaint']}, 14:39:56 INFO - 'other-e10s': {'tests': ['a11yr', 14:39:56 INFO - 'ts_paint', 14:39:56 INFO - 'tpaint', 14:39:56 INFO - 'sessionrestore', 14:39:56 INFO - 'sessionrestore_no_auto_restore', 14:39:56 INFO - 'tabpaint']}, 14:39:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:39:56 INFO - 'ts_paint', 14:39:56 INFO - 'tpaint', 14:39:56 INFO - 'sessionrestore', 14:39:56 INFO - 'sessionrestore_no_auto_restore', 14:39:56 INFO - 'tabpaint']}, 14:39:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:39:56 INFO - 'ts_paint', 14:39:56 INFO - 'tpaint', 14:39:56 INFO - 'sessionrestore', 14:39:56 INFO - 'sessionrestore_no_auto_restore', 14:39:56 INFO - 'tabpaint']}, 14:39:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['a11yr', 14:39:56 INFO - 'ts_paint', 14:39:56 INFO - 'tpaint', 14:39:56 INFO - 'sessionrestore', 14:39:56 INFO - 'sessionrestore_no_auto_restore', 14:39:56 INFO - 'tabpaint']}, 14:39:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['a11yr', 14:39:56 INFO - 'ts_paint', 14:39:56 INFO - 'tpaint', 14:39:56 INFO - 'sessionrestore', 14:39:56 INFO - 'sessionrestore_no_auto_restore', 14:39:56 INFO - 'tabpaint']}, 14:39:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['tsvgx', 14:39:56 INFO - 'tsvgr_opacity', 14:39:56 INFO - 'tart', 14:39:56 INFO - 'tscrollx', 14:39:56 INFO - 'cart']}, 14:39:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:39:56 INFO - 'tsvgr_opacity', 14:39:56 INFO - 'tart', 14:39:56 INFO - 'tscrollx', 14:39:56 INFO - 'cart']}, 14:39:56 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:56 INFO - 'talos_options': ['--disable-e10s'], 14:39:56 INFO - 'tests': ['tp5o']}, 14:39:56 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:56 INFO - 'tests': ['tp5o']}, 14:39:56 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:56 INFO - 'talos_options': ['--disable-e10s', 14:39:56 INFO - '--xperf_path', 14:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:56 INFO - 'tests': ['tp5n']}, 14:39:56 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:39:56 INFO - 'talos_options': ['--xperf_path', 14:39:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:39:56 INFO - 'tests': ['tp5n']}}, 14:39:56 INFO - 'talos.zip': {'path': '', 14:39:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:39:56 INFO - Running post-action listener: _resource_record_post_action 14:39:56 INFO - [mozharness: 2017-01-31 22:39:56.876287Z] Finished populate-webroot step (success) 14:39:56 INFO - [mozharness: 2017-01-31 22:39:56.876374Z] Running create-virtualenv step. 14:39:56 INFO - Running pre-action listener: _resource_record_pre_action 14:39:56 INFO - Running main action method: create_virtualenv 14:39:56 INFO - Creating virtualenv /builds/slave/test/build/venv 14:39:56 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 14:39:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:39:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:39:56 INFO - Using real prefix '/usr' 14:39:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:39:57 INFO - Installing distribute.............................................................................................................................................................................................done. 14:39:59 INFO - Installing pip.................done. 14:39:59 INFO - Return code: 0 14:39:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:39:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:39:59 INFO - Reading from file tmpfile_stdout 14:39:59 INFO - Output received: 14:39:59 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) 14:39:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d1dc7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1affca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', '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 14:39: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', 'pip>=1.5'] in /builds/slave/test/build 14:39: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 pip>=1.5 14:39:59 INFO - Using env: {'DISPLAY': ':0', 14:39:59 INFO - 'HOME': '/home/cltbld', 14:39:59 INFO - 'LANG': 'en_US.UTF-8', 14:39:59 INFO - 'LANGUAGE': 'en_US:en', 14:39:59 INFO - 'LOGNAME': 'cltbld', 14:39:59 INFO - 'MAIL': '/var/mail/cltbld', 14:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:59 INFO - 'MOZ_NO_REMOTE': '1', 14:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:59 INFO - 'NO_EM_RESTART': '1', 14:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:59 INFO - 'PWD': '/builds/slave/test', 14:39:59 INFO - 'SHELL': '/bin/bash', 14:39:59 INFO - 'SHLVL': '1', 14:39:59 INFO - 'TERM': 'linux', 14:39:59 INFO - 'TMOUT': '86400', 14:39:59 INFO - 'USER': 'cltbld', 14:39:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:59 INFO - '_': '/tools/buildbot/bin/python'} 14:39:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:39:59 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 14:39:59 INFO - Cleaning up... 14:39:59 INFO - Return code: 0 14:39:59 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:39: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')]} 14:39:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:39:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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')]} 14:39:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:39:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:39: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', '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 0x7f8d1dc7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1affca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', '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 14:39: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', 'psutil>=3.1.1'] in /builds/slave/test/build 14:39: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 psutil>=3.1.1 14:39:59 INFO - Using env: {'DISPLAY': ':0', 14:39:59 INFO - 'HOME': '/home/cltbld', 14:39:59 INFO - 'LANG': 'en_US.UTF-8', 14:39:59 INFO - 'LANGUAGE': 'en_US:en', 14:39:59 INFO - 'LOGNAME': 'cltbld', 14:39:59 INFO - 'MAIL': '/var/mail/cltbld', 14:39:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:39:59 INFO - 'MOZ_NO_REMOTE': '1', 14:39:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:39:59 INFO - 'NO_EM_RESTART': '1', 14:39:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:39:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:39:59 INFO - 'PWD': '/builds/slave/test', 14:39:59 INFO - 'SHELL': '/bin/bash', 14:39:59 INFO - 'SHLVL': '1', 14:39:59 INFO - 'TERM': 'linux', 14:39:59 INFO - 'TMOUT': '86400', 14:39:59 INFO - 'USER': 'cltbld', 14:39:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:39:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:39:59 INFO - '_': '/tools/buildbot/bin/python'} 14:40:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:00 INFO - Downloading/unpacking psutil>=3.1.1 14:40:00 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 14:40:00 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 14:40:00 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 14:40:00 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 14:40:00 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 14:40:00 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 14:40:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:40:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:40:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:40:02 INFO - Installing collected packages: psutil 14:40:02 INFO - Running setup.py install for psutil 14:40:02 INFO - building 'psutil._psutil_linux' extension 14:40:02 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 14:40:02 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 14:40:02 INFO - building 'psutil._psutil_posix' extension 14:40:02 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 14:40:02 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 14:40:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:40:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:40:02 INFO - Successfully installed psutil 14:40:02 INFO - Cleaning up... 14:40:02 INFO - Return code: 0 14:40:02 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:40:02 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')]} 14:40:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:02 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')]} 14:40:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:02 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 0x7f8d1dc7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1affca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', '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 14:40:02 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 14:40:02 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 14:40:02 INFO - Using env: {'DISPLAY': ':0', 14:40:02 INFO - 'HOME': '/home/cltbld', 14:40:02 INFO - 'LANG': 'en_US.UTF-8', 14:40:02 INFO - 'LANGUAGE': 'en_US:en', 14:40:02 INFO - 'LOGNAME': 'cltbld', 14:40:02 INFO - 'MAIL': '/var/mail/cltbld', 14:40:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:02 INFO - 'MOZ_NO_REMOTE': '1', 14:40:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:02 INFO - 'NO_EM_RESTART': '1', 14:40:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:02 INFO - 'PWD': '/builds/slave/test', 14:40:02 INFO - 'SHELL': '/bin/bash', 14:40:02 INFO - 'SHLVL': '1', 14:40:02 INFO - 'TERM': 'linux', 14:40:02 INFO - 'TMOUT': '86400', 14:40:02 INFO - 'USER': 'cltbld', 14:40:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:40:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:02 INFO - '_': '/tools/buildbot/bin/python'} 14:40:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:40:02 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 14:40:02 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 14:40:02 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 14:40:02 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 14:40:02 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 14:40:02 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 14:40:04 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:40:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:40:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:40:05 INFO - Installing collected packages: mozsystemmonitor 14:40:05 INFO - Running setup.py install for mozsystemmonitor 14:40:05 INFO - Successfully installed mozsystemmonitor 14:40:05 INFO - Cleaning up... 14:40:05 INFO - Return code: 0 14:40:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:40:05 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')]} 14:40:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:05 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')]} 14:40:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:05 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 0x7f8d1dc7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1affca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', '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 14:40:05 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 14:40:05 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 14:40:05 INFO - Using env: {'DISPLAY': ':0', 14:40:05 INFO - 'HOME': '/home/cltbld', 14:40:05 INFO - 'LANG': 'en_US.UTF-8', 14:40:05 INFO - 'LANGUAGE': 'en_US:en', 14:40:05 INFO - 'LOGNAME': 'cltbld', 14:40:05 INFO - 'MAIL': '/var/mail/cltbld', 14:40:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:05 INFO - 'MOZ_NO_REMOTE': '1', 14:40:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:05 INFO - 'NO_EM_RESTART': '1', 14:40:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:05 INFO - 'PWD': '/builds/slave/test', 14:40:05 INFO - 'SHELL': '/bin/bash', 14:40:05 INFO - 'SHLVL': '1', 14:40:05 INFO - 'TERM': 'linux', 14:40:05 INFO - 'TMOUT': '86400', 14:40:05 INFO - 'USER': 'cltbld', 14:40:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:40:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:05 INFO - '_': '/tools/buildbot/bin/python'} 14:40:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:05 INFO - Downloading/unpacking jsonschema==2.5.1 14:40:05 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 14:40:05 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 14:40:05 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 14:40:05 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 14:40:05 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 14:40:05 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 14:40:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:40:07 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40: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 14:40:07 INFO - Downloading functools32-3.2.3-2.tar.gz 14:40:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:40:07 INFO - warning: no files found matching '*.txt' 14:40:07 INFO - no previously-included directories found matching 'build' 14:40:07 INFO - no previously-included directories found matching 'dist' 14:40:07 INFO - no previously-included directories found matching '.git*' 14:40:07 INFO - Installing collected packages: jsonschema, functools32 14:40:07 INFO - Running setup.py install for functools32 14:40:07 INFO - warning: no files found matching '*.txt' 14:40:07 INFO - no previously-included directories found matching 'build' 14:40:07 INFO - no previously-included directories found matching 'dist' 14:40:07 INFO - no previously-included directories found matching '.git*' 14:40:07 INFO - Successfully installed jsonschema functools32 14:40:07 INFO - Cleaning up... 14:40:07 INFO - Return code: 0 14:40:07 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:40:07 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')]} 14:40:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:07 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')]} 14:40:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:07 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 0x7f8d1dc7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1affca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', '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 14:40:07 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 14:40:07 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 14:40:07 INFO - Using env: {'DISPLAY': ':0', 14:40:07 INFO - 'HOME': '/home/cltbld', 14:40:07 INFO - 'LANG': 'en_US.UTF-8', 14:40:07 INFO - 'LANGUAGE': 'en_US:en', 14:40:07 INFO - 'LOGNAME': 'cltbld', 14:40:07 INFO - 'MAIL': '/var/mail/cltbld', 14:40:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:07 INFO - 'MOZ_NO_REMOTE': '1', 14:40:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:07 INFO - 'NO_EM_RESTART': '1', 14:40:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:07 INFO - 'PWD': '/builds/slave/test', 14:40:07 INFO - 'SHELL': '/bin/bash', 14:40:07 INFO - 'SHLVL': '1', 14:40:07 INFO - 'TERM': 'linux', 14:40:07 INFO - 'TMOUT': '86400', 14:40:07 INFO - 'USER': 'cltbld', 14:40:07 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:40:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:07 INFO - '_': '/tools/buildbot/bin/python'} 14:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:08 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:40:08 INFO - Cleaning up... 14:40:08 INFO - Return code: 0 14:40:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:08 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 0x7f8d1dc7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1affca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', '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 14:40:08 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 14:40:08 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 14:40:08 INFO - Using env: {'DISPLAY': ':0', 14:40:08 INFO - 'HOME': '/home/cltbld', 14:40:08 INFO - 'LANG': 'en_US.UTF-8', 14:40:08 INFO - 'LANGUAGE': 'en_US:en', 14:40:08 INFO - 'LOGNAME': 'cltbld', 14:40:08 INFO - 'MAIL': '/var/mail/cltbld', 14:40:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:08 INFO - 'MOZ_NO_REMOTE': '1', 14:40:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:08 INFO - 'NO_EM_RESTART': '1', 14:40:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:08 INFO - 'PWD': '/builds/slave/test', 14:40:08 INFO - 'SHELL': '/bin/bash', 14:40:08 INFO - 'SHLVL': '1', 14:40:08 INFO - 'TERM': 'linux', 14:40:08 INFO - 'TMOUT': '86400', 14:40:08 INFO - 'USER': 'cltbld', 14:40:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:40:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:08 INFO - '_': '/tools/buildbot/bin/python'} 14:40:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:08 INFO - Downloading/unpacking blobuploader==1.2.4 14:40:08 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 14:40:08 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 14:40:08 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 14:40:08 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 14:40:08 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 14:40:08 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 14:40:10 INFO - Downloading blobuploader-1.2.4.tar.gz 14:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:40:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:40:10 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 14:40:10 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 14:40:10 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 14:40:10 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 14:40:10 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 14:40:10 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 14:40:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:40:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:40:10 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 14:40:10 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 14:40:10 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 14:40:10 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 14:40:10 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 14:40:10 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 14:40:11 INFO - Downloading docopt-0.6.1.tar.gz 14:40:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:40:11 INFO - Installing collected packages: blobuploader, requests, docopt 14:40:11 INFO - Running setup.py install for blobuploader 14:40:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:40:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:40:11 INFO - Running setup.py install for requests 14:40:11 INFO - Running setup.py install for docopt 14:40:11 INFO - Successfully installed blobuploader requests docopt 14:40:11 INFO - Cleaning up... 14:40:11 INFO - Return code: 0 14:40:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:11 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 0x7f8d1dc7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1affca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', '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 14:40:11 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 14:40:11 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 14:40:11 INFO - Using env: {'DISPLAY': ':0', 14:40:11 INFO - 'HOME': '/home/cltbld', 14:40:11 INFO - 'LANG': 'en_US.UTF-8', 14:40:11 INFO - 'LANGUAGE': 'en_US:en', 14:40:11 INFO - 'LOGNAME': 'cltbld', 14:40:11 INFO - 'MAIL': '/var/mail/cltbld', 14:40:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:11 INFO - 'MOZ_NO_REMOTE': '1', 14:40:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:11 INFO - 'NO_EM_RESTART': '1', 14:40:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:11 INFO - 'PWD': '/builds/slave/test', 14:40:11 INFO - 'SHELL': '/bin/bash', 14:40:11 INFO - 'SHLVL': '1', 14:40:11 INFO - 'TERM': 'linux', 14:40:11 INFO - 'TMOUT': '86400', 14:40:11 INFO - 'USER': 'cltbld', 14:40:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:40:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:11 INFO - '_': '/tools/buildbot/bin/python'} 14:40:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:40:12 INFO - Running setup.py (path:/tmp/pip-y4kZRU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:40:12 INFO - Running setup.py (path:/tmp/pip-69da11-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:40:12 INFO - Running setup.py (path:/tmp/pip-wPyvEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:40:12 INFO - Running setup.py (path:/tmp/pip-bO6rvk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:40:12 INFO - Running setup.py (path:/tmp/pip-s_idHm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:40:12 INFO - Running setup.py (path:/tmp/pip-Ydf0oP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:40:12 INFO - Running setup.py (path:/tmp/pip-ce3Vnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:40:12 INFO - Running setup.py (path:/tmp/pip-zXsUFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:40:12 INFO - Running setup.py (path:/tmp/pip-5Uj6bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:40:12 INFO - Running setup.py (path:/tmp/pip-ccYw0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:40:12 INFO - Running setup.py (path:/tmp/pip-rSnJBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:40:12 INFO - Running setup.py (path:/tmp/pip-7C6YLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:40:12 INFO - Running setup.py (path:/tmp/pip-rpwROB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:40:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:40:12 INFO - Running setup.py (path:/tmp/pip-LusvXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:13 INFO - Running setup.py (path:/tmp/pip-YOi8SC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:40:13 INFO - Running setup.py (path:/tmp/pip-jwsBGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:40:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:40:13 INFO - Running setup.py (path:/tmp/pip-_VBtfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:40:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:40:13 INFO - Running setup.py install for manifestparser 14:40:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:40:13 INFO - Running setup.py install for mozcrash 14:40:13 INFO - Running setup.py install for mozdebug 14:40:13 INFO - Running setup.py install for mozdevice 14:40:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:40:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:40:13 INFO - Running setup.py install for mozfile 14:40:13 INFO - Running setup.py install for mozhttpd 14:40:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:40:13 INFO - Running setup.py install for mozinfo 14:40:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:40:13 INFO - Running setup.py install for mozInstall 14:40:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:40:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:40:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:40:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:40:14 INFO - Running setup.py install for mozleak 14:40:14 INFO - Running setup.py install for mozlog 14:40:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:40:14 INFO - Running setup.py install for moznetwork 14:40:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:40:14 INFO - Running setup.py install for mozprocess 14:40:14 INFO - Running setup.py install for mozprofile 14:40:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:40:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:40:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:40:14 INFO - Running setup.py install for mozrunner 14:40:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:40:14 INFO - Running setup.py install for mozscreenshot 14:40:14 INFO - Running setup.py install for moztest 14:40:14 INFO - Running setup.py install for mozversion 14:40:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:40:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:40:15 INFO - Cleaning up... 14:40:15 INFO - Return code: 0 14:40:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40: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')]} 14:40:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40: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')]} 14:40:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:15 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 0x7f8d1dc7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1affca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', '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 14:40:15 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 14:40:15 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 14:40:15 INFO - Using env: {'DISPLAY': ':0', 14:40:15 INFO - 'HOME': '/home/cltbld', 14:40:15 INFO - 'LANG': 'en_US.UTF-8', 14:40:15 INFO - 'LANGUAGE': 'en_US:en', 14:40:15 INFO - 'LOGNAME': 'cltbld', 14:40:15 INFO - 'MAIL': '/var/mail/cltbld', 14:40:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:15 INFO - 'MOZ_NO_REMOTE': '1', 14:40:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:15 INFO - 'NO_EM_RESTART': '1', 14:40:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:15 INFO - 'PWD': '/builds/slave/test', 14:40:15 INFO - 'SHELL': '/bin/bash', 14:40:15 INFO - 'SHLVL': '1', 14:40:15 INFO - 'TERM': 'linux', 14:40:15 INFO - 'TMOUT': '86400', 14:40:15 INFO - 'USER': 'cltbld', 14:40:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:40:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:15 INFO - '_': '/tools/buildbot/bin/python'} 14:40:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:40:15 INFO - Running setup.py (path:/tmp/pip-EMGqp9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:40:15 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)) 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:40:15 INFO - Running setup.py (path:/tmp/pip-I2XLAD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:40:15 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)) 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:40:15 INFO - Running setup.py (path:/tmp/pip-MA722P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:40:15 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)) 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:40:15 INFO - Running setup.py (path:/tmp/pip-9ASCam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:40:15 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)) 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:40:15 INFO - Running setup.py (path:/tmp/pip-qCUnnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:40:15 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)) 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:40:15 INFO - Running setup.py (path:/tmp/pip-UN8cez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:40:15 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)) 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:40:15 INFO - Running setup.py (path:/tmp/pip-VbozxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:40:15 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)) 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:40:15 INFO - Running setup.py (path:/tmp/pip-0kcZR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:40:15 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)) 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:40:15 INFO - Running setup.py (path:/tmp/pip-HnPXUR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:40:15 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)) 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:40:15 INFO - Running setup.py (path:/tmp/pip-XYAZuC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:40:15 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)) 14:40:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:40:15 INFO - Running setup.py (path:/tmp/pip-9nnTaw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:40:16 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)) 14:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:40:16 INFO - Running setup.py (path:/tmp/pip-eXzUYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:40:16 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)) 14:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:40:16 INFO - Running setup.py (path:/tmp/pip-xU7Gax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:40:16 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)) 14:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:40:16 INFO - Running setup.py (path:/tmp/pip-oJZIw4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:40:16 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)) 14:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:16 INFO - Running setup.py (path:/tmp/pip-KhEwOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:40:16 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)) 14:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:40:16 INFO - Running setup.py (path:/tmp/pip-xZtpt8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:40:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 14:40:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:40:16 INFO - Running setup.py (path:/tmp/pip-ICxXdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:40:16 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)) 14:40:16 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)) 14:40:16 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)) 14:40:16 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)) 14:40:16 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)) 14:40:16 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)) 14:40:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 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 14:40:16 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 14:40:18 INFO - Downloading blessings-1.6.tar.gz 14:40:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:40:18 INFO - Installing collected packages: blessings 14:40:18 INFO - Running setup.py install for blessings 14:40:18 INFO - Successfully installed blessings 14:40:18 INFO - Cleaning up... 14:40:18 INFO - Return code: 0 14:40:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:40:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:18 INFO - Reading from file tmpfile_stdout 14:40:18 INFO - Current package versions: 14:40:18 INFO - argparse == 1.2.1 14:40:18 INFO - blessings == 1.6 14:40:18 INFO - blobuploader == 1.2.4 14:40:18 INFO - docopt == 0.6.1 14:40:18 INFO - functools32 == 3.2.3-2 14:40:18 INFO - jsonschema == 2.5.1 14:40:18 INFO - manifestparser == 1.1 14:40:18 INFO - mozInstall == 1.12 14:40:18 INFO - mozcrash == 1.0 14:40:18 INFO - mozdebug == 0.1 14:40:18 INFO - mozdevice == 0.48 14:40:18 INFO - mozfile == 1.2 14:40:18 INFO - mozhttpd == 0.7 14:40:18 INFO - mozinfo == 0.9 14:40:18 INFO - mozleak == 0.1 14:40:18 INFO - mozlog == 3.4 14:40:18 INFO - moznetwork == 0.27 14:40:18 INFO - mozprocess == 0.23 14:40:18 INFO - mozprofile == 0.28 14:40:18 INFO - mozrunner == 6.13 14:40:18 INFO - mozscreenshot == 0.1 14:40:18 INFO - mozsystemmonitor == 0.3 14:40:18 INFO - moztest == 0.8 14:40:18 INFO - mozversion == 1.4 14:40:18 INFO - psutil == 3.1.1 14:40:18 INFO - requests == 1.2.3 14:40:18 INFO - wsgiref == 0.1.2 14:40:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:40:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:40:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:18 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 0x7f8d1dc7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1affca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', '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 14:40:18 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 14:40:18 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 14:40:18 INFO - Using env: {'DISPLAY': ':0', 14:40:18 INFO - 'HOME': '/home/cltbld', 14:40:18 INFO - 'LANG': 'en_US.UTF-8', 14:40:18 INFO - 'LANGUAGE': 'en_US:en', 14:40:18 INFO - 'LOGNAME': 'cltbld', 14:40:18 INFO - 'MAIL': '/var/mail/cltbld', 14:40:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:18 INFO - 'MOZ_NO_REMOTE': '1', 14:40:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:18 INFO - 'NO_EM_RESTART': '1', 14:40:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:18 INFO - 'PWD': '/builds/slave/test', 14:40:18 INFO - 'SHELL': '/bin/bash', 14:40:18 INFO - 'SHLVL': '1', 14:40:18 INFO - 'TERM': 'linux', 14:40:18 INFO - 'TMOUT': '86400', 14:40:18 INFO - 'USER': 'cltbld', 14:40:18 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:40:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:18 INFO - '_': '/tools/buildbot/bin/python'} 14:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:19 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)) 14:40:19 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)) 14:40:19 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)) 14:40:19 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)) 14:40:19 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)) 14:40:19 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)) 14:40:19 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)) 14:40:19 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)) 14:40:19 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)) 14:40:19 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)) 14:40:19 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)) 14:40:19 INFO - Cleaning up... 14:40:19 INFO - Return code: 0 14:40:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:40:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:40:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:40:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:40:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:40:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d1dc7ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1affca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, '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': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', '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 14:40:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:40:19 INFO - Using env: {'DISPLAY': ':0', 14:40:19 INFO - 'HOME': '/home/cltbld', 14:40:19 INFO - 'LANG': 'en_US.UTF-8', 14:40:19 INFO - 'LANGUAGE': 'en_US:en', 14:40:19 INFO - 'LOGNAME': 'cltbld', 14:40:19 INFO - 'MAIL': '/var/mail/cltbld', 14:40:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:19 INFO - 'MOZ_NO_REMOTE': '1', 14:40:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:19 INFO - 'NO_EM_RESTART': '1', 14:40:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:19 INFO - 'PWD': '/builds/slave/test', 14:40:19 INFO - 'SHELL': '/bin/bash', 14:40:19 INFO - 'SHLVL': '1', 14:40:19 INFO - 'TERM': 'linux', 14:40:19 INFO - 'TMOUT': '86400', 14:40:19 INFO - 'USER': 'cltbld', 14:40:19 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:40:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:19 INFO - '_': '/tools/buildbot/bin/python'} 14:40:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:40:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:40:19 INFO - Cleaning up... 14:40:19 INFO - Return code: 0 14:40:19 INFO - Running post-action listener: _resource_record_post_action 14:40:19 INFO - Running post-action listener: _start_resource_monitoring 14:40:19 INFO - Starting resource monitoring. 14:40:19 INFO - [mozharness: 2017-01-31 22:40:19.452596Z] Finished create-virtualenv step (success) 14:40:19 INFO - [mozharness: 2017-01-31 22:40:19.453044Z] Running install step. 14:40:19 INFO - Running pre-action listener: _resource_record_pre_action 14:40:19 INFO - Running main action method: install 14:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:40:19 INFO - Reading from file tmpfile_stdout 14:40:19 INFO - Detecting whether we're running mozinstall >=1.0... 14:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:40:19 INFO - Reading from file tmpfile_stdout 14:40:19 INFO - Output received: 14:40:19 INFO - Usage: mozinstall [options] installer 14:40:19 INFO - Options: 14:40:19 INFO - -h, --help show this help message and exit 14:40:19 INFO - -d DEST, --destination=DEST 14:40:19 INFO - Directory to install application into. [default: 14:40:19 INFO - "/builds/slave/test"] 14:40:19 INFO - --app=APP Application being installed. [default: firefox] 14:40:19 INFO - mkdir: /builds/slave/test/build/application 14:40:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:40:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:40:33 INFO - Reading from file tmpfile_stdout 14:40:33 INFO - Output received: 14:40:33 INFO - /builds/slave/test/build/application/firefox/firefox 14:40:33 INFO - Running post-action listener: _resource_record_post_action 14:40:33 INFO - [mozharness: 2017-01-31 22:40:33.352551Z] Finished install step (success) 14:40:33 INFO - [mozharness: 2017-01-31 22:40:33.352801Z] Running run-tests step. 14:40:33 INFO - Running pre-action listener: _resource_record_pre_action 14:40:33 INFO - Running main action method: run_tests 14:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:40:33 INFO - Python 2.7.3 14:40:33 INFO - Return code: 0 14:40:33 INFO - grabbing minidump binary from tooltool 14:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:40:33 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 0x1afcf60>, '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 0x1afdd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1afe1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:40:33 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 14:40:33 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 14:40:33 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 14:40:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:40:33 INFO - Return code: 0 14:40:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:40:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:40:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:40:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:40:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 14:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --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 14:40:33 INFO - Using env: {'DISPLAY': ':0', 14:40:33 INFO - 'HOME': '/home/cltbld', 14:40:33 INFO - 'LANG': 'en_US.UTF-8', 14:40:33 INFO - 'LANGUAGE': 'en_US:en', 14:40:33 INFO - 'LOGNAME': 'cltbld', 14:40:33 INFO - 'MAIL': '/var/mail/cltbld', 14:40:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:40:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:40:33 INFO - 'MOZ_NO_REMOTE': '1', 14:40:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:40:33 INFO - 'NO_EM_RESTART': '1', 14:40:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:40:33 INFO - 'PWD': '/builds/slave/test', 14:40:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:40:33 INFO - 'SHELL': '/bin/bash', 14:40:33 INFO - 'SHLVL': '1', 14:40:33 INFO - 'TERM': 'linux', 14:40:33 INFO - 'TMOUT': '86400', 14:40:33 INFO - 'USER': 'cltbld', 14:40:33 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537', 14:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:40:33 INFO - '_': '/tools/buildbot/bin/python'} 14:40:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--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 14:40:33 INFO - mozversion application_buildid: 20170131125208 14:40:33 INFO - mozversion application_changeset: c2d975acbc8308d51d39e006f2fb873869fbd488 14:40:33 INFO - mozversion application_display_name: Firefox 14:40:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:40:33 INFO - mozversion application_name: Firefox 14:40:33 INFO - mozversion application_remotingname: firefox 14:40:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 14:40:33 INFO - mozversion application_vendor: Mozilla 14:40:33 INFO - mozversion application_version: 52.0 14:40:33 INFO - mozversion platform_buildid: 20170131125208 14:40:33 INFO - mozversion platform_changeset: c2d975acbc8308d51d39e006f2fb873869fbd488 14:40:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 14:40:33 INFO - mozversion platform_version: 52.0 14:40:33 INFO - using testdate: 1485902433 14:40:33 INFO - actual date: 1485902433 14:40:33 INFO - starting webserver on 'localhost:43822' 14:40:33 INFO - SUITE-START | Running 2 tests 14:40:33 INFO - TEST-START | dromaeo_css 14:40:33 INFO - operating with platform_type : linux_ 14:40:33 INFO - Initialising browser for dromaeo_css test... 14:40:33 INFO - TEST-INFO | started process 2314 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoyvIwP/profile http://localhost:43822/getInfo.html) 14:40:37 INFO - PROCESS | 2314 | __metrics Screen width/height:1600/1200 14:40:37 INFO - PROCESS | 2314 | colorDepth:24 14:40:37 INFO - PROCESS | 2314 | Browser inner width/height: 1024/697 14:40:37 INFO - PROCESS | 2314 | __metrics 14:40:38 INFO - PROCESS | 2314 | 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" 14:40:38 INFO - PROCESS | 2314 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:40:38 INFO - PROCESS | 2314 | console.error: PushService: 14:40:38 INFO - PROCESS | 2314 | stateChangeProcessEnqueue: Error transitioning state 14:40:38 INFO - PROCESS | 2314 | UnknownError 14:40:38 INFO - TEST-INFO | 2314: exit 0 14:40:38 INFO - Browser initialized. 14:40:38 INFO - Running cycle 1/1 for dromaeo_css test... 14:40:38 INFO - TEST-INFO | started process 2478 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoyvIwP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:40:50 INFO - PROCESS | 2478 | RSS: Main: 145432576 14:40:50 INFO - PROCESS | 2478 | 14:43:51 INFO - PROCESS | 2478 | Cycle 1(1): loaded http://localhost:43822/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43822/tests/dromaeo/cssquery-ext.html) 14:43:52 INFO - PROCESS | 2478 | RSS: Main: 254652416 14:43:52 INFO - PROCESS | 2478 | 14:46:55 INFO - PROCESS | 2478 | Cycle 1(1): loaded http://localhost:43822/tests/dromaeo/cssquery-ext.html (next: http://localhost:43822/tests/dromaeo/cssquery-jquery.html) 14:46:55 INFO - PROCESS | 2478 | RSS: Main: 234237952 14:46:55 INFO - PROCESS | 2478 | 14:49:57 INFO - PROCESS | 2478 | Cycle 1(1): loaded http://localhost:43822/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43822/tests/dromaeo/cssquery-mootools.html) 14:49:58 INFO - PROCESS | 2478 | RSS: Main: 174813184 14:49:58 INFO - PROCESS | 2478 | 14:52:59 INFO - PROCESS | 2478 | Cycle 1(1): loaded http://localhost:43822/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43822/tests/dromaeo/cssquery-prototype.html) 14:53:00 INFO - PROCESS | 2478 | RSS: Main: 216985600 14:53:00 INFO - PROCESS | 2478 | 14:56:03 INFO - PROCESS | 2478 | Cycle 1(1): loaded http://localhost:43822/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43822/tests/dromaeo/cssquery-yui.html) 14:56:03 INFO - PROCESS | 2478 | RSS: Main: 178069504 14:56:03 INFO - PROCESS | 2478 | 14:59:05 INFO - PROCESS | 2478 | Cycle 1(1): loaded http://localhost:43822/tests/dromaeo/cssquery-yui.html (next: http://localhost:43822/tests/dromaeo/cssquery-dojo.html) 14:59:06 INFO - PROCESS | 2478 | RSS: Main: 258486272 14:59:06 INFO - PROCESS | 2478 | 14:59:06 INFO - PROCESS | 2478 | __start_tp_report 14:59:06 INFO - PROCESS | 2478 | _x_x_mozilla_page_load 14:59:06 INFO - PROCESS | 2478 | _x_x_mozilla_page_load_details 14:59:06 INFO - PROCESS | 2478 | |i|pagename|runs| 14:59:06 INFO - PROCESS | 2478 | |0;dojo.html;3196.1210667066557;3241.8541165647543;3250.7724459287842;3257.12057744409;3268.8692452301907;5393.1910213468;5479.643823151492;5490.396056433789;5494.038543254925;5516.28288322518;5447.1829225616075;5454.263674403955;5462.399136095037;5480.6437581557175;5486.61593688442;4939.036887806888;4945.357103576548;4966.602671786249;4989.226669866177;4993.325901003373;4836;4981.775820088104;5043.697378157304;5054.3176671149295;5083.720395378253;4838.491958344376;4852.6117910567245;4894.04566109607;4932.309476673251;4979.751012449381;4950.851474455754;4958.578520825752;5032.396112466491;5035.3454050973505;5058.924116138261;4774.474807771142;4956.355673762424;4965.528274813887;4978.228374601942;5011.248312753116;5234.7120908350025;5237.685738855643;5239.738013099368;5247.475252474722;5340.813071542516;5621.297337832771;5631.324241091054;5721.599488035839;5725.227094342252;5744;5612.045952188097;5708.1723150143;5793.478586927196;5793.594448388614;5796.159556864273;5344.358676958751;5456.045192091328;5456.427075157131;5499;5502.697351645618;5954.910676339859;5956.404359564009;5980.790672326448;5981.3719559445635;5996.280446346466;5483.862903427366;5533.584981126432;5744.684042377626;5749.712514374264;5752.194692743019;5646.2377579027125;5733.426657334317;5740.885182296414;5829.417058294137;5838.649681019152;5779.768809247583;5780.682062486603;5786.71066446676;5787.623804452697;5788.392218817048;5454.10007348791;5567.638103523258;5772.278465191851;5783.2192653992015;5815.447532484407;4427.955720442818;4469.7318160910445;4474.530174331713;4509.729416234971;4538.773061346986;4007.5591684914634;4022.6178513041214;4026.053877338823;4039.959600403958;4050.8379664813665;5326.493983071602;5478.835634930959;5492.615516913777;5493.285872836505;5493.890122197534;5679.31848178213;5686.3744988051285;5760.769569217268;5764.135379692996;5812.738426770721;5467.17992301158;5471.972640136773;5474.2609747683555;5476.288082549243;5488.615796894259;4980.05378977993;4984.725840078758;4993.400791904995;4993.425756038029;5025;5717.342505611908;5773.913391299134;5940.049592065248;6057.7879774207695;6070.423309785563;5922.674252916131;5933.139694744152;5933.2880054393745;5941.732622032106;5952.672603006703;6083.9695801522475;6128.356522565066;6147;6147.96926015385;6156.5998210116195;5534.557235421076;5541.168824676331;5556.527695145796;5660.320761508646;5816.04035334182;5828.6502809831545;5838.5621078418435;5840.036393994943;5846;5874.383189765184;5667.943320566742;5673.801416950387;5675.177099320658;5679.9148012779015;5689.118186681071;5411.377691565521;5453.809116680897;5559.944400555943;5634.4365563443325;5670.489655930986;5665.773369065191;5665.915011274752;5671.517920976598;5693.259876216231;5707.286589176353;5691.459311365414;5695.7436915338085;5729.742161602655;5736.368999410145;5740.1963725077685;5347.652402593819;5388.245645609696;5414.945850541444;5566.109422492382;5592.217089607377 14:59:06 INFO - PROCESS | 2478 | |1;ext.html;582.2488989203927;613.7790395457635;644.8935925572282;645.3578689204243;658.8385845467864;34463;45401.318980215285;46513.7674311628;46654.30018549716;46746.76626616866;47799.522004779945;47919.76040119794;48064.038719225595;48376;48397.758011209895;8507.447015943975;9030.277577793777;9175.72472825813;9187.127222913812;9188.632454701803;8685;10699.732506687316;10928.890711092867;10942.945285273563;11230.382328971904;10986;11035.282706624044;11046.834297485544;11058.723531911686;11062.1703372247;10814.513346899408;10841.186910981629;10851.294665846695;10863.565457381736;10870.293430926964;10905.727356816064;10957.671269861918;10972.286801357886;10981.17641176915;10981.17641176915;44714.776426117984;44817.55182448166;44931.775341123415;45023.774881125384;45055.09889802218;3678.558572971234;3695.981520092409;3724.7206459515646;3732.701383889282;3738.420544815558;32830.671693283;32868.6713132868;33046.6695333046;33122.83438582792;33239.33521329584;4250.107477429743;4305.5694430557005;4306.806193721259;4342.34864770287;4396.428464299621;359887;360492;361012;362829;363169;60622;60918;60992.39007609956;61057.389426106056;61090.69454652698;40060.399094013614;40616.39075413871;40950;42910.57089429066;42947;16543.6691266174;16668.33326666944;16671.499855004127;16681.666366672598;16683.749743753855;11015.889841101647;11112.388818614892;12250.44872980718;13184.60446186616;13282.203067815963;19813.10841012129;20971.8951405242;21010.36968890936;21012.68480972756;21068.894655526932;7165.7850264492145;7216.170140433812;7430.256974302634;7496.212897645778;7641.503302285334;951.2342564235719;1040.9687709368732;1043.8068957242933;1070.250824422907;1095.2114477576133;33187;33390;33422.49866252008;33452.3309533808;33461.49807752837;1123.9100871930389;1131.8981291683624;1176.394157009141;1187.5843454790754;1189.0606420927543;17509.38717144894;17614.559636009202;17671.646567068587;17786;17811.910940445476;531788;537317;537672;537846;538753;62467.6876615614;62909.68545157245;62973.68513157497;63097.68451157715;63172.684136579024;1340.2896464873634;1390.061708346862;1395;1443.570864843818;1451.6225781296728;31882;33710.83144584261;34417.48373774345;34614.6154153831;34657;51721.93112275467;52292.47707522876;52298.73850630875;52401;52522.47477525176;400622;404828;405273;407075.7169713297;622176;26897.462050759266;28898.27754306159;29807;29914.850425747733;31073.689263107983;48994.75502622607;49403.7529812363;49604.603157191035;49681.25478117759;50264.748676256386;42376.36435453409;42459.36310955277;42828.35757463578;43239;44024.339634906144;41774.37338439865;41858.58141418547;42394.57605423906;44079.33880991852;44499;41717.37423938583;42630.78684606557;43212.783936080115;43697.126057479305;43730.12539749123;34903.650963491054;37146;37411.6258837419;37918.431223531115;38080;28205.306845551528;28249.201373487995;28310.547899361834;28345.574816377357;28398.574021390108 14:59:06 INFO - PROCESS | 2478 | |2;jquery.html;404.18485250232146;407.27098493696286;411.3849794557137;414.30603738737614;418.8910883170375;14753.48362807302;18455.354062607796;19471.41585752426;20203.292884749055;20252.493687657818;15801.289374087348;17321.653566928653;18634.627307453844;19033.238670453164;19897.701534476993;1933.4779609505424;1934.9322773702922;1935.7289979402894;1936.1190658250462;2115.3019503563864;5769.24999750034;5824.679642619654;5827.1550625159325;5833.125031245326;5838.386969368219;5566.666000039991;5686.601937864351;5741.425857414246;5851.970740146293;5854.238948936632;5706.28671416073;5719.656820590757;5755.079187330028;5759.971200143972;5760.308762948473;5069.543741063322;5117.309163262949;5149.819756308511;5173.689578625257;5176.094183517869;23544.764552354427;24024.399390015216;24344.66104364259;24529.509409811704;24795.876020619962;2372.1697405907967;2474.5669507836055;2572.5883858582724;2694.137875879719;2792.6788419331833;14263.358148883326;14642.560723178321;15019.324130414048;15375;15721.921390393089;1811.1397086383995;1844.3729132095018;1909.9809001909941;1934.3133187718438;1971.8619696621242;80904;81477;82791;83454;84437;10974.286671366335;11032.28290161137;11058.612948546763;11134.16493762971;11312.604058858065;15455.613609659624;15467.84532154664;15478;15521.45674901373;15819.05085694862;7278.235785242473;7389.445791565654;8076.394270429624;8355.498670079814;8398.958005209935;7996.360291176692;8077.151899050515;8099.919000809917;8109.797255068553;8147.307478864244;6759.121314229217;6860.931390686129;6878.793636190922;6921.242233560926;7089.82275443118;1935.7870634230223;1962.3033822992918;1966.4985428715586;1989.3435166395054;2006.3479369205068;974.7027156717128;1005.2561104782554;1022.7187523431116;1052.9789404211872;1090.6400887707039;20088.69866951997;20489.07799149042;20710.896445517676;20782.1687132513;20955;947.1097168661436;1003.9498025098716;1006.5973610555836;1039.875214974208;1070.882202957674;9735.70792876215;10159.799663106098;10188;10190.847137292947;10312.278140530241;354668;356881;357488;485186;489292;61710;62471.375286247465;64344.67827660832;100302.49848750855;104600.47699761605;486.0449217288046;508.97964081437067;510.9182530795055;513.9948600514022;514.1028904561564;11150.776984460103;11244.212905096565;11341.149413793833;11717.882821172021;11969.760604787682;27877.721222788325;43502.34746478868;44416.777916110215;45371;45400.54599453963;50749.49250507448;58237;59262.407375925686;59452.70273648604;60964.695176523834;6099.878002440015;6963.895541566779;8838.469691818511;8971.282297416321;9310.208632266062;12999.41502632365;13520.526781562598;13535.390907409386;13604.251766152956;13761.243131627856;11600.477978491157;11648.650540483799;11674.649760507198;11732.237404568676;12010.159288849696;11469.369184694922;11832.82250766222;11904.642860714192;12012.879871201176;12097.818532722193;11541.192116552096;11658.242214256046;11679.941600291944;11751.941240293743;11848.940755296167;8843.098733772269;9035.50304733246;9105.362624616213;9106.635734570544;9291.163795258459;10301.227407944583;11082.722931926766;11116.44417779124;11384.886151138382;11424.82862757076 14:59:06 INFO - PROCESS | 2478 | |3;mootools.html;1514.9772753408697;1531.5648119490008;1680.4118558504524;1768.5755418699516;1804.521801722543;8104.270615644591;8653.74038778836;8660.74017779466;8660.956695216531;8661.177188167121;7101.680424380902;7370.74202402916;8115.513069215851;8378.07841137476;8380.83238335233;2423.878806059699;2448.5592593333195;2450.301664025753;2452.7056753189554;2452.717937437191;2439.256026911791;2459.9262022139364;2487.3035550045925;2493.5760920643443;2495.9251222463354;2382.9642555361684;2394.724606670229;2413.1192114878118;2416.2388847513066;2418.3712234818986;2386.2721869829693;2394.341556072077;2413.734489206186;2414.7343792182846;2415.649730789026;2399.8680072596;2404.855708657486;2425.0421083672027;2426.211481268595;2427.6237183236626;8414.78963025923;8440.535770532619;8441.57792110392;8470.618822152956;8475;4973.4280557735965;5099.388073431212;5102.056119617882;5102.8518583318455;5106.591472682177;3088.521279201705;3189.8405079746153;3243.5459035735016;3244.4971029490466;3260.7717459777823;1009.1825621246741;1016.9186465082776;1020.3469779341227;1050.6480329089763;1074.4198133008167;11504.942475287653;11570.19008669402;11592.536298548048;11603.129765267639;11621.012213961823;4453.242948698729;4500.234960056799;4627.074585082997;4637.026224492827;4699.295105734099;9729.318947673737;9734.951325243328;9735.561899714388;9737.367071140354;9738.75653108678;5228.398734145546;5232.058229518723;5232.293640358503;5237.292965449692;5239.240310155083;4353.825846966086;4458.6878918475395;4760.262159365235;4828.95171048292;4943.8516844494725;4050.6151915567975;4082.4488694026522;4094.529129150126;4153.397757325171;4198.706090573631;1246.5387806511467;1256.265084925329;1259.6221133659865;1269.7904845700357;1280.180684362009;929.8744669469535;998.0518507417981;1016.8779746430475;1033.2973577967055;1035.5961175141701;5758.539316854642;5850.707464626837;5858.150568167677;6080.75676972925;6197.5351848611535;958.0850287974968;976.2434113562047;995.8008398320364;1018.3584341864578;1021.877374715039;4235.195312890541;4405.9559404405545;4498.482674492409;4518.954810451919;4552.11233809404;10431;10542.841857372145;10578.312409693346;10747.570097196181;10971.286866353661;10462.058414742709;10482.947585262178;10514.474276286155;10525.684229473129;10531.104856087166;7650.693972241159;8016.599170041474;8023.318017968421;8146.14465481116;8153.429259951747;5696.886062278814;5885.735141918538;5938.6436813791315;5949.762009519571;6020.638761674313;9712.125908668253;9717.368371055858;9824.164945979672;9832.115109640166;9837.213022958003;9303.209227215762;9452.007539208284;9481.431114133175;9618.374805637612;9684.32209745311;6703.625756719958;6908.827279318058;7404.777856664308;7618.314351708373;7798.883016754639;8207.95896020516;8397.118302578141;8405.411621186702;8408.83182336362;8409.117042710672;7383.520071195355;7457.179710231761;7517.361024312994;7618.352440042437;7644.694212231449;7216.3505284524645;7237.8914316286355;7239.746608868664;7313;7431.442641801778;6828.2830302819475;6911.343422374866;6922.965385173042;6924.376806087476;6929.480288978246;4847.5394837490385;4946.678465899705;4983.700977941335;4985.626078044089;5038.84883453497;4965.453800081916;5003.599712022957;5128.538431541179;5146.228065790161;5229.320188375486 14:59:06 INFO - PROCESS | 2478 | |4;prototype.html;323.71027930002646;333.8547731736694;334.75562839127434;346.26246095815907;349.36764456334055;5260.842174734764;5334.466553344663;5414.593905457092;5479.287692599962;5483.8080667176655;5215.556677682402;5320.334958130234;5356.9732151339285;5358.169483730018;5362.544183744387;4252.597282535357;4254.212970600433;4261.29688601382;4270.402143699885;4290.785460726951;4174.535135837263;4207.527365422093;4237.406763053175;4256.404103425523;4267.189234045537;4194.601512856274;4206.369044643313;4206.833480757412;4211.536730959592;4219.367094935754;4197.181549597814;4206.936895946548;4210.221109094828;4213.367994800805;4238.118079705799;3735.1409175889426;3747.4940882980995;3753.2681127180213;3756.9104959561696;3804.1821008483307;5046.905534203302;5254.789808407659;5278.445763194848;5301.363836339664;5303.178007408857;4820.156472617278;4826.565609095163;4826.806927722887;4835.202191638376;4838.620993017009;5394;5695.781883236;5701.857453563653;5704;5708.001099807517;3991.6207960243732;4004.1391100913443;4017.317056100441;4019.8543415126546;4032.4556184914954;5840.955665517077;5846.649201047908;5851.143550852782;5872.265966754156;5891.941080589182;4071.1654110907193;4179.91640167195;4180.2795511994345;4183.330667093251;4196.202721482909;4199.160167966419;4209.684273679486;4220.915581688349;4222.387753775747;4228.830846766156;4792.353032340659;4802.783874725646;4803.471618122004;4804.95195048052;4805.831795887128;5470.654041312059;5635.830925072254;5650.434956504317;5659.726561523624;5669;1389.7845833895763;1400.1459109942928;1403.1440821099122;1405.304374334711;1413.1238632048196;933.8179055084329;941.8398872191743;951.2009911674227;961.8121619799542;973.177664873181;5307.8142265021315;5317.388500322435;5319.414864364917;5321.627486075938;5326.378062917176;5647.407022262685;5650.237217975603;5661.207430959669;5668.886622267614;5688.459596338341;5147.794088236504;5266.605004624668;5321.175217841241;5321.8935621287355;5334.466553344712;2993.7247691753987;3001.2346851552716;3001.274267296313;3001.504751715986;3005.218643152796;5756.42435756421;5756.424357564294;5759.884802304015;5793;5819.912701309484;5379.655086228443;5638.887222255532;5649.830505084854;5655.434456554394;5659.405762394889;5769.451902069297;5803.883922321615;5818.418158184232;5837.532997360201;5842.883142337215;5331.573474121983;5363.9731801342305;5490.3411590609385;5637.408072152529;5660.54715622741;5388.622796404214;5456.91814622773;5472.671639701631;5474.781008759605;5520.392756796668;5713.285839270091;5723.284589426322;5733.770649173986;5774.422557744192;5780.132980053026;3983.203359328204;4034.6772258219858;4117.649999750055;4156.168766246823;4172.728772629769;5807.8548036299435;5807.8548036299435;5809.390014048464;5817.9127313091185;5818.679972601548;5527.751251193787;5662.971685141548;5675;5676.347220069745;5678.517326027169;5604.607677462538;5642.605017648725;5651.632643878134;5664.122061080539;5664.801731939362;5587.860303492445;5626.43735626434;5627.352854421794;5633.802816901389;5648.237487939075;5555.88882223565;5606.355269144101;5620.156976453564;5696.857578560403;5726.685032323096;5501.669899806025;5526.336839579276;5540.36285827135;5542.667439953616;5545.611807173459 14:59:06 INFO - PROCESS | 2478 | |5;yui.html;700.5341447937121;756.292866170131;757.6439073635393;765.6631082323773;768.2931702833392;15058.472953446631;15610.453634122809;15648.530544083667;15662.686746265068;15855.365785368585;14491.782623260633;14598.41606335748;14625.561233163022;14635;14653.120812751242;738.1695592458484;756.2853103816896;839.8740188971642;864.6973559254258;872.6945569050845;869.326272139091;875.9737207883774;877.5085951866943;878.2841983783228;878.6221924572432;936.8641546975684;936.9578368973413;937.3391758810022;937.5499760115149;938.4088024544561;936.5551363102505;937.4703292639637;937.9062093790601;938.8075444533922;938.816930698514;681.5297444763098;683.7504310926525;684.0320945861649;684.9143857017873;686.4062585863243;14722;14846.925765371105;14855.48005819791;14857.777133343008;15574.610634734108;11983.520659173622;13193.86806131936;13847.192022193876;14206.928965355108;14277.357518911675;11133.665990020312;11511.251768635011;11613.3612651305;11849.644510664693;11953.701157471045;4165;4172.290710579209;4176.4570605821355;4195.958040419618;4350.499692535367;49334.7533262335;51575.484245157444;60405.395946040415;60513.39486605122;61031.694841525954;9647.517624118766;9765.804683906283;9851.16265117473;9867.259955503367;9956.253281003954;21069.57860842805;21204;21205.469863253544;21228.363149105553;21482.89258553697;7506.28690274423;7562.0925488941675;7659.693612255559;7670.96164519185;8096.311813495919;4414.580614841585;4506.59440650343;4561.087782443525;4590.88522786933;4797.544233297831;3406.8466918988706;3484.494748261488;3503.667151620592;3511.122219445139;3533.258015816656;587.5241054745584;589.286962775047;593.1666009257001;596.8000719758929;599.3646734461485;625.1935003844989;680.7617333933084;688.8691148681735;703.3739971425435;711.5695004522292;8859.335549833659;9007.459552426875;9048.049954754788;9142.542872856331;9683.370580912218;629.2637613991641;632.4213344789558;638.3712043637014;641.3169973977699;699.7201119552118;4431.689781715249;4458.353538736865;4493.932591011137;4578.5650363215445;4637.327587499861;93371;94140.52929735307;94490.52754736182;96208.51895740477;98492;79217.60391198007;81200.59399702963;84018;86530.56734716285;87782;61842.38157618366;72721;74061;74808;75373.24626753663;8573.399862009599;8727.127287271222;8834.469931804113;9145.176934075966;9169.724908252763;51825.999999998494;52277.7386113067;52286.73856630692;52510.47489525056;52705.472945270056;66524.33475665182;67905.66047169732;69600.65199674171;69997.30002699907;71851;12516.687082823002;13092.672683182616;13106.934465327613;13108.803367949298;13139.211647301192;12617.116801823784;12632.6841828955;12655.240685558896;12844.807327889903;12917.483300667867;10820;11137;11407.372594507382;11524.94237528807;11838.230515016496;12035.819462707892;12085.093617978511;12209.511619535118;12245.877541224474;12276.938615306866;11877.940610296893;11929.28424294545;12021.639350819489;12077.973372263456;12150.513979440724;9735.489895484268;9863.605455781688;9988.400695958266;9994.900050999397;10537.367757934548;8882.40554326042;9779.902200977898;9877.950610246902;9917.900820991987;9969.551370188505 14:59:06 INFO - PROCESS | 2478 | __end_tp_report 14:59:06 INFO - PROCESS | 2478 | __start_cc_report 14:59:06 INFO - PROCESS | 2478 | _x_x_mozilla_cycle_collect,1048 14:59:06 INFO - PROCESS | 2478 | __end_cc_report 14:59:06 INFO - PROCESS | 2478 | __startTimestamp1485903546205__endTimestamp 14:59:06 INFO - PROCESS | 2478 | 14:59:06 INFO - PROCESS | 2478 | ------- Summary: start ------- 14:59:06 INFO - PROCESS | 2478 | Number of tests: 6 14:59:06 INFO - PROCESS | 2478 | 14:59:06 INFO - PROCESS | 2478 | [#0] dojo.html Cycles:165 Average:5384.80 Median:5533.58 stddev:588.29 (10.6%) stddev-sans-first:564.48 14:59:06 INFO - PROCESS | 2478 | Values: 3196.1 3241.9 3250.8 3257.1 3268.9 5393.2 5479.6 5490.4 5494.0 5516.3 5447.2 5454.3 5462.4 5480.6 5486.6 4939.0 4945.4 4966.6 4989.2 4993.3 4836.0 4981.8 5043.7 5054.3 5083.7 4838.5 4852.6 4894.0 4932.3 4979.8 4950.9 4958.6 5032.4 5035.3 5058.9 4774.5 4956.4 4965.5 4978.2 5011.2 5234.7 5237.7 5239.7 5247.5 5340.8 5621.3 5631.3 5721.6 5725.2 5744.0 5612.0 5708.2 5793.5 5793.6 5796.2 5344.4 5456.0 5456.4 5499.0 5502.7 5954.9 5956.4 5980.8 5981.4 5996.3 5483.9 5533.6 5744.7 5749.7 5752.2 5646.2 5733.4 5740.9 5829.4 5838.6 5779.8 5780.7 5786.7 5787.6 5788.4 5454.1 5567.6 5772.3 5783.2 5815.4 4428.0 4469.7 4474.5 4509.7 4538.8 4007.6 4022.6 4026.1 4040.0 4050.8 5326.5 5478.8 5492.6 5493.3 5493.9 5679.3 5686.4 5760.8 5764.1 5812.7 5467.2 5472.0 5474.3 5476.3 5488.6 4980.1 4984.7 4993.4 4993.4 5025.0 5717.3 5773.9 5940.0 6057.8 6070.4 5922.7 5933.1 5933.3 5941.7 5952.7 6084.0 6128.4 6147.0 6148.0 6156.6 5534.6 5541.2 5556.5 5660.3 5816.0 5828.7 5838.6 5840.0 5846.0 5874.4 5667.9 5673.8 5675.2 5679.9 5689.1 5411.4 5453.8 5559.9 5634.4 5670.5 5665.8 5665.9 5671.5 5693.3 5707.3 5691.5 5695.7 5729.7 5736.4 5740.2 5347.7 5388.2 5414.9 5566.1 5592.2 14:59:06 INFO - PROCESS | 2478 | 14:59:06 INFO - PROCESS | 2478 | [#1] ext.html Cycles:180 Average:61485.79 Median:20575.02 stddev:121156.47 (588.9%) stddev-sans-first:121410.05 14:59:06 INFO - PROCESS | 2478 | Values: 582.2 613.8 644.9 645.4 658.8 34463.0 45401.3 46513.8 46654.3 46746.8 47799.5 47919.8 48064.0 48376.0 48397.8 8507.4 9030.3 9175.7 9187.1 9188.6 8685.0 10699.7 10928.9 10942.9 11230.4 10986.0 11035.3 11046.8 11058.7 11062.2 10814.5 10841.2 10851.3 10863.6 10870.3 10905.7 10957.7 10972.3 10981.2 10981.2 44714.8 44817.6 44931.8 45023.8 45055.1 3678.6 3696.0 3724.7 3732.7 3738.4 32830.7 32868.7 33046.7 33122.8 33239.3 4250.1 4305.6 4306.8 4342.3 4396.4 359887.0 360492.0 361012.0 362829.0 363169.0 60622.0 60918.0 60992.4 61057.4 61090.7 40060.4 40616.4 40950.0 42910.6 42947.0 16543.7 16668.3 16671.5 16681.7 16683.7 11015.9 11112.4 12250.4 13184.6 13282.2 19813.1 20971.9 21010.4 21012.7 21068.9 7165.8 7216.2 7430.3 7496.2 7641.5 951.2 1041.0 1043.8 1070.3 1095.2 33187.0 33390.0 33422.5 33452.3 33461.5 1123.9 1131.9 1176.4 1187.6 1189.1 17509.4 17614.6 17671.6 17786.0 17811.9 531788.0 537317.0 537672.0 537846.0 538753.0 62467.7 62909.7 62973.7 63097.7 63172.7 1340.3 1390.1 1395.0 1443.6 1451.6 31882.0 33710.8 34417.5 34614.6 34657.0 51721.9 52292.5 52298.7 52401.0 52522.5 400622.0 404828.0 405273.0 407075.7 622176.0 26897.5 28898.3 29807.0 29914.9 31073.7 48994.8 49403.8 49604.6 49681.3 50264.7 42376.4 42459.4 42828.4 43239.0 44024.3 41774.4 41858.6 42394.6 44079.3 44499.0 41717.4 42630.8 43212.8 43697.1 43730.1 34903.7 37146.0 37411.6 37918.4 38080.0 28205.3 28249.2 28310.5 28345.6 28398.6 14:59:06 INFO - PROCESS | 2478 | 14:59:06 INFO - PROCESS | 2478 | [#2] jquery.html Cycles:180 Average:26321.65 Median:13198.28 stddev:68588.51 (519.7%) stddev-sans-first:68753.31 14:59:06 INFO - PROCESS | 2478 | Values: 404.2 407.3 411.4 414.3 418.9 14753.5 18455.4 19471.4 20203.3 20252.5 15801.3 17321.7 18634.6 19033.2 19897.7 1933.5 1934.9 1935.7 1936.1 2115.3 5769.2 5824.7 5827.2 5833.1 5838.4 5566.7 5686.6 5741.4 5852.0 5854.2 5706.3 5719.7 5755.1 5760.0 5760.3 5069.5 5117.3 5149.8 5173.7 5176.1 23544.8 24024.4 24344.7 24529.5 24795.9 2372.2 2474.6 2572.6 2694.1 2792.7 14263.4 14642.6 15019.3 15375.0 15721.9 1811.1 1844.4 1910.0 1934.3 1971.9 80904.0 81477.0 82791.0 83454.0 84437.0 10974.3 11032.3 11058.6 11134.2 11312.6 15455.6 15467.8 15478.0 15521.5 15819.1 7278.2 7389.4 8076.4 8355.5 8399.0 7996.4 8077.2 8099.9 8109.8 8147.3 6759.1 6860.9 6878.8 6921.2 7089.8 1935.8 1962.3 1966.5 1989.3 2006.3 974.7 1005.3 1022.7 1053.0 1090.6 20088.7 20489.1 20710.9 20782.2 20955.0 947.1 1003.9 1006.6 1039.9 1070.9 9735.7 10159.8 10188.0 10190.8 10312.3 354668.0 356881.0 357488.0 485186.0 489292.0 61710.0 62471.4 64344.7 100302.5 104600.5 486.0 509.0 510.9 514.0 514.1 11150.8 11244.2 11341.1 11717.9 11969.8 27877.7 43502.3 44416.8 45371.0 45400.5 50749.5 58237.0 59262.4 59452.7 60964.7 6099.9 6963.9 8838.5 8971.3 9310.2 12999.4 13520.5 13535.4 13604.3 13761.2 11600.5 11648.7 11674.6 11732.2 12010.2 11469.4 11832.8 11904.6 12012.9 12097.8 11541.2 11658.2 11679.9 11751.9 11848.9 8843.1 9035.5 9105.4 9106.6 9291.2 10301.2 11082.7 11116.4 11384.9 11424.8 14:59:06 INFO - PROCESS | 2478 | 14:59:06 INFO - PROCESS | 2478 | [#3] mootools.html Cycles:180 Average:5647.94 Median:4994.61 stddev:3093.55 (61.9%) stddev-sans-first:3086.64 14:59:06 INFO - PROCESS | 2478 | Values: 1515.0 1531.6 1680.4 1768.6 1804.5 8104.3 8653.7 8660.7 8661.0 8661.2 7101.7 7370.7 8115.5 8378.1 8380.8 2423.9 2448.6 2450.3 2452.7 2452.7 2439.3 2459.9 2487.3 2493.6 2495.9 2383.0 2394.7 2413.1 2416.2 2418.4 2386.3 2394.3 2413.7 2414.7 2415.6 2399.9 2404.9 2425.0 2426.2 2427.6 8414.8 8440.5 8441.6 8470.6 8475.0 4973.4 5099.4 5102.1 5102.9 5106.6 3088.5 3189.8 3243.5 3244.5 3260.8 1009.2 1016.9 1020.3 1050.6 1074.4 11504.9 11570.2 11592.5 11603.1 11621.0 4453.2 4500.2 4627.1 4637.0 4699.3 9729.3 9735.0 9735.6 9737.4 9738.8 5228.4 5232.1 5232.3 5237.3 5239.2 4353.8 4458.7 4760.3 4829.0 4943.9 4050.6 4082.4 4094.5 4153.4 4198.7 1246.5 1256.3 1259.6 1269.8 1280.2 929.9 998.1 1016.9 1033.3 1035.6 5758.5 5850.7 5858.2 6080.8 6197.5 958.1 976.2 995.8 1018.4 1021.9 4235.2 4406.0 4498.5 4519.0 4552.1 10431.0 10542.8 10578.3 10747.6 10971.3 10462.1 10482.9 10514.5 10525.7 10531.1 7650.7 8016.6 8023.3 8146.1 8153.4 5696.9 5885.7 5938.6 5949.8 6020.6 9712.1 9717.4 9824.2 9832.1 9837.2 9303.2 9452.0 9481.4 9618.4 9684.3 6703.6 6908.8 7404.8 7618.3 7798.9 8208.0 8397.1 8405.4 8408.8 8409.1 7383.5 7457.2 7517.4 7618.4 7644.7 7216.4 7237.9 7239.7 7313.0 7431.4 6828.3 6911.3 6923.0 6924.4 6929.5 4847.5 4946.7 4983.7 4985.6 5038.8 4965.5 5003.6 5128.5 5146.2 5229.3 14:59:06 INFO - PROCESS | 2478 | 14:59:06 INFO - PROCESS | 2478 | [#4] prototype.html Cycles:180 Average:4711.34 Median:5357.57 stddev:1367.46 (25.5%) stddev-sans-first:1331.05 14:59:06 INFO - PROCESS | 2478 | Values: 323.7 333.9 334.8 346.3 349.4 5260.8 5334.5 5414.6 5479.3 5483.8 5215.6 5320.3 5357.0 5358.2 5362.5 4252.6 4254.2 4261.3 4270.4 4290.8 4174.5 4207.5 4237.4 4256.4 4267.2 4194.6 4206.4 4206.8 4211.5 4219.4 4197.2 4206.9 4210.2 4213.4 4238.1 3735.1 3747.5 3753.3 3756.9 3804.2 5046.9 5254.8 5278.4 5301.4 5303.2 4820.2 4826.6 4826.8 4835.2 4838.6 5394.0 5695.8 5701.9 5704.0 5708.0 3991.6 4004.1 4017.3 4019.9 4032.5 5841.0 5846.6 5851.1 5872.3 5891.9 4071.2 4179.9 4180.3 4183.3 4196.2 4199.2 4209.7 4220.9 4222.4 4228.8 4792.4 4802.8 4803.5 4805.0 4805.8 5470.7 5635.8 5650.4 5659.7 5669.0 1389.8 1400.1 1403.1 1405.3 1413.1 933.8 941.8 951.2 961.8 973.2 5307.8 5317.4 5319.4 5321.6 5326.4 5647.4 5650.2 5661.2 5668.9 5688.5 5147.8 5266.6 5321.2 5321.9 5334.5 2993.7 3001.2 3001.3 3001.5 3005.2 5756.4 5756.4 5759.9 5793.0 5819.9 5379.7 5638.9 5649.8 5655.4 5659.4 5769.5 5803.9 5818.4 5837.5 5842.9 5331.6 5364.0 5490.3 5637.4 5660.5 5388.6 5456.9 5472.7 5474.8 5520.4 5713.3 5723.3 5733.8 5774.4 5780.1 3983.2 4034.7 4117.6 4156.2 4172.7 5807.9 5807.9 5809.4 5817.9 5818.7 5527.8 5663.0 5675.0 5676.3 5678.5 5604.6 5642.6 5651.6 5664.1 5664.8 5587.9 5626.4 5627.4 5633.8 5648.2 5555.9 5606.4 5620.2 5696.9 5726.7 5501.7 5526.3 5540.4 5542.7 5545.6 14:59:06 INFO - PROCESS | 2478 | 14:59:06 INFO - PROCESS | 2478 | [#5] yui.html Cycles:180 Average:18351.31 Median:61437.04 stddev:25187.46 (41.0%) stddev-sans-first:25223.25 14:59:06 INFO - PROCESS | 2478 | Values: 700.5 756.3 757.6 765.7 768.3 15058.5 15610.5 15648.5 15662.7 15855.4 14491.8 14598.4 14625.6 14635.0 14653.1 738.2 756.3 839.9 864.7 872.7 869.3 876.0 877.5 878.3 878.6 936.9 937.0 937.3 937.5 938.4 936.6 937.5 937.9 938.8 938.8 681.5 683.8 684.0 684.9 686.4 14722.0 14846.9 14855.5 14857.8 15574.6 11983.5 13193.9 13847.2 14206.9 14277.4 11133.7 11511.3 11613.4 11849.6 11953.7 4165.0 4172.3 4176.5 4196.0 4350.5 49334.8 51575.5 60405.4 60513.4 61031.7 9647.5 9765.8 9851.2 9867.3 9956.3 21069.6 21204.0 21205.5 21228.4 21482.9 7506.3 7562.1 7659.7 7671.0 8096.3 4414.6 4506.6 4561.1 4590.9 4797.5 3406.8 3484.5 3503.7 3511.1 3533.3 587.5 589.3 593.2 596.8 599.4 625.2 680.8 688.9 703.4 711.6 8859.3 9007.5 9048.0 9142.5 9683.4 629.3 632.4 638.4 641.3 699.7 4431.7 4458.4 4493.9 4578.6 4637.3 93371.0 94140.5 94490.5 96208.5 98492.0 79217.6 81200.6 84018.0 86530.6 87782.0 61842.4 72721.0 74061.0 74808.0 75373.2 8573.4 8727.1 8834.5 9145.2 9169.7 51826.0 52277.7 52286.7 52510.5 52705.5 66524.3 67905.7 69600.7 69997.3 71851.0 12516.7 13092.7 13106.9 13108.8 13139.2 12617.1 12632.7 12655.2 12844.8 12917.5 10820.0 11137.0 11407.4 11524.9 11838.2 12035.8 12085.1 12209.5 12245.9 12276.9 11877.9 11929.3 12021.6 12078.0 12150.5 9735.5 9863.6 9988.4 9994.9 10537.4 8882.4 9779.9 9878.0 9917.9 9969.6 14:59:06 INFO - PROCESS | 2478 | -------- Summary: end -------- 14:59:06 INFO - PROCESS | 2478 | 14:59:06 INFO - TEST-INFO | 2478: exit 0 14:59:06 INFO - TEST-OK | dromaeo_css | took 1113300ms 14:59:06 INFO - TEST-START | kraken 14:59:06 INFO - operating with platform_type : linux_ 14:59:06 INFO - Initialising browser for kraken test... 14:59:06 INFO - TEST-INFO | started process 2880 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaGPtrA/profile http://localhost:43822/getInfo.html) 14:59:10 INFO - PROCESS | 2880 | __metrics Screen width/height:1600/1200 14:59:10 INFO - PROCESS | 2880 | colorDepth:24 14:59:10 INFO - PROCESS | 2880 | Browser inner width/height: 1024/697 14:59:10 INFO - PROCESS | 2880 | __metrics 14:59:11 INFO - PROCESS | 2880 | 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" 14:59:11 INFO - PROCESS | 2880 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:59:11 INFO - PROCESS | 2880 | console.error: PushService: 14:59:11 INFO - PROCESS | 2880 | stateChangeProcessEnqueue: Error transitioning state 14:59:11 INFO - PROCESS | 2880 | UnknownError 14:59:12 INFO - TEST-INFO | 2880: exit 0 14:59:12 INFO - Browser initialized. 14:59:12 INFO - Running cycle 1/1 for kraken test... 14:59:12 INFO - TEST-INFO | started process 2988 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaGPtrA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:24 INFO - PROCESS | 2988 | RSS: Main: 141975552 14:59:24 INFO - PROCESS | 2988 | 14:59:26 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43822/tests/kraken/driver.html?testName=audio-beat-detection) 14:59:27 INFO - PROCESS | 2988 | RSS: Main: 183799808 14:59:27 INFO - PROCESS | 2988 | 14:59:29 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43822/tests/kraken/driver.html?testName=audio-dft) 14:59:30 INFO - PROCESS | 2988 | RSS: Main: 172945408 14:59:30 INFO - PROCESS | 2988 | 14:59:33 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43822/tests/kraken/driver.html?testName=audio-fft) 14:59:33 INFO - PROCESS | 2988 | RSS: Main: 264945664 14:59:33 INFO - PROCESS | 2988 | 14:59:36 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43822/tests/kraken/driver.html?testName=audio-oscillator) 14:59:36 INFO - PROCESS | 2988 | RSS: Main: 171192320 14:59:36 INFO - PROCESS | 2988 | 14:59:38 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43822/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:59:39 INFO - PROCESS | 2988 | RSS: Main: 173596672 14:59:39 INFO - PROCESS | 2988 | 14:59:42 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43822/tests/kraken/driver.html?testName=imaging-darkroom) 14:59:42 INFO - PROCESS | 2988 | RSS: Main: 212865024 14:59:42 INFO - PROCESS | 2988 | 14:59:46 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43822/tests/kraken/driver.html?testName=imaging-desaturate) 14:59:46 INFO - PROCESS | 2988 | RSS: Main: 211161088 14:59:46 INFO - PROCESS | 2988 | 14:59:49 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43822/tests/kraken/driver.html?testName=json-parse-financial) 14:59:49 INFO - PROCESS | 2988 | RSS: Main: 209895424 14:59:49 INFO - PROCESS | 2988 | 14:59:51 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43822/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:59:52 INFO - PROCESS | 2988 | RSS: Main: 171753472 14:59:52 INFO - PROCESS | 2988 | 14:59:53 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43822/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:59:54 INFO - PROCESS | 2988 | RSS: Main: 179122176 14:59:54 INFO - PROCESS | 2988 | 14:59:56 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43822/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:59:56 INFO - PROCESS | 2988 | RSS: Main: 188317696 14:59:56 INFO - PROCESS | 2988 | 14:59:59 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:00:00 INFO - PROCESS | 2988 | RSS: Main: 196673536 15:00:00 INFO - PROCESS | 2988 | 15:00:02 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:00:03 INFO - PROCESS | 2988 | RSS: Main: 192688128 15:00:03 INFO - PROCESS | 2988 | 15:00:04 INFO - PROCESS | 2988 | Cycle 1(1): loaded http://localhost:43822/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43822/tests/kraken/driver.html?testName=ai-astar) 15:00:05 INFO - PROCESS | 2988 | RSS: Main: 244285440 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | __start_tp_report 15:00:05 INFO - PROCESS | 2988 | _x_x_mozilla_page_load 15:00:05 INFO - PROCESS | 2988 | _x_x_mozilla_page_load_details 15:00:05 INFO - PROCESS | 2988 | |i|pagename|runs| 15:00:05 INFO - PROCESS | 2988 | |0;ai-astar;101;111;110;111;113;110;112;110;111;112 15:00:05 INFO - PROCESS | 2988 | |1;audio-beat-detection;155;115;118;151;120;118;116;117;158;117 15:00:05 INFO - PROCESS | 2988 | |2;audio-dft;160;160;161;161;159;161;159;159;161;160 15:00:05 INFO - PROCESS | 2988 | |3;audio-fft;78;74;74;103;76;74;74;75;102;74 15:00:05 INFO - PROCESS | 2988 | |4;audio-oscillator;81;81;120;83;81;80;105;81;80;117 15:00:05 INFO - PROCESS | 2988 | |5;imaging-gaussian-blur;117;117;117;117;116;116;117;117;117;117 15:00:05 INFO - PROCESS | 2988 | |6;imaging-darkroom;146;146;145;145;146;147;145;146;146;147 15:00:05 INFO - PROCESS | 2988 | |7;imaging-desaturate;84;85;84;84;85;85;84;85;84;85 15:00:05 INFO - PROCESS | 2988 | |8;json-parse-financial;50;50;50;50;50;50;49;50;49;49 15:00:05 INFO - PROCESS | 2988 | |9;json-stringify-tinderbox;58;58;57;57;58;58;58;58;59;57 15:00:05 INFO - PROCESS | 2988 | |10;stanford-crypto-aes;76;74;75;75;74;81;75;78;74;77 15:00:05 INFO - PROCESS | 2988 | |11;stanford-crypto-ccm;122;131;130;123;128;121;121;125;161;121 15:00:05 INFO - PROCESS | 2988 | |12;stanford-crypto-pbkdf2;172;157;158;159;156;160;156;154;157;162 15:00:05 INFO - PROCESS | 2988 | |13;stanford-crypto-sha256-iterative;62;64;63;65;62;62;63;63;63;61 15:00:05 INFO - PROCESS | 2988 | __end_tp_report 15:00:05 INFO - PROCESS | 2988 | __start_cc_report 15:00:05 INFO - PROCESS | 2988 | _x_x_mozilla_cycle_collect,1567 15:00:05 INFO - PROCESS | 2988 | __end_cc_report 15:00:05 INFO - PROCESS | 2988 | __startTimestamp1485903605235__endTimestamp 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | ------- Summary: start ------- 15:00:05 INFO - PROCESS | 2988 | Number of tests: 14 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:3.35 (3.0%) stddev-sans-first:1.05 15:00:05 INFO - PROCESS | 2988 | Values: 101.0 111.0 110.0 111.0 113.0 110.0 112.0 110.0 111.0 112.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:119.00 stddev:18.18 (15.3%) stddev-sans-first:16.56 15:00:05 INFO - PROCESS | 2988 | Values: 155.0 115.0 118.0 151.0 120.0 118.0 116.0 117.0 158.0 117.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#2] audio-dft Cycles:10 Average:160.10 Median:160.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 15:00:05 INFO - PROCESS | 2988 | Values: 160.0 160.0 161.0 161.0 159.0 161.0 159.0 159.0 161.0 160.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#3] audio-fft Cycles:10 Average:80.40 Median:74.00 stddev:11.72 (15.8%) stddev-sans-first:12.40 15:00:05 INFO - PROCESS | 2988 | Values: 78.0 74.0 74.0 103.0 76.0 74.0 74.0 75.0 102.0 74.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:81.00 stddev:16.39 (20.2%) stddev-sans-first:16.99 15:00:05 INFO - PROCESS | 2988 | Values: 81.0 81.0 120.0 83.0 81.0 80.0 105.0 81.0 80.0 117.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:00:05 INFO - PROCESS | 2988 | Values: 117.0 117.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 15:00:05 INFO - PROCESS | 2988 | Values: 146.0 146.0 145.0 145.0 146.0 147.0 145.0 146.0 146.0 147.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 15:00:05 INFO - PROCESS | 2988 | Values: 84.0 85.0 84.0 84.0 85.0 85.0 84.0 85.0 84.0 85.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#8] json-parse-financial Cycles:10 Average:49.70 Median:50.00 stddev:0.48 (1.0%) stddev-sans-first:0.50 15:00:05 INFO - PROCESS | 2988 | Values: 50.0 50.0 50.0 50.0 50.0 50.0 49.0 50.0 49.0 49.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#9] json-stringify-tinderbox Cycles:10 Average:57.80 Median:58.00 stddev:0.63 (1.1%) stddev-sans-first:0.67 15:00:05 INFO - PROCESS | 2988 | Values: 58.0 58.0 57.0 57.0 58.0 58.0 58.0 58.0 59.0 57.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#10] stanford-crypto-aes Cycles:10 Average:75.90 Median:75.50 stddev:2.23 (3.0%) stddev-sans-first:2.37 15:00:05 INFO - PROCESS | 2988 | Values: 76.0 74.0 75.0 75.0 74.0 81.0 75.0 78.0 74.0 77.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:126.50 stddev:12.10 (9.6%) stddev-sans-first:12.62 15:00:05 INFO - PROCESS | 2988 | Values: 122.0 131.0 130.0 123.0 128.0 121.0 121.0 125.0 161.0 121.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:158.50 stddev:5.07 (3.2%) stddev-sans-first:2.40 15:00:05 INFO - PROCESS | 2988 | Values: 172.0 157.0 158.0 159.0 156.0 160.0 156.0 154.0 157.0 162.0 15:00:05 INFO - PROCESS | 2988 | 15:00:05 INFO - PROCESS | 2988 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.17 15:00:05 INFO - PROCESS | 2988 | Values: 62.0 64.0 63.0 65.0 62.0 62.0 63.0 63.0 63.0 61.0 15:00:05 INFO - PROCESS | 2988 | -------- Summary: end -------- 15:00:05 INFO - PROCESS | 2988 | 15:00:06 INFO - TEST-INFO | 2988: exit 0 15:00:06 INFO - TEST-OK | kraken | took 59304ms 15:00:06 INFO - SUITE-END | took 1172s 15:00:06 INFO - Completed test suite (00:19:32) 15:00:06 INFO - javascript benchmark 15:00:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3196.1210667066557, 3241.8541165647543, 3250.7724459287842, 3257.12057744409, 3268.8692452301907, 5393.1910213468, 5479.643823151492, 5490.396056433789, 5494.038543254925, 5516.28288322518, 5447.1829225616075, 5454.263674403955, 5462.399136095037, 5480.6437581557175, 5486.61593688442, 4939.036887806888, 4945.357103576548, 4966.602671786249, 4989.226669866177, 4993.325901003373, 4836.0, 4981.775820088104, 5043.697378157304, 5054.3176671149295, 5083.720395378253, 4838.491958344376, 4852.6117910567245, 4894.04566109607, 4932.309476673251, 4979.751012449381, 4950.851474455754, 4958.578520825752, 5032.396112466491, 5035.3454050973505, 5058.924116138261, 4774.474807771142, 4956.355673762424, 4965.528274813887, 4978.228374601942, 5011.248312753116, 5234.7120908350025, 5237.685738855643, 5239.738013099368, 5247.475252474722, 5340.813071542516, 5621.297337832771, 5631.324241091054, 5721.599488035839, 5725.227094342252, 5744.0, 5612.045952188097, 5708.1723150143, 5793.478586927196, 5793.594448388614, 5796.159556864273, 5344.358676958751, 5456.045192091328, 5456.427075157131, 5499.0, 5502.697351645618, 5954.910676339859, 5956.404359564009, 5980.790672326448, 5981.3719559445635, 5996.280446346466, 5483.862903427366, 5533.584981126432, 5744.684042377626, 5749.712514374264, 5752.194692743019, 5646.2377579027125, 5733.426657334317, 5740.885182296414, 5829.417058294137, 5838.649681019152, 5779.768809247583, 5780.682062486603, 5786.71066446676, 5787.623804452697, 5788.392218817048, 5454.10007348791, 5567.638103523258, 5772.278465191851, 5783.2192653992015, 5815.447532484407, 4427.955720442818, 4469.7318160910445, 4474.530174331713, 4509.729416234971, 4538.773061346986, 4007.5591684914634, 4022.6178513041214, 4026.053877338823, 4039.959600403958, 4050.8379664813665, 5326.493983071602, 5478.835634930959, 5492.615516913777, 5493.285872836505, 5493.890122197534, 5679.31848178213, 5686.3744988051285, 5760.769569217268, 5764.135379692996, 5812.738426770721, 5467.17992301158, 5471.972640136773, 5474.2609747683555, 5476.288082549243, 5488.615796894259, 4980.05378977993, 4984.725840078758, 4993.400791904995, 4993.425756038029, 5025.0, 5717.342505611908, 5773.913391299134, 5940.049592065248, 6057.7879774207695, 6070.423309785563, 5922.674252916131, 5933.139694744152, 5933.2880054393745, 5941.732622032106, 5952.672603006703, 6083.9695801522475, 6128.356522565066, 6147.0, 6147.96926015385, 6156.5998210116195, 5534.557235421076, 5541.168824676331, 5556.527695145796, 5660.320761508646, 5816.04035334182, 5828.6502809831545, 5838.5621078418435, 5840.036393994943, 5846.0, 5874.383189765184, 5667.943320566742, 5673.801416950387, 5675.177099320658, 5679.9148012779015, 5689.118186681071, 5411.377691565521, 5453.809116680897, 5559.944400555943, 5634.4365563443325, 5670.489655930986, 5665.773369065191, 5665.915011274752, 5671.517920976598, 5693.259876216231, 5707.286589176353, 5691.459311365414, 5695.7436915338085, 5729.742161602655, 5736.368999410145, 5740.1963725077685, 5347.652402593819, 5388.245645609696, 5414.945850541444, 5566.109422492382, 5592.217089607377], "value": 5347.38607927857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.2488989203927, 613.7790395457635, 644.8935925572282, 645.3578689204243, 658.8385845467864, 34463.0, 45401.318980215285, 46513.7674311628, 46654.30018549716, 46746.76626616866, 47799.522004779945, 47919.76040119794, 48064.038719225595, 48376.0, 48397.758011209895, 8507.447015943975, 9030.277577793777, 9175.72472825813, 9187.127222913812, 9188.632454701803, 8685.0, 10699.732506687316, 10928.890711092867, 10942.945285273563, 11230.382328971904, 10986.0, 11035.282706624044, 11046.834297485544, 11058.723531911686, 11062.1703372247, 10814.513346899408, 10841.186910981629, 10851.294665846695, 10863.565457381736, 10870.293430926964, 10905.727356816064, 10957.671269861918, 10972.286801357886, 10981.17641176915, 10981.17641176915, 44714.776426117984, 44817.55182448166, 44931.775341123415, 45023.774881125384, 45055.09889802218, 3678.558572971234, 3695.981520092409, 3724.7206459515646, 3732.701383889282, 3738.420544815558, 32830.671693283, 32868.6713132868, 33046.6695333046, 33122.83438582792, 33239.33521329584, 4250.107477429743, 4305.5694430557005, 4306.806193721259, 4342.34864770287, 4396.428464299621, 359887.0, 360492.0, 361012.0, 362829.0, 363169.0, 60622.0, 60918.0, 60992.39007609956, 61057.389426106056, 61090.69454652698, 40060.399094013614, 40616.39075413871, 40950.0, 42910.57089429066, 42947.0, 16543.6691266174, 16668.33326666944, 16671.499855004127, 16681.666366672598, 16683.749743753855, 11015.889841101647, 11112.388818614892, 12250.44872980718, 13184.60446186616, 13282.203067815963, 19813.10841012129, 20971.8951405242, 21010.36968890936, 21012.68480972756, 21068.894655526932, 7165.7850264492145, 7216.170140433812, 7430.256974302634, 7496.212897645778, 7641.503302285334, 951.2342564235719, 1040.9687709368732, 1043.8068957242933, 1070.250824422907, 1095.2114477576133, 33187.0, 33390.0, 33422.49866252008, 33452.3309533808, 33461.49807752837, 1123.9100871930389, 1131.8981291683624, 1176.394157009141, 1187.5843454790754, 1189.0606420927543, 17509.38717144894, 17614.559636009202, 17671.646567068587, 17786.0, 17811.910940445476, 531788.0, 537317.0, 537672.0, 537846.0, 538753.0, 62467.6876615614, 62909.68545157245, 62973.68513157497, 63097.68451157715, 63172.684136579024, 1340.2896464873634, 1390.061708346862, 1395.0, 1443.570864843818, 1451.6225781296728, 31882.0, 33710.83144584261, 34417.48373774345, 34614.6154153831, 34657.0, 51721.93112275467, 52292.47707522876, 52298.73850630875, 52401.0, 52522.47477525176, 400622.0, 404828.0, 405273.0, 407075.7169713297, 622176.0, 26897.462050759266, 28898.27754306159, 29807.0, 29914.850425747733, 31073.689263107983, 48994.75502622607, 49403.7529812363, 49604.603157191035, 49681.25478117759, 50264.748676256386, 42376.36435453409, 42459.36310955277, 42828.35757463578, 43239.0, 44024.339634906144, 41774.37338439865, 41858.58141418547, 42394.57605423906, 44079.33880991852, 44499.0, 41717.37423938583, 42630.78684606557, 43212.783936080115, 43697.126057479305, 43730.12539749123, 34903.650963491054, 37146.0, 37411.6258837419, 37918.431223531115, 38080.0, 28205.306845551528, 28249.201373487995, 28310.547899361834, 28345.574816377357, 28398.574021390108], "value": 20948.503672909443, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [404.18485250232146, 407.27098493696286, 411.3849794557137, 414.30603738737614, 418.8910883170375, 14753.48362807302, 18455.354062607796, 19471.41585752426, 20203.292884749055, 20252.493687657818, 15801.289374087348, 17321.653566928653, 18634.627307453844, 19033.238670453164, 19897.701534476993, 1933.4779609505424, 1934.9322773702922, 1935.7289979402894, 1936.1190658250462, 2115.3019503563864, 5769.24999750034, 5824.679642619654, 5827.1550625159325, 5833.125031245326, 5838.386969368219, 5566.666000039991, 5686.601937864351, 5741.425857414246, 5851.970740146293, 5854.238948936632, 5706.28671416073, 5719.656820590757, 5755.079187330028, 5759.971200143972, 5760.308762948473, 5069.543741063322, 5117.309163262949, 5149.819756308511, 5173.689578625257, 5176.094183517869, 23544.764552354427, 24024.399390015216, 24344.66104364259, 24529.509409811704, 24795.876020619962, 2372.1697405907967, 2474.5669507836055, 2572.5883858582724, 2694.137875879719, 2792.6788419331833, 14263.358148883326, 14642.560723178321, 15019.324130414048, 15375.0, 15721.921390393089, 1811.1397086383995, 1844.3729132095018, 1909.9809001909941, 1934.3133187718438, 1971.8619696621242, 80904.0, 81477.0, 82791.0, 83454.0, 84437.0, 10974.286671366335, 11032.28290161137, 11058.612948546763, 11134.16493762971, 11312.604058858065, 15455.613609659624, 15467.84532154664, 15478.0, 15521.45674901373, 15819.05085694862, 7278.235785242473, 7389.445791565654, 8076.394270429624, 8355.498670079814, 8398.958005209935, 7996.360291176692, 8077.151899050515, 8099.919000809917, 8109.797255068553, 8147.307478864244, 6759.121314229217, 6860.931390686129, 6878.793636190922, 6921.242233560926, 7089.82275443118, 1935.7870634230223, 1962.3033822992918, 1966.4985428715586, 1989.3435166395054, 2006.3479369205068, 974.7027156717128, 1005.2561104782554, 1022.7187523431116, 1052.9789404211872, 1090.6400887707039, 20088.69866951997, 20489.07799149042, 20710.896445517676, 20782.1687132513, 20955.0, 947.1097168661436, 1003.9498025098716, 1006.5973610555836, 1039.875214974208, 1070.882202957674, 9735.70792876215, 10159.799663106098, 10188.0, 10190.847137292947, 10312.278140530241, 354668.0, 356881.0, 357488.0, 485186.0, 489292.0, 61710.0, 62471.375286247465, 64344.67827660832, 100302.49848750855, 104600.47699761605, 486.0449217288046, 508.97964081437067, 510.9182530795055, 513.9948600514022, 514.1028904561564, 11150.776984460103, 11244.212905096565, 11341.149413793833, 11717.882821172021, 11969.760604787682, 27877.721222788325, 43502.34746478868, 44416.777916110215, 45371.0, 45400.54599453963, 50749.49250507448, 58237.0, 59262.407375925686, 59452.70273648604, 60964.695176523834, 6099.878002440015, 6963.895541566779, 8838.469691818511, 8971.282297416321, 9310.208632266062, 12999.41502632365, 13520.526781562598, 13535.390907409386, 13604.251766152956, 13761.243131627856, 11600.477978491157, 11648.650540483799, 11674.649760507198, 11732.237404568676, 12010.159288849696, 11469.369184694922, 11832.82250766222, 11904.642860714192, 12012.879871201176, 12097.818532722193, 11541.192116552096, 11658.242214256046, 11679.941600291944, 11751.941240293743, 11848.940755296167, 8843.098733772269, 9035.50304733246, 9105.362624616213, 9106.635734570544, 9291.163795258459, 10301.227407944583, 11082.722931926766, 11116.44417779124, 11384.886151138382, 11424.82862757076], "value": 8806.508332612419, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1514.9772753408697, 1531.5648119490008, 1680.4118558504524, 1768.5755418699516, 1804.521801722543, 8104.270615644591, 8653.74038778836, 8660.74017779466, 8660.956695216531, 8661.177188167121, 7101.680424380902, 7370.74202402916, 8115.513069215851, 8378.07841137476, 8380.83238335233, 2423.878806059699, 2448.5592593333195, 2450.301664025753, 2452.7056753189554, 2452.717937437191, 2439.256026911791, 2459.9262022139364, 2487.3035550045925, 2493.5760920643443, 2495.9251222463354, 2382.9642555361684, 2394.724606670229, 2413.1192114878118, 2416.2388847513066, 2418.3712234818986, 2386.2721869829693, 2394.341556072077, 2413.734489206186, 2414.7343792182846, 2415.649730789026, 2399.8680072596, 2404.855708657486, 2425.0421083672027, 2426.211481268595, 2427.6237183236626, 8414.78963025923, 8440.535770532619, 8441.57792110392, 8470.618822152956, 8475.0, 4973.4280557735965, 5099.388073431212, 5102.056119617882, 5102.8518583318455, 5106.591472682177, 3088.521279201705, 3189.8405079746153, 3243.5459035735016, 3244.4971029490466, 3260.7717459777823, 1009.1825621246741, 1016.9186465082776, 1020.3469779341227, 1050.6480329089763, 1074.4198133008167, 11504.942475287653, 11570.19008669402, 11592.536298548048, 11603.129765267639, 11621.012213961823, 4453.242948698729, 4500.234960056799, 4627.074585082997, 4637.026224492827, 4699.295105734099, 9729.318947673737, 9734.951325243328, 9735.561899714388, 9737.367071140354, 9738.75653108678, 5228.398734145546, 5232.058229518723, 5232.293640358503, 5237.292965449692, 5239.240310155083, 4353.825846966086, 4458.6878918475395, 4760.262159365235, 4828.95171048292, 4943.8516844494725, 4050.6151915567975, 4082.4488694026522, 4094.529129150126, 4153.397757325171, 4198.706090573631, 1246.5387806511467, 1256.265084925329, 1259.6221133659865, 1269.7904845700357, 1280.180684362009, 929.8744669469535, 998.0518507417981, 1016.8779746430475, 1033.2973577967055, 1035.5961175141701, 5758.539316854642, 5850.707464626837, 5858.150568167677, 6080.75676972925, 6197.5351848611535, 958.0850287974968, 976.2434113562047, 995.8008398320364, 1018.3584341864578, 1021.877374715039, 4235.195312890541, 4405.9559404405545, 4498.482674492409, 4518.954810451919, 4552.11233809404, 10431.0, 10542.841857372145, 10578.312409693346, 10747.570097196181, 10971.286866353661, 10462.058414742709, 10482.947585262178, 10514.474276286155, 10525.684229473129, 10531.104856087166, 7650.693972241159, 8016.599170041474, 8023.318017968421, 8146.14465481116, 8153.429259951747, 5696.886062278814, 5885.735141918538, 5938.6436813791315, 5949.762009519571, 6020.638761674313, 9712.125908668253, 9717.368371055858, 9824.164945979672, 9832.115109640166, 9837.213022958003, 9303.209227215762, 9452.007539208284, 9481.431114133175, 9618.374805637612, 9684.32209745311, 6703.625756719958, 6908.827279318058, 7404.777856664308, 7618.314351708373, 7798.883016754639, 8207.95896020516, 8397.118302578141, 8405.411621186702, 8408.83182336362, 8409.117042710672, 7383.520071195355, 7457.179710231761, 7517.361024312994, 7618.352440042437, 7644.694212231449, 7216.3505284524645, 7237.8914316286355, 7239.746608868664, 7313.0, 7431.442641801778, 6828.2830302819475, 6911.343422374866, 6922.965385173042, 6924.376806087476, 6929.480288978246, 4847.5394837490385, 4946.678465899705, 4983.700977941335, 4985.626078044089, 5038.84883453497, 4965.453800081916, 5003.599712022957, 5128.538431541179, 5146.228065790161, 5229.320188375486], "value": 4589.631626474548, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.71027930002646, 333.8547731736694, 334.75562839127434, 346.26246095815907, 349.36764456334055, 5260.842174734764, 5334.466553344663, 5414.593905457092, 5479.287692599962, 5483.8080667176655, 5215.556677682402, 5320.334958130234, 5356.9732151339285, 5358.169483730018, 5362.544183744387, 4252.597282535357, 4254.212970600433, 4261.29688601382, 4270.402143699885, 4290.785460726951, 4174.535135837263, 4207.527365422093, 4237.406763053175, 4256.404103425523, 4267.189234045537, 4194.601512856274, 4206.369044643313, 4206.833480757412, 4211.536730959592, 4219.367094935754, 4197.181549597814, 4206.936895946548, 4210.221109094828, 4213.367994800805, 4238.118079705799, 3735.1409175889426, 3747.4940882980995, 3753.2681127180213, 3756.9104959561696, 3804.1821008483307, 5046.905534203302, 5254.789808407659, 5278.445763194848, 5301.363836339664, 5303.178007408857, 4820.156472617278, 4826.565609095163, 4826.806927722887, 4835.202191638376, 4838.620993017009, 5394.0, 5695.781883236, 5701.857453563653, 5704.0, 5708.001099807517, 3991.6207960243732, 4004.1391100913443, 4017.317056100441, 4019.8543415126546, 4032.4556184914954, 5840.955665517077, 5846.649201047908, 5851.143550852782, 5872.265966754156, 5891.941080589182, 4071.1654110907193, 4179.91640167195, 4180.2795511994345, 4183.330667093251, 4196.202721482909, 4199.160167966419, 4209.684273679486, 4220.915581688349, 4222.387753775747, 4228.830846766156, 4792.353032340659, 4802.783874725646, 4803.471618122004, 4804.95195048052, 4805.831795887128, 5470.654041312059, 5635.830925072254, 5650.434956504317, 5659.726561523624, 5669.0, 1389.7845833895763, 1400.1459109942928, 1403.1440821099122, 1405.304374334711, 1413.1238632048196, 933.8179055084329, 941.8398872191743, 951.2009911674227, 961.8121619799542, 973.177664873181, 5307.8142265021315, 5317.388500322435, 5319.414864364917, 5321.627486075938, 5326.378062917176, 5647.407022262685, 5650.237217975603, 5661.207430959669, 5668.886622267614, 5688.459596338341, 5147.794088236504, 5266.605004624668, 5321.175217841241, 5321.8935621287355, 5334.466553344712, 2993.7247691753987, 3001.2346851552716, 3001.274267296313, 3001.504751715986, 3005.218643152796, 5756.42435756421, 5756.424357564294, 5759.884802304015, 5793.0, 5819.912701309484, 5379.655086228443, 5638.887222255532, 5649.830505084854, 5655.434456554394, 5659.405762394889, 5769.451902069297, 5803.883922321615, 5818.418158184232, 5837.532997360201, 5842.883142337215, 5331.573474121983, 5363.9731801342305, 5490.3411590609385, 5637.408072152529, 5660.54715622741, 5388.622796404214, 5456.91814622773, 5472.671639701631, 5474.781008759605, 5520.392756796668, 5713.285839270091, 5723.284589426322, 5733.770649173986, 5774.422557744192, 5780.132980053026, 3983.203359328204, 4034.6772258219858, 4117.649999750055, 4156.168766246823, 4172.728772629769, 5807.8548036299435, 5807.8548036299435, 5809.390014048464, 5817.9127313091185, 5818.679972601548, 5527.751251193787, 5662.971685141548, 5675.0, 5676.347220069745, 5678.517326027169, 5604.607677462538, 5642.605017648725, 5651.632643878134, 5664.122061080539, 5664.801731939362, 5587.860303492445, 5626.43735626434, 5627.352854421794, 5633.802816901389, 5648.237487939075, 5555.88882223565, 5606.355269144101, 5620.156976453564, 5696.857578560403, 5726.685032323096, 5501.669899806025, 5526.336839579276, 5540.36285827135, 5542.667439953616, 5545.611807173459], "value": 4273.388950411519, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [700.5341447937121, 756.292866170131, 757.6439073635393, 765.6631082323773, 768.2931702833392, 15058.472953446631, 15610.453634122809, 15648.530544083667, 15662.686746265068, 15855.365785368585, 14491.782623260633, 14598.41606335748, 14625.561233163022, 14635.0, 14653.120812751242, 738.1695592458484, 756.2853103816896, 839.8740188971642, 864.6973559254258, 872.6945569050845, 869.326272139091, 875.9737207883774, 877.5085951866943, 878.2841983783228, 878.6221924572432, 936.8641546975684, 936.9578368973413, 937.3391758810022, 937.5499760115149, 938.4088024544561, 936.5551363102505, 937.4703292639637, 937.9062093790601, 938.8075444533922, 938.816930698514, 681.5297444763098, 683.7504310926525, 684.0320945861649, 684.9143857017873, 686.4062585863243, 14722.0, 14846.925765371105, 14855.48005819791, 14857.777133343008, 15574.610634734108, 11983.520659173622, 13193.86806131936, 13847.192022193876, 14206.928965355108, 14277.357518911675, 11133.665990020312, 11511.251768635011, 11613.3612651305, 11849.644510664693, 11953.701157471045, 4165.0, 4172.290710579209, 4176.4570605821355, 4195.958040419618, 4350.499692535367, 49334.7533262335, 51575.484245157444, 60405.395946040415, 60513.39486605122, 61031.694841525954, 9647.517624118766, 9765.804683906283, 9851.16265117473, 9867.259955503367, 9956.253281003954, 21069.57860842805, 21204.0, 21205.469863253544, 21228.363149105553, 21482.89258553697, 7506.28690274423, 7562.0925488941675, 7659.693612255559, 7670.96164519185, 8096.311813495919, 4414.580614841585, 4506.59440650343, 4561.087782443525, 4590.88522786933, 4797.544233297831, 3406.8466918988706, 3484.494748261488, 3503.667151620592, 3511.122219445139, 3533.258015816656, 587.5241054745584, 589.286962775047, 593.1666009257001, 596.8000719758929, 599.3646734461485, 625.1935003844989, 680.7617333933084, 688.8691148681735, 703.3739971425435, 711.5695004522292, 8859.335549833659, 9007.459552426875, 9048.049954754788, 9142.542872856331, 9683.370580912218, 629.2637613991641, 632.4213344789558, 638.3712043637014, 641.3169973977699, 699.7201119552118, 4431.689781715249, 4458.353538736865, 4493.932591011137, 4578.5650363215445, 4637.327587499861, 93371.0, 94140.52929735307, 94490.52754736182, 96208.51895740477, 98492.0, 79217.60391198007, 81200.59399702963, 84018.0, 86530.56734716285, 87782.0, 61842.38157618366, 72721.0, 74061.0, 74808.0, 75373.24626753663, 8573.399862009599, 8727.127287271222, 8834.469931804113, 9145.176934075966, 9169.724908252763, 51825.999999998494, 52277.7386113067, 52286.73856630692, 52510.47489525056, 52705.472945270056, 66524.33475665182, 67905.66047169732, 69600.65199674171, 69997.30002699907, 71851.0, 12516.687082823002, 13092.672683182616, 13106.934465327613, 13108.803367949298, 13139.211647301192, 12617.116801823784, 12632.6841828955, 12655.240685558896, 12844.807327889903, 12917.483300667867, 10820.0, 11137.0, 11407.372594507382, 11524.94237528807, 11838.230515016496, 12035.819462707892, 12085.093617978511, 12209.511619535118, 12245.877541224474, 12276.938615306866, 11877.940610296893, 11929.28424294545, 12021.639350819489, 12077.973372263456, 12150.513979440724, 9735.489895484268, 9863.605455781688, 9988.400695958266, 9994.900050999397, 10537.367757934548, 8882.40554326042, 9779.902200977898, 9877.950610246902, 9917.900820991987, 9969.551370188505], "value": 7147.975336832386, "unit": "score"}], "name": "dromaeo_css", "value": 7191.391273045606, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 111.0, 110.0, 111.0, 113.0, 110.0, 112.0, 110.0, 111.0, 112.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 115.0, 118.0, 151.0, 120.0, 118.0, 116.0, 117.0, 158.0, 117.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 161.0, 159.0, 161.0, 159.0, 159.0, 161.0, 160.0], "value": 160.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 74.0, 103.0, 76.0, 74.0, 74.0, 75.0, 102.0, 74.0], "value": 80.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 120.0, 83.0, 81.0, 80.0, 105.0, 81.0, 80.0, 117.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 147.0, 145.0, 146.0, 146.0, 147.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 84.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 50.0, 50.0, 50.0, 50.0, 50.0, 49.0, 50.0, 49.0, 49.0], "value": 49.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 57.0, 57.0, 58.0, 58.0, 58.0, 58.0, 59.0, 57.0], "value": 57.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 75.0, 75.0, 74.0, 81.0, 75.0, 78.0, 74.0, 77.0], "value": 75.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 131.0, 130.0, 123.0, 128.0, 121.0, 121.0, 125.0, 161.0, 121.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 157.0, 158.0, 159.0, 156.0, 160.0, 156.0, 154.0, 157.0, 162.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 64.0, 63.0, 65.0, 62.0, 62.0, 63.0, 63.0, 63.0, 61.0], "value": 62.8, "unit": "score"}], "name": "kraken", "value": 1450.8, "alertThreshold": 2.0}]} 15:00:06 INFO - Return code: 0 15:00:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:00:06 INFO - # TBPL SUCCESS # 15:00:06 INFO - Running post-action listener: _resource_record_post_action 15:00:06 INFO - [mozharness: 2017-01-31 23:00:06.553424Z] Finished run-tests step (success) 15:00:06 INFO - Running post-run listener: _resource_record_post_run 15:00:06 INFO - Total resource usage - Wall time: 1187s; CPU: 13.0%; Read bytes: 307200; Write bytes: 322867200; Read time: 64; Write time: 180872 15:00:06 INFO - TinderboxPrint: CPU usage
12.9% 15:00:06 INFO - TinderboxPrint: I/O read bytes / time
307,200 / 64 15:00:06 INFO - TinderboxPrint: I/O write bytes / time
322,867,200 / 180,872 15:00:06 INFO - TinderboxPrint: CPU idle
8,248.9 (87.0%) 15:00:06 INFO - TinderboxPrint: CPU user
1,185.9 (12.5%) 15:00:06 INFO - TinderboxPrint: Swap in / out
0 / 0 15:00:06 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101269504; Read time: 0; Write time: 86184 15:00:06 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 307200; Write bytes: 221597696; Read time: 64; Write time: 94688 15:00:07 INFO - Running post-run listener: _upload_blobber_files 15:00:07 INFO - Blob upload gear active. 15:00:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:00:07 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 15:00:07 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-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:00:07 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-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:00:07 INFO - (blobuploader) - INFO - Open directory for files ... 15:00:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:00:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:00:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:11 INFO - (blobuploader) - INFO - Done attempting. 15:00:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:00:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:00:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:12 INFO - (blobuploader) - INFO - Done attempting. 15:00:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:00:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:00:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:00:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:00:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:00:13 INFO - (blobuploader) - INFO - Done attempting. 15:00:13 INFO - (blobuploader) - INFO - Iteration through files over. 15:00:13 INFO - Return code: 0 15:00:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:00:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:00:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cf77b7079018da37082aaddb3c7d0f101b5b1ac5747e8ee150fcde30516c3667674bd3dfc0c192a4fa1cefe911a406858df24009290d510d319342bce19080b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6b89be144e5edb29688c463106e908e8a6c881e7e2f4bea90aa0c011160b526eed4c7f5f0cbc094326b4d044c52d7899372250e6e02008fa3c533ce48de2050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50c695a8c7fc4fde000b42e9d0282151f87db45979613c08dc2b3bb80ef0e798db147ec9d91cab945cdec2ca1d506a71788bd32610ee55e7bfefb705f9f02071"} 15:00:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:00:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:00:13 INFO - Contents: 15:00:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cf77b7079018da37082aaddb3c7d0f101b5b1ac5747e8ee150fcde30516c3667674bd3dfc0c192a4fa1cefe911a406858df24009290d510d319342bce19080b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6b89be144e5edb29688c463106e908e8a6c881e7e2f4bea90aa0c011160b526eed4c7f5f0cbc094326b4d044c52d7899372250e6e02008fa3c533ce48de2050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50c695a8c7fc4fde000b42e9d0282151f87db45979613c08dc2b3bb80ef0e798db147ec9d91cab945cdec2ca1d506a71788bd32610ee55e7bfefb705f9f02071"} 15:00:13 INFO - Running post-run listener: copy_logs_to_upload_dir 15:00:13 INFO - Copying logs to upload dir... 15:00:13 INFO - mkdir: /builds/slave/test/build/upload/logs 15:00:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1231.148602 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 31 secs) (at 2017-01-31 15:00:13.453730) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 15:00:13.457412) ========= 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=20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537 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-Beta/sha512/2cf77b7079018da37082aaddb3c7d0f101b5b1ac5747e8ee150fcde30516c3667674bd3dfc0c192a4fa1cefe911a406858df24009290d510d319342bce19080b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6b89be144e5edb29688c463106e908e8a6c881e7e2f4bea90aa0c011160b526eed4c7f5f0cbc094326b4d044c52d7899372250e6e02008fa3c533ce48de2050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50c695a8c7fc4fde000b42e9d0282151f87db45979613c08dc2b3bb80ef0e798db147ec9d91cab945cdec2ca1d506a71788bd32610ee55e7bfefb705f9f02071"} build_url:https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/T_uise6QR8Ko7LHRhEf08w/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2cf77b7079018da37082aaddb3c7d0f101b5b1ac5747e8ee150fcde30516c3667674bd3dfc0c192a4fa1cefe911a406858df24009290d510d319342bce19080b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6b89be144e5edb29688c463106e908e8a6c881e7e2f4bea90aa0c011160b526eed4c7f5f0cbc094326b4d044c52d7899372250e6e02008fa3c533ce48de2050", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/50c695a8c7fc4fde000b42e9d0282151f87db45979613c08dc2b3bb80ef0e798db147ec9d91cab945cdec2ca1d506a71788bd32610ee55e7bfefb705f9f02071"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-31 15:00:13.482341) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 15:00:13.482664) ========= 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=20e666a3d4cfbb71505a330e000001b4-1485902380.917574-1386607537 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004517 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-31 15:00:13.567089) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 15:00:13.567418) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-31 15:00:13.567705) ========= ========= Total master_lag: 0.17 =========