builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-050 starttime: 1485243113.63 results: success (0) buildid: 20170123213845 builduid: 36854ff7c20b40b89cba9e3d0f263bf4 revision: 7443e9844412b8645aafbc9654a6da7adc65cb30 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.634723) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.635258) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.635716) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.711986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.712520) ========= 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=6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-23 23:31:54-- 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% 221M=0s 2017-01-23 23:31:54 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.087707 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.821448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.821785) ========= 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=6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019073 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:53.881197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 23:31:53.881556) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7443e9844412b8645aafbc9654a6da7adc65cb30 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 7443e9844412b8645aafbc9654a6da7adc65cb30 --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=6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-23 23:31:54,463 truncating revision to first 12 chars 2017-01-23 23:31:54,463 Setting DEBUG logging. 2017-01-23 23:31:54,464 attempt 1/10 2017-01-23 23:31:54,464 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/7443e9844412?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 23:31:55,729 unpacking tar archive at: mozilla-beta-7443e9844412/testing/mozharness/ program finished with exit code 0 elapsedTime=1.569837 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 23:31:55.469646) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:55.469957) ========= script_repo_revision: 7443e9844412b8645aafbc9654a6da7adc65cb30 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:55.470445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:55.470763) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 23:31:55.479763) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-23 23:31:55.480085) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:31:56 INFO - MultiFileLogger online at 20170123 23:31:56 in /builds/slave/test 23:31:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 23:31:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:31:56 INFO - {'append_to_log': False, 23:31:56 INFO - 'base_work_dir': '/builds/slave/test', 23:31:56 INFO - 'blob_upload_branch': 'Mozilla-Beta', 23:31:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:31:56 INFO - 'branch': 'Mozilla-Beta', 23:31:56 INFO - 'buildbot_json_path': 'buildprops.json', 23:31:56 INFO - 'config_files': ('talos/linux_config.py',), 23:31:56 INFO - 'default_actions': ('clobber', 23:31:56 INFO - 'read-buildbot-config', 23:31:56 INFO - 'download-and-extract', 23:31:56 INFO - 'populate-webroot', 23:31:56 INFO - 'create-virtualenv', 23:31:56 INFO - 'install', 23:31:56 INFO - 'run-tests'), 23:31:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:31:56 INFO - 'download_minidump_stackwalk': True, 23:31:56 INFO - 'download_symbols': 'ondemand', 23:31:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:31:56 INFO - 'tooltool.py': '/tools/tooltool.py', 23:31:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:31:56 INFO - '/tools/misc-python/virtualenv.py')}, 23:31:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:31:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:31:56 INFO - 'installer_path': 'installer.exe', 23:31:56 INFO - 'log_level': 'info', 23:31:56 INFO - 'log_name': 'talos', 23:31:56 INFO - 'log_to_console': True, 23:31:56 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:31:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:31:56 INFO - 'opt_config_files': (), 23:31:56 INFO - 'pip_index': False, 23:31:56 INFO - 'sps_profile': False, 23:31:56 INFO - 'sps_profile_interval': 0, 23:31:56 INFO - 'suite': 'dromaeojs', 23:31:56 INFO - 'system_bits': '32', 23:31:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:31:56 INFO - 'title': 'talos-linux64-ix-050', 23:31:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:31:56 INFO - 'use_talos_json': True, 23:31:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:31:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:31:56 INFO - 'work_dir': 'build'} 23:31:56 INFO - [mozharness: 2017-01-24 07:31:56.165209Z] Running clobber step. 23:31:56 INFO - Running pre-action listener: _resource_record_pre_action 23:31:56 INFO - Running main action method: clobber 23:31:56 INFO - rmtree: /builds/slave/test/build 23:31:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:31:56 INFO - Running post-action listener: _resource_record_post_action 23:31:56 INFO - [mozharness: 2017-01-24 07:31:56.627931Z] Finished clobber step (success) 23:31:56 INFO - [mozharness: 2017-01-24 07:31:56.628033Z] Running read-buildbot-config step. 23:31:56 INFO - Running pre-action listener: _resource_record_pre_action 23:31:56 INFO - Running main action method: read_buildbot_config 23:31:56 INFO - Using buildbot properties: 23:31:56 INFO - { 23:31:56 INFO - "project": "", 23:31:56 INFO - "product": "firefox", 23:31:56 INFO - "script_repo_revision": "production", 23:31:56 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 23:31:56 INFO - "repository": "", 23:31:56 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 23:31:56 INFO - "buildid": "20170123213845", 23:31:56 INFO - "pgo_build": "True", 23:31:56 INFO - "basedir": "/builds/slave/test", 23:31:56 INFO - "buildnumber": 102, 23:31:56 INFO - "slavename": "talos-linux64-ix-050", 23:31:56 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:31:56 INFO - "platform": "ubuntu64_hw", 23:31:56 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 23:31:56 INFO - "branch": "mozilla-beta", 23:31:56 INFO - "repo_path": "releases/mozilla-beta", 23:31:56 INFO - "revision": "7443e9844412b8645aafbc9654a6da7adc65cb30", 23:31:56 INFO - "stage_platform": "linux64-pgo", 23:31:56 INFO - "builduid": "36854ff7c20b40b89cba9e3d0f263bf4", 23:31:56 INFO - "slavebuilddir": "test" 23:31:56 INFO - } 23:31:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 23:31:56 INFO - Running post-action listener: _resource_record_post_action 23:31:56 INFO - [mozharness: 2017-01-24 07:31:56.630467Z] Finished read-buildbot-config step (success) 23:31:56 INFO - [mozharness: 2017-01-24 07:31:56.630556Z] Running download-and-extract step. 23:31:56 INFO - Running pre-action listener: _resource_record_pre_action 23:31:56 INFO - Running main action method: download_and_extract 23:31:56 INFO - mkdir: /builds/slave/test/build/tests 23:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:56 INFO - trying https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:31:56 INFO - Downloading https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:31:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:31:57 INFO - Downloaded 1327 bytes. 23:31:57 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 23:31:57 INFO - Using the following test package requirements: 23:31:57 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 23:31:57 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:57 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 23:31:57 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:57 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 23:31:57 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:57 INFO - u'jsshell-linux-x86_64.zip'], 23:31:57 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:57 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 23:31:57 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 23:31:57 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:57 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 23:31:57 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:57 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 23:31:57 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:57 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 23:31:57 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 23:31:57 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 23:31:57 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:31:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 23:31:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:31:57 INFO - Fetch https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 23:31:57 INFO - Http code: 200 23:31:57 INFO - via: 1.1 e1eb7447ab46f530f6009f1d93917c54.cloudfront.net (CloudFront) 23:31:57 INFO - x-amz-cf-id: B1nzu9IBh1-fz25ER25wh6zDkWTL-1tZNGEUtPDZij8wSWOZlHbwsA== 23:31:57 INFO - x-amz-version-id: 4Op0Url43B_SHW9nt0Wqe6mKVd8Czora 23:31:58 INFO - Expected file size: 21950671 23:31:58 INFO - Obtained file size: 21950671 23:32:02 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:32:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 23:32:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:32:02 INFO - Fetch https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 23:32:02 INFO - Http code: 200 23:32:02 INFO - via: 1.1 a1aa00de8387e7235a256b2a5b73ede8.cloudfront.net (CloudFront) 23:32:02 INFO - x-amz-cf-id: SjlQx05z-xrHlnTIOgzb07ROIg4oA5RlZ4WJcr7ztZdy7IoQFAAb-Q== 23:32:02 INFO - x-amz-version-id: 4Op0Url43B_SHW9nt0Wqe6mKVd8Czora 23:32:03 INFO - Expected file size: 21950671 23:32:03 INFO - Obtained file size: 21950671 23:32:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 23:32:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:32:08 INFO - Fetch https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 23:32:08 INFO - Http code: 200 23:32:08 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 23:32:08 INFO - x-amz-cf-id: E1WUgW1Cj1lTz1TtrxRPkXZ0UcIm2Q2BATcvlzrj9Kw28QRnMZYCcw== 23:32:08 INFO - x-amz-version-id: cxJluqb2jvdVxHHI5DsDN2vLWf9C0hMl 23:32:08 INFO - Expected file size: 14402992 23:32:08 INFO - Obtained file size: 14402992 23:32:09 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')]} 23:32:09 INFO - trying https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:32:09 INFO - Downloading https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:32:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:32:11 INFO - Downloaded 57682179 bytes. 23:32:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:32:11 INFO - mkdir: /builds/slave/test/properties 23:32:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:32:11 INFO - Writing to file /builds/slave/test/properties/build_url 23:32:11 INFO - Contents: 23:32:11 INFO - build_url:https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 23:32:12 INFO - Running post-action listener: _resource_record_post_action 23:32:12 INFO - Running post-action listener: set_extra_try_arguments 23:32:12 INFO - [mozharness: 2017-01-24 07:32:12.265614Z] Finished download-and-extract step (success) 23:32:12 INFO - [mozharness: 2017-01-24 07:32:12.265842Z] Running populate-webroot step. 23:32:12 INFO - Running pre-action listener: _resource_record_pre_action 23:32:12 INFO - Running main action method: populate_webroot 23:32:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:32:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:32:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:32:12 INFO - '--tppagecycles', 23:32:12 INFO - '7'], 23:32:12 INFO - 'tests': ['tsvgm']}}, 23:32:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:32:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:32:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:32:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:32:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:12 INFO - 'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:32:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:32:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:12 INFO - 'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['damp', 'tps']}, 23:32:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:12 INFO - 'tests': ['damp', 'tps']}, 23:32:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['dromaeo_dom']}, 23:32:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:32:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['basic_compositor_video']}, 23:32:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:32:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['a11yr', 23:32:12 INFO - 'ts_paint', 23:32:12 INFO - 'tpaint', 23:32:12 INFO - 'sessionrestore', 23:32:12 INFO - 'sessionrestore_no_auto_restore', 23:32:12 INFO - 'tabpaint']}, 23:32:12 INFO - 'other-e10s': {'tests': ['a11yr', 23:32:12 INFO - 'ts_paint', 23:32:12 INFO - 'tpaint', 23:32:12 INFO - 'sessionrestore', 23:32:12 INFO - 'sessionrestore_no_auto_restore', 23:32:12 INFO - 'tabpaint']}, 23:32:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:32:12 INFO - 'ts_paint', 23:32:12 INFO - 'tpaint', 23:32:12 INFO - 'sessionrestore', 23:32:12 INFO - 'sessionrestore_no_auto_restore', 23:32:12 INFO - 'tabpaint']}, 23:32:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:32:12 INFO - 'ts_paint', 23:32:12 INFO - 'tpaint', 23:32:12 INFO - 'sessionrestore', 23:32:12 INFO - 'sessionrestore_no_auto_restore', 23:32:12 INFO - 'tabpaint']}, 23:32:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['a11yr', 23:32:12 INFO - 'ts_paint', 23:32:12 INFO - 'tpaint', 23:32:12 INFO - 'sessionrestore', 23:32:12 INFO - 'sessionrestore_no_auto_restore', 23:32:12 INFO - 'tabpaint']}, 23:32:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['a11yr', 23:32:12 INFO - 'ts_paint', 23:32:12 INFO - 'tpaint', 23:32:12 INFO - 'sessionrestore', 23:32:12 INFO - 'sessionrestore_no_auto_restore', 23:32:12 INFO - 'tabpaint']}, 23:32:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['tsvgx', 23:32:12 INFO - 'tsvgr_opacity', 23:32:12 INFO - 'tart', 23:32:12 INFO - 'tscrollx', 23:32:12 INFO - 'cart']}, 23:32:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:32:12 INFO - 'tsvgr_opacity', 23:32:12 INFO - 'tart', 23:32:12 INFO - 'tscrollx', 23:32:12 INFO - 'cart']}, 23:32:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:12 INFO - 'talos_options': ['--disable-e10s'], 23:32:12 INFO - 'tests': ['tp5o']}, 23:32:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:12 INFO - 'tests': ['tp5o']}, 23:32:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:12 INFO - 'talos_options': ['--disable-e10s', 23:32:12 INFO - '--xperf_path', 23:32:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:32:12 INFO - 'tests': ['tp5n']}, 23:32:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:32:12 INFO - 'talos_options': ['--xperf_path', 23:32:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:32:12 INFO - 'tests': ['tp5n']}}, 23:32:12 INFO - 'talos.zip': {'path': '', 23:32:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:32:12 INFO - Running post-action listener: _resource_record_post_action 23:32:12 INFO - [mozharness: 2017-01-24 07:32:12.283965Z] Finished populate-webroot step (success) 23:32:12 INFO - [mozharness: 2017-01-24 07:32:12.284054Z] Running create-virtualenv step. 23:32:12 INFO - Running pre-action listener: _resource_record_pre_action 23:32:12 INFO - Running main action method: create_virtualenv 23:32:12 INFO - Creating virtualenv /builds/slave/test/build/venv 23:32:12 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 23:32:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:32:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:32:12 INFO - Using real prefix '/usr' 23:32:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:32:12 INFO - Installing distribute.............................................................................................................................................................................................done. 23:32:14 INFO - Installing pip.................done. 23:32:14 INFO - Return code: 0 23:32:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:32:15 INFO - Reading from file tmpfile_stdout 23:32:15 INFO - Output received: 23:32:15 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) 23:32:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23: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')]} 23:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23: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')]} 23:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5df4eb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', '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 23:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:32:15 INFO - Using env: {'DISPLAY': ':0', 23:32:15 INFO - 'HOME': '/home/cltbld', 23:32:15 INFO - 'LANG': 'en_US.UTF-8', 23:32:15 INFO - 'LANGUAGE': 'en_US:en', 23:32:15 INFO - 'LOGNAME': 'cltbld', 23:32:15 INFO - 'MAIL': '/var/mail/cltbld', 23:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:15 INFO - 'MOZ_NO_REMOTE': '1', 23:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:15 INFO - 'NO_EM_RESTART': '1', 23:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:15 INFO - 'PWD': '/builds/slave/test', 23:32:15 INFO - 'SHELL': '/bin/bash', 23:32:15 INFO - 'SHLVL': '1', 23:32:15 INFO - 'TERM': 'linux', 23:32:15 INFO - 'TMOUT': '86400', 23:32:15 INFO - 'USER': 'cltbld', 23:32:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:15 INFO - '_': '/tools/buildbot/bin/python'} 23:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:15 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 23:32:15 INFO - Cleaning up... 23:32:15 INFO - Return code: 0 23:32:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23: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')]} 23:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23: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')]} 23:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f5df4eb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', '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 23:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:32:15 INFO - Using env: {'DISPLAY': ':0', 23:32:15 INFO - 'HOME': '/home/cltbld', 23:32:15 INFO - 'LANG': 'en_US.UTF-8', 23:32:15 INFO - 'LANGUAGE': 'en_US:en', 23:32:15 INFO - 'LOGNAME': 'cltbld', 23:32:15 INFO - 'MAIL': '/var/mail/cltbld', 23:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:15 INFO - 'MOZ_NO_REMOTE': '1', 23:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:15 INFO - 'NO_EM_RESTART': '1', 23:32:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:15 INFO - 'PWD': '/builds/slave/test', 23:32:15 INFO - 'SHELL': '/bin/bash', 23:32:15 INFO - 'SHLVL': '1', 23:32:15 INFO - 'TERM': 'linux', 23:32:15 INFO - 'TMOUT': '86400', 23:32:15 INFO - 'USER': 'cltbld', 23:32:15 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:15 INFO - '_': '/tools/buildbot/bin/python'} 23:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:15 INFO - Downloading/unpacking psutil>=3.1.1 23:32:15 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 23:32:15 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 23:32:15 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 23:32:15 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 23:32:15 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 23:32:15 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 23:32:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:32:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:32:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:32:17 INFO - Installing collected packages: psutil 23:32:17 INFO - Running setup.py install for psutil 23:32:17 INFO - building 'psutil._psutil_linux' extension 23:32:17 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 23:32:17 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 23:32:17 INFO - building 'psutil._psutil_posix' extension 23:32:17 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 23:32:17 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 23:32:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:32:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:32:18 INFO - Successfully installed psutil 23:32:18 INFO - Cleaning up... 23:32:18 INFO - Return code: 0 23:32:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23: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')]} 23:32:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23: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')]} 23:32:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5df4eb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', '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 23:32:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:32:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:32:18 INFO - Using env: {'DISPLAY': ':0', 23:32:18 INFO - 'HOME': '/home/cltbld', 23:32:18 INFO - 'LANG': 'en_US.UTF-8', 23:32:18 INFO - 'LANGUAGE': 'en_US:en', 23:32:18 INFO - 'LOGNAME': 'cltbld', 23:32:18 INFO - 'MAIL': '/var/mail/cltbld', 23:32:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:18 INFO - 'MOZ_NO_REMOTE': '1', 23:32:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:18 INFO - 'NO_EM_RESTART': '1', 23:32:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:18 INFO - 'PWD': '/builds/slave/test', 23:32:18 INFO - 'SHELL': '/bin/bash', 23:32:18 INFO - 'SHLVL': '1', 23:32:18 INFO - 'TERM': 'linux', 23:32:18 INFO - 'TMOUT': '86400', 23:32:18 INFO - 'USER': 'cltbld', 23:32:18 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:18 INFO - '_': '/tools/buildbot/bin/python'} 23:32:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:32:18 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 23:32:18 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 23:32:18 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 23:32:18 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 23:32:18 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 23:32:18 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 23:32:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:32:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:32:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:32:20 INFO - Installing collected packages: mozsystemmonitor 23:32:20 INFO - Running setup.py install for mozsystemmonitor 23:32:20 INFO - Successfully installed mozsystemmonitor 23:32:20 INFO - Cleaning up... 23:32:20 INFO - Return code: 0 23:32:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:32:20 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')]} 23:32:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:20 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')]} 23:32:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:20 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 0x7f5df4eb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', '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 23:32:20 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 23:32:20 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 23:32:20 INFO - Using env: {'DISPLAY': ':0', 23:32:20 INFO - 'HOME': '/home/cltbld', 23:32:20 INFO - 'LANG': 'en_US.UTF-8', 23:32:20 INFO - 'LANGUAGE': 'en_US:en', 23:32:20 INFO - 'LOGNAME': 'cltbld', 23:32:20 INFO - 'MAIL': '/var/mail/cltbld', 23:32:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:20 INFO - 'MOZ_NO_REMOTE': '1', 23:32:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:20 INFO - 'NO_EM_RESTART': '1', 23:32:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:20 INFO - 'PWD': '/builds/slave/test', 23:32:20 INFO - 'SHELL': '/bin/bash', 23:32:20 INFO - 'SHLVL': '1', 23:32:20 INFO - 'TERM': 'linux', 23:32:20 INFO - 'TMOUT': '86400', 23:32:20 INFO - 'USER': 'cltbld', 23:32:20 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:20 INFO - '_': '/tools/buildbot/bin/python'} 23:32:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:20 INFO - Downloading/unpacking jsonschema==2.5.1 23:32:20 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 23:32:20 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 23:32:20 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 23:32:20 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 23:32:20 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 23:32:20 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 23:32:22 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:32:22 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:32:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:32:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:32:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:32:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:32:23 INFO - Downloading functools32-3.2.3-2.tar.gz 23:32:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:32:23 INFO - warning: no files found matching '*.txt' 23:32:23 INFO - no previously-included directories found matching 'build' 23:32:23 INFO - no previously-included directories found matching 'dist' 23:32:23 INFO - no previously-included directories found matching '.git*' 23:32:23 INFO - Installing collected packages: jsonschema, functools32 23:32:23 INFO - Running setup.py install for functools32 23:32:23 INFO - warning: no files found matching '*.txt' 23:32:23 INFO - no previously-included directories found matching 'build' 23:32:23 INFO - no previously-included directories found matching 'dist' 23:32:23 INFO - no previously-included directories found matching '.git*' 23:32:23 INFO - Successfully installed jsonschema functools32 23:32:23 INFO - Cleaning up... 23:32:23 INFO - Return code: 0 23:32:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:32:23 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')]} 23:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:23 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')]} 23:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:23 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 0x7f5df4eb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', '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 23:32:23 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 23:32:23 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 23:32:23 INFO - Using env: {'DISPLAY': ':0', 23:32:23 INFO - 'HOME': '/home/cltbld', 23:32:23 INFO - 'LANG': 'en_US.UTF-8', 23:32:23 INFO - 'LANGUAGE': 'en_US:en', 23:32:23 INFO - 'LOGNAME': 'cltbld', 23:32:23 INFO - 'MAIL': '/var/mail/cltbld', 23:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:23 INFO - 'MOZ_NO_REMOTE': '1', 23:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:23 INFO - 'NO_EM_RESTART': '1', 23:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:23 INFO - 'PWD': '/builds/slave/test', 23:32:23 INFO - 'SHELL': '/bin/bash', 23:32:23 INFO - 'SHLVL': '1', 23:32:23 INFO - 'TERM': 'linux', 23:32:23 INFO - 'TMOUT': '86400', 23:32:23 INFO - 'USER': 'cltbld', 23:32:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:23 INFO - '_': '/tools/buildbot/bin/python'} 23:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:32:23 INFO - Cleaning up... 23:32:23 INFO - Return code: 0 23:32:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:32:23 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')]} 23:32:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:23 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')]} 23:32:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:23 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 0x7f5df4eb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', '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 23:32:23 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 23:32:23 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 23:32:23 INFO - Using env: {'DISPLAY': ':0', 23:32:23 INFO - 'HOME': '/home/cltbld', 23:32:23 INFO - 'LANG': 'en_US.UTF-8', 23:32:23 INFO - 'LANGUAGE': 'en_US:en', 23:32:23 INFO - 'LOGNAME': 'cltbld', 23:32:23 INFO - 'MAIL': '/var/mail/cltbld', 23:32:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:23 INFO - 'MOZ_NO_REMOTE': '1', 23:32:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:23 INFO - 'NO_EM_RESTART': '1', 23:32:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:23 INFO - 'PWD': '/builds/slave/test', 23:32:23 INFO - 'SHELL': '/bin/bash', 23:32:23 INFO - 'SHLVL': '1', 23:32:23 INFO - 'TERM': 'linux', 23:32:23 INFO - 'TMOUT': '86400', 23:32:23 INFO - 'USER': 'cltbld', 23:32:23 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:23 INFO - '_': '/tools/buildbot/bin/python'} 23:32:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:23 INFO - Downloading/unpacking blobuploader==1.2.4 23:32:23 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 23:32:23 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 23:32:23 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 23:32:23 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 23:32:23 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 23:32:23 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 23:32:25 INFO - Downloading blobuploader-1.2.4.tar.gz 23:32:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:32:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:32:25 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 23:32:25 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 23:32:25 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 23:32:25 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 23:32:25 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 23:32:25 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 23:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:32:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:32:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:32:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:32:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:32:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:32:26 INFO - Downloading docopt-0.6.1.tar.gz 23:32:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:32:26 INFO - Installing collected packages: blobuploader, requests, docopt 23:32:26 INFO - Running setup.py install for blobuploader 23:32:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:32:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:32:26 INFO - Running setup.py install for requests 23:32:26 INFO - Running setup.py install for docopt 23:32:27 INFO - Successfully installed blobuploader requests docopt 23:32:27 INFO - Cleaning up... 23:32:27 INFO - Return code: 0 23:32:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:27 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 0x7f5df4eb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', '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 23:32:27 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 23:32:27 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 23:32:27 INFO - Using env: {'DISPLAY': ':0', 23:32:27 INFO - 'HOME': '/home/cltbld', 23:32:27 INFO - 'LANG': 'en_US.UTF-8', 23:32:27 INFO - 'LANGUAGE': 'en_US:en', 23:32:27 INFO - 'LOGNAME': 'cltbld', 23:32:27 INFO - 'MAIL': '/var/mail/cltbld', 23:32:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:27 INFO - 'MOZ_NO_REMOTE': '1', 23:32:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:27 INFO - 'NO_EM_RESTART': '1', 23:32:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:27 INFO - 'PWD': '/builds/slave/test', 23:32:27 INFO - 'SHELL': '/bin/bash', 23:32:27 INFO - 'SHLVL': '1', 23:32:27 INFO - 'TERM': 'linux', 23:32:27 INFO - 'TMOUT': '86400', 23:32:27 INFO - 'USER': 'cltbld', 23:32:27 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:27 INFO - '_': '/tools/buildbot/bin/python'} 23:32:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:32:27 INFO - Running setup.py (path:/tmp/pip-f82kwy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:32:27 INFO - Running setup.py (path:/tmp/pip-Qra1w8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:32:27 INFO - Running setup.py (path:/tmp/pip-0SngQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:32:27 INFO - Running setup.py (path:/tmp/pip-077YDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:32:27 INFO - Running setup.py (path:/tmp/pip-1glZ8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:32:27 INFO - Running setup.py (path:/tmp/pip-s5v_aI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:32:27 INFO - Running setup.py (path:/tmp/pip-o8QjNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:32:27 INFO - Running setup.py (path:/tmp/pip-e77FZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:32:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:32:27 INFO - Running setup.py (path:/tmp/pip-XchKJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:32:28 INFO - Running setup.py (path:/tmp/pip-g1qmaW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:32:28 INFO - Running setup.py (path:/tmp/pip-1SqRlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:32:28 INFO - Running setup.py (path:/tmp/pip-I0Rcwm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:32:28 INFO - Running setup.py (path:/tmp/pip-cMnHuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:32:28 INFO - Running setup.py (path:/tmp/pip-3ADhrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:32:28 INFO - Running setup.py (path:/tmp/pip-X_ayjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:32:28 INFO - Running setup.py (path:/tmp/pip-YBWkBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:32:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:32:28 INFO - Running setup.py (path:/tmp/pip-JWIe1M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:32:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:32:28 INFO - Running setup.py install for manifestparser 23:32:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Running setup.py install for mozcrash 23:32:28 INFO - Running setup.py install for mozdebug 23:32:28 INFO - Running setup.py install for mozdevice 23:32:28 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:32:28 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Running setup.py install for mozfile 23:32:29 INFO - Running setup.py install for mozhttpd 23:32:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Running setup.py install for mozinfo 23:32:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Running setup.py install for mozInstall 23:32:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Running setup.py install for mozleak 23:32:29 INFO - Running setup.py install for mozlog 23:32:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Running setup.py install for moznetwork 23:32:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Running setup.py install for mozprocess 23:32:29 INFO - Running setup.py install for mozprofile 23:32:29 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:32:29 INFO - Running setup.py install for mozrunner 23:32:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:32:30 INFO - Running setup.py install for mozscreenshot 23:32:30 INFO - Running setup.py install for moztest 23:32:30 INFO - Running setup.py install for mozversion 23:32:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:32:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:32:30 INFO - Cleaning up... 23:32:30 INFO - Return code: 0 23:32:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:30 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 0x7f5df4eb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', '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 23:32:30 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 23:32:30 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 23:32:30 INFO - Using env: {'DISPLAY': ':0', 23:32:30 INFO - 'HOME': '/home/cltbld', 23:32:30 INFO - 'LANG': 'en_US.UTF-8', 23:32:30 INFO - 'LANGUAGE': 'en_US:en', 23:32:30 INFO - 'LOGNAME': 'cltbld', 23:32:30 INFO - 'MAIL': '/var/mail/cltbld', 23:32:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:30 INFO - 'MOZ_NO_REMOTE': '1', 23:32:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:30 INFO - 'NO_EM_RESTART': '1', 23:32:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:30 INFO - 'PWD': '/builds/slave/test', 23:32:30 INFO - 'SHELL': '/bin/bash', 23:32:30 INFO - 'SHLVL': '1', 23:32:30 INFO - 'TERM': 'linux', 23:32:30 INFO - 'TMOUT': '86400', 23:32:30 INFO - 'USER': 'cltbld', 23:32:30 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:30 INFO - '_': '/tools/buildbot/bin/python'} 23:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:32:30 INFO - Running setup.py (path:/tmp/pip-lltM8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:32:30 INFO - Running setup.py (path:/tmp/pip-_pMmF_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:32:30 INFO - Running setup.py (path:/tmp/pip-njruA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:32:30 INFO - Running setup.py (path:/tmp/pip-SjxH0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:32:30 INFO - Running setup.py (path:/tmp/pip-OMc0RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:32:30 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)) 23:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:32:30 INFO - Running setup.py (path:/tmp/pip-DgQOEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:32:31 INFO - Running setup.py (path:/tmp/pip-gq7HA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:32:31 INFO - Running setup.py (path:/tmp/pip-xGhx07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:32:31 INFO - Running setup.py (path:/tmp/pip-e_EdIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:32:31 INFO - Running setup.py (path:/tmp/pip-FVMMzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:32:31 INFO - Running setup.py (path:/tmp/pip-HzVNQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:32:31 INFO - Running setup.py (path:/tmp/pip-ZUBsdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:32:31 INFO - Running setup.py (path:/tmp/pip-rkFUyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:32:31 INFO - Running setup.py (path:/tmp/pip-oRAZDy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:32:31 INFO - Running setup.py (path:/tmp/pip-u8uVy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:32:31 INFO - Running setup.py (path:/tmp/pip-0q3ha5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:32:31 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)) 23:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:32:31 INFO - Running setup.py (path:/tmp/pip-Qskbn4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:32:31 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)) 23:32:31 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)) 23:32:31 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)) 23:32:31 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)) 23:32:31 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)) 23:32:31 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)) 23:32:31 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:32:31 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 23:32:31 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 23:32:31 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 23:32:31 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 23:32:31 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 23:32:31 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 23:32:33 INFO - Downloading blessings-1.6.tar.gz 23:32:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:32:33 INFO - Installing collected packages: blessings 23:32:33 INFO - Running setup.py install for blessings 23:32:34 INFO - Successfully installed blessings 23:32:34 INFO - Cleaning up... 23:32:34 INFO - Return code: 0 23:32:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:32:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:32:34 INFO - Reading from file tmpfile_stdout 23:32:34 INFO - Current package versions: 23:32:34 INFO - argparse == 1.2.1 23:32:34 INFO - blessings == 1.6 23:32:34 INFO - blobuploader == 1.2.4 23:32:34 INFO - docopt == 0.6.1 23:32:34 INFO - functools32 == 3.2.3-2 23:32:34 INFO - jsonschema == 2.5.1 23:32:34 INFO - manifestparser == 1.1 23:32:34 INFO - mozInstall == 1.12 23:32:34 INFO - mozcrash == 1.0 23:32:34 INFO - mozdebug == 0.1 23:32:34 INFO - mozdevice == 0.48 23:32:34 INFO - mozfile == 1.2 23:32:34 INFO - mozhttpd == 0.7 23:32:34 INFO - mozinfo == 0.9 23:32:34 INFO - mozleak == 0.1 23:32:34 INFO - mozlog == 3.4 23:32:34 INFO - moznetwork == 0.27 23:32:34 INFO - mozprocess == 0.23 23:32:34 INFO - mozprofile == 0.28 23:32:34 INFO - mozrunner == 6.13 23:32:34 INFO - mozscreenshot == 0.1 23:32:34 INFO - mozsystemmonitor == 0.3 23:32:34 INFO - moztest == 0.8 23:32:34 INFO - mozversion == 1.4 23:32:34 INFO - psutil == 3.1.1 23:32:34 INFO - requests == 1.2.3 23:32:34 INFO - wsgiref == 0.1.2 23:32:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:34 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 0x7f5df4eb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', '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 23:32:34 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 23:32:34 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 23:32:34 INFO - Using env: {'DISPLAY': ':0', 23:32:34 INFO - 'HOME': '/home/cltbld', 23:32:34 INFO - 'LANG': 'en_US.UTF-8', 23:32:34 INFO - 'LANGUAGE': 'en_US:en', 23:32:34 INFO - 'LOGNAME': 'cltbld', 23:32:34 INFO - 'MAIL': '/var/mail/cltbld', 23:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:34 INFO - 'MOZ_NO_REMOTE': '1', 23:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:34 INFO - 'NO_EM_RESTART': '1', 23:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:34 INFO - 'PWD': '/builds/slave/test', 23:32:34 INFO - 'SHELL': '/bin/bash', 23:32:34 INFO - 'SHLVL': '1', 23:32:34 INFO - 'TERM': 'linux', 23:32:34 INFO - 'TMOUT': '86400', 23:32:34 INFO - 'USER': 'cltbld', 23:32:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:34 INFO - '_': '/tools/buildbot/bin/python'} 23:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:34 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)) 23:32:34 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)) 23:32:34 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)) 23:32:34 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)) 23:32:34 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)) 23:32:34 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)) 23:32:34 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)) 23:32:34 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)) 23:32:34 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)) 23:32:34 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)) 23:32:34 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)) 23:32:34 INFO - Cleaning up... 23:32:34 INFO - Return code: 0 23:32:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:32:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:32:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:32:34 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 0x7f5df4eb4f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f618a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x202eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, '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': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', '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 23:32:34 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 23:32:34 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 23:32:34 INFO - Using env: {'DISPLAY': ':0', 23:32:34 INFO - 'HOME': '/home/cltbld', 23:32:34 INFO - 'LANG': 'en_US.UTF-8', 23:32:34 INFO - 'LANGUAGE': 'en_US:en', 23:32:34 INFO - 'LOGNAME': 'cltbld', 23:32:34 INFO - 'MAIL': '/var/mail/cltbld', 23:32:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:34 INFO - 'MOZ_NO_REMOTE': '1', 23:32:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:34 INFO - 'NO_EM_RESTART': '1', 23:32:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:34 INFO - 'PWD': '/builds/slave/test', 23:32:34 INFO - 'SHELL': '/bin/bash', 23:32:34 INFO - 'SHLVL': '1', 23:32:34 INFO - 'TERM': 'linux', 23:32:34 INFO - 'TMOUT': '86400', 23:32:34 INFO - 'USER': 'cltbld', 23:32:34 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:34 INFO - '_': '/tools/buildbot/bin/python'} 23:32:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:32:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:32:34 INFO - Cleaning up... 23:32:34 INFO - Return code: 0 23:32:34 INFO - Running post-action listener: _resource_record_post_action 23:32:34 INFO - Running post-action listener: _start_resource_monitoring 23:32:34 INFO - Starting resource monitoring. 23:32:34 INFO - [mozharness: 2017-01-24 07:32:34.883026Z] Finished create-virtualenv step (success) 23:32:34 INFO - [mozharness: 2017-01-24 07:32:34.883531Z] Running install step. 23:32:34 INFO - Running pre-action listener: _resource_record_pre_action 23:32:34 INFO - Running main action method: install 23:32:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:32:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:32:35 INFO - Reading from file tmpfile_stdout 23:32:35 INFO - Detecting whether we're running mozinstall >=1.0... 23:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:32:35 INFO - Reading from file tmpfile_stdout 23:32:35 INFO - Output received: 23:32:35 INFO - Usage: mozinstall [options] installer 23:32:35 INFO - Options: 23:32:35 INFO - -h, --help show this help message and exit 23:32:35 INFO - -d DEST, --destination=DEST 23:32:35 INFO - Directory to install application into. [default: 23:32:35 INFO - "/builds/slave/test"] 23:32:35 INFO - --app=APP Application being installed. [default: firefox] 23:32:35 INFO - mkdir: /builds/slave/test/build/application 23:32:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:32:49 INFO - Reading from file tmpfile_stdout 23:32:49 INFO - Output received: 23:32:49 INFO - /builds/slave/test/build/application/firefox/firefox 23:32:49 INFO - Running post-action listener: _resource_record_post_action 23:32:49 INFO - [mozharness: 2017-01-24 07:32:49.321671Z] Finished install step (success) 23:32:49 INFO - [mozharness: 2017-01-24 07:32:49.321918Z] Running run-tests step. 23:32:49 INFO - Running pre-action listener: _resource_record_pre_action 23:32:49 INFO - Running main action method: run_tests 23:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:32:49 INFO - Python 2.7.3 23:32:49 INFO - Return code: 0 23:32:49 INFO - grabbing minidump binary from tooltool 23:32:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:49 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 0x202bf60>, '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 0x202cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x202d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:32:49 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 23:32:49 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 23:32:49 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 23:32:49 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:32:49 INFO - Return code: 0 23:32:49 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:32:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:32:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:32:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:32:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:32:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 23:32:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 23:32:49 INFO - Using env: {'DISPLAY': ':0', 23:32:49 INFO - 'HOME': '/home/cltbld', 23:32:49 INFO - 'LANG': 'en_US.UTF-8', 23:32:49 INFO - 'LANGUAGE': 'en_US:en', 23:32:49 INFO - 'LOGNAME': 'cltbld', 23:32:49 INFO - 'MAIL': '/var/mail/cltbld', 23:32:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:32:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:32:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:49 INFO - 'MOZ_NO_REMOTE': '1', 23:32:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:32:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:49 INFO - 'NO_EM_RESTART': '1', 23:32:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:49 INFO - 'PWD': '/builds/slave/test', 23:32:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:32:49 INFO - 'SHELL': '/bin/bash', 23:32:49 INFO - 'SHLVL': '1', 23:32:49 INFO - 'TERM': 'linux', 23:32:49 INFO - 'TMOUT': '86400', 23:32:49 INFO - 'USER': 'cltbld', 23:32:49 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695', 23:32:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:49 INFO - '_': '/tools/buildbot/bin/python'} 23:32:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 23:32:49 INFO - mozversion application_buildid: 20170123213845 23:32:49 INFO - mozversion application_changeset: 7443e9844412b8645aafbc9654a6da7adc65cb30 23:32:49 INFO - mozversion application_display_name: Firefox 23:32:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:32:49 INFO - mozversion application_name: Firefox 23:32:49 INFO - mozversion application_remotingname: firefox 23:32:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 23:32:49 INFO - mozversion application_vendor: Mozilla 23:32:49 INFO - mozversion application_version: 52.0 23:32:49 INFO - mozversion platform_buildid: 20170123213845 23:32:49 INFO - mozversion platform_changeset: 7443e9844412b8645aafbc9654a6da7adc65cb30 23:32:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 23:32:49 INFO - mozversion platform_version: 52.0 23:32:49 INFO - using testdate: 1485243169 23:32:49 INFO - actual date: 1485243169 23:32:49 INFO - starting webserver on 'localhost:51611' 23:32:49 INFO - SUITE-START | Running 2 tests 23:32:49 INFO - TEST-START | dromaeo_css 23:32:49 INFO - operating with platform_type : linux_ 23:32:49 INFO - Initialising browser for dromaeo_css test... 23:32:49 INFO - TEST-INFO | started process 29636 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuVre6N/profile http://localhost:51611/getInfo.html) 23:32:53 INFO - PROCESS | 29636 | __metrics Screen width/height:1600/1200 23:32:53 INFO - PROCESS | 29636 | colorDepth:24 23:32:53 INFO - PROCESS | 29636 | Browser inner width/height: 1024/697 23:32:53 INFO - PROCESS | 29636 | __metrics 23:32:54 INFO - PROCESS | 29636 | 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" 23:32:54 INFO - PROCESS | 29636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:32:54 INFO - PROCESS | 29636 | console.error: PushService: 23:32:54 INFO - PROCESS | 29636 | stateChangeProcessEnqueue: Error transitioning state 23:32:54 INFO - PROCESS | 29636 | UnknownError 23:32:55 INFO - TEST-INFO | 29636: exit 0 23:32:55 INFO - Browser initialized. 23:32:55 INFO - Running cycle 1/1 for dromaeo_css test... 23:32:55 INFO - TEST-INFO | started process 29730 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuVre6N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:33:07 INFO - PROCESS | 29730 | RSS: Main: 141205504 23:33:07 INFO - PROCESS | 29730 | 23:36:08 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51611/tests/dromaeo/cssquery-ext.html) 23:36:09 INFO - PROCESS | 29730 | RSS: Main: 236511232 23:36:09 INFO - PROCESS | 29730 | 23:39:12 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-ext.html (next: http://localhost:51611/tests/dromaeo/cssquery-jquery.html) 23:39:12 INFO - PROCESS | 29730 | RSS: Main: 233623552 23:39:12 INFO - PROCESS | 29730 | 23:42:14 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51611/tests/dromaeo/cssquery-mootools.html) 23:42:15 INFO - PROCESS | 29730 | RSS: Main: 179724288 23:42:15 INFO - PROCESS | 29730 | 23:45:17 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51611/tests/dromaeo/cssquery-prototype.html) 23:45:18 INFO - PROCESS | 29730 | RSS: Main: 223174656 23:45:18 INFO - PROCESS | 29730 | 23:48:20 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51611/tests/dromaeo/cssquery-yui.html) 23:48:21 INFO - PROCESS | 29730 | RSS: Main: 175583232 23:48:21 INFO - PROCESS | 29730 | 23:51:23 INFO - PROCESS | 29730 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-yui.html (next: http://localhost:51611/tests/dromaeo/cssquery-dojo.html) 23:51:23 INFO - PROCESS | 29730 | RSS: Main: 267993088 23:51:23 INFO - PROCESS | 29730 | 23:51:23 INFO - PROCESS | 29730 | __start_tp_report 23:51:23 INFO - PROCESS | 29730 | _x_x_mozilla_page_load 23:51:23 INFO - PROCESS | 29730 | _x_x_mozilla_page_load_details 23:51:23 INFO - PROCESS | 29730 | |i|pagename|runs| 23:51:23 INFO - PROCESS | 29730 | |0;dojo.html;3237.9514307285385;3280.6883346082127;3289.4901290300004;3303.3723592517404;3307.470804671253;5618.5786066045;5671.8014869479575;5688.829335119943;5695.658260504368;5695.914561281579;5538.695371754552;5593.216949627045;5601.131824567188;5603.635763675358;5637.746301416436;5063.139266324733;5079.84760457185;5117.744112794364;5140.640155189139;5156.793728250866;5059.949400506003;5157.71632560209;5164.122099243119;5170.482951704818;5172.431032586413;5033.270175824503;5078.314427552288;5142.794288228466;5179.378474583055;5187.118189907725;5098.464661210575;5121.129408000649;5129.589632829365;5197.428282888879;5206.167013277857;5040.798368065273;5066.164082926312;5119.257707632372;5169.81905633301;5190.429052804188;5398.676079435247;5424.566034717213;5446.537044351235;5495.917561236544;5562.360328562227;5881.47066763989;5911.9113213301835;5920.881582368372;6011.458968692795;6018.037114061773;6074.817755467343;6085.847853803646;6087.269527656666;6093.207882975229;6097.115918191837;5513.669179849182;5571.192177134333;5575.303087114111;5613.186088017296;5626.774929002876;6117;6139.693015349215;6141.969290153521;6149.7847575334645;6152.630842149485;5919.082542205965;5919.970400147971;5927.407259274124;5928.970355148283;5931.911021334683;5814.709264536841;5839.124131380242;5944.108383742473;5954.166416701665;5974.761009559656;6011.09833524966;6016.578839481282;6021.42796434338;6048.153258543807;6052.848678782978;5965.55258355625;6012.579119461683;6014.879702405928;6019.879602407927;6029.336772954972;4559.498455169929;4602.470715867651;4666.253399456139;4696.1546921554445;4711.175544279738;4130.793460327031;4157.397177409319;4180.540140584533;4202.600752928467;4208.894777630584;5762.769489220468;5765.135229715576;5768.394318596487;5769.336526299446;5770.913436298459;5944.554158438134;5989.700514974234;6050.515958723292;6140.539459540552;6156.107364432132;5705.62913410627;5774.307083150049;5778.913316300259;5795.536357091422;5812.302523697099;5119.641625086283;5122.769475373617;5127.974360128175;5128.974355128275;5130.629509828315;5995.520358371233;6033;6257.342978987141;6303.149074874925;6325;5935.732892019956;5949.434803693643;5999.220101386792;6072.14989901423;6091.847703807263;6220.688965551795;6257.217847769029;6257.68711564429;6258.311585725658;6271.059341098689;5853.151293062397;5853.209816674695;5856.531477481876;5891.970540147272;5898.587098903207;5772.884542309046;5879.2944846618675;5982.282126144891;6016.578839481194;6088.299845517822;5954.225950626391;6003.189569408074;6003.849903752441;6013.428724271187;6034.668093254913;5949.494292985145;5973.790917317873;5980.132880732356;5985.670788106696;5989.610675306091;5659.54723622101;5722.055860782924;5816.47651711348;5875.500582450369;5897.970510147422;5954.07711804671;5957.49361304294;5968.045112781934;5985.832762611249;6002.399760023963;5626.606137570331;5655.038643430709;5820.76716931335;5827.79602713903;5833.708314584339 23:51:23 INFO - PROCESS | 29730 | |1;ext.html;593.9198208241888;605.1558076483304;650.703929711981;660.3231687520295;675.6925598852523;36484.45273320899;46115.53884461158;46961.53038469614;47190.76404617972;51356;48477.51522484774;49062.75468622661;49065;49103.26345104817;49143;8517.403781735282;9002.639894404216;9138.77153071172;9141.177294043535;9145.496997665126;8608.268297194745;10870.61952831651;11141.944290278538;11142.108631309517;11444.599439019636;11212.551497940072;11276.887231127706;11279.830802537968;11282.492287847066;11289.661310160709;11029.062529684987;11070.667879963614;11082.667519974413;11088.55645774172;11114.333140011626;10973.83539246912;11030.283031603;11030.834537481944;11032.117430605533;11044.061254793352;44962.55037449616;45095.32357014647;45113.54886451159;45173.32240016403;45213.54786452159;3838.654521093087;3887.6695480883877;3962.286788378091;4243.469566304212;4380.08018316154;33919;34338.6566134338;34369.656303436896;34914.82542587271;35839.82080089609;4384.495782984934;4641.651876109271;4665.370175026362;4679;4735.124002059595;336957.99999999756;336967;338195;338734;339677;64209;64747.35252647507;64825.67587162034;64851;64936;36017.459738103425;36702;36894.8155259222;37154.44268335977;37208.44187337138;17216.655666886592;17360.65278694419;17380.739288910678;17404.129793510274;17415;12657.177283476545;12867.099303048697;13038.348082595832;13535.59393218205;13700.52048178329;20497.795022049588;21574.352769416942;21718.78281217199;21738.13047478083;21786;7464.402847772165;7645.579493127821;7749.3413059890545;7777.650005749755;7781.649825757854;1007.6019972110975;1064.9041586257274;1088.4666513408372;1101.4823033174396;1160.3270103340042;33169.83415082909;33767.493487597705;33932.10989076629;34050;34295.314093717985;1141.611851970334;1147.925384849982;1171.630936255077;1207.456644509974;1210.7820592293472;17743.822561774476;18168.727469087975;18192.909035454737;18287.268509259746;18311.63376732458;488729;492128;492448;492456;493150;62247.377526225064;62713.37286627075;62879;63014;63060;1310.194230548206;1375.587323802875;1404.4171668757351;1415.2640626874174;1453.2152637575803;32536.83731581327;34376.312473750884;34478.31043379169;34949;35161.47257791186;54311.45688543064;54761.45238547723;54893.451065488836;54943.725281373336;54980.175297371374;299839;300810;301857;301949;301983;27948.86025569859;28701;30340.696593033786;31165.53251701181;31562.36875262528;49489.50510494849;49957.50042499528;50150.74924625354;50242;50589.49410505995;42076;42721.07755150963;42786.572134278256;42829.78585107055;44444.11111777811;42004.3699344504;42225.155496889274;42762.35856462093;43897.56102439063;44108.779456102515;42673.78663106664;43273.3508997359;43766.343504846816;44391.77804110959;44493.33260001038;36244.27511449809;38274.2345153101;38484.80757596194;38561.614383856926;38867;28675;29197.416051679273;29383.412331753672;29389.706102938697;29451.263718407212 23:51:23 INFO - PROCESS | 29730 | |2;jquery.html;417.57407444406687;428.7839453956772;431.6546762589928;436.2801377726751;438.18497594474275;18680;19479.220831166735;20387.388378348656;20620.793792062075;20704.89647551764;19343.129559169836;20178.89910550449;20235.595288094268;20246.190152393923;20937.162513499443;5325.174597937326;5549.084401073818;5552.08390615548;5586.329640443152;5589.385167631557;5467.890642187154;5564.777408903639;5567.944320556803;5828.41715828418;6096.1770161028135;6119.143319935212;6132.570720049598;6165.0444181152;6166.38336166382;6176.81469555914;6127.5097992160745;6181.412765787243;6629.071929929813;6698.966505167492;6710.630915299656;5809.215755872945;6014.278286605591;6037.366076561942;6037.637741735466;6046.153538504613;23578;23873.76126238733;23933.401664958343;24194.15320463793;24560.631590525976;2449.595816690244;2488.129154795825;2498.612715029173;2579.0070822733196;2763.7236276372405;10785.78428431427;12640.620781376574;15458.381664733397;16213.594660133473;16622.25199866009;2054.3631474242884;2149.516358819253;2164.047818959653;2174.6520556711007;2198.043850924853;96492;103815;103830.58983199668;104100;104198;18849.811501884804;19026.334078307194;19135.981443896937;19476.318328858422;19498.220071196993;35063.12342191466;35126.12184695403;35167.4724879127;35335.82332088323;35581.46627800533;10925.399103049409;11166.274192177483;11201.887981120248;11359;11631.76736465283;9493.430394176372;9512;9522.190613797766;9724.49270363095;9732.805343893082;9396.67111651089;9441.819772528434;9640.879006618672;9701.417914925127;9775.4623495707;3224.516322551636;3259.6111621222194;3559.982200088983;3719.776813391205;3802.16352402471;932.3520153493257;1025.2720568396373;1033.3748082410184;1051.8790339111101;1093.699232710995;20372.185112595627;21021.264255750975;21123.961329498266;21213.363599092052;21259.68110478344;1020.9540570674337;1044.9216308776872;1055.963041293551;1065.2649671726483;1081.8377243413552;10884.673459796219;11557.942210289062;11742.823857642143;11747.29516229029;11889.108316876269;461840;467225;470290;482409;487845;71967;98758;98763;98896.50551747195;99619;1023.6826583759058;1043.3583346242006;1048.7325731938458;1069.2301542889106;1070.7911957168433;17791.911040444716;18098.638027239118;18637.161327740556;18678.71981920245;18768.503842818573;44716.55283447254;44799;44800.77599611981;45381.54618453905;46261;63163;63358.366416335244;63853;63878.68060659667;64438.35561644324;8753.693620723245;9153.77115572116;9251.444913305224;9290.210332121575;9413;10405.427701476492;13691.726165476435;14041.789373159207;14121.893183499613;14515.564533064025;11995.220310679779;12112.697182570506;12317.630471085882;12476;12573.245605263714;11775.941120294343;11833.171677982458;11880.524779009089;12299.938500307799;12518.937405312916;12104.334261615344;12150.57472988441;12224.266544007389;12312;12429;8055.83888322242;8394.286485648789;8935.151160639729;9316.580753865957;9418.011108833474;5823.301203855564;8870.73387798367;10344.741381465523;12157.331346776013;12312.13815032939 23:51:23 INFO - PROCESS | 29730 | |3;mootools.html;1411.8941079419046;1481.3111902965122;1530.7218472575398;1658.9336426542939;1815.972760408594;7887.684492620296;8440.451370660903;8471.322294216456;8753.3872628916;8755.649774009033;8799.56002199889;8867.645294188225;8884.733457996253;8889.422187557804;8899.555022248878;2440.5728997425467;2467.568175569277;2468.2471846086937;2470.29596564979;2472.307753828931;2332.1942703980485;2381.749916258785;2383.4756353602265;2396.760323967607;2397.2328854766483;2434.525267572824;2450.0322372662786;2465.6055031195015;2469.925902222936;2474.0474917156935;2261.1407665087163;2272.625016872214;2291.0606651273065;2293.0713061210154;2316.548273086749;2288.0504590594883;2297.7702229777055;2298.908043678251;2319.2926157521947;2321.1759825262125;8875.911240887574;8945.373823832335;8970.50662213578;9080.727578172666;9086;5262.947370526284;5428.185772134172;5437.619366644337;5498;5512.448755124496;3362.4283871741864;3425.160835595295;3479.0860282182543;3479.530263414432;3528.4883691864534;1076.1229597877705;1105.4914739219887;1116.8548088748412;1117.458032854065;1131.9377434241114;12465.875341246652;12502.187357821804;12532.060095492874;12549.874501254963;12571.245725256515;4484.932726009112;4640.118377508263;4733.219018861849;4735.052989402065;4756.310335001405;9857.605695772088;9891.60433582663;9892.851607225897;9901.207903367713;9905.108540231413;5456.8090116846515;5458.072127738294;5461.781528738806;5463.972680136574;5467.480589344006;4292.506361768436;4503.617192538605;4613.700109492872;4992.301077849104;5062.164742817394;3820.9617903820604;3846.1538461538416;3951.7431366961055;3955.782431966212;3961.0493481564795;1147.391882302381;1170.8770579089244;1174.3834486894448;1182.0838849891402;1189.0547015122997;918.0865039285819;936.6253498600614;978.7308490165119;1014.5535964175739;1023.1763430438419;6041.526122479592;6066.211392518944;6096.72564734588;6145.692715364214;6223.502119830403;458.8875725447287;459.5588235294088;471.42250742840434;473.862579851846;482.8961773218775;4056.0265536271672;4084.1219137885496;4091.774952377648;4107.507099148062;4136.110736191733;10192.13366863825;10359.171266298677;10453.529591168415;10466.52900619474;10467.685969420929;10339.327943683787;10393.740156496147;10394.48027598617;10403.84394234087;10408.895911040943;7895.6052197391045;8263;8271.462354946909;8275.379346548913;8275.462094963808;5983.34183239852;6086.482648974709;6262.561620686508;6277.780277690259;6429.292777794532;10070.848937266093;10242.6415075472;10246.231532634933;10247.59009639636;10348.793024139626;9142.405743626643;9484.193843523377;10382.221333400177;10432.530536126045;10438.895611043792;7546.509476883985;7712.92287077122;7782.027246594176;7828.178041305809;7983.680652773824;8378.874316885129;8543.231109200202;8551.57242137903;8565.871511927202;8569.65721371163;7605.429592780674;7657.540547567164;7714.652840622073;7720.652570634447;7734.303912647889;7423.851522969619;7480.0649918760155;7620.314171724572;7626.275503827128;7825.726099586487;6907.447404207752;7039.964800175966;7046.506744527834;7047.506674532733;7048.330408611174;4950.257461380822;5163.328767260232;5173.094708425935;5174.835661976176;5262.657927234717;5184.7926082956255;5196.142636464941;5199.66202196856;5341.439148889466;5453.509184173444 23:51:23 INFO - PROCESS | 29730 | |4;prototype.html;346.35577825245053;356.4688613965192;357.11791874071037;361.5372323426014;365.89206184175663;5209.531142197202;5287.814926477574;5372.516473517383;5391.32608423947;5446.891062178754;5174.4825517448235;5305.708186049766;5310.787568497265;5346.117890548065;5379.784808607651;4296;4319.697621166504;4321.978390108053;4348.695391382588;4353.825846966118;4273.807678654468;4294.484661840584;4307.181635489263;4309.37514060461;4334.718243314174;4242.80907359168;4250.744955302676;4261.744295342274;4273.67947403946;4283.336082907154;4244.363345498169;4255.404243405926;4258.87223383299;4260.829566817323;4275;3688.391415416453;3781.697464202857;3791.6018818023986;3806.3148633246005;3861.4014827701753;5232.764525596357;5233.267342572043;5247.842564723064;5250.7112108834;5255.369355677343;4853.830115945925;4859.222524396115;4890.73100979446;4901.485344038896;4903.8774030649165;5458.863528411782;5610.803621873256;5628.127640215773;5649.943500565024;5706.201131841545;4144.44050053242;4153.314703074019;4153.709240353177;4155.625993660555;4178.456800615931;5818.3308919474375;5849.38581448946;5852.57624289791;5876.501492119525;5904.232449781543;4134.565870583546;4208.305629571087;4234.301340278881;4245.787710614457;4259.936100958488;4266.509351424564;4277.379779931893;4278.358246263086;4287.7641729705165;4338.522762496123;4833.951660483421;4858.562729354305;4864.246041863446;4876.658633895593;4914.877128071756;5529.474699903583;5685.379666795026;5703;5739.827805165852;5749.655020698771;1357.8777909988148;1376.5870238928483;1403.505266890758;1442.9855701443062;1450.7606244969672;956.8899576548786;976.1117383181271;991.4794732765356;1001.5392919257077;1009.5557954499997;5219.739013049409;5224.294720212799;5234.3718753749035;5238.428471458547;5240.222681978481;5560.2493663355735;5591.9720401398545;5597.80407685729;5617.269754931833;5628.71856407178;5214.217867319932;5242.659227150223;5253.868653283698;5260.237265596467;5518.889622207534;2993.8593905357775;2998.5202367621077;3000.97966691326;3004.6094007779284;3008.5487176923198;5794.870000349892;5832.387599302097;5835.533157347487;5839.532837373;5885.6174348668055;5502.669839809624;5727.541796656257;5759.366469688331;5767.68277744728;5828.825135245949;5838.737256823453;5840.408148988427;5844.561657875676;5852.824415267463;5873.882522349529;5460.235567020541;5655.462731040545;5655.830325090254;5657.971710141587;5666.914996275142;5519.779208831602;5556.860843527148;5566.192902029264;5605.355384130714;5636.210930469655;5850.678212698343;5859.384764599826;5875.236219291465;5877.148698160066;5898.705064746831;3978.1844721832535;4100.323446631272;4193.958060419479;4212.515560710435;4224.197402493516;5586.966411213938;5759.625624334405;5762;5784.623999440023;5808.6224395414165;5589.580781441489;5610.298712660918;5728.341240757366;5736.397678243724;5762.596618236683;5673.085570956027;5698.54411647059;5699.202111704281;5705.828825135252;5719.256496655408;5413.648112872808;5638.716319890451;5661.631993920382;5688.544916406595;5692.1746346778655;5703.828885133453;5717.3996730342715;5726.484616384545;5731.398203188605;5735.311762588516;5485.945140548703;5574.609777315549;5602.327720673546;5626.74679639409;5643.689597072201 23:51:23 INFO - PROCESS | 29730 | |5;yui.html;798.5328582779074;800.3157300508066;829.0962850492962;898.5731777405737;904.9638014479423;14760.77858832117;15294.694106117871;15331.923340383297;15349.846501534967;15922.203889805522;16178.191090445489;16730.24713887875;16876.83123168768;16945.49163525093;16953.3218671253;849.9405041647071;863.447393668053;878.5387671472464;878.9956050219772;879.3580686099151;731.4733391957808;749.3555542233674;840.1598401598402;859.8538248497739;869.5347988825979;901.914318139779;909.2453263791037;912.2018234045211;913.7761248494095;914.6524320758102;903.6746771162376;904.9683261085896;905.0496978172893;905.7011186308503;907.4101833808045;660.2802944790202;661.0513912535479;666.3303380102966;666.5833853841349;666.7333066773281;15151.545453636409;15565.37738490459;15715.607109822346;15808.288627011812;15842.207889605474;11229.494672739746;13363.06458547902;14239;14407.855921440756;14432.342790551707;12370.567030153992;12497.769671497397;12623.431945562472;12645.810312845315;13232.933835330761;3864.0726225705907;3894.4547763313158;3906.335922893115;3956.940645890314;3975.403689446606;62834;63249;63344.68327658378;63407.68296158536;63444.365556343844;11199.440027998568;11346.773064538827;11472.4837382318;11762.58830940913;11764.411779410995;20582.27962021322;20582.588348232952;20606.896965515076;20607.381778546667;20623.58752824935;7732.30409263169;7824.100228473684;7873.881891771628;7885.605719713992;8241.752747417588;4743.976280118646;4878.56092951636;4878.731669758126;5034.723090229999;5041.823536176216;3561.661642143992;3673.081729567608;3679.356112680324;3681.0245284999496;3682.852685892588;596.5198015597399;596.749365266589;606.3057798820327;618.6442795392667;620.8634100497883;651.1372431528245;772.8067983004249;775.8681024225895;778.0624347661055;802.5987006496752;9680.709578712649;10006.599736010623;10250.179985601135;10264.538095785707;10403.635872744419;716.8279612892868;739.0872272743158;761.7828918758238;763.5685837501794;769.9807504812425;4777.163996300634;4846.7818948147415;4883.780229889663;4927.630427717935;4954.5788607968725;88404;90014.54992724994;91462;91654.54172729094;94588.52705736565;79799;80651.59674201591;81708.59145704233;82568.58715706383;84559.57720211359;72164.27835721575;72594.27405725981;73627.63186184035;74177.62911185517;75474.62262688651;9433.952830235805;9474.715758527254;9477.810443790948;9485.146336829719;9569.712908612475;48364.758176208896;49439;50085.74957125191;50115;51534;53496;61732.38267617446;64664;67472;68160.6591967037;13114.868851311365;13261.138026028277;13302.800457993331;13306.800397994231;13697.178169309873;14798.48205312809;14850.777238341218;14900.18049007315;15171.848281517485;15650.217489125725;13047.412866420844;13890.791638125234;14824.703505929605;15269.77095343593;15385.076895386313;13900.860991389956;14158;14237.288135593386;14428.711425771637;14548.709025819637;13573;13702.246376448993;13958.720825583228;14163.221022843842;14405.42378304856;11070.944645276722;11540.422978850856;11731.941340293244;11760.294382337088;12778.61664150077;11035.668929932115;12035.578754743541;12221.816672749737;12321.137520373488;12441.440135193758 23:51:23 INFO - PROCESS | 29730 | __end_tp_report 23:51:23 INFO - PROCESS | 29730 | __start_cc_report 23:51:23 INFO - PROCESS | 29730 | _x_x_mozilla_cycle_collect,918 23:51:23 INFO - PROCESS | 29730 | __end_cc_report 23:51:23 INFO - PROCESS | 29730 | __startTimestamp1485244283839__endTimestamp 23:51:23 INFO - PROCESS | 29730 | 23:51:23 INFO - PROCESS | 29730 | ------- Summary: start ------- 23:51:23 INFO - PROCESS | 29730 | Number of tests: 6 23:51:23 INFO - PROCESS | 29730 | 23:51:23 INFO - PROCESS | 29730 | [#0] dojo.html Cycles:165 Average:5593.98 Median:5820.77 stddev:625.89 (10.8%) stddev-sans-first:599.90 23:51:23 INFO - PROCESS | 29730 | Values: 3238.0 3280.7 3289.5 3303.4 3307.5 5618.6 5671.8 5688.8 5695.7 5695.9 5538.7 5593.2 5601.1 5603.6 5637.7 5063.1 5079.8 5117.7 5140.6 5156.8 5059.9 5157.7 5164.1 5170.5 5172.4 5033.3 5078.3 5142.8 5179.4 5187.1 5098.5 5121.1 5129.6 5197.4 5206.2 5040.8 5066.2 5119.3 5169.8 5190.4 5398.7 5424.6 5446.5 5495.9 5562.4 5881.5 5911.9 5920.9 6011.5 6018.0 6074.8 6085.8 6087.3 6093.2 6097.1 5513.7 5571.2 5575.3 5613.2 5626.8 6117.0 6139.7 6142.0 6149.8 6152.6 5919.1 5920.0 5927.4 5929.0 5931.9 5814.7 5839.1 5944.1 5954.2 5974.8 6011.1 6016.6 6021.4 6048.2 6052.8 5965.6 6012.6 6014.9 6019.9 6029.3 4559.5 4602.5 4666.3 4696.2 4711.2 4130.8 4157.4 4180.5 4202.6 4208.9 5762.8 5765.1 5768.4 5769.3 5770.9 5944.6 5989.7 6050.5 6140.5 6156.1 5705.6 5774.3 5778.9 5795.5 5812.3 5119.6 5122.8 5128.0 5129.0 5130.6 5995.5 6033.0 6257.3 6303.1 6325.0 5935.7 5949.4 5999.2 6072.1 6091.8 6220.7 6257.2 6257.7 6258.3 6271.1 5853.2 5853.2 5856.5 5892.0 5898.6 5772.9 5879.3 5982.3 6016.6 6088.3 5954.2 6003.2 6003.8 6013.4 6034.7 5949.5 5973.8 5980.1 5985.7 5989.6 5659.5 5722.1 5816.5 5875.5 5898.0 5954.1 5957.5 5968.0 5985.8 6002.4 5626.6 5655.0 5820.8 5827.8 5833.7 23:51:23 INFO - PROCESS | 29730 | 23:51:23 INFO - PROCESS | 29730 | [#1] ext.html Cycles:180 Average:55932.48 Median:36364.36 stddev:101679.09 (279.6%) stddev-sans-first:101879.44 23:51:23 INFO - PROCESS | 29730 | Values: 593.9 605.2 650.7 660.3 675.7 36484.5 46115.5 46961.5 47190.8 51356.0 48477.5 49062.8 49065.0 49103.3 49143.0 8517.4 9002.6 9138.8 9141.2 9145.5 8608.3 10870.6 11141.9 11142.1 11444.6 11212.6 11276.9 11279.8 11282.5 11289.7 11029.1 11070.7 11082.7 11088.6 11114.3 10973.8 11030.3 11030.8 11032.1 11044.1 44962.6 45095.3 45113.5 45173.3 45213.5 3838.7 3887.7 3962.3 4243.5 4380.1 33919.0 34338.7 34369.7 34914.8 35839.8 4384.5 4641.7 4665.4 4679.0 4735.1 336958.0 336967.0 338195.0 338734.0 339677.0 64209.0 64747.4 64825.7 64851.0 64936.0 36017.5 36702.0 36894.8 37154.4 37208.4 17216.7 17360.7 17380.7 17404.1 17415.0 12657.2 12867.1 13038.3 13535.6 13700.5 20497.8 21574.4 21718.8 21738.1 21786.0 7464.4 7645.6 7749.3 7777.7 7781.6 1007.6 1064.9 1088.5 1101.5 1160.3 33169.8 33767.5 33932.1 34050.0 34295.3 1141.6 1147.9 1171.6 1207.5 1210.8 17743.8 18168.7 18192.9 18287.3 18311.6 488729.0 492128.0 492448.0 492456.0 493150.0 62247.4 62713.4 62879.0 63014.0 63060.0 1310.2 1375.6 1404.4 1415.3 1453.2 32536.8 34376.3 34478.3 34949.0 35161.5 54311.5 54761.5 54893.5 54943.7 54980.2 299839.0 300810.0 301857.0 301949.0 301983.0 27948.9 28701.0 30340.7 31165.5 31562.4 49489.5 49957.5 50150.7 50242.0 50589.5 42076.0 42721.1 42786.6 42829.8 44444.1 42004.4 42225.2 42762.4 43897.6 44108.8 42673.8 43273.4 43766.3 44391.8 44493.3 36244.3 38274.2 38484.8 38561.6 38867.0 28675.0 29197.4 29383.4 29389.7 29451.3 23:51:23 INFO - PROCESS | 29730 | 23:51:23 INFO - PROCESS | 29730 | [#2] jquery.html Cycles:180 Average:30911.08 Median:13505.11 stddev:78627.37 (582.2%) stddev-sans-first:78814.60 23:51:23 INFO - PROCESS | 29730 | Values: 417.6 428.8 431.7 436.3 438.2 18680.0 19479.2 20387.4 20620.8 20704.9 19343.1 20178.9 20235.6 20246.2 20937.2 5325.2 5549.1 5552.1 5586.3 5589.4 5467.9 5564.8 5567.9 5828.4 6096.2 6119.1 6132.6 6165.0 6166.4 6176.8 6127.5 6181.4 6629.1 6699.0 6710.6 5809.2 6014.3 6037.4 6037.6 6046.2 23578.0 23873.8 23933.4 24194.2 24560.6 2449.6 2488.1 2498.6 2579.0 2763.7 10785.8 12640.6 15458.4 16213.6 16622.3 2054.4 2149.5 2164.0 2174.7 2198.0 96492.0 103815.0 103830.6 104100.0 104198.0 18849.8 19026.3 19136.0 19476.3 19498.2 35063.1 35126.1 35167.5 35335.8 35581.5 10925.4 11166.3 11201.9 11359.0 11631.8 9493.4 9512.0 9522.2 9724.5 9732.8 9396.7 9441.8 9640.9 9701.4 9775.5 3224.5 3259.6 3560.0 3719.8 3802.2 932.4 1025.3 1033.4 1051.9 1093.7 20372.2 21021.3 21124.0 21213.4 21259.7 1021.0 1044.9 1056.0 1065.3 1081.8 10884.7 11557.9 11742.8 11747.3 11889.1 461840.0 467225.0 470290.0 482409.0 487845.0 71967.0 98758.0 98763.0 98896.5 99619.0 1023.7 1043.4 1048.7 1069.2 1070.8 17791.9 18098.6 18637.2 18678.7 18768.5 44716.6 44799.0 44800.8 45381.5 46261.0 63163.0 63358.4 63853.0 63878.7 64438.4 8753.7 9153.8 9251.4 9290.2 9413.0 10405.4 13691.7 14041.8 14121.9 14515.6 11995.2 12112.7 12317.6 12476.0 12573.2 11775.9 11833.2 11880.5 12299.9 12518.9 12104.3 12150.6 12224.3 12312.0 12429.0 8055.8 8394.3 8935.2 9316.6 9418.0 5823.3 8870.7 10344.7 12157.3 12312.1 23:51:23 INFO - PROCESS | 29730 | 23:51:23 INFO - PROCESS | 29730 | [#3] mootools.html Cycles:180 Average:5782.15 Median:4745.68 stddev:3262.19 (68.7%) stddev-sans-first:3254.81 23:51:23 INFO - PROCESS | 29730 | Values: 1411.9 1481.3 1530.7 1658.9 1816.0 7887.7 8440.5 8471.3 8753.4 8755.6 8799.6 8867.6 8884.7 8889.4 8899.6 2440.6 2467.6 2468.2 2470.3 2472.3 2332.2 2381.7 2383.5 2396.8 2397.2 2434.5 2450.0 2465.6 2469.9 2474.0 2261.1 2272.6 2291.1 2293.1 2316.5 2288.1 2297.8 2298.9 2319.3 2321.2 8875.9 8945.4 8970.5 9080.7 9086.0 5262.9 5428.2 5437.6 5498.0 5512.4 3362.4 3425.2 3479.1 3479.5 3528.5 1076.1 1105.5 1116.9 1117.5 1131.9 12465.9 12502.2 12532.1 12549.9 12571.2 4484.9 4640.1 4733.2 4735.1 4756.3 9857.6 9891.6 9892.9 9901.2 9905.1 5456.8 5458.1 5461.8 5464.0 5467.5 4292.5 4503.6 4613.7 4992.3 5062.2 3821.0 3846.2 3951.7 3955.8 3961.0 1147.4 1170.9 1174.4 1182.1 1189.1 918.1 936.6 978.7 1014.6 1023.2 6041.5 6066.2 6096.7 6145.7 6223.5 458.9 459.6 471.4 473.9 482.9 4056.0 4084.1 4091.8 4107.5 4136.1 10192.1 10359.2 10453.5 10466.5 10467.7 10339.3 10393.7 10394.5 10403.8 10408.9 7895.6 8263.0 8271.5 8275.4 8275.5 5983.3 6086.5 6262.6 6277.8 6429.3 10070.8 10242.6 10246.2 10247.6 10348.8 9142.4 9484.2 10382.2 10432.5 10438.9 7546.5 7712.9 7782.0 7828.2 7983.7 8378.9 8543.2 8551.6 8565.9 8569.7 7605.4 7657.5 7714.7 7720.7 7734.3 7423.9 7480.1 7620.3 7626.3 7825.7 6907.4 7040.0 7046.5 7047.5 7048.3 4950.3 5163.3 5173.1 5174.8 5262.7 5184.8 5196.1 5199.7 5341.4 5453.5 23:51:23 INFO - PROCESS | 29730 | 23:51:23 INFO - PROCESS | 29730 | [#4] prototype.html Cycles:180 Average:4748.47 Median:5328.45 stddev:1368.15 (25.7%) stddev-sans-first:1331.49 23:51:23 INFO - PROCESS | 29730 | Values: 346.4 356.5 357.1 361.5 365.9 5209.5 5287.8 5372.5 5391.3 5446.9 5174.5 5305.7 5310.8 5346.1 5379.8 4296.0 4319.7 4322.0 4348.7 4353.8 4273.8 4294.5 4307.2 4309.4 4334.7 4242.8 4250.7 4261.7 4273.7 4283.3 4244.4 4255.4 4258.9 4260.8 4275.0 3688.4 3781.7 3791.6 3806.3 3861.4 5232.8 5233.3 5247.8 5250.7 5255.4 4853.8 4859.2 4890.7 4901.5 4903.9 5458.9 5610.8 5628.1 5649.9 5706.2 4144.4 4153.3 4153.7 4155.6 4178.5 5818.3 5849.4 5852.6 5876.5 5904.2 4134.6 4208.3 4234.3 4245.8 4259.9 4266.5 4277.4 4278.4 4287.8 4338.5 4834.0 4858.6 4864.2 4876.7 4914.9 5529.5 5685.4 5703.0 5739.8 5749.7 1357.9 1376.6 1403.5 1443.0 1450.8 956.9 976.1 991.5 1001.5 1009.6 5219.7 5224.3 5234.4 5238.4 5240.2 5560.2 5592.0 5597.8 5617.3 5628.7 5214.2 5242.7 5253.9 5260.2 5518.9 2993.9 2998.5 3001.0 3004.6 3008.5 5794.9 5832.4 5835.5 5839.5 5885.6 5502.7 5727.5 5759.4 5767.7 5828.8 5838.7 5840.4 5844.6 5852.8 5873.9 5460.2 5655.5 5655.8 5658.0 5666.9 5519.8 5556.9 5566.2 5605.4 5636.2 5850.7 5859.4 5875.2 5877.1 5898.7 3978.2 4100.3 4194.0 4212.5 4224.2 5587.0 5759.6 5762.0 5784.6 5808.6 5589.6 5610.3 5728.3 5736.4 5762.6 5673.1 5698.5 5699.2 5705.8 5719.3 5413.6 5638.7 5661.6 5688.5 5692.2 5703.8 5717.4 5726.5 5731.4 5735.3 5485.9 5574.6 5602.3 5626.7 5643.7 23:51:23 INFO - PROCESS | 29730 | 23:51:23 INFO - PROCESS | 29730 | [#5] yui.html Cycles:180 Average:18774.15 Median:4905.71 stddev:24540.80 (500.3%) stddev-sans-first:24572.52 23:51:23 INFO - PROCESS | 29730 | Values: 798.5 800.3 829.1 898.6 905.0 14760.8 15294.7 15331.9 15349.8 15922.2 16178.2 16730.2 16876.8 16945.5 16953.3 849.9 863.4 878.5 879.0 879.4 731.5 749.4 840.2 859.9 869.5 901.9 909.2 912.2 913.8 914.7 903.7 905.0 905.0 905.7 907.4 660.3 661.1 666.3 666.6 666.7 15151.5 15565.4 15715.6 15808.3 15842.2 11229.5 13363.1 14239.0 14407.9 14432.3 12370.6 12497.8 12623.4 12645.8 13232.9 3864.1 3894.5 3906.3 3956.9 3975.4 62834.0 63249.0 63344.7 63407.7 63444.4 11199.4 11346.8 11472.5 11762.6 11764.4 20582.3 20582.6 20606.9 20607.4 20623.6 7732.3 7824.1 7873.9 7885.6 8241.8 4744.0 4878.6 4878.7 5034.7 5041.8 3561.7 3673.1 3679.4 3681.0 3682.9 596.5 596.7 606.3 618.6 620.9 651.1 772.8 775.9 778.1 802.6 9680.7 10006.6 10250.2 10264.5 10403.6 716.8 739.1 761.8 763.6 770.0 4777.2 4846.8 4883.8 4927.6 4954.6 88404.0 90014.5 91462.0 91654.5 94588.5 79799.0 80651.6 81708.6 82568.6 84559.6 72164.3 72594.3 73627.6 74177.6 75474.6 9434.0 9474.7 9477.8 9485.1 9569.7 48364.8 49439.0 50085.7 50115.0 51534.0 53496.0 61732.4 64664.0 67472.0 68160.7 13114.9 13261.1 13302.8 13306.8 13697.2 14798.5 14850.8 14900.2 15171.8 15650.2 13047.4 13890.8 14824.7 15269.8 15385.1 13900.9 14158.0 14237.3 14428.7 14548.7 13573.0 13702.2 13958.7 14163.2 14405.4 11070.9 11540.4 11731.9 11760.3 12778.6 11035.7 12035.6 12221.8 12321.1 12441.4 23:51:23 INFO - PROCESS | 29730 | -------- Summary: end -------- 23:51:23 INFO - PROCESS | 29730 | 23:51:24 INFO - TEST-INFO | 29730: exit 0 23:51:24 INFO - TEST-OK | dromaeo_css | took 1115019ms 23:51:24 INFO - TEST-START | kraken 23:51:24 INFO - operating with platform_type : linux_ 23:51:24 INFO - Initialising browser for kraken test... 23:51:24 INFO - TEST-INFO | started process 30036 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMDHVmP/profile http://localhost:51611/getInfo.html) 23:51:28 INFO - PROCESS | 30036 | __metrics Screen width/height:1600/1200 23:51:28 INFO - PROCESS | 30036 | colorDepth:24 23:51:28 INFO - PROCESS | 30036 | Browser inner width/height: 1024/697 23:51:28 INFO - PROCESS | 30036 | __metrics 23:51:28 INFO - PROCESS | 30036 | 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" 23:51:28 INFO - PROCESS | 30036 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:51:29 INFO - PROCESS | 30036 | console.error: PushService: 23:51:29 INFO - PROCESS | 30036 | stateChangeProcessEnqueue: Error transitioning state 23:51:29 INFO - PROCESS | 30036 | UnknownError 23:51:29 INFO - TEST-INFO | 30036: exit 0 23:51:29 INFO - Browser initialized. 23:51:29 INFO - Running cycle 1/1 for kraken test... 23:51:29 INFO - TEST-INFO | started process 30133 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMDHVmP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:51:41 INFO - PROCESS | 30133 | RSS: Main: 144723968 23:51:41 INFO - PROCESS | 30133 | 23:51:43 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51611/tests/kraken/driver.html?testName=audio-beat-detection) 23:51:44 INFO - PROCESS | 30133 | RSS: Main: 186482688 23:51:44 INFO - PROCESS | 30133 | 23:51:47 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51611/tests/kraken/driver.html?testName=audio-dft) 23:51:47 INFO - PROCESS | 30133 | RSS: Main: 175935488 23:51:47 INFO - PROCESS | 30133 | 23:51:50 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51611/tests/kraken/driver.html?testName=audio-fft) 23:51:51 INFO - PROCESS | 30133 | RSS: Main: 267137024 23:51:51 INFO - PROCESS | 30133 | 23:51:53 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51611/tests/kraken/driver.html?testName=audio-oscillator) 23:51:53 INFO - PROCESS | 30133 | RSS: Main: 173535232 23:51:53 INFO - PROCESS | 30133 | 23:51:55 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:51:56 INFO - PROCESS | 30133 | RSS: Main: 175947776 23:51:56 INFO - PROCESS | 30133 | 23:51:59 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51611/tests/kraken/driver.html?testName=imaging-darkroom) 23:52:00 INFO - PROCESS | 30133 | RSS: Main: 213622784 23:52:00 INFO - PROCESS | 30133 | 23:52:03 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51611/tests/kraken/driver.html?testName=imaging-desaturate) 23:52:04 INFO - PROCESS | 30133 | RSS: Main: 213880832 23:52:04 INFO - PROCESS | 30133 | 23:52:06 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51611/tests/kraken/driver.html?testName=json-parse-financial) 23:52:07 INFO - PROCESS | 30133 | RSS: Main: 212369408 23:52:07 INFO - PROCESS | 30133 | 23:52:08 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:52:09 INFO - PROCESS | 30133 | RSS: Main: 174596096 23:52:09 INFO - PROCESS | 30133 | 23:52:11 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:52:11 INFO - PROCESS | 30133 | RSS: Main: 181559296 23:52:11 INFO - PROCESS | 30133 | 23:52:13 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:52:14 INFO - PROCESS | 30133 | RSS: Main: 187707392 23:52:14 INFO - PROCESS | 30133 | 23:52:16 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:52:17 INFO - PROCESS | 30133 | RSS: Main: 195649536 23:52:17 INFO - PROCESS | 30133 | 23:52:20 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:52:20 INFO - PROCESS | 30133 | RSS: Main: 192737280 23:52:20 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51611/tests/kraken/driver.html?testName=ai-astar) 23:52:22 INFO - PROCESS | 30133 | RSS: Main: 245035008 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | __start_tp_report 23:52:22 INFO - PROCESS | 30133 | _x_x_mozilla_page_load 23:52:22 INFO - PROCESS | 30133 | _x_x_mozilla_page_load_details 23:52:22 INFO - PROCESS | 30133 | |i|pagename|runs| 23:52:22 INFO - PROCESS | 30133 | |0;ai-astar;103;110;113;110;112;110;112;111;110;110 23:52:22 INFO - PROCESS | 30133 | |1;audio-beat-detection;138;117;117;154;119;118;120;117;143;117 23:52:22 INFO - PROCESS | 30133 | |2;audio-dft;159;159;160;160;160;160;159;160;161;161 23:52:22 INFO - PROCESS | 30133 | |3;audio-fft;74;76;75;112;75;76;75;76;104;75 23:52:22 INFO - PROCESS | 30133 | |4;audio-oscillator;83;82;114;82;83;83;99;82;82;109 23:52:22 INFO - PROCESS | 30133 | |5;imaging-gaussian-blur;117;117;117;117;117;117;116;118;117;117 23:52:22 INFO - PROCESS | 30133 | |6;imaging-darkroom;147;146;146;145;147;146;146;146;146;146 23:52:22 INFO - PROCESS | 30133 | |7;imaging-desaturate;84;84;84;84;84;84;85;85;85;84 23:52:22 INFO - PROCESS | 30133 | |8;json-parse-financial;50;49;49;48;50;51;51;49;49;49 23:52:22 INFO - PROCESS | 30133 | |9;json-stringify-tinderbox;58;60;57;58;59;59;58;59;60;59 23:52:22 INFO - PROCESS | 30133 | |10;stanford-crypto-aes;84;75;74;76;76;76;76;75;76;74 23:52:22 INFO - PROCESS | 30133 | |11;stanford-crypto-ccm;129;123;122;129;131;127;119;127;159;120 23:52:22 INFO - PROCESS | 30133 | |12;stanford-crypto-pbkdf2;159;154;155;158;154;153;155;153;152;155 23:52:22 INFO - PROCESS | 30133 | |13;stanford-crypto-sha256-iterative;63;63;66;64;62;63;61;61;61;60 23:52:22 INFO - PROCESS | 30133 | __end_tp_report 23:52:22 INFO - PROCESS | 30133 | __start_cc_report 23:52:22 INFO - PROCESS | 30133 | _x_x_mozilla_cycle_collect,1564 23:52:22 INFO - PROCESS | 30133 | __end_cc_report 23:52:22 INFO - PROCESS | 30133 | __startTimestamp1485244342564__endTimestamp 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | ------- Summary: start ------- 23:52:22 INFO - PROCESS | 30133 | Number of tests: 14 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#0] ai-astar Cycles:10 Average:110.10 Median:110.50 stddev:2.73 (2.5%) stddev-sans-first:1.17 23:52:22 INFO - PROCESS | 30133 | Values: 103.0 110.0 113.0 110.0 112.0 110.0 112.0 111.0 110.0 110.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#1] audio-beat-detection Cycles:10 Average:126.00 Median:119.50 stddev:13.70 (11.5%) stddev-sans-first:13.83 23:52:22 INFO - PROCESS | 30133 | Values: 138.0 117.0 117.0 154.0 119.0 118.0 120.0 117.0 143.0 117.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#2] audio-dft Cycles:10 Average:159.90 Median:160.00 stddev:0.74 (0.5%) stddev-sans-first:0.71 23:52:22 INFO - PROCESS | 30133 | Values: 159.0 159.0 160.0 160.0 160.0 160.0 159.0 160.0 161.0 161.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#3] audio-fft Cycles:10 Average:81.80 Median:75.00 stddev:13.95 (18.6%) stddev-sans-first:14.51 23:52:22 INFO - PROCESS | 30133 | Values: 74.0 76.0 75.0 112.0 75.0 76.0 75.0 76.0 104.0 75.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#4] audio-oscillator Cycles:10 Average:89.90 Median:82.50 stddev:12.56 (15.2%) stddev-sans-first:13.08 23:52:22 INFO - PROCESS | 30133 | Values: 83.0 82.0 114.0 82.0 83.0 83.0 99.0 82.0 82.0 109.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 23:52:22 INFO - PROCESS | 30133 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 116.0 118.0 117.0 117.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.50 23:52:22 INFO - PROCESS | 30133 | Values: 147.0 146.0 146.0 145.0 147.0 146.0 146.0 146.0 146.0 146.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#7] imaging-desaturate Cycles:10 Average:84.30 Median:84.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 23:52:22 INFO - PROCESS | 30133 | Values: 84.0 84.0 84.0 84.0 84.0 84.0 85.0 85.0 85.0 84.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#8] json-parse-financial Cycles:10 Average:49.50 Median:49.50 stddev:0.97 (2.0%) stddev-sans-first:1.01 23:52:22 INFO - PROCESS | 30133 | Values: 50.0 49.0 49.0 48.0 50.0 51.0 51.0 49.0 49.0 49.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:59.00 stddev:0.95 (1.6%) stddev-sans-first:0.97 23:52:22 INFO - PROCESS | 30133 | Values: 58.0 60.0 57.0 58.0 59.0 59.0 58.0 59.0 60.0 59.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#10] stanford-crypto-aes Cycles:10 Average:76.20 Median:76.00 stddev:2.86 (3.8%) stddev-sans-first:0.87 23:52:22 INFO - PROCESS | 30133 | Values: 84.0 75.0 74.0 76.0 76.0 76.0 76.0 75.0 76.0 74.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#11] stanford-crypto-ccm Cycles:10 Average:128.60 Median:128.00 stddev:11.43 (8.9%) stddev-sans-first:12.13 23:52:22 INFO - PROCESS | 30133 | Values: 129.0 123.0 122.0 129.0 131.0 127.0 119.0 127.0 159.0 120.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.80 Median:155.00 stddev:2.20 (1.4%) stddev-sans-first:1.73 23:52:22 INFO - PROCESS | 30133 | Values: 159.0 154.0 155.0 158.0 154.0 153.0 155.0 153.0 152.0 155.0 23:52:22 INFO - PROCESS | 30133 | 23:52:22 INFO - PROCESS | 30133 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:63.00 stddev:1.78 (2.8%) stddev-sans-first:1.87 23:52:22 INFO - PROCESS | 30133 | Values: 63.0 63.0 66.0 64.0 62.0 63.0 61.0 61.0 61.0 60.0 23:52:22 INFO - PROCESS | 30133 | -------- Summary: end -------- 23:52:22 INFO - PROCESS | 30133 | 23:52:23 INFO - TEST-INFO | 30133: exit 0 23:52:23 INFO - TEST-OK | kraken | took 58931ms 23:52:23 INFO - SUITE-END | took 1173s 23:52:23 INFO - Completed test suite (00:19:34) 23:52:23 INFO - javascript benchmark 23:52:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3237.9514307285385, 3280.6883346082127, 3289.4901290300004, 3303.3723592517404, 3307.470804671253, 5618.5786066045, 5671.8014869479575, 5688.829335119943, 5695.658260504368, 5695.914561281579, 5538.695371754552, 5593.216949627045, 5601.131824567188, 5603.635763675358, 5637.746301416436, 5063.139266324733, 5079.84760457185, 5117.744112794364, 5140.640155189139, 5156.793728250866, 5059.949400506003, 5157.71632560209, 5164.122099243119, 5170.482951704818, 5172.431032586413, 5033.270175824503, 5078.314427552288, 5142.794288228466, 5179.378474583055, 5187.118189907725, 5098.464661210575, 5121.129408000649, 5129.589632829365, 5197.428282888879, 5206.167013277857, 5040.798368065273, 5066.164082926312, 5119.257707632372, 5169.81905633301, 5190.429052804188, 5398.676079435247, 5424.566034717213, 5446.537044351235, 5495.917561236544, 5562.360328562227, 5881.47066763989, 5911.9113213301835, 5920.881582368372, 6011.458968692795, 6018.037114061773, 6074.817755467343, 6085.847853803646, 6087.269527656666, 6093.207882975229, 6097.115918191837, 5513.669179849182, 5571.192177134333, 5575.303087114111, 5613.186088017296, 5626.774929002876, 6117.0, 6139.693015349215, 6141.969290153521, 6149.7847575334645, 6152.630842149485, 5919.082542205965, 5919.970400147971, 5927.407259274124, 5928.970355148283, 5931.911021334683, 5814.709264536841, 5839.124131380242, 5944.108383742473, 5954.166416701665, 5974.761009559656, 6011.09833524966, 6016.578839481282, 6021.42796434338, 6048.153258543807, 6052.848678782978, 5965.55258355625, 6012.579119461683, 6014.879702405928, 6019.879602407927, 6029.336772954972, 4559.498455169929, 4602.470715867651, 4666.253399456139, 4696.1546921554445, 4711.175544279738, 4130.793460327031, 4157.397177409319, 4180.540140584533, 4202.600752928467, 4208.894777630584, 5762.769489220468, 5765.135229715576, 5768.394318596487, 5769.336526299446, 5770.913436298459, 5944.554158438134, 5989.700514974234, 6050.515958723292, 6140.539459540552, 6156.107364432132, 5705.62913410627, 5774.307083150049, 5778.913316300259, 5795.536357091422, 5812.302523697099, 5119.641625086283, 5122.769475373617, 5127.974360128175, 5128.974355128275, 5130.629509828315, 5995.520358371233, 6033.0, 6257.342978987141, 6303.149074874925, 6325.0, 5935.732892019956, 5949.434803693643, 5999.220101386792, 6072.14989901423, 6091.847703807263, 6220.688965551795, 6257.217847769029, 6257.68711564429, 6258.311585725658, 6271.059341098689, 5853.151293062397, 5853.209816674695, 5856.531477481876, 5891.970540147272, 5898.587098903207, 5772.884542309046, 5879.2944846618675, 5982.282126144891, 6016.578839481194, 6088.299845517822, 5954.225950626391, 6003.189569408074, 6003.849903752441, 6013.428724271187, 6034.668093254913, 5949.494292985145, 5973.790917317873, 5980.132880732356, 5985.670788106696, 5989.610675306091, 5659.54723622101, 5722.055860782924, 5816.47651711348, 5875.500582450369, 5897.970510147422, 5954.07711804671, 5957.49361304294, 5968.045112781934, 5985.832762611249, 6002.399760023963, 5626.606137570331, 5655.038643430709, 5820.76716931335, 5827.79602713903, 5833.708314584339], "value": 5552.543852650447, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [593.9198208241888, 605.1558076483304, 650.703929711981, 660.3231687520295, 675.6925598852523, 36484.45273320899, 46115.53884461158, 46961.53038469614, 47190.76404617972, 51356.0, 48477.51522484774, 49062.75468622661, 49065.0, 49103.26345104817, 49143.0, 8517.403781735282, 9002.639894404216, 9138.77153071172, 9141.177294043535, 9145.496997665126, 8608.268297194745, 10870.61952831651, 11141.944290278538, 11142.108631309517, 11444.599439019636, 11212.551497940072, 11276.887231127706, 11279.830802537968, 11282.492287847066, 11289.661310160709, 11029.062529684987, 11070.667879963614, 11082.667519974413, 11088.55645774172, 11114.333140011626, 10973.83539246912, 11030.283031603, 11030.834537481944, 11032.117430605533, 11044.061254793352, 44962.55037449616, 45095.32357014647, 45113.54886451159, 45173.32240016403, 45213.54786452159, 3838.654521093087, 3887.6695480883877, 3962.286788378091, 4243.469566304212, 4380.08018316154, 33919.0, 34338.6566134338, 34369.656303436896, 34914.82542587271, 35839.82080089609, 4384.495782984934, 4641.651876109271, 4665.370175026362, 4679.0, 4735.124002059595, 336957.99999999756, 336967.0, 338195.0, 338734.0, 339677.0, 64209.0, 64747.35252647507, 64825.67587162034, 64851.0, 64936.0, 36017.459738103425, 36702.0, 36894.8155259222, 37154.44268335977, 37208.44187337138, 17216.655666886592, 17360.65278694419, 17380.739288910678, 17404.129793510274, 17415.0, 12657.177283476545, 12867.099303048697, 13038.348082595832, 13535.59393218205, 13700.52048178329, 20497.795022049588, 21574.352769416942, 21718.78281217199, 21738.13047478083, 21786.0, 7464.402847772165, 7645.579493127821, 7749.3413059890545, 7777.650005749755, 7781.649825757854, 1007.6019972110975, 1064.9041586257274, 1088.4666513408372, 1101.4823033174396, 1160.3270103340042, 33169.83415082909, 33767.493487597705, 33932.10989076629, 34050.0, 34295.314093717985, 1141.611851970334, 1147.925384849982, 1171.630936255077, 1207.456644509974, 1210.7820592293472, 17743.822561774476, 18168.727469087975, 18192.909035454737, 18287.268509259746, 18311.63376732458, 488729.0, 492128.0, 492448.0, 492456.0, 493150.0, 62247.377526225064, 62713.37286627075, 62879.0, 63014.0, 63060.0, 1310.194230548206, 1375.587323802875, 1404.4171668757351, 1415.2640626874174, 1453.2152637575803, 32536.83731581327, 34376.312473750884, 34478.31043379169, 34949.0, 35161.47257791186, 54311.45688543064, 54761.45238547723, 54893.451065488836, 54943.725281373336, 54980.175297371374, 299839.0, 300810.0, 301857.0, 301949.0, 301983.0, 27948.86025569859, 28701.0, 30340.696593033786, 31165.53251701181, 31562.36875262528, 49489.50510494849, 49957.50042499528, 50150.74924625354, 50242.0, 50589.49410505995, 42076.0, 42721.07755150963, 42786.572134278256, 42829.78585107055, 44444.11111777811, 42004.3699344504, 42225.155496889274, 42762.35856462093, 43897.56102439063, 44108.779456102515, 42673.78663106664, 43273.3508997359, 43766.343504846816, 44391.77804110959, 44493.33260001038, 36244.27511449809, 38274.2345153101, 38484.80757596194, 38561.614383856926, 38867.0, 28675.0, 29197.416051679273, 29383.412331753672, 29389.706102938697, 29451.263718407212], "value": 21045.347175573777, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.57407444406687, 428.7839453956772, 431.6546762589928, 436.2801377726751, 438.18497594474275, 18680.0, 19479.220831166735, 20387.388378348656, 20620.793792062075, 20704.89647551764, 19343.129559169836, 20178.89910550449, 20235.595288094268, 20246.190152393923, 20937.162513499443, 5325.174597937326, 5549.084401073818, 5552.08390615548, 5586.329640443152, 5589.385167631557, 5467.890642187154, 5564.777408903639, 5567.944320556803, 5828.41715828418, 6096.1770161028135, 6119.143319935212, 6132.570720049598, 6165.0444181152, 6166.38336166382, 6176.81469555914, 6127.5097992160745, 6181.412765787243, 6629.071929929813, 6698.966505167492, 6710.630915299656, 5809.215755872945, 6014.278286605591, 6037.366076561942, 6037.637741735466, 6046.153538504613, 23578.0, 23873.76126238733, 23933.401664958343, 24194.15320463793, 24560.631590525976, 2449.595816690244, 2488.129154795825, 2498.612715029173, 2579.0070822733196, 2763.7236276372405, 10785.78428431427, 12640.620781376574, 15458.381664733397, 16213.594660133473, 16622.25199866009, 2054.3631474242884, 2149.516358819253, 2164.047818959653, 2174.6520556711007, 2198.043850924853, 96492.0, 103815.0, 103830.58983199668, 104100.0, 104198.0, 18849.811501884804, 19026.334078307194, 19135.981443896937, 19476.318328858422, 19498.220071196993, 35063.12342191466, 35126.12184695403, 35167.4724879127, 35335.82332088323, 35581.46627800533, 10925.399103049409, 11166.274192177483, 11201.887981120248, 11359.0, 11631.76736465283, 9493.430394176372, 9512.0, 9522.190613797766, 9724.49270363095, 9732.805343893082, 9396.67111651089, 9441.819772528434, 9640.879006618672, 9701.417914925127, 9775.4623495707, 3224.516322551636, 3259.6111621222194, 3559.982200088983, 3719.776813391205, 3802.16352402471, 932.3520153493257, 1025.2720568396373, 1033.3748082410184, 1051.8790339111101, 1093.699232710995, 20372.185112595627, 21021.264255750975, 21123.961329498266, 21213.363599092052, 21259.68110478344, 1020.9540570674337, 1044.9216308776872, 1055.963041293551, 1065.2649671726483, 1081.8377243413552, 10884.673459796219, 11557.942210289062, 11742.823857642143, 11747.29516229029, 11889.108316876269, 461840.0, 467225.0, 470290.0, 482409.0, 487845.0, 71967.0, 98758.0, 98763.0, 98896.50551747195, 99619.0, 1023.6826583759058, 1043.3583346242006, 1048.7325731938458, 1069.2301542889106, 1070.7911957168433, 17791.911040444716, 18098.638027239118, 18637.161327740556, 18678.71981920245, 18768.503842818573, 44716.55283447254, 44799.0, 44800.77599611981, 45381.54618453905, 46261.0, 63163.0, 63358.366416335244, 63853.0, 63878.68060659667, 64438.35561644324, 8753.693620723245, 9153.77115572116, 9251.444913305224, 9290.210332121575, 9413.0, 10405.427701476492, 13691.726165476435, 14041.789373159207, 14121.893183499613, 14515.564533064025, 11995.220310679779, 12112.697182570506, 12317.630471085882, 12476.0, 12573.245605263714, 11775.941120294343, 11833.171677982458, 11880.524779009089, 12299.938500307799, 12518.937405312916, 12104.334261615344, 12150.57472988441, 12224.266544007389, 12312.0, 12429.0, 8055.83888322242, 8394.286485648789, 8935.151160639729, 9316.580753865957, 9418.011108833474, 5823.301203855564, 8870.73387798367, 10344.741381465523, 12157.331346776013, 12312.13815032939], "value": 10590.960877415542, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1411.8941079419046, 1481.3111902965122, 1530.7218472575398, 1658.9336426542939, 1815.972760408594, 7887.684492620296, 8440.451370660903, 8471.322294216456, 8753.3872628916, 8755.649774009033, 8799.56002199889, 8867.645294188225, 8884.733457996253, 8889.422187557804, 8899.555022248878, 2440.5728997425467, 2467.568175569277, 2468.2471846086937, 2470.29596564979, 2472.307753828931, 2332.1942703980485, 2381.749916258785, 2383.4756353602265, 2396.760323967607, 2397.2328854766483, 2434.525267572824, 2450.0322372662786, 2465.6055031195015, 2469.925902222936, 2474.0474917156935, 2261.1407665087163, 2272.625016872214, 2291.0606651273065, 2293.0713061210154, 2316.548273086749, 2288.0504590594883, 2297.7702229777055, 2298.908043678251, 2319.2926157521947, 2321.1759825262125, 8875.911240887574, 8945.373823832335, 8970.50662213578, 9080.727578172666, 9086.0, 5262.947370526284, 5428.185772134172, 5437.619366644337, 5498.0, 5512.448755124496, 3362.4283871741864, 3425.160835595295, 3479.0860282182543, 3479.530263414432, 3528.4883691864534, 1076.1229597877705, 1105.4914739219887, 1116.8548088748412, 1117.458032854065, 1131.9377434241114, 12465.875341246652, 12502.187357821804, 12532.060095492874, 12549.874501254963, 12571.245725256515, 4484.932726009112, 4640.118377508263, 4733.219018861849, 4735.052989402065, 4756.310335001405, 9857.605695772088, 9891.60433582663, 9892.851607225897, 9901.207903367713, 9905.108540231413, 5456.8090116846515, 5458.072127738294, 5461.781528738806, 5463.972680136574, 5467.480589344006, 4292.506361768436, 4503.617192538605, 4613.700109492872, 4992.301077849104, 5062.164742817394, 3820.9617903820604, 3846.1538461538416, 3951.7431366961055, 3955.782431966212, 3961.0493481564795, 1147.391882302381, 1170.8770579089244, 1174.3834486894448, 1182.0838849891402, 1189.0547015122997, 918.0865039285819, 936.6253498600614, 978.7308490165119, 1014.5535964175739, 1023.1763430438419, 6041.526122479592, 6066.211392518944, 6096.72564734588, 6145.692715364214, 6223.502119830403, 458.8875725447287, 459.5588235294088, 471.42250742840434, 473.862579851846, 482.8961773218775, 4056.0265536271672, 4084.1219137885496, 4091.774952377648, 4107.507099148062, 4136.110736191733, 10192.13366863825, 10359.171266298677, 10453.529591168415, 10466.52900619474, 10467.685969420929, 10339.327943683787, 10393.740156496147, 10394.48027598617, 10403.84394234087, 10408.895911040943, 7895.6052197391045, 8263.0, 8271.462354946909, 8275.379346548913, 8275.462094963808, 5983.34183239852, 6086.482648974709, 6262.561620686508, 6277.780277690259, 6429.292777794532, 10070.848937266093, 10242.6415075472, 10246.231532634933, 10247.59009639636, 10348.793024139626, 9142.405743626643, 9484.193843523377, 10382.221333400177, 10432.530536126045, 10438.895611043792, 7546.509476883985, 7712.92287077122, 7782.027246594176, 7828.178041305809, 7983.680652773824, 8378.874316885129, 8543.231109200202, 8551.57242137903, 8565.871511927202, 8569.65721371163, 7605.429592780674, 7657.540547567164, 7714.652840622073, 7720.652570634447, 7734.303912647889, 7423.851522969619, 7480.0649918760155, 7620.314171724572, 7626.275503827128, 7825.726099586487, 6907.447404207752, 7039.964800175966, 7046.506744527834, 7047.506674532733, 7048.330408611174, 4950.257461380822, 5163.328767260232, 5173.094708425935, 5174.835661976176, 5262.657927234717, 5184.7926082956255, 5196.142636464941, 5199.66202196856, 5341.439148889466, 5453.509184173444], "value": 4563.4385419990995, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.35577825245053, 356.4688613965192, 357.11791874071037, 361.5372323426014, 365.89206184175663, 5209.531142197202, 5287.814926477574, 5372.516473517383, 5391.32608423947, 5446.891062178754, 5174.4825517448235, 5305.708186049766, 5310.787568497265, 5346.117890548065, 5379.784808607651, 4296.0, 4319.697621166504, 4321.978390108053, 4348.695391382588, 4353.825846966118, 4273.807678654468, 4294.484661840584, 4307.181635489263, 4309.37514060461, 4334.718243314174, 4242.80907359168, 4250.744955302676, 4261.744295342274, 4273.67947403946, 4283.336082907154, 4244.363345498169, 4255.404243405926, 4258.87223383299, 4260.829566817323, 4275.0, 3688.391415416453, 3781.697464202857, 3791.6018818023986, 3806.3148633246005, 3861.4014827701753, 5232.764525596357, 5233.267342572043, 5247.842564723064, 5250.7112108834, 5255.369355677343, 4853.830115945925, 4859.222524396115, 4890.73100979446, 4901.485344038896, 4903.8774030649165, 5458.863528411782, 5610.803621873256, 5628.127640215773, 5649.943500565024, 5706.201131841545, 4144.44050053242, 4153.314703074019, 4153.709240353177, 4155.625993660555, 4178.456800615931, 5818.3308919474375, 5849.38581448946, 5852.57624289791, 5876.501492119525, 5904.232449781543, 4134.565870583546, 4208.305629571087, 4234.301340278881, 4245.787710614457, 4259.936100958488, 4266.509351424564, 4277.379779931893, 4278.358246263086, 4287.7641729705165, 4338.522762496123, 4833.951660483421, 4858.562729354305, 4864.246041863446, 4876.658633895593, 4914.877128071756, 5529.474699903583, 5685.379666795026, 5703.0, 5739.827805165852, 5749.655020698771, 1357.8777909988148, 1376.5870238928483, 1403.505266890758, 1442.9855701443062, 1450.7606244969672, 956.8899576548786, 976.1117383181271, 991.4794732765356, 1001.5392919257077, 1009.5557954499997, 5219.739013049409, 5224.294720212799, 5234.3718753749035, 5238.428471458547, 5240.222681978481, 5560.2493663355735, 5591.9720401398545, 5597.80407685729, 5617.269754931833, 5628.71856407178, 5214.217867319932, 5242.659227150223, 5253.868653283698, 5260.237265596467, 5518.889622207534, 2993.8593905357775, 2998.5202367621077, 3000.97966691326, 3004.6094007779284, 3008.5487176923198, 5794.870000349892, 5832.387599302097, 5835.533157347487, 5839.532837373, 5885.6174348668055, 5502.669839809624, 5727.541796656257, 5759.366469688331, 5767.68277744728, 5828.825135245949, 5838.737256823453, 5840.408148988427, 5844.561657875676, 5852.824415267463, 5873.882522349529, 5460.235567020541, 5655.462731040545, 5655.830325090254, 5657.971710141587, 5666.914996275142, 5519.779208831602, 5556.860843527148, 5566.192902029264, 5605.355384130714, 5636.210930469655, 5850.678212698343, 5859.384764599826, 5875.236219291465, 5877.148698160066, 5898.705064746831, 3978.1844721832535, 4100.323446631272, 4193.958060419479, 4212.515560710435, 4224.197402493516, 5586.966411213938, 5759.625624334405, 5762.0, 5784.623999440023, 5808.6224395414165, 5589.580781441489, 5610.298712660918, 5728.341240757366, 5736.397678243724, 5762.596618236683, 5673.085570956027, 5698.54411647059, 5699.202111704281, 5705.828825135252, 5719.256496655408, 5413.648112872808, 5638.716319890451, 5661.631993920382, 5688.544916406595, 5692.1746346778655, 5703.828885133453, 5717.3996730342715, 5726.484616384545, 5731.398203188605, 5735.311762588516, 5485.945140548703, 5574.609777315549, 5602.327720673546, 5626.74679639409, 5643.689597072201], "value": 4316.434426519027, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [798.5328582779074, 800.3157300508066, 829.0962850492962, 898.5731777405737, 904.9638014479423, 14760.77858832117, 15294.694106117871, 15331.923340383297, 15349.846501534967, 15922.203889805522, 16178.191090445489, 16730.24713887875, 16876.83123168768, 16945.49163525093, 16953.3218671253, 849.9405041647071, 863.447393668053, 878.5387671472464, 878.9956050219772, 879.3580686099151, 731.4733391957808, 749.3555542233674, 840.1598401598402, 859.8538248497739, 869.5347988825979, 901.914318139779, 909.2453263791037, 912.2018234045211, 913.7761248494095, 914.6524320758102, 903.6746771162376, 904.9683261085896, 905.0496978172893, 905.7011186308503, 907.4101833808045, 660.2802944790202, 661.0513912535479, 666.3303380102966, 666.5833853841349, 666.7333066773281, 15151.545453636409, 15565.37738490459, 15715.607109822346, 15808.288627011812, 15842.207889605474, 11229.494672739746, 13363.06458547902, 14239.0, 14407.855921440756, 14432.342790551707, 12370.567030153992, 12497.769671497397, 12623.431945562472, 12645.810312845315, 13232.933835330761, 3864.0726225705907, 3894.4547763313158, 3906.335922893115, 3956.940645890314, 3975.403689446606, 62834.0, 63249.0, 63344.68327658378, 63407.68296158536, 63444.365556343844, 11199.440027998568, 11346.773064538827, 11472.4837382318, 11762.58830940913, 11764.411779410995, 20582.27962021322, 20582.588348232952, 20606.896965515076, 20607.381778546667, 20623.58752824935, 7732.30409263169, 7824.100228473684, 7873.881891771628, 7885.605719713992, 8241.752747417588, 4743.976280118646, 4878.56092951636, 4878.731669758126, 5034.723090229999, 5041.823536176216, 3561.661642143992, 3673.081729567608, 3679.356112680324, 3681.0245284999496, 3682.852685892588, 596.5198015597399, 596.749365266589, 606.3057798820327, 618.6442795392667, 620.8634100497883, 651.1372431528245, 772.8067983004249, 775.8681024225895, 778.0624347661055, 802.5987006496752, 9680.709578712649, 10006.599736010623, 10250.179985601135, 10264.538095785707, 10403.635872744419, 716.8279612892868, 739.0872272743158, 761.7828918758238, 763.5685837501794, 769.9807504812425, 4777.163996300634, 4846.7818948147415, 4883.780229889663, 4927.630427717935, 4954.5788607968725, 88404.0, 90014.54992724994, 91462.0, 91654.54172729094, 94588.52705736565, 79799.0, 80651.59674201591, 81708.59145704233, 82568.58715706383, 84559.57720211359, 72164.27835721575, 72594.27405725981, 73627.63186184035, 74177.62911185517, 75474.62262688651, 9433.952830235805, 9474.715758527254, 9477.810443790948, 9485.146336829719, 9569.712908612475, 48364.758176208896, 49439.0, 50085.74957125191, 50115.0, 51534.0, 53496.0, 61732.38267617446, 64664.0, 67472.0, 68160.6591967037, 13114.868851311365, 13261.138026028277, 13302.800457993331, 13306.800397994231, 13697.178169309873, 14798.48205312809, 14850.777238341218, 14900.18049007315, 15171.848281517485, 15650.217489125725, 13047.412866420844, 13890.791638125234, 14824.703505929605, 15269.77095343593, 15385.076895386313, 13900.860991389956, 14158.0, 14237.288135593386, 14428.711425771637, 14548.709025819637, 13573.0, 13702.246376448993, 13958.720825583228, 14163.221022843842, 14405.42378304856, 11070.944645276722, 11540.422978850856, 11731.941340293244, 11760.294382337088, 12778.61664150077, 11035.668929932115, 12035.578754743541, 12221.816672749737, 12321.137520373488, 12441.440135193758], "value": 7565.088163186172, "unit": "score"}], "name": "dromaeo_css", "value": 7544.7307168857815, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 110.0, 113.0, 110.0, 112.0, 110.0, 112.0, 111.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 117.0, 117.0, 154.0, 119.0, 118.0, 120.0, 117.0, 143.0, 117.0], "value": 126.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 159.0, 160.0, 160.0, 160.0, 160.0, 159.0, 160.0, 161.0, 161.0], "value": 159.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 112.0, 75.0, 76.0, 75.0, 76.0, 104.0, 75.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 114.0, 82.0, 83.0, 83.0, 99.0, 82.0, 82.0, 109.0], "value": 89.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 118.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 85.0, 85.0, 85.0, 84.0], "value": 84.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 49.0, 48.0, 50.0, 51.0, 51.0, 49.0, 49.0, 49.0], "value": 49.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 57.0, 58.0, 59.0, 59.0, 58.0, 59.0, 60.0, 59.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 75.0, 74.0, 76.0, 76.0, 76.0, 76.0, 75.0, 76.0, 74.0], "value": 76.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 123.0, 122.0, 129.0, 131.0, 127.0, 119.0, 127.0, 159.0, 120.0], "value": 128.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 154.0, 155.0, 158.0, 154.0, 153.0, 155.0, 153.0, 152.0, 155.0], "value": 154.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 66.0, 64.0, 62.0, 63.0, 61.0, 61.0, 61.0, 60.0], "value": 62.4, "unit": "score"}], "name": "kraken", "value": 1445.3, "alertThreshold": 2.0}]} 23:52:23 INFO - Return code: 0 23:52:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:52:23 INFO - # TBPL SUCCESS # 23:52:23 INFO - Running post-action listener: _resource_record_post_action 23:52:23 INFO - [mozharness: 2017-01-24 07:52:23.869779Z] Finished run-tests step (success) 23:52:23 INFO - Running post-run listener: _resource_record_post_run 23:52:23 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 310091776; Read time: 8; Write time: 150036 23:52:23 INFO - TinderboxPrint: CPU usage
13.0% 23:52:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 23:52:23 INFO - TinderboxPrint: I/O write bytes / time
310,091,776 / 150,036 23:52:23 INFO - TinderboxPrint: CPU idle
8,254.1 (87.0%) 23:52:23 INFO - TinderboxPrint: CPU user
1,186.7 (12.5%) 23:52:23 INFO - TinderboxPrint: Swap in / out
0 / 0 23:52:23 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 101003264; Read time: 0; Write time: 65404 23:52:23 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 208236544; Read time: 0; Write time: 84616 23:52:24 INFO - Running post-run listener: _upload_blobber_files 23:52:24 INFO - Blob upload gear active. 23:52:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:52:24 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 23:52:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:52:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:52:24 INFO - (blobuploader) - INFO - Open directory for files ... 23:52:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:52:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:52:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:52:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:52:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:52:25 INFO - (blobuploader) - INFO - Done attempting. 23:52:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:52:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:52:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:52:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:52:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:52:29 INFO - (blobuploader) - INFO - Done attempting. 23:52:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:52:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:52:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:52:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:52:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:52:29 INFO - (blobuploader) - INFO - Done attempting. 23:52:29 INFO - (blobuploader) - INFO - Iteration through files over. 23:52:29 INFO - Return code: 0 23:52:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:52:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:52:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/380e926fd003aef894b84d2db107abb44c887c3330a513b8c61622dd662130469e3a854b3b183f947e1acf7fd1a7aee10255ed068451e76ccec43c889f9e746e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1efe912a4487ead8b83b42ffaacfd81692dc059c286ace94ead2d30c57b4e8b4fee7e7b8a91dfa035b7764cbec653f9fd12a26cb2c63a271cffea8283626f41e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b28e0b80ca3fcae13657e09a7e0c594a7cc30c94156b171bff3e7af49c71f5dd627e1119055e47bc0b48d15703b2acbdca608de23b2b1115debcebaeebeb966"} 23:52:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:52:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:52:29 INFO - Contents: 23:52:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/380e926fd003aef894b84d2db107abb44c887c3330a513b8c61622dd662130469e3a854b3b183f947e1acf7fd1a7aee10255ed068451e76ccec43c889f9e746e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1efe912a4487ead8b83b42ffaacfd81692dc059c286ace94ead2d30c57b4e8b4fee7e7b8a91dfa035b7764cbec653f9fd12a26cb2c63a271cffea8283626f41e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b28e0b80ca3fcae13657e09a7e0c594a7cc30c94156b171bff3e7af49c71f5dd627e1119055e47bc0b48d15703b2acbdca608de23b2b1115debcebaeebeb966"} 23:52:29 INFO - Running post-run listener: copy_logs_to_upload_dir 23:52:29 INFO - Copying logs to upload dir... 23:52:29 INFO - mkdir: /builds/slave/test/build/upload/logs 23:52:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1233.837564 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2017-01-23 23:52:29.342718) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 23:52:29.347059) ========= 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=6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/380e926fd003aef894b84d2db107abb44c887c3330a513b8c61622dd662130469e3a854b3b183f947e1acf7fd1a7aee10255ed068451e76ccec43c889f9e746e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1efe912a4487ead8b83b42ffaacfd81692dc059c286ace94ead2d30c57b4e8b4fee7e7b8a91dfa035b7764cbec653f9fd12a26cb2c63a271cffea8283626f41e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b28e0b80ca3fcae13657e09a7e0c594a7cc30c94156b171bff3e7af49c71f5dd627e1119055e47bc0b48d15703b2acbdca608de23b2b1115debcebaeebeb966"} build_url:https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011614 build_url: 'https://queue.taskcluster.net/v1/task/YDFW1ajyRvuroLXpiZKY_A/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/380e926fd003aef894b84d2db107abb44c887c3330a513b8c61622dd662130469e3a854b3b183f947e1acf7fd1a7aee10255ed068451e76ccec43c889f9e746e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1efe912a4487ead8b83b42ffaacfd81692dc059c286ace94ead2d30c57b4e8b4fee7e7b8a91dfa035b7764cbec653f9fd12a26cb2c63a271cffea8283626f41e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7b28e0b80ca3fcae13657e09a7e0c594a7cc30c94156b171bff3e7af49c71f5dd627e1119055e47bc0b48d15703b2acbdca608de23b2b1115debcebaeebeb966"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 23:52:29.375276) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:52:29.375606) ========= 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=6dbc10da6d83fee962c624be000001a8-1485241157.329378-1355725695 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004507 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 23:52:29.459392) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 23:52:29.462738) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 23:52:29.463027) ========= ========= Total master_lag: 0.20 =========