builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-033 starttime: 1479295809.62 results: success (0) buildid: 20161116004016 builduid: a51a5df0f27e484ba36831f52f68e9dd revision: f99c3a999e81a017ca3f6026b1e75fe4ec31a50a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:09.617569) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:09.618074) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:09.618358) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:09.633560) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:09.633954) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-16 03:30:09-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.5M=0s 2016-11-16 03:30:09 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142402 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:09.790702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:09.791155) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014813 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:09.841431) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:09.841944) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f99c3a999e81a017ca3f6026b1e75fe4ec31a50a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f99c3a999e81a017ca3f6026b1e75fe4ec31a50a --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=edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-16 03:30:09,983 truncating revision to first 12 chars 2016-11-16 03:30:09,983 Setting DEBUG logging. 2016-11-16 03:30:09,983 attempt 1/10 2016-11-16 03:30:09,983 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f99c3a999e81?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-16 03:30:10,350 unpacking tar archive at: mozilla-aurora-f99c3a999e81/testing/mozharness/ program finished with exit code 0 elapsedTime=0.704929 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:10.560914) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:10.561264) ========= script_repo_revision: f99c3a999e81a017ca3f6026b1e75fe4ec31a50a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:10.561780) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:10.562104) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-16 03:30:10.571505) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-16 03:30:10.571969) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:30:10 INFO - MultiFileLogger online at 20161116 03:30:10 in /builds/slave/test 03:30:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:30:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:30:10 INFO - {'append_to_log': False, 03:30:10 INFO - 'base_work_dir': '/builds/slave/test', 03:30:10 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:30:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:30:10 INFO - 'branch': 'Mozilla-Aurora', 03:30:10 INFO - 'buildbot_json_path': 'buildprops.json', 03:30:10 INFO - 'config_files': ('talos/linux_config.py',), 03:30:10 INFO - 'default_actions': ('clobber', 03:30:10 INFO - 'read-buildbot-config', 03:30:10 INFO - 'download-and-extract', 03:30:10 INFO - 'populate-webroot', 03:30:10 INFO - 'create-virtualenv', 03:30:10 INFO - 'install', 03:30:10 INFO - 'run-tests'), 03:30:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:30:10 INFO - 'download_minidump_stackwalk': True, 03:30:10 INFO - 'download_symbols': 'ondemand', 03:30:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:30:10 INFO - 'tooltool.py': '/tools/tooltool.py', 03:30:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:30:10 INFO - '/tools/misc-python/virtualenv.py')}, 03:30:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:30:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:30:10 INFO - 'installer_path': 'installer.exe', 03:30:10 INFO - 'log_level': 'info', 03:30:10 INFO - 'log_name': 'talos', 03:30:10 INFO - 'log_to_console': True, 03:30:10 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:30:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:30:10 INFO - 'opt_config_files': (), 03:30:10 INFO - 'pip_index': False, 03:30:10 INFO - 'sps_profile': False, 03:30:10 INFO - 'sps_profile_interval': 0, 03:30:10 INFO - 'suite': 'dromaeojs', 03:30:10 INFO - 'system_bits': '32', 03:30:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:30:10 INFO - 'title': 'talos-linux64-ix-033', 03:30:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:30:10 INFO - 'use_talos_json': True, 03:30:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:30:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:30:10 INFO - 'work_dir': 'build'} 03:30:10 INFO - [mozharness: 2016-11-16 11:30:10.812657Z] Running clobber step. 03:30:10 INFO - Running pre-action listener: _resource_record_pre_action 03:30:10 INFO - Running main action method: clobber 03:30:10 INFO - rmtree: /builds/slave/test/build 03:30:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:30:11 INFO - Running post-action listener: _resource_record_post_action 03:30:11 INFO - [mozharness: 2016-11-16 11:30:11.273883Z] Finished clobber step (success) 03:30:11 INFO - [mozharness: 2016-11-16 11:30:11.273984Z] Running read-buildbot-config step. 03:30:11 INFO - Running pre-action listener: _resource_record_pre_action 03:30:11 INFO - Running main action method: read_buildbot_config 03:30:11 INFO - Using buildbot properties: 03:30:11 INFO - { 03:30:11 INFO - "project": "", 03:30:11 INFO - "product": "firefox", 03:30:11 INFO - "script_repo_revision": "production", 03:30:11 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 03:30:11 INFO - "repository": "", 03:30:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 03:30:11 INFO - "buildid": "20161116004016", 03:30:11 INFO - "stage_platform": "linux64-pgo", 03:30:11 INFO - "basedir": "/builds/slave/test", 03:30:11 INFO - "nightly_build": "True", 03:30:11 INFO - "buildnumber": 600, 03:30:11 INFO - "slavename": "talos-linux64-ix-033", 03:30:11 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:30:11 INFO - "platform": "ubuntu64_hw", 03:30:11 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:30:11 INFO - "branch": "mozilla-aurora", 03:30:11 INFO - "repo_path": "releases/mozilla-aurora", 03:30:11 INFO - "revision": "f99c3a999e81a017ca3f6026b1e75fe4ec31a50a", 03:30:11 INFO - "pgo_build": "True", 03:30:11 INFO - "builduid": "a51a5df0f27e484ba36831f52f68e9dd", 03:30:11 INFO - "slavebuilddir": "test" 03:30:11 INFO - } 03:30:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 03:30:11 INFO - Running post-action listener: _resource_record_post_action 03:30:11 INFO - [mozharness: 2016-11-16 11:30:11.276518Z] Finished read-buildbot-config step (success) 03:30:11 INFO - [mozharness: 2016-11-16 11:30:11.276608Z] Running download-and-extract step. 03:30:11 INFO - Running pre-action listener: _resource_record_pre_action 03:30:11 INFO - Running main action method: download_and_extract 03:30:11 INFO - mkdir: /builds/slave/test/build/tests 03:30:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:11 INFO - trying https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:11 INFO - Downloading https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:30:11 INFO - Downloaded 1361 bytes. 03:30:11 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 03:30:11 INFO - Using the following test package requirements: 03:30:11 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:11 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:30:11 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:30:11 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:11 INFO - u'jsshell-linux-x86_64.zip'], 03:30:11 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:30:11 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 03:30:11 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:30:11 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:30:11 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:30:11 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 03:30:11 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:30:11 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:30:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:30:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:11 INFO - Fetch https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:30:14 INFO - Http code: 200 03:30:14 INFO - via: 1.1 11512f00e812993b9daa35c376d7cb20.cloudfront.net (CloudFront) 03:30:14 INFO - x-amz-cf-id: DZ7aIJ-HCvMKQjvwe6q1m_f_s4k6I8vPoTF7ZtiHtDdETlmUYi5DQA== 03:30:14 INFO - x-amz-version-id: S2f.zkYOMvrzfuPHXYZwSST.PHFiR3Yu 03:30:14 INFO - Expected file size: 21999845 03:30:14 INFO - Obtained file size: 21999845 03:30:18 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:30:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 03:30:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:30:18 INFO - Fetch https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 03:30:19 INFO - Http code: 200 03:30:19 INFO - via: 1.1 0576b942ae9f4fc9c0b62b0736e9bfd6.cloudfront.net (CloudFront) 03:30:19 INFO - x-amz-cf-id: vB6ufrK4PDTb7y-HuwnwqntRqSTZRTg_EKIKtuGDKIqrYWrJznXX6w== 03:30:19 INFO - x-amz-version-id: S2f.zkYOMvrzfuPHXYZwSST.PHFiR3Yu 03:30:19 INFO - Expected file size: 21999845 03:30:19 INFO - Obtained file size: 21999845 03:30:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 03:30:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:30:24 INFO - Fetch https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 03:30:24 INFO - Http code: 200 03:30:24 INFO - via: 1.1 3d3d633d266d05d90a4eea7a6a59b514.cloudfront.net (CloudFront) 03:30:24 INFO - x-amz-cf-id: bKPx9rSI-OzOqDAR0PlN-Bh5viMooWLwXMdOe1cRB2s-KedYRpTeLw== 03:30:24 INFO - x-amz-version-id: 7diIqXztk7.PGnaNVm6GWcHNZ6JiLxh_ 03:30:25 INFO - Expected file size: 14409038 03:30:25 INFO - Obtained file size: 14409038 03:30:25 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')]} 03:30:25 INFO - trying https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:30:25 INFO - Downloading https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:30:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:30:26 INFO - Downloaded 63922485 bytes. 03:30:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:30:26 INFO - mkdir: /builds/slave/test/properties 03:30:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:30:26 INFO - Writing to file /builds/slave/test/properties/build_url 03:30:26 INFO - Contents: 03:30:26 INFO - build_url:https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 03:30:27 INFO - Running post-action listener: _resource_record_post_action 03:30:27 INFO - Running post-action listener: set_extra_try_arguments 03:30:27 INFO - [mozharness: 2016-11-16 11:30:27.376546Z] Finished download-and-extract step (success) 03:30:27 INFO - [mozharness: 2016-11-16 11:30:27.376775Z] Running populate-webroot step. 03:30:27 INFO - Running pre-action listener: _resource_record_pre_action 03:30:27 INFO - Running main action method: populate_webroot 03:30:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:30:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:30:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:30:27 INFO - '--tppagecycles', 03:30:27 INFO - '7'], 03:30:27 INFO - 'tests': ['tsvgm']}}, 03:30:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:30:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:30:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:30:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:30:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:27 INFO - 'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:30:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:27 INFO - 'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['damp', 'tps']}, 03:30:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:27 INFO - 'tests': ['damp', 'tps']}, 03:30:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['dromaeo_dom']}, 03:30:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:30:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['basic_compositor_video']}, 03:30:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:30:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['a11yr', 03:30:27 INFO - 'ts_paint', 03:30:27 INFO - 'tpaint', 03:30:27 INFO - 'sessionrestore', 03:30:27 INFO - 'sessionrestore_no_auto_restore', 03:30:27 INFO - 'tabpaint']}, 03:30:27 INFO - 'other-e10s': {'tests': ['a11yr', 03:30:27 INFO - 'ts_paint', 03:30:27 INFO - 'tpaint', 03:30:27 INFO - 'sessionrestore', 03:30:27 INFO - 'sessionrestore_no_auto_restore', 03:30:27 INFO - 'tabpaint']}, 03:30:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:30:27 INFO - 'ts_paint', 03:30:27 INFO - 'tpaint', 03:30:27 INFO - 'sessionrestore', 03:30:27 INFO - 'sessionrestore_no_auto_restore', 03:30:27 INFO - 'tabpaint']}, 03:30:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:30:27 INFO - 'ts_paint', 03:30:27 INFO - 'tpaint', 03:30:27 INFO - 'sessionrestore', 03:30:27 INFO - 'sessionrestore_no_auto_restore', 03:30:27 INFO - 'tabpaint']}, 03:30:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['a11yr', 03:30:27 INFO - 'ts_paint', 03:30:27 INFO - 'tpaint', 03:30:27 INFO - 'sessionrestore', 03:30:27 INFO - 'sessionrestore_no_auto_restore', 03:30:27 INFO - 'tabpaint']}, 03:30:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['a11yr', 03:30:27 INFO - 'ts_paint', 03:30:27 INFO - 'tpaint', 03:30:27 INFO - 'sessionrestore', 03:30:27 INFO - 'sessionrestore_no_auto_restore', 03:30:27 INFO - 'tabpaint']}, 03:30:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['tsvgx', 03:30:27 INFO - 'tsvgr_opacity', 03:30:27 INFO - 'tart', 03:30:27 INFO - 'tscrollx', 03:30:27 INFO - 'cart']}, 03:30:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:30:27 INFO - 'tsvgr_opacity', 03:30:27 INFO - 'tart', 03:30:27 INFO - 'tscrollx', 03:30:27 INFO - 'cart']}, 03:30:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:27 INFO - 'talos_options': ['--disable-e10s'], 03:30:27 INFO - 'tests': ['tp5o']}, 03:30:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:27 INFO - 'tests': ['tp5o']}, 03:30:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:27 INFO - 'talos_options': ['--disable-e10s', 03:30:27 INFO - '--xperf_path', 03:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:27 INFO - 'tests': ['tp5n']}, 03:30:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:30:27 INFO - 'talos_options': ['--xperf_path', 03:30:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:30:27 INFO - 'tests': ['tp5n']}}, 03:30:27 INFO - 'talos.zip': {'path': '', 03:30:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:30:27 INFO - Running post-action listener: _resource_record_post_action 03:30:27 INFO - [mozharness: 2016-11-16 11:30:27.395498Z] Finished populate-webroot step (success) 03:30:27 INFO - [mozharness: 2016-11-16 11:30:27.395587Z] Running create-virtualenv step. 03:30:27 INFO - Running pre-action listener: _resource_record_pre_action 03:30:27 INFO - Running main action method: create_virtualenv 03:30:27 INFO - Creating virtualenv /builds/slave/test/build/venv 03:30:27 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 03:30:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:30:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:30:27 INFO - Using real prefix '/usr' 03:30:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:30:28 INFO - Installing distribute.............................................................................................................................................................................................done. 03:30:29 INFO - Installing pip.................done. 03:30:30 INFO - Return code: 0 03:30:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:30:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:30:30 INFO - Reading from file tmpfile_stdout 03:30:30 INFO - Output received: 03:30:30 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) 03:30:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:30 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 0x7f3e45a2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', '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 03:30:30 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 03:30:30 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 03:30:30 INFO - Using env: {'DISPLAY': ':0', 03:30:30 INFO - 'HOME': '/home/cltbld', 03:30:30 INFO - 'LANG': 'en_US.UTF-8', 03:30:30 INFO - 'LANGUAGE': 'en_US:en', 03:30:30 INFO - 'LOGNAME': 'cltbld', 03:30:30 INFO - 'MAIL': '/var/mail/cltbld', 03:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:30 INFO - 'MOZ_NO_REMOTE': '1', 03:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:30 INFO - 'NO_EM_RESTART': '1', 03:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:30 INFO - 'PWD': '/builds/slave/test', 03:30:30 INFO - 'SHELL': '/bin/bash', 03:30:30 INFO - 'SHLVL': '1', 03:30:30 INFO - 'TERM': 'linux', 03:30:30 INFO - 'TMOUT': '86400', 03:30:30 INFO - 'USER': 'cltbld', 03:30:30 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:30 INFO - '_': '/tools/buildbot/bin/python'} 03:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:30 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 03:30:30 INFO - Cleaning up... 03:30:30 INFO - Return code: 0 03:30:30 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:30 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 0x7f3e45a2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', '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 03:30:30 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 03:30:30 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 03:30:30 INFO - Using env: {'DISPLAY': ':0', 03:30:30 INFO - 'HOME': '/home/cltbld', 03:30:30 INFO - 'LANG': 'en_US.UTF-8', 03:30:30 INFO - 'LANGUAGE': 'en_US:en', 03:30:30 INFO - 'LOGNAME': 'cltbld', 03:30:30 INFO - 'MAIL': '/var/mail/cltbld', 03:30:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:30 INFO - 'MOZ_NO_REMOTE': '1', 03:30:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:30 INFO - 'NO_EM_RESTART': '1', 03:30:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:30 INFO - 'PWD': '/builds/slave/test', 03:30:30 INFO - 'SHELL': '/bin/bash', 03:30:30 INFO - 'SHLVL': '1', 03:30:30 INFO - 'TERM': 'linux', 03:30:30 INFO - 'TMOUT': '86400', 03:30:30 INFO - 'USER': 'cltbld', 03:30:30 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:30:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:30 INFO - '_': '/tools/buildbot/bin/python'} 03:30:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:30 INFO - Downloading/unpacking psutil>=3.1.1 03:30:30 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 03:30:30 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 03:30:30 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 03:30:30 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 03:30:30 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 03:30:30 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 03:30:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:30:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:32 INFO - Installing collected packages: psutil 03:30:32 INFO - Running setup.py install for psutil 03:30:32 INFO - building 'psutil._psutil_linux' extension 03:30:32 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 03:30:32 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 03:30:32 INFO - building 'psutil._psutil_posix' extension 03:30:32 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 03:30:33 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 03:30:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:30:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:30:33 INFO - Successfully installed psutil 03:30:33 INFO - Cleaning up... 03:30:33 INFO - Return code: 0 03:30:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:30:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:33 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 0x7f3e45a2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', '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 03:30:33 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 03:30:33 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 03:30:33 INFO - Using env: {'DISPLAY': ':0', 03:30:33 INFO - 'HOME': '/home/cltbld', 03:30:33 INFO - 'LANG': 'en_US.UTF-8', 03:30:33 INFO - 'LANGUAGE': 'en_US:en', 03:30:33 INFO - 'LOGNAME': 'cltbld', 03:30:33 INFO - 'MAIL': '/var/mail/cltbld', 03:30:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:33 INFO - 'MOZ_NO_REMOTE': '1', 03:30:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:33 INFO - 'NO_EM_RESTART': '1', 03:30:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:33 INFO - 'PWD': '/builds/slave/test', 03:30:33 INFO - 'SHELL': '/bin/bash', 03:30:33 INFO - 'SHLVL': '1', 03:30:33 INFO - 'TERM': 'linux', 03:30:33 INFO - 'TMOUT': '86400', 03:30:33 INFO - 'USER': 'cltbld', 03:30:33 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:30:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:33 INFO - '_': '/tools/buildbot/bin/python'} 03:30:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:33 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:30:33 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 03:30:33 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 03:30:33 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 03:30:33 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 03:30:33 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 03:30:33 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 03:30:35 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:30:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:30:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:30:35 INFO - Installing collected packages: mozsystemmonitor 03:30:35 INFO - Running setup.py install for mozsystemmonitor 03:30:35 INFO - Successfully installed mozsystemmonitor 03:30:35 INFO - Cleaning up... 03:30:35 INFO - Return code: 0 03:30:35 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:30:35 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')]} 03:30:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:35 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')]} 03:30:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:35 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 0x7f3e45a2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', '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 03:30:35 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 03:30:35 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 03:30:35 INFO - Using env: {'DISPLAY': ':0', 03:30:35 INFO - 'HOME': '/home/cltbld', 03:30:35 INFO - 'LANG': 'en_US.UTF-8', 03:30:35 INFO - 'LANGUAGE': 'en_US:en', 03:30:35 INFO - 'LOGNAME': 'cltbld', 03:30:35 INFO - 'MAIL': '/var/mail/cltbld', 03:30:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:35 INFO - 'MOZ_NO_REMOTE': '1', 03:30:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:35 INFO - 'NO_EM_RESTART': '1', 03:30:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:35 INFO - 'PWD': '/builds/slave/test', 03:30:35 INFO - 'SHELL': '/bin/bash', 03:30:35 INFO - 'SHLVL': '1', 03:30:35 INFO - 'TERM': 'linux', 03:30:35 INFO - 'TMOUT': '86400', 03:30:35 INFO - 'USER': 'cltbld', 03:30:35 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:30:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:35 INFO - '_': '/tools/buildbot/bin/python'} 03:30:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:35 INFO - Downloading/unpacking jsonschema==2.5.1 03:30:35 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 03:30:35 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 03:30:35 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 03:30:35 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 03:30:35 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 03:30:35 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 03:30:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:30:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:30:37 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 03:30:37 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 03:30:37 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 03:30:37 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 03:30:37 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 03:30:37 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 03:30:37 INFO - Downloading functools32-3.2.3-2.tar.gz 03:30:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:30:38 INFO - warning: no files found matching '*.txt' 03:30:38 INFO - no previously-included directories found matching 'build' 03:30:38 INFO - no previously-included directories found matching 'dist' 03:30:38 INFO - no previously-included directories found matching '.git*' 03:30:38 INFO - Installing collected packages: jsonschema, functools32 03:30:38 INFO - Running setup.py install for functools32 03:30:38 INFO - warning: no files found matching '*.txt' 03:30:38 INFO - no previously-included directories found matching 'build' 03:30:38 INFO - no previously-included directories found matching 'dist' 03:30:38 INFO - no previously-included directories found matching '.git*' 03:30:38 INFO - Successfully installed jsonschema functools32 03:30:38 INFO - Cleaning up... 03:30:38 INFO - Return code: 0 03:30:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:30:38 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')]} 03:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:38 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')]} 03:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:38 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 0x7f3e45a2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', '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 03:30:38 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 03:30:38 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 03:30:38 INFO - Using env: {'DISPLAY': ':0', 03:30:38 INFO - 'HOME': '/home/cltbld', 03:30:38 INFO - 'LANG': 'en_US.UTF-8', 03:30:38 INFO - 'LANGUAGE': 'en_US:en', 03:30:38 INFO - 'LOGNAME': 'cltbld', 03:30:38 INFO - 'MAIL': '/var/mail/cltbld', 03:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:38 INFO - 'MOZ_NO_REMOTE': '1', 03:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:38 INFO - 'NO_EM_RESTART': '1', 03:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:38 INFO - 'PWD': '/builds/slave/test', 03:30:38 INFO - 'SHELL': '/bin/bash', 03:30:38 INFO - 'SHLVL': '1', 03:30:38 INFO - 'TERM': 'linux', 03:30:38 INFO - 'TMOUT': '86400', 03:30:38 INFO - 'USER': 'cltbld', 03:30:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:38 INFO - '_': '/tools/buildbot/bin/python'} 03:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:30:38 INFO - Cleaning up... 03:30:38 INFO - Return code: 0 03:30:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:30:38 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')]} 03:30:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:38 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')]} 03:30:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:38 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 0x7f3e45a2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', '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 03:30:38 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 03:30:38 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 03:30:38 INFO - Using env: {'DISPLAY': ':0', 03:30:38 INFO - 'HOME': '/home/cltbld', 03:30:38 INFO - 'LANG': 'en_US.UTF-8', 03:30:38 INFO - 'LANGUAGE': 'en_US:en', 03:30:38 INFO - 'LOGNAME': 'cltbld', 03:30:38 INFO - 'MAIL': '/var/mail/cltbld', 03:30:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:38 INFO - 'MOZ_NO_REMOTE': '1', 03:30:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:38 INFO - 'NO_EM_RESTART': '1', 03:30:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:38 INFO - 'PWD': '/builds/slave/test', 03:30:38 INFO - 'SHELL': '/bin/bash', 03:30:38 INFO - 'SHLVL': '1', 03:30:38 INFO - 'TERM': 'linux', 03:30:38 INFO - 'TMOUT': '86400', 03:30:38 INFO - 'USER': 'cltbld', 03:30:38 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:30:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:38 INFO - '_': '/tools/buildbot/bin/python'} 03:30:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:38 INFO - Downloading/unpacking blobuploader==1.2.4 03:30:38 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 03:30:38 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 03:30:38 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 03:30:38 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 03:30:38 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 03:30:38 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 03:30:40 INFO - Downloading blobuploader-1.2.4.tar.gz 03:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:30:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:30:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:30:41 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 03:30:41 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 03:30:41 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 03:30:41 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 03:30:41 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 03:30:41 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 03:30:41 INFO - Downloading docopt-0.6.1.tar.gz 03:30:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:30:41 INFO - Installing collected packages: blobuploader, requests, docopt 03:30:41 INFO - Running setup.py install for blobuploader 03:30:41 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:30:41 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:30:41 INFO - Running setup.py install for requests 03:30:41 INFO - Running setup.py install for docopt 03:30:41 INFO - Successfully installed blobuploader requests docopt 03:30:41 INFO - Cleaning up... 03:30:41 INFO - Return code: 0 03:30:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:41 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')]} 03:30:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:42 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')]} 03:30:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:42 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 0x7f3e45a2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', '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 03:30:42 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 03:30:42 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 03:30:42 INFO - Using env: {'DISPLAY': ':0', 03:30:42 INFO - 'HOME': '/home/cltbld', 03:30:42 INFO - 'LANG': 'en_US.UTF-8', 03:30:42 INFO - 'LANGUAGE': 'en_US:en', 03:30:42 INFO - 'LOGNAME': 'cltbld', 03:30:42 INFO - 'MAIL': '/var/mail/cltbld', 03:30:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:42 INFO - 'MOZ_NO_REMOTE': '1', 03:30:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:42 INFO - 'NO_EM_RESTART': '1', 03:30:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:42 INFO - 'PWD': '/builds/slave/test', 03:30:42 INFO - 'SHELL': '/bin/bash', 03:30:42 INFO - 'SHLVL': '1', 03:30:42 INFO - 'TERM': 'linux', 03:30:42 INFO - 'TMOUT': '86400', 03:30:42 INFO - 'USER': 'cltbld', 03:30:42 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:30:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:42 INFO - '_': '/tools/buildbot/bin/python'} 03:30:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:42 INFO - Running setup.py (path:/tmp/pip-PdcFxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:42 INFO - Running setup.py (path:/tmp/pip-gMQG5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:42 INFO - Running setup.py (path:/tmp/pip-Ru1yKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:42 INFO - Running setup.py (path:/tmp/pip-Duzpiv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:42 INFO - Running setup.py (path:/tmp/pip-T07sSX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:42 INFO - Running setup.py (path:/tmp/pip-u31NYI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:42 INFO - Running setup.py (path:/tmp/pip-6hgBo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:42 INFO - Running setup.py (path:/tmp/pip-okHmHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:42 INFO - Running setup.py (path:/tmp/pip-DceeLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:42 INFO - Running setup.py (path:/tmp/pip-2D9rVk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:42 INFO - Running setup.py (path:/tmp/pip-jf00M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:43 INFO - Running setup.py (path:/tmp/pip-zJx0cB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:43 INFO - Running setup.py (path:/tmp/pip-bswWYl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:43 INFO - Running setup.py (path:/tmp/pip-bcmOUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:43 INFO - Running setup.py (path:/tmp/pip-_B6CSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:43 INFO - Running setup.py (path:/tmp/pip-cPVSpE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:43 INFO - Running setup.py (path:/tmp/pip-HG8b_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:30:43 INFO - Running setup.py install for manifestparser 03:30:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Running setup.py install for mozcrash 03:30:43 INFO - Running setup.py install for mozdebug 03:30:43 INFO - Running setup.py install for mozdevice 03:30:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:30:43 INFO - Running setup.py install for mozfile 03:30:43 INFO - Running setup.py install for mozhttpd 03:30:44 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Running setup.py install for mozinfo 03:30:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Running setup.py install for mozInstall 03:30:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Running setup.py install for mozleak 03:30:44 INFO - Running setup.py install for mozlog 03:30:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Running setup.py install for moznetwork 03:30:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Running setup.py install for mozprocess 03:30:44 INFO - Running setup.py install for mozprofile 03:30:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Running setup.py install for mozrunner 03:30:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:30:44 INFO - Running setup.py install for mozscreenshot 03:30:45 INFO - Running setup.py install for moztest 03:30:45 INFO - Running setup.py install for mozversion 03:30:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:30:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:30:45 INFO - Cleaning up... 03:30:45 INFO - Return code: 0 03:30:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30:45 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')]} 03:30:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:45 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')]} 03:30:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:45 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 0x7f3e45a2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', '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 03:30:45 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 03:30:45 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 03:30:45 INFO - Using env: {'DISPLAY': ':0', 03:30:45 INFO - 'HOME': '/home/cltbld', 03:30:45 INFO - 'LANG': 'en_US.UTF-8', 03:30:45 INFO - 'LANGUAGE': 'en_US:en', 03:30:45 INFO - 'LOGNAME': 'cltbld', 03:30:45 INFO - 'MAIL': '/var/mail/cltbld', 03:30:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:45 INFO - 'MOZ_NO_REMOTE': '1', 03:30:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:45 INFO - 'NO_EM_RESTART': '1', 03:30:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:45 INFO - 'PWD': '/builds/slave/test', 03:30:45 INFO - 'SHELL': '/bin/bash', 03:30:45 INFO - 'SHLVL': '1', 03:30:45 INFO - 'TERM': 'linux', 03:30:45 INFO - 'TMOUT': '86400', 03:30:45 INFO - 'USER': 'cltbld', 03:30:45 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:30:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:45 INFO - '_': '/tools/buildbot/bin/python'} 03:30:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:30:45 INFO - Running setup.py (path:/tmp/pip-NS04Vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:30:45 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)) 03:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:30:45 INFO - Running setup.py (path:/tmp/pip-dOXVFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:30:45 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)) 03:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:30:45 INFO - Running setup.py (path:/tmp/pip-acZGgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:30:45 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)) 03:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:30:45 INFO - Running setup.py (path:/tmp/pip-dFEviR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:30:45 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)) 03:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:30:45 INFO - Running setup.py (path:/tmp/pip-TBuWyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:30:45 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)) 03:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:30:45 INFO - Running setup.py (path:/tmp/pip-NqHQtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:30:45 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)) 03:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:30:45 INFO - Running setup.py (path:/tmp/pip-8zNVt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:30:45 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)) 03:30:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:30:45 INFO - Running setup.py (path:/tmp/pip-OeoDeP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:30:46 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)) 03:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:30:46 INFO - Running setup.py (path:/tmp/pip-IW3MYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:30:46 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)) 03:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:30:46 INFO - Running setup.py (path:/tmp/pip-Vxoiv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:30:46 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)) 03:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:30:46 INFO - Running setup.py (path:/tmp/pip-WlXlaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:30:46 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)) 03:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:30:46 INFO - Running setup.py (path:/tmp/pip-0IJVu5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:30:46 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)) 03:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:30:46 INFO - Running setup.py (path:/tmp/pip-pPRas3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:30:46 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)) 03:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:30:46 INFO - Running setup.py (path:/tmp/pip-r8bEPJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:30:46 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)) 03:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:46 INFO - Running setup.py (path:/tmp/pip-5McGRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:30:46 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)) 03:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:30:46 INFO - Running setup.py (path:/tmp/pip-IFPsNX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:30:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:30:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:30:46 INFO - Running setup.py (path:/tmp/pip-ndVYWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:30:46 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)) 03:30:46 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)) 03:30:46 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)) 03:30:46 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)) 03:30:46 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)) 03:30:46 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)) 03:30:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:30:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:30:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:30:48 INFO - Downloading blessings-1.6.tar.gz 03:30:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:30:48 INFO - Installing collected packages: blessings 03:30:48 INFO - Running setup.py install for blessings 03:30:48 INFO - Successfully installed blessings 03:30:48 INFO - Cleaning up... 03:30:48 INFO - Return code: 0 03:30:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:30:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:49 INFO - Reading from file tmpfile_stdout 03:30:49 INFO - Current package versions: 03:30:49 INFO - argparse == 1.2.1 03:30:49 INFO - blessings == 1.6 03:30:49 INFO - blobuploader == 1.2.4 03:30:49 INFO - docopt == 0.6.1 03:30:49 INFO - functools32 == 3.2.3-2 03:30:49 INFO - jsonschema == 2.5.1 03:30:49 INFO - manifestparser == 1.1 03:30:49 INFO - mozInstall == 1.12 03:30:49 INFO - mozcrash == 1.0 03:30:49 INFO - mozdebug == 0.1 03:30:49 INFO - mozdevice == 0.48 03:30:49 INFO - mozfile == 1.2 03:30:49 INFO - mozhttpd == 0.7 03:30:49 INFO - mozinfo == 0.9 03:30:49 INFO - mozleak == 0.1 03:30:49 INFO - mozlog == 3.4 03:30:49 INFO - moznetwork == 0.27 03:30:49 INFO - mozprocess == 0.23 03:30:49 INFO - mozprofile == 0.28 03:30:49 INFO - mozrunner == 6.13 03:30:49 INFO - mozscreenshot == 0.1 03:30:49 INFO - mozsystemmonitor == 0.3 03:30:49 INFO - moztest == 0.7 03:30:49 INFO - mozversion == 1.4 03:30:49 INFO - psutil == 3.1.1 03:30:49 INFO - requests == 1.2.3 03:30:49 INFO - wsgiref == 0.1.2 03:30:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:49 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 0x7f3e45a2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', '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 03:30:49 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 03:30:49 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 03:30:49 INFO - Using env: {'DISPLAY': ':0', 03:30:49 INFO - 'HOME': '/home/cltbld', 03:30:49 INFO - 'LANG': 'en_US.UTF-8', 03:30:49 INFO - 'LANGUAGE': 'en_US:en', 03:30:49 INFO - 'LOGNAME': 'cltbld', 03:30:49 INFO - 'MAIL': '/var/mail/cltbld', 03:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:49 INFO - 'MOZ_NO_REMOTE': '1', 03:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:49 INFO - 'NO_EM_RESTART': '1', 03:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:49 INFO - 'PWD': '/builds/slave/test', 03:30:49 INFO - 'SHELL': '/bin/bash', 03:30:49 INFO - 'SHLVL': '1', 03:30:49 INFO - 'TERM': 'linux', 03:30:49 INFO - 'TMOUT': '86400', 03:30:49 INFO - 'USER': 'cltbld', 03:30:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:49 INFO - '_': '/tools/buildbot/bin/python'} 03:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:49 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)) 03:30:49 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)) 03:30:49 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)) 03:30:49 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)) 03:30:49 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)) 03:30:49 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)) 03:30:49 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)) 03:30:49 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)) 03:30:49 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)) 03:30:49 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)) 03:30:49 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)) 03:30:49 INFO - Cleaning up... 03:30:49 INFO - Return code: 0 03:30:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:30: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')]} 03:30:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:30:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30: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')]} 03:30:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:30:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:30:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3e45a2cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22db8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23a8ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, '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': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', '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 03:30:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:30:49 INFO - Using env: {'DISPLAY': ':0', 03:30:49 INFO - 'HOME': '/home/cltbld', 03:30:49 INFO - 'LANG': 'en_US.UTF-8', 03:30:49 INFO - 'LANGUAGE': 'en_US:en', 03:30:49 INFO - 'LOGNAME': 'cltbld', 03:30:49 INFO - 'MAIL': '/var/mail/cltbld', 03:30:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:30:49 INFO - 'MOZ_NO_REMOTE': '1', 03:30:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:30:49 INFO - 'NO_EM_RESTART': '1', 03:30:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:30:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:30:49 INFO - 'PWD': '/builds/slave/test', 03:30:49 INFO - 'SHELL': '/bin/bash', 03:30:49 INFO - 'SHLVL': '1', 03:30:49 INFO - 'TERM': 'linux', 03:30:49 INFO - 'TMOUT': '86400', 03:30:49 INFO - 'USER': 'cltbld', 03:30:49 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:30:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:30:49 INFO - '_': '/tools/buildbot/bin/python'} 03:30:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:30:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:30:49 INFO - Cleaning up... 03:30:49 INFO - Return code: 0 03:30:49 INFO - Running post-action listener: _resource_record_post_action 03:30:49 INFO - Running post-action listener: _start_resource_monitoring 03:30:49 INFO - Starting resource monitoring. 03:30:49 INFO - [mozharness: 2016-11-16 11:30:49.602636Z] Finished create-virtualenv step (success) 03:30:49 INFO - [mozharness: 2016-11-16 11:30:49.603145Z] Running install step. 03:30:49 INFO - Running pre-action listener: _resource_record_pre_action 03:30:49 INFO - Running main action method: install 03:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:30:49 INFO - Reading from file tmpfile_stdout 03:30:49 INFO - Detecting whether we're running mozinstall >=1.0... 03:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:30:49 INFO - Reading from file tmpfile_stdout 03:30:49 INFO - Output received: 03:30:49 INFO - Usage: mozinstall [options] installer 03:30:49 INFO - Options: 03:30:49 INFO - -h, --help show this help message and exit 03:30:49 INFO - -d DEST, --destination=DEST 03:30:49 INFO - Directory to install application into. [default: 03:30:49 INFO - "/builds/slave/test"] 03:30:49 INFO - --app=APP Application being installed. [default: firefox] 03:30:49 INFO - mkdir: /builds/slave/test/build/application 03:30:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:30:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:31:05 INFO - Reading from file tmpfile_stdout 03:31:05 INFO - Output received: 03:31:05 INFO - /builds/slave/test/build/application/firefox/firefox 03:31:05 INFO - Running post-action listener: _resource_record_post_action 03:31:05 INFO - [mozharness: 2016-11-16 11:31:05.843824Z] Finished install step (success) 03:31:05 INFO - [mozharness: 2016-11-16 11:31:05.844069Z] Running run-tests step. 03:31:05 INFO - Running pre-action listener: _resource_record_pre_action 03:31:05 INFO - Running main action method: run_tests 03:31:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:31:05 INFO - Python 2.7.3 03:31:05 INFO - Return code: 0 03:31:05 INFO - grabbing minidump binary from tooltool 03:31:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:31:05 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 0x23a5f60>, '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 0x23a6d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23a71d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:31:05 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 03:31:05 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 03:31:05 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 03:31:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:31:05 INFO - Return code: 0 03:31:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:31:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:31:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:31:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:31:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:31:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 03:31:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-033 --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 03:31:05 INFO - Using env: {'DISPLAY': ':0', 03:31:05 INFO - 'HOME': '/home/cltbld', 03:31:05 INFO - 'LANG': 'en_US.UTF-8', 03:31:05 INFO - 'LANGUAGE': 'en_US:en', 03:31:05 INFO - 'LOGNAME': 'cltbld', 03:31:05 INFO - 'MAIL': '/var/mail/cltbld', 03:31:05 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:31:05 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:31:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:31:05 INFO - 'MOZ_NO_REMOTE': '1', 03:31:05 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:31:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:31:05 INFO - 'NO_EM_RESTART': '1', 03:31:05 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:31:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:31:05 INFO - 'PWD': '/builds/slave/test', 03:31:05 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:31:05 INFO - 'SHELL': '/bin/bash', 03:31:05 INFO - 'SHLVL': '1', 03:31:05 INFO - 'TERM': 'linux', 03:31:05 INFO - 'TMOUT': '86400', 03:31:05 INFO - 'USER': 'cltbld', 03:31:05 INFO - 'XDG_SESSION_COOKIE': 'edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984', 03:31:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:31:05 INFO - '_': '/tools/buildbot/bin/python'} 03:31:05 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-033', '--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 03:31:06 INFO - mozversion application_buildid: 20161116004016 03:31:06 INFO - mozversion application_changeset: f99c3a999e81a017ca3f6026b1e75fe4ec31a50a 03:31:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:31:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:31:06 INFO - mozversion application_name: Firefox 03:31:06 INFO - mozversion application_remotingname: firefox-dev 03:31:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:06 INFO - mozversion application_vendor: Mozilla 03:31:06 INFO - mozversion application_version: 52.0a2 03:31:06 INFO - mozversion platform_buildid: 20161116004016 03:31:06 INFO - mozversion platform_changeset: f99c3a999e81a017ca3f6026b1e75fe4ec31a50a 03:31:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:31:06 INFO - mozversion platform_version: 52.0a2 03:31:06 INFO - using testdate: 1479295866 03:31:06 INFO - actual date: 1479295866 03:31:06 INFO - starting webserver on 'localhost:46152' 03:31:06 INFO - SUITE-START | Running 2 tests 03:31:06 INFO - TEST-START | dromaeo_css 03:31:06 INFO - operating with platform_type : linux_ 03:31:06 INFO - Initialising browser for dromaeo_css test... 03:31:06 INFO - TEST-INFO | started process 9552 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkZIAju/profile http://localhost:46152/getInfo.html) 03:31:09 ERROR - PROCESS | 9552 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 03:31:10 INFO - PROCESS | 9552 | __metrics Screen width/height:1600/1200 03:31:10 INFO - PROCESS | 9552 | colorDepth:24 03:31:10 INFO - PROCESS | 9552 | Browser inner width/height: 1024/697 03:31:10 INFO - PROCESS | 9552 | __metrics 03:31:11 INFO - PROCESS | 9552 | 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" 03:31:11 INFO - PROCESS | 9552 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:31:12 INFO - PROCESS | 9552 | console.error: PushService: 03:31:12 INFO - PROCESS | 9552 | stateChangeProcessEnqueue: Error transitioning state 03:31:12 INFO - PROCESS | 9552 | UnknownError 03:31:12 INFO - TEST-INFO | 9552: exit 0 03:31:12 INFO - Browser initialized. 03:31:12 INFO - Running cycle 1/1 for dromaeo_css test... 03:31:12 INFO - TEST-INFO | started process 9646 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkZIAju/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:31:24 INFO - PROCESS | 9646 | RSS: Main: 145149952 03:31:24 INFO - PROCESS | 9646 | 03:32:16 INFO - PROCESS | 9646 | 1479295936258 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:34:26 INFO - PROCESS | 9646 | Cycle 1(1): loaded http://localhost:46152/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46152/tests/dromaeo/cssquery-ext.html) 03:34:27 INFO - PROCESS | 9646 | RSS: Main: 245645312 03:34:27 INFO - PROCESS | 9646 | 03:37:30 INFO - PROCESS | 9646 | Cycle 1(1): loaded http://localhost:46152/tests/dromaeo/cssquery-ext.html (next: http://localhost:46152/tests/dromaeo/cssquery-jquery.html) 03:37:30 INFO - PROCESS | 9646 | RSS: Main: 232275968 03:37:30 INFO - PROCESS | 9646 | 03:40:32 INFO - PROCESS | 9646 | Cycle 1(1): loaded http://localhost:46152/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46152/tests/dromaeo/cssquery-mootools.html) 03:40:33 INFO - PROCESS | 9646 | RSS: Main: 178065408 03:40:33 INFO - PROCESS | 9646 | 03:43:35 INFO - PROCESS | 9646 | Cycle 1(1): loaded http://localhost:46152/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46152/tests/dromaeo/cssquery-prototype.html) 03:43:35 INFO - PROCESS | 9646 | RSS: Main: 225091584 03:43:35 INFO - PROCESS | 9646 | 03:46:38 INFO - PROCESS | 9646 | Cycle 1(1): loaded http://localhost:46152/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46152/tests/dromaeo/cssquery-yui.html) 03:46:39 INFO - PROCESS | 9646 | RSS: Main: 172552192 03:46:39 INFO - PROCESS | 9646 | 03:49:41 INFO - PROCESS | 9646 | Cycle 1(1): loaded http://localhost:46152/tests/dromaeo/cssquery-yui.html (next: http://localhost:46152/tests/dromaeo/cssquery-dojo.html) 03:49:41 INFO - PROCESS | 9646 | RSS: Main: 261632000 03:49:41 INFO - PROCESS | 9646 | 03:49:41 INFO - PROCESS | 9646 | __start_tp_report 03:49:41 INFO - PROCESS | 9646 | _x_x_mozilla_page_load 03:49:41 INFO - PROCESS | 9646 | _x_x_mozilla_page_load_details 03:49:41 INFO - PROCESS | 9646 | |i|pagename|runs| 03:49:41 INFO - PROCESS | 9646 | |0;dojo.html;3176.3012137329783;3193.169775858277;3210.1332640187134;3228.435023870822;3246.513023046543;5388.353397592289;5452.4274951130155;5453.672779633225;5459.262999495072;5463.043967305721;5439.499394670112;5474.644148130369;5480.616356855012;5493.450654934514;5497.038018346793;4946.381702287223;4959.132151873408;5002.499750025005;5009.2486127080865;5015.7492125393765;4881.438634557036;4893.877653058684;4997.400311962551;5045.0666626674;5046.268291097788;4850.102730994778;4867.951320486785;4874.244492103712;4901.754912254391;4903.950960490403;4934.963657631902;4949.703017818906;5004.724740139291;5012.8496145115705;5039.840836607564;4801.711897286139;4949.208126699711;4976.502349765031;4981.750912454363;4985.52637499437;5225.973870130663;5306.814261500829;5308.256844041837;5410.323709536308;5436.293281873371;5699.2590963174525;5716.514096301819;5775.364709881952;5782.219400380979;5811.041178205591;5700.9429905701245;5831.650100993911;5850.64896106235;5864.7067646617925;5877.5591830612875;5363.758630861621;5401.810936617199;5402.054640437947;5417.8103766367985;5474.479924407175;5911.024680927599;5930.881382372415;5935.643861368331;5936.614120082181;5937.228160339128;5552.416996215339;5718.285214348207;5725;5743.9425605744245;5744.597878148573;5684.118961560965;5780.335261444988;5811.215485909348;5815.88368232633;5910.172575839386;5784.59507834456;5826.388229235869;5826.533877289807;5827;5833.4749872511675;5741.110127930177;5784.50831679312;5793.073108302651;5793.159991801165;5817.418258174149;4444.511103778582;4459.108178364275;4477.6417886569;4478.619317357996;4488.304312831517;4006.238814625212;4031.294523458383;4039.030632648202;4040.4343391925154;4064.3903414488063;5525.336959564878;5527.474889885454;5534.418886016991;5539.086050801573;5560.36055853582;5717.342505611825;5775.133729940542;5790.71046447676;5796.420357964254;5818.5636077294375;5566.109422492382;5591.944080559224;5598.748056337475;5603.215549823028;5622.044252477089;5062.898742025139;5074.644774865724;5077.898442031139;5079.08576456234;5109.8722531937;5705.572082093942;5734.942650573525;5824.155497452761;5956.255468066492;5958.165856780054;5764.855878603068;5833.912491312549;5836.212111364912;5864.472197502245;5876.294844618673;5910.202122713378;5914.935311643945;5915.970420147872;5919.348871624204;5926.703664816828;5593.804216852391;5638.097904335286;5716.54267658578;5723.912456633227;5729;5718.771249149988;5732.856678583069;5741;5848.619839710405;5881.9705901470215;5631.831045068655;5644.689542075225;5655.802046928337;5655.830325090254;5657.943420565742;5536.557075433875;5569.972150139385;5632.85917852057;5640.266765320482;5640.548756099584;5562.16567514876;5659.207710920392;5682.232898558807;5705.429457054427;5785.739641716049;5781.653100813965;5790.739416726173;5801.535877129735;5806.709664516673;5808.6805225711305;5396.541293990055;5432.29380180574;5441.591880608891;5619.578531610064;5670.376258611632 03:49:41 INFO - PROCESS | 9646 | |1;ext.html;582.5339728217425;607.3622696169023;633.7718421368309;642.6658137768358;666.2904007232294;34112.4883126753;37321;37364.25271494569;45136.548634513645;45994.770026149905;47181.29228061582;47760.76119619406;47778.52221477784;47796.761016194956;47826;8939.642414303436;9049.411788233776;9075.183233508982;9088.909110908873;9096.681616143436;8457;8637.784055398603;8961.865572016424;9084.091590840897;10590.788184236311;10704.090152337021;11123.221374503788;11127.72180695481;11129.109671226322;11130.721731956726;10830.837537436944;10870.402127882964;10883.292585981964;10883.83674244887;10897.400642964634;10697.679069627924;10783.46082695862;10787.5684972601;10795.29830561011;10798.190135739773;43479.34780978288;43702.344464833055;43707.562924370664;43787.562124378666;43897.78051109756;3753.6246375362516;3870.9225815483533;3923.9215215695813;3928.7249892507534;3987.1228329767405;31348;32649.51025734616;32685.836570816995;32697.182570435692;33056;4024.1146947671464;4058.472398588194;4069.369247766601;4100.302948498763;4159.085001299709;349148;354494;355397;356144;356773;68423.65788171027;69272.30727692759;69383.83696978197;69402;69468.3053169472;40758.388624170664;41494.58505414907;41585;50316;50364.74817625889;16925.66148677044;17220.225089870986;17269.13654317279;17310.826891731173;17337.479875603753;12885.677858053623;12995.350232488337;13013.089083764235;13015.284159371136;13024.609261722164;19543.902280488506;19551.37799596864;21247.0438830253;21811.781882180974;22709.545809084055;7942.722004729922;7993.68025278994;8035.678572857137;8111.282720288769;8353.289970352467;1003.5885287032281;1033.9896601033893;1040.7958328592706;1079.1852151625471;1111.5053801058452;33979.830100849336;33985.660143398745;33992.150196244795;33999.32001359959;34126.65873341235;1078.6063086973197;1114.5207560748793;1125.5047778977387;1146.094585277638;1179.262960649594;16699.248533816008;17582.428508928908;17721.379751708628;17889.19498622565;17932.641347173245;556686;610206;620501;621378;905932;61186.388136118956;61865;61875;62085.689571551855;62102.37897620966;1319.2018828608554;1371.9382627781774;1391.0818859552646;1441.315375196794;1464.9707005859823;32719;34426.82786586051;34639.653603463645;34701.47947780836;34871.30257394889;53101;53553;53683.46316536941;53837.461625384814;53872.73063634657;424534;428599;428854;428973;430542;31597.526037109;32566.511502327958;32899.34201316008;33061.504077438374;33646.495302569994;50218.49781502284;50793.746031269606;51178.23232651588;51324.48675513197;51399.22901156561;41801.581984180986;42407;42623;43143;44464.55535444604;43351.566484334755;44119.55880441154;44498.3325250115;45025.32462013138;45458.54541454543;43507.34738978855;44481;44494.110117796816;44502;44688.32967505555;35978.64021359753;39253.60746392499;39557.604423956545;40993.385099224135;41528.37707434451;29156.562651560667;29278.56082158812;29317.706822931497;29420.264493387836;29722.256943576584 03:49:41 INFO - PROCESS | 9646 | |2;jquery.html;403.59438764042136;416.31516155923487;416.63128131603526;430.264248135688;441.20142541998985;15001.849981500181;18808.34170804022;19811.108500117494;20641.483962900897;20778.376648700527;18435.81564184358;19282.132304046318;20124.597508049832;20428.182872685076;20562.38312850613;5704.54363650909;5947.494462970652;5948.7323070461935;5953.940460595403;5961.88076238475;5572.108462645978;5847.0352391855295;5881.176635271044;5882.3529411764675;5882.764689412418;5809;5863.824085277427;5864.941350586482;5867.178594996704;5873.295204575457;5630.774769009235;5793.536517078624;5814.534837213013;5818.854528636775;5822.243108395903;5020.246962955549;5172.431032586413;5264.263003179558;5264.473552644743;5272.736363181864;23395.883020584788;23711.88144059286;23827.046918123255;23914.402139946465;24094.915728792246;2458.323960910746;2521.8108641851936;2538.4415428605676;2557.258395065429;2669.973300266992;14567.92716036413;14934.32795524204;14981.625459363495;15007.924960375129;15157.848421515864;1745.293156271712;1748.77265955425;1782.857371410297;1802.9008404537744;1839.1356062650532;82959.5852020742;82960.58519707424;83513;84438.15561844365;85860.14139858584;9862.802743945082;10073.69778906634;10274.383536987656;10345.586176553004;10432.68701938943;13190.406431710404;13771.724565508834;13793.034487585974;13840.169589824643;14903.925480372529;8057.798555036171;8100.270975612223;8155.877661835078;8221.753347399588;8232.917670823335;7914.722984695508;7935.008123984502;8093.109757926623;8154.2253485918745;8182.1817818217705;6594.109795177686;6624;6692.899606505906;6731.259561448237;6739.393454589111;1873.756411666502;1879.285871368871;1894.8673592848645;1960.4412742368356;1964.3517639179322;968.3657204531044;1034.3018462537757;1038.7351225437465;1069.4332004037872;1080.378782200238;20082.196712131645;20784.27255046066;20950.895245523676;21048.263310784354;21252.78747212508;998.5456617239139;1025;1037.2687255484866;1057.0539367266254;1066.3761699405934;11129.888701113046;11711.472983715754;11810.645680629423;11837;11903.702407439883;489435;498176;500401;502048;516056;85233.57383213169;86464;87889;88336;88509;997.760028735479;998.4708104704519;1021.6322124035341;1029.5572903651353;1034.281174583657;17394.565135871704;17849.340885118778;18005.369812056517;18405.263789448807;18451.81548184501;41163;41670.1665966685;42122.157556849306;42682.35976460294;43321.566784333016;54929.72535137299;55155.44844551503;55765.72117139388;55980;56307.71846140907;6422.518311126778;8215.342772578299;8729.301655867643;8856.158664926821;8884.200421962054;12596.181248218836;13026.934865325613;13355;14071.437142514185;14094.224817634718;10945.179111566506;11108.444577770917;11538;11572.18994670365;11958.940205298917;10995.395253260827;11753.217139571272;11760.117991150526;11970.58102966392;12051.397430128634;5929.85175370602;6652.966735166293;11334.433278335886;11514.712132196762;11680.612622339766;8718.564071796513;8796.428232164888;8873.290136788912;8906.421082629868;9136.223421009023;11509.366984815915;11544.076473881902;11682.123840712151;11952.34262115592;11959.701007474883 03:49:41 INFO - PROCESS | 9646 | |3;mootools.html;1385.902986790925;1507.4422463688434;1508.064999700186;1655.6771429571238;1801.5135913303416;7527.322540971311;8146.674133034679;8472.322214222862;8474.788130296745;8671.956640216806;8491.745247642566;8578.914210857889;8581.91418085819;8588.227059564639;8647.43791653542;2423.963640545389;2444.352246654638;2449.6570480132705;2454.9140780072703;2457.9016839326405;2381.7975472084895;2410.035985605763;2432.2703189043305;2450.1424501424535;2457.8279520433575;2421.9152329668464;2438.426969662128;2452.448199155194;2463.790577800889;2471.6292556116637;2294.1740973249616;2373.050779688121;2377.3105799318178;2382.5830479665988;2427.453822889853;2386.4511162432564;2399.808015358767;2404.350825277183;2405.87970601471;2409.9518009639883;8145.8370832583605;8266.173382661746;8271.421000529965;8299.709510167175;8383.077861435237;5087.389513258433;5261.631685781997;5326.760295786699;5326.866828329284;5330.9733451332495;3263.102646772133;3281.2453135778665;3282.3271229397915;3329.983350083234;3382.3235352929514;983.9163671087966;1008.7780688248573;1011.6004178349584;1026.1790567546009;1039.5685790396976;11233.382163980978;11397.373144477051;11452.484638191301;11463.254888432226;11466.197366184371;4517.215699798561;4594.218982772936;4657.5095969289505;4668.136394766979;4676.134915040729;10052.547635356426;10078.59685612582;10083.394996300245;10098.192144628412;10098.646547370807;5313.893722125613;5331.546818520469;5332.866678333073;5334.5732341412595;5338.813141540028;4264.616184543406;4424.292113261863;4443.688941774045;4482.372467854503;4913.434954980152;4050.9594904051173;4134.763396882498;4224.9155016899485;4245.532991370947;4268.210381079511;1333.5066025570602;1365.7200273943818;1367.3778430813957;1376.6420730610114;1384.3147641917114;820.9368867316839;839.8824164616958;848.7962888906618;924.5007695844304;997.121198537689;5485.725713714378;5569.610127291132;5669.291338582677;5857.238558987305;5870.589058765845;825;893.3166127912152;950.254050570299;973.3186769261546;977.6089564174387;3561.269939662363;3615.4215325547784;3641.1625326175126;3721.5534135903863;3760.2855457463543;10254.53854576546;10687.41219232934;10727.356358618508;10743.301685390581;10795.244332896622;10649.094826939798;10670.413127278074;10680.092192163753;10681.786364272672;10687.519061642244;7610.086789585285;7975.322097621651;7991.68033278674;8127.065387480516;8143.552104634184;5613.382527922007;5745;5759;5774.2782152230975;5809.9419005809405;9263.53682315868;9534.952325238606;9613.182879455324;9634.566444509874;9801.362911410735;8813.647454101763;9104.863427048733;9535.141837234682;9900.75248118774;9949.801003980025;7772.378209743094;8143.226393492609;8150.388720845842;8152.2662960333855;8262.297704695167;8234.958825206075;8473.872891906749;8526.445781024213;8544.35917306217;8548.273396761097;7267;7344.632768361667;7420.740274090381;7473.738419155304;7502.924970750222;7145.1068616422945;7163.820904477429;7318.780436586911;7505.061867266591;7607.847843042998;6368.522360822864;6435.195600549931;6445.323241059621;6683.43190828785;6684.83287917806;4868.2210846264425;4938.259261110718;4939.086269040239;5001.324821149098;5021.07110184617;4804.468715494039;4912.557869791736;5009.398872135367;5068.974655126701;5087.618428617942 03:49:41 INFO - PROCESS | 9646 | |4;prototype.html;344.52971693638193;356.2643141911952;358.0940221240263;359.1309032142216;361.34596380551204;5297;5307.601929855262;5348.946510534894;5384.030874442598;5438.7824487020525;5255.684658920468;5257.185136303879;5261.39493958194;5262.81580144695;5272.551833094191;4003.579624139467;4215.409842622035;4219.620234178923;4224.450821393222;4239.660827133822;3756.699464042884;4140.420341152226;4193.077522944947;4196.9580304197025;4212.726172798773;4154.293770059097;4155.667546596265;4161.708680392374;4163.916721665565;4179.770112643803;4175.5824417558;4175.603317684815;4177.770222637754;4185.22573323936;4197.790110494463;3525.7179425645886;3619.3123306571665;3662.047867554428;3720.9069773255887;3776.71425859504;5095;5109;5114.948850511521;5115.20714289282;5125.846224613268;4759.381280433521;4768.57082862544;4774.474807771142;4775.570198682135;4781;5385.67685938841;5461;5492.697901615409;5500.092484740013;5508.173773933902;4119.505659320871;4128.380742888561;4129.97935010326;4134.813933373005;4154.273002224629;5511.862203444906;5594.328680558318;5690.943090569124;5772.5670574707065;5777.740001699892;4173.749575025508;4176.812043458051;4186.35111557709;4200.558941311179;4202.621764041251;4251.6386107180615;4277.657787377002;4290.89272768177;4298.892527686833;4304.49342730042;4713.31656909753;4751.596114330251;4812.903741925142;4834.468208497063;4852.951470485321;5517.372375149341;5533.474319939599;5549.639273447213;5557.527610153183;5598.720063996865;1386.8058471813954;1394.7559177144162;1395.2838009248478;1401.7757158854533;1405.6927057836106;960.2893858544627;1011.8735158105237;1013.8644717915981;1020.1991436722137;1042.3485321673954;5141.38303403594;5189.896202075937;5201.219817027476;5211.42674305826;5245.659032162897;5419.349678038582;5422.834090670524;5423;5479.945200548023;5486.204500347428;4961.404631444249;5107.821226257063;5196.298499702491;5209.817656382009;5214.60890433219;2880.4527139843362;2888.797784155089;2896.956545651817;2898.608667839449;2900.463414268367;5530.281063461724;5531.897878806028;5546.69493177871;5548.944510554924;5572.804951826748;5397.325334333208;5482.369527504388;5528.917066244009;5545.195946587723;5573.191887176336;5450.628976395202;5468.812475010028;5478.369987451414;5482.506574408322;5515.338159420815;5321.228421878728;5441.619086663895;5491.2312276282155;5518.19986102021;5561.3882472927135;5383.16560933056;5385.838424847261;5396.379416367168;5406.486383793534;5439.3200849893765;5457.672539647634;5627.465390787868;5636.718164091861;5675.375708671961;5692.231548741032;4227.894302642459;4255.29787585045;4287.37833014205;4298.9570104298555;4307.160103779858;5677.716114194356;5682.431756824284;5801.593888427769;5811.331696854747;5818.2436283282905;5502.642328248651;5504.80733174353;5521.095222148352;5532.612717109763;5563.13498548256;5471.50756431923;5502.9174562380795;5509.889802203853;5553.9725150847225;5584.190292407659;5234.738263086907;5488.341399032141;5502.8349149525575;5504.559635229252;5513.255710479034;5511.3937466879415;5530.391656917816;5536.889262214814;5552.555795536428;5556.888862222814;5414.972925135349;5448.972755136199;5455.936092461931;5462.481064298885;5466.835994920159 03:49:41 INFO - PROCESS | 9646 | |5;yui.html;791.2008871040249;806.9959650201748;840.9873851892223;863.9784005399861;905.6875377994594;13603.18380897147;13680.384382702778;13710.177389356646;13733.176009439416;14326.641833954156;13735.313234338293;13833.17000979942;13846.30768461578;13847;13866.514671986482;697.4629535257849;733.9412846972256;794.6106407860165;861.5692153923038;865.472062042157;846.2045677063571;846.2341580869293;848.1306660672798;848.2704873808519;850.6002178975903;745.6420917959383;913;913.1918252346687;914.2229105260509;916.9816603667956;762.367235194787;840.3907167303687;872.2150064941571;884.9955750221208;888.6223355074068;653.5425202358368;653.7646447278976;653.8398092467328;653.9182602174728;654.1986067067851;14860.256987150598;14907.403703851833;14924;14972.251387430693;14975.625609359744;13365.198088114745;13616.93191534036;13806.792898106536;14007.439702411993;14062.929685351508;12457.93771031148;12481.75036499265;12541.811872821914;12629.115961882671;12711.237325760392;4036.374361973899;4126.7523948563185;4143.606357396073;4224.788760561991;4229.450171477688;63938.68030659863;64086;65066.67466662684;65395;65437.67281163564;10767.138628909825;10837.67486975392;10843.566257349617;11043.944780276048;11150;21456.570868582854;21473.46316342104;21475.355739327846;21490.355289341343;21498.677519837216;8049.678012879536;8081.919180808117;8155.632996515171;8364.37267204962;8493.235608795238;4464.374987501752;4490.236659767847;4511.571400716926;4610.861674149781;4612.538746125428;3262.9021129366156;3345.832708364572;3350.2964377481003;3353.1784712745534;3360.630330663625;602.0758136260819;603.2459425717852;612.8039027511243;616.5375968023982;626.0171530696763;640.5420124610926;656.1601150527333;661.497262080822;698.9615571143535;725.7568714480708;9193.448393096436;9489.240860731263;9528.380655257386;9755.8783884978;9986.450745208938;615.5198944823045;667.6227931218846;679.7756740275697;732.5494820685241;760.8021914302321;4508.842190523316;4916.508349165055;4932.654714169974;5022.360847871563;5096.286519887219;77511;85552.14447855442;87393.56303218444;88274;90589;75271;75936;76232;77186.99999999888;77245;71723;72519.27480725336;72819;73296.26703733;75822.24177758262;8482.279006284289;8724.520151391735;8865.955670221865;8931.687390941286;8972.41679290844;46590.534094659975;47036.52963470321;47848.760756195996;48883.26675099805;49055.50944490652;62024;62177.37822621716;65195.67402162959;65226;66572.66713666401;11205.327680339205;11507.884921150682;11654.941725291319;11718.88281117212;11903.583374581847;13314.866851331362;13408.731825363244;13566.075324921481;13572.321383930961;13722.794158087836;12609.30648814324;12642.2414655121;12764.106512544404;12861.935690321488;12981;11961.521539138337;11986.880131198577;12060.577879774166;12062.215955962834;12367.257964522158;11943.10426718017;11952.880471195176;12057.51769929228;12204.633860984184;12426.875731242571;10558.155347572329;10719.356838589709;10742.570297188338;11067.786442711329;11438.94280528592;10600.1519878408;10754.247202695737;10822.783544329226;10927.726806829893;10952.726181845517 03:49:41 INFO - PROCESS | 9646 | __end_tp_report 03:49:41 INFO - PROCESS | 9646 | __start_cc_report 03:49:41 INFO - PROCESS | 9646 | _x_x_mozilla_cycle_collect,1013 03:49:41 INFO - PROCESS | 9646 | __end_cc_report 03:49:41 INFO - PROCESS | 9646 | __startTimestamp1479296981779__endTimestamp 03:49:41 INFO - PROCESS | 9646 | 03:49:41 INFO - PROCESS | 9646 | ------- Summary: start ------- 03:49:41 INFO - PROCESS | 9646 | Number of tests: 6 03:49:41 INFO - PROCESS | 9646 | 03:49:41 INFO - PROCESS | 9646 | [#0] dojo.html Cycles:165 Average:5395.69 Median:5619.58 stddev:587.17 (10.4%) stddev-sans-first:562.57 03:49:41 INFO - PROCESS | 9646 | Values: 3176.3 3193.2 3210.1 3228.4 3246.5 5388.4 5452.4 5453.7 5459.3 5463.0 5439.5 5474.6 5480.6 5493.5 5497.0 4946.4 4959.1 5002.5 5009.2 5015.7 4881.4 4893.9 4997.4 5045.1 5046.3 4850.1 4868.0 4874.2 4901.8 4904.0 4935.0 4949.7 5004.7 5012.8 5039.8 4801.7 4949.2 4976.5 4981.8 4985.5 5226.0 5306.8 5308.3 5410.3 5436.3 5699.3 5716.5 5775.4 5782.2 5811.0 5700.9 5831.7 5850.6 5864.7 5877.6 5363.8 5401.8 5402.1 5417.8 5474.5 5911.0 5930.9 5935.6 5936.6 5937.2 5552.4 5718.3 5725.0 5743.9 5744.6 5684.1 5780.3 5811.2 5815.9 5910.2 5784.6 5826.4 5826.5 5827.0 5833.5 5741.1 5784.5 5793.1 5793.2 5817.4 4444.5 4459.1 4477.6 4478.6 4488.3 4006.2 4031.3 4039.0 4040.4 4064.4 5525.3 5527.5 5534.4 5539.1 5560.4 5717.3 5775.1 5790.7 5796.4 5818.6 5566.1 5591.9 5598.7 5603.2 5622.0 5062.9 5074.6 5077.9 5079.1 5109.9 5705.6 5734.9 5824.2 5956.3 5958.2 5764.9 5833.9 5836.2 5864.5 5876.3 5910.2 5914.9 5916.0 5919.3 5926.7 5593.8 5638.1 5716.5 5723.9 5729.0 5718.8 5732.9 5741.0 5848.6 5882.0 5631.8 5644.7 5655.8 5655.8 5657.9 5536.6 5570.0 5632.9 5640.3 5640.5 5562.2 5659.2 5682.2 5705.4 5785.7 5781.7 5790.7 5801.5 5806.7 5808.7 5396.5 5432.3 5441.6 5619.6 5670.4 03:49:41 INFO - PROCESS | 9646 | 03:49:41 INFO - PROCESS | 9646 | [#1] ext.html Cycles:180 Average:64763.51 Median:21772.36 stddev:134673.65 (618.6%) stddev-sans-first:134965.23 03:49:41 INFO - PROCESS | 9646 | Values: 582.5 607.4 633.8 642.7 666.3 34112.5 37321.0 37364.3 45136.5 45994.8 47181.3 47760.8 47778.5 47796.8 47826.0 8939.6 9049.4 9075.2 9088.9 9096.7 8457.0 8637.8 8961.9 9084.1 10590.8 10704.1 11123.2 11127.7 11129.1 11130.7 10830.8 10870.4 10883.3 10883.8 10897.4 10697.7 10783.5 10787.6 10795.3 10798.2 43479.3 43702.3 43707.6 43787.6 43897.8 3753.6 3870.9 3923.9 3928.7 3987.1 31348.0 32649.5 32685.8 32697.2 33056.0 4024.1 4058.5 4069.4 4100.3 4159.1 349148.0 354494.0 355397.0 356144.0 356773.0 68423.7 69272.3 69383.8 69402.0 69468.3 40758.4 41494.6 41585.0 50316.0 50364.7 16925.7 17220.2 17269.1 17310.8 17337.5 12885.7 12995.4 13013.1 13015.3 13024.6 19543.9 19551.4 21247.0 21811.8 22709.5 7942.7 7993.7 8035.7 8111.3 8353.3 1003.6 1034.0 1040.8 1079.2 1111.5 33979.8 33985.7 33992.2 33999.3 34126.7 1078.6 1114.5 1125.5 1146.1 1179.3 16699.2 17582.4 17721.4 17889.2 17932.6 556686.0 610206.0 620501.0 621378.0 905932.0 61186.4 61865.0 61875.0 62085.7 62102.4 1319.2 1371.9 1391.1 1441.3 1465.0 32719.0 34426.8 34639.7 34701.5 34871.3 53101.0 53553.0 53683.5 53837.5 53872.7 424534.0 428599.0 428854.0 428973.0 430542.0 31597.5 32566.5 32899.3 33061.5 33646.5 50218.5 50793.7 51178.2 51324.5 51399.2 41801.6 42407.0 42623.0 43143.0 44464.6 43351.6 44119.6 44498.3 45025.3 45458.5 43507.3 44481.0 44494.1 44502.0 44688.3 35978.6 39253.6 39557.6 40993.4 41528.4 29156.6 29278.6 29317.7 29420.3 29722.3 03:49:41 INFO - PROCESS | 9646 | 03:49:41 INFO - PROCESS | 9646 | [#2] jquery.html Cycles:180 Average:29400.07 Median:2547.85 stddev:82497.57 (3237.9%) stddev-sans-first:82700.27 03:49:41 INFO - PROCESS | 9646 | Values: 403.6 416.3 416.6 430.3 441.2 15001.8 18808.3 19811.1 20641.5 20778.4 18435.8 19282.1 20124.6 20428.2 20562.4 5704.5 5947.5 5948.7 5953.9 5961.9 5572.1 5847.0 5881.2 5882.4 5882.8 5809.0 5863.8 5864.9 5867.2 5873.3 5630.8 5793.5 5814.5 5818.9 5822.2 5020.2 5172.4 5264.3 5264.5 5272.7 23395.9 23711.9 23827.0 23914.4 24094.9 2458.3 2521.8 2538.4 2557.3 2670.0 14567.9 14934.3 14981.6 15007.9 15157.8 1745.3 1748.8 1782.9 1802.9 1839.1 82959.6 82960.6 83513.0 84438.2 85860.1 9862.8 10073.7 10274.4 10345.6 10432.7 13190.4 13771.7 13793.0 13840.2 14903.9 8057.8 8100.3 8155.9 8221.8 8232.9 7914.7 7935.0 8093.1 8154.2 8182.2 6594.1 6624.0 6692.9 6731.3 6739.4 1873.8 1879.3 1894.9 1960.4 1964.4 968.4 1034.3 1038.7 1069.4 1080.4 20082.2 20784.3 20950.9 21048.3 21252.8 998.5 1025.0 1037.3 1057.1 1066.4 11129.9 11711.5 11810.6 11837.0 11903.7 489435.0 498176.0 500401.0 502048.0 516056.0 85233.6 86464.0 87889.0 88336.0 88509.0 997.8 998.5 1021.6 1029.6 1034.3 17394.6 17849.3 18005.4 18405.3 18451.8 41163.0 41670.2 42122.2 42682.4 43321.6 54929.7 55155.4 55765.7 55980.0 56307.7 6422.5 8215.3 8729.3 8856.2 8884.2 12596.2 13026.9 13355.0 14071.4 14094.2 10945.2 11108.4 11538.0 11572.2 11958.9 10995.4 11753.2 11760.1 11970.6 12051.4 5929.9 6653.0 11334.4 11514.7 11680.6 8718.6 8796.4 8873.3 8906.4 9136.2 11509.4 11544.1 11682.1 11952.3 11959.7 03:49:41 INFO - PROCESS | 9646 | 03:49:41 INFO - PROCESS | 9646 | [#3] mootools.html Cycles:180 Average:5634.43 Median:5015.23 stddev:3129.57 (62.4%) stddev-sans-first:3122.06 03:49:41 INFO - PROCESS | 9646 | Values: 1385.9 1507.4 1508.1 1655.7 1801.5 7527.3 8146.7 8472.3 8474.8 8672.0 8491.7 8578.9 8581.9 8588.2 8647.4 2424.0 2444.4 2449.7 2454.9 2457.9 2381.8 2410.0 2432.3 2450.1 2457.8 2421.9 2438.4 2452.4 2463.8 2471.6 2294.2 2373.1 2377.3 2382.6 2427.5 2386.5 2399.8 2404.4 2405.9 2410.0 8145.8 8266.2 8271.4 8299.7 8383.1 5087.4 5261.6 5326.8 5326.9 5331.0 3263.1 3281.2 3282.3 3330.0 3382.3 983.9 1008.8 1011.6 1026.2 1039.6 11233.4 11397.4 11452.5 11463.3 11466.2 4517.2 4594.2 4657.5 4668.1 4676.1 10052.5 10078.6 10083.4 10098.2 10098.6 5313.9 5331.5 5332.9 5334.6 5338.8 4264.6 4424.3 4443.7 4482.4 4913.4 4051.0 4134.8 4224.9 4245.5 4268.2 1333.5 1365.7 1367.4 1376.6 1384.3 820.9 839.9 848.8 924.5 997.1 5485.7 5569.6 5669.3 5857.2 5870.6 825.0 893.3 950.3 973.3 977.6 3561.3 3615.4 3641.2 3721.6 3760.3 10254.5 10687.4 10727.4 10743.3 10795.2 10649.1 10670.4 10680.1 10681.8 10687.5 7610.1 7975.3 7991.7 8127.1 8143.6 5613.4 5745.0 5759.0 5774.3 5809.9 9263.5 9535.0 9613.2 9634.6 9801.4 8813.6 9104.9 9535.1 9900.8 9949.8 7772.4 8143.2 8150.4 8152.3 8262.3 8235.0 8473.9 8526.4 8544.4 8548.3 7267.0 7344.6 7420.7 7473.7 7502.9 7145.1 7163.8 7318.8 7505.1 7607.8 6368.5 6435.2 6445.3 6683.4 6684.8 4868.2 4938.3 4939.1 5001.3 5021.1 4804.5 4912.6 5009.4 5069.0 5087.6 03:49:41 INFO - PROCESS | 9646 | 03:49:41 INFO - PROCESS | 9646 | [#4] prototype.html Cycles:180 Average:4634.77 Median:5256.43 stddev:1318.24 (25.1%) stddev-sans-first:1282.00 03:49:41 INFO - PROCESS | 9646 | Values: 344.5 356.3 358.1 359.1 361.3 5297.0 5307.6 5348.9 5384.0 5438.8 5255.7 5257.2 5261.4 5262.8 5272.6 4003.6 4215.4 4219.6 4224.5 4239.7 3756.7 4140.4 4193.1 4197.0 4212.7 4154.3 4155.7 4161.7 4163.9 4179.8 4175.6 4175.6 4177.8 4185.2 4197.8 3525.7 3619.3 3662.0 3720.9 3776.7 5095.0 5109.0 5114.9 5115.2 5125.8 4759.4 4768.6 4774.5 4775.6 4781.0 5385.7 5461.0 5492.7 5500.1 5508.2 4119.5 4128.4 4130.0 4134.8 4154.3 5511.9 5594.3 5690.9 5772.6 5777.7 4173.7 4176.8 4186.4 4200.6 4202.6 4251.6 4277.7 4290.9 4298.9 4304.5 4713.3 4751.6 4812.9 4834.5 4853.0 5517.4 5533.5 5549.6 5557.5 5598.7 1386.8 1394.8 1395.3 1401.8 1405.7 960.3 1011.9 1013.9 1020.2 1042.3 5141.4 5189.9 5201.2 5211.4 5245.7 5419.3 5422.8 5423.0 5479.9 5486.2 4961.4 5107.8 5196.3 5209.8 5214.6 2880.5 2888.8 2897.0 2898.6 2900.5 5530.3 5531.9 5546.7 5548.9 5572.8 5397.3 5482.4 5528.9 5545.2 5573.2 5450.6 5468.8 5478.4 5482.5 5515.3 5321.2 5441.6 5491.2 5518.2 5561.4 5383.2 5385.8 5396.4 5406.5 5439.3 5457.7 5627.5 5636.7 5675.4 5692.2 4227.9 4255.3 4287.4 4299.0 4307.2 5677.7 5682.4 5801.6 5811.3 5818.2 5502.6 5504.8 5521.1 5532.6 5563.1 5471.5 5502.9 5509.9 5554.0 5584.2 5234.7 5488.3 5502.8 5504.6 5513.3 5511.4 5530.4 5536.9 5552.6 5556.9 5415.0 5449.0 5455.9 5462.5 5466.8 03:49:41 INFO - PROCESS | 9646 | 03:49:41 INFO - PROCESS | 9646 | [#5] yui.html Cycles:180 Average:17996.57 Median:26986.01 stddev:23877.80 (88.5%) stddev-sans-first:23909.83 03:49:41 INFO - PROCESS | 9646 | Values: 791.2 807.0 841.0 864.0 905.7 13603.2 13680.4 13710.2 13733.2 14326.6 13735.3 13833.2 13846.3 13847.0 13866.5 697.5 733.9 794.6 861.6 865.5 846.2 846.2 848.1 848.3 850.6 745.6 913.0 913.2 914.2 917.0 762.4 840.4 872.2 885.0 888.6 653.5 653.8 653.8 653.9 654.2 14860.3 14907.4 14924.0 14972.3 14975.6 13365.2 13616.9 13806.8 14007.4 14062.9 12457.9 12481.8 12541.8 12629.1 12711.2 4036.4 4126.8 4143.6 4224.8 4229.5 63938.7 64086.0 65066.7 65395.0 65437.7 10767.1 10837.7 10843.6 11043.9 11150.0 21456.6 21473.5 21475.4 21490.4 21498.7 8049.7 8081.9 8155.6 8364.4 8493.2 4464.4 4490.2 4511.6 4610.9 4612.5 3262.9 3345.8 3350.3 3353.2 3360.6 602.1 603.2 612.8 616.5 626.0 640.5 656.2 661.5 699.0 725.8 9193.4 9489.2 9528.4 9755.9 9986.5 615.5 667.6 679.8 732.5 760.8 4508.8 4916.5 4932.7 5022.4 5096.3 77511.0 85552.1 87393.6 88274.0 90589.0 75271.0 75936.0 76232.0 77187.0 77245.0 71723.0 72519.3 72819.0 73296.3 75822.2 8482.3 8724.5 8866.0 8931.7 8972.4 46590.5 47036.5 47848.8 48883.3 49055.5 62024.0 62177.4 65195.7 65226.0 66572.7 11205.3 11507.9 11654.9 11718.9 11903.6 13314.9 13408.7 13566.1 13572.3 13722.8 12609.3 12642.2 12764.1 12861.9 12981.0 11961.5 11986.9 12060.6 12062.2 12367.3 11943.1 11952.9 12057.5 12204.6 12426.9 10558.2 10719.4 10742.6 11067.8 11438.9 10600.2 10754.2 10822.8 10927.7 10952.7 03:49:41 INFO - PROCESS | 9646 | -------- Summary: end -------- 03:49:41 INFO - PROCESS | 9646 | 03:49:42 INFO - TEST-INFO | 9646: exit 0 03:49:42 INFO - TEST-OK | dromaeo_css | took 1116480ms 03:49:42 INFO - TEST-START | kraken 03:49:42 INFO - operating with platform_type : linux_ 03:49:42 INFO - Initialising browser for kraken test... 03:49:42 INFO - TEST-INFO | started process 9963 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXELOXm/profile http://localhost:46152/getInfo.html) 03:49:46 ERROR - PROCESS | 9963 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 5376: TypeError: parent.firstChild is null 03:49:47 INFO - PROCESS | 9963 | __metrics Screen width/height:1600/1200 03:49:47 INFO - PROCESS | 9963 | colorDepth:24 03:49:47 INFO - PROCESS | 9963 | Browser inner width/height: 1024/697 03:49:47 INFO - PROCESS | 9963 | __metrics 03:49:47 INFO - PROCESS | 9963 | 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" 03:49:47 INFO - PROCESS | 9963 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:49:48 INFO - PROCESS | 9963 | console.error: PushService: 03:49:48 INFO - PROCESS | 9963 | stateChangeProcessEnqueue: Error transitioning state 03:49:48 INFO - PROCESS | 9963 | UnknownError 03:49:49 INFO - TEST-INFO | 9963: exit 0 03:49:49 INFO - Browser initialized. 03:49:49 INFO - Running cycle 1/1 for kraken test... 03:49:49 INFO - TEST-INFO | started process 10058 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXELOXm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:50:01 INFO - PROCESS | 10058 | RSS: Main: 144977920 03:50:01 INFO - PROCESS | 10058 | 03:50:03 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46152/tests/kraken/driver.html?testName=audio-beat-detection) 03:50:04 INFO - PROCESS | 10058 | RSS: Main: 186081280 03:50:04 INFO - PROCESS | 10058 | 03:50:07 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46152/tests/kraken/driver.html?testName=audio-dft) 03:50:07 INFO - PROCESS | 10058 | RSS: Main: 175542272 03:50:07 INFO - PROCESS | 10058 | 03:50:10 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46152/tests/kraken/driver.html?testName=audio-fft) 03:50:11 INFO - PROCESS | 10058 | RSS: Main: 266706944 03:50:11 INFO - PROCESS | 10058 | 03:50:13 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46152/tests/kraken/driver.html?testName=audio-oscillator) 03:50:13 INFO - PROCESS | 10058 | RSS: Main: 174006272 03:50:13 INFO - PROCESS | 10058 | 03:50:15 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46152/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:50:16 INFO - PROCESS | 10058 | RSS: Main: 175624192 03:50:16 INFO - PROCESS | 10058 | 03:50:19 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46152/tests/kraken/driver.html?testName=imaging-darkroom) 03:50:19 INFO - PROCESS | 10058 | RSS: Main: 213925888 03:50:19 INFO - PROCESS | 10058 | 03:50:23 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46152/tests/kraken/driver.html?testName=imaging-desaturate) 03:50:24 INFO - PROCESS | 10058 | RSS: Main: 213106688 03:50:24 INFO - PROCESS | 10058 | 03:50:26 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46152/tests/kraken/driver.html?testName=json-parse-financial) 03:50:27 INFO - PROCESS | 10058 | RSS: Main: 211103744 03:50:27 INFO - PROCESS | 10058 | 03:50:28 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46152/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:50:29 INFO - PROCESS | 10058 | RSS: Main: 173531136 03:50:29 INFO - PROCESS | 10058 | 03:50:30 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46152/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:50:31 INFO - PROCESS | 10058 | RSS: Main: 180989952 03:50:31 INFO - PROCESS | 10058 | 03:50:33 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46152/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:50:34 INFO - PROCESS | 10058 | RSS: Main: 189972480 03:50:34 INFO - PROCESS | 10058 | 03:50:36 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46152/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:50:37 INFO - PROCESS | 10058 | RSS: Main: 198885376 03:50:37 INFO - PROCESS | 10058 | 03:50:40 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46152/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:50:40 INFO - PROCESS | 10058 | RSS: Main: 194916352 03:50:40 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | Cycle 1(1): loaded http://localhost:46152/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46152/tests/kraken/driver.html?testName=ai-astar) 03:50:42 INFO - PROCESS | 10058 | RSS: Main: 246562816 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | __start_tp_report 03:50:42 INFO - PROCESS | 10058 | _x_x_mozilla_page_load 03:50:42 INFO - PROCESS | 10058 | _x_x_mozilla_page_load_details 03:50:42 INFO - PROCESS | 10058 | |i|pagename|runs| 03:50:42 INFO - PROCESS | 10058 | |0;ai-astar;101;112;111;110;112;112;111;112;111;110 03:50:42 INFO - PROCESS | 10058 | |1;audio-beat-detection;148;122;121;173;128;124;123;120;167;125 03:50:42 INFO - PROCESS | 10058 | |2;audio-dft;161;161;161;160;160;160;160;160;160;161 03:50:42 INFO - PROCESS | 10058 | |3;audio-fft;75;75;77;113;75;76;75;75;102;74 03:50:42 INFO - PROCESS | 10058 | |4;audio-oscillator;82;81;115;82;82;82;109;82;82;110 03:50:42 INFO - PROCESS | 10058 | |5;imaging-gaussian-blur;117;117;117;117;116;117;117;117;117;117 03:50:42 INFO - PROCESS | 10058 | |6;imaging-darkroom;145;146;146;146;146;146;147;154;171;146 03:50:42 INFO - PROCESS | 10058 | |7;imaging-desaturate;85;85;85;85;85;84;85;84;84;85 03:50:42 INFO - PROCESS | 10058 | |8;json-parse-financial;51;51;50;51;51;51;51;51;51;52 03:50:42 INFO - PROCESS | 10058 | |9;json-stringify-tinderbox;60;60;61;59;61;60;60;60;65;60 03:50:42 INFO - PROCESS | 10058 | |10;stanford-crypto-aes;75;75;75;74;81;74;75;76;77;75 03:50:42 INFO - PROCESS | 10058 | |11;stanford-crypto-ccm;125;132;128;129;134;129;130;132;174;134 03:50:42 INFO - PROCESS | 10058 | |12;stanford-crypto-pbkdf2;153;161;154;152;158;156;155;159;158;159 03:50:42 INFO - PROCESS | 10058 | |13;stanford-crypto-sha256-iterative;65;62;65;63;62;71;61;73;61;60 03:50:42 INFO - PROCESS | 10058 | __end_tp_report 03:50:42 INFO - PROCESS | 10058 | __start_cc_report 03:50:42 INFO - PROCESS | 10058 | _x_x_mozilla_cycle_collect,1641 03:50:42 INFO - PROCESS | 10058 | __end_cc_report 03:50:42 INFO - PROCESS | 10058 | __startTimestamp1479297042654__endTimestamp 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | ------- Summary: start ------- 03:50:42 INFO - PROCESS | 10058 | Number of tests: 14 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.33 (3.0%) stddev-sans-first:0.83 03:50:42 INFO - PROCESS | 10058 | Values: 101.0 112.0 111.0 110.0 112.0 112.0 111.0 112.0 111.0 110.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#1] audio-beat-detection Cycles:10 Average:135.10 Median:126.50 stddev:20.11 (15.9%) stddev-sans-first:20.78 03:50:42 INFO - PROCESS | 10058 | Values: 148.0 122.0 121.0 173.0 128.0 124.0 123.0 120.0 167.0 125.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#2] audio-dft Cycles:10 Average:160.40 Median:160.50 stddev:0.52 (0.3%) stddev-sans-first:0.50 03:50:42 INFO - PROCESS | 10058 | Values: 161.0 161.0 161.0 160.0 160.0 160.0 160.0 160.0 160.0 161.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#3] audio-fft Cycles:10 Average:81.70 Median:75.00 stddev:13.86 (18.5%) stddev-sans-first:14.49 03:50:42 INFO - PROCESS | 10058 | Values: 75.0 75.0 77.0 113.0 75.0 76.0 75.0 75.0 102.0 74.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.00 stddev:14.32 (17.5%) stddev-sans-first:14.84 03:50:42 INFO - PROCESS | 10058 | Values: 82.0 81.0 115.0 82.0 82.0 82.0 109.0 82.0 82.0 110.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:50:42 INFO - PROCESS | 10058 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#6] imaging-darkroom Cycles:10 Average:149.30 Median:146.00 stddev:8.04 (5.5%) stddev-sans-first:8.38 03:50:42 INFO - PROCESS | 10058 | Values: 145.0 146.0 146.0 146.0 146.0 146.0 147.0 154.0 171.0 146.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 03:50:42 INFO - PROCESS | 10058 | Values: 85.0 85.0 85.0 85.0 85.0 84.0 85.0 84.0 84.0 85.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#8] json-parse-financial Cycles:10 Average:51.00 Median:51.00 stddev:0.47 (0.9%) stddev-sans-first:0.50 03:50:42 INFO - PROCESS | 10058 | Values: 51.0 51.0 50.0 51.0 51.0 51.0 51.0 51.0 51.0 52.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#9] json-stringify-tinderbox Cycles:10 Average:60.60 Median:60.00 stddev:1.65 (2.7%) stddev-sans-first:1.73 03:50:42 INFO - PROCESS | 10058 | Values: 60.0 60.0 61.0 59.0 61.0 60.0 60.0 60.0 65.0 60.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#10] stanford-crypto-aes Cycles:10 Average:75.70 Median:75.00 stddev:2.06 (2.7%) stddev-sans-first:2.17 03:50:42 INFO - PROCESS | 10058 | Values: 75.0 75.0 75.0 74.0 81.0 74.0 75.0 76.0 77.0 75.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:132.00 stddev:14.09 (10.7%) stddev-sans-first:14.50 03:50:42 INFO - PROCESS | 10058 | Values: 125.0 132.0 128.0 129.0 134.0 129.0 130.0 132.0 174.0 134.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.50 Median:158.00 stddev:2.95 (1.9%) stddev-sans-first:2.85 03:50:42 INFO - PROCESS | 10058 | Values: 153.0 161.0 154.0 152.0 158.0 156.0 155.0 159.0 158.0 159.0 03:50:42 INFO - PROCESS | 10058 | 03:50:42 INFO - PROCESS | 10058 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.00 stddev:4.40 (6.9%) stddev-sans-first:4.66 03:50:42 INFO - PROCESS | 10058 | Values: 65.0 62.0 65.0 63.0 62.0 71.0 61.0 73.0 61.0 60.0 03:50:42 INFO - PROCESS | 10058 | -------- Summary: end -------- 03:50:42 INFO - PROCESS | 10058 | 03:50:43 INFO - TEST-INFO | 10058: exit 0 03:50:43 INFO - TEST-OK | kraken | took 61160ms 03:50:43 INFO - SUITE-END | took 1177s 03:50:43 INFO - Completed test suite (00:19:37) 03:50:43 INFO - javascript benchmark 03:50:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3176.3012137329783, 3193.169775858277, 3210.1332640187134, 3228.435023870822, 3246.513023046543, 5388.353397592289, 5452.4274951130155, 5453.672779633225, 5459.262999495072, 5463.043967305721, 5439.499394670112, 5474.644148130369, 5480.616356855012, 5493.450654934514, 5497.038018346793, 4946.381702287223, 4959.132151873408, 5002.499750025005, 5009.2486127080865, 5015.7492125393765, 4881.438634557036, 4893.877653058684, 4997.400311962551, 5045.0666626674, 5046.268291097788, 4850.102730994778, 4867.951320486785, 4874.244492103712, 4901.754912254391, 4903.950960490403, 4934.963657631902, 4949.703017818906, 5004.724740139291, 5012.8496145115705, 5039.840836607564, 4801.711897286139, 4949.208126699711, 4976.502349765031, 4981.750912454363, 4985.52637499437, 5225.973870130663, 5306.814261500829, 5308.256844041837, 5410.323709536308, 5436.293281873371, 5699.2590963174525, 5716.514096301819, 5775.364709881952, 5782.219400380979, 5811.041178205591, 5700.9429905701245, 5831.650100993911, 5850.64896106235, 5864.7067646617925, 5877.5591830612875, 5363.758630861621, 5401.810936617199, 5402.054640437947, 5417.8103766367985, 5474.479924407175, 5911.024680927599, 5930.881382372415, 5935.643861368331, 5936.614120082181, 5937.228160339128, 5552.416996215339, 5718.285214348207, 5725.0, 5743.9425605744245, 5744.597878148573, 5684.118961560965, 5780.335261444988, 5811.215485909348, 5815.88368232633, 5910.172575839386, 5784.59507834456, 5826.388229235869, 5826.533877289807, 5827.0, 5833.4749872511675, 5741.110127930177, 5784.50831679312, 5793.073108302651, 5793.159991801165, 5817.418258174149, 4444.511103778582, 4459.108178364275, 4477.6417886569, 4478.619317357996, 4488.304312831517, 4006.238814625212, 4031.294523458383, 4039.030632648202, 4040.4343391925154, 4064.3903414488063, 5525.336959564878, 5527.474889885454, 5534.418886016991, 5539.086050801573, 5560.36055853582, 5717.342505611825, 5775.133729940542, 5790.71046447676, 5796.420357964254, 5818.5636077294375, 5566.109422492382, 5591.944080559224, 5598.748056337475, 5603.215549823028, 5622.044252477089, 5062.898742025139, 5074.644774865724, 5077.898442031139, 5079.08576456234, 5109.8722531937, 5705.572082093942, 5734.942650573525, 5824.155497452761, 5956.255468066492, 5958.165856780054, 5764.855878603068, 5833.912491312549, 5836.212111364912, 5864.472197502245, 5876.294844618673, 5910.202122713378, 5914.935311643945, 5915.970420147872, 5919.348871624204, 5926.703664816828, 5593.804216852391, 5638.097904335286, 5716.54267658578, 5723.912456633227, 5729.0, 5718.771249149988, 5732.856678583069, 5741.0, 5848.619839710405, 5881.9705901470215, 5631.831045068655, 5644.689542075225, 5655.802046928337, 5655.830325090254, 5657.943420565742, 5536.557075433875, 5569.972150139385, 5632.85917852057, 5640.266765320482, 5640.548756099584, 5562.16567514876, 5659.207710920392, 5682.232898558807, 5705.429457054427, 5785.739641716049, 5781.653100813965, 5790.739416726173, 5801.535877129735, 5806.709664516673, 5808.6805225711305, 5396.541293990055, 5432.29380180574, 5441.591880608891, 5619.578531610064, 5670.376258611632], "value": 5357.8322820775265, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [582.5339728217425, 607.3622696169023, 633.7718421368309, 642.6658137768358, 666.2904007232294, 34112.4883126753, 37321.0, 37364.25271494569, 45136.548634513645, 45994.770026149905, 47181.29228061582, 47760.76119619406, 47778.52221477784, 47796.761016194956, 47826.0, 8939.642414303436, 9049.411788233776, 9075.183233508982, 9088.909110908873, 9096.681616143436, 8457.0, 8637.784055398603, 8961.865572016424, 9084.091590840897, 10590.788184236311, 10704.090152337021, 11123.221374503788, 11127.72180695481, 11129.109671226322, 11130.721731956726, 10830.837537436944, 10870.402127882964, 10883.292585981964, 10883.83674244887, 10897.400642964634, 10697.679069627924, 10783.46082695862, 10787.5684972601, 10795.29830561011, 10798.190135739773, 43479.34780978288, 43702.344464833055, 43707.562924370664, 43787.562124378666, 43897.78051109756, 3753.6246375362516, 3870.9225815483533, 3923.9215215695813, 3928.7249892507534, 3987.1228329767405, 31348.0, 32649.51025734616, 32685.836570816995, 32697.182570435692, 33056.0, 4024.1146947671464, 4058.472398588194, 4069.369247766601, 4100.302948498763, 4159.085001299709, 349148.0, 354494.0, 355397.0, 356144.0, 356773.0, 68423.65788171027, 69272.30727692759, 69383.83696978197, 69402.0, 69468.3053169472, 40758.388624170664, 41494.58505414907, 41585.0, 50316.0, 50364.74817625889, 16925.66148677044, 17220.225089870986, 17269.13654317279, 17310.826891731173, 17337.479875603753, 12885.677858053623, 12995.350232488337, 13013.089083764235, 13015.284159371136, 13024.609261722164, 19543.902280488506, 19551.37799596864, 21247.0438830253, 21811.781882180974, 22709.545809084055, 7942.722004729922, 7993.68025278994, 8035.678572857137, 8111.282720288769, 8353.289970352467, 1003.5885287032281, 1033.9896601033893, 1040.7958328592706, 1079.1852151625471, 1111.5053801058452, 33979.830100849336, 33985.660143398745, 33992.150196244795, 33999.32001359959, 34126.65873341235, 1078.6063086973197, 1114.5207560748793, 1125.5047778977387, 1146.094585277638, 1179.262960649594, 16699.248533816008, 17582.428508928908, 17721.379751708628, 17889.19498622565, 17932.641347173245, 556686.0, 610206.0, 620501.0, 621378.0, 905932.0, 61186.388136118956, 61865.0, 61875.0, 62085.689571551855, 62102.37897620966, 1319.2018828608554, 1371.9382627781774, 1391.0818859552646, 1441.315375196794, 1464.9707005859823, 32719.0, 34426.82786586051, 34639.653603463645, 34701.47947780836, 34871.30257394889, 53101.0, 53553.0, 53683.46316536941, 53837.461625384814, 53872.73063634657, 424534.0, 428599.0, 428854.0, 428973.0, 430542.0, 31597.526037109, 32566.511502327958, 32899.34201316008, 33061.504077438374, 33646.495302569994, 50218.49781502284, 50793.746031269606, 51178.23232651588, 51324.48675513197, 51399.22901156561, 41801.581984180986, 42407.0, 42623.0, 43143.0, 44464.55535444604, 43351.566484334755, 44119.55880441154, 44498.3325250115, 45025.32462013138, 45458.54541454543, 43507.34738978855, 44481.0, 44494.110117796816, 44502.0, 44688.32967505555, 35978.64021359753, 39253.60746392499, 39557.604423956545, 40993.385099224135, 41528.37707434451, 29156.562651560667, 29278.56082158812, 29317.706822931497, 29420.264493387836, 29722.256943576584], "value": 21274.09097388838, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [403.59438764042136, 416.31516155923487, 416.63128131603526, 430.264248135688, 441.20142541998985, 15001.849981500181, 18808.34170804022, 19811.108500117494, 20641.483962900897, 20778.376648700527, 18435.81564184358, 19282.132304046318, 20124.597508049832, 20428.182872685076, 20562.38312850613, 5704.54363650909, 5947.494462970652, 5948.7323070461935, 5953.940460595403, 5961.88076238475, 5572.108462645978, 5847.0352391855295, 5881.176635271044, 5882.3529411764675, 5882.764689412418, 5809.0, 5863.824085277427, 5864.941350586482, 5867.178594996704, 5873.295204575457, 5630.774769009235, 5793.536517078624, 5814.534837213013, 5818.854528636775, 5822.243108395903, 5020.246962955549, 5172.431032586413, 5264.263003179558, 5264.473552644743, 5272.736363181864, 23395.883020584788, 23711.88144059286, 23827.046918123255, 23914.402139946465, 24094.915728792246, 2458.323960910746, 2521.8108641851936, 2538.4415428605676, 2557.258395065429, 2669.973300266992, 14567.92716036413, 14934.32795524204, 14981.625459363495, 15007.924960375129, 15157.848421515864, 1745.293156271712, 1748.77265955425, 1782.857371410297, 1802.9008404537744, 1839.1356062650532, 82959.5852020742, 82960.58519707424, 83513.0, 84438.15561844365, 85860.14139858584, 9862.802743945082, 10073.69778906634, 10274.383536987656, 10345.586176553004, 10432.68701938943, 13190.406431710404, 13771.724565508834, 13793.034487585974, 13840.169589824643, 14903.925480372529, 8057.798555036171, 8100.270975612223, 8155.877661835078, 8221.753347399588, 8232.917670823335, 7914.722984695508, 7935.008123984502, 8093.109757926623, 8154.2253485918745, 8182.1817818217705, 6594.109795177686, 6624.0, 6692.899606505906, 6731.259561448237, 6739.393454589111, 1873.756411666502, 1879.285871368871, 1894.8673592848645, 1960.4412742368356, 1964.3517639179322, 968.3657204531044, 1034.3018462537757, 1038.7351225437465, 1069.4332004037872, 1080.378782200238, 20082.196712131645, 20784.27255046066, 20950.895245523676, 21048.263310784354, 21252.78747212508, 998.5456617239139, 1025.0, 1037.2687255484866, 1057.0539367266254, 1066.3761699405934, 11129.888701113046, 11711.472983715754, 11810.645680629423, 11837.0, 11903.702407439883, 489435.0, 498176.0, 500401.0, 502048.0, 516056.0, 85233.57383213169, 86464.0, 87889.0, 88336.0, 88509.0, 997.760028735479, 998.4708104704519, 1021.6322124035341, 1029.5572903651353, 1034.281174583657, 17394.565135871704, 17849.340885118778, 18005.369812056517, 18405.263789448807, 18451.81548184501, 41163.0, 41670.1665966685, 42122.157556849306, 42682.35976460294, 43321.566784333016, 54929.72535137299, 55155.44844551503, 55765.72117139388, 55980.0, 56307.71846140907, 6422.518311126778, 8215.342772578299, 8729.301655867643, 8856.158664926821, 8884.200421962054, 12596.181248218836, 13026.934865325613, 13355.0, 14071.437142514185, 14094.224817634718, 10945.179111566506, 11108.444577770917, 11538.0, 11572.18994670365, 11958.940205298917, 10995.395253260827, 11753.217139571272, 11760.117991150526, 11970.58102966392, 12051.397430128634, 5929.85175370602, 6652.966735166293, 11334.433278335886, 11514.712132196762, 11680.612622339766, 8718.564071796513, 8796.428232164888, 8873.290136788912, 8906.421082629868, 9136.223421009023, 11509.366984815915, 11544.076473881902, 11682.123840712151, 11952.34262115592, 11959.701007474883], "value": 9406.99142890116, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.902986790925, 1507.4422463688434, 1508.064999700186, 1655.6771429571238, 1801.5135913303416, 7527.322540971311, 8146.674133034679, 8472.322214222862, 8474.788130296745, 8671.956640216806, 8491.745247642566, 8578.914210857889, 8581.91418085819, 8588.227059564639, 8647.43791653542, 2423.963640545389, 2444.352246654638, 2449.6570480132705, 2454.9140780072703, 2457.9016839326405, 2381.7975472084895, 2410.035985605763, 2432.2703189043305, 2450.1424501424535, 2457.8279520433575, 2421.9152329668464, 2438.426969662128, 2452.448199155194, 2463.790577800889, 2471.6292556116637, 2294.1740973249616, 2373.050779688121, 2377.3105799318178, 2382.5830479665988, 2427.453822889853, 2386.4511162432564, 2399.808015358767, 2404.350825277183, 2405.87970601471, 2409.9518009639883, 8145.8370832583605, 8266.173382661746, 8271.421000529965, 8299.709510167175, 8383.077861435237, 5087.389513258433, 5261.631685781997, 5326.760295786699, 5326.866828329284, 5330.9733451332495, 3263.102646772133, 3281.2453135778665, 3282.3271229397915, 3329.983350083234, 3382.3235352929514, 983.9163671087966, 1008.7780688248573, 1011.6004178349584, 1026.1790567546009, 1039.5685790396976, 11233.382163980978, 11397.373144477051, 11452.484638191301, 11463.254888432226, 11466.197366184371, 4517.215699798561, 4594.218982772936, 4657.5095969289505, 4668.136394766979, 4676.134915040729, 10052.547635356426, 10078.59685612582, 10083.394996300245, 10098.192144628412, 10098.646547370807, 5313.893722125613, 5331.546818520469, 5332.866678333073, 5334.5732341412595, 5338.813141540028, 4264.616184543406, 4424.292113261863, 4443.688941774045, 4482.372467854503, 4913.434954980152, 4050.9594904051173, 4134.763396882498, 4224.9155016899485, 4245.532991370947, 4268.210381079511, 1333.5066025570602, 1365.7200273943818, 1367.3778430813957, 1376.6420730610114, 1384.3147641917114, 820.9368867316839, 839.8824164616958, 848.7962888906618, 924.5007695844304, 997.121198537689, 5485.725713714378, 5569.610127291132, 5669.291338582677, 5857.238558987305, 5870.589058765845, 825.0, 893.3166127912152, 950.254050570299, 973.3186769261546, 977.6089564174387, 3561.269939662363, 3615.4215325547784, 3641.1625326175126, 3721.5534135903863, 3760.2855457463543, 10254.53854576546, 10687.41219232934, 10727.356358618508, 10743.301685390581, 10795.244332896622, 10649.094826939798, 10670.413127278074, 10680.092192163753, 10681.786364272672, 10687.519061642244, 7610.086789585285, 7975.322097621651, 7991.68033278674, 8127.065387480516, 8143.552104634184, 5613.382527922007, 5745.0, 5759.0, 5774.2782152230975, 5809.9419005809405, 9263.53682315868, 9534.952325238606, 9613.182879455324, 9634.566444509874, 9801.362911410735, 8813.647454101763, 9104.863427048733, 9535.141837234682, 9900.75248118774, 9949.801003980025, 7772.378209743094, 8143.226393492609, 8150.388720845842, 8152.2662960333855, 8262.297704695167, 8234.958825206075, 8473.872891906749, 8526.445781024213, 8544.35917306217, 8548.273396761097, 7267.0, 7344.632768361667, 7420.740274090381, 7473.738419155304, 7502.924970750222, 7145.1068616422945, 7163.820904477429, 7318.780436586911, 7505.061867266591, 7607.847843042998, 6368.522360822864, 6435.195600549931, 6445.323241059621, 6683.43190828785, 6684.83287917806, 4868.2210846264425, 4938.259261110718, 4939.086269040239, 5001.324821149098, 5021.07110184617, 4804.468715494039, 4912.557869791736, 5009.398872135367, 5068.974655126701, 5087.618428617942], "value": 4546.281728327206, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.52971693638193, 356.2643141911952, 358.0940221240263, 359.1309032142216, 361.34596380551204, 5297.0, 5307.601929855262, 5348.946510534894, 5384.030874442598, 5438.7824487020525, 5255.684658920468, 5257.185136303879, 5261.39493958194, 5262.81580144695, 5272.551833094191, 4003.579624139467, 4215.409842622035, 4219.620234178923, 4224.450821393222, 4239.660827133822, 3756.699464042884, 4140.420341152226, 4193.077522944947, 4196.9580304197025, 4212.726172798773, 4154.293770059097, 4155.667546596265, 4161.708680392374, 4163.916721665565, 4179.770112643803, 4175.5824417558, 4175.603317684815, 4177.770222637754, 4185.22573323936, 4197.790110494463, 3525.7179425645886, 3619.3123306571665, 3662.047867554428, 3720.9069773255887, 3776.71425859504, 5095.0, 5109.0, 5114.948850511521, 5115.20714289282, 5125.846224613268, 4759.381280433521, 4768.57082862544, 4774.474807771142, 4775.570198682135, 4781.0, 5385.67685938841, 5461.0, 5492.697901615409, 5500.092484740013, 5508.173773933902, 4119.505659320871, 4128.380742888561, 4129.97935010326, 4134.813933373005, 4154.273002224629, 5511.862203444906, 5594.328680558318, 5690.943090569124, 5772.5670574707065, 5777.740001699892, 4173.749575025508, 4176.812043458051, 4186.35111557709, 4200.558941311179, 4202.621764041251, 4251.6386107180615, 4277.657787377002, 4290.89272768177, 4298.892527686833, 4304.49342730042, 4713.31656909753, 4751.596114330251, 4812.903741925142, 4834.468208497063, 4852.951470485321, 5517.372375149341, 5533.474319939599, 5549.639273447213, 5557.527610153183, 5598.720063996865, 1386.8058471813954, 1394.7559177144162, 1395.2838009248478, 1401.7757158854533, 1405.6927057836106, 960.2893858544627, 1011.8735158105237, 1013.8644717915981, 1020.1991436722137, 1042.3485321673954, 5141.38303403594, 5189.896202075937, 5201.219817027476, 5211.42674305826, 5245.659032162897, 5419.349678038582, 5422.834090670524, 5423.0, 5479.945200548023, 5486.204500347428, 4961.404631444249, 5107.821226257063, 5196.298499702491, 5209.817656382009, 5214.60890433219, 2880.4527139843362, 2888.797784155089, 2896.956545651817, 2898.608667839449, 2900.463414268367, 5530.281063461724, 5531.897878806028, 5546.69493177871, 5548.944510554924, 5572.804951826748, 5397.325334333208, 5482.369527504388, 5528.917066244009, 5545.195946587723, 5573.191887176336, 5450.628976395202, 5468.812475010028, 5478.369987451414, 5482.506574408322, 5515.338159420815, 5321.228421878728, 5441.619086663895, 5491.2312276282155, 5518.19986102021, 5561.3882472927135, 5383.16560933056, 5385.838424847261, 5396.379416367168, 5406.486383793534, 5439.3200849893765, 5457.672539647634, 5627.465390787868, 5636.718164091861, 5675.375708671961, 5692.231548741032, 4227.894302642459, 4255.29787585045, 4287.37833014205, 4298.9570104298555, 4307.160103779858, 5677.716114194356, 5682.431756824284, 5801.593888427769, 5811.331696854747, 5818.2436283282905, 5502.642328248651, 5504.80733174353, 5521.095222148352, 5532.612717109763, 5563.13498548256, 5471.50756431923, 5502.9174562380795, 5509.889802203853, 5553.9725150847225, 5584.190292407659, 5234.738263086907, 5488.341399032141, 5502.8349149525575, 5504.559635229252, 5513.255710479034, 5511.3937466879415, 5530.391656917816, 5536.889262214814, 5552.555795536428, 5556.888862222814, 5414.972925135349, 5448.972755136199, 5455.936092461931, 5462.481064298885, 5466.835994920159], "value": 4223.326770886717, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.2008871040249, 806.9959650201748, 840.9873851892223, 863.9784005399861, 905.6875377994594, 13603.18380897147, 13680.384382702778, 13710.177389356646, 13733.176009439416, 14326.641833954156, 13735.313234338293, 13833.17000979942, 13846.30768461578, 13847.0, 13866.514671986482, 697.4629535257849, 733.9412846972256, 794.6106407860165, 861.5692153923038, 865.472062042157, 846.2045677063571, 846.2341580869293, 848.1306660672798, 848.2704873808519, 850.6002178975903, 745.6420917959383, 913.0, 913.1918252346687, 914.2229105260509, 916.9816603667956, 762.367235194787, 840.3907167303687, 872.2150064941571, 884.9955750221208, 888.6223355074068, 653.5425202358368, 653.7646447278976, 653.8398092467328, 653.9182602174728, 654.1986067067851, 14860.256987150598, 14907.403703851833, 14924.0, 14972.251387430693, 14975.625609359744, 13365.198088114745, 13616.93191534036, 13806.792898106536, 14007.439702411993, 14062.929685351508, 12457.93771031148, 12481.75036499265, 12541.811872821914, 12629.115961882671, 12711.237325760392, 4036.374361973899, 4126.7523948563185, 4143.606357396073, 4224.788760561991, 4229.450171477688, 63938.68030659863, 64086.0, 65066.67466662684, 65395.0, 65437.67281163564, 10767.138628909825, 10837.67486975392, 10843.566257349617, 11043.944780276048, 11150.0, 21456.570868582854, 21473.46316342104, 21475.355739327846, 21490.355289341343, 21498.677519837216, 8049.678012879536, 8081.919180808117, 8155.632996515171, 8364.37267204962, 8493.235608795238, 4464.374987501752, 4490.236659767847, 4511.571400716926, 4610.861674149781, 4612.538746125428, 3262.9021129366156, 3345.832708364572, 3350.2964377481003, 3353.1784712745534, 3360.630330663625, 602.0758136260819, 603.2459425717852, 612.8039027511243, 616.5375968023982, 626.0171530696763, 640.5420124610926, 656.1601150527333, 661.497262080822, 698.9615571143535, 725.7568714480708, 9193.448393096436, 9489.240860731263, 9528.380655257386, 9755.8783884978, 9986.450745208938, 615.5198944823045, 667.6227931218846, 679.7756740275697, 732.5494820685241, 760.8021914302321, 4508.842190523316, 4916.508349165055, 4932.654714169974, 5022.360847871563, 5096.286519887219, 77511.0, 85552.14447855442, 87393.56303218444, 88274.0, 90589.0, 75271.0, 75936.0, 76232.0, 77186.99999999888, 77245.0, 71723.0, 72519.27480725336, 72819.0, 73296.26703733, 75822.24177758262, 8482.279006284289, 8724.520151391735, 8865.955670221865, 8931.687390941286, 8972.41679290844, 46590.534094659975, 47036.52963470321, 47848.760756195996, 48883.26675099805, 49055.50944490652, 62024.0, 62177.37822621716, 65195.67402162959, 65226.0, 66572.66713666401, 11205.327680339205, 11507.884921150682, 11654.941725291319, 11718.88281117212, 11903.583374581847, 13314.866851331362, 13408.731825363244, 13566.075324921481, 13572.321383930961, 13722.794158087836, 12609.30648814324, 12642.2414655121, 12764.106512544404, 12861.935690321488, 12981.0, 11961.521539138337, 11986.880131198577, 12060.577879774166, 12062.215955962834, 12367.257964522158, 11943.10426718017, 11952.880471195176, 12057.51769929228, 12204.633860984184, 12426.875731242571, 10558.155347572329, 10719.356838589709, 10742.570297188338, 11067.786442711329, 11438.94280528592, 10600.1519878408, 10754.247202695737, 10822.783544329226, 10927.726806829893, 10952.726181845517], "value": 7177.341214424517, "unit": "score"}], "name": "dromaeo_css", "value": 7271.136044275381, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 111.0, 110.0, 112.0, 112.0, 111.0, 112.0, 111.0, 110.0], "value": 110.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 122.0, 121.0, 173.0, 128.0, 124.0, 123.0, 120.0, 167.0, 125.0], "value": 135.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 160.0, 160.0, 160.0, 160.0, 161.0], "value": 160.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 113.0, 75.0, 76.0, 75.0, 75.0, 102.0, 74.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 115.0, 82.0, 82.0, 82.0, 109.0, 82.0, 82.0, 110.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 154.0, 171.0, 146.0], "value": 149.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 85.0, 85.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 50.0, 51.0, 51.0, 51.0, 51.0, 51.0, 51.0, 52.0], "value": 51.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 59.0, 61.0, 60.0, 60.0, 60.0, 65.0, 60.0], "value": 60.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 74.0, 81.0, 74.0, 75.0, 76.0, 77.0, 75.0], "value": 75.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 132.0, 128.0, 129.0, 134.0, 129.0, 130.0, 132.0, 174.0, 134.0], "value": 134.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 161.0, 154.0, 152.0, 158.0, 156.0, 155.0, 159.0, 158.0, 159.0], "value": 156.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 65.0, 63.0, 62.0, 71.0, 61.0, 73.0, 61.0, 60.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1471.8, "alertThreshold": 2.0}]} 03:50:43 INFO - Return code: 0 03:50:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:50:43 ERROR - # TBPL SUCCESS # 03:50:43 INFO - Running post-action listener: _resource_record_post_action 03:50:43 INFO - [mozharness: 2016-11-16 11:50:43.987738Z] Finished run-tests step (success) 03:50:43 INFO - Running post-run listener: _resource_record_post_run 03:50:44 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 266240; Write bytes: 357703680; Read time: 24; Write time: 434908 03:50:44 INFO - TinderboxPrint: CPU usage
13.0% 03:50:44 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 24 03:50:44 INFO - TinderboxPrint: I/O write bytes / time
357,703,680 / 434,908 03:50:44 INFO - TinderboxPrint: CPU idle
8,288.4 (87.0%) 03:50:44 INFO - TinderboxPrint: CPU user
1,191.8 (12.5%) 03:50:44 INFO - TinderboxPrint: Swap in / out
0 / 0 03:50:44 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113672192; Read time: 0; Write time: 172472 03:50:44 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 262144; Write bytes: 243417088; Read time: 12; Write time: 262436 03:50:44 INFO - Running post-run listener: _upload_blobber_files 03:50:44 INFO - Blob upload gear active. 03:50:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:50:44 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 03:50:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:50:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:50:45 INFO - (blobuploader) - INFO - Open directory for files ... 03:50:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:50:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:50:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:48 INFO - (blobuploader) - INFO - Done attempting. 03:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:50:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:48 INFO - (blobuploader) - INFO - Done attempting. 03:50:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:50:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:50:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:50:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:50:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:50:49 INFO - (blobuploader) - INFO - Done attempting. 03:50:49 INFO - (blobuploader) - INFO - Iteration through files over. 03:50:49 INFO - Return code: 0 03:50:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:50:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:50:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/618ea8614c2ab8e10de2130af694b4c1475f0f179e122b95470ee62ecaf51ccf6d6f36eecd1e4627f40786fdbfba4291a636b6f108f56143af76489afad84620", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/272b6755fdfded6a56e77b819e27ce3b09e21507001794eaabd15cf505dbd0a261c4c2d2289678cf3b5640f446eea6ef3c345e616036459879d68933fbf259da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2a7ea73107070b421aa414758244eea9be9c18d22c9bb0ce1bbf6d758c40cc08da1ae79941ffb6019517b500efc2a523b0ed6ce782d16bfc8d827bf9aaa8a8b"} 03:50:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:50:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:50:49 INFO - Contents: 03:50:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/618ea8614c2ab8e10de2130af694b4c1475f0f179e122b95470ee62ecaf51ccf6d6f36eecd1e4627f40786fdbfba4291a636b6f108f56143af76489afad84620", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/272b6755fdfded6a56e77b819e27ce3b09e21507001794eaabd15cf505dbd0a261c4c2d2289678cf3b5640f446eea6ef3c345e616036459879d68933fbf259da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2a7ea73107070b421aa414758244eea9be9c18d22c9bb0ce1bbf6d758c40cc08da1ae79941ffb6019517b500efc2a523b0ed6ce782d16bfc8d827bf9aaa8a8b"} 03:50:49 INFO - Running post-run listener: copy_logs_to_upload_dir 03:50:49 INFO - Copying logs to upload dir... 03:50:49 INFO - mkdir: /builds/slave/test/build/upload/logs 03:50:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.987966 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-11-16 03:50:49.585279) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 03:50:49.588805) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/618ea8614c2ab8e10de2130af694b4c1475f0f179e122b95470ee62ecaf51ccf6d6f36eecd1e4627f40786fdbfba4291a636b6f108f56143af76489afad84620", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/272b6755fdfded6a56e77b819e27ce3b09e21507001794eaabd15cf505dbd0a261c4c2d2289678cf3b5640f446eea6ef3c345e616036459879d68933fbf259da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2a7ea73107070b421aa414758244eea9be9c18d22c9bb0ce1bbf6d758c40cc08da1ae79941ffb6019517b500efc2a523b0ed6ce782d16bfc8d827bf9aaa8a8b"} build_url:https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011499 build_url: 'https://queue.taskcluster.net/v1/task/eU9nYSbqQFaILDD4pzAyqA/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/618ea8614c2ab8e10de2130af694b4c1475f0f179e122b95470ee62ecaf51ccf6d6f36eecd1e4627f40786fdbfba4291a636b6f108f56143af76489afad84620", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/272b6755fdfded6a56e77b819e27ce3b09e21507001794eaabd15cf505dbd0a261c4c2d2289678cf3b5640f446eea6ef3c345e616036459879d68933fbf259da", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2a7ea73107070b421aa414758244eea9be9c18d22c9bb0ce1bbf6d758c40cc08da1ae79941ffb6019517b500efc2a523b0ed6ce782d16bfc8d827bf9aaa8a8b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-16 03:50:49.618447) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 03:50:49.618885) ========= 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=edae0fb5fee9fb758e8af6d3000002a4-1479295809.48541-1614105984 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004415 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-16 03:50:49.702897) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 03:50:49.703437) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-16 03:50:49.703998) ========= ========= Total master_lag: 0.19 =========