builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-025 starttime: 1479396995.18 results: success (0) buildid: 20161117060528 builduid: ffe7cc22040b41db9d8be4bb9032600a revision: 05e5b12f41df270b31955ff7e6d09245c1f83a7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:35.182286) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:35.182718) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:35.182991) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:35.197262) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:35.197518) ========= 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=232498196343f89f466a4a9a000001c8-1479396995.463775-520358466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 07:36:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 88.8M=0s 2016-11-17 07:36:36 (88.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.072202 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:35.283016) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:35.283292) ========= 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=232498196343f89f466a4a9a000001c8-1479396995.463775-520358466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016867 ========= master_lag: 0.07 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:35.369056) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:35.369359) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 05e5b12f41df270b31955ff7e6d09245c1f83a7a --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 05e5b12f41df270b31955ff7e6d09245c1f83a7a --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=232498196343f89f466a4a9a000001c8-1479396995.463775-520358466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 07:36:36,406 truncating revision to first 12 chars 2016-11-17 07:36:36,406 Setting DEBUG logging. 2016-11-17 07:36:36,406 attempt 1/10 2016-11-17 07:36:36,406 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/05e5b12f41df?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 07:36:36,820 unpacking tar archive at: mozilla-central-05e5b12f41df/testing/mozharness/ program finished with exit code 0 elapsedTime=0.724008 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:36.106445) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:36.106776) ========= script_repo_revision: 05e5b12f41df270b31955ff7e6d09245c1f83a7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:36.107180) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:36.107442) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 07:36:36.115230) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-17 07:36:36.115492) ========= /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=232498196343f89f466a4a9a000001c8-1479396995.463775-520358466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:36:37 INFO - MultiFileLogger online at 20161117 07:36:37 in /builds/slave/test 07:36:37 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 07:36:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:36:37 INFO - {'append_to_log': False, 07:36:37 INFO - 'base_work_dir': '/builds/slave/test', 07:36:37 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:36:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:36:37 INFO - 'branch': 'Firefox-Non-PGO', 07:36:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:36:37 INFO - 'config_files': ('talos/linux_config.py',), 07:36:37 INFO - 'default_actions': ('clobber', 07:36:37 INFO - 'read-buildbot-config', 07:36:37 INFO - 'download-and-extract', 07:36:37 INFO - 'populate-webroot', 07:36:37 INFO - 'create-virtualenv', 07:36:37 INFO - 'install', 07:36:37 INFO - 'run-tests'), 07:36:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:36:37 INFO - 'download_minidump_stackwalk': True, 07:36:37 INFO - 'download_symbols': 'ondemand', 07:36:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:36:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:36:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:36:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:36:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:36:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:36:37 INFO - 'installer_path': 'installer.exe', 07:36:37 INFO - 'log_level': 'info', 07:36:37 INFO - 'log_name': 'talos', 07:36:37 INFO - 'log_to_console': True, 07:36:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:36:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:36:37 INFO - 'opt_config_files': (), 07:36:37 INFO - 'pip_index': False, 07:36:37 INFO - 'sps_profile': False, 07:36:37 INFO - 'sps_profile_interval': 0, 07:36:37 INFO - 'suite': 'dromaeojs', 07:36:37 INFO - 'system_bits': '32', 07:36:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:36:37 INFO - 'title': 'talos-linux64-ix-025', 07:36:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:36:37 INFO - 'use_talos_json': True, 07:36:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:36:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:36:37 INFO - 'work_dir': 'build'} 07:36:37 INFO - [mozharness: 2016-11-17 15:36:37.251313Z] Running clobber step. 07:36:37 INFO - Running pre-action listener: _resource_record_pre_action 07:36:37 INFO - Running main action method: clobber 07:36:37 INFO - rmtree: /builds/slave/test/build 07:36:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:36:37 INFO - Running post-action listener: _resource_record_post_action 07:36:37 INFO - [mozharness: 2016-11-17 15:36:37.738181Z] Finished clobber step (success) 07:36:37 INFO - [mozharness: 2016-11-17 15:36:37.738278Z] Running read-buildbot-config step. 07:36:37 INFO - Running pre-action listener: _resource_record_pre_action 07:36:37 INFO - Running main action method: read_buildbot_config 07:36:37 INFO - Using buildbot properties: 07:36:37 INFO - { 07:36:37 INFO - "project": "", 07:36:37 INFO - "product": "firefox", 07:36:37 INFO - "script_repo_revision": "production", 07:36:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:36:37 INFO - "repository": "", 07:36:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:36:37 INFO - "buildid": "20161117060528", 07:36:37 INFO - "pgo_build": "False", 07:36:37 INFO - "basedir": "/builds/slave/test", 07:36:37 INFO - "buildnumber": 819, 07:36:37 INFO - "slavename": "talos-linux64-ix-025", 07:36:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:36:37 INFO - "platform": "ubuntu64_hw", 07:36:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:36:37 INFO - "branch": "mozilla-central", 07:36:37 INFO - "repo_path": "mozilla-central", 07:36:37 INFO - "revision": "05e5b12f41df270b31955ff7e6d09245c1f83a7a", 07:36:37 INFO - "stage_platform": "linux64", 07:36:37 INFO - "builduid": "ffe7cc22040b41db9d8be4bb9032600a", 07:36:37 INFO - "slavebuilddir": "test" 07:36:37 INFO - } 07:36:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 07:36:37 INFO - Running post-action listener: _resource_record_post_action 07:36:37 INFO - [mozharness: 2016-11-17 15:36:37.740704Z] Finished read-buildbot-config step (success) 07:36:37 INFO - [mozharness: 2016-11-17 15:36:37.740792Z] Running download-and-extract step. 07:36:37 INFO - Running pre-action listener: _resource_record_pre_action 07:36:37 INFO - Running main action method: download_and_extract 07:36:37 INFO - mkdir: /builds/slave/test/build/tests 07:36:37 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')]} 07:36:37 INFO - trying https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:36:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/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 07:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/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 07:36:38 INFO - Downloaded 1361 bytes. 07:36:38 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 07:36:38 INFO - Using the following test package requirements: 07:36:38 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:38 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:36:38 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:36:38 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:38 INFO - u'jsshell-linux-x86_64.zip'], 07:36:38 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:36:38 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 07:36:38 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:36:38 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:36:38 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:36:38 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 07:36:38 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:36:38 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:36:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:36:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:36:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:36:39 INFO - Http code: 200 07:36:39 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 07:36:39 INFO - x-amz-cf-id: nmifVMir4TIY3l2u9egytMIO9Bw5ZDCVdXWjeCEWXMpqnHIWeJNHcQ== 07:36:39 INFO - x-amz-version-id: lhjbENKS7eIwVYvIsxHTQz1GbWKcbXbQ 07:36:39 INFO - Expected file size: 20361374 07:36:39 INFO - Obtained file size: 20361374 07:36:43 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 07:36:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 07:36:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:36:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:36:43 INFO - Http code: 200 07:36:43 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 07:36:43 INFO - x-amz-cf-id: SvN-DfEvztCidx_ZM_EKniQZPNYzBkze53NceoXckpfiWAWmnuBXqg== 07:36:43 INFO - x-amz-version-id: lhjbENKS7eIwVYvIsxHTQz1GbWKcbXbQ 07:36:44 INFO - Expected file size: 20361374 07:36:44 INFO - Obtained file size: 20361374 07:36:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 07:36:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:36:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:36:49 INFO - Http code: 200 07:36:49 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 07:36:49 INFO - x-amz-cf-id: f3Cotb8v8JFNRMZMEDMjon7eduRkZFZURTV8XgsayZ63xODj9IHXbg== 07:36:49 INFO - x-amz-version-id: .8Dkkq.1lfbHqXYRM4iZ.D76197GatMu 07:36:49 INFO - Expected file size: 14409392 07:36:49 INFO - Obtained file size: 14409392 07:36: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')]} 07:36:49 INFO - trying https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:36:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/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 07:36:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/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 07:36:50 INFO - Downloaded 55716270 bytes. 07:36:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:36:50 INFO - mkdir: /builds/slave/test/properties 07:36:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:36:50 INFO - Writing to file /builds/slave/test/properties/build_url 07:36:50 INFO - Contents: 07:36:50 INFO - build_url:https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 07:36:51 INFO - Running post-action listener: _resource_record_post_action 07:36:51 INFO - Running post-action listener: set_extra_try_arguments 07:36:51 INFO - [mozharness: 2016-11-17 15:36:51.455893Z] Finished download-and-extract step (success) 07:36:51 INFO - [mozharness: 2016-11-17 15:36:51.456155Z] Running populate-webroot step. 07:36:51 INFO - Running pre-action listener: _resource_record_pre_action 07:36:51 INFO - Running main action method: populate_webroot 07:36:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:36:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:36:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:36:51 INFO - '--tppagecycles', 07:36:51 INFO - '7'], 07:36:51 INFO - 'tests': ['tsvgm']}}, 07:36:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:36:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:36:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:36:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:36:51 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:36:51 INFO - 'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:51 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:36:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:36:51 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:36:51 INFO - 'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['damp', 'tps']}, 07:36:51 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:36:51 INFO - 'tests': ['damp', 'tps']}, 07:36:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['dromaeo_dom']}, 07:36:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:36:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['basic_compositor_video']}, 07:36:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:36:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['a11yr', 07:36:51 INFO - 'ts_paint', 07:36:51 INFO - 'tpaint', 07:36:51 INFO - 'sessionrestore', 07:36:51 INFO - 'sessionrestore_no_auto_restore', 07:36:51 INFO - 'tabpaint']}, 07:36:51 INFO - 'other-e10s': {'tests': ['a11yr', 07:36:51 INFO - 'ts_paint', 07:36:51 INFO - 'tpaint', 07:36:51 INFO - 'sessionrestore', 07:36:51 INFO - 'sessionrestore_no_auto_restore', 07:36:51 INFO - 'tabpaint']}, 07:36:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:36:51 INFO - 'ts_paint', 07:36:51 INFO - 'tpaint', 07:36:51 INFO - 'sessionrestore', 07:36:51 INFO - 'sessionrestore_no_auto_restore', 07:36:51 INFO - 'tabpaint']}, 07:36:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:36:51 INFO - 'ts_paint', 07:36:51 INFO - 'tpaint', 07:36:51 INFO - 'sessionrestore', 07:36:51 INFO - 'sessionrestore_no_auto_restore', 07:36:51 INFO - 'tabpaint']}, 07:36:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['a11yr', 07:36:51 INFO - 'ts_paint', 07:36:51 INFO - 'tpaint', 07:36:51 INFO - 'sessionrestore', 07:36:51 INFO - 'sessionrestore_no_auto_restore', 07:36:51 INFO - 'tabpaint']}, 07:36:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['a11yr', 07:36:51 INFO - 'ts_paint', 07:36:51 INFO - 'tpaint', 07:36:51 INFO - 'sessionrestore', 07:36:51 INFO - 'sessionrestore_no_auto_restore', 07:36:51 INFO - 'tabpaint']}, 07:36:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['tsvgx', 07:36:51 INFO - 'tsvgr_opacity', 07:36:51 INFO - 'tart', 07:36:51 INFO - 'tscrollx', 07:36:51 INFO - 'cart']}, 07:36:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:36:51 INFO - 'tsvgr_opacity', 07:36:51 INFO - 'tart', 07:36:51 INFO - 'tscrollx', 07:36:51 INFO - 'cart']}, 07:36:51 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:36:51 INFO - 'talos_options': ['--disable-e10s'], 07:36:51 INFO - 'tests': ['tp5o']}, 07:36:51 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:36:51 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:36:51 INFO - 'talos_options': ['--disable-e10s', 07:36:51 INFO - '--xperf_path', 07:36:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:51 INFO - 'tests': ['tp5n']}, 07:36:51 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:36:51 INFO - 'talos_options': ['--xperf_path', 07:36:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:36:51 INFO - 'tests': ['tp5n']}}, 07:36:51 INFO - 'talos.zip': {'path': '', 07:36:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:36:51 INFO - Running post-action listener: _resource_record_post_action 07:36:51 INFO - [mozharness: 2016-11-17 15:36:51.471378Z] Finished populate-webroot step (success) 07:36:51 INFO - [mozharness: 2016-11-17 15:36:51.471466Z] Running create-virtualenv step. 07:36:51 INFO - Running pre-action listener: _resource_record_pre_action 07:36:51 INFO - Running main action method: create_virtualenv 07:36:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:36:51 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 07:36:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:36:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:36:51 INFO - Using real prefix '/usr' 07:36:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:36:52 INFO - Installing distribute.............................................................................................................................................................................................done. 07:36:54 INFO - Installing pip.................done. 07:36:54 INFO - Return code: 0 07:36:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:36:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:36:54 INFO - Reading from file tmpfile_stdout 07:36:54 INFO - Output received: 07:36:54 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) 07:36:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:36:54 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')]} 07:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:54 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')]} 07:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:54 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 0x7fc5192b8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, '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': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', '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 07:36:54 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 07:36:54 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 07:36:54 INFO - Using env: {'DISPLAY': ':0', 07:36:54 INFO - 'HOME': '/home/cltbld', 07:36:54 INFO - 'LANG': 'en_US.UTF-8', 07:36:54 INFO - 'LANGUAGE': 'en_US:en', 07:36:54 INFO - 'LOGNAME': 'cltbld', 07:36:54 INFO - 'MAIL': '/var/mail/cltbld', 07:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:54 INFO - 'MOZ_NO_REMOTE': '1', 07:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:54 INFO - 'NO_EM_RESTART': '1', 07:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:54 INFO - 'PWD': '/builds/slave/test', 07:36:54 INFO - 'SHELL': '/bin/bash', 07:36:54 INFO - 'SHLVL': '1', 07:36:54 INFO - 'TERM': 'linux', 07:36:54 INFO - 'TMOUT': '86400', 07:36:54 INFO - 'USER': 'cltbld', 07:36:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:54 INFO - '_': '/tools/buildbot/bin/python'} 07:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:54 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 07:36:54 INFO - Cleaning up... 07:36:54 INFO - Return code: 0 07:36:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:36:54 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')]} 07:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:54 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')]} 07:36:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:54 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 0x7fc5192b8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, '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': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', '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 07:36:54 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 07:36:54 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 07:36:54 INFO - Using env: {'DISPLAY': ':0', 07:36:54 INFO - 'HOME': '/home/cltbld', 07:36:54 INFO - 'LANG': 'en_US.UTF-8', 07:36:54 INFO - 'LANGUAGE': 'en_US:en', 07:36:54 INFO - 'LOGNAME': 'cltbld', 07:36:54 INFO - 'MAIL': '/var/mail/cltbld', 07:36:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:54 INFO - 'MOZ_NO_REMOTE': '1', 07:36:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:54 INFO - 'NO_EM_RESTART': '1', 07:36:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:54 INFO - 'PWD': '/builds/slave/test', 07:36:54 INFO - 'SHELL': '/bin/bash', 07:36:54 INFO - 'SHLVL': '1', 07:36:54 INFO - 'TERM': 'linux', 07:36:54 INFO - 'TMOUT': '86400', 07:36:54 INFO - 'USER': 'cltbld', 07:36:54 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:36:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:54 INFO - '_': '/tools/buildbot/bin/python'} 07:36:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:54 INFO - Downloading/unpacking psutil>=3.1.1 07:36:54 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 07:36:54 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 07:36:54 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 07:36:54 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 07:36:54 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 07:36:54 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 07:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:36:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:56 INFO - Installing collected packages: psutil 07:36:56 INFO - Running setup.py install for psutil 07:36:56 INFO - building 'psutil._psutil_linux' extension 07:36:56 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 07:36:57 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 07:36:57 INFO - building 'psutil._psutil_posix' extension 07:36:57 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 07:36:57 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 07:36:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:36:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:36:57 INFO - Successfully installed psutil 07:36:57 INFO - Cleaning up... 07:36:57 INFO - Return code: 0 07:36:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:36:57 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')]} 07:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:57 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')]} 07:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:57 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 0x7fc5192b8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, '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': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', '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 07:36:57 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 07:36:57 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 07:36:57 INFO - Using env: {'DISPLAY': ':0', 07:36:57 INFO - 'HOME': '/home/cltbld', 07:36:57 INFO - 'LANG': 'en_US.UTF-8', 07:36:57 INFO - 'LANGUAGE': 'en_US:en', 07:36:57 INFO - 'LOGNAME': 'cltbld', 07:36:57 INFO - 'MAIL': '/var/mail/cltbld', 07:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:57 INFO - 'MOZ_NO_REMOTE': '1', 07:36:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:57 INFO - 'NO_EM_RESTART': '1', 07:36:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:57 INFO - 'PWD': '/builds/slave/test', 07:36:57 INFO - 'SHELL': '/bin/bash', 07:36:57 INFO - 'SHLVL': '1', 07:36:57 INFO - 'TERM': 'linux', 07:36:57 INFO - 'TMOUT': '86400', 07:36:57 INFO - 'USER': 'cltbld', 07:36:57 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:57 INFO - '_': '/tools/buildbot/bin/python'} 07:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:36:57 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 07:36:57 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 07:36:57 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 07:36:57 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 07:36:57 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 07:36:57 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 07:36:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:36:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:36:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:36:59 INFO - Installing collected packages: mozsystemmonitor 07:36:59 INFO - Running setup.py install for mozsystemmonitor 07:36:59 INFO - Successfully installed mozsystemmonitor 07:36:59 INFO - Cleaning up... 07:36:59 INFO - Return code: 0 07:36:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:36: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')]} 07:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36: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')]} 07:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:36:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5192b8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, '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': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', '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 07:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:36:59 INFO - Using env: {'DISPLAY': ':0', 07:36:59 INFO - 'HOME': '/home/cltbld', 07:36:59 INFO - 'LANG': 'en_US.UTF-8', 07:36:59 INFO - 'LANGUAGE': 'en_US:en', 07:36:59 INFO - 'LOGNAME': 'cltbld', 07:36:59 INFO - 'MAIL': '/var/mail/cltbld', 07:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:36:59 INFO - 'MOZ_NO_REMOTE': '1', 07:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:36:59 INFO - 'NO_EM_RESTART': '1', 07:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:36:59 INFO - 'PWD': '/builds/slave/test', 07:36:59 INFO - 'SHELL': '/bin/bash', 07:36:59 INFO - 'SHLVL': '1', 07:36:59 INFO - 'TERM': 'linux', 07:36:59 INFO - 'TMOUT': '86400', 07:36:59 INFO - 'USER': 'cltbld', 07:36:59 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:36:59 INFO - '_': '/tools/buildbot/bin/python'} 07:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:36:59 INFO - Downloading/unpacking jsonschema==2.5.1 07:36:59 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 07:36:59 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 07:36:59 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 07:36:59 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 07:36:59 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 07:36:59 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 07:37:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:37:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37: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 07:37:02 INFO - Downloading functools32-3.2.3-2.tar.gz 07:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:37:02 INFO - warning: no files found matching '*.txt' 07:37:02 INFO - no previously-included directories found matching 'build' 07:37:02 INFO - no previously-included directories found matching 'dist' 07:37:02 INFO - no previously-included directories found matching '.git*' 07:37:02 INFO - Installing collected packages: jsonschema, functools32 07:37:02 INFO - Running setup.py install for functools32 07:37:02 INFO - warning: no files found matching '*.txt' 07:37:02 INFO - no previously-included directories found matching 'build' 07:37:02 INFO - no previously-included directories found matching 'dist' 07:37:02 INFO - no previously-included directories found matching '.git*' 07:37:02 INFO - Successfully installed jsonschema functools32 07:37:02 INFO - Cleaning up... 07:37:02 INFO - Return code: 0 07:37:02 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5192b8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, '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': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', '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 07:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:37:02 INFO - Using env: {'DISPLAY': ':0', 07:37:02 INFO - 'HOME': '/home/cltbld', 07:37:02 INFO - 'LANG': 'en_US.UTF-8', 07:37:02 INFO - 'LANGUAGE': 'en_US:en', 07:37:02 INFO - 'LOGNAME': 'cltbld', 07:37:02 INFO - 'MAIL': '/var/mail/cltbld', 07:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:02 INFO - 'MOZ_NO_REMOTE': '1', 07:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:02 INFO - 'NO_EM_RESTART': '1', 07:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:02 INFO - 'PWD': '/builds/slave/test', 07:37:02 INFO - 'SHELL': '/bin/bash', 07:37:02 INFO - 'SHLVL': '1', 07:37:02 INFO - 'TERM': 'linux', 07:37:02 INFO - 'TMOUT': '86400', 07:37:02 INFO - 'USER': 'cltbld', 07:37:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:02 INFO - '_': '/tools/buildbot/bin/python'} 07:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:02 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:37:02 INFO - Cleaning up... 07:37:02 INFO - Return code: 0 07:37:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc5192b8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, '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': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', '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 07:37:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:37:02 INFO - Using env: {'DISPLAY': ':0', 07:37:02 INFO - 'HOME': '/home/cltbld', 07:37:02 INFO - 'LANG': 'en_US.UTF-8', 07:37:02 INFO - 'LANGUAGE': 'en_US:en', 07:37:02 INFO - 'LOGNAME': 'cltbld', 07:37:02 INFO - 'MAIL': '/var/mail/cltbld', 07:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:02 INFO - 'MOZ_NO_REMOTE': '1', 07:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:02 INFO - 'NO_EM_RESTART': '1', 07:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:02 INFO - 'PWD': '/builds/slave/test', 07:37:02 INFO - 'SHELL': '/bin/bash', 07:37:02 INFO - 'SHLVL': '1', 07:37:02 INFO - 'TERM': 'linux', 07:37:02 INFO - 'TMOUT': '86400', 07:37:02 INFO - 'USER': 'cltbld', 07:37:02 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:02 INFO - '_': '/tools/buildbot/bin/python'} 07:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:02 INFO - Downloading/unpacking blobuploader==1.2.4 07:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:04 INFO - Downloading blobuploader-1.2.4.tar.gz 07:37:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:37:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:37:04 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 07:37:04 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 07:37:04 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 07:37:04 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 07:37:04 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 07:37:04 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 07:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:37:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:05 INFO - Downloading docopt-0.6.1.tar.gz 07:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:37:05 INFO - Installing collected packages: blobuploader, requests, docopt 07:37:05 INFO - Running setup.py install for blobuploader 07:37:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:37:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:37:05 INFO - Running setup.py install for requests 07:37:05 INFO - Running setup.py install for docopt 07:37:06 INFO - Successfully installed blobuploader requests docopt 07:37:06 INFO - Cleaning up... 07:37:06 INFO - Return code: 0 07:37:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:06 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')]} 07:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:06 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')]} 07:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:06 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 0x7fc5192b8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, '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': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', '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 07:37:06 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 07:37:06 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 07:37:06 INFO - Using env: {'DISPLAY': ':0', 07:37:06 INFO - 'HOME': '/home/cltbld', 07:37:06 INFO - 'LANG': 'en_US.UTF-8', 07:37:06 INFO - 'LANGUAGE': 'en_US:en', 07:37:06 INFO - 'LOGNAME': 'cltbld', 07:37:06 INFO - 'MAIL': '/var/mail/cltbld', 07:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:06 INFO - 'MOZ_NO_REMOTE': '1', 07:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:06 INFO - 'NO_EM_RESTART': '1', 07:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:06 INFO - 'PWD': '/builds/slave/test', 07:37:06 INFO - 'SHELL': '/bin/bash', 07:37:06 INFO - 'SHLVL': '1', 07:37:06 INFO - 'TERM': 'linux', 07:37:06 INFO - 'TMOUT': '86400', 07:37:06 INFO - 'USER': 'cltbld', 07:37:06 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:06 INFO - '_': '/tools/buildbot/bin/python'} 07:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:06 INFO - Running setup.py (path:/tmp/pip-JFSz4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:06 INFO - Running setup.py (path:/tmp/pip-ILEUQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:06 INFO - Running setup.py (path:/tmp/pip-1nJ7y8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:06 INFO - Running setup.py (path:/tmp/pip-Y6B_j8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:06 INFO - Running setup.py (path:/tmp/pip-LE7WeQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:06 INFO - Running setup.py (path:/tmp/pip-EAsWHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:06 INFO - Running setup.py (path:/tmp/pip-etdYGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:06 INFO - Running setup.py (path:/tmp/pip-pCAByN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:06 INFO - Running setup.py (path:/tmp/pip-4SPmNF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:07 INFO - Running setup.py (path:/tmp/pip-bIXFHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:07 INFO - Running setup.py (path:/tmp/pip-eyRPIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:07 INFO - Running setup.py (path:/tmp/pip-kn2V8b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:07 INFO - Running setup.py (path:/tmp/pip-7j02Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:07 INFO - Running setup.py (path:/tmp/pip-hd1jeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:07 INFO - Running setup.py (path:/tmp/pip-nlVKRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:07 INFO - Running setup.py (path:/tmp/pip-GIkjt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:07 INFO - Running setup.py (path:/tmp/pip-rY4iVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:37:07 INFO - Running setup.py install for manifestparser 07:37:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:37:07 INFO - Running setup.py install for mozcrash 07:37:07 INFO - Running setup.py install for mozdebug 07:37:07 INFO - Running setup.py install for mozdevice 07:37:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Running setup.py install for mozfile 07:37:08 INFO - Running setup.py install for mozhttpd 07:37:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Running setup.py install for mozinfo 07:37:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Running setup.py install for mozInstall 07:37:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Running setup.py install for mozleak 07:37:08 INFO - Running setup.py install for mozlog 07:37:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Running setup.py install for moznetwork 07:37:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:37:08 INFO - Running setup.py install for mozprocess 07:37:08 INFO - Running setup.py install for mozprofile 07:37:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:37:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:37:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:37:09 INFO - Running setup.py install for mozrunner 07:37:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:37:09 INFO - Running setup.py install for mozscreenshot 07:37:09 INFO - Running setup.py install for moztest 07:37:09 INFO - Running setup.py install for mozversion 07:37:09 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:37:09 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:37:09 INFO - Cleaning up... 07:37:09 INFO - Return code: 0 07:37:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:09 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 0x7fc5192b8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, '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': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', '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 07:37:09 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 07:37:09 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 07:37:09 INFO - Using env: {'DISPLAY': ':0', 07:37:09 INFO - 'HOME': '/home/cltbld', 07:37:09 INFO - 'LANG': 'en_US.UTF-8', 07:37:09 INFO - 'LANGUAGE': 'en_US:en', 07:37:09 INFO - 'LOGNAME': 'cltbld', 07:37:09 INFO - 'MAIL': '/var/mail/cltbld', 07:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:09 INFO - 'MOZ_NO_REMOTE': '1', 07:37:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:09 INFO - 'NO_EM_RESTART': '1', 07:37:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:09 INFO - 'PWD': '/builds/slave/test', 07:37:09 INFO - 'SHELL': '/bin/bash', 07:37:09 INFO - 'SHLVL': '1', 07:37:09 INFO - 'TERM': 'linux', 07:37:09 INFO - 'TMOUT': '86400', 07:37:09 INFO - 'USER': 'cltbld', 07:37:09 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:09 INFO - '_': '/tools/buildbot/bin/python'} 07:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:37:09 INFO - Running setup.py (path:/tmp/pip-7zTkDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:37:09 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)) 07:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:37:09 INFO - Running setup.py (path:/tmp/pip-w03xM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:37:09 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)) 07:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:37:09 INFO - Running setup.py (path:/tmp/pip-c78u6L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:37:09 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)) 07:37:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:37:09 INFO - Running setup.py (path:/tmp/pip-PpvhLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:37:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:37:10 INFO - Running setup.py (path:/tmp/pip-673ytP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:37:10 INFO - Running setup.py (path:/tmp/pip-ZU8IJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:37:10 INFO - Running setup.py (path:/tmp/pip-g8Jur9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:37:10 INFO - Running setup.py (path:/tmp/pip-3dRjZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:37:10 INFO - Running setup.py (path:/tmp/pip-gKqC3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:37:10 INFO - Running setup.py (path:/tmp/pip-82K9h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:37:10 INFO - Running setup.py (path:/tmp/pip-ZAf9yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:37:10 INFO - Running setup.py (path:/tmp/pip-Bd4WJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:37:10 INFO - Running setup.py (path:/tmp/pip-qY7okF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:37:10 INFO - Running setup.py (path:/tmp/pip-klZMtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:10 INFO - Running setup.py (path:/tmp/pip-GZlDFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:37:10 INFO - Running setup.py (path:/tmp/pip-cYPfPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:37:10 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)) 07:37:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:37:10 INFO - Running setup.py (path:/tmp/pip-xGBy2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:37:10 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)) 07:37:10 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)) 07:37:10 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)) 07:37:10 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)) 07:37:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:37:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:37:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:37:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:37:12 INFO - Downloading blessings-1.6.tar.gz 07:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:37:13 INFO - Installing collected packages: blessings 07:37:13 INFO - Running setup.py install for blessings 07:37:13 INFO - Successfully installed blessings 07:37:13 INFO - Cleaning up... 07:37:13 INFO - Return code: 0 07:37:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:37:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:13 INFO - Reading from file tmpfile_stdout 07:37:13 INFO - Current package versions: 07:37:13 INFO - argparse == 1.2.1 07:37:13 INFO - blessings == 1.6 07:37:13 INFO - blobuploader == 1.2.4 07:37:13 INFO - docopt == 0.6.1 07:37:13 INFO - functools32 == 3.2.3-2 07:37:13 INFO - jsonschema == 2.5.1 07:37:13 INFO - manifestparser == 1.1 07:37:13 INFO - mozInstall == 1.12 07:37:13 INFO - mozcrash == 1.0 07:37:13 INFO - mozdebug == 0.1 07:37:13 INFO - mozdevice == 0.48 07:37:13 INFO - mozfile == 1.2 07:37:13 INFO - mozhttpd == 0.7 07:37:13 INFO - mozinfo == 0.9 07:37:13 INFO - mozleak == 0.1 07:37:13 INFO - mozlog == 3.4 07:37:13 INFO - moznetwork == 0.27 07:37:13 INFO - mozprocess == 0.23 07:37:13 INFO - mozprofile == 0.28 07:37:13 INFO - mozrunner == 6.13 07:37:13 INFO - mozscreenshot == 0.1 07:37:13 INFO - mozsystemmonitor == 0.3 07:37:13 INFO - moztest == 0.7 07:37:13 INFO - mozversion == 1.4 07:37:13 INFO - psutil == 3.1.1 07:37:13 INFO - requests == 1.2.3 07:37:13 INFO - wsgiref == 0.1.2 07:37:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:37:13 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')]} 07:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:13 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')]} 07:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:13 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 0x7fc5192b8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, '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': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', '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 07:37:13 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 07:37:13 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 07:37:13 INFO - Using env: {'DISPLAY': ':0', 07:37:13 INFO - 'HOME': '/home/cltbld', 07:37:13 INFO - 'LANG': 'en_US.UTF-8', 07:37:13 INFO - 'LANGUAGE': 'en_US:en', 07:37:13 INFO - 'LOGNAME': 'cltbld', 07:37:13 INFO - 'MAIL': '/var/mail/cltbld', 07:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:13 INFO - 'MOZ_NO_REMOTE': '1', 07:37:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:13 INFO - 'NO_EM_RESTART': '1', 07:37:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:13 INFO - 'PWD': '/builds/slave/test', 07:37:13 INFO - 'SHELL': '/bin/bash', 07:37:13 INFO - 'SHLVL': '1', 07:37:13 INFO - 'TERM': 'linux', 07:37:13 INFO - 'TMOUT': '86400', 07:37:13 INFO - 'USER': 'cltbld', 07:37:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:13 INFO - '_': '/tools/buildbot/bin/python'} 07:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:13 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)) 07:37:13 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)) 07:37:13 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)) 07:37:13 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)) 07:37:13 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)) 07:37:13 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)) 07:37:13 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)) 07:37:13 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)) 07:37:13 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)) 07:37:13 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)) 07:37:13 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)) 07:37:13 INFO - Cleaning up... 07:37:13 INFO - Return code: 0 07:37:13 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:37:13 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')]} 07:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:13 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')]} 07:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:37:13 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 0x7fc5192b8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b4bb70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce7130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, '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': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', '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 07:37:13 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 07:37:13 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 07:37:13 INFO - Using env: {'DISPLAY': ':0', 07:37:13 INFO - 'HOME': '/home/cltbld', 07:37:13 INFO - 'LANG': 'en_US.UTF-8', 07:37:13 INFO - 'LANGUAGE': 'en_US:en', 07:37:13 INFO - 'LOGNAME': 'cltbld', 07:37:13 INFO - 'MAIL': '/var/mail/cltbld', 07:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:13 INFO - 'MOZ_NO_REMOTE': '1', 07:37:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:13 INFO - 'NO_EM_RESTART': '1', 07:37:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:13 INFO - 'PWD': '/builds/slave/test', 07:37:13 INFO - 'SHELL': '/bin/bash', 07:37:13 INFO - 'SHLVL': '1', 07:37:13 INFO - 'TERM': 'linux', 07:37:13 INFO - 'TMOUT': '86400', 07:37:13 INFO - 'USER': 'cltbld', 07:37:13 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:13 INFO - '_': '/tools/buildbot/bin/python'} 07:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:37:13 INFO - Cleaning up... 07:37:13 INFO - Return code: 0 07:37:13 INFO - Running post-action listener: _resource_record_post_action 07:37:13 INFO - Running post-action listener: _start_resource_monitoring 07:37:13 INFO - Starting resource monitoring. 07:37:13 INFO - [mozharness: 2016-11-17 15:37:13.902625Z] Finished create-virtualenv step (success) 07:37:13 INFO - [mozharness: 2016-11-17 15:37:13.903145Z] Running install step. 07:37:13 INFO - Running pre-action listener: _resource_record_pre_action 07:37:13 INFO - Running main action method: install 07:37:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:37:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:37:14 INFO - Reading from file tmpfile_stdout 07:37:14 INFO - Detecting whether we're running mozinstall >=1.0... 07:37:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:37:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:37:14 INFO - Reading from file tmpfile_stdout 07:37:14 INFO - Output received: 07:37:14 INFO - Usage: mozinstall [options] installer 07:37:14 INFO - Options: 07:37:14 INFO - -h, --help show this help message and exit 07:37:14 INFO - -d DEST, --destination=DEST 07:37:14 INFO - Directory to install application into. [default: 07:37:14 INFO - "/builds/slave/test"] 07:37:14 INFO - --app=APP Application being installed. [default: firefox] 07:37:14 INFO - mkdir: /builds/slave/test/build/application 07:37:14 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'] 07:37:14 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 07:37:30 INFO - Reading from file tmpfile_stdout 07:37:30 INFO - Output received: 07:37:30 INFO - /builds/slave/test/build/application/firefox/firefox 07:37:30 INFO - Running post-action listener: _resource_record_post_action 07:37:30 INFO - [mozharness: 2016-11-17 15:37:30.268398Z] Finished install step (success) 07:37:30 INFO - [mozharness: 2016-11-17 15:37:30.268639Z] Running run-tests step. 07:37:30 INFO - Running pre-action listener: _resource_record_pre_action 07:37:30 INFO - Running main action method: run_tests 07:37:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:37:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:37:30 INFO - Python 2.7.3 07:37:30 INFO - Return code: 0 07:37:30 INFO - grabbing minidump binary from tooltool 07:37:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:37:30 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 0x1d75fc0>, '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 0x1d76ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d77350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:37:30 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 07:37:30 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 07:37:30 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 07:37:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:37:30 INFO - Return code: 0 07:37:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:37:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:37:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:37:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:37:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:37:30 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/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 07:37:30 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/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-025 --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 07:37:30 INFO - Using env: {'DISPLAY': ':0', 07:37:30 INFO - 'HOME': '/home/cltbld', 07:37:30 INFO - 'LANG': 'en_US.UTF-8', 07:37:30 INFO - 'LANGUAGE': 'en_US:en', 07:37:30 INFO - 'LOGNAME': 'cltbld', 07:37:30 INFO - 'MAIL': '/var/mail/cltbld', 07:37:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:37:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:37:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:37:30 INFO - 'MOZ_NO_REMOTE': '1', 07:37:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:37:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:37:30 INFO - 'NO_EM_RESTART': '1', 07:37:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:37:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:37:30 INFO - 'PWD': '/builds/slave/test', 07:37:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:37:30 INFO - 'SHELL': '/bin/bash', 07:37:30 INFO - 'SHLVL': '1', 07:37:30 INFO - 'TERM': 'linux', 07:37:30 INFO - 'TMOUT': '86400', 07:37:30 INFO - 'USER': 'cltbld', 07:37:30 INFO - 'XDG_SESSION_COOKIE': '232498196343f89f466a4a9a000001c8-1479396995.463775-520358466', 07:37:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:37:30 INFO - '_': '/tools/buildbot/bin/python'} 07:37:30 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/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-025', '--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 07:37:30 INFO - mozversion application_buildid: 20161117060528 07:37:30 INFO - mozversion application_changeset: 05e5b12f41df270b31955ff7e6d09245c1f83a7a 07:37:30 INFO - mozversion application_display_name: Nightly 07:37:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:37:30 INFO - mozversion application_name: Firefox 07:37:30 INFO - mozversion application_remotingname: firefox 07:37:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:37:30 INFO - mozversion application_vendor: Mozilla 07:37:30 INFO - mozversion application_version: 53.0a1 07:37:30 INFO - mozversion platform_buildid: 20161117060528 07:37:30 INFO - mozversion platform_changeset: 05e5b12f41df270b31955ff7e6d09245c1f83a7a 07:37:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:37:30 INFO - mozversion platform_version: 53.0a1 07:37:30 INFO - using testdate: 1479397050 07:37:30 INFO - actual date: 1479397050 07:37:30 INFO - starting webserver on 'localhost:50265' 07:37:30 INFO - SUITE-START | Running 2 tests 07:37:30 INFO - TEST-START | dromaeo_css 07:37:30 INFO - operating with platform_type : linux_ 07:37:30 INFO - Initialising browser for dromaeo_css test... 07:37:30 INFO - TEST-INFO | started process 6203 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi07K3o/profile http://localhost:50265/getInfo.html) 07:37:34 INFO - PROCESS | 6203 | __metrics Screen width/height:1600/1200 07:37:34 INFO - PROCESS | 6203 | colorDepth:24 07:37:34 INFO - PROCESS | 6203 | Browser inner width/height: 1024/697 07:37:34 INFO - PROCESS | 6203 | __metrics 07:37:35 INFO - PROCESS | 6203 | 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" 07:37:35 INFO - PROCESS | 6203 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:37:36 INFO - TEST-INFO | 6203: exit 0 07:37:36 INFO - Browser initialized. 07:37:36 INFO - Running cycle 1/1 for dromaeo_css test... 07:37:36 INFO - TEST-INFO | started process 6285 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi07K3o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:37:49 INFO - PROCESS | 6285 | RSS: Main: 174477312 07:37:49 INFO - PROCESS | 6285 | 07:38:40 INFO - PROCESS | 6285 | 1479397120978 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] 07:40:53 INFO - PROCESS | 6285 | Cycle 1(1): loaded http://localhost:50265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50265/tests/dromaeo/cssquery-ext.html) 07:40:55 INFO - PROCESS | 6285 | RSS: Main: 325382144 07:40:55 INFO - PROCESS | 6285 | 07:43:58 INFO - PROCESS | 6285 | Cycle 1(1): loaded http://localhost:50265/tests/dromaeo/cssquery-ext.html (next: http://localhost:50265/tests/dromaeo/cssquery-jquery.html) 07:43:59 INFO - PROCESS | 6285 | RSS: Main: 280817664 07:43:59 INFO - PROCESS | 6285 | 07:47:01 INFO - PROCESS | 6285 | Cycle 1(1): loaded http://localhost:50265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50265/tests/dromaeo/cssquery-mootools.html) 07:47:02 INFO - PROCESS | 6285 | RSS: Main: 242618368 07:47:02 INFO - PROCESS | 6285 | 07:50:04 INFO - PROCESS | 6285 | Cycle 1(1): loaded http://localhost:50265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50265/tests/dromaeo/cssquery-prototype.html) 07:50:05 INFO - PROCESS | 6285 | RSS: Main: 219897856 07:50:05 INFO - PROCESS | 6285 | 07:53:08 INFO - PROCESS | 6285 | Cycle 1(1): loaded http://localhost:50265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50265/tests/dromaeo/cssquery-yui.html) 07:53:08 INFO - PROCESS | 6285 | RSS: Main: 219004928 07:53:08 INFO - PROCESS | 6285 | 07:56:11 INFO - PROCESS | 6285 | Cycle 1(1): loaded http://localhost:50265/tests/dromaeo/cssquery-yui.html (next: http://localhost:50265/tests/dromaeo/cssquery-dojo.html) 07:56:11 INFO - PROCESS | 6285 | RSS: Main: 310665216 07:56:11 INFO - PROCESS | 6285 | 07:56:11 INFO - PROCESS | 6285 | __start_tp_report 07:56:11 INFO - PROCESS | 6285 | _x_x_mozilla_page_load 07:56:11 INFO - PROCESS | 6285 | _x_x_mozilla_page_load_details 07:56:11 INFO - PROCESS | 6285 | |i|pagename|runs| 07:56:11 INFO - PROCESS | 6285 | |0;dojo.html;2546.4907018596277;2570.19039002714;2593.6887573491176;2597.5843864981593;2615.9215223543288;4422.3145412461035;4512.63898888089;4585.679002469828;4601.976990115049;4634.814607415704;4530.886727831806;4552.590266875981;4567.177907976563;4577.519360467145;4583.679142460021;4202.789860506962;4206.579342065785;4250.213710463574;4269.252880745873;4339.392485052095;4299.441072660566;4331.350297455376;4358.97820510897;4359;4404.581564751344;4145.875623731293;4182.53992060873;4316.913661726748;4345.994280021219;4369.978150109261;4184.916301673949;4218.261804184286;4235.110626768383;4238.597333253336;4319.07139964909;4222.429971953778;4232.238197124517;4236.428082208893;4238.597333253336;4273.252180868336;4587.816487340502;4609.216433206363;4610.377599024156;4644.9767751161025;4661.09108723799;4824.228123500258;4867.586255168315;4885.022995400898;4890.266460030988;4896.167651499253;4948.8762780930765;4954.108260513106;4969.652124351297;4996.300517927493;5000.249962505617;4646.97676511622;4647.37260469839;4648.65135114861;4656.371389862393;4678.602318802906;4879.950810575743;4919.65562410635;4931.358923340014;5067.949320506821;5117.0533451310885;4789.521047895182;4837.516248375135;4837.564619184291;4916.508349165055;4917.139500587455;4942.703437793672;4950.950490495121;4957.3555437793575;4957.380327459067;5006.874828129326;4915.3855768029;4916.655834091579;4919.926201106986;4927.95072049282;4979;4724.078804633133;4773.64197685175;4783.354247176656;4794.712317260975;4836.056968891033;4171.416001759695;4200;4203.831846726097;4213.557576454489;4230.5769423057445;3671.908202294964;3674.4855720199193;3676.485292059114;3708.740388172802;3733.906652333659;4296.3555466680245;4303.526612072732;4304.504981927056;4332.653387728974;4342.69601127918;4778.283257511401;4831.782569784368;4834.927476087792;4908.607311415079;4954.504549545089;4262.46719160105;4286.057067445157;4286.485621725351;4321.222180007566;4328.632066274402;4474.149911516802;4475.283954567253;4477.776111194427;4511.977440112779;4521.050579378368;4533.614642755403;4594.88512787183;4603.3785438965315;4651.790669419885;4658.767061646972;4655.2784318430695;4863.878403039952;4920.212765957573;4943.65394422387;4945.851624451272;4693.530646935279;4706.858794236178;4707.082118986902;4707.340972263817;4749.762511874462;4939.703617782944;4940.975295123501;4942.357493525818;4944.8763780905765;4995;4789.114013907439;4875.926861097158;4893.168161412497;4962.156433406258;4975.925361119514;4856.295837103671;4858.076965376567;4865.391826021747;4900.558949694402;4906.656534042583;4834.419869615669;4834.758262086812;4835.806567737392;4836.105320515716;4882.511748825089;4640.559146881041;4673.883152921068;4713.340132381538;4775.044991001883;4782.115308667908;4764.4282686077895;4825.469198388104;4825.855224343275;4839.95160048395;4853.733044682576;4562.88592785183;4626.190416677001;4626.583607475343;4682.578567928903;4766.046790641816 07:56:11 INFO - PROCESS | 6285 | |1;ext.html;550.3203543623624;550.6998685716284;559.490863314384;564.0805487056097;569.8888716700243;21978.45053873654;27497.450050998992;28365.149045528615;28512.857435712845;30466.390672186542;27865.16404507863;28143.859280703567;28156;28210.294742631395;28238.294042648944;5363.785448582052;5512.33851937768;5514;5514.862128446801;5518.2826232589705;5644.068728659787;5716.056850619642;5718.228039214694;5720.11338242573;5720.427957204267;5692.943070569303;5722.37053924068;5727.799527016556;5730.713464326788;5732.140178973145;5686.5735069869925;5720.284964379432;5726.398728133569;5726.455986681301;5733.655980641175;5637.436256374371;5690.630109042899;5692.6299790513485;5696.259486266758;5696.77212911483;25501.23496295114;25552.616710749353;25695.22914312555;25824.22527324183;25849.224523264333;2977.389635124794;2999.850007499638;3054;3119.313750974782;3257.674232576723;18023.819761802344;18109.7283540747;18211.63576728471;18235;19057.61884762297;2641.1944356971308;2712.83348160291;2734.125079974409;2745.8764355603844;2773.057160565397;242390;242564;243151.78424107944;243436;244198;31140.221494462367;51236.74381628143;51677.741611291705;51683.741581291855;51707.741461292455;31518.21204469861;33056.66943330584;33073;33092.539730944605;33127.66872331294;11787.705307367385;11821.113416493625;11873.643790686294;11880.821787673192;11885.22746021506;10250.282480226313;10269.024442677934;10324.328918620266;10341.482925853828;10349.844752328721;7702.883081953086;7705.845883082307;7804.726834560876;7805.2194780521495;7809.726659566888;3001.4747419201553;3064.111407691789;3085.3983473222506;3108.6788115051013;3112.8754849805755;809.8137428391503;823.2138307915926;838.1450920061625;910.7495438754396;948.8054948735493;25131;26812.865935670587;27262.727372726415;27643.44713105767;27805.304867378476;832.8500869843486;916.7524768312652;959.4003747657714;975.9512024398751;979.2557656181353;13732.382042808098;13989.720205596035;14222.928885355506;14788.630284242765;14847.109173449628;340381;345454;346086;346213;346238.4513858353;42915.141697165884;43417.78291108524;43506.347404788954;43508.782456087516;43548.78225608852;1035.5288343803552;1095.2114477576133;1128.503458478267;1169.8362229287907;1183.7810005148904;23819;26413.471730565667;26539.601905971813;27281.181564553095;27425.588616170375;40655.79672101739;41286.58713412948;41296.79351603223;41303.7934810324;41395.379069313385;273551;275309;275564;275620;275947;20963.475913101684;21660.675089873348;23235.419114522272;34854.47718284177;35842.10394740153;37694.434583480725;37707.62292377041;38014.239715206095;38505;39118.2176356477;32778;32813.34373312568;33293.33413331768;33341.33317333688;33454.33091338208;32237.838810805795;32803.67196328006;33330.16674583155;33661.83169084139;33665.495017575246;33415.66584334125;33936.32127357488;34033.31933361269;34143.65856341405;34556.82721586376;28237.717622823508;30480.390392192476;30719.539206911468;31115.22211944629;31298.37403251877;24027.399315017265;24524.14165504199;24766.725439308793;24809.25572232836;25221.243362699148 07:56:11 INFO - PROCESS | 6285 | |2;jquery.html;341.0921890880247;359.2563393774886;364.1969457346551;366.63336663336656;388.48137736122277;9561.139497445229;11269.211155219138;11561.479733411996;11915.463804128813;12383.257004579731;15840.445584404548;16058.678826423464;16201;16382.83617163828;16388.83611163888;3940.743851649641;4174.20690068886;4175.519815221258;4177.791110444481;4180.602842729951;2796.5385711357603;2806.1441260415563;2959.5708622249763;4089.1003979124544;4161.0845613964875;4188.518320393163;4188.623023927846;4194.916101677964;4195.119025004753;4195.3916682081235;4072.6741860651077;4183.184279065584;4184;4185.560516145822;4187.120704652011;3710.628937106295;3801.1637439763485;3801.82891769871;3803.5055442792536;3803.7717736935874;16047.518574442785;16083.91958040214;16268.75596866048;16278.430254941139;16352.509424717278;1709.8888572242765;1875.3061367294188;2178.836587255962;2238.440389902524;2376.821738369612;9582.712518624452;10634.308769930007;10682.62610808618;10799.2440529163;10828.675139745821;1386.3137746815391;1443.559714287142;1447.862453066957;1456.9529810616102;1514.5380658899032;65823.01265481021;66065.00902486514;66081.1054010278;66685;67721.66139169323;9038.683646072355;9054.185123338799;9372.5313734313;9432.292578056537;9619.951900240454;11219.94390028061;11586.536538538365;11954.940225298818;12419.31693756834;12469.376531173404;6526.314736952551;6646.900296495556;6661.333866613397;6835.248122706498;6869.450443964471;6302.243730752248;6314.210723659543;6424.068510066014;6509.544331896722;6535.3464653534265;5867.6772777497645;6001.549883758736;6015.54883383748;6104.786332478431;6111.35830737775;1721.7847769028872;1724.939627113045;1747.344745720355;1750.8336708012719;1781.5724226185623;865.2385900407601;907.2515174980667;911.9361644684808;958.7440453006584;998.336106489191;16270.186490675418;16533.090680012716;17318;17545.912270438566;17600.823991760175;888.036480418753;898.874157617934;902.8961669408102;912.926965842731;930.8683115665186;9256.259499240045;9956.153726933147;10187.7453063674;10191.388516689023;10213.74465638365;332028;338035;339142;339271;340428;62539;62957.37042629515;63869;63999;64588;912.6896855069308;933.9019402962726;955.5699935029264;956.3496822160997;956.6699488676395;14978.707277423695;14989.325480353193;15427.382904683687;15707.607309817346;15838.683226335179;31607;32892;33662.77238710846;34409.655903440645;36038.45942310815;45470.31794523151;47054;47698.28452573145;47845;49048.50951490439;6849.383555480031;7556.546607203585;7584.2794934481135;7634.525676498971;7978.84042319162;8712.128787121237;11634.476448559666;11819.135032524391;11926.986206172225;12003.939980300043;10181.287309888237;10275.691729248134;10449.16406687448;10678.252522323362;11133.387663678575;9917.87586910121;10177.389356638329;10401.27191096616;10406.323588966692;10637.574497020032;10843.295185812896;10953.780924381626;11031.39327336972;11046.668599942015;11075.504806851295;5803.564732645153;6381.361863813581;7484.775456736306;7758.146603873456;7825.33484653788;7770.922290777246;9235.538223088684;9450.669226577036;9483.810323793623;9898.455584942609 07:56:11 INFO - PROCESS | 6285 | |3;mootools.html;1183.8105903055514;1312.8030795380691;1344.630226687661;1389.6178550898508;1629.9266533006007;5460.78156873725;5912.290525136984;6198.72105755241;6199.101130336098;6202.968985155079;6089.817305480843;6168.198134242542;6293.118963345135;6297.244330680325;6299.401556852104;1727.1450631937178;1775.2011594782334;1778.4397914656906;1786.63374008328;1787.392286622548;1711.897286162828;1747.1089744230408;1749.991250043748;1756.0956107604593;1757.4815429448279;1741.3469948769211;1765.0645158066245;1766.3641089207874;1768.5490199999047;1771.0259357353405;1708.4020592792485;1728.5160155156577;1729.3428497171121;1731.2469075952001;1731.471901070173;1685.8314168583165;1698.8810783245178;1701.421516684321;1702.208473060033;1702.2339947023888;5737.168110623936;6077.270727512682;6162.784302549434;6163.969180154116;6171.105189747506;4053.1893621275863;4215.873523794291;4217.1144059747185;4219.050713589418;4232.407462955189;2568.75596818302;2693.4209145033715;2763.557830747091;2765.4330862173206;2771.0439898235077;789.8025493626593;790.130856058337;812.34200297759;812.4482238923628;827.1439060572279;8365.539895305756;8656.740297791077;8669.783255418602;8673.436226645248;8681.30549556034;3630.237650093457;3789.829457674411;3816.160444702161;3847.5190601174854;3861.536615606089;7588.089429268523;7591.506552074097;7596.696132154762;7599.810004749815;7604.163542010375;4221.662267018631;4226.1758957003085;4226.5773422657485;4227.852025179104;4230.873073807791;3305;3314.486254630536;3860.131470419133;3938.4683067786054;3941.4087886817206;2970.287131088523;3125.2343175922047;3305.0500204879236;3310.1724568857785;3326.817025063645;1104.9116070714485;1116.1740312168936;1125.5649047464549;1129.740159763259;1140.224647239885;820.1347578304826;832.650286879512;846.724814435311;866.4931015355961;867.3191544637556;4722.315264286728;4742.834000810024;4750.239961606196;4854.854354369375;4859.805607775649;392.479964047638;404.5186228388209;411.64392800227586;412.0625576812715;418.4204876246421;3300.372929143455;3382.763206575565;3396.286779776225;3421.2815308784934;3534.169470174507;7661.118971318369;7789.493682910593;7871.567063811431;7874.6850125994315;7880.487768295043;7849.058113026359;7852.293293603489;7854;7857.921420785833;7863.213678632091;6165.784197553064;6198.194234749454;6227;6259.6870156492;6264.937350626436;4561.521040290721;4586.564276393738;4592.563706447882;4594.47163576193;4651.209294419889;7199.71201151948;7218.3503484686635;7343.412526997934;7346.4122870169185;7351.742689005859;7326.743563975236;7441.851162976818;7464.365528929885;7471.589062601392;7474.215207403362;5023.146065168857;5429.131338985743;5596.888062238814;5738.885222295447;5808.73860676279;6339.90490142639;6372.0760489729655;6392.712327945161;6399.072134540373;6400.327965563549;5755.424457554211;5791;5898.056310990221;6004.579679422399;6019.067044608093;5419.485148910847;5464.863378415572;5571.05292100352;5769.567282453917;5818.592698511064;5623.100303951348;5628.85927851807;5673.716314184357;5676.858078548069;5678.488935995781;4032.6572241359813;4038.374052021941;4088.6933479988525;4152.148809494107;4250.978745106255;4162.729422587522;4182.853600123981;4201.70588058833;4278.828846846091;4329.2640251156745 07:56:11 INFO - PROCESS | 6285 | |4;prototype.html;295.927497763048;301.63954074880513;304.58120084883285;305.11212371997493;307.649279821004;4679.766011699414;4736.834210802623;4750;4770.141374552579;4801.207800712878;4684.882877928054;4691.530846915315;4696.671233013691;4710.764461776906;4717.952820471794;3501.0547152268873;3597.586277578073;3618.7285953553587;3733.45864849598;3751.4185301278344;3702.629737026303;3710;3710.3321402147603;3716.256748650267;3721.6464435878547;3687.7234207434417;3698.722595805312;3701.3522633539155;3704.8332825022803;3715.6098609646006;3517.278957813642;3573.5890372606964;3639.399499082648;3713.7586056906484;3721.3301605710963;3259.348130373911;3264.8367581620823;3266.9382450703615;3269.5749552558254;3289.259916518788;4569.47451043131;4570.960311392953;4573.725576465423;4586;4587.3577699121815;4187.225363307798;4193.1486589119695;4194.874153775391;4198.5591512891015;4199.475065616798;4650.348951146842;4883.169861123618;4910;4912.656114072016;4912.8771780705765;3498.0904964709357;3499.8075105869166;3502.317048175607;3509.666581674737;3513.1555933135055;5116.334876466073;5121.180611102206;5122.820701275437;5149.613778966555;5150.304708864331;3422.8117453540294;3477.826108694555;3517.8065206413894;3529.982350088233;3560.590532088791;3581.3553560358864;3590.4075827488173;3596.3166998270767;3599.370110230699;3608.350496910529;4124.226582569524;4124.360724087771;4125.195586860534;4144.937825932613;4145.647619952338;4838.316441021181;4947.628927830355;4958.776855041532;4962.751862406937;4972.129877271463;1171.46698252295;1210.975780484403;1219.1709637446622;1222.468226321553;1223.8103094020441;800.0239707556772;833.6248688090384;843.5866425451485;844.1178967978477;845.89003429555;4204.201201771653;4264.168487145039;4275.743455392624;4318.719283246579;4385.122975404932;5080.240621939738;5086.64393492452;5092.567131793765;5094.974525127351;5109.744512774347;4394.648428125806;4399.692021558524;4400.779961001937;4402.163588918095;4416.183006143874;2516.7483251674685;2563.9103381062973;2596.5326241276375;2604.2577865308676;2605.5831067029562;4592.2422800238255;4610.308453731967;4616.238320677051;4632.3977882875015;4642.79107440166;5003.324551185616;5018.698878067255;5022.59819214462;5026.49205238427;5042.621803364762;4456.688031837805;4599.931001034987;4620.5148459411275;4626;4634.374359461497;4886.95113048865;4899.534544218293;4909.607231421406;4910.2880082388565;4941.407031156285;4870.659053866196;4872.366592342973;4873.610111191168;4878.658493905535;4883.511648835088;4497.1905057088725;4641.512641172628;4657.604103651092;4659.44086709597;4660.22521757364;3576.7496275260482;3582.229820588586;3599;3613.241219343862;3625.513539448919;4828.444728856227;4866.537678920497;4882.194437917846;4883.462819089968;4891.486393928586;4583.72497650142;4724.71651700899;4729.787159577759;4757.928631070467;4764.30917516965;4738.905221895612;4753.857384278477;4767.4994125617695;4775.42694876617;4789.808407663654;4638.953610463852;4660.811493069245;4699.906001880012;4709.7174169549935;4730.361401210793;4661.463931647768;4798.640101992434;4802.183628783185;4807.519248075165;4978.726170060537;4903.828366007316;4908.141075311734;4912.533309335608;4913.828016019422;4918.827841025547 07:56:11 INFO - PROCESS | 6285 | |5;yui.html;641.5605310362403;666.5300962821211;670.1489108831784;729.059513227936;748.8689479341114;10671.733206669827;11353.829692554618;11364.261323014009;11377;11394.829077563843;11179.273347232445;11269.09847212223;11288.153388495855;11299.717507062307;11307.038901693346;602.6233603997501;620.3858180401393;625.1903784598956;738.2469880721674;755.8866170074506;606.4511616986634;608.9847753806146;736.1607767145458;757.8029712274821;764.6597264217426;787.4527203593505;788.7278888783361;796.1083586383259;796.24356860982;797.182887540273;792.825578372757;793.234528679821;793.2464159048926;793.8967934168579;795.2326005404755;469.0806020200411;474.67721949074615;567.2540609099021;590.5895402695129;591.2343515147851;10102.69691909244;10499.212559058102;10605.204609654229;10612.893871061267;10631.149508039338;8850.893638295212;9247.815043699156;9275.814483710288;9558.426494410358;9891.258155638285;8205.79485512861;8344.41589088764;8405.621747021398;8405.70580029702;8536.530490823003;2464.4208610976407;2477.467344520937;2479.690038745157;2512.4849405871937;2574.9871250643628;47857.282140767915;48991.265131023065;49217.26174107391;49851.750741246426;50312;7445.2890118560335;7599.658015389321;7673.808154796175;7721.305082542598;7733.149353571102;15340.769888451681;15402.22988850553;15424.228788560527;15522;15685.05889646625;6483.805485835433;6514.967425162844;6539.2479864815205;6596.736130554724;6827.214870289881;3481.3559491494157;3585.695215906625;3628.292482965849;3649.434337677664;3708.054446116277;2537.784288335475;2614.150401119644;2637.11656595039;2646.7353264673766;2695.811293209496;470.19596490001794;472.75653038685107;478.0987837925466;479.7673128532659;482.4596451973812;502.94216165140745;521.9321488206509;548.3912856729028;562.1707980728393;569.6382796923983;7030.261822508665;7551.713800339674;7685.23147685227;7696.345810606049;7733;465.3043699668949;489.7428849853855;496.3349112189611;516.2256615077384;565.7312776431162;3629.582598001211;3631.710742686308;3679.264147170523;4015.217032678658;4143.6685065194715;70224.6488767553;70338.2966170342;71193.64403178054;73154.63422682852;73179;38418.42372364417;44058.33912491315;59013.70493147593;59628.63610526669;64774;53661.46338536643;55978;56122.71938640362;56545.43454565402;56672.716636417375;6922.688479018557;7256.818579535554;7267.563946163247;7382.483226174117;7474.626268686653;33274;37500.812495937345;38021.619783801805;38546.80726596349;38890;46863.29705054495;54858.45141548693;55536.444635553125;55711.44288557063;56018.43981560132;8458.74623761288;8855.645774168961;9331.673391431268;9464.148226659634;9613.375130616487;9763.609455621696;9948.303618746908;10025.197984161396;10259.640912568322;10959.232853700483;9452.054794520493;9828.606855725691;9878.110970012733;10700.571977121139;10706.464676766287;9740.074692904163;9938.950305248427;9994.250431217542;10217.744556385853;10260.384376937407;9437.245020398488;9442.575084121094;9826.705198844045;10154.39073655583;10186.847197291898;8389.790255243668;8724.563771811258;9122.726318210463;9325.114114159143;9627.90372096298;8733.868991964999;8893.555322233733;9031.81936361256;9060.570332327428;9139.771505712144 07:56:11 INFO - PROCESS | 6285 | __end_tp_report 07:56:11 INFO - PROCESS | 6285 | __start_cc_report 07:56:11 INFO - PROCESS | 6285 | _x_x_mozilla_cycle_collect,1659 07:56:11 INFO - PROCESS | 6285 | __end_cc_report 07:56:11 INFO - PROCESS | 6285 | __startTimestamp1479398171979__endTimestamp 07:56:11 INFO - PROCESS | 6285 | 07:56:11 INFO - PROCESS | 6285 | ------- Summary: start ------- 07:56:11 INFO - PROCESS | 6285 | Number of tests: 6 07:56:11 INFO - PROCESS | 6285 | 07:56:11 INFO - PROCESS | 6285 | [#0] dojo.html Cycles:165 Average:4561.10 Median:4658.77 stddev:464.40 (10.0%) stddev-sans-first:438.11 07:56:11 INFO - PROCESS | 6285 | Values: 2546.5 2570.2 2593.7 2597.6 2615.9 4422.3 4512.6 4585.7 4602.0 4634.8 4530.9 4552.6 4567.2 4577.5 4583.7 4202.8 4206.6 4250.2 4269.3 4339.4 4299.4 4331.4 4359.0 4359.0 4404.6 4145.9 4182.5 4316.9 4346.0 4370.0 4184.9 4218.3 4235.1 4238.6 4319.1 4222.4 4232.2 4236.4 4238.6 4273.3 4587.8 4609.2 4610.4 4645.0 4661.1 4824.2 4867.6 4885.0 4890.3 4896.2 4948.9 4954.1 4969.7 4996.3 5000.2 4647.0 4647.4 4648.7 4656.4 4678.6 4880.0 4919.7 4931.4 5067.9 5117.1 4789.5 4837.5 4837.6 4916.5 4917.1 4942.7 4951.0 4957.4 4957.4 5006.9 4915.4 4916.7 4919.9 4928.0 4979.0 4724.1 4773.6 4783.4 4794.7 4836.1 4171.4 4200.0 4203.8 4213.6 4230.6 3671.9 3674.5 3676.5 3708.7 3733.9 4296.4 4303.5 4304.5 4332.7 4342.7 4778.3 4831.8 4834.9 4908.6 4954.5 4262.5 4286.1 4286.5 4321.2 4328.6 4474.1 4475.3 4477.8 4512.0 4521.1 4533.6 4594.9 4603.4 4651.8 4658.8 4655.3 4863.9 4920.2 4943.7 4945.9 4693.5 4706.9 4707.1 4707.3 4749.8 4939.7 4941.0 4942.4 4944.9 4995.0 4789.1 4875.9 4893.2 4962.2 4975.9 4856.3 4858.1 4865.4 4900.6 4906.7 4834.4 4834.8 4835.8 4836.1 4882.5 4640.6 4673.9 4713.3 4775.0 4782.1 4764.4 4825.5 4825.9 4840.0 4853.7 4562.9 4626.2 4626.6 4682.6 4766.0 07:56:11 INFO - PROCESS | 6285 | 07:56:11 INFO - PROCESS | 6285 | [#1] ext.html Cycles:180 Average:41292.67 Median:18017.84 stddev:76806.47 (426.3%) stddev-sans-first:76961.01 07:56:11 INFO - PROCESS | 6285 | Values: 550.3 550.7 559.5 564.1 569.9 21978.5 27497.5 28365.1 28512.9 30466.4 27865.2 28143.9 28156.0 28210.3 28238.3 5363.8 5512.3 5514.0 5514.9 5518.3 5644.1 5716.1 5718.2 5720.1 5720.4 5692.9 5722.4 5727.8 5730.7 5732.1 5686.6 5720.3 5726.4 5726.5 5733.7 5637.4 5690.6 5692.6 5696.3 5696.8 25501.2 25552.6 25695.2 25824.2 25849.2 2977.4 2999.9 3054.0 3119.3 3257.7 18023.8 18109.7 18211.6 18235.0 19057.6 2641.2 2712.8 2734.1 2745.9 2773.1 242390.0 242564.0 243151.8 243436.0 244198.0 31140.2 51236.7 51677.7 51683.7 51707.7 31518.2 33056.7 33073.0 33092.5 33127.7 11787.7 11821.1 11873.6 11880.8 11885.2 10250.3 10269.0 10324.3 10341.5 10349.8 7702.9 7705.8 7804.7 7805.2 7809.7 3001.5 3064.1 3085.4 3108.7 3112.9 809.8 823.2 838.1 910.7 948.8 25131.0 26812.9 27262.7 27643.4 27805.3 832.9 916.8 959.4 976.0 979.3 13732.4 13989.7 14222.9 14788.6 14847.1 340381.0 345454.0 346086.0 346213.0 346238.5 42915.1 43417.8 43506.3 43508.8 43548.8 1035.5 1095.2 1128.5 1169.8 1183.8 23819.0 26413.5 26539.6 27281.2 27425.6 40655.8 41286.6 41296.8 41303.8 41395.4 273551.0 275309.0 275564.0 275620.0 275947.0 20963.5 21660.7 23235.4 34854.5 35842.1 37694.4 37707.6 38014.2 38505.0 39118.2 32778.0 32813.3 33293.3 33341.3 33454.3 32237.8 32803.7 33330.2 33661.8 33665.5 33415.7 33936.3 34033.3 34143.7 34556.8 28237.7 30480.4 30719.5 31115.2 31298.4 24027.4 24524.1 24766.7 24809.3 25221.2 07:56:11 INFO - PROCESS | 6285 | 07:56:11 INFO - PROCESS | 6285 | [#2] jquery.html Cycles:180 Average:21690.06 Median:2096.13 stddev:55811.12 (2662.6%) stddev-sans-first:55944.66 07:56:11 INFO - PROCESS | 6285 | Values: 341.1 359.3 364.2 366.6 388.5 9561.1 11269.2 11561.5 11915.5 12383.3 15840.4 16058.7 16201.0 16382.8 16388.8 3940.7 4174.2 4175.5 4177.8 4180.6 2796.5 2806.1 2959.6 4089.1 4161.1 4188.5 4188.6 4194.9 4195.1 4195.4 4072.7 4183.2 4184.0 4185.6 4187.1 3710.6 3801.2 3801.8 3803.5 3803.8 16047.5 16083.9 16268.8 16278.4 16352.5 1709.9 1875.3 2178.8 2238.4 2376.8 9582.7 10634.3 10682.6 10799.2 10828.7 1386.3 1443.6 1447.9 1457.0 1514.5 65823.0 66065.0 66081.1 66685.0 67721.7 9038.7 9054.2 9372.5 9432.3 9620.0 11219.9 11586.5 11954.9 12419.3 12469.4 6526.3 6646.9 6661.3 6835.2 6869.5 6302.2 6314.2 6424.1 6509.5 6535.3 5867.7 6001.5 6015.5 6104.8 6111.4 1721.8 1724.9 1747.3 1750.8 1781.6 865.2 907.3 911.9 958.7 998.3 16270.2 16533.1 17318.0 17545.9 17600.8 888.0 898.9 902.9 912.9 930.9 9256.3 9956.2 10187.7 10191.4 10213.7 332028.0 338035.0 339142.0 339271.0 340428.0 62539.0 62957.4 63869.0 63999.0 64588.0 912.7 933.9 955.6 956.3 956.7 14978.7 14989.3 15427.4 15707.6 15838.7 31607.0 32892.0 33662.8 34409.7 36038.5 45470.3 47054.0 47698.3 47845.0 49048.5 6849.4 7556.5 7584.3 7634.5 7978.8 8712.1 11634.5 11819.1 11927.0 12003.9 10181.3 10275.7 10449.2 10678.3 11133.4 9917.9 10177.4 10401.3 10406.3 10637.6 10843.3 10953.8 11031.4 11046.7 11075.5 5803.6 6381.4 7484.8 7758.1 7825.3 7770.9 9235.5 9450.7 9483.8 9898.5 07:56:11 INFO - PROCESS | 6285 | 07:56:11 INFO - PROCESS | 6285 | [#3] mootools.html Cycles:180 Average:4343.32 Median:4732.57 stddev:2334.76 (49.3%) stddev-sans-first:2329.23 07:56:11 INFO - PROCESS | 6285 | Values: 1183.8 1312.8 1344.6 1389.6 1629.9 5460.8 5912.3 6198.7 6199.1 6203.0 6089.8 6168.2 6293.1 6297.2 6299.4 1727.1 1775.2 1778.4 1786.6 1787.4 1711.9 1747.1 1750.0 1756.1 1757.5 1741.3 1765.1 1766.4 1768.5 1771.0 1708.4 1728.5 1729.3 1731.2 1731.5 1685.8 1698.9 1701.4 1702.2 1702.2 5737.2 6077.3 6162.8 6164.0 6171.1 4053.2 4215.9 4217.1 4219.1 4232.4 2568.8 2693.4 2763.6 2765.4 2771.0 789.8 790.1 812.3 812.4 827.1 8365.5 8656.7 8669.8 8673.4 8681.3 3630.2 3789.8 3816.2 3847.5 3861.5 7588.1 7591.5 7596.7 7599.8 7604.2 4221.7 4226.2 4226.6 4227.9 4230.9 3305.0 3314.5 3860.1 3938.5 3941.4 2970.3 3125.2 3305.1 3310.2 3326.8 1104.9 1116.2 1125.6 1129.7 1140.2 820.1 832.7 846.7 866.5 867.3 4722.3 4742.8 4750.2 4854.9 4859.8 392.5 404.5 411.6 412.1 418.4 3300.4 3382.8 3396.3 3421.3 3534.2 7661.1 7789.5 7871.6 7874.7 7880.5 7849.1 7852.3 7854.0 7857.9 7863.2 6165.8 6198.2 6227.0 6259.7 6264.9 4561.5 4586.6 4592.6 4594.5 4651.2 7199.7 7218.4 7343.4 7346.4 7351.7 7326.7 7441.9 7464.4 7471.6 7474.2 5023.1 5429.1 5596.9 5738.9 5808.7 6339.9 6372.1 6392.7 6399.1 6400.3 5755.4 5791.0 5898.1 6004.6 6019.1 5419.5 5464.9 5571.1 5769.6 5818.6 5623.1 5628.9 5673.7 5676.9 5678.5 4032.7 4038.4 4088.7 4152.1 4251.0 4162.7 4182.9 4201.7 4278.8 4329.3 07:56:11 INFO - PROCESS | 6285 | 07:56:11 INFO - PROCESS | 6285 | [#4] prototype.html Cycles:180 Average:4042.66 Median:4613.27 stddev:1165.40 (25.3%) stddev-sans-first:1134.23 07:56:11 INFO - PROCESS | 6285 | Values: 295.9 301.6 304.6 305.1 307.6 4679.8 4736.8 4750.0 4770.1 4801.2 4684.9 4691.5 4696.7 4710.8 4718.0 3501.1 3597.6 3618.7 3733.5 3751.4 3702.6 3710.0 3710.3 3716.3 3721.6 3687.7 3698.7 3701.4 3704.8 3715.6 3517.3 3573.6 3639.4 3713.8 3721.3 3259.3 3264.8 3266.9 3269.6 3289.3 4569.5 4571.0 4573.7 4586.0 4587.4 4187.2 4193.1 4194.9 4198.6 4199.5 4650.3 4883.2 4910.0 4912.7 4912.9 3498.1 3499.8 3502.3 3509.7 3513.2 5116.3 5121.2 5122.8 5149.6 5150.3 3422.8 3477.8 3517.8 3530.0 3560.6 3581.4 3590.4 3596.3 3599.4 3608.4 4124.2 4124.4 4125.2 4144.9 4145.6 4838.3 4947.6 4958.8 4962.8 4972.1 1171.5 1211.0 1219.2 1222.5 1223.8 800.0 833.6 843.6 844.1 845.9 4204.2 4264.2 4275.7 4318.7 4385.1 5080.2 5086.6 5092.6 5095.0 5109.7 4394.6 4399.7 4400.8 4402.2 4416.2 2516.7 2563.9 2596.5 2604.3 2605.6 4592.2 4610.3 4616.2 4632.4 4642.8 5003.3 5018.7 5022.6 5026.5 5042.6 4456.7 4599.9 4620.5 4626.0 4634.4 4887.0 4899.5 4909.6 4910.3 4941.4 4870.7 4872.4 4873.6 4878.7 4883.5 4497.2 4641.5 4657.6 4659.4 4660.2 3576.7 3582.2 3599.0 3613.2 3625.5 4828.4 4866.5 4882.2 4883.5 4891.5 4583.7 4724.7 4729.8 4757.9 4764.3 4738.9 4753.9 4767.5 4775.4 4789.8 4639.0 4660.8 4699.9 4709.7 4730.4 4661.5 4798.6 4802.2 4807.5 4978.7 4903.8 4908.1 4912.5 4913.8 4918.8 07:56:11 INFO - PROCESS | 6285 | 07:56:11 INFO - PROCESS | 6285 | [#5] yui.html Cycles:180 Average:13935.62 Median:29802.47 stddev:18741.49 (62.9%) stddev-sans-first:18767.48 07:56:11 INFO - PROCESS | 6285 | Values: 641.6 666.5 670.1 729.1 748.9 10671.7 11353.8 11364.3 11377.0 11394.8 11179.3 11269.1 11288.2 11299.7 11307.0 602.6 620.4 625.2 738.2 755.9 606.5 609.0 736.2 757.8 764.7 787.5 788.7 796.1 796.2 797.2 792.8 793.2 793.2 793.9 795.2 469.1 474.7 567.3 590.6 591.2 10102.7 10499.2 10605.2 10612.9 10631.1 8850.9 9247.8 9275.8 9558.4 9891.3 8205.8 8344.4 8405.6 8405.7 8536.5 2464.4 2477.5 2479.7 2512.5 2575.0 47857.3 48991.3 49217.3 49851.8 50312.0 7445.3 7599.7 7673.8 7721.3 7733.1 15340.8 15402.2 15424.2 15522.0 15685.1 6483.8 6515.0 6539.2 6596.7 6827.2 3481.4 3585.7 3628.3 3649.4 3708.1 2537.8 2614.2 2637.1 2646.7 2695.8 470.2 472.8 478.1 479.8 482.5 502.9 521.9 548.4 562.2 569.6 7030.3 7551.7 7685.2 7696.3 7733.0 465.3 489.7 496.3 516.2 565.7 3629.6 3631.7 3679.3 4015.2 4143.7 70224.6 70338.3 71193.6 73154.6 73179.0 38418.4 44058.3 59013.7 59628.6 64774.0 53661.5 55978.0 56122.7 56545.4 56672.7 6922.7 7256.8 7267.6 7382.5 7474.6 33274.0 37500.8 38021.6 38546.8 38890.0 46863.3 54858.5 55536.4 55711.4 56018.4 8458.7 8855.6 9331.7 9464.1 9613.4 9763.6 9948.3 10025.2 10259.6 10959.2 9452.1 9828.6 9878.1 10700.6 10706.5 9740.1 9939.0 9994.3 10217.7 10260.4 9437.2 9442.6 9826.7 10154.4 10186.8 8389.8 8724.6 9122.7 9325.1 9627.9 8733.9 8893.6 9031.8 9060.6 9139.8 07:56:11 INFO - PROCESS | 6285 | -------- Summary: end -------- 07:56:11 INFO - PROCESS | 6285 | 07:56:12 INFO - TEST-INFO | 6285: exit 0 07:56:12 INFO - TEST-OK | dromaeo_css | took 1122387ms 07:56:12 INFO - TEST-START | kraken 07:56:12 INFO - operating with platform_type : linux_ 07:56:12 INFO - Initialising browser for kraken test... 07:56:12 INFO - TEST-INFO | started process 6586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfjuAF0/profile http://localhost:50265/getInfo.html) 07:56:17 INFO - PROCESS | 6586 | __metrics Screen width/height:1600/1200 07:56:17 INFO - PROCESS | 6586 | colorDepth:24 07:56:17 INFO - PROCESS | 6586 | Browser inner width/height: 1024/697 07:56:17 INFO - PROCESS | 6586 | __metrics 07:56:17 INFO - PROCESS | 6586 | 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" 07:56:17 INFO - PROCESS | 6586 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:56:18 INFO - PROCESS | 6586 | console.error: PushService: 07:56:18 INFO - PROCESS | 6586 | stateChangeProcessEnqueue: Error transitioning state 07:56:18 INFO - PROCESS | 6586 | UnknownError 07:56:19 INFO - TEST-INFO | 6586: exit 0 07:56:19 INFO - Browser initialized. 07:56:19 INFO - Running cycle 1/1 for kraken test... 07:56:19 INFO - TEST-INFO | started process 6669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfjuAF0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:56:31 INFO - PROCESS | 6669 | RSS: Main: 174907392 07:56:31 INFO - PROCESS | 6669 | 07:56:34 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50265/tests/kraken/driver.html?testName=audio-beat-detection) 07:56:35 INFO - PROCESS | 6669 | RSS: Main: 231440384 07:56:35 INFO - PROCESS | 6669 | 07:56:37 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50265/tests/kraken/driver.html?testName=audio-dft) 07:56:38 INFO - PROCESS | 6669 | RSS: Main: 218468352 07:56:38 INFO - PROCESS | 6669 | 07:56:41 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50265/tests/kraken/driver.html?testName=audio-fft) 07:56:42 INFO - PROCESS | 6669 | RSS: Main: 300044288 07:56:42 INFO - PROCESS | 6669 | 07:56:44 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50265/tests/kraken/driver.html?testName=audio-oscillator) 07:56:45 INFO - PROCESS | 6669 | RSS: Main: 209108992 07:56:45 INFO - PROCESS | 6669 | 07:56:47 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:56:48 INFO - PROCESS | 6669 | RSS: Main: 213946368 07:56:48 INFO - PROCESS | 6669 | 07:56:51 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50265/tests/kraken/driver.html?testName=imaging-darkroom) 07:56:51 INFO - PROCESS | 6669 | RSS: Main: 253493248 07:56:51 INFO - PROCESS | 6669 | 07:56:55 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50265/tests/kraken/driver.html?testName=imaging-desaturate) 07:56:55 INFO - PROCESS | 6669 | RSS: Main: 253751296 07:56:55 INFO - PROCESS | 6669 | 07:56:58 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50265/tests/kraken/driver.html?testName=json-parse-financial) 07:56:59 INFO - PROCESS | 6669 | RSS: Main: 252223488 07:56:59 INFO - PROCESS | 6669 | 07:57:01 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:57:01 INFO - PROCESS | 6669 | RSS: Main: 214704128 07:57:01 INFO - PROCESS | 6669 | 07:57:03 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50265/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:57:04 INFO - PROCESS | 6669 | RSS: Main: 221843456 07:57:04 INFO - PROCESS | 6669 | 07:57:06 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:57:07 INFO - PROCESS | 6669 | RSS: Main: 230719488 07:57:07 INFO - PROCESS | 6669 | 07:57:10 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:57:10 INFO - PROCESS | 6669 | RSS: Main: 239411200 07:57:10 INFO - PROCESS | 6669 | 07:57:13 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:57:14 INFO - PROCESS | 6669 | RSS: Main: 235016192 07:57:14 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | Cycle 1(1): loaded http://localhost:50265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50265/tests/kraken/driver.html?testName=ai-astar) 07:57:16 INFO - PROCESS | 6669 | RSS: Main: 284590080 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | __start_tp_report 07:57:16 INFO - PROCESS | 6669 | _x_x_mozilla_page_load 07:57:16 INFO - PROCESS | 6669 | _x_x_mozilla_page_load_details 07:57:16 INFO - PROCESS | 6669 | |i|pagename|runs| 07:57:16 INFO - PROCESS | 6669 | |0;ai-astar;107;115;114;116;115;116;116;116;117;116 07:57:16 INFO - PROCESS | 6669 | |1;audio-beat-detection;155;132;132;177;140;130;127;128;166;128 07:57:16 INFO - PROCESS | 6669 | |2;audio-dft;163;161;163;165;164;160;163;162;161;168 07:57:16 INFO - PROCESS | 6669 | |3;audio-fft;76;76;77;125;79;78;77;78;101;76 07:57:16 INFO - PROCESS | 6669 | |4;audio-oscillator;84;84;122;85;84;84;104;83;89;119 07:57:16 INFO - PROCESS | 6669 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;116;117;117 07:57:16 INFO - PROCESS | 6669 | |6;imaging-darkroom;147;146;148;155;147;146;147;147;147;145 07:57:16 INFO - PROCESS | 6669 | |7;imaging-desaturate;95;95;96;95;95;96;95;95;95;95 07:57:16 INFO - PROCESS | 6669 | |8;json-parse-financial;63;64;63;63;64;64;66;64;64;64 07:57:16 INFO - PROCESS | 6669 | |9;json-stringify-tinderbox;67;67;67;66;67;67;68;67;67;67 07:57:16 INFO - PROCESS | 6669 | |10;stanford-crypto-aes;94;84;94;84;85;83;84;84;95;83 07:57:16 INFO - PROCESS | 6669 | |11;stanford-crypto-ccm;143;143;154;143;140;151;142;142;187;141 07:57:16 INFO - PROCESS | 6669 | |12;stanford-crypto-pbkdf2;181;179;180;182;178;178;180;177;177;179 07:57:16 INFO - PROCESS | 6669 | |13;stanford-crypto-sha256-iterative;70;69;69;69;71;69;68;69;70;69 07:57:16 INFO - PROCESS | 6669 | __end_tp_report 07:57:16 INFO - PROCESS | 6669 | __start_cc_report 07:57:16 INFO - PROCESS | 6669 | _x_x_mozilla_cycle_collect,1990 07:57:16 INFO - PROCESS | 6669 | __end_cc_report 07:57:16 INFO - PROCESS | 6669 | __startTimestamp1479398236509__endTimestamp 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | ------- Summary: start ------- 07:57:16 INFO - PROCESS | 6669 | Number of tests: 14 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#0] ai-astar Cycles:10 Average:114.80 Median:116.00 stddev:2.86 (2.5%) stddev-sans-first:0.87 07:57:16 INFO - PROCESS | 6669 | Values: 107.0 115.0 114.0 116.0 115.0 116.0 116.0 116.0 117.0 116.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#1] audio-beat-detection Cycles:10 Average:141.50 Median:136.00 stddev:18.05 (13.3%) stddev-sans-first:18.47 07:57:16 INFO - PROCESS | 6669 | Values: 155.0 132.0 132.0 177.0 140.0 130.0 127.0 128.0 166.0 128.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#2] audio-dft Cycles:10 Average:163.00 Median:163.00 stddev:2.31 (1.4%) stddev-sans-first:2.45 07:57:16 INFO - PROCESS | 6669 | Values: 163.0 161.0 163.0 165.0 164.0 160.0 163.0 162.0 161.0 168.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#3] audio-fft Cycles:10 Average:84.30 Median:77.00 stddev:16.18 (21.0%) stddev-sans-first:16.88 07:57:16 INFO - PROCESS | 6669 | Values: 76.0 76.0 77.0 125.0 79.0 78.0 77.0 78.0 101.0 76.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#4] audio-oscillator Cycles:10 Average:93.80 Median:84.00 stddev:15.40 (18.3%) stddev-sans-first:15.93 07:57:16 INFO - PROCESS | 6669 | Values: 84.0 84.0 122.0 85.0 84.0 84.0 104.0 83.0 89.0 119.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:57:16 INFO - PROCESS | 6669 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:2.76 (1.9%) stddev-sans-first:2.92 07:57:16 INFO - PROCESS | 6669 | Values: 147.0 146.0 148.0 155.0 147.0 146.0 147.0 147.0 147.0 145.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:57:16 INFO - PROCESS | 6669 | Values: 95.0 95.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#8] json-parse-financial Cycles:10 Average:63.90 Median:64.00 stddev:0.88 (1.4%) stddev-sans-first:0.87 07:57:16 INFO - PROCESS | 6669 | Values: 63.0 64.0 63.0 63.0 64.0 64.0 66.0 64.0 64.0 64.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:0.47 (0.7%) stddev-sans-first:0.50 07:57:16 INFO - PROCESS | 6669 | Values: 67.0 67.0 67.0 66.0 67.0 67.0 68.0 67.0 67.0 67.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:84.50 stddev:5.10 (6.0%) stddev-sans-first:4.74 07:57:16 INFO - PROCESS | 6669 | Values: 94.0 84.0 94.0 84.0 85.0 83.0 84.0 84.0 95.0 83.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:143.00 stddev:14.23 (10.0%) stddev-sans-first:14.95 07:57:16 INFO - PROCESS | 6669 | Values: 143.0 143.0 154.0 143.0 140.0 151.0 142.0 142.0 187.0 141.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.10 Median:179.50 stddev:1.66 (0.9%) stddev-sans-first:1.62 07:57:16 INFO - PROCESS | 6669 | Values: 181.0 179.0 180.0 182.0 178.0 178.0 180.0 177.0 177.0 179.0 07:57:16 INFO - PROCESS | 6669 | 07:57:16 INFO - PROCESS | 6669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 07:57:16 INFO - PROCESS | 6669 | Values: 70.0 69.0 69.0 69.0 71.0 69.0 68.0 69.0 70.0 69.0 07:57:16 INFO - PROCESS | 6669 | -------- Summary: end -------- 07:57:16 INFO - PROCESS | 6669 | 07:57:17 INFO - TEST-INFO | 6669: exit 0 07:57:17 INFO - TEST-OK | kraken | took 64944ms 07:57:17 INFO - SUITE-END | took 1187s 07:57:18 INFO - Completed test suite (00:19:47) 07:57:18 INFO - javascript benchmark 07:57:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2546.4907018596277, 2570.19039002714, 2593.6887573491176, 2597.5843864981593, 2615.9215223543288, 4422.3145412461035, 4512.63898888089, 4585.679002469828, 4601.976990115049, 4634.814607415704, 4530.886727831806, 4552.590266875981, 4567.177907976563, 4577.519360467145, 4583.679142460021, 4202.789860506962, 4206.579342065785, 4250.213710463574, 4269.252880745873, 4339.392485052095, 4299.441072660566, 4331.350297455376, 4358.97820510897, 4359.0, 4404.581564751344, 4145.875623731293, 4182.53992060873, 4316.913661726748, 4345.994280021219, 4369.978150109261, 4184.916301673949, 4218.261804184286, 4235.110626768383, 4238.597333253336, 4319.07139964909, 4222.429971953778, 4232.238197124517, 4236.428082208893, 4238.597333253336, 4273.252180868336, 4587.816487340502, 4609.216433206363, 4610.377599024156, 4644.9767751161025, 4661.09108723799, 4824.228123500258, 4867.586255168315, 4885.022995400898, 4890.266460030988, 4896.167651499253, 4948.8762780930765, 4954.108260513106, 4969.652124351297, 4996.300517927493, 5000.249962505617, 4646.97676511622, 4647.37260469839, 4648.65135114861, 4656.371389862393, 4678.602318802906, 4879.950810575743, 4919.65562410635, 4931.358923340014, 5067.949320506821, 5117.0533451310885, 4789.521047895182, 4837.516248375135, 4837.564619184291, 4916.508349165055, 4917.139500587455, 4942.703437793672, 4950.950490495121, 4957.3555437793575, 4957.380327459067, 5006.874828129326, 4915.3855768029, 4916.655834091579, 4919.926201106986, 4927.95072049282, 4979.0, 4724.078804633133, 4773.64197685175, 4783.354247176656, 4794.712317260975, 4836.056968891033, 4171.416001759695, 4200.0, 4203.831846726097, 4213.557576454489, 4230.5769423057445, 3671.908202294964, 3674.4855720199193, 3676.485292059114, 3708.740388172802, 3733.906652333659, 4296.3555466680245, 4303.526612072732, 4304.504981927056, 4332.653387728974, 4342.69601127918, 4778.283257511401, 4831.782569784368, 4834.927476087792, 4908.607311415079, 4954.504549545089, 4262.46719160105, 4286.057067445157, 4286.485621725351, 4321.222180007566, 4328.632066274402, 4474.149911516802, 4475.283954567253, 4477.776111194427, 4511.977440112779, 4521.050579378368, 4533.614642755403, 4594.88512787183, 4603.3785438965315, 4651.790669419885, 4658.767061646972, 4655.2784318430695, 4863.878403039952, 4920.212765957573, 4943.65394422387, 4945.851624451272, 4693.530646935279, 4706.858794236178, 4707.082118986902, 4707.340972263817, 4749.762511874462, 4939.703617782944, 4940.975295123501, 4942.357493525818, 4944.8763780905765, 4995.0, 4789.114013907439, 4875.926861097158, 4893.168161412497, 4962.156433406258, 4975.925361119514, 4856.295837103671, 4858.076965376567, 4865.391826021747, 4900.558949694402, 4906.656534042583, 4834.419869615669, 4834.758262086812, 4835.806567737392, 4836.105320515716, 4882.511748825089, 4640.559146881041, 4673.883152921068, 4713.340132381538, 4775.044991001883, 4782.115308667908, 4764.4282686077895, 4825.469198388104, 4825.855224343275, 4839.95160048395, 4853.733044682576, 4562.88592785183, 4626.190416677001, 4626.583607475343, 4682.578567928903, 4766.046790641816], "value": 4532.0862837772, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.3203543623624, 550.6998685716284, 559.490863314384, 564.0805487056097, 569.8888716700243, 21978.45053873654, 27497.450050998992, 28365.149045528615, 28512.857435712845, 30466.390672186542, 27865.16404507863, 28143.859280703567, 28156.0, 28210.294742631395, 28238.294042648944, 5363.785448582052, 5512.33851937768, 5514.0, 5514.862128446801, 5518.2826232589705, 5644.068728659787, 5716.056850619642, 5718.228039214694, 5720.11338242573, 5720.427957204267, 5692.943070569303, 5722.37053924068, 5727.799527016556, 5730.713464326788, 5732.140178973145, 5686.5735069869925, 5720.284964379432, 5726.398728133569, 5726.455986681301, 5733.655980641175, 5637.436256374371, 5690.630109042899, 5692.6299790513485, 5696.259486266758, 5696.77212911483, 25501.23496295114, 25552.616710749353, 25695.22914312555, 25824.22527324183, 25849.224523264333, 2977.389635124794, 2999.850007499638, 3054.0, 3119.313750974782, 3257.674232576723, 18023.819761802344, 18109.7283540747, 18211.63576728471, 18235.0, 19057.61884762297, 2641.1944356971308, 2712.83348160291, 2734.125079974409, 2745.8764355603844, 2773.057160565397, 242390.0, 242564.0, 243151.78424107944, 243436.0, 244198.0, 31140.221494462367, 51236.74381628143, 51677.741611291705, 51683.741581291855, 51707.741461292455, 31518.21204469861, 33056.66943330584, 33073.0, 33092.539730944605, 33127.66872331294, 11787.705307367385, 11821.113416493625, 11873.643790686294, 11880.821787673192, 11885.22746021506, 10250.282480226313, 10269.024442677934, 10324.328918620266, 10341.482925853828, 10349.844752328721, 7702.883081953086, 7705.845883082307, 7804.726834560876, 7805.2194780521495, 7809.726659566888, 3001.4747419201553, 3064.111407691789, 3085.3983473222506, 3108.6788115051013, 3112.8754849805755, 809.8137428391503, 823.2138307915926, 838.1450920061625, 910.7495438754396, 948.8054948735493, 25131.0, 26812.865935670587, 27262.727372726415, 27643.44713105767, 27805.304867378476, 832.8500869843486, 916.7524768312652, 959.4003747657714, 975.9512024398751, 979.2557656181353, 13732.382042808098, 13989.720205596035, 14222.928885355506, 14788.630284242765, 14847.109173449628, 340381.0, 345454.0, 346086.0, 346213.0, 346238.4513858353, 42915.141697165884, 43417.78291108524, 43506.347404788954, 43508.782456087516, 43548.78225608852, 1035.5288343803552, 1095.2114477576133, 1128.503458478267, 1169.8362229287907, 1183.7810005148904, 23819.0, 26413.471730565667, 26539.601905971813, 27281.181564553095, 27425.588616170375, 40655.79672101739, 41286.58713412948, 41296.79351603223, 41303.7934810324, 41395.379069313385, 273551.0, 275309.0, 275564.0, 275620.0, 275947.0, 20963.475913101684, 21660.675089873348, 23235.419114522272, 34854.47718284177, 35842.10394740153, 37694.434583480725, 37707.62292377041, 38014.239715206095, 38505.0, 39118.2176356477, 32778.0, 32813.34373312568, 33293.33413331768, 33341.33317333688, 33454.33091338208, 32237.838810805795, 32803.67196328006, 33330.16674583155, 33661.83169084139, 33665.495017575246, 33415.66584334125, 33936.32127357488, 34033.31933361269, 34143.65856341405, 34556.82721586376, 28237.717622823508, 30480.390392192476, 30719.539206911468, 31115.22211944629, 31298.37403251877, 24027.399315017265, 24524.14165504199, 24766.725439308793, 24809.25572232836, 25221.243362699148], "value": 14397.224843237136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.0921890880247, 359.2563393774886, 364.1969457346551, 366.63336663336656, 388.48137736122277, 9561.139497445229, 11269.211155219138, 11561.479733411996, 11915.463804128813, 12383.257004579731, 15840.445584404548, 16058.678826423464, 16201.0, 16382.83617163828, 16388.83611163888, 3940.743851649641, 4174.20690068886, 4175.519815221258, 4177.791110444481, 4180.602842729951, 2796.5385711357603, 2806.1441260415563, 2959.5708622249763, 4089.1003979124544, 4161.0845613964875, 4188.518320393163, 4188.623023927846, 4194.916101677964, 4195.119025004753, 4195.3916682081235, 4072.6741860651077, 4183.184279065584, 4184.0, 4185.560516145822, 4187.120704652011, 3710.628937106295, 3801.1637439763485, 3801.82891769871, 3803.5055442792536, 3803.7717736935874, 16047.518574442785, 16083.91958040214, 16268.75596866048, 16278.430254941139, 16352.509424717278, 1709.8888572242765, 1875.3061367294188, 2178.836587255962, 2238.440389902524, 2376.821738369612, 9582.712518624452, 10634.308769930007, 10682.62610808618, 10799.2440529163, 10828.675139745821, 1386.3137746815391, 1443.559714287142, 1447.862453066957, 1456.9529810616102, 1514.5380658899032, 65823.01265481021, 66065.00902486514, 66081.1054010278, 66685.0, 67721.66139169323, 9038.683646072355, 9054.185123338799, 9372.5313734313, 9432.292578056537, 9619.951900240454, 11219.94390028061, 11586.536538538365, 11954.940225298818, 12419.31693756834, 12469.376531173404, 6526.314736952551, 6646.900296495556, 6661.333866613397, 6835.248122706498, 6869.450443964471, 6302.243730752248, 6314.210723659543, 6424.068510066014, 6509.544331896722, 6535.3464653534265, 5867.6772777497645, 6001.549883758736, 6015.54883383748, 6104.786332478431, 6111.35830737775, 1721.7847769028872, 1724.939627113045, 1747.344745720355, 1750.8336708012719, 1781.5724226185623, 865.2385900407601, 907.2515174980667, 911.9361644684808, 958.7440453006584, 998.336106489191, 16270.186490675418, 16533.090680012716, 17318.0, 17545.912270438566, 17600.823991760175, 888.036480418753, 898.874157617934, 902.8961669408102, 912.926965842731, 930.8683115665186, 9256.259499240045, 9956.153726933147, 10187.7453063674, 10191.388516689023, 10213.74465638365, 332028.0, 338035.0, 339142.0, 339271.0, 340428.0, 62539.0, 62957.37042629515, 63869.0, 63999.0, 64588.0, 912.6896855069308, 933.9019402962726, 955.5699935029264, 956.3496822160997, 956.6699488676395, 14978.707277423695, 14989.325480353193, 15427.382904683687, 15707.607309817346, 15838.683226335179, 31607.0, 32892.0, 33662.77238710846, 34409.655903440645, 36038.45942310815, 45470.31794523151, 47054.0, 47698.28452573145, 47845.0, 49048.50951490439, 6849.383555480031, 7556.546607203585, 7584.2794934481135, 7634.525676498971, 7978.84042319162, 8712.128787121237, 11634.476448559666, 11819.135032524391, 11926.986206172225, 12003.939980300043, 10181.287309888237, 10275.691729248134, 10449.16406687448, 10678.252522323362, 11133.387663678575, 9917.87586910121, 10177.389356638329, 10401.27191096616, 10406.323588966692, 10637.574497020032, 10843.295185812896, 10953.780924381626, 11031.39327336972, 11046.668599942015, 11075.504806851295, 5803.564732645153, 6381.361863813581, 7484.775456736306, 7758.146603873456, 7825.33484653788, 7770.922290777246, 9235.538223088684, 9450.669226577036, 9483.810323793623, 9898.455584942609], "value": 7590.292086633, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1183.8105903055514, 1312.8030795380691, 1344.630226687661, 1389.6178550898508, 1629.9266533006007, 5460.78156873725, 5912.290525136984, 6198.72105755241, 6199.101130336098, 6202.968985155079, 6089.817305480843, 6168.198134242542, 6293.118963345135, 6297.244330680325, 6299.401556852104, 1727.1450631937178, 1775.2011594782334, 1778.4397914656906, 1786.63374008328, 1787.392286622548, 1711.897286162828, 1747.1089744230408, 1749.991250043748, 1756.0956107604593, 1757.4815429448279, 1741.3469948769211, 1765.0645158066245, 1766.3641089207874, 1768.5490199999047, 1771.0259357353405, 1708.4020592792485, 1728.5160155156577, 1729.3428497171121, 1731.2469075952001, 1731.471901070173, 1685.8314168583165, 1698.8810783245178, 1701.421516684321, 1702.208473060033, 1702.2339947023888, 5737.168110623936, 6077.270727512682, 6162.784302549434, 6163.969180154116, 6171.105189747506, 4053.1893621275863, 4215.873523794291, 4217.1144059747185, 4219.050713589418, 4232.407462955189, 2568.75596818302, 2693.4209145033715, 2763.557830747091, 2765.4330862173206, 2771.0439898235077, 789.8025493626593, 790.130856058337, 812.34200297759, 812.4482238923628, 827.1439060572279, 8365.539895305756, 8656.740297791077, 8669.783255418602, 8673.436226645248, 8681.30549556034, 3630.237650093457, 3789.829457674411, 3816.160444702161, 3847.5190601174854, 3861.536615606089, 7588.089429268523, 7591.506552074097, 7596.696132154762, 7599.810004749815, 7604.163542010375, 4221.662267018631, 4226.1758957003085, 4226.5773422657485, 4227.852025179104, 4230.873073807791, 3305.0, 3314.486254630536, 3860.131470419133, 3938.4683067786054, 3941.4087886817206, 2970.287131088523, 3125.2343175922047, 3305.0500204879236, 3310.1724568857785, 3326.817025063645, 1104.9116070714485, 1116.1740312168936, 1125.5649047464549, 1129.740159763259, 1140.224647239885, 820.1347578304826, 832.650286879512, 846.724814435311, 866.4931015355961, 867.3191544637556, 4722.315264286728, 4742.834000810024, 4750.239961606196, 4854.854354369375, 4859.805607775649, 392.479964047638, 404.5186228388209, 411.64392800227586, 412.0625576812715, 418.4204876246421, 3300.372929143455, 3382.763206575565, 3396.286779776225, 3421.2815308784934, 3534.169470174507, 7661.118971318369, 7789.493682910593, 7871.567063811431, 7874.6850125994315, 7880.487768295043, 7849.058113026359, 7852.293293603489, 7854.0, 7857.921420785833, 7863.213678632091, 6165.784197553064, 6198.194234749454, 6227.0, 6259.6870156492, 6264.937350626436, 4561.521040290721, 4586.564276393738, 4592.563706447882, 4594.47163576193, 4651.209294419889, 7199.71201151948, 7218.3503484686635, 7343.412526997934, 7346.4122870169185, 7351.742689005859, 7326.743563975236, 7441.851162976818, 7464.365528929885, 7471.589062601392, 7474.215207403362, 5023.146065168857, 5429.131338985743, 5596.888062238814, 5738.885222295447, 5808.73860676279, 6339.90490142639, 6372.0760489729655, 6392.712327945161, 6399.072134540373, 6400.327965563549, 5755.424457554211, 5791.0, 5898.056310990221, 6004.579679422399, 6019.067044608093, 5419.485148910847, 5464.863378415572, 5571.05292100352, 5769.567282453917, 5818.592698511064, 5623.100303951348, 5628.85927851807, 5673.716314184357, 5676.858078548069, 5678.488935995781, 4032.6572241359813, 4038.374052021941, 4088.6933479988525, 4152.148809494107, 4250.978745106255, 4162.729422587522, 4182.853600123981, 4201.70588058833, 4278.828846846091, 4329.2640251156745], "value": 3500.5748700417944, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.927497763048, 301.63954074880513, 304.58120084883285, 305.11212371997493, 307.649279821004, 4679.766011699414, 4736.834210802623, 4750.0, 4770.141374552579, 4801.207800712878, 4684.882877928054, 4691.530846915315, 4696.671233013691, 4710.764461776906, 4717.952820471794, 3501.0547152268873, 3597.586277578073, 3618.7285953553587, 3733.45864849598, 3751.4185301278344, 3702.629737026303, 3710.0, 3710.3321402147603, 3716.256748650267, 3721.6464435878547, 3687.7234207434417, 3698.722595805312, 3701.3522633539155, 3704.8332825022803, 3715.6098609646006, 3517.278957813642, 3573.5890372606964, 3639.399499082648, 3713.7586056906484, 3721.3301605710963, 3259.348130373911, 3264.8367581620823, 3266.9382450703615, 3269.5749552558254, 3289.259916518788, 4569.47451043131, 4570.960311392953, 4573.725576465423, 4586.0, 4587.3577699121815, 4187.225363307798, 4193.1486589119695, 4194.874153775391, 4198.5591512891015, 4199.475065616798, 4650.348951146842, 4883.169861123618, 4910.0, 4912.656114072016, 4912.8771780705765, 3498.0904964709357, 3499.8075105869166, 3502.317048175607, 3509.666581674737, 3513.1555933135055, 5116.334876466073, 5121.180611102206, 5122.820701275437, 5149.613778966555, 5150.304708864331, 3422.8117453540294, 3477.826108694555, 3517.8065206413894, 3529.982350088233, 3560.590532088791, 3581.3553560358864, 3590.4075827488173, 3596.3166998270767, 3599.370110230699, 3608.350496910529, 4124.226582569524, 4124.360724087771, 4125.195586860534, 4144.937825932613, 4145.647619952338, 4838.316441021181, 4947.628927830355, 4958.776855041532, 4962.751862406937, 4972.129877271463, 1171.46698252295, 1210.975780484403, 1219.1709637446622, 1222.468226321553, 1223.8103094020441, 800.0239707556772, 833.6248688090384, 843.5866425451485, 844.1178967978477, 845.89003429555, 4204.201201771653, 4264.168487145039, 4275.743455392624, 4318.719283246579, 4385.122975404932, 5080.240621939738, 5086.64393492452, 5092.567131793765, 5094.974525127351, 5109.744512774347, 4394.648428125806, 4399.692021558524, 4400.779961001937, 4402.163588918095, 4416.183006143874, 2516.7483251674685, 2563.9103381062973, 2596.5326241276375, 2604.2577865308676, 2605.5831067029562, 4592.2422800238255, 4610.308453731967, 4616.238320677051, 4632.3977882875015, 4642.79107440166, 5003.324551185616, 5018.698878067255, 5022.59819214462, 5026.49205238427, 5042.621803364762, 4456.688031837805, 4599.931001034987, 4620.5148459411275, 4626.0, 4634.374359461497, 4886.95113048865, 4899.534544218293, 4909.607231421406, 4910.2880082388565, 4941.407031156285, 4870.659053866196, 4872.366592342973, 4873.610111191168, 4878.658493905535, 4883.511648835088, 4497.1905057088725, 4641.512641172628, 4657.604103651092, 4659.44086709597, 4660.22521757364, 3576.7496275260482, 3582.229820588586, 3599.0, 3613.241219343862, 3625.513539448919, 4828.444728856227, 4866.537678920497, 4882.194437917846, 4883.462819089968, 4891.486393928586, 4583.72497650142, 4724.71651700899, 4729.787159577759, 4757.928631070467, 4764.30917516965, 4738.905221895612, 4753.857384278477, 4767.4994125617695, 4775.42694876617, 4789.808407663654, 4638.953610463852, 4660.811493069245, 4699.906001880012, 4709.7174169549935, 4730.361401210793, 4661.463931647768, 4798.640101992434, 4802.183628783185, 4807.519248075165, 4978.726170060537, 4903.828366007316, 4908.141075311734, 4912.533309335608, 4913.828016019422, 4918.827841025547], "value": 3674.6282287688564, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.5605310362403, 666.5300962821211, 670.1489108831784, 729.059513227936, 748.8689479341114, 10671.733206669827, 11353.829692554618, 11364.261323014009, 11377.0, 11394.829077563843, 11179.273347232445, 11269.09847212223, 11288.153388495855, 11299.717507062307, 11307.038901693346, 602.6233603997501, 620.3858180401393, 625.1903784598956, 738.2469880721674, 755.8866170074506, 606.4511616986634, 608.9847753806146, 736.1607767145458, 757.8029712274821, 764.6597264217426, 787.4527203593505, 788.7278888783361, 796.1083586383259, 796.24356860982, 797.182887540273, 792.825578372757, 793.234528679821, 793.2464159048926, 793.8967934168579, 795.2326005404755, 469.0806020200411, 474.67721949074615, 567.2540609099021, 590.5895402695129, 591.2343515147851, 10102.69691909244, 10499.212559058102, 10605.204609654229, 10612.893871061267, 10631.149508039338, 8850.893638295212, 9247.815043699156, 9275.814483710288, 9558.426494410358, 9891.258155638285, 8205.79485512861, 8344.41589088764, 8405.621747021398, 8405.70580029702, 8536.530490823003, 2464.4208610976407, 2477.467344520937, 2479.690038745157, 2512.4849405871937, 2574.9871250643628, 47857.282140767915, 48991.265131023065, 49217.26174107391, 49851.750741246426, 50312.0, 7445.2890118560335, 7599.658015389321, 7673.808154796175, 7721.305082542598, 7733.149353571102, 15340.769888451681, 15402.22988850553, 15424.228788560527, 15522.0, 15685.05889646625, 6483.805485835433, 6514.967425162844, 6539.2479864815205, 6596.736130554724, 6827.214870289881, 3481.3559491494157, 3585.695215906625, 3628.292482965849, 3649.434337677664, 3708.054446116277, 2537.784288335475, 2614.150401119644, 2637.11656595039, 2646.7353264673766, 2695.811293209496, 470.19596490001794, 472.75653038685107, 478.0987837925466, 479.7673128532659, 482.4596451973812, 502.94216165140745, 521.9321488206509, 548.3912856729028, 562.1707980728393, 569.6382796923983, 7030.261822508665, 7551.713800339674, 7685.23147685227, 7696.345810606049, 7733.0, 465.3043699668949, 489.7428849853855, 496.3349112189611, 516.2256615077384, 565.7312776431162, 3629.582598001211, 3631.710742686308, 3679.264147170523, 4015.217032678658, 4143.6685065194715, 70224.6488767553, 70338.2966170342, 71193.64403178054, 73154.63422682852, 73179.0, 38418.42372364417, 44058.33912491315, 59013.70493147593, 59628.63610526669, 64774.0, 53661.46338536643, 55978.0, 56122.71938640362, 56545.43454565402, 56672.716636417375, 6922.688479018557, 7256.818579535554, 7267.563946163247, 7382.483226174117, 7474.626268686653, 33274.0, 37500.812495937345, 38021.619783801805, 38546.80726596349, 38890.0, 46863.29705054495, 54858.45141548693, 55536.444635553125, 55711.44288557063, 56018.43981560132, 8458.74623761288, 8855.645774168961, 9331.673391431268, 9464.148226659634, 9613.375130616487, 9763.609455621696, 9948.303618746908, 10025.197984161396, 10259.640912568322, 10959.232853700483, 9452.054794520493, 9828.606855725691, 9878.110970012733, 10700.571977121139, 10706.464676766287, 9740.074692904163, 9938.950305248427, 9994.250431217542, 10217.744556385853, 10260.384376937407, 9437.245020398488, 9442.575084121094, 9826.705198844045, 10154.39073655583, 10186.847197291898, 8389.790255243668, 8724.563771811258, 9122.726318210463, 9325.114114159143, 9627.90372096298, 8733.868991964999, 8893.555322233733, 9031.81936361256, 9060.570332327428, 9139.771505712144], "value": 5609.260245730611, "unit": "score"}], "name": "dromaeo_css", "value": 5739.275989457458, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 114.0, 116.0, 115.0, 116.0, 116.0, 116.0, 117.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 132.0, 132.0, 177.0, 140.0, 130.0, 127.0, 128.0, 166.0, 128.0], "value": 141.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 165.0, 164.0, 160.0, 163.0, 162.0, 161.0, 168.0], "value": 163.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 125.0, 79.0, 78.0, 77.0, 78.0, 101.0, 76.0], "value": 84.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 122.0, 85.0, 84.0, 84.0, 104.0, 83.0, 89.0, 119.0], "value": 93.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 148.0, 155.0, 147.0, 146.0, 147.0, 147.0, 147.0, 145.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 64.0, 64.0, 66.0, 64.0, 64.0, 64.0], "value": 63.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 84.0, 94.0, 84.0, 85.0, 83.0, 84.0, 84.0, 95.0, 83.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 143.0, 154.0, 143.0, 140.0, 151.0, 142.0, 142.0, 187.0, 141.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 179.0, 180.0, 182.0, 178.0, 178.0, 180.0, 177.0, 177.0, 179.0], "value": 179.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 69.0, 71.0, 69.0, 68.0, 69.0, 70.0, 69.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1571.7999999999997, "alertThreshold": 2.0}]} 07:57:18 INFO - Return code: 0 07:57:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:57:18 INFO - # TBPL SUCCESS # 07:57:18 INFO - Running post-action listener: _resource_record_post_action 07:57:18 INFO - [mozharness: 2016-11-17 15:57:18.320523Z] Finished run-tests step (success) 07:57:18 INFO - Running post-run listener: _resource_record_post_run 07:57:18 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 16384; Write bytes: 392151040; Read time: 248; Write time: 253304 07:57:18 INFO - TinderboxPrint: CPU usage
13.1% 07:57:18 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 248 07:57:18 INFO - TinderboxPrint: I/O write bytes / time
392,151,040 / 253,304 07:57:18 INFO - TinderboxPrint: CPU idle
8,349.2 (86.9%) 07:57:18 INFO - TinderboxPrint: CPU user
1,207.9 (12.6%) 07:57:18 INFO - TinderboxPrint: Swap in / out
0 / 0 07:57:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 99704832; Read time: 76; Write time: 73960 07:57:18 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292446208; Read time: 164; Write time: 179344 07:57:18 INFO - Running post-run listener: _upload_blobber_files 07:57:18 INFO - Blob upload gear active. 07:57:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:57:18 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 07:57:18 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'] 07:57:18 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 07:57:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:57:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:57:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:57:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:20 INFO - (blobuploader) - INFO - Done attempting. 07:57:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:57:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:57:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:23 INFO - (blobuploader) - INFO - Done attempting. 07:57:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:57:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:57:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:57:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:57:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:57:24 INFO - (blobuploader) - INFO - Done attempting. 07:57:24 INFO - (blobuploader) - INFO - Iteration through files over. 07:57:24 INFO - Return code: 0 07:57:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:57:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:57:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdd2b8d2633484603317fbfd6a781271bb13292ed9a237ab1e1ab0723f8f2e50244f73f1b19be73e152d60649ce415aa4d1318df6c168aeba26960347b68a629", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbd25719e48b66498c9678cce5016c43457580ac40ca909e82e8c0f1fdccf85b334bc1c63fd6fb0f86263e7e80fe9550c872e82c47d21a6872cb82f6cf54d73d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa9add1fae250785c94ab48c63f2dec41e0dcc2e2ccf31365c78fe70f4778230a3d042486444430e4be5e97dc95b263b95749ef79d38bdf3c47686e0508aa3a4"} 07:57:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:57:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:57:24 INFO - Contents: 07:57:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fdd2b8d2633484603317fbfd6a781271bb13292ed9a237ab1e1ab0723f8f2e50244f73f1b19be73e152d60649ce415aa4d1318df6c168aeba26960347b68a629", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbd25719e48b66498c9678cce5016c43457580ac40ca909e82e8c0f1fdccf85b334bc1c63fd6fb0f86263e7e80fe9550c872e82c47d21a6872cb82f6cf54d73d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa9add1fae250785c94ab48c63f2dec41e0dcc2e2ccf31365c78fe70f4778230a3d042486444430e4be5e97dc95b263b95749ef79d38bdf3c47686e0508aa3a4"} 07:57:24 INFO - Running post-run listener: copy_logs_to_upload_dir 07:57:24 INFO - Copying logs to upload dir... 07:57:24 INFO - mkdir: /builds/slave/test/build/upload/logs 07:57:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.042006 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-11-17 07:57:23.158422) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 07:57:23.162000) ========= 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=232498196343f89f466a4a9a000001c8-1479396995.463775-520358466 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/fdd2b8d2633484603317fbfd6a781271bb13292ed9a237ab1e1ab0723f8f2e50244f73f1b19be73e152d60649ce415aa4d1318df6c168aeba26960347b68a629", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbd25719e48b66498c9678cce5016c43457580ac40ca909e82e8c0f1fdccf85b334bc1c63fd6fb0f86263e7e80fe9550c872e82c47d21a6872cb82f6cf54d73d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa9add1fae250785c94ab48c63f2dec41e0dcc2e2ccf31365c78fe70f4778230a3d042486444430e4be5e97dc95b263b95749ef79d38bdf3c47686e0508aa3a4"} build_url:https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/Q9oc4uwHSIiUFZ7RjcZB5A/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/fdd2b8d2633484603317fbfd6a781271bb13292ed9a237ab1e1ab0723f8f2e50244f73f1b19be73e152d60649ce415aa4d1318df6c168aeba26960347b68a629", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbd25719e48b66498c9678cce5016c43457580ac40ca909e82e8c0f1fdccf85b334bc1c63fd6fb0f86263e7e80fe9550c872e82c47d21a6872cb82f6cf54d73d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aa9add1fae250785c94ab48c63f2dec41e0dcc2e2ccf31365c78fe70f4778230a3d042486444430e4be5e97dc95b263b95749ef79d38bdf3c47686e0508aa3a4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 07:57:23.187518) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:57:23.187867) ========= 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=232498196343f89f466a4a9a000001c8-1479396995.463775-520358466 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 07:57:23.270531) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 07:57:23.270860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 07:57:23.271159) ========= ========= Total master_lag: 0.19 =========