builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1480522585.89 results: success (0) buildid: 20161130065243 builduid: 72850d7aa1464d5cbdf1c181a09d5ad5 revision: 741a720c98cdb92c229376be0badbf036f653bff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:25.890164) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:25.890687) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:25.890970) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:25.905726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:25.906103) ========= 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=db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-30 08:16:26-- 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-30 08:16:26 (42.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107275 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:26.027907) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:26.028268) ========= 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=db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020639 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:26.078175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:26.078615) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 741a720c98cdb92c229376be0badbf036f653bff --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 741a720c98cdb92c229376be0badbf036f653bff --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=db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-30 08:16:26,817 truncating revision to first 12 chars 2016-11-30 08:16:26,817 Setting DEBUG logging. 2016-11-30 08:16:26,817 attempt 1/10 2016-11-30 08:16:26,817 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/741a720c98cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-30 08:16:27,126 unpacking tar archive at: mozilla-central-741a720c98cd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.679692 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:26.772906) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:26.773289) ========= script_repo_revision: 741a720c98cdb92c229376be0badbf036f653bff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:26.773703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:26.773988) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-30 08:16:26.784011) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-30 08:16:26.784503) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] 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=db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:16:27 INFO - MultiFileLogger online at 20161130 08:16:27 in /builds/slave/test 08:16:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:16:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:16:27 INFO - {'append_to_log': False, 08:16:27 INFO - 'base_work_dir': '/builds/slave/test', 08:16:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:16:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:16:27 INFO - 'branch': 'Firefox-Non-PGO', 08:16:27 INFO - 'buildbot_json_path': 'buildprops.json', 08:16:27 INFO - 'config_files': ('talos/linux_config.py',), 08:16:27 INFO - 'default_actions': ('clobber', 08:16:27 INFO - 'read-buildbot-config', 08:16:27 INFO - 'download-and-extract', 08:16:27 INFO - 'populate-webroot', 08:16:27 INFO - 'create-virtualenv', 08:16:27 INFO - 'install', 08:16:27 INFO - 'run-tests'), 08:16:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:16:27 INFO - 'download_minidump_stackwalk': True, 08:16:27 INFO - 'download_symbols': 'ondemand', 08:16:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:16:27 INFO - 'tooltool.py': '/tools/tooltool.py', 08:16:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:16:27 INFO - '/tools/misc-python/virtualenv.py')}, 08:16:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:16:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:16:27 INFO - 'installer_path': 'installer.exe', 08:16:27 INFO - 'log_level': 'info', 08:16:27 INFO - 'log_name': 'talos', 08:16:27 INFO - 'log_to_console': True, 08:16:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:16:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:16:27 INFO - 'opt_config_files': (), 08:16:27 INFO - 'pip_index': False, 08:16:27 INFO - 'sps_profile': False, 08:16:27 INFO - 'sps_profile_interval': 0, 08:16:27 INFO - 'suite': 'dromaeojs', 08:16:27 INFO - 'system_bits': '32', 08:16:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:16:27 INFO - 'title': 'talos-linux64-ix-049', 08:16:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:16:27 INFO - 'use_talos_json': True, 08:16:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:16:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:16:27 INFO - 'work_dir': 'build'} 08:16:27 INFO - [mozharness: 2016-11-30 16:16:27.627706Z] Running clobber step. 08:16:27 INFO - Running pre-action listener: _resource_record_pre_action 08:16:27 INFO - Running main action method: clobber 08:16:27 INFO - rmtree: /builds/slave/test/build 08:16:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:16:28 INFO - Running post-action listener: _resource_record_post_action 08:16:28 INFO - [mozharness: 2016-11-30 16:16:28.092290Z] Finished clobber step (success) 08:16:28 INFO - [mozharness: 2016-11-30 16:16:28.092389Z] Running read-buildbot-config step. 08:16:28 INFO - Running pre-action listener: _resource_record_pre_action 08:16:28 INFO - Running main action method: read_buildbot_config 08:16:28 INFO - Using buildbot properties: 08:16:28 INFO - { 08:16:28 INFO - "project": "", 08:16:28 INFO - "product": "firefox", 08:16:28 INFO - "script_repo_revision": "production", 08:16:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:16:28 INFO - "repository": "", 08:16:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:16:28 INFO - "buildid": "20161130065243", 08:16:28 INFO - "pgo_build": "False", 08:16:28 INFO - "basedir": "/builds/slave/test", 08:16:28 INFO - "buildnumber": 843, 08:16:28 INFO - "slavename": "talos-linux64-ix-049", 08:16:28 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:16:28 INFO - "platform": "ubuntu64_hw", 08:16:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 08:16:28 INFO - "branch": "mozilla-central", 08:16:28 INFO - "repo_path": "mozilla-central", 08:16:28 INFO - "revision": "741a720c98cdb92c229376be0badbf036f653bff", 08:16:28 INFO - "stage_platform": "linux64", 08:16:28 INFO - "builduid": "72850d7aa1464d5cbdf1c181a09d5ad5", 08:16:28 INFO - "slavebuilddir": "test" 08:16:28 INFO - } 08:16:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 08:16:28 INFO - Running post-action listener: _resource_record_post_action 08:16:28 INFO - [mozharness: 2016-11-30 16:16:28.094803Z] Finished read-buildbot-config step (success) 08:16:28 INFO - [mozharness: 2016-11-30 16:16:28.094891Z] Running download-and-extract step. 08:16:28 INFO - Running pre-action listener: _resource_record_pre_action 08:16:28 INFO - Running main action method: download_and_extract 08:16:28 INFO - mkdir: /builds/slave/test/build/tests 08:16:28 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')]} 08:16:28 INFO - trying https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:16:28 INFO - Downloading https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:16:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:16:28 INFO - Downloaded 1361 bytes. 08:16:28 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 08:16:28 INFO - Using the following test package requirements: 08:16:28 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:16:28 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:28 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:16:28 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:28 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:16:28 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:28 INFO - u'jsshell-linux-x86_64.zip'], 08:16:28 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:28 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:16:28 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 08:16:28 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:28 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:16:28 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:28 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:16:28 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:28 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:16:28 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 08:16:28 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:16:28 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:16:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:16:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:16:28 INFO - Fetch https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:16:29 INFO - Http code: 200 08:16:29 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 08:16:29 INFO - x-amz-cf-id: a_lK5P91oZUWOakyCFEF-J8AN9qeIjykSxFHdEdvezOgRN1xs9UKAA== 08:16:29 INFO - x-amz-version-id: 9ldqZbca.0BKiqB9ZZ3XkKDxSR4.R82f 08:16:29 INFO - Expected file size: 20221427 08:16:29 INFO - Obtained file size: 20221427 08:16:33 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:16:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 08:16:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:16:33 INFO - Fetch https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:16:33 INFO - Http code: 200 08:16:33 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 08:16:33 INFO - x-amz-cf-id: i01M1CasGRBxf2wg6NBRvVDOi8Vf8KZKdqHL3-9TAkuOvnmJImNdjg== 08:16:33 INFO - x-amz-version-id: 9ldqZbca.0BKiqB9ZZ3XkKDxSR4.R82f 08:16:34 INFO - Expected file size: 20221427 08:16:34 INFO - Obtained file size: 20221427 08:16:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 08:16:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:16:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:16:39 INFO - Http code: 200 08:16:39 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 08:16:39 INFO - x-amz-cf-id: dzZHg2fEYCDnOjTwGPinrWP73tGX2PLxj1XsvXQVB-2AZyh1N_J2Og== 08:16:39 INFO - x-amz-version-id: V8d7wW1ZKSkBGzrDVfaG8k.FAr9n.AYc 08:16:39 INFO - Expected file size: 14409702 08:16:39 INFO - Obtained file size: 14409702 08:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:39 INFO - trying https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:16:39 INFO - Downloading https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:16:40 INFO - Downloaded 55666999 bytes. 08:16:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:16:40 INFO - mkdir: /builds/slave/test/properties 08:16:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:16:40 INFO - Writing to file /builds/slave/test/properties/build_url 08:16:40 INFO - Contents: 08:16:40 INFO - build_url:https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 08:16:41 INFO - Running post-action listener: _resource_record_post_action 08:16:41 INFO - Running post-action listener: set_extra_try_arguments 08:16:41 INFO - [mozharness: 2016-11-30 16:16:41.398407Z] Finished download-and-extract step (success) 08:16:41 INFO - [mozharness: 2016-11-30 16:16:41.398632Z] Running populate-webroot step. 08:16:41 INFO - Running pre-action listener: _resource_record_pre_action 08:16:41 INFO - Running main action method: populate_webroot 08:16:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:16:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:16:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:16:41 INFO - '--tppagecycles', 08:16:41 INFO - '7'], 08:16:41 INFO - 'tests': ['tsvgm']}}, 08:16:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:16:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:16:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:16:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:16:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:16:41 INFO - 'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:16:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:16:41 INFO - 'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['damp', 'tps']}, 08:16:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:16:41 INFO - 'tests': ['damp', 'tps']}, 08:16:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['dromaeo_dom']}, 08:16:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:16:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['basic_compositor_video']}, 08:16:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:16:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['a11yr', 08:16:41 INFO - 'ts_paint', 08:16:41 INFO - 'tpaint', 08:16:41 INFO - 'sessionrestore', 08:16:41 INFO - 'sessionrestore_no_auto_restore', 08:16:41 INFO - 'tabpaint']}, 08:16:41 INFO - 'other-e10s': {'tests': ['a11yr', 08:16:41 INFO - 'ts_paint', 08:16:41 INFO - 'tpaint', 08:16:41 INFO - 'sessionrestore', 08:16:41 INFO - 'sessionrestore_no_auto_restore', 08:16:41 INFO - 'tabpaint']}, 08:16:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:16:41 INFO - 'ts_paint', 08:16:41 INFO - 'tpaint', 08:16:41 INFO - 'sessionrestore', 08:16:41 INFO - 'sessionrestore_no_auto_restore', 08:16:41 INFO - 'tabpaint']}, 08:16:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:16:41 INFO - 'ts_paint', 08:16:41 INFO - 'tpaint', 08:16:41 INFO - 'sessionrestore', 08:16:41 INFO - 'sessionrestore_no_auto_restore', 08:16:41 INFO - 'tabpaint']}, 08:16:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['a11yr', 08:16:41 INFO - 'ts_paint', 08:16:41 INFO - 'tpaint', 08:16:41 INFO - 'sessionrestore', 08:16:41 INFO - 'sessionrestore_no_auto_restore', 08:16:41 INFO - 'tabpaint']}, 08:16:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['a11yr', 08:16:41 INFO - 'ts_paint', 08:16:41 INFO - 'tpaint', 08:16:41 INFO - 'sessionrestore', 08:16:41 INFO - 'sessionrestore_no_auto_restore', 08:16:41 INFO - 'tabpaint']}, 08:16:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['tsvgx', 08:16:41 INFO - 'tsvgr_opacity', 08:16:41 INFO - 'tart', 08:16:41 INFO - 'tscrollx', 08:16:41 INFO - 'cart', 08:16:41 INFO - 'tsvg_static']}, 08:16:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:16:41 INFO - 'tsvgr_opacity', 08:16:41 INFO - 'tart', 08:16:41 INFO - 'tscrollx', 08:16:41 INFO - 'cart', 08:16:41 INFO - 'tsvg_static']}, 08:16:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:16:41 INFO - 'talos_options': ['--disable-e10s'], 08:16:41 INFO - 'tests': ['tp5o']}, 08:16:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:16:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:16:41 INFO - 'talos_options': ['--disable-e10s', 08:16:41 INFO - '--xperf_path', 08:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:41 INFO - 'tests': ['tp5n']}, 08:16:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:16:41 INFO - 'talos_options': ['--xperf_path', 08:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:16:41 INFO - 'tests': ['tp5n']}}, 08:16:41 INFO - 'talos.zip': {'path': '', 08:16:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:16:41 INFO - Running post-action listener: _resource_record_post_action 08:16:41 INFO - [mozharness: 2016-11-30 16:16:41.420689Z] Finished populate-webroot step (success) 08:16:41 INFO - [mozharness: 2016-11-30 16:16:41.420776Z] Running create-virtualenv step. 08:16:41 INFO - Running pre-action listener: _resource_record_pre_action 08:16:41 INFO - Running main action method: create_virtualenv 08:16:41 INFO - Creating virtualenv /builds/slave/test/build/venv 08:16:41 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 08:16:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:16:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:16:41 INFO - Using real prefix '/usr' 08:16:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:16:42 INFO - Installing distribute.............................................................................................................................................................................................done. 08:16:43 INFO - Installing pip.................done. 08:16:43 INFO - Return code: 0 08:16:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:16:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:16:44 INFO - Reading from file tmpfile_stdout 08:16:44 INFO - Output received: 08:16:44 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) 08:16:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:16:44 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')]} 08:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:44 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')]} 08:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:44 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 0x7fb4f94fae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', '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 08:16:44 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 08:16:44 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 08:16:44 INFO - Using env: {'DISPLAY': ':0', 08:16:44 INFO - 'HOME': '/home/cltbld', 08:16:44 INFO - 'LANG': 'en_US.UTF-8', 08:16:44 INFO - 'LANGUAGE': 'en_US:en', 08:16:44 INFO - 'LOGNAME': 'cltbld', 08:16:44 INFO - 'MAIL': '/var/mail/cltbld', 08:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:44 INFO - 'MOZ_NO_REMOTE': '1', 08:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:44 INFO - 'NO_EM_RESTART': '1', 08:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:44 INFO - 'PWD': '/builds/slave/test', 08:16:44 INFO - 'SHELL': '/bin/bash', 08:16:44 INFO - 'SHLVL': '1', 08:16:44 INFO - 'TERM': 'linux', 08:16:44 INFO - 'TMOUT': '86400', 08:16:44 INFO - 'USER': 'cltbld', 08:16:44 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:44 INFO - '_': '/tools/buildbot/bin/python'} 08:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:44 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 08:16:44 INFO - Cleaning up... 08:16:44 INFO - Return code: 0 08:16:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:16:44 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')]} 08:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:44 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')]} 08:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:44 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 0x7fb4f94fae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', '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 08:16:44 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 08:16:44 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 08:16:44 INFO - Using env: {'DISPLAY': ':0', 08:16:44 INFO - 'HOME': '/home/cltbld', 08:16:44 INFO - 'LANG': 'en_US.UTF-8', 08:16:44 INFO - 'LANGUAGE': 'en_US:en', 08:16:44 INFO - 'LOGNAME': 'cltbld', 08:16:44 INFO - 'MAIL': '/var/mail/cltbld', 08:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:44 INFO - 'MOZ_NO_REMOTE': '1', 08:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:44 INFO - 'NO_EM_RESTART': '1', 08:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:44 INFO - 'PWD': '/builds/slave/test', 08:16:44 INFO - 'SHELL': '/bin/bash', 08:16:44 INFO - 'SHLVL': '1', 08:16:44 INFO - 'TERM': 'linux', 08:16:44 INFO - 'TMOUT': '86400', 08:16:44 INFO - 'USER': 'cltbld', 08:16:44 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:44 INFO - '_': '/tools/buildbot/bin/python'} 08:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:44 INFO - Downloading/unpacking psutil>=3.1.1 08:16:44 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 08:16:44 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 08:16:44 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 08:16:44 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 08:16:44 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 08:16:44 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 08:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:16:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:46 INFO - Installing collected packages: psutil 08:16:46 INFO - Running setup.py install for psutil 08:16:46 INFO - building 'psutil._psutil_linux' extension 08:16:46 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 08:16:46 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 08:16:47 INFO - building 'psutil._psutil_posix' extension 08:16:47 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 08:16:47 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 08:16:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:16:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:16:47 INFO - Successfully installed psutil 08:16:47 INFO - Cleaning up... 08:16:47 INFO - Return code: 0 08:16:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:16:47 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')]} 08:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:47 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')]} 08:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:47 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 0x7fb4f94fae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', '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 08:16:47 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 08:16:47 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 08:16:47 INFO - Using env: {'DISPLAY': ':0', 08:16:47 INFO - 'HOME': '/home/cltbld', 08:16:47 INFO - 'LANG': 'en_US.UTF-8', 08:16:47 INFO - 'LANGUAGE': 'en_US:en', 08:16:47 INFO - 'LOGNAME': 'cltbld', 08:16:47 INFO - 'MAIL': '/var/mail/cltbld', 08:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:47 INFO - 'MOZ_NO_REMOTE': '1', 08:16:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:47 INFO - 'NO_EM_RESTART': '1', 08:16:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:47 INFO - 'PWD': '/builds/slave/test', 08:16:47 INFO - 'SHELL': '/bin/bash', 08:16:47 INFO - 'SHLVL': '1', 08:16:47 INFO - 'TERM': 'linux', 08:16:47 INFO - 'TMOUT': '86400', 08:16:47 INFO - 'USER': 'cltbld', 08:16:47 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:47 INFO - '_': '/tools/buildbot/bin/python'} 08:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:16:47 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 08:16:47 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 08:16:47 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 08:16:47 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 08:16:47 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 08:16:47 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 08:16:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:16:49 INFO - Installing collected packages: mozsystemmonitor 08:16:49 INFO - Running setup.py install for mozsystemmonitor 08:16:49 INFO - Successfully installed mozsystemmonitor 08:16:49 INFO - Cleaning up... 08:16:49 INFO - Return code: 0 08:16:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:16: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')]} 08:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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')]} 08:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f94fae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', '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 08:16: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==2.5.1'] in /builds/slave/test/build 08:16: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==2.5.1 08:16:49 INFO - Using env: {'DISPLAY': ':0', 08:16:49 INFO - 'HOME': '/home/cltbld', 08:16:49 INFO - 'LANG': 'en_US.UTF-8', 08:16:49 INFO - 'LANGUAGE': 'en_US:en', 08:16:49 INFO - 'LOGNAME': 'cltbld', 08:16:49 INFO - 'MAIL': '/var/mail/cltbld', 08:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:49 INFO - 'MOZ_NO_REMOTE': '1', 08:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:49 INFO - 'NO_EM_RESTART': '1', 08:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:49 INFO - 'PWD': '/builds/slave/test', 08:16:49 INFO - 'SHELL': '/bin/bash', 08:16:49 INFO - 'SHLVL': '1', 08:16:49 INFO - 'TERM': 'linux', 08:16:49 INFO - 'TMOUT': '86400', 08:16:49 INFO - 'USER': 'cltbld', 08:16:49 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:49 INFO - '_': '/tools/buildbot/bin/python'} 08:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:16:49 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 08:16:49 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 08:16:49 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 08:16:49 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 08:16:49 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 08:16:49 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 08:16:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:16:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:16:52 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 08:16:52 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 08:16:52 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 08:16:52 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 08:16:52 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 08:16:52 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 08:16:52 INFO - Downloading functools32-3.2.3-2.tar.gz 08:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:16:52 INFO - warning: no files found matching '*.txt' 08:16:52 INFO - no previously-included directories found matching 'build' 08:16:52 INFO - no previously-included directories found matching 'dist' 08:16:52 INFO - no previously-included directories found matching '.git*' 08:16:52 INFO - Installing collected packages: jsonschema, functools32 08:16:52 INFO - Running setup.py install for functools32 08:16:52 INFO - warning: no files found matching '*.txt' 08:16:52 INFO - no previously-included directories found matching 'build' 08:16:52 INFO - no previously-included directories found matching 'dist' 08:16:52 INFO - no previously-included directories found matching '.git*' 08:16:52 INFO - Successfully installed jsonschema functools32 08:16:52 INFO - Cleaning up... 08:16:52 INFO - Return code: 0 08:16:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:16:52 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')]} 08:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:52 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')]} 08:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:52 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 0x7fb4f94fae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', '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 08:16:52 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 08:16:52 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 08:16:52 INFO - Using env: {'DISPLAY': ':0', 08:16:52 INFO - 'HOME': '/home/cltbld', 08:16:52 INFO - 'LANG': 'en_US.UTF-8', 08:16:52 INFO - 'LANGUAGE': 'en_US:en', 08:16:52 INFO - 'LOGNAME': 'cltbld', 08:16:52 INFO - 'MAIL': '/var/mail/cltbld', 08:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:52 INFO - 'MOZ_NO_REMOTE': '1', 08:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:52 INFO - 'NO_EM_RESTART': '1', 08:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:52 INFO - 'PWD': '/builds/slave/test', 08:16:52 INFO - 'SHELL': '/bin/bash', 08:16:52 INFO - 'SHLVL': '1', 08:16:52 INFO - 'TERM': 'linux', 08:16:52 INFO - 'TMOUT': '86400', 08:16:52 INFO - 'USER': 'cltbld', 08:16:52 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:52 INFO - '_': '/tools/buildbot/bin/python'} 08:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:16:52 INFO - Cleaning up... 08:16:52 INFO - Return code: 0 08:16:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:16:52 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')]} 08:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:52 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')]} 08:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:52 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 0x7fb4f94fae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', '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 08:16:52 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 08:16:52 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 08:16:52 INFO - Using env: {'DISPLAY': ':0', 08:16:52 INFO - 'HOME': '/home/cltbld', 08:16:52 INFO - 'LANG': 'en_US.UTF-8', 08:16:52 INFO - 'LANGUAGE': 'en_US:en', 08:16:52 INFO - 'LOGNAME': 'cltbld', 08:16:52 INFO - 'MAIL': '/var/mail/cltbld', 08:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:52 INFO - 'MOZ_NO_REMOTE': '1', 08:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:52 INFO - 'NO_EM_RESTART': '1', 08:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:52 INFO - 'PWD': '/builds/slave/test', 08:16:52 INFO - 'SHELL': '/bin/bash', 08:16:52 INFO - 'SHLVL': '1', 08:16:52 INFO - 'TERM': 'linux', 08:16:52 INFO - 'TMOUT': '86400', 08:16:52 INFO - 'USER': 'cltbld', 08:16:52 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:52 INFO - '_': '/tools/buildbot/bin/python'} 08:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:53 INFO - Downloading/unpacking blobuploader==1.2.4 08:16:53 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 08:16:53 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 08:16:53 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 08:16:53 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 08:16:53 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 08:16:53 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 08:16:55 INFO - Downloading blobuploader-1.2.4.tar.gz 08:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:16:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:16:55 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 08:16:55 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 08:16:55 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 08:16:55 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 08:16:55 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 08:16:55 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 08:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:16:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:16:55 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 08:16:55 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 08:16:55 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 08:16:55 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 08:16:55 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 08:16:55 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 08:16:55 INFO - Downloading docopt-0.6.1.tar.gz 08:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:16:55 INFO - Installing collected packages: blobuploader, requests, docopt 08:16:55 INFO - Running setup.py install for blobuploader 08:16:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:16:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:16:55 INFO - Running setup.py install for requests 08:16:56 INFO - Running setup.py install for docopt 08:16:56 INFO - Successfully installed blobuploader requests docopt 08:16:56 INFO - Cleaning up... 08:16:56 INFO - Return code: 0 08:16:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:56 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 0x7fb4f94fae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', '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 08:16:56 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 08:16:56 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 08:16:56 INFO - Using env: {'DISPLAY': ':0', 08:16:56 INFO - 'HOME': '/home/cltbld', 08:16:56 INFO - 'LANG': 'en_US.UTF-8', 08:16:56 INFO - 'LANGUAGE': 'en_US:en', 08:16:56 INFO - 'LOGNAME': 'cltbld', 08:16:56 INFO - 'MAIL': '/var/mail/cltbld', 08:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:56 INFO - 'MOZ_NO_REMOTE': '1', 08:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:56 INFO - 'NO_EM_RESTART': '1', 08:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:56 INFO - 'PWD': '/builds/slave/test', 08:16:56 INFO - 'SHELL': '/bin/bash', 08:16:56 INFO - 'SHLVL': '1', 08:16:56 INFO - 'TERM': 'linux', 08:16:56 INFO - 'TMOUT': '86400', 08:16:56 INFO - 'USER': 'cltbld', 08:16:56 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:56 INFO - '_': '/tools/buildbot/bin/python'} 08:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:56 INFO - Running setup.py (path:/tmp/pip-LDr0eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:16:56 INFO - Running setup.py (path:/tmp/pip-0A_rWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:16:56 INFO - Running setup.py (path:/tmp/pip-cP0B3s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:16:56 INFO - Running setup.py (path:/tmp/pip-ao3xaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:16:56 INFO - Running setup.py (path:/tmp/pip-shF0No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:16:57 INFO - Running setup.py (path:/tmp/pip-oN4d5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:16:57 INFO - Running setup.py (path:/tmp/pip-RHECV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:16:57 INFO - Running setup.py (path:/tmp/pip-XDoFW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:16:57 INFO - Running setup.py (path:/tmp/pip-XcC7Ts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:16:57 INFO - Running setup.py (path:/tmp/pip-BYq9l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:16:57 INFO - Running setup.py (path:/tmp/pip-e6cL5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:16:57 INFO - Running setup.py (path:/tmp/pip-ScJSGV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:16:57 INFO - Running setup.py (path:/tmp/pip-uRP2qH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:16:57 INFO - Running setup.py (path:/tmp/pip-lrDssc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:57 INFO - Running setup.py (path:/tmp/pip-KfRaFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:16:57 INFO - Running setup.py (path:/tmp/pip-BOpTN8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:16:57 INFO - Running setup.py (path:/tmp/pip-RkoYRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:16:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:16:57 INFO - Running setup.py install for manifestparser 08:16:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Running setup.py install for mozcrash 08:16:58 INFO - Running setup.py install for mozdebug 08:16:58 INFO - Running setup.py install for mozdevice 08:16:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Running setup.py install for mozfile 08:16:58 INFO - Running setup.py install for mozhttpd 08:16:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Running setup.py install for mozinfo 08:16:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Running setup.py install for mozInstall 08:16:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Running setup.py install for mozleak 08:16:58 INFO - Running setup.py install for mozlog 08:16:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:16:58 INFO - Running setup.py install for moznetwork 08:16:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Running setup.py install for mozprocess 08:16:59 INFO - Running setup.py install for mozprofile 08:16:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Running setup.py install for mozrunner 08:16:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Running setup.py install for mozscreenshot 08:16:59 INFO - Running setup.py install for moztest 08:16:59 INFO - Running setup.py install for mozversion 08:16:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:16:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:16:59 INFO - Cleaning up... 08:16:59 INFO - Return code: 0 08:16:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:16:59 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 0x7fb4f94fae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', '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 08:16:59 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 08:16:59 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 08:16:59 INFO - Using env: {'DISPLAY': ':0', 08:16:59 INFO - 'HOME': '/home/cltbld', 08:16:59 INFO - 'LANG': 'en_US.UTF-8', 08:16:59 INFO - 'LANGUAGE': 'en_US:en', 08:16:59 INFO - 'LOGNAME': 'cltbld', 08:16:59 INFO - 'MAIL': '/var/mail/cltbld', 08:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:16:59 INFO - 'MOZ_NO_REMOTE': '1', 08:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:16:59 INFO - 'NO_EM_RESTART': '1', 08:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:16:59 INFO - 'PWD': '/builds/slave/test', 08:16:59 INFO - 'SHELL': '/bin/bash', 08:16:59 INFO - 'SHLVL': '1', 08:16:59 INFO - 'TERM': 'linux', 08:16:59 INFO - 'TMOUT': '86400', 08:16:59 INFO - 'USER': 'cltbld', 08:16:59 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:16:59 INFO - '_': '/tools/buildbot/bin/python'} 08:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:16:59 INFO - Running setup.py (path:/tmp/pip-P5jjAL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:17:00 INFO - Running setup.py (path:/tmp/pip-SNntHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:17:00 INFO - Running setup.py (path:/tmp/pip-ys1FME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:17:00 INFO - Running setup.py (path:/tmp/pip-iI8ril-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:17:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:17:00 INFO - Running setup.py (path:/tmp/pip-3tdxEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:17:00 INFO - Running setup.py (path:/tmp/pip-iCVz4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:17:00 INFO - Running setup.py (path:/tmp/pip-hgJ76v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:17:00 INFO - Running setup.py (path:/tmp/pip-QIYeYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:17:00 INFO - Running setup.py (path:/tmp/pip-iyf2qG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:17:00 INFO - Running setup.py (path:/tmp/pip-04Er3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:17:00 INFO - Running setup.py (path:/tmp/pip-qux9LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:17:00 INFO - Running setup.py (path:/tmp/pip-oO_M9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:17:00 INFO - Running setup.py (path:/tmp/pip-W6NcyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:17:00 INFO - Running setup.py (path:/tmp/pip-G5DZz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:17:00 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)) 08:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:00 INFO - Running setup.py (path:/tmp/pip-EjNW0d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:17:01 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)) 08:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:17:01 INFO - Running setup.py (path:/tmp/pip-BpFv5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:17:01 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)) 08:17:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:17:01 INFO - Running setup.py (path:/tmp/pip-eofg_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:17:01 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)) 08:17:01 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)) 08:17:01 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)) 08:17:01 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)) 08:17:01 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:01 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:17:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:17:03 INFO - Downloading blessings-1.6.tar.gz 08:17:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:17:03 INFO - Installing collected packages: blessings 08:17:03 INFO - Running setup.py install for blessings 08:17:03 INFO - Successfully installed blessings 08:17:03 INFO - Cleaning up... 08:17:03 INFO - Return code: 0 08:17:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:03 INFO - Reading from file tmpfile_stdout 08:17:03 INFO - Current package versions: 08:17:03 INFO - argparse == 1.2.1 08:17:03 INFO - blessings == 1.6 08:17:03 INFO - blobuploader == 1.2.4 08:17:03 INFO - docopt == 0.6.1 08:17:03 INFO - functools32 == 3.2.3-2 08:17:03 INFO - jsonschema == 2.5.1 08:17:03 INFO - manifestparser == 1.1 08:17:03 INFO - mozInstall == 1.12 08:17:03 INFO - mozcrash == 1.0 08:17:03 INFO - mozdebug == 0.1 08:17:03 INFO - mozdevice == 0.49 08:17:03 INFO - mozfile == 1.2 08:17:03 INFO - mozhttpd == 0.7 08:17:03 INFO - mozinfo == 0.9 08:17:03 INFO - mozleak == 0.1 08:17:03 INFO - mozlog == 3.4 08:17:03 INFO - moznetwork == 0.27 08:17:03 INFO - mozprocess == 0.23 08:17:03 INFO - mozprofile == 0.28 08:17:03 INFO - mozrunner == 6.13 08:17:03 INFO - mozscreenshot == 0.1 08:17:03 INFO - mozsystemmonitor == 0.3 08:17:03 INFO - moztest == 0.7 08:17:03 INFO - mozversion == 1.4 08:17:03 INFO - psutil == 3.1.1 08:17:03 INFO - requests == 1.2.3 08:17:03 INFO - wsgiref == 0.1.2 08:17:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:03 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 0x7fb4f94fae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', '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 08:17:03 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 08:17:03 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 08:17:03 INFO - Using env: {'DISPLAY': ':0', 08:17:03 INFO - 'HOME': '/home/cltbld', 08:17:03 INFO - 'LANG': 'en_US.UTF-8', 08:17:03 INFO - 'LANGUAGE': 'en_US:en', 08:17:03 INFO - 'LOGNAME': 'cltbld', 08:17:03 INFO - 'MAIL': '/var/mail/cltbld', 08:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:03 INFO - 'MOZ_NO_REMOTE': '1', 08:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:03 INFO - 'NO_EM_RESTART': '1', 08:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:03 INFO - 'PWD': '/builds/slave/test', 08:17:03 INFO - 'SHELL': '/bin/bash', 08:17:03 INFO - 'SHLVL': '1', 08:17:03 INFO - 'TERM': 'linux', 08:17:03 INFO - 'TMOUT': '86400', 08:17:03 INFO - 'USER': 'cltbld', 08:17:03 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:03 INFO - '_': '/tools/buildbot/bin/python'} 08:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:03 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)) 08:17:03 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)) 08:17:03 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)) 08:17:03 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)) 08:17:03 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)) 08:17:03 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)) 08:17:03 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)) 08:17:03 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)) 08:17:03 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)) 08:17:03 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)) 08:17:03 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)) 08:17:03 INFO - Cleaning up... 08:17:03 INFO - Return code: 0 08:17:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f94fae30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfeb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e9a130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, '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': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', '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 08:17:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:17:03 INFO - Using env: {'DISPLAY': ':0', 08:17:03 INFO - 'HOME': '/home/cltbld', 08:17:03 INFO - 'LANG': 'en_US.UTF-8', 08:17:03 INFO - 'LANGUAGE': 'en_US:en', 08:17:03 INFO - 'LOGNAME': 'cltbld', 08:17:03 INFO - 'MAIL': '/var/mail/cltbld', 08:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:03 INFO - 'MOZ_NO_REMOTE': '1', 08:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:03 INFO - 'NO_EM_RESTART': '1', 08:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:03 INFO - 'PWD': '/builds/slave/test', 08:17:03 INFO - 'SHELL': '/bin/bash', 08:17:03 INFO - 'SHLVL': '1', 08:17:03 INFO - 'TERM': 'linux', 08:17:03 INFO - 'TMOUT': '86400', 08:17:03 INFO - 'USER': 'cltbld', 08:17:03 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:03 INFO - '_': '/tools/buildbot/bin/python'} 08:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:17:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:17:04 INFO - Cleaning up... 08:17:04 INFO - Return code: 0 08:17:04 INFO - Running post-action listener: _resource_record_post_action 08:17:04 INFO - Running post-action listener: _start_resource_monitoring 08:17:04 INFO - Starting resource monitoring. 08:17:04 INFO - [mozharness: 2016-11-30 16:17:04.131756Z] Finished create-virtualenv step (success) 08:17:04 INFO - [mozharness: 2016-11-30 16:17:04.132285Z] Running install step. 08:17:04 INFO - Running pre-action listener: _resource_record_pre_action 08:17:04 INFO - Running main action method: install 08:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:17:04 INFO - Reading from file tmpfile_stdout 08:17:04 INFO - Detecting whether we're running mozinstall >=1.0... 08:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:17:04 INFO - Reading from file tmpfile_stdout 08:17:04 INFO - Output received: 08:17:04 INFO - Usage: mozinstall [options] installer 08:17:04 INFO - Options: 08:17:04 INFO - -h, --help show this help message and exit 08:17:04 INFO - -d DEST, --destination=DEST 08:17:04 INFO - Directory to install application into. [default: 08:17:04 INFO - "/builds/slave/test"] 08:17:04 INFO - --app=APP Application being installed. [default: firefox] 08:17:04 INFO - mkdir: /builds/slave/test/build/application 08:17:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:17:20 INFO - Reading from file tmpfile_stdout 08:17:20 INFO - Output received: 08:17:20 INFO - /builds/slave/test/build/application/firefox/firefox 08:17:20 INFO - Running post-action listener: _resource_record_post_action 08:17:20 INFO - [mozharness: 2016-11-30 16:17:20.438050Z] Finished install step (success) 08:17:20 INFO - [mozharness: 2016-11-30 16:17:20.438291Z] Running run-tests step. 08:17:20 INFO - Running pre-action listener: _resource_record_pre_action 08:17:20 INFO - Running main action method: run_tests 08:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:17:20 INFO - Python 2.7.3 08:17:20 INFO - Return code: 0 08:17:20 INFO - grabbing minidump binary from tooltool 08:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:17:20 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 0x1f28fc0>, '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 0x1f29ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f2a350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:17:20 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 08:17:20 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 08:17:20 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 08:17:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:17:20 INFO - Return code: 0 08:17:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:17:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:17:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:17:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:17:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 08:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 08:17:20 INFO - Using env: {'DISPLAY': ':0', 08:17:20 INFO - 'HOME': '/home/cltbld', 08:17:20 INFO - 'LANG': 'en_US.UTF-8', 08:17:20 INFO - 'LANGUAGE': 'en_US:en', 08:17:20 INFO - 'LOGNAME': 'cltbld', 08:17:20 INFO - 'MAIL': '/var/mail/cltbld', 08:17:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:17:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:17:20 INFO - 'MOZ_NO_REMOTE': '1', 08:17:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:17:20 INFO - 'NO_EM_RESTART': '1', 08:17:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:17:20 INFO - 'PWD': '/builds/slave/test', 08:17:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:17:20 INFO - 'SHELL': '/bin/bash', 08:17:20 INFO - 'SHLVL': '1', 08:17:20 INFO - 'TERM': 'linux', 08:17:20 INFO - 'TMOUT': '86400', 08:17:20 INFO - 'USER': 'cltbld', 08:17:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644', 08:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:17:20 INFO - '_': '/tools/buildbot/bin/python'} 08:17:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 08:17:20 INFO - mozversion application_buildid: 20161130065243 08:17:20 INFO - mozversion application_changeset: 741a720c98cdb92c229376be0badbf036f653bff 08:17:20 INFO - mozversion application_display_name: Nightly 08:17:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:17:20 INFO - mozversion application_name: Firefox 08:17:20 INFO - mozversion application_remotingname: firefox 08:17:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:17:20 INFO - mozversion application_vendor: Mozilla 08:17:20 INFO - mozversion application_version: 53.0a1 08:17:20 INFO - mozversion platform_buildid: 20161130065243 08:17:20 INFO - mozversion platform_changeset: 741a720c98cdb92c229376be0badbf036f653bff 08:17:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:17:20 INFO - mozversion platform_version: 53.0a1 08:17:20 INFO - using testdate: 1480522640 08:17:20 INFO - actual date: 1480522640 08:17:20 INFO - starting webserver on 'localhost:43642' 08:17:20 INFO - SUITE-START | Running 2 tests 08:17:20 INFO - TEST-START | dromaeo_css 08:17:20 INFO - operating with platform_type : linux_ 08:17:20 INFO - Initialising browser for dromaeo_css test... 08:17:20 INFO - TEST-INFO | started process 12555 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphfIpmd/profile http://localhost:43642/getInfo.html) 08:17:25 INFO - PROCESS | 12555 | __metrics Screen width/height:1600/1200 08:17:25 INFO - PROCESS | 12555 | colorDepth:24 08:17:25 INFO - PROCESS | 12555 | Browser inner width/height: 1024/697 08:17:25 INFO - PROCESS | 12555 | __metrics 08:17:25 INFO - PROCESS | 12555 | 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" 08:17:25 INFO - PROCESS | 12555 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:17:26 INFO - PROCESS | 12555 | console.error: PushService: 08:17:26 INFO - PROCESS | 12555 | stateChangeProcessEnqueue: Error transitioning state 08:17:26 INFO - PROCESS | 12555 | UnknownError 08:17:27 INFO - TEST-INFO | 12555: exit 0 08:17:27 INFO - Browser initialized. 08:17:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:17:27 INFO - TEST-INFO | started process 12638 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphfIpmd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:39 INFO - PROCESS | 12638 | RSS: Main: 174903296 08:17:39 INFO - PROCESS | 12638 | 08:18:30 INFO - PROCESS | 12638 | 1480522710184 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] 08:20:43 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:43642/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43642/tests/dromaeo/cssquery-ext.html) 08:20:46 INFO - PROCESS | 12638 | RSS: Main: 271937536 08:20:46 INFO - PROCESS | 12638 | 08:23:49 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:43642/tests/dromaeo/cssquery-ext.html (next: http://localhost:43642/tests/dromaeo/cssquery-jquery.html) 08:23:49 INFO - PROCESS | 12638 | RSS: Main: 285700096 08:23:49 INFO - PROCESS | 12638 | 08:26:52 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:43642/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43642/tests/dromaeo/cssquery-mootools.html) 08:26:52 INFO - PROCESS | 12638 | RSS: Main: 219881472 08:26:52 INFO - PROCESS | 12638 | 08:29:55 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:43642/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43642/tests/dromaeo/cssquery-prototype.html) 08:29:55 INFO - PROCESS | 12638 | RSS: Main: 218484736 08:29:55 INFO - PROCESS | 12638 | 08:32:59 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:43642/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43642/tests/dromaeo/cssquery-yui.html) 08:32:59 INFO - PROCESS | 12638 | RSS: Main: 221052928 08:32:59 INFO - PROCESS | 12638 | 08:36:02 INFO - PROCESS | 12638 | Cycle 1(1): loaded http://localhost:43642/tests/dromaeo/cssquery-yui.html (next: http://localhost:43642/tests/dromaeo/cssquery-dojo.html) 08:36:02 INFO - PROCESS | 12638 | RSS: Main: 312619008 08:36:02 INFO - PROCESS | 12638 | 08:36:02 INFO - PROCESS | 12638 | __start_tp_report 08:36:02 INFO - PROCESS | 12638 | _x_x_mozilla_page_load 08:36:02 INFO - PROCESS | 12638 | _x_x_mozilla_page_load_details 08:36:02 INFO - PROCESS | 12638 | |i|pagename|runs| 08:36:02 INFO - PROCESS | 12638 | |0;dojo.html;2525.797936165107;2550.260424476902;2565.474077814048;2585.03061351993;2591.76674099331;4444.755538445384;4445.866624001281;4449.288113901776;4486.5962063414245;4488.304312831517;4514.1423129605355;4536.455625324966;4537.183307004746;4556.794944227509;4620.676552641308;4157.127003329305;4178.394132850734;4217.472815898012;4217.683673724483;4342.50061242958;3880.92591790683;4184.372344148372;4272.230998420283;4313.611774940255;4355.477342718862;4132.669386449077;4166.270902592065;4204.810783514749;4267.274563324242;4281.422008028923;4206.348016057516;4210.957890421118;4213.747175169499;4214.283571792803;4217.641500472463;4211.178820130076;4212.473440819897;4212.620864122213;4213.810378532973;4214.051838336381;4501.212287849613;4557.384753058328;4574.222382195035;4583.1062942726185;4616.953830461686;4871.14754917888;4874.53691899269;4887.608991280689;4890.951090489085;4933.7286449245275;4769.880752981168;4912.508749125094;4918.04098200851;4919.557239848395;4970.950290497085;4506.414166158411;4567.314902764546;4571.817127314936;4573.359729637853;4576.83981060668;4894.902101957941;4934.407871055496;4940.1601727706375;4965.503449655078;4993.275974983607;4695.671303008825;4738.597219236334;4740.45484769249;4777.570018698264;4778.283257511401;4805.630559085131;4810.95189048112;4813.3983252093485;4815.95184048155;4866.513348665176;4711.081339138835;4756.048790241965;4765.499622539653;4766.451858036301;4781.043791241766;4738.691985020962;4814.013127308894;4848.466668666444;4856.368672072608;4866.732329721899;4105.67154627629;4116.814743336557;4119.382092686061;4150;4155.148194620096;3569.5181150544863;3584.623614520438;3608.1701208721615;3610.4042832932796;3637.6907962823457;4190.099128687347;4226.830926762957;4237.385579091077;4250.511191212988;4259.467566554181;4921.434035086011;4922.581580565692;4923.409190897115;4923.630727695438;4959.057779021974;4257.893552661147;4265.3601959705675;4265.509466411402;4271.615554600101;4296.677749168824;4238.936415953764;4323.783810809447;4332.848350307787;4370.300751879748;4444.266695995189;4559.475660299108;4569.971756354794;4571.382863313544;4571.6799824012;4573.222552166073;4833.178359678793;4845.055214233191;4847.80608775645;4848.515148485123;4849.054434385402;4569.885752856072;4571.1543364477675;4573.565511276423;4580.427446569179;4580.702254353457;4769.57073863354;4771.332013518041;4773.188557945227;4776.522347765195;4784.138855006132;4784.545468180518;4849.224124140121;4850.345203397637;4852.975735121302;4853.126437241331;4652.3719297895705;4657.743824089707;4691.812327506861;4704.5765881070865;4708.693934894221;4703;4712.387389639325;4717.622590192845;4719.1741445247635;4749.430068391815;4554.2257816172;4591.885202869955;4633.235516139934;4650.069986002881;4682.531746825426;4693.671442998957;4701.529847015271;4712.646551508582;4791.233402655698;4843.055604157155;4665;4681.274402467623;4683.718976861399;4731;4740.573348398522 08:36:02 INFO - PROCESS | 12638 | |1;ext.html;547.5592148320602;571.9742611582478;581.9098039803832;596.9701514924253;612.721211848609;33214.523167982254;36637.450438243446;36717.08207294819;36741;36745.44881826768;36576.08559786007;36874.631253687454;37105.44341834875;37125.44311835324;37136;7321.560706357609;7405.851882962351;7500.737474188404;7581.507202031878;7586.848263034736;9575.42547447152;9880.555375008142;9893.752656183617;10122.139618132467;10127;9813.362131461468;9864.408135511856;9885.555150018266;9890.20878329732;9892.95053524735;9667.70996870095;9716.562754676057;9725.221982241404;9725.708228753148;9733.853992190123;9752.171065459444;9802.5588848502;9816.509174541245;9819.803603927952;9825.754356141082;36307;36683.81658091719;36692.816535917416;36701;36709.082272943124;2801.747842694147;2802.957955630667;2804.915852524407;2829.80191386603;3091.721745042957;27383.315417114532;27441.31396715098;27648.447031059266;27767.86116069427;27782.3054423639;3427.2631384252254;3434.21013166973;3453.7582369233915;3475.7045651119683;3525.9118522036897;232385;232475;232818.0154595365;232889;235381.82309088515;49126;49523.752381238584;49537.50462495401;49540.50459495431;49548;51518.22722659163;51558.48441515612;51817.7409112952;51819.48180518222;51942.48057519377;13326.93336533311;13751.862481375058;13773.517926872511;13781.310934453237;13789.379477923518;9006.954965225132;9303.53482325881;9312.627494900264;9494;10726.088282496075;13509.2569908654;14968.625784355261;15405.22973851303;15447.150406727738;15782.921085394499;5697.287839020122;5754.395788442237;5762.640744107936;5784.739686714108;5863.970680146657;862.1680078724062;890.429378193436;924.6671198368582;941.3928016429364;958.6453012385462;25788.226353209433;26554.6016809748;26793.464130717668;27058;27104.32239194036;871.2115535440437;883.8011447424278;889.9955500222458;930.5812384426899;1026.9986762906108;13148.671283217996;13762.380692868845;13789.655258618615;13953.86046139546;13969.511067112806;346014;347554;348587;348677;349367;41026;41311.00990356381;41375.1724965499;41406.171876562905;41409.585904141175;1068.56188962525;1103.178132291432;1141.9429028548705;1181.1849823621674;1193.164784650748;24458.877705611358;26842.86578567173;27247.591286130326;27502.449951000468;27587.31031724223;38838.834834955;39307.213855722155;39324.606753932094;39324.606753933236;39330.2133957325;262308;263880;263965;264996;265676;23357.883210584518;37464.438033430066;37957;38563;38871.6112838868;36892.81553592215;37186.814065929495;38278.808605956794;40705;40819.795901020305;34334.313313734085;34593;35026;35531.64468355283;36072.45891311685;34753.478697819046;35517.467237991965;35653.82173089118;35662.64337356593;35986.4602030975;32248;32789.83605081959;32811.50782738309;33005.84479543204;33446;30517;31824.36351273008;32336.676633234307;32394.514082289257;32438.189045274055;23663.408414789767;23892.641610376206;24193.274201773977;24532.632010520214;24685.62971555392 08:36:02 INFO - PROCESS | 12638 | |2;jquery.html;338.30815981318204;355.3692196351477;364.0861437791144;369.5731430198121;377.33588883564937;12363.752724945496;15606.453774117908;15906.602334941632;16038.117903515302;16355;16411.67176656466;16458.423955161572;17080.402185923496;17096.57258568533;17227.569310767238;4923.60611151108;4947.233178857283;5114;5132.050570644443;5150.665206761567;3640.8907732767925;3854;5049.899002019957;5163.845084647448;5168.405633352157;5721.170430287606;5995.460408563228;6006.099085137243;6107.26712794463;6113.908291375633;5896.115582662635;6013.939860601382;6059.939400605982;6090.817275481742;6105.664188469655;5313.787448502094;5325.547328477084;5331.173668081415;5331.840044798662;5335.706536140549;19593.510162245915;20334;20401.081951312226;20415.89792051045;20472.385828425173;1796.4341232511717;1857.2663797799794;1882.8493720502463;1895.4218963216213;1921.4139687395339;12728.80906786399;12743.426545805462;13061.477540898353;13138.554938690695;13484.190948543119;1528.4115615488006;1734.1329335332334;1787.5888545634448;1824.1973531646033;1879.2201236486842;65691.343086569;65812.67093664501;66574.66712666406;67004.6649766753;68609.31390686079;9030.28424599324;9119.954400227956;9285.953570232241;9469.289803264783;9593.13661770444;12634.557790477289;12665.620031399072;12667.239965602093;12669.619911402488;12670.936645316715;6810.829729256809;6952.826179345557;7071.434285257167;7107.964460177769;7298;6699.966500167566;6713.6643167842385;6741.561798483083;6975.930240697629;6989.965050174716;3886.1839013806853;3947.585503522146;3980.542237642708;4025.1748391579654;4195.412642230091;1594.5614955886992;1656.4202529114955;1683.3434960365466;1695.203254470397;1696.8981861088373;803.6343463723991;819.2462934100523;826;830.2278880641062;887.1793590928365;15292.847071529364;17973.191206395742;18249;18432.539186520175;18461;801.4411968720899;821.765796747936;823.390690888738;832.8167803083312;837.0917554453365;8907.51008694528;9564.13922746956;9631.181349585364;9713.167213702589;9728.61085556584;365431;377104;377261;378463;379047;77542.22457775463;77681.22318776853;77992.22007779963;78378.21621783823;78874.21125788783;914.7164379042385;916.8624706293975;933.2114363362947;938.5870217104452;939.6382392778693;14034.157950523002;14875.628109297355;14950.692504160867;15254.847451525342;15749.29128189257;33650;35835.462468063524;38494.80752596219;38538.807305964416;38915.221695565364;48509.75745121252;48728.75635621799;49330.75334623304;49465.75267123641;50110.749446252536;6117.204763380732;6917.169939607279;6963.1296087989;7312.597807120659;7370.189279179179;7674.9232507674205;9704.466254356079;10414.583416663248;10754.247202695737;11038.558457661924;8774.078721734126;8797.47215167092;8932.910670893469;9186.954065229631;9396.906030939603;8172.723844306423;8348.791280218044;8721.607527661143;9208.815823683623;9397.624095036123;9034.728958131267;9485.430874147572;9555.617775289189;9806;9831.410115392813;6887.5178737487895;6974.267701891228;7038.964805175941;7073.3987611053635;7227.421806255592;8468.957655211685;9601.855972160563;9641.807163856824;9642.132208101304;10113.848292275768 08:36:02 INFO - PROCESS | 12638 | |3;mootools.html;1217.1540779158488;1304.621659718682;1352.2765320553503;1408.591508462546;1659.6182877938065;6335.5565110442285;6751.594904305745;7004.404625606823;7035.718571257144;7049.964750176255;6876.518643694943;6997.965010174942;6999.860002799941;7182.892256616155;7183.102112235971;1790.8030116687155;1984.4542750743517;2029.2288930206576;2029.4520479470534;2031.461662659389;1857.3035111833062;2020.6362854686151;2073.5023594337326;2074.751029876417;2090.937271881846;2051.6307064728344;2054.455569274136;2057.238821635989;2058.7529496460447;2060.629086764382;2016.1330627830027;2047.1811275489774;2054.558269971963;2059.824914882237;2060.7527096748336;2007.076744697441;2029.5027718208985;2031.0961622078182;2047.8668886522478;2052.8709209934477;7000.089988301539;7037.401820845234;7069.151701795766;7120.572765634027;7127.322904324081;4138.79306034697;4264.253755592759;4267.658587313039;4268.743875367457;4270.338097594878;2645.9867700661375;2708;2749.340158361999;2794.091920125967;2794.580812878064;834.6077343648476;876.9561521923878;880.828238493494;887.8046829697456;904.5115637555712;9003.189712925803;9155.359124861263;9195.954020229856;9257.814843703156;9422.05779422066;3726.1802403471193;3806.980965095157;3910.902227444337;3916.236333914859;3929.135590170158;8302.335813135056;8303.418760686694;8304.8339033219;8311.085780564134;8313.33493320533;4295.3771703102875;4323.329883868006;4327.1345730853955;4327.350897365357;4332.826686932487;3385.322935412927;3414.9829250853586;3904.375299951994;3905.062784931596;3906.0820707133803;3333.7666363354333;3446.724262059029;3458.39478091333;3472.2187507811045;3565.7860528368383;1026.645807196516;1057.1859668055554;1058.777656692088;1066.7119877633152;1072.9195310351754;674.5345711459078;682.5699809120322;725.8911163325438;727.1601300497828;750.8310630108291;4425.557444255549;4473.172463094338;4789.233722604366;4849.078675051799;4874.2444921037295;818.55388813097;846.7798372423214;859.6604341285282;908.9020976946123;928.2570005633472;3143.669914658928;3156.447621666245;3185.1240908749814;3229.9677003229667;3383.052745231339;7901.091374491892;7985;8061.2744852963515;8077.35381169505;8096.433249672466;8013.919860801318;8020.0375954885785;8023.237792409712;8027.036755589366;8034.397420193392;6695.966520167465;6783.796486105425;6806.115205023414;6818.045473633695;6822;4668.789904454376;4685.812567497262;4796.232602783677;4809.2064809306075;4878.341423907869;7664.156942736183;7793.415493838098;7902.24928631779;7919.802004949923;7932.881006784787;7846;7967;7977.122516523062;8004.7198348059865;8020.799480013046;5037.672551284301;5151.407588127413;5720.3421606515785;5776.480116789509;5852.473277404883;6510.316416776171;6709.496787741036;6714.227863795726;6763.93236067633;6820.829479263058;5889.116632505158;5922.703864806828;5963.7912673056235;5972.8805423892145;6043.516518678407;5742.913856292075;5749.080147176432;5792.652440853562;5833.358330583547;5875.294964604275;5723.5707321950185;5744.30263446983;5759.193712880284;5803.7968671096305;5806.738696758741;3944.9408258876715;4029.8992525187105;4054.412110244057;4101.753894766323;4244.639205667553;4047.8785636430953;4057.046594050455;4119.382092686121;4127.277726397929;4246.3842742802735 08:36:02 INFO - PROCESS | 12638 | |4;prototype.html;269.46645641629567;271.85591636432696;275.5054676855045;278.33755661525566;281.4202742350756;4574.99350142968;4698.64760142989;4722.724864286641;4751.976240118799;4805.519448055193;4575.6730548140995;4660.5339466053465;4669.463011753649;4707.529247075291;4711.929321060187;3500.299940011995;3601.567811862567;3616.2948225096115;3673.246984368198;3675.9632403675955;3682.054356514791;3684.5946945835935;3689.1883785567134;3695.150115473443;3697.3899306614376;3635.1457407509215;3644.908877278063;3654.762440441376;3656.451532270154;3667.8716244931434;3658.8353524091212;3660.249648821985;3671.6781958495053;3673.2469843682247;3687.446882967576;3144.811311321328;3194.4888817789274;3197.2646291353117;3198.9923174200053;3227.4190645683766;4521.638268938477;4540.72755634663;4557;4562.58936695699;4565.497795242521;4112.897177570555;4113.321301985169;4117.402976568411;4121.918431192229;4129.318662420697;4743.596794272491;4865.975670121662;4872.1473742094995;4878.365812444395;4889.853304400874;3428.3314753623054;3457.878974235915;3458.7345288835854;3459.8270086495572;3470.6008808987035;5116.820911268125;5131.486851314876;5132.974335128338;5158.277841102249;5178.300929374524;3542.1144713821545;3552.5381700378784;3556.644335566423;3557.3596752584785;3563.251717139378;3360.5967283926084;3538.203904121552;3548.432250839853;3609.115766637138;3617.3488772021287;4049.797510124541;4053.3919912013434;4053.5541090480024;4067.206894655573;4091.9590804091577;4639.37368455261;4698.7415692137265;4777.331173635694;4855.174620314555;4934.1611925972675;1212.7210741529498;1221.8167274908658;1226.8957937856;1228.4103630257348;1229.7786398448366;828.9709860154866;841.9452735572169;845.8350621628723;852.4075767341762;858.6651206029653;4183.518895327015;4196.307609244502;4207.200631879994;4231.89970607638;4236.766977816188;4864.73243971585;4879.780409881564;4897.2654101885;4904.288878112654;4909.410870695468;4229.513605935295;4231.132617813341;4232.30167022444;4265.7440553566885;4266.445362102969;2538.9873050634997;2543.949121017606;2547.4522977559914;2558.93602659935;2613.490369377991;4546.272596384562;4558.772061396917;4612.976935115303;4614.292711696694;4614.677432248843;4970.950290497121;4982.202847544376;4987.80048798044;4991.201407774739;5057.898842023139;4400.933985990213;4608.815647374135;4632.652551058617;4634.745089020069;4659.347691323217;4901.264810278487;4906.503516427524;4915.311856340044;4933.457319694759;4981.4769449207315;4861.343718597944;4873.87815304606;4878.390201224847;4881.73150476713;4889.46215916256;4482.663800214932;4586.334981427608;4599.241125214436;4610.953890461053;4645.910469537719;3499.33512632599;3504.176518518197;3514.2268700885766;3516.9824150880104;3546.8049257290063;4873.95126048735;4910.729909854849;4917.459079501324;4982.377202849644;4990.8253211137435;4853.684510506806;4862.513748625109;4868.5637736867;4879.536444037811;4887.3890763654545;4856.878578035577;4889.266610008527;4913.70517768935;4935.555799978019;4938.802447902043;4662.510436404129;4761.357216775691;4777.474477807508;4807.543283388072;4817.229243321051;4904.773806548363;4915.926261106158;4941.555260026615;4957.4794646561595;4960.627952903619;4811.615070794398;4820.493848145894;4841.975790121027;4866.416030076413;4883.90232195347 08:36:02 INFO - PROCESS | 12638 | |5;yui.html;540.9296791417114;545.1849485019895;565.2453973944783;565.776518275281;571.6312978129105;11443.713907152325;12138;12205.938970305137;12228.449719762599;12401.56594519192;11637.069034477243;11757.647270581874;11853.288802671825;11881.702957426069;11891.464884080215;590.4538302070589;739.1130643228121;753.600591686407;754.4002517998205;755.8979537762386;605.3794860268239;729.2853004056028;747.5477336211595;754.4115589839934;756.2588663110155;784.8626490364163;786.9488483248571;787.3622365883624;787.9684812607488;788.4993029426298;618.2766163588567;781.6091954022988;781.6404453951133;782.2803021220491;782.49138060261;469.5163981099473;557.1030640668521;572.4104172702123;573.0001147996772;574.4399210769467;11879.40602969848;11879.584214552535;11884.346360950145;12003.399830008464;12017.699557511045;11534.13493987946;11865.940670296593;11944.88055119455;12177.208481448677;12983.09118361715;11183.44082795857;11451.541938322458;11653.70865728355;11794.230865370177;12335;3930.803459827026;3950.644442000234;3956.2285354355913;3980.8208630611693;4052.8784136475656;62143.06785398268;62749;62824.68587657078;63381.68309158471;64192;9610.615575377047;9664.565094570762;9744.512774361254;9772.951135244279;9970.501474926225;17152;17249;17250.65498690019;17276.481705548853;17281.827181728273;5839.416058394127;5884.970575147183;5896.882062358729;6096.969515152396;6108.664023478751;3299.736021118305;3413.5903691557173;3425.53755243044;3437.037629463754;3478.0261526772542;2419.395151212197;2481.5905375613183;2506.0602274147195;2519.8110141739076;2524.8358856674627;431.0258815077946;431.16569438137304;433.84598467544197;461.08704764566346;485.2938973793122;484.706752414791;496.0599663637387;503.86647538402354;520.7604501929079;542.3058485139028;6896.965515172493;6915.412189963909;6956.234814170437;6983.092198014226;7149.571025738473;511.5396143470906;522.7046718603976;526.1712802336335;539.6681041159737;545.7735039958452;3170.873165073371;3316.5688460499982;3378;3406;3434.8797792077157;60207.397926021054;60718.392816071275;62070.379296207364;63766.36233637604;65902.67048664726;54015.729921350925;54379;55247.447525525036;55329;56966;44247.11505769931;44408.55591444044;49872.750636247314;50292.49707502951;50294;7567.432442566719;8031.919680803117;8164.224398682116;8212.753617391489;8403.663853445794;34759;35865.46201806923;36653.45019824758;36667.81666091653;37184.07039824026;41037.58962410457;44983.55016449794;47134.764326179524;47346.76326618345;47670.52329476661;10083.949580252052;10312.742181445525;10494;10605.946970265099;10627.468626568796;11512.366819824654;11895.583654572049;12100.455479503267;12159.270443773403;12271.325077120488;10421.635242766466;10422.218333624856;10536.789264214825;10590.8411373831;10923.12614990783;10976.560937562728;10984.450777461256;11152.107831373633;11177.66467005991;11704.765904682028;10270.281080324306;10337.534810933677;10516.57933682644;10575.524101415609;10789.352638841694;9447;9597.184239339455;9652.71041868717;9816.411015338817;10324.845127323246;8731.607077681392;9186.954065229631;9342.579583918876;9348.392354496937;9507.144357007903 08:36:02 INFO - PROCESS | 12638 | __end_tp_report 08:36:02 INFO - PROCESS | 12638 | __start_cc_report 08:36:02 INFO - PROCESS | 12638 | _x_x_mozilla_cycle_collect,2611 08:36:02 INFO - PROCESS | 12638 | __end_cc_report 08:36:02 INFO - PROCESS | 12638 | __startTimestamp1480523762904__endTimestamp 08:36:02 INFO - PROCESS | 12638 | 08:36:02 INFO - PROCESS | 12638 | ------- Summary: start ------- 08:36:02 INFO - PROCESS | 12638 | Number of tests: 6 08:36:02 INFO - PROCESS | 12638 | 08:36:02 INFO - PROCESS | 12638 | [#0] dojo.html Cycles:165 Average:4491.95 Median:4580.70 stddev:458.03 (10.0%) stddev-sans-first:432.68 08:36:02 INFO - PROCESS | 12638 | Values: 2525.8 2550.3 2565.5 2585.0 2591.8 4444.8 4445.9 4449.3 4486.6 4488.3 4514.1 4536.5 4537.2 4556.8 4620.7 4157.1 4178.4 4217.5 4217.7 4342.5 3880.9 4184.4 4272.2 4313.6 4355.5 4132.7 4166.3 4204.8 4267.3 4281.4 4206.3 4211.0 4213.7 4214.3 4217.6 4211.2 4212.5 4212.6 4213.8 4214.1 4501.2 4557.4 4574.2 4583.1 4617.0 4871.1 4874.5 4887.6 4891.0 4933.7 4769.9 4912.5 4918.0 4919.6 4971.0 4506.4 4567.3 4571.8 4573.4 4576.8 4894.9 4934.4 4940.2 4965.5 4993.3 4695.7 4738.6 4740.5 4777.6 4778.3 4805.6 4811.0 4813.4 4816.0 4866.5 4711.1 4756.0 4765.5 4766.5 4781.0 4738.7 4814.0 4848.5 4856.4 4866.7 4105.7 4116.8 4119.4 4150.0 4155.1 3569.5 3584.6 3608.2 3610.4 3637.7 4190.1 4226.8 4237.4 4250.5 4259.5 4921.4 4922.6 4923.4 4923.6 4959.1 4257.9 4265.4 4265.5 4271.6 4296.7 4238.9 4323.8 4332.8 4370.3 4444.3 4559.5 4570.0 4571.4 4571.7 4573.2 4833.2 4845.1 4847.8 4848.5 4849.1 4569.9 4571.2 4573.6 4580.4 4580.7 4769.6 4771.3 4773.2 4776.5 4784.1 4784.5 4849.2 4850.3 4853.0 4853.1 4652.4 4657.7 4691.8 4704.6 4708.7 4703.0 4712.4 4717.6 4719.2 4749.4 4554.2 4591.9 4633.2 4650.1 4682.5 4693.7 4701.5 4712.6 4791.2 4843.1 4665.0 4681.3 4683.7 4731.0 4740.6 08:36:02 INFO - PROCESS | 12638 | 08:36:02 INFO - PROCESS | 12638 | [#1] ext.html Cycles:180 Average:43492.86 Median:36189.73 stddev:74914.25 (207.0%) stddev-sans-first:75055.01 08:36:02 INFO - PROCESS | 12638 | Values: 547.6 572.0 581.9 597.0 612.7 33214.5 36637.5 36717.1 36741.0 36745.4 36576.1 36874.6 37105.4 37125.4 37136.0 7321.6 7405.9 7500.7 7581.5 7586.8 9575.4 9880.6 9893.8 10122.1 10127.0 9813.4 9864.4 9885.6 9890.2 9893.0 9667.7 9716.6 9725.2 9725.7 9733.9 9752.2 9802.6 9816.5 9819.8 9825.8 36307.0 36683.8 36692.8 36701.0 36709.1 2801.7 2803.0 2804.9 2829.8 3091.7 27383.3 27441.3 27648.4 27767.9 27782.3 3427.3 3434.2 3453.8 3475.7 3525.9 232385.0 232475.0 232818.0 232889.0 235381.8 49126.0 49523.8 49537.5 49540.5 49548.0 51518.2 51558.5 51817.7 51819.5 51942.5 13326.9 13751.9 13773.5 13781.3 13789.4 9007.0 9303.5 9312.6 9494.0 10726.1 13509.3 14968.6 15405.2 15447.2 15782.9 5697.3 5754.4 5762.6 5784.7 5864.0 862.2 890.4 924.7 941.4 958.6 25788.2 26554.6 26793.5 27058.0 27104.3 871.2 883.8 890.0 930.6 1027.0 13148.7 13762.4 13789.7 13953.9 13969.5 346014.0 347554.0 348587.0 348677.0 349367.0 41026.0 41311.0 41375.2 41406.2 41409.6 1068.6 1103.2 1141.9 1181.2 1193.2 24458.9 26842.9 27247.6 27502.4 27587.3 38838.8 39307.2 39324.6 39324.6 39330.2 262308.0 263880.0 263965.0 264996.0 265676.0 23357.9 37464.4 37957.0 38563.0 38871.6 36892.8 37186.8 38278.8 40705.0 40819.8 34334.3 34593.0 35026.0 35531.6 36072.5 34753.5 35517.5 35653.8 35662.6 35986.5 32248.0 32789.8 32811.5 33005.8 33446.0 30517.0 31824.4 32336.7 32394.5 32438.2 23663.4 23892.6 24193.3 24532.6 24685.6 08:36:02 INFO - PROCESS | 12638 | 08:36:02 INFO - PROCESS | 12638 | [#2] jquery.html Cycles:180 Average:23609.06 Median:5328.36 stddev:62102.94 (1165.5%) stddev-sans-first:62252.57 08:36:02 INFO - PROCESS | 12638 | Values: 338.3 355.4 364.1 369.6 377.3 12363.8 15606.5 15906.6 16038.1 16355.0 16411.7 16458.4 17080.4 17096.6 17227.6 4923.6 4947.2 5114.0 5132.1 5150.7 3640.9 3854.0 5049.9 5163.8 5168.4 5721.2 5995.5 6006.1 6107.3 6113.9 5896.1 6013.9 6059.9 6090.8 6105.7 5313.8 5325.5 5331.2 5331.8 5335.7 19593.5 20334.0 20401.1 20415.9 20472.4 1796.4 1857.3 1882.8 1895.4 1921.4 12728.8 12743.4 13061.5 13138.6 13484.2 1528.4 1734.1 1787.6 1824.2 1879.2 65691.3 65812.7 66574.7 67004.7 68609.3 9030.3 9120.0 9286.0 9469.3 9593.1 12634.6 12665.6 12667.2 12669.6 12670.9 6810.8 6952.8 7071.4 7108.0 7298.0 6700.0 6713.7 6741.6 6975.9 6990.0 3886.2 3947.6 3980.5 4025.2 4195.4 1594.6 1656.4 1683.3 1695.2 1696.9 803.6 819.2 826.0 830.2 887.2 15292.8 17973.2 18249.0 18432.5 18461.0 801.4 821.8 823.4 832.8 837.1 8907.5 9564.1 9631.2 9713.2 9728.6 365431.0 377104.0 377261.0 378463.0 379047.0 77542.2 77681.2 77992.2 78378.2 78874.2 914.7 916.9 933.2 938.6 939.6 14034.2 14875.6 14950.7 15254.8 15749.3 33650.0 35835.5 38494.8 38538.8 38915.2 48509.8 48728.8 49330.8 49465.8 50110.7 6117.2 6917.2 6963.1 7312.6 7370.2 7674.9 9704.5 10414.6 10754.2 11038.6 8774.1 8797.5 8932.9 9187.0 9396.9 8172.7 8348.8 8721.6 9208.8 9397.6 9034.7 9485.4 9555.6 9806.0 9831.4 6887.5 6974.3 7039.0 7073.4 7227.4 8469.0 9601.9 9641.8 9642.1 10113.8 08:36:02 INFO - PROCESS | 12638 | 08:36:02 INFO - PROCESS | 12638 | [#3] mootools.html Cycles:180 Average:4585.17 Median:5094.54 stddev:2479.42 (48.7%) stddev-sans-first:2473.45 08:36:02 INFO - PROCESS | 12638 | Values: 1217.2 1304.6 1352.3 1408.6 1659.6 6335.6 6751.6 7004.4 7035.7 7050.0 6876.5 6998.0 6999.9 7182.9 7183.1 1790.8 1984.5 2029.2 2029.5 2031.5 1857.3 2020.6 2073.5 2074.8 2090.9 2051.6 2054.5 2057.2 2058.8 2060.6 2016.1 2047.2 2054.6 2059.8 2060.8 2007.1 2029.5 2031.1 2047.9 2052.9 7000.1 7037.4 7069.2 7120.6 7127.3 4138.8 4264.3 4267.7 4268.7 4270.3 2646.0 2708.0 2749.3 2794.1 2794.6 834.6 877.0 880.8 887.8 904.5 9003.2 9155.4 9196.0 9257.8 9422.1 3726.2 3807.0 3910.9 3916.2 3929.1 8302.3 8303.4 8304.8 8311.1 8313.3 4295.4 4323.3 4327.1 4327.4 4332.8 3385.3 3415.0 3904.4 3905.1 3906.1 3333.8 3446.7 3458.4 3472.2 3565.8 1026.6 1057.2 1058.8 1066.7 1072.9 674.5 682.6 725.9 727.2 750.8 4425.6 4473.2 4789.2 4849.1 4874.2 818.6 846.8 859.7 908.9 928.3 3143.7 3156.4 3185.1 3230.0 3383.1 7901.1 7985.0 8061.3 8077.4 8096.4 8013.9 8020.0 8023.2 8027.0 8034.4 6696.0 6783.8 6806.1 6818.0 6822.0 4668.8 4685.8 4796.2 4809.2 4878.3 7664.2 7793.4 7902.2 7919.8 7932.9 7846.0 7967.0 7977.1 8004.7 8020.8 5037.7 5151.4 5720.3 5776.5 5852.5 6510.3 6709.5 6714.2 6763.9 6820.8 5889.1 5922.7 5963.8 5972.9 6043.5 5742.9 5749.1 5792.7 5833.4 5875.3 5723.6 5744.3 5759.2 5803.8 5806.7 3944.9 4029.9 4054.4 4101.8 4244.6 4047.9 4057.0 4119.4 4127.3 4246.4 08:36:02 INFO - PROCESS | 12638 | 08:36:02 INFO - PROCESS | 12638 | [#4] prototype.html Cycles:180 Average:4023.21 Median:4581.00 stddev:1167.70 (25.5%) stddev-sans-first:1136.48 08:36:02 INFO - PROCESS | 12638 | Values: 269.5 271.9 275.5 278.3 281.4 4575.0 4698.6 4722.7 4752.0 4805.5 4575.7 4660.5 4669.5 4707.5 4711.9 3500.3 3601.6 3616.3 3673.2 3676.0 3682.1 3684.6 3689.2 3695.2 3697.4 3635.1 3644.9 3654.8 3656.5 3667.9 3658.8 3660.2 3671.7 3673.2 3687.4 3144.8 3194.5 3197.3 3199.0 3227.4 4521.6 4540.7 4557.0 4562.6 4565.5 4112.9 4113.3 4117.4 4121.9 4129.3 4743.6 4866.0 4872.1 4878.4 4889.9 3428.3 3457.9 3458.7 3459.8 3470.6 5116.8 5131.5 5133.0 5158.3 5178.3 3542.1 3552.5 3556.6 3557.4 3563.3 3360.6 3538.2 3548.4 3609.1 3617.3 4049.8 4053.4 4053.6 4067.2 4092.0 4639.4 4698.7 4777.3 4855.2 4934.2 1212.7 1221.8 1226.9 1228.4 1229.8 829.0 841.9 845.8 852.4 858.7 4183.5 4196.3 4207.2 4231.9 4236.8 4864.7 4879.8 4897.3 4904.3 4909.4 4229.5 4231.1 4232.3 4265.7 4266.4 2539.0 2543.9 2547.5 2558.9 2613.5 4546.3 4558.8 4613.0 4614.3 4614.7 4971.0 4982.2 4987.8 4991.2 5057.9 4400.9 4608.8 4632.7 4634.7 4659.3 4901.3 4906.5 4915.3 4933.5 4981.5 4861.3 4873.9 4878.4 4881.7 4889.5 4482.7 4586.3 4599.2 4611.0 4645.9 3499.3 3504.2 3514.2 3517.0 3546.8 4874.0 4910.7 4917.5 4982.4 4990.8 4853.7 4862.5 4868.6 4879.5 4887.4 4856.9 4889.3 4913.7 4935.6 4938.8 4662.5 4761.4 4777.5 4807.5 4817.2 4904.8 4915.9 4941.6 4957.5 4960.6 4811.6 4820.5 4842.0 4866.4 4883.9 08:36:02 INFO - PROCESS | 12638 | 08:36:02 INFO - PROCESS | 12638 | [#5] yui.html Cycles:180 Average:14181.88 Median:47240.76 stddev:17905.01 (37.9%) stddev-sans-first:17925.93 08:36:02 INFO - PROCESS | 12638 | Values: 540.9 545.2 565.2 565.8 571.6 11443.7 12138.0 12205.9 12228.4 12401.6 11637.1 11757.6 11853.3 11881.7 11891.5 590.5 739.1 753.6 754.4 755.9 605.4 729.3 747.5 754.4 756.3 784.9 786.9 787.4 788.0 788.5 618.3 781.6 781.6 782.3 782.5 469.5 557.1 572.4 573.0 574.4 11879.4 11879.6 11884.3 12003.4 12017.7 11534.1 11865.9 11944.9 12177.2 12983.1 11183.4 11451.5 11653.7 11794.2 12335.0 3930.8 3950.6 3956.2 3980.8 4052.9 62143.1 62749.0 62824.7 63381.7 64192.0 9610.6 9664.6 9744.5 9773.0 9970.5 17152.0 17249.0 17250.7 17276.5 17281.8 5839.4 5885.0 5896.9 6097.0 6108.7 3299.7 3413.6 3425.5 3437.0 3478.0 2419.4 2481.6 2506.1 2519.8 2524.8 431.0 431.2 433.8 461.1 485.3 484.7 496.1 503.9 520.8 542.3 6897.0 6915.4 6956.2 6983.1 7149.6 511.5 522.7 526.2 539.7 545.8 3170.9 3316.6 3378.0 3406.0 3434.9 60207.4 60718.4 62070.4 63766.4 65902.7 54015.7 54379.0 55247.4 55329.0 56966.0 44247.1 44408.6 49872.8 50292.5 50294.0 7567.4 8031.9 8164.2 8212.8 8403.7 34759.0 35865.5 36653.5 36667.8 37184.1 41037.6 44983.6 47134.8 47346.8 47670.5 10083.9 10312.7 10494.0 10605.9 10627.5 11512.4 11895.6 12100.5 12159.3 12271.3 10421.6 10422.2 10536.8 10590.8 10923.1 10976.6 10984.5 11152.1 11177.7 11704.8 10270.3 10337.5 10516.6 10575.5 10789.4 9447.0 9597.2 9652.7 9816.4 10324.8 8731.6 9187.0 9342.6 9348.4 9507.1 08:36:02 INFO - PROCESS | 12638 | -------- Summary: end -------- 08:36:02 INFO - PROCESS | 12638 | 08:36:03 INFO - TEST-INFO | 12638: exit 0 08:36:03 INFO - TEST-OK | dromaeo_css | took 1123206ms 08:36:03 INFO - TEST-START | kraken 08:36:03 INFO - operating with platform_type : linux_ 08:36:03 INFO - Initialising browser for kraken test... 08:36:03 INFO - TEST-INFO | started process 12942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfRJAvU/profile http://localhost:43642/getInfo.html) 08:36:08 INFO - PROCESS | 12942 | __metrics Screen width/height:1600/1200 08:36:08 INFO - PROCESS | 12942 | colorDepth:24 08:36:08 INFO - PROCESS | 12942 | Browser inner width/height: 1024/697 08:36:08 INFO - PROCESS | 12942 | __metrics 08:36:08 INFO - PROCESS | 12942 | 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" 08:36:08 INFO - PROCESS | 12942 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:36:09 INFO - PROCESS | 12942 | console.error: PushService: 08:36:09 INFO - PROCESS | 12942 | stateChangeProcessEnqueue: Error transitioning state 08:36:09 INFO - PROCESS | 12942 | UnknownError 08:36:10 INFO - TEST-INFO | 12942: exit 0 08:36:10 INFO - Browser initialized. 08:36:10 INFO - Running cycle 1/1 for kraken test... 08:36:10 INFO - TEST-INFO | started process 13025 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfRJAvU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:36:22 INFO - PROCESS | 13025 | RSS: Main: 174280704 08:36:22 INFO - PROCESS | 13025 | 08:36:25 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43642/tests/kraken/driver.html?testName=audio-beat-detection) 08:36:26 INFO - PROCESS | 13025 | RSS: Main: 239849472 08:36:26 INFO - PROCESS | 13025 | 08:36:29 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43642/tests/kraken/driver.html?testName=audio-dft) 08:36:29 INFO - PROCESS | 13025 | RSS: Main: 218431488 08:36:29 INFO - PROCESS | 13025 | 08:36:32 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43642/tests/kraken/driver.html?testName=audio-fft) 08:36:33 INFO - PROCESS | 13025 | RSS: Main: 300220416 08:36:33 INFO - PROCESS | 13025 | 08:36:35 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43642/tests/kraken/driver.html?testName=audio-oscillator) 08:36:36 INFO - PROCESS | 13025 | RSS: Main: 211632128 08:36:36 INFO - PROCESS | 13025 | 08:36:38 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43642/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:36:39 INFO - PROCESS | 13025 | RSS: Main: 214786048 08:36:39 INFO - PROCESS | 13025 | 08:36:42 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43642/tests/kraken/driver.html?testName=imaging-darkroom) 08:36:42 INFO - PROCESS | 13025 | RSS: Main: 253648896 08:36:42 INFO - PROCESS | 13025 | 08:36:46 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43642/tests/kraken/driver.html?testName=imaging-desaturate) 08:36:46 INFO - PROCESS | 13025 | RSS: Main: 253616128 08:36:46 INFO - PROCESS | 13025 | 08:36:49 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43642/tests/kraken/driver.html?testName=json-parse-financial) 08:36:50 INFO - PROCESS | 13025 | RSS: Main: 252428288 08:36:50 INFO - PROCESS | 13025 | 08:36:52 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43642/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:36:52 INFO - PROCESS | 13025 | RSS: Main: 214806528 08:36:52 INFO - PROCESS | 13025 | 08:36:54 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43642/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:36:55 INFO - PROCESS | 13025 | RSS: Main: 221581312 08:36:55 INFO - PROCESS | 13025 | 08:36:57 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43642/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:36:58 INFO - PROCESS | 13025 | RSS: Main: 230260736 08:36:58 INFO - PROCESS | 13025 | 08:37:01 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43642/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:37:01 INFO - PROCESS | 13025 | RSS: Main: 239300608 08:37:01 INFO - PROCESS | 13025 | 08:37:04 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43642/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:37:05 INFO - PROCESS | 13025 | RSS: Main: 235761664 08:37:05 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | Cycle 1(1): loaded http://localhost:43642/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43642/tests/kraken/driver.html?testName=ai-astar) 08:37:07 INFO - PROCESS | 13025 | RSS: Main: 286138368 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | __start_tp_report 08:37:07 INFO - PROCESS | 13025 | _x_x_mozilla_page_load 08:37:07 INFO - PROCESS | 13025 | _x_x_mozilla_page_load_details 08:37:07 INFO - PROCESS | 13025 | |i|pagename|runs| 08:37:07 INFO - PROCESS | 13025 | |0;ai-astar;106;116;116;117;118;115;116;118;115;117 08:37:07 INFO - PROCESS | 13025 | |1;audio-beat-detection;156;136;135;171;130;129;129;129;160;128 08:37:07 INFO - PROCESS | 13025 | |2;audio-dft;163;160;162;162;163;162;164;161;161;163 08:37:07 INFO - PROCESS | 13025 | |3;audio-fft;77;76;77;110;78;77;78;76;91;77 08:37:07 INFO - PROCESS | 13025 | |4;audio-oscillator;83;84;109;84;85;85;103;83;90;106 08:37:07 INFO - PROCESS | 13025 | |5;imaging-gaussian-blur;117;116;117;119;117;118;117;117;117;117 08:37:07 INFO - PROCESS | 13025 | |6;imaging-darkroom;147;148;146;148;146;146;147;147;146;146 08:37:07 INFO - PROCESS | 13025 | |7;imaging-desaturate;95;95;95;95;95;96;95;96;95;95 08:37:07 INFO - PROCESS | 13025 | |8;json-parse-financial;64;64;64;63;65;64;65;66;65;65 08:37:07 INFO - PROCESS | 13025 | |9;json-stringify-tinderbox;65;66;66;66;67;66;65;66;66;66 08:37:07 INFO - PROCESS | 13025 | |10;stanford-crypto-aes;84;85;85;84;94;85;85;85;85;85 08:37:07 INFO - PROCESS | 13025 | |11;stanford-crypto-ccm;146;148;146;145;146;156;142;147;208;144 08:37:07 INFO - PROCESS | 13025 | |12;stanford-crypto-pbkdf2;179;179;177;177;176;185;180;180;177;180 08:37:07 INFO - PROCESS | 13025 | |13;stanford-crypto-sha256-iterative;73;72;74;75;72;71;72;75;70;69 08:37:07 INFO - PROCESS | 13025 | __end_tp_report 08:37:07 INFO - PROCESS | 13025 | __start_cc_report 08:37:07 INFO - PROCESS | 13025 | _x_x_mozilla_cycle_collect,2034 08:37:07 INFO - PROCESS | 13025 | __end_cc_report 08:37:07 INFO - PROCESS | 13025 | __startTimestamp1480523827589__endTimestamp 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | ------- Summary: start ------- 08:37:07 INFO - PROCESS | 13025 | Number of tests: 14 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#0] ai-astar Cycles:10 Average:115.40 Median:116.50 stddev:3.47 (3.0%) stddev-sans-first:1.13 08:37:07 INFO - PROCESS | 13025 | Values: 106.0 116.0 116.0 117.0 118.0 115.0 116.0 118.0 115.0 117.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#1] audio-beat-detection Cycles:10 Average:140.30 Median:135.50 stddev:15.86 (11.7%) stddev-sans-first:15.77 08:37:07 INFO - PROCESS | 13025 | Values: 156.0 136.0 135.0 171.0 130.0 129.0 129.0 129.0 160.0 128.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#2] audio-dft Cycles:10 Average:162.10 Median:162.50 stddev:1.20 (0.7%) stddev-sans-first:1.22 08:37:07 INFO - PROCESS | 13025 | Values: 163.0 160.0 162.0 162.0 163.0 162.0 164.0 161.0 161.0 163.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#3] audio-fft Cycles:10 Average:81.70 Median:77.00 stddev:10.89 (14.1%) stddev-sans-first:11.42 08:37:07 INFO - PROCESS | 13025 | Values: 77.0 76.0 77.0 110.0 78.0 77.0 78.0 76.0 91.0 77.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:84.00 stddev:10.50 (12.5%) stddev-sans-first:10.71 08:37:07 INFO - PROCESS | 13025 | Values: 83.0 84.0 109.0 84.0 85.0 85.0 103.0 83.0 90.0 106.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 08:37:07 INFO - PROCESS | 13025 | Values: 117.0 116.0 117.0 119.0 117.0 118.0 117.0 117.0 117.0 117.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 08:37:07 INFO - PROCESS | 13025 | Values: 147.0 148.0 146.0 148.0 146.0 146.0 147.0 147.0 146.0 146.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:37:07 INFO - PROCESS | 13025 | Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 96.0 95.0 95.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:65.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 08:37:07 INFO - PROCESS | 13025 | Values: 64.0 64.0 64.0 63.0 65.0 64.0 65.0 66.0 65.0 65.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.50 08:37:07 INFO - PROCESS | 13025 | Values: 65.0 66.0 66.0 66.0 67.0 66.0 65.0 66.0 66.0 66.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.95 (3.5%) stddev-sans-first:3.06 08:37:07 INFO - PROCESS | 13025 | Values: 84.0 85.0 85.0 84.0 94.0 85.0 85.0 85.0 85.0 85.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:146.50 stddev:19.74 (13.5%) stddev-sans-first:20.79 08:37:07 INFO - PROCESS | 13025 | Values: 146.0 148.0 146.0 145.0 146.0 156.0 142.0 147.0 208.0 144.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.00 Median:179.50 stddev:2.58 (1.4%) stddev-sans-first:2.74 08:37:07 INFO - PROCESS | 13025 | Values: 179.0 179.0 177.0 177.0 176.0 185.0 180.0 180.0 177.0 180.0 08:37:07 INFO - PROCESS | 13025 | 08:37:07 INFO - PROCESS | 13025 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:72.50 stddev:2.00 (2.8%) stddev-sans-first:2.11 08:37:07 INFO - PROCESS | 13025 | Values: 73.0 72.0 74.0 75.0 72.0 71.0 72.0 75.0 70.0 69.0 08:37:07 INFO - PROCESS | 13025 | -------- Summary: end -------- 08:37:07 INFO - PROCESS | 13025 | 08:37:08 INFO - TEST-INFO | 13025: exit 0 08:37:08 INFO - TEST-OK | kraken | took 65036ms 08:37:08 INFO - SUITE-END | took 1188s 08:37:09 INFO - Completed test suite (00:19:48) 08:37:09 INFO - javascript benchmark 08:37:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2525.797936165107, 2550.260424476902, 2565.474077814048, 2585.03061351993, 2591.76674099331, 4444.755538445384, 4445.866624001281, 4449.288113901776, 4486.5962063414245, 4488.304312831517, 4514.1423129605355, 4536.455625324966, 4537.183307004746, 4556.794944227509, 4620.676552641308, 4157.127003329305, 4178.394132850734, 4217.472815898012, 4217.683673724483, 4342.50061242958, 3880.92591790683, 4184.372344148372, 4272.230998420283, 4313.611774940255, 4355.477342718862, 4132.669386449077, 4166.270902592065, 4204.810783514749, 4267.274563324242, 4281.422008028923, 4206.348016057516, 4210.957890421118, 4213.747175169499, 4214.283571792803, 4217.641500472463, 4211.178820130076, 4212.473440819897, 4212.620864122213, 4213.810378532973, 4214.051838336381, 4501.212287849613, 4557.384753058328, 4574.222382195035, 4583.1062942726185, 4616.953830461686, 4871.14754917888, 4874.53691899269, 4887.608991280689, 4890.951090489085, 4933.7286449245275, 4769.880752981168, 4912.508749125094, 4918.04098200851, 4919.557239848395, 4970.950290497085, 4506.414166158411, 4567.314902764546, 4571.817127314936, 4573.359729637853, 4576.83981060668, 4894.902101957941, 4934.407871055496, 4940.1601727706375, 4965.503449655078, 4993.275974983607, 4695.671303008825, 4738.597219236334, 4740.45484769249, 4777.570018698264, 4778.283257511401, 4805.630559085131, 4810.95189048112, 4813.3983252093485, 4815.95184048155, 4866.513348665176, 4711.081339138835, 4756.048790241965, 4765.499622539653, 4766.451858036301, 4781.043791241766, 4738.691985020962, 4814.013127308894, 4848.466668666444, 4856.368672072608, 4866.732329721899, 4105.67154627629, 4116.814743336557, 4119.382092686061, 4150.0, 4155.148194620096, 3569.5181150544863, 3584.623614520438, 3608.1701208721615, 3610.4042832932796, 3637.6907962823457, 4190.099128687347, 4226.830926762957, 4237.385579091077, 4250.511191212988, 4259.467566554181, 4921.434035086011, 4922.581580565692, 4923.409190897115, 4923.630727695438, 4959.057779021974, 4257.893552661147, 4265.3601959705675, 4265.509466411402, 4271.615554600101, 4296.677749168824, 4238.936415953764, 4323.783810809447, 4332.848350307787, 4370.300751879748, 4444.266695995189, 4559.475660299108, 4569.971756354794, 4571.382863313544, 4571.6799824012, 4573.222552166073, 4833.178359678793, 4845.055214233191, 4847.80608775645, 4848.515148485123, 4849.054434385402, 4569.885752856072, 4571.1543364477675, 4573.565511276423, 4580.427446569179, 4580.702254353457, 4769.57073863354, 4771.332013518041, 4773.188557945227, 4776.522347765195, 4784.138855006132, 4784.545468180518, 4849.224124140121, 4850.345203397637, 4852.975735121302, 4853.126437241331, 4652.3719297895705, 4657.743824089707, 4691.812327506861, 4704.5765881070865, 4708.693934894221, 4703.0, 4712.387389639325, 4717.622590192845, 4719.1741445247635, 4749.430068391815, 4554.2257816172, 4591.885202869955, 4633.235516139934, 4650.069986002881, 4682.531746825426, 4693.671442998957, 4701.529847015271, 4712.646551508582, 4791.233402655698, 4843.055604157155, 4665.0, 4681.274402467623, 4683.718976861399, 4731.0, 4740.573348398522], "value": 4463.4519651207975, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [547.5592148320602, 571.9742611582478, 581.9098039803832, 596.9701514924253, 612.721211848609, 33214.523167982254, 36637.450438243446, 36717.08207294819, 36741.0, 36745.44881826768, 36576.08559786007, 36874.631253687454, 37105.44341834875, 37125.44311835324, 37136.0, 7321.560706357609, 7405.851882962351, 7500.737474188404, 7581.507202031878, 7586.848263034736, 9575.42547447152, 9880.555375008142, 9893.752656183617, 10122.139618132467, 10127.0, 9813.362131461468, 9864.408135511856, 9885.555150018266, 9890.20878329732, 9892.95053524735, 9667.70996870095, 9716.562754676057, 9725.221982241404, 9725.708228753148, 9733.853992190123, 9752.171065459444, 9802.5588848502, 9816.509174541245, 9819.803603927952, 9825.754356141082, 36307.0, 36683.81658091719, 36692.816535917416, 36701.0, 36709.082272943124, 2801.747842694147, 2802.957955630667, 2804.915852524407, 2829.80191386603, 3091.721745042957, 27383.315417114532, 27441.31396715098, 27648.447031059266, 27767.86116069427, 27782.3054423639, 3427.2631384252254, 3434.21013166973, 3453.7582369233915, 3475.7045651119683, 3525.9118522036897, 232385.0, 232475.0, 232818.0154595365, 232889.0, 235381.82309088515, 49126.0, 49523.752381238584, 49537.50462495401, 49540.50459495431, 49548.0, 51518.22722659163, 51558.48441515612, 51817.7409112952, 51819.48180518222, 51942.48057519377, 13326.93336533311, 13751.862481375058, 13773.517926872511, 13781.310934453237, 13789.379477923518, 9006.954965225132, 9303.53482325881, 9312.627494900264, 9494.0, 10726.088282496075, 13509.2569908654, 14968.625784355261, 15405.22973851303, 15447.150406727738, 15782.921085394499, 5697.287839020122, 5754.395788442237, 5762.640744107936, 5784.739686714108, 5863.970680146657, 862.1680078724062, 890.429378193436, 924.6671198368582, 941.3928016429364, 958.6453012385462, 25788.226353209433, 26554.6016809748, 26793.464130717668, 27058.0, 27104.32239194036, 871.2115535440437, 883.8011447424278, 889.9955500222458, 930.5812384426899, 1026.9986762906108, 13148.671283217996, 13762.380692868845, 13789.655258618615, 13953.86046139546, 13969.511067112806, 346014.0, 347554.0, 348587.0, 348677.0, 349367.0, 41026.0, 41311.00990356381, 41375.1724965499, 41406.171876562905, 41409.585904141175, 1068.56188962525, 1103.178132291432, 1141.9429028548705, 1181.1849823621674, 1193.164784650748, 24458.877705611358, 26842.86578567173, 27247.591286130326, 27502.449951000468, 27587.31031724223, 38838.834834955, 39307.213855722155, 39324.606753932094, 39324.606753933236, 39330.2133957325, 262308.0, 263880.0, 263965.0, 264996.0, 265676.0, 23357.883210584518, 37464.438033430066, 37957.0, 38563.0, 38871.6112838868, 36892.81553592215, 37186.814065929495, 38278.808605956794, 40705.0, 40819.795901020305, 34334.313313734085, 34593.0, 35026.0, 35531.64468355283, 36072.45891311685, 34753.478697819046, 35517.467237991965, 35653.82173089118, 35662.64337356593, 35986.4602030975, 32248.0, 32789.83605081959, 32811.50782738309, 33005.84479543204, 33446.0, 30517.0, 31824.36351273008, 32336.676633234307, 32394.514082289257, 32438.189045274055, 23663.408414789767, 23892.641610376206, 24193.274201773977, 24532.632010520214, 24685.62971555392], "value": 17056.395901607375, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.30815981318204, 355.3692196351477, 364.0861437791144, 369.5731430198121, 377.33588883564937, 12363.752724945496, 15606.453774117908, 15906.602334941632, 16038.117903515302, 16355.0, 16411.67176656466, 16458.423955161572, 17080.402185923496, 17096.57258568533, 17227.569310767238, 4923.60611151108, 4947.233178857283, 5114.0, 5132.050570644443, 5150.665206761567, 3640.8907732767925, 3854.0, 5049.899002019957, 5163.845084647448, 5168.405633352157, 5721.170430287606, 5995.460408563228, 6006.099085137243, 6107.26712794463, 6113.908291375633, 5896.115582662635, 6013.939860601382, 6059.939400605982, 6090.817275481742, 6105.664188469655, 5313.787448502094, 5325.547328477084, 5331.173668081415, 5331.840044798662, 5335.706536140549, 19593.510162245915, 20334.0, 20401.081951312226, 20415.89792051045, 20472.385828425173, 1796.4341232511717, 1857.2663797799794, 1882.8493720502463, 1895.4218963216213, 1921.4139687395339, 12728.80906786399, 12743.426545805462, 13061.477540898353, 13138.554938690695, 13484.190948543119, 1528.4115615488006, 1734.1329335332334, 1787.5888545634448, 1824.1973531646033, 1879.2201236486842, 65691.343086569, 65812.67093664501, 66574.66712666406, 67004.6649766753, 68609.31390686079, 9030.28424599324, 9119.954400227956, 9285.953570232241, 9469.289803264783, 9593.13661770444, 12634.557790477289, 12665.620031399072, 12667.239965602093, 12669.619911402488, 12670.936645316715, 6810.829729256809, 6952.826179345557, 7071.434285257167, 7107.964460177769, 7298.0, 6699.966500167566, 6713.6643167842385, 6741.561798483083, 6975.930240697629, 6989.965050174716, 3886.1839013806853, 3947.585503522146, 3980.542237642708, 4025.1748391579654, 4195.412642230091, 1594.5614955886992, 1656.4202529114955, 1683.3434960365466, 1695.203254470397, 1696.8981861088373, 803.6343463723991, 819.2462934100523, 826.0, 830.2278880641062, 887.1793590928365, 15292.847071529364, 17973.191206395742, 18249.0, 18432.539186520175, 18461.0, 801.4411968720899, 821.765796747936, 823.390690888738, 832.8167803083312, 837.0917554453365, 8907.51008694528, 9564.13922746956, 9631.181349585364, 9713.167213702589, 9728.61085556584, 365431.0, 377104.0, 377261.0, 378463.0, 379047.0, 77542.22457775463, 77681.22318776853, 77992.22007779963, 78378.21621783823, 78874.21125788783, 914.7164379042385, 916.8624706293975, 933.2114363362947, 938.5870217104452, 939.6382392778693, 14034.157950523002, 14875.628109297355, 14950.692504160867, 15254.847451525342, 15749.29128189257, 33650.0, 35835.462468063524, 38494.80752596219, 38538.807305964416, 38915.221695565364, 48509.75745121252, 48728.75635621799, 49330.75334623304, 49465.75267123641, 50110.749446252536, 6117.204763380732, 6917.169939607279, 6963.1296087989, 7312.597807120659, 7370.189279179179, 7674.9232507674205, 9704.466254356079, 10414.583416663248, 10754.247202695737, 11038.558457661924, 8774.078721734126, 8797.47215167092, 8932.910670893469, 9186.954065229631, 9396.906030939603, 8172.723844306423, 8348.791280218044, 8721.607527661143, 9208.815823683623, 9397.624095036123, 9034.728958131267, 9485.430874147572, 9555.617775289189, 9806.0, 9831.410115392813, 6887.5178737487895, 6974.267701891228, 7038.964805175941, 7073.3987611053635, 7227.421806255592, 8468.957655211685, 9601.855972160563, 9641.807163856824, 9642.132208101304, 10113.848292275768], "value": 7959.101658409101, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.1540779158488, 1304.621659718682, 1352.2765320553503, 1408.591508462546, 1659.6182877938065, 6335.5565110442285, 6751.594904305745, 7004.404625606823, 7035.718571257144, 7049.964750176255, 6876.518643694943, 6997.965010174942, 6999.860002799941, 7182.892256616155, 7183.102112235971, 1790.8030116687155, 1984.4542750743517, 2029.2288930206576, 2029.4520479470534, 2031.461662659389, 1857.3035111833062, 2020.6362854686151, 2073.5023594337326, 2074.751029876417, 2090.937271881846, 2051.6307064728344, 2054.455569274136, 2057.238821635989, 2058.7529496460447, 2060.629086764382, 2016.1330627830027, 2047.1811275489774, 2054.558269971963, 2059.824914882237, 2060.7527096748336, 2007.076744697441, 2029.5027718208985, 2031.0961622078182, 2047.8668886522478, 2052.8709209934477, 7000.089988301539, 7037.401820845234, 7069.151701795766, 7120.572765634027, 7127.322904324081, 4138.79306034697, 4264.253755592759, 4267.658587313039, 4268.743875367457, 4270.338097594878, 2645.9867700661375, 2708.0, 2749.340158361999, 2794.091920125967, 2794.580812878064, 834.6077343648476, 876.9561521923878, 880.828238493494, 887.8046829697456, 904.5115637555712, 9003.189712925803, 9155.359124861263, 9195.954020229856, 9257.814843703156, 9422.05779422066, 3726.1802403471193, 3806.980965095157, 3910.902227444337, 3916.236333914859, 3929.135590170158, 8302.335813135056, 8303.418760686694, 8304.8339033219, 8311.085780564134, 8313.33493320533, 4295.3771703102875, 4323.329883868006, 4327.1345730853955, 4327.350897365357, 4332.826686932487, 3385.322935412927, 3414.9829250853586, 3904.375299951994, 3905.062784931596, 3906.0820707133803, 3333.7666363354333, 3446.724262059029, 3458.39478091333, 3472.2187507811045, 3565.7860528368383, 1026.645807196516, 1057.1859668055554, 1058.777656692088, 1066.7119877633152, 1072.9195310351754, 674.5345711459078, 682.5699809120322, 725.8911163325438, 727.1601300497828, 750.8310630108291, 4425.557444255549, 4473.172463094338, 4789.233722604366, 4849.078675051799, 4874.2444921037295, 818.55388813097, 846.7798372423214, 859.6604341285282, 908.9020976946123, 928.2570005633472, 3143.669914658928, 3156.447621666245, 3185.1240908749814, 3229.9677003229667, 3383.052745231339, 7901.091374491892, 7985.0, 8061.2744852963515, 8077.35381169505, 8096.433249672466, 8013.919860801318, 8020.0375954885785, 8023.237792409712, 8027.036755589366, 8034.397420193392, 6695.966520167465, 6783.796486105425, 6806.115205023414, 6818.045473633695, 6822.0, 4668.789904454376, 4685.812567497262, 4796.232602783677, 4809.2064809306075, 4878.341423907869, 7664.156942736183, 7793.415493838098, 7902.24928631779, 7919.802004949923, 7932.881006784787, 7846.0, 7967.0, 7977.122516523062, 8004.7198348059865, 8020.799480013046, 5037.672551284301, 5151.407588127413, 5720.3421606515785, 5776.480116789509, 5852.473277404883, 6510.316416776171, 6709.496787741036, 6714.227863795726, 6763.93236067633, 6820.829479263058, 5889.116632505158, 5922.703864806828, 5963.7912673056235, 5972.8805423892145, 6043.516518678407, 5742.913856292075, 5749.080147176432, 5792.652440853562, 5833.358330583547, 5875.294964604275, 5723.5707321950185, 5744.30263446983, 5759.193712880284, 5803.7968671096305, 5806.738696758741, 3944.9408258876715, 4029.8992525187105, 4054.412110244057, 4101.753894766323, 4244.639205667553, 4047.8785636430953, 4057.046594050455, 4119.382092686121, 4127.277726397929, 4246.3842742802735], "value": 3742.0952849749533, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [269.46645641629567, 271.85591636432696, 275.5054676855045, 278.33755661525566, 281.4202742350756, 4574.99350142968, 4698.64760142989, 4722.724864286641, 4751.976240118799, 4805.519448055193, 4575.6730548140995, 4660.5339466053465, 4669.463011753649, 4707.529247075291, 4711.929321060187, 3500.299940011995, 3601.567811862567, 3616.2948225096115, 3673.246984368198, 3675.9632403675955, 3682.054356514791, 3684.5946945835935, 3689.1883785567134, 3695.150115473443, 3697.3899306614376, 3635.1457407509215, 3644.908877278063, 3654.762440441376, 3656.451532270154, 3667.8716244931434, 3658.8353524091212, 3660.249648821985, 3671.6781958495053, 3673.2469843682247, 3687.446882967576, 3144.811311321328, 3194.4888817789274, 3197.2646291353117, 3198.9923174200053, 3227.4190645683766, 4521.638268938477, 4540.72755634663, 4557.0, 4562.58936695699, 4565.497795242521, 4112.897177570555, 4113.321301985169, 4117.402976568411, 4121.918431192229, 4129.318662420697, 4743.596794272491, 4865.975670121662, 4872.1473742094995, 4878.365812444395, 4889.853304400874, 3428.3314753623054, 3457.878974235915, 3458.7345288835854, 3459.8270086495572, 3470.6008808987035, 5116.820911268125, 5131.486851314876, 5132.974335128338, 5158.277841102249, 5178.300929374524, 3542.1144713821545, 3552.5381700378784, 3556.644335566423, 3557.3596752584785, 3563.251717139378, 3360.5967283926084, 3538.203904121552, 3548.432250839853, 3609.115766637138, 3617.3488772021287, 4049.797510124541, 4053.3919912013434, 4053.5541090480024, 4067.206894655573, 4091.9590804091577, 4639.37368455261, 4698.7415692137265, 4777.331173635694, 4855.174620314555, 4934.1611925972675, 1212.7210741529498, 1221.8167274908658, 1226.8957937856, 1228.4103630257348, 1229.7786398448366, 828.9709860154866, 841.9452735572169, 845.8350621628723, 852.4075767341762, 858.6651206029653, 4183.518895327015, 4196.307609244502, 4207.200631879994, 4231.89970607638, 4236.766977816188, 4864.73243971585, 4879.780409881564, 4897.2654101885, 4904.288878112654, 4909.410870695468, 4229.513605935295, 4231.132617813341, 4232.30167022444, 4265.7440553566885, 4266.445362102969, 2538.9873050634997, 2543.949121017606, 2547.4522977559914, 2558.93602659935, 2613.490369377991, 4546.272596384562, 4558.772061396917, 4612.976935115303, 4614.292711696694, 4614.677432248843, 4970.950290497121, 4982.202847544376, 4987.80048798044, 4991.201407774739, 5057.898842023139, 4400.933985990213, 4608.815647374135, 4632.652551058617, 4634.745089020069, 4659.347691323217, 4901.264810278487, 4906.503516427524, 4915.311856340044, 4933.457319694759, 4981.4769449207315, 4861.343718597944, 4873.87815304606, 4878.390201224847, 4881.73150476713, 4889.46215916256, 4482.663800214932, 4586.334981427608, 4599.241125214436, 4610.953890461053, 4645.910469537719, 3499.33512632599, 3504.176518518197, 3514.2268700885766, 3516.9824150880104, 3546.8049257290063, 4873.95126048735, 4910.729909854849, 4917.459079501324, 4982.377202849644, 4990.8253211137435, 4853.684510506806, 4862.513748625109, 4868.5637736867, 4879.536444037811, 4887.3890763654545, 4856.878578035577, 4889.266610008527, 4913.70517768935, 4935.555799978019, 4938.802447902043, 4662.510436404129, 4761.357216775691, 4777.474477807508, 4807.543283388072, 4817.229243321051, 4904.773806548363, 4915.926261106158, 4941.555260026615, 4957.4794646561595, 4960.627952903619, 4811.615070794398, 4820.493848145894, 4841.975790121027, 4866.416030076413, 4883.90232195347], "value": 3649.1683899965474, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [540.9296791417114, 545.1849485019895, 565.2453973944783, 565.776518275281, 571.6312978129105, 11443.713907152325, 12138.0, 12205.938970305137, 12228.449719762599, 12401.56594519192, 11637.069034477243, 11757.647270581874, 11853.288802671825, 11881.702957426069, 11891.464884080215, 590.4538302070589, 739.1130643228121, 753.600591686407, 754.4002517998205, 755.8979537762386, 605.3794860268239, 729.2853004056028, 747.5477336211595, 754.4115589839934, 756.2588663110155, 784.8626490364163, 786.9488483248571, 787.3622365883624, 787.9684812607488, 788.4993029426298, 618.2766163588567, 781.6091954022988, 781.6404453951133, 782.2803021220491, 782.49138060261, 469.5163981099473, 557.1030640668521, 572.4104172702123, 573.0001147996772, 574.4399210769467, 11879.40602969848, 11879.584214552535, 11884.346360950145, 12003.399830008464, 12017.699557511045, 11534.13493987946, 11865.940670296593, 11944.88055119455, 12177.208481448677, 12983.09118361715, 11183.44082795857, 11451.541938322458, 11653.70865728355, 11794.230865370177, 12335.0, 3930.803459827026, 3950.644442000234, 3956.2285354355913, 3980.8208630611693, 4052.8784136475656, 62143.06785398268, 62749.0, 62824.68587657078, 63381.68309158471, 64192.0, 9610.615575377047, 9664.565094570762, 9744.512774361254, 9772.951135244279, 9970.501474926225, 17152.0, 17249.0, 17250.65498690019, 17276.481705548853, 17281.827181728273, 5839.416058394127, 5884.970575147183, 5896.882062358729, 6096.969515152396, 6108.664023478751, 3299.736021118305, 3413.5903691557173, 3425.53755243044, 3437.037629463754, 3478.0261526772542, 2419.395151212197, 2481.5905375613183, 2506.0602274147195, 2519.8110141739076, 2524.8358856674627, 431.0258815077946, 431.16569438137304, 433.84598467544197, 461.08704764566346, 485.2938973793122, 484.706752414791, 496.0599663637387, 503.86647538402354, 520.7604501929079, 542.3058485139028, 6896.965515172493, 6915.412189963909, 6956.234814170437, 6983.092198014226, 7149.571025738473, 511.5396143470906, 522.7046718603976, 526.1712802336335, 539.6681041159737, 545.7735039958452, 3170.873165073371, 3316.5688460499982, 3378.0, 3406.0, 3434.8797792077157, 60207.397926021054, 60718.392816071275, 62070.379296207364, 63766.36233637604, 65902.67048664726, 54015.729921350925, 54379.0, 55247.447525525036, 55329.0, 56966.0, 44247.11505769931, 44408.55591444044, 49872.750636247314, 50292.49707502951, 50294.0, 7567.432442566719, 8031.919680803117, 8164.224398682116, 8212.753617391489, 8403.663853445794, 34759.0, 35865.46201806923, 36653.45019824758, 36667.81666091653, 37184.07039824026, 41037.58962410457, 44983.55016449794, 47134.764326179524, 47346.76326618345, 47670.52329476661, 10083.949580252052, 10312.742181445525, 10494.0, 10605.946970265099, 10627.468626568796, 11512.366819824654, 11895.583654572049, 12100.455479503267, 12159.270443773403, 12271.325077120488, 10421.635242766466, 10422.218333624856, 10536.789264214825, 10590.8411373831, 10923.12614990783, 10976.560937562728, 10984.450777461256, 11152.107831373633, 11177.66467005991, 11704.765904682028, 10270.281080324306, 10337.534810933677, 10516.57933682644, 10575.524101415609, 10789.352638841694, 9447.0, 9597.184239339455, 9652.71041868717, 9816.411015338817, 10324.845127323246, 8731.607077681392, 9186.954065229631, 9342.579583918876, 9348.392354496937, 9507.144357007903], "value": 5852.985036964439, "unit": "score"}], "name": "dromaeo_css", "value": 6037.54742505457, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 116.0, 117.0, 118.0, 115.0, 116.0, 118.0, 115.0, 117.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 136.0, 135.0, 171.0, 130.0, 129.0, 129.0, 129.0, 160.0, 128.0], "value": 140.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 160.0, 162.0, 162.0, 163.0, 162.0, 164.0, 161.0, 161.0, 163.0], "value": 162.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 110.0, 78.0, 77.0, 78.0, 76.0, 91.0, 77.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 109.0, 84.0, 85.0, 85.0, 103.0, 83.0, 90.0, 106.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 119.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 146.0, 148.0, 146.0, 146.0, 147.0, 147.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 65.0, 64.0, 65.0, 66.0, 65.0, 65.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 66.0, 66.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 94.0, 85.0, 85.0, 85.0, 85.0, 85.0], "value": 85.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 148.0, 146.0, 145.0, 146.0, 156.0, 142.0, 147.0, 208.0, 144.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 179.0, 177.0, 177.0, 176.0, 185.0, 180.0, 180.0, 177.0, 180.0], "value": 179.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 72.0, 74.0, 75.0, 72.0, 71.0, 72.0, 75.0, 70.0, 69.0], "value": 72.3, "unit": "score"}], "name": "kraken", "value": 1570.0000000000002, "alertThreshold": 2.0}]} 08:37:09 INFO - Return code: 0 08:37:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:37:09 INFO - # TBPL SUCCESS # 08:37:09 INFO - Running post-action listener: _resource_record_post_action 08:37:09 INFO - [mozharness: 2016-11-30 16:37:09.389056Z] Finished run-tests step (success) 08:37:09 INFO - Running post-run listener: _resource_record_post_run 08:37:09 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 401522688; Read time: 104; Write time: 249952 08:37:09 INFO - TinderboxPrint: CPU usage
13.1% 08:37:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 104 08:37:09 INFO - TinderboxPrint: I/O write bytes / time
401,522,688 / 249,952 08:37:09 INFO - TinderboxPrint: CPU idle
8,354.0 (86.9%) 08:37:09 INFO - TinderboxPrint: CPU user
1,211.1 (12.6%) 08:37:09 INFO - TinderboxPrint: Swap in / out
0 / 0 08:37:09 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110637056; Read time: 0; Write time: 66260 08:37:09 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289857536; Read time: 104; Write time: 183668 08:37:10 INFO - Running post-run listener: _upload_blobber_files 08:37:10 INFO - Blob upload gear active. 08:37:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:37:10 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 08:37:10 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:37:10 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:37:10 INFO - (blobuploader) - INFO - Open directory for files ... 08:37:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:37:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:37:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:11 INFO - (blobuploader) - INFO - Done attempting. 08:37:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:37:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:37:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:12 INFO - (blobuploader) - INFO - Done attempting. 08:37:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:37:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:37:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:37:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:37:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:37:15 INFO - (blobuploader) - INFO - Done attempting. 08:37:15 INFO - (blobuploader) - INFO - Iteration through files over. 08:37:15 INFO - Return code: 0 08:37:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:37:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:37:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb76bfec7aada1f1346ddcdf21c9d280ed90c3a96679296a30e7029db149bf515e138096c927c923e46aae39e43e1fd94004df983b614a8ce651151a48d0804e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fba46b895b10482a87d7754e37749b4162ee5cb371d591afa0a6da97b1dbdeb9a7b6c6854871b89fb0c8636a733f384508161ecb8cb93033f5580478f12b957", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f361759d285ae78514bc264ef1466ccff81820584868b9a93480670c7c5ab17f9972881e106fc7af7a8be0563b233403e5cffe6d348495c77720ed23948ec8f"} 08:37:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:37:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:37:15 INFO - Contents: 08:37:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb76bfec7aada1f1346ddcdf21c9d280ed90c3a96679296a30e7029db149bf515e138096c927c923e46aae39e43e1fd94004df983b614a8ce651151a48d0804e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fba46b895b10482a87d7754e37749b4162ee5cb371d591afa0a6da97b1dbdeb9a7b6c6854871b89fb0c8636a733f384508161ecb8cb93033f5580478f12b957", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f361759d285ae78514bc264ef1466ccff81820584868b9a93480670c7c5ab17f9972881e106fc7af7a8be0563b233403e5cffe6d348495c77720ed23948ec8f"} 08:37:15 INFO - Running post-run listener: copy_logs_to_upload_dir 08:37:15 INFO - Copying logs to upload dir... 08:37:15 INFO - mkdir: /builds/slave/test/build/upload/logs 08:37:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.181141 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-11-30 08:37:14.979651) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 08:37:14.983121) ========= 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=db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb76bfec7aada1f1346ddcdf21c9d280ed90c3a96679296a30e7029db149bf515e138096c927c923e46aae39e43e1fd94004df983b614a8ce651151a48d0804e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fba46b895b10482a87d7754e37749b4162ee5cb371d591afa0a6da97b1dbdeb9a7b6c6854871b89fb0c8636a733f384508161ecb8cb93033f5580478f12b957", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f361759d285ae78514bc264ef1466ccff81820584868b9a93480670c7c5ab17f9972881e106fc7af7a8be0563b233403e5cffe6d348495c77720ed23948ec8f"} build_url:https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011916 build_url: 'https://queue.taskcluster.net/v1/task/ZooZH85lSY-vDe3NvTu_7A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bb76bfec7aada1f1346ddcdf21c9d280ed90c3a96679296a30e7029db149bf515e138096c927c923e46aae39e43e1fd94004df983b614a8ce651151a48d0804e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6fba46b895b10482a87d7754e37749b4162ee5cb371d591afa0a6da97b1dbdeb9a7b6c6854871b89fb0c8636a733f384508161ecb8cb93033f5580478f12b957", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6f361759d285ae78514bc264ef1466ccff81820584868b9a93480670c7c5ab17f9972881e106fc7af7a8be0563b233403e5cffe6d348495c77720ed23948ec8f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-30 08:37:15.009171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:37:15.009619) ========= 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=db7e7c15f3ca076d53731445000001ba-1480522585.930128-1695267644 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-30 08:37:15.093859) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 08:37:15.094199) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-30 08:37:15.094518) ========= ========= Total master_lag: 0.17 =========