builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1483525903.6 results: success (0) buildid: 20170104004006 builduid: 5cdabe96efff4c4f9bea0dbd25e82dae revision: 236b90305efbbc79f66ca1453be47f3688b26c7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:43.595765) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:43.596269) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:43.596563) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:43.611547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:43.611904) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-04 02:31:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-01-04 02:31:44 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104615 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:43.730578) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:43.730908) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019855 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:43.781221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 02:31:43.781740) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 236b90305efbbc79f66ca1453be47f3688b26c7a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 236b90305efbbc79f66ca1453be47f3688b26c7a --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=97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-04 02:31:44,951 truncating revision to first 12 chars 2017-01-04 02:31:44,951 Setting DEBUG logging. 2017-01-04 02:31:44,952 attempt 1/10 2017-01-04 02:31:44,952 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/236b90305efb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 02:31:45,708 unpacking tar archive at: mozilla-aurora-236b90305efb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.050258 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 02:31:44.842332) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:44.842653) ========= script_repo_revision: 236b90305efbbc79f66ca1453be47f3688b26c7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:44.843069) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:44.843341) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 02:31:44.851325) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-04 02:31:44.851609) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:31:46 INFO - MultiFileLogger online at 20170104 02:31:46 in /builds/slave/test 02:31:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:31:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:31:46 INFO - {'append_to_log': False, 02:31:46 INFO - 'base_work_dir': '/builds/slave/test', 02:31:46 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:31:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:31:46 INFO - 'branch': 'Mozilla-Aurora', 02:31:46 INFO - 'buildbot_json_path': 'buildprops.json', 02:31:46 INFO - 'config_files': ('talos/linux_config.py',), 02:31:46 INFO - 'default_actions': ('clobber', 02:31:46 INFO - 'read-buildbot-config', 02:31:46 INFO - 'download-and-extract', 02:31:46 INFO - 'populate-webroot', 02:31:46 INFO - 'create-virtualenv', 02:31:46 INFO - 'install', 02:31:46 INFO - 'run-tests'), 02:31:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:31:46 INFO - 'download_minidump_stackwalk': True, 02:31:46 INFO - 'download_symbols': 'ondemand', 02:31:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:31:46 INFO - 'tooltool.py': '/tools/tooltool.py', 02:31:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:31:46 INFO - '/tools/misc-python/virtualenv.py')}, 02:31:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:31:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:31:46 INFO - 'installer_path': 'installer.exe', 02:31:46 INFO - 'log_level': 'info', 02:31:46 INFO - 'log_name': 'talos', 02:31:46 INFO - 'log_to_console': True, 02:31:46 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:31:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:31:46 INFO - 'opt_config_files': (), 02:31:46 INFO - 'pip_index': False, 02:31:46 INFO - 'sps_profile': False, 02:31:46 INFO - 'sps_profile_interval': 0, 02:31:46 INFO - 'suite': 'dromaeojs', 02:31:46 INFO - 'system_bits': '32', 02:31:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:31:46 INFO - 'title': 'talos-linux64-ix-068', 02:31:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:31:46 INFO - 'use_talos_json': True, 02:31:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:31:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:31:46 INFO - 'work_dir': 'build'} 02:31:46 INFO - [mozharness: 2017-01-04 10:31:46.120020Z] Running clobber step. 02:31:46 INFO - Running pre-action listener: _resource_record_pre_action 02:31:46 INFO - Running main action method: clobber 02:31:46 INFO - rmtree: /builds/slave/test/build 02:31:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:31:46 INFO - Running post-action listener: _resource_record_post_action 02:31:46 INFO - [mozharness: 2017-01-04 10:31:46.586184Z] Finished clobber step (success) 02:31:46 INFO - [mozharness: 2017-01-04 10:31:46.586286Z] Running read-buildbot-config step. 02:31:46 INFO - Running pre-action listener: _resource_record_pre_action 02:31:46 INFO - Running main action method: read_buildbot_config 02:31:46 INFO - Using buildbot properties: 02:31:46 INFO - { 02:31:46 INFO - "project": "", 02:31:46 INFO - "product": "firefox", 02:31:46 INFO - "script_repo_revision": "production", 02:31:46 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:31:46 INFO - "repository": "", 02:31:46 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:31:46 INFO - "buildid": "20170104004006", 02:31:46 INFO - "stage_platform": "linux64-pgo", 02:31:46 INFO - "basedir": "/builds/slave/test", 02:31:46 INFO - "nightly_build": "True", 02:31:46 INFO - "buildnumber": 990, 02:31:46 INFO - "slavename": "talos-linux64-ix-068", 02:31:46 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:31:46 INFO - "platform": "ubuntu64_hw", 02:31:46 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:31:46 INFO - "branch": "mozilla-aurora", 02:31:46 INFO - "repo_path": "releases/mozilla-aurora", 02:31:46 INFO - "revision": "236b90305efbbc79f66ca1453be47f3688b26c7a", 02:31:46 INFO - "pgo_build": "True", 02:31:46 INFO - "builduid": "5cdabe96efff4c4f9bea0dbd25e82dae", 02:31:46 INFO - "slavebuilddir": "test" 02:31:46 INFO - } 02:31:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 02:31:46 INFO - Running post-action listener: _resource_record_post_action 02:31:46 INFO - [mozharness: 2017-01-04 10:31:46.588819Z] Finished read-buildbot-config step (success) 02:31:46 INFO - [mozharness: 2017-01-04 10:31:46.588907Z] Running download-and-extract step. 02:31:46 INFO - Running pre-action listener: _resource_record_pre_action 02:31:46 INFO - Running main action method: download_and_extract 02:31:46 INFO - mkdir: /builds/slave/test/build/tests 02:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:31:46 INFO - trying https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:31:46 INFO - Downloading https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:31:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:31:47 INFO - Downloaded 1361 bytes. 02:31:47 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 02:31:47 INFO - Using the following test package requirements: 02:31:47 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:31:47 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:31:47 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:31:47 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:47 INFO - u'jsshell-linux-x86_64.zip'], 02:31:47 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:31:47 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 02:31:47 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:31:47 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:31:47 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:31:47 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 02:31:47 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:31:47 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:31:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:31:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:31:47 INFO - Fetch https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:31:47 INFO - Http code: 200 02:31:47 INFO - via: 1.1 81871f1c889cc44b6c25e3ef722a3801.cloudfront.net (CloudFront) 02:31:47 INFO - x-amz-cf-id: ug_0QZY0rCIlB3PB3DUByRrNLgXgVJOeSnc-FYoeaJ9kIMJWKTx9XQ== 02:31:47 INFO - x-amz-version-id: z6jW3MjNjT8amWtHkP6Rupd8FKR0W.Ky 02:31:48 INFO - Expected file size: 21942671 02:31:48 INFO - Obtained file size: 21942671 02:31:51 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:31:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 02:31:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:31:51 INFO - Fetch https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 02:31:52 INFO - Http code: 200 02:31:52 INFO - via: 1.1 6eaa7f856e226a0db7cef6201d3b8393.cloudfront.net (CloudFront) 02:31:52 INFO - x-amz-cf-id: zhQESSMdLQFc1Oej6hIDn1Ihk00YRo8ZJzkA5el5K4atiQhL84pVnw== 02:31:52 INFO - x-amz-version-id: z6jW3MjNjT8amWtHkP6Rupd8FKR0W.Ky 02:31:52 INFO - Expected file size: 21942671 02:31:52 INFO - Obtained file size: 21942671 02:31:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 02:31:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:31:57 INFO - Fetch https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 02:31:57 INFO - Http code: 200 02:31:57 INFO - via: 1.1 f46e4d7bc5419470a70eb57aa9c935c8.cloudfront.net (CloudFront) 02:31:57 INFO - x-amz-cf-id: Rhm8wxWNh0JZNq7yhulxRR-9ulLVhJTbGaue0W71I0hc6oLFro9hJA== 02:31:57 INFO - x-amz-version-id: Hp619GBcxFXEWDk1nuYmAbMc116Okefk 02:31:57 INFO - Expected file size: 14409038 02:31:57 INFO - Obtained file size: 14409038 02:31:58 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')]} 02:31:58 INFO - trying https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:31:58 INFO - Downloading https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:31:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:31:59 INFO - Downloaded 63998243 bytes. 02:31:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:31:59 INFO - mkdir: /builds/slave/test/properties 02:31:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:31:59 INFO - Writing to file /builds/slave/test/properties/build_url 02:31:59 INFO - Contents: 02:31:59 INFO - build_url:https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 02:32:00 INFO - Running post-action listener: _resource_record_post_action 02:32:00 INFO - Running post-action listener: set_extra_try_arguments 02:32:00 INFO - [mozharness: 2017-01-04 10:32:00.036236Z] Finished download-and-extract step (success) 02:32:00 INFO - [mozharness: 2017-01-04 10:32:00.036464Z] Running populate-webroot step. 02:32:00 INFO - Running pre-action listener: _resource_record_pre_action 02:32:00 INFO - Running main action method: populate_webroot 02:32:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:32:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:32:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:32:00 INFO - '--tppagecycles', 02:32:00 INFO - '7'], 02:32:00 INFO - 'tests': ['tsvgm']}}, 02:32:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:32:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:32:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:32:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:32:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:00 INFO - 'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:32:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:00 INFO - 'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['damp', 'tps']}, 02:32:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:00 INFO - 'tests': ['damp', 'tps']}, 02:32:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['dromaeo_dom']}, 02:32:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:32:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['basic_compositor_video']}, 02:32:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:32:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['a11yr', 02:32:00 INFO - 'ts_paint', 02:32:00 INFO - 'tpaint', 02:32:00 INFO - 'sessionrestore', 02:32:00 INFO - 'sessionrestore_no_auto_restore', 02:32:00 INFO - 'tabpaint']}, 02:32:00 INFO - 'other-e10s': {'tests': ['a11yr', 02:32:00 INFO - 'ts_paint', 02:32:00 INFO - 'tpaint', 02:32:00 INFO - 'sessionrestore', 02:32:00 INFO - 'sessionrestore_no_auto_restore', 02:32:00 INFO - 'tabpaint']}, 02:32:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:32:00 INFO - 'ts_paint', 02:32:00 INFO - 'tpaint', 02:32:00 INFO - 'sessionrestore', 02:32:00 INFO - 'sessionrestore_no_auto_restore', 02:32:00 INFO - 'tabpaint']}, 02:32:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:32:00 INFO - 'ts_paint', 02:32:00 INFO - 'tpaint', 02:32:00 INFO - 'sessionrestore', 02:32:00 INFO - 'sessionrestore_no_auto_restore', 02:32:00 INFO - 'tabpaint']}, 02:32:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['a11yr', 02:32:00 INFO - 'ts_paint', 02:32:00 INFO - 'tpaint', 02:32:00 INFO - 'sessionrestore', 02:32:00 INFO - 'sessionrestore_no_auto_restore', 02:32:00 INFO - 'tabpaint']}, 02:32:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['a11yr', 02:32:00 INFO - 'ts_paint', 02:32:00 INFO - 'tpaint', 02:32:00 INFO - 'sessionrestore', 02:32:00 INFO - 'sessionrestore_no_auto_restore', 02:32:00 INFO - 'tabpaint']}, 02:32:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['tsvgx', 02:32:00 INFO - 'tsvgr_opacity', 02:32:00 INFO - 'tart', 02:32:00 INFO - 'tscrollx', 02:32:00 INFO - 'cart']}, 02:32:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:32:00 INFO - 'tsvgr_opacity', 02:32:00 INFO - 'tart', 02:32:00 INFO - 'tscrollx', 02:32:00 INFO - 'cart']}, 02:32:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:00 INFO - 'talos_options': ['--disable-e10s'], 02:32:00 INFO - 'tests': ['tp5o']}, 02:32:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:00 INFO - 'tests': ['tp5o']}, 02:32:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:00 INFO - 'talos_options': ['--disable-e10s', 02:32:00 INFO - '--xperf_path', 02:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:00 INFO - 'tests': ['tp5n']}, 02:32:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:32:00 INFO - 'talos_options': ['--xperf_path', 02:32:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:32:00 INFO - 'tests': ['tp5n']}}, 02:32:00 INFO - 'talos.zip': {'path': '', 02:32:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:32:00 INFO - Running post-action listener: _resource_record_post_action 02:32:00 INFO - [mozharness: 2017-01-04 10:32:00.057232Z] Finished populate-webroot step (success) 02:32:00 INFO - [mozharness: 2017-01-04 10:32:00.057320Z] Running create-virtualenv step. 02:32:00 INFO - Running pre-action listener: _resource_record_pre_action 02:32:00 INFO - Running main action method: create_virtualenv 02:32:00 INFO - Creating virtualenv /builds/slave/test/build/venv 02:32:00 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 02:32:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:32:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:32:00 INFO - Using real prefix '/usr' 02:32:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:32:00 INFO - Installing distribute.............................................................................................................................................................................................done. 02:32:02 INFO - Installing pip.................done. 02:32:02 INFO - Return code: 0 02:32:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:32:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:32:02 INFO - Reading from file tmpfile_stdout 02:32:02 INFO - Output received: 02:32:02 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) 02:32:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6dcdd3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', '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 02:32: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', 'pip>=1.5'] in /builds/slave/test/build 02:32: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 pip>=1.5 02:32:02 INFO - Using env: {'DISPLAY': ':0', 02:32:02 INFO - 'HOME': '/home/cltbld', 02:32:02 INFO - 'LANG': 'en_US.UTF-8', 02:32:02 INFO - 'LANGUAGE': 'en_US:en', 02:32:02 INFO - 'LOGNAME': 'cltbld', 02:32:02 INFO - 'MAIL': '/var/mail/cltbld', 02:32:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:02 INFO - 'MOZ_NO_REMOTE': '1', 02:32:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:02 INFO - 'NO_EM_RESTART': '1', 02:32:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:02 INFO - 'PWD': '/builds/slave/test', 02:32:02 INFO - 'SHELL': '/bin/bash', 02:32:02 INFO - 'SHLVL': '1', 02:32:02 INFO - 'TERM': 'linux', 02:32:02 INFO - 'TMOUT': '86400', 02:32:02 INFO - 'USER': 'cltbld', 02:32:02 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:02 INFO - '_': '/tools/buildbot/bin/python'} 02:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:03 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 02:32:03 INFO - Cleaning up... 02:32:03 INFO - Return code: 0 02:32:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:32:03 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')]} 02:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:03 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')]} 02:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:03 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 0x7f6dcdd3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', '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 02:32:03 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 02:32:03 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 02:32:03 INFO - Using env: {'DISPLAY': ':0', 02:32:03 INFO - 'HOME': '/home/cltbld', 02:32:03 INFO - 'LANG': 'en_US.UTF-8', 02:32:03 INFO - 'LANGUAGE': 'en_US:en', 02:32:03 INFO - 'LOGNAME': 'cltbld', 02:32:03 INFO - 'MAIL': '/var/mail/cltbld', 02:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:03 INFO - 'MOZ_NO_REMOTE': '1', 02:32:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:03 INFO - 'NO_EM_RESTART': '1', 02:32:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:03 INFO - 'PWD': '/builds/slave/test', 02:32:03 INFO - 'SHELL': '/bin/bash', 02:32:03 INFO - 'SHLVL': '1', 02:32:03 INFO - 'TERM': 'linux', 02:32:03 INFO - 'TMOUT': '86400', 02:32:03 INFO - 'USER': 'cltbld', 02:32:03 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:03 INFO - '_': '/tools/buildbot/bin/python'} 02:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:03 INFO - Downloading/unpacking psutil>=3.1.1 02:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:05 INFO - Installing collected packages: psutil 02:32:05 INFO - Running setup.py install for psutil 02:32:05 INFO - building 'psutil._psutil_linux' extension 02:32:05 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 02:32:05 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 02:32:05 INFO - building 'psutil._psutil_posix' extension 02:32:05 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 02:32:05 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 02:32:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:32:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:32:05 INFO - Successfully installed psutil 02:32:05 INFO - Cleaning up... 02:32:05 INFO - Return code: 0 02:32:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:06 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 0x7f6dcdd3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', '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 02:32:06 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 02:32:06 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 02:32:06 INFO - Using env: {'DISPLAY': ':0', 02:32:06 INFO - 'HOME': '/home/cltbld', 02:32:06 INFO - 'LANG': 'en_US.UTF-8', 02:32:06 INFO - 'LANGUAGE': 'en_US:en', 02:32:06 INFO - 'LOGNAME': 'cltbld', 02:32:06 INFO - 'MAIL': '/var/mail/cltbld', 02:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:06 INFO - 'MOZ_NO_REMOTE': '1', 02:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:06 INFO - 'NO_EM_RESTART': '1', 02:32:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:06 INFO - 'PWD': '/builds/slave/test', 02:32:06 INFO - 'SHELL': '/bin/bash', 02:32:06 INFO - 'SHLVL': '1', 02:32:06 INFO - 'TERM': 'linux', 02:32:06 INFO - 'TMOUT': '86400', 02:32:06 INFO - 'USER': 'cltbld', 02:32:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:06 INFO - '_': '/tools/buildbot/bin/python'} 02:32:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:32:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:32:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:32:08 INFO - Installing collected packages: mozsystemmonitor 02:32:08 INFO - Running setup.py install for mozsystemmonitor 02:32:08 INFO - Successfully installed mozsystemmonitor 02:32:08 INFO - Cleaning up... 02:32:08 INFO - Return code: 0 02:32:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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', '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 0x7f6dcdd3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', '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 02:32: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:32: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 jsonschema==2.5.1 02:32:08 INFO - Using env: {'DISPLAY': ':0', 02:32:08 INFO - 'HOME': '/home/cltbld', 02:32:08 INFO - 'LANG': 'en_US.UTF-8', 02:32:08 INFO - 'LANGUAGE': 'en_US:en', 02:32:08 INFO - 'LOGNAME': 'cltbld', 02:32:08 INFO - 'MAIL': '/var/mail/cltbld', 02:32:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:08 INFO - 'MOZ_NO_REMOTE': '1', 02:32:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:08 INFO - 'NO_EM_RESTART': '1', 02:32:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:08 INFO - 'PWD': '/builds/slave/test', 02:32:08 INFO - 'SHELL': '/bin/bash', 02:32:08 INFO - 'SHLVL': '1', 02:32:08 INFO - 'TERM': 'linux', 02:32:08 INFO - 'TMOUT': '86400', 02:32:08 INFO - 'USER': 'cltbld', 02:32:08 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:08 INFO - '_': '/tools/buildbot/bin/python'} 02:32:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:08 INFO - Downloading/unpacking jsonschema==2.5.1 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:32:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32: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 02:32:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:32:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:32:10 INFO - warning: no files found matching '*.txt' 02:32:10 INFO - no previously-included directories found matching 'build' 02:32:10 INFO - no previously-included directories found matching 'dist' 02:32:10 INFO - no previously-included directories found matching '.git*' 02:32:10 INFO - Installing collected packages: jsonschema, functools32 02:32:10 INFO - Running setup.py install for functools32 02:32:11 INFO - warning: no files found matching '*.txt' 02:32:11 INFO - no previously-included directories found matching 'build' 02:32:11 INFO - no previously-included directories found matching 'dist' 02:32:11 INFO - no previously-included directories found matching '.git*' 02:32:11 INFO - Successfully installed jsonschema functools32 02:32:11 INFO - Cleaning up... 02:32:11 INFO - Return code: 0 02:32:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:11 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 0x7f6dcdd3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', '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 02:32:11 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 02:32:11 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 02:32:11 INFO - Using env: {'DISPLAY': ':0', 02:32:11 INFO - 'HOME': '/home/cltbld', 02:32:11 INFO - 'LANG': 'en_US.UTF-8', 02:32:11 INFO - 'LANGUAGE': 'en_US:en', 02:32:11 INFO - 'LOGNAME': 'cltbld', 02:32:11 INFO - 'MAIL': '/var/mail/cltbld', 02:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:11 INFO - 'MOZ_NO_REMOTE': '1', 02:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:11 INFO - 'NO_EM_RESTART': '1', 02:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:11 INFO - 'PWD': '/builds/slave/test', 02:32:11 INFO - 'SHELL': '/bin/bash', 02:32:11 INFO - 'SHLVL': '1', 02:32:11 INFO - 'TERM': 'linux', 02:32:11 INFO - 'TMOUT': '86400', 02:32:11 INFO - 'USER': 'cltbld', 02:32:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:11 INFO - '_': '/tools/buildbot/bin/python'} 02:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:32:11 INFO - Cleaning up... 02:32:11 INFO - Return code: 0 02:32:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:11 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 0x7f6dcdd3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', '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 02:32:11 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 02:32:11 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 02:32:11 INFO - Using env: {'DISPLAY': ':0', 02:32:11 INFO - 'HOME': '/home/cltbld', 02:32:11 INFO - 'LANG': 'en_US.UTF-8', 02:32:11 INFO - 'LANGUAGE': 'en_US:en', 02:32:11 INFO - 'LOGNAME': 'cltbld', 02:32:11 INFO - 'MAIL': '/var/mail/cltbld', 02:32:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:11 INFO - 'MOZ_NO_REMOTE': '1', 02:32:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:11 INFO - 'NO_EM_RESTART': '1', 02:32:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:11 INFO - 'PWD': '/builds/slave/test', 02:32:11 INFO - 'SHELL': '/bin/bash', 02:32:11 INFO - 'SHLVL': '1', 02:32:11 INFO - 'TERM': 'linux', 02:32:11 INFO - 'TMOUT': '86400', 02:32:11 INFO - 'USER': 'cltbld', 02:32:11 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:11 INFO - '_': '/tools/buildbot/bin/python'} 02:32:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:11 INFO - Downloading/unpacking blobuploader==1.2.4 02:32:11 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 02:32:11 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 02:32:11 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 02:32:11 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 02:32:11 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 02:32:11 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 02:32:13 INFO - Downloading blobuploader-1.2.4.tar.gz 02:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:32:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:32:13 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 02:32:13 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 02:32:13 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 02:32:13 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 02:32:13 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 02:32:13 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 02:32:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:32:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:32:14 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 02:32:14 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 02:32:14 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 02:32:14 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 02:32:14 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 02:32:14 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 02:32:14 INFO - Downloading docopt-0.6.1.tar.gz 02:32:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:32:14 INFO - Installing collected packages: blobuploader, requests, docopt 02:32:14 INFO - Running setup.py install for blobuploader 02:32:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:32:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:32:14 INFO - Running setup.py install for requests 02:32:14 INFO - Running setup.py install for docopt 02:32:14 INFO - Successfully installed blobuploader requests docopt 02:32:14 INFO - Cleaning up... 02:32:14 INFO - Return code: 0 02:32:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:15 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 0x7f6dcdd3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', '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 02:32:15 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 02:32:15 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 02:32:15 INFO - Using env: {'DISPLAY': ':0', 02:32:15 INFO - 'HOME': '/home/cltbld', 02:32:15 INFO - 'LANG': 'en_US.UTF-8', 02:32:15 INFO - 'LANGUAGE': 'en_US:en', 02:32:15 INFO - 'LOGNAME': 'cltbld', 02:32:15 INFO - 'MAIL': '/var/mail/cltbld', 02:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:15 INFO - 'MOZ_NO_REMOTE': '1', 02:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:15 INFO - 'NO_EM_RESTART': '1', 02:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:15 INFO - 'PWD': '/builds/slave/test', 02:32:15 INFO - 'SHELL': '/bin/bash', 02:32:15 INFO - 'SHLVL': '1', 02:32:15 INFO - 'TERM': 'linux', 02:32:15 INFO - 'TMOUT': '86400', 02:32:15 INFO - 'USER': 'cltbld', 02:32:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:15 INFO - '_': '/tools/buildbot/bin/python'} 02:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:15 INFO - Running setup.py (path:/tmp/pip-RJCvq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:15 INFO - Running setup.py (path:/tmp/pip-vUCDsl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:15 INFO - Running setup.py (path:/tmp/pip-cb4u2W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:15 INFO - Running setup.py (path:/tmp/pip-7G4XoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:15 INFO - Running setup.py (path:/tmp/pip-u34DGF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:15 INFO - Running setup.py (path:/tmp/pip-yeCDhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:15 INFO - Running setup.py (path:/tmp/pip-rIBw6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:15 INFO - Running setup.py (path:/tmp/pip-07SWFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:15 INFO - Running setup.py (path:/tmp/pip-4Adyji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:15 INFO - Running setup.py (path:/tmp/pip-gGcgqX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:15 INFO - Running setup.py (path:/tmp/pip-Y3PB9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:16 INFO - Running setup.py (path:/tmp/pip-R2qjO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:16 INFO - Running setup.py (path:/tmp/pip-S6v44m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:16 INFO - Running setup.py (path:/tmp/pip-wbj4SD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:16 INFO - Running setup.py (path:/tmp/pip-L23W78-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:16 INFO - Running setup.py (path:/tmp/pip-VQhgC9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:16 INFO - Running setup.py (path:/tmp/pip-nbRGU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:32:16 INFO - Running setup.py install for manifestparser 02:32:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:32:16 INFO - Running setup.py install for mozcrash 02:32:16 INFO - Running setup.py install for mozdebug 02:32:16 INFO - Running setup.py install for mozdevice 02:32:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:32:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:32:16 INFO - Running setup.py install for mozfile 02:32:16 INFO - Running setup.py install for mozhttpd 02:32:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Running setup.py install for mozinfo 02:32:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Running setup.py install for mozInstall 02:32:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Running setup.py install for mozleak 02:32:17 INFO - Running setup.py install for mozlog 02:32:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Running setup.py install for moznetwork 02:32:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Running setup.py install for mozprocess 02:32:17 INFO - Running setup.py install for mozprofile 02:32:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Running setup.py install for mozrunner 02:32:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:32:17 INFO - Running setup.py install for mozscreenshot 02:32:18 INFO - Running setup.py install for moztest 02:32:18 INFO - Running setup.py install for mozversion 02:32:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:32:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:32:18 INFO - Cleaning up... 02:32:18 INFO - Return code: 0 02:32:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32: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')]} 02:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32: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')]} 02:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:18 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 0x7f6dcdd3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', '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 02:32:18 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 02:32:18 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 02:32:18 INFO - Using env: {'DISPLAY': ':0', 02:32:18 INFO - 'HOME': '/home/cltbld', 02:32:18 INFO - 'LANG': 'en_US.UTF-8', 02:32:18 INFO - 'LANGUAGE': 'en_US:en', 02:32:18 INFO - 'LOGNAME': 'cltbld', 02:32:18 INFO - 'MAIL': '/var/mail/cltbld', 02:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:18 INFO - 'MOZ_NO_REMOTE': '1', 02:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:18 INFO - 'NO_EM_RESTART': '1', 02:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:18 INFO - 'PWD': '/builds/slave/test', 02:32:18 INFO - 'SHELL': '/bin/bash', 02:32:18 INFO - 'SHLVL': '1', 02:32:18 INFO - 'TERM': 'linux', 02:32:18 INFO - 'TMOUT': '86400', 02:32:18 INFO - 'USER': 'cltbld', 02:32:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:18 INFO - '_': '/tools/buildbot/bin/python'} 02:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:32:18 INFO - Running setup.py (path:/tmp/pip-d4bv5o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:32:18 INFO - Running setup.py (path:/tmp/pip-Gxfnxa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:32:18 INFO - Running setup.py (path:/tmp/pip-dxvmy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:32:18 INFO - Running setup.py (path:/tmp/pip-aEirmV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:32:18 INFO - Running setup.py (path:/tmp/pip-n45jUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:32:18 INFO - Running setup.py (path:/tmp/pip-GHp8s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:32:18 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)) 02:32:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:32:18 INFO - Running setup.py (path:/tmp/pip-jLQpOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:32:19 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)) 02:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:32:19 INFO - Running setup.py (path:/tmp/pip-MHhGkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:32:19 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)) 02:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:32:19 INFO - Running setup.py (path:/tmp/pip-4LuBTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:32:19 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)) 02:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:32:19 INFO - Running setup.py (path:/tmp/pip-4KRXgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:32:19 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)) 02:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:32:19 INFO - Running setup.py (path:/tmp/pip-fvHXli-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:32:19 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)) 02:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:32:19 INFO - Running setup.py (path:/tmp/pip-wvECoA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:32:19 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)) 02:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:32:19 INFO - Running setup.py (path:/tmp/pip-N2Wj0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:32:19 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)) 02:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:32:19 INFO - Running setup.py (path:/tmp/pip-R7w9IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:32:19 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)) 02:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:19 INFO - Running setup.py (path:/tmp/pip-fNqWny-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:32:19 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)) 02:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:32:19 INFO - Running setup.py (path:/tmp/pip-SvsY0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:32:19 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)) 02:32:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:32:19 INFO - Running setup.py (path:/tmp/pip-n3zm0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:32:19 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)) 02:32:19 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)) 02:32:19 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)) 02:32:19 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)) 02:32:19 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)) 02:32:19 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)) 02:32:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:32:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:32:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:32:21 INFO - Downloading blessings-1.6.tar.gz 02:32:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:32:21 INFO - Installing collected packages: blessings 02:32:21 INFO - Running setup.py install for blessings 02:32:21 INFO - Successfully installed blessings 02:32:21 INFO - Cleaning up... 02:32:22 INFO - Return code: 0 02:32:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:22 INFO - Reading from file tmpfile_stdout 02:32:22 INFO - Current package versions: 02:32:22 INFO - argparse == 1.2.1 02:32:22 INFO - blessings == 1.6 02:32:22 INFO - blobuploader == 1.2.4 02:32:22 INFO - docopt == 0.6.1 02:32:22 INFO - functools32 == 3.2.3-2 02:32:22 INFO - jsonschema == 2.5.1 02:32:22 INFO - manifestparser == 1.1 02:32:22 INFO - mozInstall == 1.12 02:32:22 INFO - mozcrash == 1.0 02:32:22 INFO - mozdebug == 0.1 02:32:22 INFO - mozdevice == 0.48 02:32:22 INFO - mozfile == 1.2 02:32:22 INFO - mozhttpd == 0.7 02:32:22 INFO - mozinfo == 0.9 02:32:22 INFO - mozleak == 0.1 02:32:22 INFO - mozlog == 3.4 02:32:22 INFO - moznetwork == 0.27 02:32:22 INFO - mozprocess == 0.23 02:32:22 INFO - mozprofile == 0.28 02:32:22 INFO - mozrunner == 6.13 02:32:22 INFO - mozscreenshot == 0.1 02:32:22 INFO - mozsystemmonitor == 0.3 02:32:22 INFO - moztest == 0.8 02:32:22 INFO - mozversion == 1.4 02:32:22 INFO - psutil == 3.1.1 02:32:22 INFO - requests == 1.2.3 02:32:22 INFO - wsgiref == 0.1.2 02:32:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:22 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 0x7f6dcdd3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', '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 02:32:22 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 02:32:22 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 02:32:22 INFO - Using env: {'DISPLAY': ':0', 02:32:22 INFO - 'HOME': '/home/cltbld', 02:32:22 INFO - 'LANG': 'en_US.UTF-8', 02:32:22 INFO - 'LANGUAGE': 'en_US:en', 02:32:22 INFO - 'LOGNAME': 'cltbld', 02:32:22 INFO - 'MAIL': '/var/mail/cltbld', 02:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:22 INFO - 'MOZ_NO_REMOTE': '1', 02:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:22 INFO - 'NO_EM_RESTART': '1', 02:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:22 INFO - 'PWD': '/builds/slave/test', 02:32:22 INFO - 'SHELL': '/bin/bash', 02:32:22 INFO - 'SHLVL': '1', 02:32:22 INFO - 'TERM': 'linux', 02:32:22 INFO - 'TMOUT': '86400', 02:32:22 INFO - 'USER': 'cltbld', 02:32:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:22 INFO - '_': '/tools/buildbot/bin/python'} 02:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:22 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)) 02:32:22 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)) 02:32:22 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)) 02:32:22 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)) 02:32:22 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)) 02:32:22 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)) 02:32:22 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)) 02:32:22 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)) 02:32:22 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)) 02:32:22 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)) 02:32:22 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)) 02:32:22 INFO - Cleaning up... 02:32:22 INFO - Return code: 0 02:32:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:32:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:32:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:32:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6dcdd3bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x203e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x210bca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', '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 02:32:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 02:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 02:32:22 INFO - Using env: {'DISPLAY': ':0', 02:32:22 INFO - 'HOME': '/home/cltbld', 02:32:22 INFO - 'LANG': 'en_US.UTF-8', 02:32:22 INFO - 'LANGUAGE': 'en_US:en', 02:32:22 INFO - 'LOGNAME': 'cltbld', 02:32:22 INFO - 'MAIL': '/var/mail/cltbld', 02:32:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:22 INFO - 'MOZ_NO_REMOTE': '1', 02:32:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:22 INFO - 'NO_EM_RESTART': '1', 02:32:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:22 INFO - 'PWD': '/builds/slave/test', 02:32:22 INFO - 'SHELL': '/bin/bash', 02:32:22 INFO - 'SHLVL': '1', 02:32:22 INFO - 'TERM': 'linux', 02:32:22 INFO - 'TMOUT': '86400', 02:32:22 INFO - 'USER': 'cltbld', 02:32:22 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:22 INFO - '_': '/tools/buildbot/bin/python'} 02:32:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:32:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:32:22 INFO - Cleaning up... 02:32:22 INFO - Return code: 0 02:32:22 INFO - Running post-action listener: _resource_record_post_action 02:32:22 INFO - Running post-action listener: _start_resource_monitoring 02:32:22 INFO - Starting resource monitoring. 02:32:22 INFO - [mozharness: 2017-01-04 10:32:22.804294Z] Finished create-virtualenv step (success) 02:32:22 INFO - [mozharness: 2017-01-04 10:32:22.804870Z] Running install step. 02:32:22 INFO - Running pre-action listener: _resource_record_pre_action 02:32:22 INFO - Running main action method: install 02:32:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:32:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:32:23 INFO - Reading from file tmpfile_stdout 02:32:23 INFO - Detecting whether we're running mozinstall >=1.0... 02:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:32:23 INFO - Reading from file tmpfile_stdout 02:32:23 INFO - Output received: 02:32:23 INFO - Usage: mozinstall [options] installer 02:32:23 INFO - Options: 02:32:23 INFO - -h, --help show this help message and exit 02:32:23 INFO - -d DEST, --destination=DEST 02:32:23 INFO - Directory to install application into. [default: 02:32:23 INFO - "/builds/slave/test"] 02:32:23 INFO - --app=APP Application being installed. [default: firefox] 02:32:23 INFO - mkdir: /builds/slave/test/build/application 02:32:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:32:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:32:39 INFO - Reading from file tmpfile_stdout 02:32:39 INFO - Output received: 02:32:39 INFO - /builds/slave/test/build/application/firefox/firefox 02:32:39 INFO - Running post-action listener: _resource_record_post_action 02:32:39 INFO - [mozharness: 2017-01-04 10:32:39.044644Z] Finished install step (success) 02:32:39 INFO - [mozharness: 2017-01-04 10:32:39.044886Z] Running run-tests step. 02:32:39 INFO - Running pre-action listener: _resource_record_pre_action 02:32:39 INFO - Running main action method: run_tests 02:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:32:39 INFO - Python 2.7.3 02:32:39 INFO - Return code: 0 02:32:39 INFO - grabbing minidump binary from tooltool 02:32:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:32:39 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 0x2108f60>, '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 0x2109d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x210a1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:32:39 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 02:32:39 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 02:32:39 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 02:32:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:32:39 INFO - Return code: 0 02:32:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:32:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:32:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:32:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:32:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:32:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 02:32:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 02:32:39 INFO - Using env: {'DISPLAY': ':0', 02:32:39 INFO - 'HOME': '/home/cltbld', 02:32:39 INFO - 'LANG': 'en_US.UTF-8', 02:32:39 INFO - 'LANGUAGE': 'en_US:en', 02:32:39 INFO - 'LOGNAME': 'cltbld', 02:32:39 INFO - 'MAIL': '/var/mail/cltbld', 02:32:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:32:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:32:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:32:39 INFO - 'MOZ_NO_REMOTE': '1', 02:32:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:32:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:32:39 INFO - 'NO_EM_RESTART': '1', 02:32:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:32:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:32:39 INFO - 'PWD': '/builds/slave/test', 02:32:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:32:39 INFO - 'SHELL': '/bin/bash', 02:32:39 INFO - 'SHLVL': '1', 02:32:39 INFO - 'TERM': 'linux', 02:32:39 INFO - 'TMOUT': '86400', 02:32:39 INFO - 'USER': 'cltbld', 02:32:39 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725', 02:32:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:32:39 INFO - '_': '/tools/buildbot/bin/python'} 02:32:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 02:32:39 INFO - mozversion application_buildid: 20170104004006 02:32:39 INFO - mozversion application_changeset: 236b90305efbbc79f66ca1453be47f3688b26c7a 02:32:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:32:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:32:39 INFO - mozversion application_name: Firefox 02:32:39 INFO - mozversion application_remotingname: firefox-dev 02:32:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:32:39 INFO - mozversion application_vendor: Mozilla 02:32:39 INFO - mozversion application_version: 52.0a2 02:32:39 INFO - mozversion platform_buildid: 20170104004006 02:32:39 INFO - mozversion platform_changeset: 236b90305efbbc79f66ca1453be47f3688b26c7a 02:32:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:32:39 INFO - mozversion platform_version: 52.0a2 02:32:39 INFO - using testdate: 1483525959 02:32:39 INFO - actual date: 1483525959 02:32:39 INFO - starting webserver on 'localhost:45611' 02:32:39 INFO - SUITE-START | Running 2 tests 02:32:39 INFO - TEST-START | dromaeo_css 02:32:39 INFO - operating with platform_type : linux_ 02:32:39 INFO - Initialising browser for dromaeo_css test... 02:32:39 INFO - TEST-INFO | started process 12498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQqBvss/profile http://localhost:45611/getInfo.html) 02:32:43 INFO - PROCESS | 12498 | __metrics Screen width/height:1600/1200 02:32:43 INFO - PROCESS | 12498 | colorDepth:24 02:32:43 INFO - PROCESS | 12498 | Browser inner width/height: 1024/697 02:32:43 INFO - PROCESS | 12498 | __metrics 02:32:43 INFO - PROCESS | 12498 | 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" 02:32:43 INFO - PROCESS | 12498 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:32:44 INFO - PROCESS | 12498 | console.error: PushService: 02:32:44 INFO - PROCESS | 12498 | stateChangeProcessEnqueue: Error transitioning state 02:32:44 INFO - PROCESS | 12498 | UnknownError 02:32:44 INFO - TEST-INFO | 12498: exit 0 02:32:44 INFO - Browser initialized. 02:32:44 INFO - Running cycle 1/1 for dromaeo_css test... 02:32:44 INFO - TEST-INFO | started process 12589 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQqBvss/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:32:56 INFO - PROCESS | 12589 | RSS: Main: 145297408 02:32:56 INFO - PROCESS | 12589 | 02:35:59 INFO - PROCESS | 12589 | Cycle 1(1): loaded http://localhost:45611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45611/tests/dromaeo/cssquery-ext.html) 02:36:00 INFO - PROCESS | 12589 | RSS: Main: 246784000 02:36:00 INFO - PROCESS | 12589 | 02:39:02 INFO - PROCESS | 12589 | Cycle 1(1): loaded http://localhost:45611/tests/dromaeo/cssquery-ext.html (next: http://localhost:45611/tests/dromaeo/cssquery-jquery.html) 02:39:03 INFO - PROCESS | 12589 | RSS: Main: 235802624 02:39:03 INFO - PROCESS | 12589 | 02:42:05 INFO - PROCESS | 12589 | Cycle 1(1): loaded http://localhost:45611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45611/tests/dromaeo/cssquery-mootools.html) 02:42:05 INFO - PROCESS | 12589 | RSS: Main: 204890112 02:42:05 INFO - PROCESS | 12589 | 02:45:07 INFO - PROCESS | 12589 | Cycle 1(1): loaded http://localhost:45611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45611/tests/dromaeo/cssquery-prototype.html) 02:45:08 INFO - PROCESS | 12589 | RSS: Main: 218341376 02:45:08 INFO - PROCESS | 12589 | 02:48:11 INFO - PROCESS | 12589 | Cycle 1(1): loaded http://localhost:45611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45611/tests/dromaeo/cssquery-yui.html) 02:48:11 INFO - PROCESS | 12589 | RSS: Main: 172969984 02:48:11 INFO - PROCESS | 12589 | 02:51:14 INFO - PROCESS | 12589 | Cycle 1(1): loaded http://localhost:45611/tests/dromaeo/cssquery-yui.html (next: http://localhost:45611/tests/dromaeo/cssquery-dojo.html) 02:51:14 INFO - PROCESS | 12589 | RSS: Main: 266072064 02:51:14 INFO - PROCESS | 12589 | 02:51:14 INFO - PROCESS | 12589 | __start_tp_report 02:51:14 INFO - PROCESS | 12589 | _x_x_mozilla_page_load 02:51:14 INFO - PROCESS | 12589 | _x_x_mozilla_page_load_details 02:51:14 INFO - PROCESS | 12589 | |i|pagename|runs| 02:51:14 INFO - PROCESS | 12589 | |0;dojo.html;3187.9203019924503;3231.6929891660293;3240.5301231321473;3260.1849537615594;3273.6889995450424;5470.753816078276;5538.446155384465;5582.441755824416;5583.832485025446;5585.497305242538;5542.91685624715;5639.68981706006;5659.490645841874;5668.263125793651;5689.061304884689;5115.18157094864;5133.666311689747;5149.40781810091;5166.638335316529;5210.713410762407;5004.899902001957;5005.224190250517;5198.714070726109;5213.426523082477;5224.555912747421;5127.154019586782;5127.461616530267;5133.768980395873;5157.329547158864;5165.560927321182;5166.844994650167;5182.32629758129;5243.86890327741;5245.291885595434;5260.184671375943;4862.586680132193;5129.9743501282255;5142.897142057175;5196.818111366084;5209.60927930403;5423.566114710853;5454.781808727646;5460.754266058037;5496.0931446311315;5531.834044978657;5851.180834683105;5869.383714709937;5971.850703732398;5975.163477113208;5976.5218782497295;5924.526037916957;5980.192673989;5996.550258730613;6003.639781613074;6006.519478441714;5561.249231353715;5578.163275508706;5581.972090139564;5626.156076588544;5692.37383887772;6163.8150855474405;6174.536909731788;6182;6187.690615469299;6188.938110618927;5767.279090113736;5929.4070592941225;5929.911051334234;5934.258217722785;5937.70311484424;5900.1739756434135;5969.403059694083;6028.065649824284;6037.486813620803;6041.516678665696;5955.196048533479;5955.791547295824;5960.986632272524;5973.492253158443;6001;5657.9434205658235;5890.3815099414805;5942.37605051472;5973.820785376446;5974.551908606872;4470.508244093147;4529.116822219636;4540.931886021646;4559.589636932692;4584.426946631671;4099.549049604541;4126.277901367309;4129.731567448106;4147.6267135957305;4166.062635906957;5689.886202276014;5735.8566035849435;5738.397468265855;5754.539636829044;5755.3381361143165;5848.88302233953;5900.20347253124;5976.671283079472;6023;6079.665618390943;5791.247137872134;5805.042168042311;5805.245318108618;5815.331236907725;5840.912386314209;5186.5850731941355;5190.169572868323;5190.8961820764125;5203.453637368022;5205.7917683293;6089.360617135137;6119.228375855631;6120.721420533169;6256.655883926428;6311.084892690534;5950.077737950624;6064.06007068905;6071.39286071407;6093.512518998558;6107.816765497042;6275.874482510233;6289.308176100717;6295;6299.559030867796;6309.242890853127;5742.885142297047;5750.539956803362;5929.762809487572;5935.376785437467;5967.76128954837;5962.582619216613;5977.641341519523;5981.551383646157;6062.120992456157;6088;5848.093545500455;5880.235569375954;5889.764409423747;5895.498882595028;5900.380460051632;5515.200295957144;5871.266091738533;5875.6474611523445;5882.911756323573;5895.20414744004;5526.889462210653;5714.428557144252;5724.914126288192;5763.423657634203;5784.074548072288;5818.8254352369495;5827.475527202572;5834.27071616048;5842.941570584409;5843.532517398683;5622.887542249214;5654.491095801398;5658.660480371191;5705.800296989585;5722.141678748221 02:51:14 INFO - PROCESS | 12589 | |1;ext.html;570.4666137161754;591.7869566955895;620.7423919073585;658.2989116590827;668.5554106519165;34126.82936585317;47102.52897471024;47781.52218477814;47845.76077119618;47884.76057619716;47591.76204118983;48052.759736201355;48094.51905480944;48120.518794812044;48129.518704812945;8471.703490377839;8906.42108262964;9055.728328150166;9058.411203271766;9065;8379.62291696875;10551.525181366856;10768.300060496082;10780.73048173794;11138.387388693618;11033.062189713844;11101.38942358174;11108.111351091933;11114.888851111507;11116.55533778652;10655.467226638675;10678.305910115818;10685.893141068607;10692.572297108107;10724.249302548824;10789.946050269698;10847.186461015455;10853.589033425604;10855.077318427942;10863.239573229877;44897.102057958655;44951;45116.3232551512;45127.32309015367;45158.09683806305;3860.3437415639128;4008.07814202735;4083.693722970789;4141.565135660772;4406.2949928011685;34244;34306.31387372263;34357.14107147316;34363;34381.48427773586;4490.932636010462;4499.662525310582;4569;4572.977135114304;4660.207764680013;359829;359930;360074;361375;361972;63841.36158638447;64183.395415114996;64229;64240.678796605716;64243.357566424675;40002.799986000464;40669.79665101656;40970.18059638791;43252;43469;19402.514937126685;19635.116419761143;19648.90175549113;19660.606787864162;19668;12389.690257743629;12777.808332875014;13950.860491394957;14981.775273370908;15181.848181518264;20289.28987485431;20911.37265882026;21017.789822101582;21066.78933210679;21095.367138985854;7388.593627350548;7661.774116141391;7727.884081738778;7768.611569421506;7859.017622797151;1069.3476979042778;1094.0591091661165;1133.523919953605;1170.976580468386;1179.8525184351956;34760.95518715831;34866.65133348685;34990.30019399598;34999.30001399958;35036.299274014884;1138.4706111658118;1147.4549588945351;1148.9138314626268;1213.5267245774155;1246.1028059796931;18838.3406580769;19710.40868773939;19854.90072549628;19862.51718535183;20025.39923802259;529539;531618;532506;532509;532590;62152.06771898425;62450.68774656098;63017.36982630115;63023.68488157621;63070.36929630737;1300.8699130087105;1383.6402535340683;1400.2578633324354;1440.7694768836936;1494.2006026775841;33806.49290260697;35814;36000.459993100645;36022;36232.27535449329;53097;53798.19302710541;53829.46170538245;53855;53876.73061634667;401237;402319;402355;405276;407117;30653.540196896618;31078.844605776827;31665.683343166274;31883.521747174276;31943.840280798446;50146.247806282205;50152.498475014785;50174;50187.74906125446;50511.74744126256;42745.35881961711;42756.358654620824;42894.78552607217;43527.56472435235;44649.33026004677;42147.57852421559;42353.5764642362;43169.35245971376;43726;44034.77982610066;43194;43970.560294397925;44380.778096109316;44958.55041449544;45010.099798004514;37349.25301494009;39085.41371879367;39361.73933026588;39647;39909.2018159641;29545.556816648197;29602;29852.85073574705;29889.701102989562;30294.84852575723 02:51:14 INFO - PROCESS | 12589 | |2;jquery.html;398.8464441190141;415.64877678361773;429.5854500407107;430.14615987265285;447.4228245563224;15290.69418611627;19197.944113073794;20092.698609520852;20259.39221823344;20426.2850800222;19299.324523641677;20208.292709755162;20272.594548109028;20314.89842550789;20500.897495512538;5754.424557544254;5995.640261584319;5996.100584912255;6005.4895333896675;6008.1888944992525;5575.916361254564;5846.09385545239;5864.325602555697;5867.794627188049;5868.589198756089;5656.208130861683;5850.502707269887;5852.590318677694;5853.268341457318;5853.297604287492;5799.913001304963;5805.796797112102;5840.3575606683235;5853.414658534155;5860.413958604148;5242.606804489678;5288.709120998344;5293.338332708411;5293.947060529423;5534.612577119603;22703.886480567493;23046.423839403982;23348.18281360144;23355;23587.764122358727;2425.943062977019;2914.8688309025933;3035.4991426414617;3048.085574327693;3078.2304423894025;10866.076383507412;10973.396463194522;10975.231733778639;10983.121350291958;11075.335479871233;1960;1967.144292232869;1974.5261137327082;2011.1352118589;2041.5406533529838;68287.65856170688;87504.12495875024;88331.55834220788;89636.10363896408;89872.5506372464;10633.308834925705;10643.361398316125;10694.197935154894;10922.890771092187;10935.453227338601;15413.152276624893;15790.289436975363;15934;15984.200789960456;15998.76001859973;7255.927440725525;7815.29662330393;8096.028476582847;8424.747257582283;8620.95689521561;8356.958215208884;8611.268042216356;8711.21599056088;8984.23633991105;9031.729048128567;4595.264757638762;4605.631549476034;4620.607248383925;5189.117849965515;5191.740412979336;2075.647139986206;2116.3227767114377;2140.265237161164;2155.4072630026553;2170.056025628825;906.5014242166914;1003.6487229469773;1006.0191313469455;1061.5117046158698;1086.8098082835472;19747.01264936776;20061.197552097754;20757.89621051885;20799.272025479037;20938.685919711217;974.7124598243536;1011.8988101189822;1036.7097212780434;1037.242812746684;1043.6555936540924;10551.683449496528;11553.884461155449;11683.299002059903;11701.882981170249;11728.472218750177;464095;466087;478742;481265;484420;89717.55141224383;90925.54537227271;93203;94487;94897.525512372;1017.2065788684986;1052.310736467615;1068.0814499530397;1075.306427354352;1083.6748975307376;17760.822391776434;18192.81807181964;18381.080945952915;18674.719879202094;18916.527086822938;40986.77039688814;42503;43668.56331436772;43707.34438983354;45658.54341456543;59027;59472.70263648654;59582.70208648929;60260;60276;6298.905516417349;7981.561014144046;8394.622241999003;8698.391112622308;9183.494907780136;13033.869661303266;13598.592042238748;13857.4457021718;13915.58253252404;14019.088759230617;12130.878691212974;12158.817617735918;12255.69360765988;12320.815187772012;12469.064820138707;11920.403979801149;11928.642140735792;12001.519939202333;12108.273503589813;12393.380330983235;12020;12062.336571488653;12125.878741212475;12403.13178077562;12519.311437871005;8375.120612335617;8401.369897257608;8533.487990720576;8834.204921557091;8975.908388477143;9106.134917182857;10994.560217591206;11638.06895448379;11918.284902905853;12187 02:51:14 INFO - PROCESS | 12589 | |3;mootools.html;1367.1113776045574;1471.6468047668557;1502.5116837027967;1651.983480165198;1841.2542920117357;7358.190599034108;7941.245581669747;8214.342852571795;8217.137200593941;8417.158284171579;8178.304844088259;8231.09457959624;8246.46397984132;8258.669653213865;8259.710910118147;2407.759224077587;2432.9538298531625;2433.9513209735796;2439.2194497760725;2439.5364880672614;2373.2405630198346;2407.301882454095;2478.7025556933195;2486.0925762096886;2488.191337815208;2384.0940442631777;2386.8567885926814;2402.8678422686835;2413.625887987356;2422.5760491913934;2346.577616029114;2372.881355932205;2381.071382160959;2388.1880160745345;2391.4738757473415;2374.536965291769;2392.7966122879575;2396.7962723168553;2398.4243781492314;2401.951960960771;8341.582920853994;8581.141885811432;8720.607572659246;8733;8756.255718263956;5330.600204984642;5546.27898373213;5556.555475561945;5558.666480011212;5558.86102847428;3358.9664103358896;3485.1112966193714;3491.1097670093964;3539.327527769741;3546.2198316370614;1036.4506811389974;1067.4075887882223;1069.6149386220955;1074.693712291993;1102.2725001499052;12061.457234424472;12115.273083614924;12137.453814578364;12152.392380381034;12169.269843809312;4383.583559561836;4670.789814458358;4735.786889589908;4820.783064762094;4833.9033219335415;9575.138237558653;9580;9587.712368628952;9600.279979001603;9608;5406.107992181324;5412.5940554458575;5413.9729301353245;5416.512513873691;5418.620696551204;4277.1873344064525;4417.315316126005;4981.302617633534;5055.848324550269;5078.111330517145;3850.5764365919727;3909.4722212501515;3924.8626298080003;3967.92064158721;4032.6370626643743;1178.8113901775675;1179.2099293473393;1186.0926391310654;1188.0198835960368;1192.546832203757;961.4183419031385;986.5313975861409;1001.2690735762934;1009.3136667066318;1019.4749703902496;5789.681567513743;6061.36355682647;6176;6231.657258850807;6316.652584107918;904.8235594059096;905.9456432614064;958.3770549143113;1011.7217765114506;1040.8750949886062;4104.671626269891;4313.9137217255475;4317.546657600969;4341.370501277297;4347.500037495665;10116.342437741523;10492.895071049345;10522.368657880552;10546.894531054744;10565.683029509128;10362.948185259025;10410.739731506774;10414.323069000491;10427.426491542887;10452.634157804441;7637.312641862148;8100.149484304181;8102.108768035511;8118.228768267005;8307.335413166933;6056.636601803906;6087.847803804941;6126.571140020156;6153.2000839890525;6250.843728906631;9177.724668259963;9204.309676774135;9207;9210.217131543626;9294.163525282756;9119.726408207764;9383.483908385104;9439.339246252697;9458.479783611967;9461.337706360764;6593.439557637655;6729.427998620172;6826.795196144124;7725.034370703662;7870.134285228734;7775.6112194388925;7861.331786798186;8190.303824175012;8381.622826972678;8469.5341756204;7688.654010569426;7729.1836418442745;7809.804754881174;8003.239692229229;8031.879521807295;7401.666924988281;7548.924510754822;7572.507786993828;7618.885716714143;7657.617119144132;6698.464122870256;6803.557768745016;6818.147731533559;6830.043793868763;6841.486888483284;5269.604779641466;5397.9460205397445;5424.945750542602;5438.211459338295;5506.366767821592;5241.816536421207;5277.076511610376;5289.127293996447;5330.893382132258;5368.060589396918 02:51:14 INFO - PROCESS | 12589 | |4;prototype.html;350.1054804973292;361.61307401080836;363.271640361076;364.4187520904157;367.31862395256815;5232.843014709565;5313.867153321169;5317.776911310401;5344.625876188668;5381.224196015311;5175.464022628904;5206.114960456722;5289.867753306169;5295.894082118355;5300.469953004697;4181.870894858386;4197.412362269285;4205.348171033479;4228.90048587368;4240.745555266679;4030.919381612366;4179.2059508693255;4189.895252618694;4224.450821393215;4242.469691288589;4135.607117323864;4151;4161.979190104045;4162.83348666053;4167.687423443239;4139.4204811326435;4145.854895078673;4158.771267580282;4164.042270277853;4167.937480937789;3678;3683.7053035757076;3694.741368104234;3705.573859006222;3708.740388172802;5024.422191447957;5169.172932330846;5203.427622961472;5207.166853303491;5225.555827754645;4809.302651115569;4820.301056346845;4820.734859582722;4825.059113472874;4825.445073816521;5383.946160538384;5524.944750552483;5546.916796248019;5547.25112109864;5560.916586251209;4036.820117136772;4052.8176232069627;4082.4896887889013;4090.1206240658403;4105.401949816195;5675.432456754333;5681.7727290908315;5721.937424428661;5732.570057245724;5758.424157584208;4193.364587810756;4203.453551038346;4212.873613791591;4225.148025083056;4228.492580890252;4158.91682166355;4212.662986961036;4213.620774130343;4245.766482843474;4269.850555230552;4755.0489902019735;4780.036377446006;4780.139574876555;4788.401449818773;4788.569028787426;5554.833354999357;5563.749631266603;5564.777408903679;5593.489757765462;5600.831975040755;1310.7313000834806;1345.6232254968625;1358.3479929633831;1365.6449323176046;1390.8956828237922;970.3450171134456;973.6640858903667;990.8612794208816;996.6611352140308;998.5905778630727;5170.224466330081;5170.5346518813485;5192;5228.215767634885;5230.038735474197;5444.537214336826;5459.454054594588;5460.290162278958;5471.452854714496;5483.972580137074;5153.561947234452;5194.883100133489;5235.089192444806;5255.580993131833;5436.6737995719595;2931.3697555025774;2931.5456104303867;2939.985300073529;2952.3062080411514;2955.9556606650917;5757.424257574209;5758.74085666146;5765.4522820332;5793.7392817323325;5808.137588503682;5456.017916774939;5576.86057848557;5620.634658747168;5638.23883775685;5640.5769567281795;5608.383077861432;5659.971700141473;5694.914576281276;5738.971305143447;5765.913511297334;5325.866853328698;5514.105094825249;5536.612437129363;5569.387367389503;5579.609427340048;5443.855556499228;5445.428230035947;5450.345958484849;5464.726763661881;5468.671879687232;5692.235407023836;5728.42468321215;5731;5755.884882302246;5786.739596718074;3927.9607203927594;4040.6565441937764;4054.1283624020975;4164.979580002919;4194.098268872085;5505.779768809363;5684.578855286179;5690.2887139107615;5696.231008813757;5711.828645140652;5400.648957817729;5488.533474654699;5598.636088654224;5598.712296171821;5605.234351179365;5578.581606379456;5594.664320140804;5598.076317407745;5606.551475882001;5613.691246981455;5299;5517.668939863621;5555.611107222456;5560.972195138998;5563.443655634404;5594.9369619772115;5617.387914619558;5622.217002583748;5629.845881594181;5637.830865074055;5497.4162143792355;5501.826778422581;5514.751836167462;5532.30846144232;5534.225208470898 02:51:14 INFO - PROCESS | 12589 | |5;yui.html;777.7316825695136;824.2869917521342;842.4902933725097;870.3776799588293;912.115248209237;14377.640558986031;15196.392144314228;15420.151891645983;15490.535283941486;15496.147711875843;14423.350949207284;14580;15208.239588020582;15274.312655930482;15698.607534811636;742.0687037767594;760.4942713095785;862.2455351567379;862.8058686795453;883.8409086364452;869.9217070463657;885.7874110213567;885.7962668586229;886.0961818944672;886.2201262888649;918.3342076994193;922.0088404964656;923.2936803345447;924.2190349154953;924.5515924776478;757.2654525110606;793.587334586012;848.2620120495209;917.2249449215435;917.8210249001447;662.8011596521025;666.114068289179;666.7199776094052;667.1127400557248;667.3160010988776;14824.555263342118;14833.332500037524;14864.70270594582;14873.925630371887;14903.403863845433;13823.930880345635;13912.791308130387;14025.579232623038;14048.297585120805;14066.296685165804;12889.226646401152;13098.083134180612;13119.606411807566;13139.14595551286;13180.406881690347;4386.8025938832825;4475.731456112644;4497.280435130396;4508.211063063951;4528.9547104528865;55896;57251.42748572503;57956.71021644907;63481.04778428327;64509.67745161244;11085.944570277097;11106.333619982664;11273.323600583992;11378.544858205745;11481.770364592829;18024;18359.90820045918;18783.718244226347;20118.49703757418;20395.490112747004;8275.255227029476;8324.916750832414;8389.53857537829;8534;8595.054464498658;4753.33453316536;4764.8332308369045;4799.28010798383;4915.139850526144;4961.280614310905;3578.8210589470423;3693.6306369363388;3701.981490092532;3705.2033812729856;3708.9814550927613;658.8846951783419;661.2296674374396;663.3896814930275;676.2932735291632;676.3270545806954;711.6726305899241;720.661289194078;722.0901663903519;726.6148941061246;731.352752813753;9380.311543922024;9996.900030999597;10147.847782283272;10388.584456621651;10545.947270263752;676.3356886079088;788.4480863395646;800.5876973358725;806.2300503019602;828.8052307707684;4917.606591472673;4979.427365852901;4982;4994.525520075587;5042.722650254272;85971.14028859632;91120;93782;93828;95220;62777.372226277155;64345;80169.79745303825;81849;81852.18147818446;65172.67413662996;65381.34618653753;65911.67044164844;66481.33518664751;66912.99630505547;10088.899111008795;10236.795264094826;10288.434136122585;10293.228007899586;10425.374477531372;32529.512057319633;32858.50712239366;38459.42310865395;43046;45730.31404529001;56841;57708.42291577198;59345.40654593399;59520;62035.37964620296;12757.170783899388;12900.741985160057;13055.34723263852;13157.473701052233;13170.802437963246;14565.271736412926;14585.708285834437;14842.257887105385;14878.404863805326;15426.074435533905;13818.447262109403;14015.50945716895;14468.927655362077;14693.412263509339;14802.259887005392;13891.72216555643;13988.510402135877;14539.78190327167;14539.92730036343;14670;13609.931950340186;13839.100458470168;14347.85652143507;14555.854441455449;14693.338799753823;10383.325083869524;10447.68656940293;10706.464676765974;10962.397068161008;11202.83195752048;11856.644300670994;11874.881251187722;11982.343061823874;12054.578089766816;12210.938945305217 02:51:14 INFO - PROCESS | 12589 | __end_tp_report 02:51:14 INFO - PROCESS | 12589 | __start_cc_report 02:51:14 INFO - PROCESS | 12589 | _x_x_mozilla_cycle_collect,1025 02:51:14 INFO - PROCESS | 12589 | __end_cc_report 02:51:14 INFO - PROCESS | 12589 | __startTimestamp1483527074780__endTimestamp 02:51:14 INFO - PROCESS | 12589 | 02:51:14 INFO - PROCESS | 12589 | ------- Summary: start ------- 02:51:14 INFO - PROCESS | 12589 | Number of tests: 6 02:51:14 INFO - PROCESS | 12589 | 02:51:14 INFO - PROCESS | 12589 | [#0] dojo.html Cycles:165 Average:5569.63 Median:5763.42 stddev:626.30 (10.9%) stddev-sans-first:599.71 02:51:14 INFO - PROCESS | 12589 | Values: 3187.9 3231.7 3240.5 3260.2 3273.7 5470.8 5538.4 5582.4 5583.8 5585.5 5542.9 5639.7 5659.5 5668.3 5689.1 5115.2 5133.7 5149.4 5166.6 5210.7 5004.9 5005.2 5198.7 5213.4 5224.6 5127.2 5127.5 5133.8 5157.3 5165.6 5166.8 5182.3 5243.9 5245.3 5260.2 4862.6 5130.0 5142.9 5196.8 5209.6 5423.6 5454.8 5460.8 5496.1 5531.8 5851.2 5869.4 5971.9 5975.2 5976.5 5924.5 5980.2 5996.6 6003.6 6006.5 5561.2 5578.2 5582.0 5626.2 5692.4 6163.8 6174.5 6182.0 6187.7 6188.9 5767.3 5929.4 5929.9 5934.3 5937.7 5900.2 5969.4 6028.1 6037.5 6041.5 5955.2 5955.8 5961.0 5973.5 6001.0 5657.9 5890.4 5942.4 5973.8 5974.6 4470.5 4529.1 4540.9 4559.6 4584.4 4099.5 4126.3 4129.7 4147.6 4166.1 5689.9 5735.9 5738.4 5754.5 5755.3 5848.9 5900.2 5976.7 6023.0 6079.7 5791.2 5805.0 5805.2 5815.3 5840.9 5186.6 5190.2 5190.9 5203.5 5205.8 6089.4 6119.2 6120.7 6256.7 6311.1 5950.1 6064.1 6071.4 6093.5 6107.8 6275.9 6289.3 6295.0 6299.6 6309.2 5742.9 5750.5 5929.8 5935.4 5967.8 5962.6 5977.6 5981.6 6062.1 6088.0 5848.1 5880.2 5889.8 5895.5 5900.4 5515.2 5871.3 5875.6 5882.9 5895.2 5526.9 5714.4 5724.9 5763.4 5784.1 5818.8 5827.5 5834.3 5842.9 5843.5 5622.9 5654.5 5658.7 5705.8 5722.1 02:51:14 INFO - PROCESS | 12589 | 02:51:14 INFO - PROCESS | 12589 | [#1] ext.html Cycles:180 Average:60804.27 Median:39956.00 stddev:115678.98 (289.5%) stddev-sans-first:115915.09 02:51:14 INFO - PROCESS | 12589 | Values: 570.5 591.8 620.7 658.3 668.6 34126.8 47102.5 47781.5 47845.8 47884.8 47591.8 48052.8 48094.5 48120.5 48129.5 8471.7 8906.4 9055.7 9058.4 9065.0 8379.6 10551.5 10768.3 10780.7 11138.4 11033.1 11101.4 11108.1 11114.9 11116.6 10655.5 10678.3 10685.9 10692.6 10724.2 10789.9 10847.2 10853.6 10855.1 10863.2 44897.1 44951.0 45116.3 45127.3 45158.1 3860.3 4008.1 4083.7 4141.6 4406.3 34244.0 34306.3 34357.1 34363.0 34381.5 4490.9 4499.7 4569.0 4573.0 4660.2 359829.0 359930.0 360074.0 361375.0 361972.0 63841.4 64183.4 64229.0 64240.7 64243.4 40002.8 40669.8 40970.2 43252.0 43469.0 19402.5 19635.1 19648.9 19660.6 19668.0 12389.7 12777.8 13950.9 14981.8 15181.8 20289.3 20911.4 21017.8 21066.8 21095.4 7388.6 7661.8 7727.9 7768.6 7859.0 1069.3 1094.1 1133.5 1171.0 1179.9 34761.0 34866.7 34990.3 34999.3 35036.3 1138.5 1147.5 1148.9 1213.5 1246.1 18838.3 19710.4 19854.9 19862.5 20025.4 529539.0 531618.0 532506.0 532509.0 532590.0 62152.1 62450.7 63017.4 63023.7 63070.4 1300.9 1383.6 1400.3 1440.8 1494.2 33806.5 35814.0 36000.5 36022.0 36232.3 53097.0 53798.2 53829.5 53855.0 53876.7 401237.0 402319.0 402355.0 405276.0 407117.0 30653.5 31078.8 31665.7 31883.5 31943.8 50146.2 50152.5 50174.0 50187.7 50511.7 42745.4 42756.4 42894.8 43527.6 44649.3 42147.6 42353.6 43169.4 43726.0 44034.8 43194.0 43970.6 44380.8 44958.6 45010.1 37349.3 39085.4 39361.7 39647.0 39909.2 29545.6 29602.0 29852.9 29889.7 30294.8 02:51:14 INFO - PROCESS | 12589 | 02:51:14 INFO - PROCESS | 12589 | [#2] jquery.html Cycles:180 Average:29016.82 Median:23471.38 stddev:78484.79 (334.4%) stddev-sans-first:78675.54 02:51:14 INFO - PROCESS | 12589 | Values: 398.8 415.6 429.6 430.1 447.4 15290.7 19197.9 20092.7 20259.4 20426.3 19299.3 20208.3 20272.6 20314.9 20500.9 5754.4 5995.6 5996.1 6005.5 6008.2 5575.9 5846.1 5864.3 5867.8 5868.6 5656.2 5850.5 5852.6 5853.3 5853.3 5799.9 5805.8 5840.4 5853.4 5860.4 5242.6 5288.7 5293.3 5293.9 5534.6 22703.9 23046.4 23348.2 23355.0 23587.8 2425.9 2914.9 3035.5 3048.1 3078.2 10866.1 10973.4 10975.2 10983.1 11075.3 1960.0 1967.1 1974.5 2011.1 2041.5 68287.7 87504.1 88331.6 89636.1 89872.6 10633.3 10643.4 10694.2 10922.9 10935.5 15413.2 15790.3 15934.0 15984.2 15998.8 7255.9 7815.3 8096.0 8424.7 8621.0 8357.0 8611.3 8711.2 8984.2 9031.7 4595.3 4605.6 4620.6 5189.1 5191.7 2075.6 2116.3 2140.3 2155.4 2170.1 906.5 1003.6 1006.0 1061.5 1086.8 19747.0 20061.2 20757.9 20799.3 20938.7 974.7 1011.9 1036.7 1037.2 1043.7 10551.7 11553.9 11683.3 11701.9 11728.5 464095.0 466087.0 478742.0 481265.0 484420.0 89717.6 90925.5 93203.0 94487.0 94897.5 1017.2 1052.3 1068.1 1075.3 1083.7 17760.8 18192.8 18381.1 18674.7 18916.5 40986.8 42503.0 43668.6 43707.3 45658.5 59027.0 59472.7 59582.7 60260.0 60276.0 6298.9 7981.6 8394.6 8698.4 9183.5 13033.9 13598.6 13857.4 13915.6 14019.1 12130.9 12158.8 12255.7 12320.8 12469.1 11920.4 11928.6 12001.5 12108.3 12393.4 12020.0 12062.3 12125.9 12403.1 12519.3 8375.1 8401.4 8533.5 8834.2 8975.9 9106.1 10994.6 11638.1 11918.3 12187.0 02:51:14 INFO - PROCESS | 12589 | 02:51:14 INFO - PROCESS | 12589 | [#3] mootools.html Cycles:180 Average:5680.01 Median:5349.48 stddev:3088.52 (57.7%) stddev-sans-first:3080.18 02:51:14 INFO - PROCESS | 12589 | Values: 1367.1 1471.6 1502.5 1652.0 1841.3 7358.2 7941.2 8214.3 8217.1 8417.2 8178.3 8231.1 8246.5 8258.7 8259.7 2407.8 2433.0 2434.0 2439.2 2439.5 2373.2 2407.3 2478.7 2486.1 2488.2 2384.1 2386.9 2402.9 2413.6 2422.6 2346.6 2372.9 2381.1 2388.2 2391.5 2374.5 2392.8 2396.8 2398.4 2402.0 8341.6 8581.1 8720.6 8733.0 8756.3 5330.6 5546.3 5556.6 5558.7 5558.9 3359.0 3485.1 3491.1 3539.3 3546.2 1036.5 1067.4 1069.6 1074.7 1102.3 12061.5 12115.3 12137.5 12152.4 12169.3 4383.6 4670.8 4735.8 4820.8 4833.9 9575.1 9580.0 9587.7 9600.3 9608.0 5406.1 5412.6 5414.0 5416.5 5418.6 4277.2 4417.3 4981.3 5055.8 5078.1 3850.6 3909.5 3924.9 3967.9 4032.6 1178.8 1179.2 1186.1 1188.0 1192.5 961.4 986.5 1001.3 1009.3 1019.5 5789.7 6061.4 6176.0 6231.7 6316.7 904.8 905.9 958.4 1011.7 1040.9 4104.7 4313.9 4317.5 4341.4 4347.5 10116.3 10492.9 10522.4 10546.9 10565.7 10362.9 10410.7 10414.3 10427.4 10452.6 7637.3 8100.1 8102.1 8118.2 8307.3 6056.6 6087.8 6126.6 6153.2 6250.8 9177.7 9204.3 9207.0 9210.2 9294.2 9119.7 9383.5 9439.3 9458.5 9461.3 6593.4 6729.4 6826.8 7725.0 7870.1 7775.6 7861.3 8190.3 8381.6 8469.5 7688.7 7729.2 7809.8 8003.2 8031.9 7401.7 7548.9 7572.5 7618.9 7657.6 6698.5 6803.6 6818.1 6830.0 6841.5 5269.6 5397.9 5424.9 5438.2 5506.4 5241.8 5277.1 5289.1 5330.9 5368.1 02:51:14 INFO - PROCESS | 12589 | 02:51:14 INFO - PROCESS | 12589 | [#4] prototype.html Cycles:180 Average:4662.71 Median:5307.17 stddev:1343.71 (25.3%) stddev-sans-first:1307.91 02:51:14 INFO - PROCESS | 12589 | Values: 350.1 361.6 363.3 364.4 367.3 5232.8 5313.9 5317.8 5344.6 5381.2 5175.5 5206.1 5289.9 5295.9 5300.5 4181.9 4197.4 4205.3 4228.9 4240.7 4030.9 4179.2 4189.9 4224.5 4242.5 4135.6 4151.0 4162.0 4162.8 4167.7 4139.4 4145.9 4158.8 4164.0 4167.9 3678.0 3683.7 3694.7 3705.6 3708.7 5024.4 5169.2 5203.4 5207.2 5225.6 4809.3 4820.3 4820.7 4825.1 4825.4 5383.9 5524.9 5546.9 5547.3 5560.9 4036.8 4052.8 4082.5 4090.1 4105.4 5675.4 5681.8 5721.9 5732.6 5758.4 4193.4 4203.5 4212.9 4225.1 4228.5 4158.9 4212.7 4213.6 4245.8 4269.9 4755.0 4780.0 4780.1 4788.4 4788.6 5554.8 5563.7 5564.8 5593.5 5600.8 1310.7 1345.6 1358.3 1365.6 1390.9 970.3 973.7 990.9 996.7 998.6 5170.2 5170.5 5192.0 5228.2 5230.0 5444.5 5459.5 5460.3 5471.5 5484.0 5153.6 5194.9 5235.1 5255.6 5436.7 2931.4 2931.5 2940.0 2952.3 2956.0 5757.4 5758.7 5765.5 5793.7 5808.1 5456.0 5576.9 5620.6 5638.2 5640.6 5608.4 5660.0 5694.9 5739.0 5765.9 5325.9 5514.1 5536.6 5569.4 5579.6 5443.9 5445.4 5450.3 5464.7 5468.7 5692.2 5728.4 5731.0 5755.9 5786.7 3928.0 4040.7 4054.1 4165.0 4194.1 5505.8 5684.6 5690.3 5696.2 5711.8 5400.6 5488.5 5598.6 5598.7 5605.2 5578.6 5594.7 5598.1 5606.6 5613.7 5299.0 5517.7 5555.6 5561.0 5563.4 5594.9 5617.4 5622.2 5629.8 5637.8 5497.4 5501.8 5514.8 5532.3 5534.2 02:51:14 INFO - PROCESS | 12589 | 02:51:14 INFO - PROCESS | 12589 | [#5] yui.html Cycles:180 Average:17765.56 Median:4518.58 stddev:22921.81 (507.3%) stddev-sans-first:22950.62 02:51:14 INFO - PROCESS | 12589 | Values: 777.7 824.3 842.5 870.4 912.1 14377.6 15196.4 15420.2 15490.5 15496.1 14423.4 14580.0 15208.2 15274.3 15698.6 742.1 760.5 862.2 862.8 883.8 869.9 885.8 885.8 886.1 886.2 918.3 922.0 923.3 924.2 924.6 757.3 793.6 848.3 917.2 917.8 662.8 666.1 666.7 667.1 667.3 14824.6 14833.3 14864.7 14873.9 14903.4 13823.9 13912.8 14025.6 14048.3 14066.3 12889.2 13098.1 13119.6 13139.1 13180.4 4386.8 4475.7 4497.3 4508.2 4529.0 55896.0 57251.4 57956.7 63481.0 64509.7 11085.9 11106.3 11273.3 11378.5 11481.8 18024.0 18359.9 18783.7 20118.5 20395.5 8275.3 8324.9 8389.5 8534.0 8595.1 4753.3 4764.8 4799.3 4915.1 4961.3 3578.8 3693.6 3702.0 3705.2 3709.0 658.9 661.2 663.4 676.3 676.3 711.7 720.7 722.1 726.6 731.4 9380.3 9996.9 10147.8 10388.6 10545.9 676.3 788.4 800.6 806.2 828.8 4917.6 4979.4 4982.0 4994.5 5042.7 85971.1 91120.0 93782.0 93828.0 95220.0 62777.4 64345.0 80169.8 81849.0 81852.2 65172.7 65381.3 65911.7 66481.3 66913.0 10088.9 10236.8 10288.4 10293.2 10425.4 32529.5 32858.5 38459.4 43046.0 45730.3 56841.0 57708.4 59345.4 59520.0 62035.4 12757.2 12900.7 13055.3 13157.5 13170.8 14565.3 14585.7 14842.3 14878.4 15426.1 13818.4 14015.5 14468.9 14693.4 14802.3 13891.7 13988.5 14539.8 14539.9 14670.0 13609.9 13839.1 14347.9 14555.9 14693.3 10383.3 10447.7 10706.5 10962.4 11202.8 11856.6 11874.9 11982.3 12054.6 12210.9 02:51:14 INFO - PROCESS | 12589 | -------- Summary: end -------- 02:51:14 INFO - PROCESS | 12589 | 02:51:15 INFO - TEST-INFO | 12589: exit 0 02:51:15 INFO - TEST-OK | dromaeo_css | took 1116178ms 02:51:15 INFO - TEST-START | kraken 02:51:15 INFO - operating with platform_type : linux_ 02:51:15 INFO - Initialising browser for kraken test... 02:51:15 INFO - TEST-INFO | started process 12908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLTYN2z/profile http://localhost:45611/getInfo.html) 02:51:19 INFO - PROCESS | 12908 | __metrics Screen width/height:1600/1200 02:51:19 INFO - PROCESS | 12908 | colorDepth:24 02:51:19 INFO - PROCESS | 12908 | Browser inner width/height: 1024/697 02:51:19 INFO - PROCESS | 12908 | __metrics 02:51:20 INFO - PROCESS | 12908 | 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" 02:51:20 INFO - PROCESS | 12908 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:51:20 INFO - PROCESS | 12908 | console.error: PushService: 02:51:20 INFO - PROCESS | 12908 | stateChangeProcessEnqueue: Error transitioning state 02:51:20 INFO - PROCESS | 12908 | UnknownError 02:51:21 INFO - TEST-INFO | 12908: exit 0 02:51:21 INFO - Browser initialized. 02:51:21 INFO - Running cycle 1/1 for kraken test... 02:51:21 INFO - TEST-INFO | started process 13000 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLTYN2z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:51:33 INFO - PROCESS | 13000 | RSS: Main: 144519168 02:51:33 INFO - PROCESS | 13000 | 02:51:35 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45611/tests/kraken/driver.html?testName=audio-beat-detection) 02:51:36 INFO - PROCESS | 13000 | RSS: Main: 185815040 02:51:36 INFO - PROCESS | 13000 | 02:51:38 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45611/tests/kraken/driver.html?testName=audio-dft) 02:51:39 INFO - PROCESS | 13000 | RSS: Main: 174673920 02:51:39 INFO - PROCESS | 13000 | 02:51:42 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45611/tests/kraken/driver.html?testName=audio-fft) 02:51:42 INFO - PROCESS | 13000 | RSS: Main: 266158080 02:51:42 INFO - PROCESS | 13000 | 02:51:45 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45611/tests/kraken/driver.html?testName=audio-oscillator) 02:51:45 INFO - PROCESS | 13000 | RSS: Main: 172736512 02:51:45 INFO - PROCESS | 13000 | 02:51:47 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:51:48 INFO - PROCESS | 13000 | RSS: Main: 174518272 02:51:48 INFO - PROCESS | 13000 | 02:51:51 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45611/tests/kraken/driver.html?testName=imaging-darkroom) 02:51:51 INFO - PROCESS | 13000 | RSS: Main: 214003712 02:51:51 INFO - PROCESS | 13000 | 02:51:55 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45611/tests/kraken/driver.html?testName=imaging-desaturate) 02:51:55 INFO - PROCESS | 13000 | RSS: Main: 212705280 02:51:55 INFO - PROCESS | 13000 | 02:51:58 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45611/tests/kraken/driver.html?testName=json-parse-financial) 02:51:59 INFO - PROCESS | 13000 | RSS: Main: 211251200 02:51:59 INFO - PROCESS | 13000 | 02:52:00 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:52:01 INFO - PROCESS | 13000 | RSS: Main: 173506560 02:52:01 INFO - PROCESS | 13000 | 02:52:02 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45611/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:52:03 INFO - PROCESS | 13000 | RSS: Main: 180563968 02:52:03 INFO - PROCESS | 13000 | 02:52:05 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:52:06 INFO - PROCESS | 13000 | RSS: Main: 189157376 02:52:06 INFO - PROCESS | 13000 | 02:52:08 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:52:09 INFO - PROCESS | 13000 | RSS: Main: 198205440 02:52:09 INFO - PROCESS | 13000 | 02:52:11 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:52:12 INFO - PROCESS | 13000 | RSS: Main: 194994176 02:52:12 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | Cycle 1(1): loaded http://localhost:45611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45611/tests/kraken/driver.html?testName=ai-astar) 02:52:14 INFO - PROCESS | 13000 | RSS: Main: 246554624 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | __start_tp_report 02:52:14 INFO - PROCESS | 13000 | _x_x_mozilla_page_load 02:52:14 INFO - PROCESS | 13000 | _x_x_mozilla_page_load_details 02:52:14 INFO - PROCESS | 13000 | |i|pagename|runs| 02:52:14 INFO - PROCESS | 13000 | |0;ai-astar;104;114;111;113;112;113;112;113;112;111 02:52:14 INFO - PROCESS | 13000 | |1;audio-beat-detection;140;119;118;158;123;123;124;117;147;118 02:52:14 INFO - PROCESS | 13000 | |2;audio-dft;162;161;164;161;162;161;161;162;161;159 02:52:14 INFO - PROCESS | 13000 | |3;audio-fft;74;75;83;118;76;76;77;75;100;76 02:52:14 INFO - PROCESS | 13000 | |4;audio-oscillator;81;83;124;83;81;83;99;83;82;115 02:52:14 INFO - PROCESS | 13000 | |5;imaging-gaussian-blur;116;118;117;117;116;116;117;117;117;117 02:52:14 INFO - PROCESS | 13000 | |6;imaging-darkroom;146;147;147;147;147;147;146;147;146;146 02:52:14 INFO - PROCESS | 13000 | |7;imaging-desaturate;85;84;84;85;84;85;85;84;84;85 02:52:14 INFO - PROCESS | 13000 | |8;json-parse-financial;49;50;51;50;50;50;57;53;50;50 02:52:14 INFO - PROCESS | 13000 | |9;json-stringify-tinderbox;60;61;60;60;61;60;60;60;60;60 02:52:14 INFO - PROCESS | 13000 | |10;stanford-crypto-aes;82;76;75;81;75;75;75;76;76;76 02:52:14 INFO - PROCESS | 13000 | |11;stanford-crypto-ccm;122;122;122;120;121;127;120;120;163;125 02:52:14 INFO - PROCESS | 13000 | |12;stanford-crypto-pbkdf2;158;154;152;158;156;157;152;156;156;160 02:52:14 INFO - PROCESS | 13000 | |13;stanford-crypto-sha256-iterative;63;62;64;63;64;63;65;62;64;62 02:52:14 INFO - PROCESS | 13000 | __end_tp_report 02:52:14 INFO - PROCESS | 13000 | __start_cc_report 02:52:14 INFO - PROCESS | 13000 | _x_x_mozilla_cycle_collect,1586 02:52:14 INFO - PROCESS | 13000 | __end_cc_report 02:52:14 INFO - PROCESS | 13000 | __startTimestamp1483527134387__endTimestamp 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | ------- Summary: start ------- 02:52:14 INFO - PROCESS | 13000 | Number of tests: 14 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.50 stddev:2.80 (2.5%) stddev-sans-first:1.00 02:52:14 INFO - PROCESS | 13000 | Values: 104.0 114.0 111.0 113.0 112.0 113.0 112.0 113.0 112.0 111.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#1] audio-beat-detection Cycles:10 Average:128.70 Median:123.50 stddev:14.41 (11.7%) stddev-sans-first:14.69 02:52:14 INFO - PROCESS | 13000 | Values: 140.0 119.0 118.0 158.0 123.0 123.0 124.0 117.0 147.0 118.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.26 (0.8%) stddev-sans-first:1.32 02:52:14 INFO - PROCESS | 13000 | Values: 162.0 161.0 164.0 161.0 162.0 161.0 161.0 162.0 161.0 159.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:14.55 (19.1%) stddev-sans-first:15.07 02:52:14 INFO - PROCESS | 13000 | Values: 74.0 75.0 83.0 118.0 76.0 76.0 77.0 75.0 100.0 76.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#4] audio-oscillator Cycles:10 Average:91.40 Median:83.00 stddev:15.86 (19.1%) stddev-sans-first:16.37 02:52:14 INFO - PROCESS | 13000 | Values: 81.0 83.0 124.0 83.0 81.0 83.0 99.0 83.0 82.0 115.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 02:52:14 INFO - PROCESS | 13000 | Values: 116.0 118.0 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 02:52:14 INFO - PROCESS | 13000 | Values: 146.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 02:52:14 INFO - PROCESS | 13000 | Values: 85.0 84.0 84.0 85.0 84.0 85.0 85.0 84.0 84.0 85.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:50.00 stddev:2.36 (4.7%) stddev-sans-first:2.39 02:52:14 INFO - PROCESS | 13000 | Values: 49.0 50.0 51.0 50.0 50.0 50.0 57.0 53.0 50.0 50.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 02:52:14 INFO - PROCESS | 13000 | Values: 60.0 61.0 60.0 60.0 61.0 60.0 60.0 60.0 60.0 60.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#10] stanford-crypto-aes Cycles:10 Average:76.70 Median:76.00 stddev:2.58 (3.4%) stddev-sans-first:1.90 02:52:14 INFO - PROCESS | 13000 | Values: 82.0 76.0 75.0 81.0 75.0 75.0 75.0 76.0 76.0 76.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:122.00 stddev:13.13 (10.8%) stddev-sans-first:13.84 02:52:14 INFO - PROCESS | 13000 | Values: 122.0 122.0 122.0 120.0 121.0 127.0 120.0 120.0 163.0 125.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.90 Median:156.50 stddev:2.60 (1.7%) stddev-sans-first:2.65 02:52:14 INFO - PROCESS | 13000 | Values: 158.0 154.0 152.0 158.0 156.0 157.0 152.0 156.0 156.0 160.0 02:52:14 INFO - PROCESS | 13000 | 02:52:14 INFO - PROCESS | 13000 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.20 Median:63.50 stddev:1.03 (1.6%) stddev-sans-first:1.09 02:52:14 INFO - PROCESS | 13000 | Values: 63.0 62.0 64.0 63.0 64.0 63.0 65.0 62.0 64.0 62.0 02:52:14 INFO - PROCESS | 13000 | -------- Summary: end -------- 02:52:14 INFO - PROCESS | 13000 | 02:52:15 INFO - TEST-INFO | 13000: exit 0 02:52:15 INFO - TEST-OK | kraken | took 59964ms 02:52:15 INFO - SUITE-END | took 1176s 02:52:15 INFO - Completed test suite (00:19:36) 02:52:15 INFO - javascript benchmark 02:52:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3187.9203019924503, 3231.6929891660293, 3240.5301231321473, 3260.1849537615594, 3273.6889995450424, 5470.753816078276, 5538.446155384465, 5582.441755824416, 5583.832485025446, 5585.497305242538, 5542.91685624715, 5639.68981706006, 5659.490645841874, 5668.263125793651, 5689.061304884689, 5115.18157094864, 5133.666311689747, 5149.40781810091, 5166.638335316529, 5210.713410762407, 5004.899902001957, 5005.224190250517, 5198.714070726109, 5213.426523082477, 5224.555912747421, 5127.154019586782, 5127.461616530267, 5133.768980395873, 5157.329547158864, 5165.560927321182, 5166.844994650167, 5182.32629758129, 5243.86890327741, 5245.291885595434, 5260.184671375943, 4862.586680132193, 5129.9743501282255, 5142.897142057175, 5196.818111366084, 5209.60927930403, 5423.566114710853, 5454.781808727646, 5460.754266058037, 5496.0931446311315, 5531.834044978657, 5851.180834683105, 5869.383714709937, 5971.850703732398, 5975.163477113208, 5976.5218782497295, 5924.526037916957, 5980.192673989, 5996.550258730613, 6003.639781613074, 6006.519478441714, 5561.249231353715, 5578.163275508706, 5581.972090139564, 5626.156076588544, 5692.37383887772, 6163.8150855474405, 6174.536909731788, 6182.0, 6187.690615469299, 6188.938110618927, 5767.279090113736, 5929.4070592941225, 5929.911051334234, 5934.258217722785, 5937.70311484424, 5900.1739756434135, 5969.403059694083, 6028.065649824284, 6037.486813620803, 6041.516678665696, 5955.196048533479, 5955.791547295824, 5960.986632272524, 5973.492253158443, 6001.0, 5657.9434205658235, 5890.3815099414805, 5942.37605051472, 5973.820785376446, 5974.551908606872, 4470.508244093147, 4529.116822219636, 4540.931886021646, 4559.589636932692, 4584.426946631671, 4099.549049604541, 4126.277901367309, 4129.731567448106, 4147.6267135957305, 4166.062635906957, 5689.886202276014, 5735.8566035849435, 5738.397468265855, 5754.539636829044, 5755.3381361143165, 5848.88302233953, 5900.20347253124, 5976.671283079472, 6023.0, 6079.665618390943, 5791.247137872134, 5805.042168042311, 5805.245318108618, 5815.331236907725, 5840.912386314209, 5186.5850731941355, 5190.169572868323, 5190.8961820764125, 5203.453637368022, 5205.7917683293, 6089.360617135137, 6119.228375855631, 6120.721420533169, 6256.655883926428, 6311.084892690534, 5950.077737950624, 6064.06007068905, 6071.39286071407, 6093.512518998558, 6107.816765497042, 6275.874482510233, 6289.308176100717, 6295.0, 6299.559030867796, 6309.242890853127, 5742.885142297047, 5750.539956803362, 5929.762809487572, 5935.376785437467, 5967.76128954837, 5962.582619216613, 5977.641341519523, 5981.551383646157, 6062.120992456157, 6088.0, 5848.093545500455, 5880.235569375954, 5889.764409423747, 5895.498882595028, 5900.380460051632, 5515.200295957144, 5871.266091738533, 5875.6474611523445, 5882.911756323573, 5895.20414744004, 5526.889462210653, 5714.428557144252, 5724.914126288192, 5763.423657634203, 5784.074548072288, 5818.8254352369495, 5827.475527202572, 5834.27071616048, 5842.941570584409, 5843.532517398683, 5622.887542249214, 5654.491095801398, 5658.660480371191, 5705.800296989585, 5722.141678748221], "value": 5527.766171361936, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.4666137161754, 591.7869566955895, 620.7423919073585, 658.2989116590827, 668.5554106519165, 34126.82936585317, 47102.52897471024, 47781.52218477814, 47845.76077119618, 47884.76057619716, 47591.76204118983, 48052.759736201355, 48094.51905480944, 48120.518794812044, 48129.518704812945, 8471.703490377839, 8906.42108262964, 9055.728328150166, 9058.411203271766, 9065.0, 8379.62291696875, 10551.525181366856, 10768.300060496082, 10780.73048173794, 11138.387388693618, 11033.062189713844, 11101.38942358174, 11108.111351091933, 11114.888851111507, 11116.55533778652, 10655.467226638675, 10678.305910115818, 10685.893141068607, 10692.572297108107, 10724.249302548824, 10789.946050269698, 10847.186461015455, 10853.589033425604, 10855.077318427942, 10863.239573229877, 44897.102057958655, 44951.0, 45116.3232551512, 45127.32309015367, 45158.09683806305, 3860.3437415639128, 4008.07814202735, 4083.693722970789, 4141.565135660772, 4406.2949928011685, 34244.0, 34306.31387372263, 34357.14107147316, 34363.0, 34381.48427773586, 4490.932636010462, 4499.662525310582, 4569.0, 4572.977135114304, 4660.207764680013, 359829.0, 359930.0, 360074.0, 361375.0, 361972.0, 63841.36158638447, 64183.395415114996, 64229.0, 64240.678796605716, 64243.357566424675, 40002.799986000464, 40669.79665101656, 40970.18059638791, 43252.0, 43469.0, 19402.514937126685, 19635.116419761143, 19648.90175549113, 19660.606787864162, 19668.0, 12389.690257743629, 12777.808332875014, 13950.860491394957, 14981.775273370908, 15181.848181518264, 20289.28987485431, 20911.37265882026, 21017.789822101582, 21066.78933210679, 21095.367138985854, 7388.593627350548, 7661.774116141391, 7727.884081738778, 7768.611569421506, 7859.017622797151, 1069.3476979042778, 1094.0591091661165, 1133.523919953605, 1170.976580468386, 1179.8525184351956, 34760.95518715831, 34866.65133348685, 34990.30019399598, 34999.30001399958, 35036.299274014884, 1138.4706111658118, 1147.4549588945351, 1148.9138314626268, 1213.5267245774155, 1246.1028059796931, 18838.3406580769, 19710.40868773939, 19854.90072549628, 19862.51718535183, 20025.39923802259, 529539.0, 531618.0, 532506.0, 532509.0, 532590.0, 62152.06771898425, 62450.68774656098, 63017.36982630115, 63023.68488157621, 63070.36929630737, 1300.8699130087105, 1383.6402535340683, 1400.2578633324354, 1440.7694768836936, 1494.2006026775841, 33806.49290260697, 35814.0, 36000.459993100645, 36022.0, 36232.27535449329, 53097.0, 53798.19302710541, 53829.46170538245, 53855.0, 53876.73061634667, 401237.0, 402319.0, 402355.0, 405276.0, 407117.0, 30653.540196896618, 31078.844605776827, 31665.683343166274, 31883.521747174276, 31943.840280798446, 50146.247806282205, 50152.498475014785, 50174.0, 50187.74906125446, 50511.74744126256, 42745.35881961711, 42756.358654620824, 42894.78552607217, 43527.56472435235, 44649.33026004677, 42147.57852421559, 42353.5764642362, 43169.35245971376, 43726.0, 44034.77982610066, 43194.0, 43970.560294397925, 44380.778096109316, 44958.55041449544, 45010.099798004514, 37349.25301494009, 39085.41371879367, 39361.73933026588, 39647.0, 39909.2018159641, 29545.556816648197, 29602.0, 29852.85073574705, 29889.701102989562, 30294.84852575723], "value": 21527.651100781783, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.8464441190141, 415.64877678361773, 429.5854500407107, 430.14615987265285, 447.4228245563224, 15290.69418611627, 19197.944113073794, 20092.698609520852, 20259.39221823344, 20426.2850800222, 19299.324523641677, 20208.292709755162, 20272.594548109028, 20314.89842550789, 20500.897495512538, 5754.424557544254, 5995.640261584319, 5996.100584912255, 6005.4895333896675, 6008.1888944992525, 5575.916361254564, 5846.09385545239, 5864.325602555697, 5867.794627188049, 5868.589198756089, 5656.208130861683, 5850.502707269887, 5852.590318677694, 5853.268341457318, 5853.297604287492, 5799.913001304963, 5805.796797112102, 5840.3575606683235, 5853.414658534155, 5860.413958604148, 5242.606804489678, 5288.709120998344, 5293.338332708411, 5293.947060529423, 5534.612577119603, 22703.886480567493, 23046.423839403982, 23348.18281360144, 23355.0, 23587.764122358727, 2425.943062977019, 2914.8688309025933, 3035.4991426414617, 3048.085574327693, 3078.2304423894025, 10866.076383507412, 10973.396463194522, 10975.231733778639, 10983.121350291958, 11075.335479871233, 1960.0, 1967.144292232869, 1974.5261137327082, 2011.1352118589, 2041.5406533529838, 68287.65856170688, 87504.12495875024, 88331.55834220788, 89636.10363896408, 89872.5506372464, 10633.308834925705, 10643.361398316125, 10694.197935154894, 10922.890771092187, 10935.453227338601, 15413.152276624893, 15790.289436975363, 15934.0, 15984.200789960456, 15998.76001859973, 7255.927440725525, 7815.29662330393, 8096.028476582847, 8424.747257582283, 8620.95689521561, 8356.958215208884, 8611.268042216356, 8711.21599056088, 8984.23633991105, 9031.729048128567, 4595.264757638762, 4605.631549476034, 4620.607248383925, 5189.117849965515, 5191.740412979336, 2075.647139986206, 2116.3227767114377, 2140.265237161164, 2155.4072630026553, 2170.056025628825, 906.5014242166914, 1003.6487229469773, 1006.0191313469455, 1061.5117046158698, 1086.8098082835472, 19747.01264936776, 20061.197552097754, 20757.89621051885, 20799.272025479037, 20938.685919711217, 974.7124598243536, 1011.8988101189822, 1036.7097212780434, 1037.242812746684, 1043.6555936540924, 10551.683449496528, 11553.884461155449, 11683.299002059903, 11701.882981170249, 11728.472218750177, 464095.0, 466087.0, 478742.0, 481265.0, 484420.0, 89717.55141224383, 90925.54537227271, 93203.0, 94487.0, 94897.525512372, 1017.2065788684986, 1052.310736467615, 1068.0814499530397, 1075.306427354352, 1083.6748975307376, 17760.822391776434, 18192.81807181964, 18381.080945952915, 18674.719879202094, 18916.527086822938, 40986.77039688814, 42503.0, 43668.56331436772, 43707.34438983354, 45658.54341456543, 59027.0, 59472.70263648654, 59582.70208648929, 60260.0, 60276.0, 6298.905516417349, 7981.561014144046, 8394.622241999003, 8698.391112622308, 9183.494907780136, 13033.869661303266, 13598.592042238748, 13857.4457021718, 13915.58253252404, 14019.088759230617, 12130.878691212974, 12158.817617735918, 12255.69360765988, 12320.815187772012, 12469.064820138707, 11920.403979801149, 11928.642140735792, 12001.519939202333, 12108.273503589813, 12393.380330983235, 12020.0, 12062.336571488653, 12125.878741212475, 12403.13178077562, 12519.311437871005, 8375.120612335617, 8401.369897257608, 8533.487990720576, 8834.204921557091, 8975.908388477143, 9106.134917182857, 10994.560217591206, 11638.06895448379, 11918.284902905853, 12187.0], "value": 9509.03082970018, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1367.1113776045574, 1471.6468047668557, 1502.5116837027967, 1651.983480165198, 1841.2542920117357, 7358.190599034108, 7941.245581669747, 8214.342852571795, 8217.137200593941, 8417.158284171579, 8178.304844088259, 8231.09457959624, 8246.46397984132, 8258.669653213865, 8259.710910118147, 2407.759224077587, 2432.9538298531625, 2433.9513209735796, 2439.2194497760725, 2439.5364880672614, 2373.2405630198346, 2407.301882454095, 2478.7025556933195, 2486.0925762096886, 2488.191337815208, 2384.0940442631777, 2386.8567885926814, 2402.8678422686835, 2413.625887987356, 2422.5760491913934, 2346.577616029114, 2372.881355932205, 2381.071382160959, 2388.1880160745345, 2391.4738757473415, 2374.536965291769, 2392.7966122879575, 2396.7962723168553, 2398.4243781492314, 2401.951960960771, 8341.582920853994, 8581.141885811432, 8720.607572659246, 8733.0, 8756.255718263956, 5330.600204984642, 5546.27898373213, 5556.555475561945, 5558.666480011212, 5558.86102847428, 3358.9664103358896, 3485.1112966193714, 3491.1097670093964, 3539.327527769741, 3546.2198316370614, 1036.4506811389974, 1067.4075887882223, 1069.6149386220955, 1074.693712291993, 1102.2725001499052, 12061.457234424472, 12115.273083614924, 12137.453814578364, 12152.392380381034, 12169.269843809312, 4383.583559561836, 4670.789814458358, 4735.786889589908, 4820.783064762094, 4833.9033219335415, 9575.138237558653, 9580.0, 9587.712368628952, 9600.279979001603, 9608.0, 5406.107992181324, 5412.5940554458575, 5413.9729301353245, 5416.512513873691, 5418.620696551204, 4277.1873344064525, 4417.315316126005, 4981.302617633534, 5055.848324550269, 5078.111330517145, 3850.5764365919727, 3909.4722212501515, 3924.8626298080003, 3967.92064158721, 4032.6370626643743, 1178.8113901775675, 1179.2099293473393, 1186.0926391310654, 1188.0198835960368, 1192.546832203757, 961.4183419031385, 986.5313975861409, 1001.2690735762934, 1009.3136667066318, 1019.4749703902496, 5789.681567513743, 6061.36355682647, 6176.0, 6231.657258850807, 6316.652584107918, 904.8235594059096, 905.9456432614064, 958.3770549143113, 1011.7217765114506, 1040.8750949886062, 4104.671626269891, 4313.9137217255475, 4317.546657600969, 4341.370501277297, 4347.500037495665, 10116.342437741523, 10492.895071049345, 10522.368657880552, 10546.894531054744, 10565.683029509128, 10362.948185259025, 10410.739731506774, 10414.323069000491, 10427.426491542887, 10452.634157804441, 7637.312641862148, 8100.149484304181, 8102.108768035511, 8118.228768267005, 8307.335413166933, 6056.636601803906, 6087.847803804941, 6126.571140020156, 6153.2000839890525, 6250.843728906631, 9177.724668259963, 9204.309676774135, 9207.0, 9210.217131543626, 9294.163525282756, 9119.726408207764, 9383.483908385104, 9439.339246252697, 9458.479783611967, 9461.337706360764, 6593.439557637655, 6729.427998620172, 6826.795196144124, 7725.034370703662, 7870.134285228734, 7775.6112194388925, 7861.331786798186, 8190.303824175012, 8381.622826972678, 8469.5341756204, 7688.654010569426, 7729.1836418442745, 7809.804754881174, 8003.239692229229, 8031.879521807295, 7401.666924988281, 7548.924510754822, 7572.507786993828, 7618.885716714143, 7657.617119144132, 6698.464122870256, 6803.557768745016, 6818.147731533559, 6830.043793868763, 6841.486888483284, 5269.604779641466, 5397.9460205397445, 5424.945750542602, 5438.211459338295, 5506.366767821592, 5241.816536421207, 5277.076511610376, 5289.127293996447, 5330.893382132258, 5368.060589396918], "value": 4608.207004277115, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.1054804973292, 361.61307401080836, 363.271640361076, 364.4187520904157, 367.31862395256815, 5232.843014709565, 5313.867153321169, 5317.776911310401, 5344.625876188668, 5381.224196015311, 5175.464022628904, 5206.114960456722, 5289.867753306169, 5295.894082118355, 5300.469953004697, 4181.870894858386, 4197.412362269285, 4205.348171033479, 4228.90048587368, 4240.745555266679, 4030.919381612366, 4179.2059508693255, 4189.895252618694, 4224.450821393215, 4242.469691288589, 4135.607117323864, 4151.0, 4161.979190104045, 4162.83348666053, 4167.687423443239, 4139.4204811326435, 4145.854895078673, 4158.771267580282, 4164.042270277853, 4167.937480937789, 3678.0, 3683.7053035757076, 3694.741368104234, 3705.573859006222, 3708.740388172802, 5024.422191447957, 5169.172932330846, 5203.427622961472, 5207.166853303491, 5225.555827754645, 4809.302651115569, 4820.301056346845, 4820.734859582722, 4825.059113472874, 4825.445073816521, 5383.946160538384, 5524.944750552483, 5546.916796248019, 5547.25112109864, 5560.916586251209, 4036.820117136772, 4052.8176232069627, 4082.4896887889013, 4090.1206240658403, 4105.401949816195, 5675.432456754333, 5681.7727290908315, 5721.937424428661, 5732.570057245724, 5758.424157584208, 4193.364587810756, 4203.453551038346, 4212.873613791591, 4225.148025083056, 4228.492580890252, 4158.91682166355, 4212.662986961036, 4213.620774130343, 4245.766482843474, 4269.850555230552, 4755.0489902019735, 4780.036377446006, 4780.139574876555, 4788.401449818773, 4788.569028787426, 5554.833354999357, 5563.749631266603, 5564.777408903679, 5593.489757765462, 5600.831975040755, 1310.7313000834806, 1345.6232254968625, 1358.3479929633831, 1365.6449323176046, 1390.8956828237922, 970.3450171134456, 973.6640858903667, 990.8612794208816, 996.6611352140308, 998.5905778630727, 5170.224466330081, 5170.5346518813485, 5192.0, 5228.215767634885, 5230.038735474197, 5444.537214336826, 5459.454054594588, 5460.290162278958, 5471.452854714496, 5483.972580137074, 5153.561947234452, 5194.883100133489, 5235.089192444806, 5255.580993131833, 5436.6737995719595, 2931.3697555025774, 2931.5456104303867, 2939.985300073529, 2952.3062080411514, 2955.9556606650917, 5757.424257574209, 5758.74085666146, 5765.4522820332, 5793.7392817323325, 5808.137588503682, 5456.017916774939, 5576.86057848557, 5620.634658747168, 5638.23883775685, 5640.5769567281795, 5608.383077861432, 5659.971700141473, 5694.914576281276, 5738.971305143447, 5765.913511297334, 5325.866853328698, 5514.105094825249, 5536.612437129363, 5569.387367389503, 5579.609427340048, 5443.855556499228, 5445.428230035947, 5450.345958484849, 5464.726763661881, 5468.671879687232, 5692.235407023836, 5728.42468321215, 5731.0, 5755.884882302246, 5786.739596718074, 3927.9607203927594, 4040.6565441937764, 4054.1283624020975, 4164.979580002919, 4194.098268872085, 5505.779768809363, 5684.578855286179, 5690.2887139107615, 5696.231008813757, 5711.828645140652, 5400.648957817729, 5488.533474654699, 5598.636088654224, 5598.712296171821, 5605.234351179365, 5578.581606379456, 5594.664320140804, 5598.076317407745, 5606.551475882001, 5613.691246981455, 5299.0, 5517.668939863621, 5555.611107222456, 5560.972195138998, 5563.443655634404, 5594.9369619772115, 5617.387914619558, 5622.217002583748, 5629.845881594181, 5637.830865074055, 5497.4162143792355, 5501.826778422581, 5514.751836167462, 5532.30846144232, 5534.225208470898], "value": 4241.245135162118, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [777.7316825695136, 824.2869917521342, 842.4902933725097, 870.3776799588293, 912.115248209237, 14377.640558986031, 15196.392144314228, 15420.151891645983, 15490.535283941486, 15496.147711875843, 14423.350949207284, 14580.0, 15208.239588020582, 15274.312655930482, 15698.607534811636, 742.0687037767594, 760.4942713095785, 862.2455351567379, 862.8058686795453, 883.8409086364452, 869.9217070463657, 885.7874110213567, 885.7962668586229, 886.0961818944672, 886.2201262888649, 918.3342076994193, 922.0088404964656, 923.2936803345447, 924.2190349154953, 924.5515924776478, 757.2654525110606, 793.587334586012, 848.2620120495209, 917.2249449215435, 917.8210249001447, 662.8011596521025, 666.114068289179, 666.7199776094052, 667.1127400557248, 667.3160010988776, 14824.555263342118, 14833.332500037524, 14864.70270594582, 14873.925630371887, 14903.403863845433, 13823.930880345635, 13912.791308130387, 14025.579232623038, 14048.297585120805, 14066.296685165804, 12889.226646401152, 13098.083134180612, 13119.606411807566, 13139.14595551286, 13180.406881690347, 4386.8025938832825, 4475.731456112644, 4497.280435130396, 4508.211063063951, 4528.9547104528865, 55896.0, 57251.42748572503, 57956.71021644907, 63481.04778428327, 64509.67745161244, 11085.944570277097, 11106.333619982664, 11273.323600583992, 11378.544858205745, 11481.770364592829, 18024.0, 18359.90820045918, 18783.718244226347, 20118.49703757418, 20395.490112747004, 8275.255227029476, 8324.916750832414, 8389.53857537829, 8534.0, 8595.054464498658, 4753.33453316536, 4764.8332308369045, 4799.28010798383, 4915.139850526144, 4961.280614310905, 3578.8210589470423, 3693.6306369363388, 3701.981490092532, 3705.2033812729856, 3708.9814550927613, 658.8846951783419, 661.2296674374396, 663.3896814930275, 676.2932735291632, 676.3270545806954, 711.6726305899241, 720.661289194078, 722.0901663903519, 726.6148941061246, 731.352752813753, 9380.311543922024, 9996.900030999597, 10147.847782283272, 10388.584456621651, 10545.947270263752, 676.3356886079088, 788.4480863395646, 800.5876973358725, 806.2300503019602, 828.8052307707684, 4917.606591472673, 4979.427365852901, 4982.0, 4994.525520075587, 5042.722650254272, 85971.14028859632, 91120.0, 93782.0, 93828.0, 95220.0, 62777.372226277155, 64345.0, 80169.79745303825, 81849.0, 81852.18147818446, 65172.67413662996, 65381.34618653753, 65911.67044164844, 66481.33518664751, 66912.99630505547, 10088.899111008795, 10236.795264094826, 10288.434136122585, 10293.228007899586, 10425.374477531372, 32529.512057319633, 32858.50712239366, 38459.42310865395, 43046.0, 45730.31404529001, 56841.0, 57708.42291577198, 59345.40654593399, 59520.0, 62035.37964620296, 12757.170783899388, 12900.741985160057, 13055.34723263852, 13157.473701052233, 13170.802437963246, 14565.271736412926, 14585.708285834437, 14842.257887105385, 14878.404863805326, 15426.074435533905, 13818.447262109403, 14015.50945716895, 14468.927655362077, 14693.412263509339, 14802.259887005392, 13891.72216555643, 13988.510402135877, 14539.78190327167, 14539.92730036343, 14670.0, 13609.931950340186, 13839.100458470168, 14347.85652143507, 14555.854441455449, 14693.338799753823, 10383.325083869524, 10447.68656940293, 10706.464676765974, 10962.397068161008, 11202.83195752048, 11856.644300670994, 11874.881251187722, 11982.343061823874, 12054.578089766816, 12210.938945305217], "value": 7450.936617804818, "unit": "score"}], "name": "dromaeo_css", "value": 7404.476625513391, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 111.0, 113.0, 112.0, 113.0, 112.0, 113.0, 112.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 119.0, 118.0, 158.0, 123.0, 123.0, 124.0, 117.0, 147.0, 118.0], "value": 128.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 164.0, 161.0, 162.0, 161.0, 161.0, 162.0, 161.0, 159.0], "value": 161.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 83.0, 118.0, 76.0, 76.0, 77.0, 75.0, 100.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 83.0, 124.0, 83.0, 81.0, 83.0, 99.0, 83.0, 82.0, 115.0], "value": 91.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 118.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, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 85.0, 84.0, 85.0, 85.0, 84.0, 84.0, 85.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 50.0, 51.0, 50.0, 50.0, 50.0, 57.0, 53.0, 50.0, 50.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 60.0, 60.0, 61.0, 60.0, 60.0, 60.0, 60.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 76.0, 75.0, 81.0, 75.0, 75.0, 75.0, 76.0, 76.0, 76.0], "value": 76.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 122.0, 122.0, 120.0, 121.0, 127.0, 120.0, 120.0, 163.0, 125.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 154.0, 152.0, 158.0, 156.0, 157.0, 152.0, 156.0, 156.0, 160.0], "value": 155.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 63.0, 64.0, 63.0, 65.0, 62.0, 64.0, 62.0], "value": 63.2, "unit": "score"}], "name": "kraken", "value": 1457.1000000000001, "alertThreshold": 2.0}]} 02:52:15 INFO - Return code: 0 02:52:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:52:15 INFO - # TBPL SUCCESS # 02:52:15 INFO - Running post-action listener: _resource_record_post_action 02:52:15 INFO - [mozharness: 2017-01-04 10:52:15.703207Z] Finished run-tests step (success) 02:52:15 INFO - Running post-run listener: _resource_record_post_run 02:52:15 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 356343808; Read time: 28; Write time: 234000 02:52:15 INFO - TinderboxPrint: CPU usage
13.0% 02:52:15 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 02:52:15 INFO - TinderboxPrint: I/O write bytes / time
356,343,808 / 234,000 02:52:15 INFO - TinderboxPrint: CPU idle
8,276.3 (87.0%) 02:52:15 INFO - TinderboxPrint: CPU user
1,191.6 (12.5%) 02:52:15 INFO - TinderboxPrint: Swap in / out
0 / 0 02:52:15 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108163072; Read time: 0; Write time: 99240 02:52:15 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 262144; Write bytes: 248180736; Read time: 12; Write time: 134760 02:52:16 INFO - Running post-run listener: _upload_blobber_files 02:52:16 INFO - Blob upload gear active. 02:52:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:52:16 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 02:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:52:16 INFO - (blobuploader) - INFO - Open directory for files ... 02:52:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:52:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:52:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:20 INFO - (blobuploader) - INFO - Done attempting. 02:52:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:52:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:52:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:20 INFO - (blobuploader) - INFO - Done attempting. 02:52:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:52:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:52:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:52:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:52:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:52:21 INFO - (blobuploader) - INFO - Done attempting. 02:52:21 INFO - (blobuploader) - INFO - Iteration through files over. 02:52:21 INFO - Return code: 0 02:52:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:52:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:52:21 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/868ceab872e3ef56ce1878d32ef4759d43978e1ff859d4b1bc81fbf0d98a1d4a18e6e9125bcc1a6ac274537aa4a0a31dd689a67acd8e0f532737a21115a60d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c713f33705312c4a5646908f8ab609fc0c86e5615dcf62da4e2224933d329913a8754e86bcf522272f6b9c6b5c80c9f87d6b116bca715af367ca63377c8ca268", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cf5eac977ac8fee46f063150799a191e90160065a1e0a079da2d2700669f1e56cfe6e93e7d90b1f0218c52df8029bed886a6a10bb6e4f9093b2a602a85f420d"} 02:52:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:52:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:52:21 INFO - Contents: 02:52:21 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/868ceab872e3ef56ce1878d32ef4759d43978e1ff859d4b1bc81fbf0d98a1d4a18e6e9125bcc1a6ac274537aa4a0a31dd689a67acd8e0f532737a21115a60d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c713f33705312c4a5646908f8ab609fc0c86e5615dcf62da4e2224933d329913a8754e86bcf522272f6b9c6b5c80c9f87d6b116bca715af367ca63377c8ca268", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cf5eac977ac8fee46f063150799a191e90160065a1e0a079da2d2700669f1e56cfe6e93e7d90b1f0218c52df8029bed886a6a10bb6e4f9093b2a602a85f420d"} 02:52:21 INFO - Running post-run listener: copy_logs_to_upload_dir 02:52:21 INFO - Copying logs to upload dir... 02:52:21 INFO - mkdir: /builds/slave/test/build/upload/logs 02:52:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.682514 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2017-01-04 02:52:20.532105) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 02:52:20.535347) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/868ceab872e3ef56ce1878d32ef4759d43978e1ff859d4b1bc81fbf0d98a1d4a18e6e9125bcc1a6ac274537aa4a0a31dd689a67acd8e0f532737a21115a60d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c713f33705312c4a5646908f8ab609fc0c86e5615dcf62da4e2224933d329913a8754e86bcf522272f6b9c6b5c80c9f87d6b116bca715af367ca63377c8ca268", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cf5eac977ac8fee46f063150799a191e90160065a1e0a079da2d2700669f1e56cfe6e93e7d90b1f0218c52df8029bed886a6a10bb6e4f9093b2a602a85f420d"} build_url:https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/eHCzG2jyT5uB_QHj37falw/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/868ceab872e3ef56ce1878d32ef4759d43978e1ff859d4b1bc81fbf0d98a1d4a18e6e9125bcc1a6ac274537aa4a0a31dd689a67acd8e0f532737a21115a60d72", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c713f33705312c4a5646908f8ab609fc0c86e5615dcf62da4e2224933d329913a8754e86bcf522272f6b9c6b5c80c9f87d6b116bca715af367ca63377c8ca268", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/8cf5eac977ac8fee46f063150799a191e90160065a1e0a079da2d2700669f1e56cfe6e93e7d90b1f0218c52df8029bed886a6a10bb6e4f9093b2a602a85f420d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 02:52:20.560946) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:52:20.561273) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1483525904.63999-1022838725 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004398 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 02:52:20.645877) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 02:52:20.646190) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 02:52:20.646490) ========= ========= Total master_lag: 0.15 =========