builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1479156854.61 results: success (0) buildid: 20161114103043 builduid: b48e2ee8ce274da8a2d8c6eda7950086 revision: 71fd23fa0803a548b6e571aa25d0533a06cd0421 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:14.610837) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:14.611234) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:14.611548) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:14.625301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:14.625575) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-14 12:54:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.6M=0s 2016-11-14 12:54:15 (42.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111938 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:14.748951) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:14.749256) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018981 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:14.801071) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:54:14.801417) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 71fd23fa0803a548b6e571aa25d0533a06cd0421 --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 71fd23fa0803a548b6e571aa25d0533a06cd0421 --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=78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-14 12:54:15,328 truncating revision to first 12 chars 2016-11-14 12:54:15,329 Setting DEBUG logging. 2016-11-14 12:54:15,329 attempt 1/10 2016-11-14 12:54:15,329 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/71fd23fa0803?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-14 12:54:16,050 unpacking tar archive at: mozilla-central-71fd23fa0803/testing/mozharness/ program finished with exit code 0 elapsedTime=1.095399 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-14 12:54:15.911955) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:15.912271) ========= script_repo_revision: 71fd23fa0803a548b6e571aa25d0533a06cd0421 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:15.915665) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:15.915936) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-14 12:54:15.925726) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-11-14 12:54:15.926030) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:54:16 INFO - MultiFileLogger online at 20161114 12:54:16 in /builds/slave/test 12:54:16 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 12:54:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:16 INFO - {'append_to_log': False, 12:54:16 INFO - 'base_work_dir': '/builds/slave/test', 12:54:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 12:54:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:16 INFO - 'branch': 'Firefox-Non-PGO', 12:54:16 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:16 INFO - 'config_files': ('talos/linux_config.py',), 12:54:16 INFO - 'default_actions': ('clobber', 12:54:16 INFO - 'read-buildbot-config', 12:54:16 INFO - 'download-and-extract', 12:54:16 INFO - 'populate-webroot', 12:54:16 INFO - 'create-virtualenv', 12:54:16 INFO - 'install', 12:54:16 INFO - 'run-tests'), 12:54:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:16 INFO - 'download_minidump_stackwalk': True, 12:54:16 INFO - 'download_symbols': 'ondemand', 12:54:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:16 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:16 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:16 INFO - 'installer_path': 'installer.exe', 12:54:16 INFO - 'log_level': 'info', 12:54:16 INFO - 'log_name': 'talos', 12:54:16 INFO - 'log_to_console': True, 12:54:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:54:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:54:16 INFO - 'opt_config_files': (), 12:54:16 INFO - 'pip_index': False, 12:54:16 INFO - 'sps_profile': False, 12:54:16 INFO - 'sps_profile_interval': 0, 12:54:16 INFO - 'suite': 'dromaeojs', 12:54:16 INFO - 'system_bits': '32', 12:54:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:16 INFO - 'title': 'talos-linux64-ix-019', 12:54:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:16 INFO - 'use_talos_json': True, 12:54:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:16 INFO - 'work_dir': 'build'} 12:54:16 INFO - [mozharness: 2016-11-14 20:54:16.555273Z] Running clobber step. 12:54:16 INFO - Running pre-action listener: _resource_record_pre_action 12:54:16 INFO - Running main action method: clobber 12:54:16 INFO - rmtree: /builds/slave/test/build 12:54:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:17 INFO - Running post-action listener: _resource_record_post_action 12:54:17 INFO - [mozharness: 2016-11-14 20:54:17.555111Z] Finished clobber step (success) 12:54:17 INFO - [mozharness: 2016-11-14 20:54:17.555211Z] Running read-buildbot-config step. 12:54:17 INFO - Running pre-action listener: _resource_record_pre_action 12:54:17 INFO - Running main action method: read_buildbot_config 12:54:17 INFO - Using buildbot properties: 12:54:17 INFO - { 12:54:17 INFO - "project": "", 12:54:17 INFO - "product": "firefox", 12:54:17 INFO - "script_repo_revision": "production", 12:54:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 12:54:17 INFO - "repository": "", 12:54:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 12:54:17 INFO - "buildid": "20161114103043", 12:54:17 INFO - "pgo_build": "False", 12:54:17 INFO - "basedir": "/builds/slave/test", 12:54:17 INFO - "buildnumber": 711, 12:54:17 INFO - "slavename": "talos-linux64-ix-019", 12:54:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:54:17 INFO - "platform": "ubuntu64_hw", 12:54:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 12:54:17 INFO - "branch": "mozilla-central", 12:54:17 INFO - "repo_path": "mozilla-central", 12:54:17 INFO - "revision": "71fd23fa0803a548b6e571aa25d0533a06cd0421", 12:54:17 INFO - "stage_platform": "linux64", 12:54:17 INFO - "builduid": "b48e2ee8ce274da8a2d8c6eda7950086", 12:54:17 INFO - "slavebuilddir": "test" 12:54:17 INFO - } 12:54:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 12:54:17 INFO - Running post-action listener: _resource_record_post_action 12:54:17 INFO - [mozharness: 2016-11-14 20:54:17.557679Z] Finished read-buildbot-config step (success) 12:54:17 INFO - [mozharness: 2016-11-14 20:54:17.557767Z] Running download-and-extract step. 12:54:17 INFO - Running pre-action listener: _resource_record_pre_action 12:54:17 INFO - Running main action method: download_and_extract 12:54:17 INFO - mkdir: /builds/slave/test/build/tests 12:54:17 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')]} 12:54:17 INFO - trying https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:54:17 INFO - Downloading https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/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 12:54:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/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 12:54:18 INFO - Downloaded 1361 bytes. 12:54:18 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:54:18 INFO - Using the following test package requirements: 12:54:18 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:18 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:54:18 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:54:18 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:18 INFO - u'jsshell-linux-x86_64.zip'], 12:54:18 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:54:18 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:18 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:54:18 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:54:18 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:54:18 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:18 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:54:18 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:54:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:54:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:54:18 INFO - Fetch https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:54:18 INFO - Http code: 200 12:54:18 INFO - via: 1.1 bb8a7ff26b131d51953dc2d3e19a2751.cloudfront.net (CloudFront) 12:54:18 INFO - x-amz-cf-id: liF4d5HyU6aA4mF_SYxtlJ0pDiGD5twmUc6n-wmqvZdQL-SPkL_Hzg== 12:54:18 INFO - x-amz-version-id: w0Eaa27FAAzGCfhk3UyraoW50TZ1_fnj 12:54:18 INFO - Expected file size: 20414491 12:54:18 INFO - Obtained file size: 20414491 12:54:23 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 12:54:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:54:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:54:23 INFO - Fetch https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:54:23 INFO - Http code: 200 12:54:23 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 12:54:23 INFO - x-amz-cf-id: XmaVSwlhRQqwmpOIfqXOzLAePRBLHbvza-YBM5IrOYCAi1g6H93JLA== 12:54:23 INFO - x-amz-version-id: w0Eaa27FAAzGCfhk3UyraoW50TZ1_fnj 12:54:23 INFO - Expected file size: 20414491 12:54:23 INFO - Obtained file size: 20414491 12:54:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 12:54:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:54:28 INFO - Fetch https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:54:28 INFO - Http code: 200 12:54:28 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 12:54:28 INFO - x-amz-cf-id: 7iXXYoE3d7hzy0c9Wp1u4sGCserkfnUnXecO7_bmTV2GoF9e1twIUA== 12:54:28 INFO - x-amz-version-id: rrePkfFbVBbIep7r67vEd3In7GI0BodZ 12:54:29 INFO - Expected file size: 14409038 12:54:29 INFO - Obtained file size: 14409038 12:54:29 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')]} 12:54:29 INFO - trying https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:54:29 INFO - Downloading https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/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 12:54:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/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 12:54:30 INFO - Downloaded 55696127 bytes. 12:54:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:54:30 INFO - mkdir: /builds/slave/test/properties 12:54:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:30 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:30 INFO - Contents: 12:54:30 INFO - build_url:https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:54:31 INFO - Running post-action listener: _resource_record_post_action 12:54:31 INFO - Running post-action listener: set_extra_try_arguments 12:54:31 INFO - [mozharness: 2016-11-14 20:54:31.338301Z] Finished download-and-extract step (success) 12:54:31 INFO - [mozharness: 2016-11-14 20:54:31.338529Z] Running populate-webroot step. 12:54:31 INFO - Running pre-action listener: _resource_record_pre_action 12:54:31 INFO - Running main action method: populate_webroot 12:54:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:31 INFO - '--tppagecycles', 12:54:31 INFO - '7'], 12:54:31 INFO - 'tests': ['tsvgm']}}, 12:54:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:31 INFO - 'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:31 INFO - 'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['damp', 'tps']}, 12:54:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:31 INFO - 'tests': ['damp', 'tps']}, 12:54:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['dromaeo_dom']}, 12:54:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['basic_compositor_video']}, 12:54:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:54:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['a11yr', 12:54:31 INFO - 'ts_paint', 12:54:31 INFO - 'tpaint', 12:54:31 INFO - 'sessionrestore', 12:54:31 INFO - 'sessionrestore_no_auto_restore', 12:54:31 INFO - 'tabpaint']}, 12:54:31 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:31 INFO - 'ts_paint', 12:54:31 INFO - 'tpaint', 12:54:31 INFO - 'sessionrestore', 12:54:31 INFO - 'sessionrestore_no_auto_restore', 12:54:31 INFO - 'tabpaint']}, 12:54:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:31 INFO - 'ts_paint', 12:54:31 INFO - 'tpaint', 12:54:31 INFO - 'sessionrestore', 12:54:31 INFO - 'sessionrestore_no_auto_restore', 12:54:31 INFO - 'tabpaint']}, 12:54:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:31 INFO - 'ts_paint', 12:54:31 INFO - 'tpaint', 12:54:31 INFO - 'sessionrestore', 12:54:31 INFO - 'sessionrestore_no_auto_restore', 12:54:31 INFO - 'tabpaint']}, 12:54:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['a11yr', 12:54:31 INFO - 'ts_paint', 12:54:31 INFO - 'tpaint', 12:54:31 INFO - 'sessionrestore', 12:54:31 INFO - 'sessionrestore_no_auto_restore', 12:54:31 INFO - 'tabpaint']}, 12:54:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['a11yr', 12:54:31 INFO - 'ts_paint', 12:54:31 INFO - 'tpaint', 12:54:31 INFO - 'sessionrestore', 12:54:31 INFO - 'sessionrestore_no_auto_restore', 12:54:31 INFO - 'tabpaint']}, 12:54:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['tsvgx', 12:54:31 INFO - 'tsvgr_opacity', 12:54:31 INFO - 'tart', 12:54:31 INFO - 'tscrollx', 12:54:31 INFO - 'cart']}, 12:54:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:31 INFO - 'tsvgr_opacity', 12:54:31 INFO - 'tart', 12:54:31 INFO - 'tscrollx', 12:54:31 INFO - 'cart']}, 12:54:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:31 INFO - 'talos_options': ['--disable-e10s'], 12:54:31 INFO - 'tests': ['tp5o']}, 12:54:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:31 INFO - 'tests': ['tp5o']}, 12:54:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:31 INFO - 'talos_options': ['--disable-e10s', 12:54:31 INFO - '--xperf_path', 12:54:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:31 INFO - 'tests': ['tp5n']}, 12:54:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:54:31 INFO - 'talos_options': ['--xperf_path', 12:54:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:31 INFO - 'tests': ['tp5n']}}, 12:54:31 INFO - 'talos.zip': {'path': '', 12:54:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:31 INFO - Running post-action listener: _resource_record_post_action 12:54:31 INFO - [mozharness: 2016-11-14 20:54:31.358150Z] Finished populate-webroot step (success) 12:54:31 INFO - [mozharness: 2016-11-14 20:54:31.358238Z] Running create-virtualenv step. 12:54:31 INFO - Running pre-action listener: _resource_record_pre_action 12:54:31 INFO - Running main action method: create_virtualenv 12:54:31 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:31 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 12:54:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:31 INFO - Using real prefix '/usr' 12:54:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:31 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:33 INFO - Installing pip.................done. 12:54:33 INFO - Return code: 0 12:54:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:54:34 INFO - Reading from file tmpfile_stdout 12:54:34 INFO - Output received: 12:54:34 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) 12:54:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f807cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', '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 12:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:54:34 INFO - Using env: {'DISPLAY': ':0', 12:54:34 INFO - 'HOME': '/home/cltbld', 12:54:34 INFO - 'LANG': 'en_US.UTF-8', 12:54:34 INFO - 'LANGUAGE': 'en_US:en', 12:54:34 INFO - 'LOGNAME': 'cltbld', 12:54:34 INFO - 'MAIL': '/var/mail/cltbld', 12:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:34 INFO - 'MOZ_NO_REMOTE': '1', 12:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:34 INFO - 'NO_EM_RESTART': '1', 12:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:34 INFO - 'PWD': '/builds/slave/test', 12:54:34 INFO - 'SHELL': '/bin/bash', 12:54:34 INFO - 'SHLVL': '1', 12:54:34 INFO - 'TERM': 'linux', 12:54:34 INFO - 'TMOUT': '86400', 12:54:34 INFO - 'USER': 'cltbld', 12:54:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:34 INFO - '_': '/tools/buildbot/bin/python'} 12:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:34 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 12:54:34 INFO - Cleaning up... 12:54:34 INFO - Return code: 0 12:54:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f807cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', '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 12:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:54:34 INFO - Using env: {'DISPLAY': ':0', 12:54:34 INFO - 'HOME': '/home/cltbld', 12:54:34 INFO - 'LANG': 'en_US.UTF-8', 12:54:34 INFO - 'LANGUAGE': 'en_US:en', 12:54:34 INFO - 'LOGNAME': 'cltbld', 12:54:34 INFO - 'MAIL': '/var/mail/cltbld', 12:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:34 INFO - 'MOZ_NO_REMOTE': '1', 12:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:34 INFO - 'NO_EM_RESTART': '1', 12:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:34 INFO - 'PWD': '/builds/slave/test', 12:54:34 INFO - 'SHELL': '/bin/bash', 12:54:34 INFO - 'SHLVL': '1', 12:54:34 INFO - 'TERM': 'linux', 12:54:34 INFO - 'TMOUT': '86400', 12:54:34 INFO - 'USER': 'cltbld', 12:54:34 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:34 INFO - '_': '/tools/buildbot/bin/python'} 12:54:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:34 INFO - Downloading/unpacking psutil>=3.1.1 12:54:34 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 12:54:34 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 12:54:34 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 12:54:34 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 12:54:34 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 12:54:34 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 12:54:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:36 INFO - Installing collected packages: psutil 12:54:36 INFO - Running setup.py install for psutil 12:54:36 INFO - building 'psutil._psutil_linux' extension 12:54:36 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 12:54:36 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 12:54:36 INFO - building 'psutil._psutil_posix' extension 12:54:36 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 12:54:37 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 12:54:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:37 INFO - Successfully installed psutil 12:54:37 INFO - Cleaning up... 12:54:37 INFO - Return code: 0 12:54:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:37 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 0x7f807cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', '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 12:54:37 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 12:54:37 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 12:54:37 INFO - Using env: {'DISPLAY': ':0', 12:54:37 INFO - 'HOME': '/home/cltbld', 12:54:37 INFO - 'LANG': 'en_US.UTF-8', 12:54:37 INFO - 'LANGUAGE': 'en_US:en', 12:54:37 INFO - 'LOGNAME': 'cltbld', 12:54:37 INFO - 'MAIL': '/var/mail/cltbld', 12:54:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:37 INFO - 'MOZ_NO_REMOTE': '1', 12:54:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:37 INFO - 'NO_EM_RESTART': '1', 12:54:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:37 INFO - 'PWD': '/builds/slave/test', 12:54:37 INFO - 'SHELL': '/bin/bash', 12:54:37 INFO - 'SHLVL': '1', 12:54:37 INFO - 'TERM': 'linux', 12:54:37 INFO - 'TMOUT': '86400', 12:54:37 INFO - 'USER': 'cltbld', 12:54:37 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:54:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:37 INFO - '_': '/tools/buildbot/bin/python'} 12:54:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:39 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:39 INFO - Installing collected packages: mozsystemmonitor 12:54:39 INFO - Running setup.py install for mozsystemmonitor 12:54:39 INFO - Successfully installed mozsystemmonitor 12:54:39 INFO - Cleaning up... 12:54:39 INFO - Return code: 0 12:54:39 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:39 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 0x7f807cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', '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 12:54:39 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 12:54:39 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 12:54:39 INFO - Using env: {'DISPLAY': ':0', 12:54:39 INFO - 'HOME': '/home/cltbld', 12:54:39 INFO - 'LANG': 'en_US.UTF-8', 12:54:39 INFO - 'LANGUAGE': 'en_US:en', 12:54:39 INFO - 'LOGNAME': 'cltbld', 12:54:39 INFO - 'MAIL': '/var/mail/cltbld', 12:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:39 INFO - 'MOZ_NO_REMOTE': '1', 12:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:39 INFO - 'NO_EM_RESTART': '1', 12:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:39 INFO - 'PWD': '/builds/slave/test', 12:54:39 INFO - 'SHELL': '/bin/bash', 12:54:39 INFO - 'SHLVL': '1', 12:54:39 INFO - 'TERM': 'linux', 12:54:39 INFO - 'TMOUT': '86400', 12:54:39 INFO - 'USER': 'cltbld', 12:54:39 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:39 INFO - '_': '/tools/buildbot/bin/python'} 12:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:39 INFO - Downloading/unpacking jsonschema==2.5.1 12:54:39 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 12:54:39 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 12:54:39 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 12:54:39 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 12:54:39 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 12:54:39 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 12:54:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:41 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:41 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:41 INFO - warning: no files found matching '*.txt' 12:54:41 INFO - no previously-included directories found matching 'build' 12:54:41 INFO - no previously-included directories found matching 'dist' 12:54:41 INFO - no previously-included directories found matching '.git*' 12:54:41 INFO - Installing collected packages: jsonschema, functools32 12:54:42 INFO - Running setup.py install for functools32 12:54:42 INFO - warning: no files found matching '*.txt' 12:54:42 INFO - no previously-included directories found matching 'build' 12:54:42 INFO - no previously-included directories found matching 'dist' 12:54:42 INFO - no previously-included directories found matching '.git*' 12:54:42 INFO - Successfully installed jsonschema functools32 12:54:42 INFO - Cleaning up... 12:54:42 INFO - Return code: 0 12:54:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:42 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 0x7f807cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', '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 12:54:42 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 12:54:42 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 12:54:42 INFO - Using env: {'DISPLAY': ':0', 12:54:42 INFO - 'HOME': '/home/cltbld', 12:54:42 INFO - 'LANG': 'en_US.UTF-8', 12:54:42 INFO - 'LANGUAGE': 'en_US:en', 12:54:42 INFO - 'LOGNAME': 'cltbld', 12:54:42 INFO - 'MAIL': '/var/mail/cltbld', 12:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:42 INFO - 'MOZ_NO_REMOTE': '1', 12:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:42 INFO - 'NO_EM_RESTART': '1', 12:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:42 INFO - 'PWD': '/builds/slave/test', 12:54:42 INFO - 'SHELL': '/bin/bash', 12:54:42 INFO - 'SHLVL': '1', 12:54:42 INFO - 'TERM': 'linux', 12:54:42 INFO - 'TMOUT': '86400', 12:54:42 INFO - 'USER': 'cltbld', 12:54:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:42 INFO - '_': '/tools/buildbot/bin/python'} 12:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:54:42 INFO - Cleaning up... 12:54:42 INFO - Return code: 0 12:54:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:42 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 0x7f807cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', '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 12:54:42 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 12:54:42 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 12:54:42 INFO - Using env: {'DISPLAY': ':0', 12:54:42 INFO - 'HOME': '/home/cltbld', 12:54:42 INFO - 'LANG': 'en_US.UTF-8', 12:54:42 INFO - 'LANGUAGE': 'en_US:en', 12:54:42 INFO - 'LOGNAME': 'cltbld', 12:54:42 INFO - 'MAIL': '/var/mail/cltbld', 12:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:42 INFO - 'MOZ_NO_REMOTE': '1', 12:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:42 INFO - 'NO_EM_RESTART': '1', 12:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:42 INFO - 'PWD': '/builds/slave/test', 12:54:42 INFO - 'SHELL': '/bin/bash', 12:54:42 INFO - 'SHLVL': '1', 12:54:42 INFO - 'TERM': 'linux', 12:54:42 INFO - 'TMOUT': '86400', 12:54:42 INFO - 'USER': 'cltbld', 12:54:42 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:42 INFO - '_': '/tools/buildbot/bin/python'} 12:54:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:42 INFO - Downloading/unpacking blobuploader==1.2.4 12:54:42 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 12:54:42 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 12:54:42 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 12:54:42 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 12:54:42 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 12:54:42 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 12:54:44 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:45 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 12:54:45 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 12:54:45 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 12:54:45 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 12:54:45 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 12:54:45 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 12:54:45 INFO - Downloading docopt-0.6.1.tar.gz 12:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:45 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:45 INFO - Running setup.py install for blobuploader 12:54:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:45 INFO - Running setup.py install for requests 12:54:45 INFO - Running setup.py install for docopt 12:54:45 INFO - Successfully installed blobuploader requests docopt 12:54:45 INFO - Cleaning up... 12:54:45 INFO - Return code: 0 12:54:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:45 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 0x7f807cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', '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 12:54:45 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 12:54:45 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 12:54:45 INFO - Using env: {'DISPLAY': ':0', 12:54:45 INFO - 'HOME': '/home/cltbld', 12:54:45 INFO - 'LANG': 'en_US.UTF-8', 12:54:45 INFO - 'LANGUAGE': 'en_US:en', 12:54:45 INFO - 'LOGNAME': 'cltbld', 12:54:45 INFO - 'MAIL': '/var/mail/cltbld', 12:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:45 INFO - 'MOZ_NO_REMOTE': '1', 12:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:45 INFO - 'NO_EM_RESTART': '1', 12:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:45 INFO - 'PWD': '/builds/slave/test', 12:54:45 INFO - 'SHELL': '/bin/bash', 12:54:45 INFO - 'SHLVL': '1', 12:54:45 INFO - 'TERM': 'linux', 12:54:45 INFO - 'TMOUT': '86400', 12:54:45 INFO - 'USER': 'cltbld', 12:54:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:45 INFO - '_': '/tools/buildbot/bin/python'} 12:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:46 INFO - Running setup.py (path:/tmp/pip-krX93f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:46 INFO - Running setup.py (path:/tmp/pip-jaDqLN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:46 INFO - Running setup.py (path:/tmp/pip-Jvx4Re-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:46 INFO - Running setup.py (path:/tmp/pip-quI3E8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:46 INFO - Running setup.py (path:/tmp/pip-UkvfZw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:46 INFO - Running setup.py (path:/tmp/pip-LmK9Vr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:46 INFO - Running setup.py (path:/tmp/pip-XpIUCH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:46 INFO - Running setup.py (path:/tmp/pip-TyUS8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:46 INFO - Running setup.py (path:/tmp/pip-XnYK7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:46 INFO - Running setup.py (path:/tmp/pip-udxbtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:46 INFO - Running setup.py (path:/tmp/pip-MWWnLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:46 INFO - Running setup.py (path:/tmp/pip-k8TB5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:47 INFO - Running setup.py (path:/tmp/pip-sUQyLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:47 INFO - Running setup.py (path:/tmp/pip-uqhDqr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:47 INFO - Running setup.py (path:/tmp/pip-bJYeyk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:47 INFO - Running setup.py (path:/tmp/pip-RkD7h8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:47 INFO - Running setup.py (path:/tmp/pip-CXs3VN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:47 INFO - Running setup.py install for manifestparser 12:54:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Running setup.py install for mozcrash 12:54:47 INFO - Running setup.py install for mozdebug 12:54:47 INFO - Running setup.py install for mozdevice 12:54:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:47 INFO - Running setup.py install for mozfile 12:54:47 INFO - Running setup.py install for mozhttpd 12:54:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozinfo 12:54:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozInstall 12:54:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozleak 12:54:48 INFO - Running setup.py install for mozlog 12:54:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for moznetwork 12:54:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozprocess 12:54:48 INFO - Running setup.py install for mozprofile 12:54:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozrunner 12:54:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:54:48 INFO - Running setup.py install for mozscreenshot 12:54:48 INFO - Running setup.py install for moztest 12:54:49 INFO - Running setup.py install for mozversion 12:54:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:54:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:54:49 INFO - Cleaning up... 12:54:49 INFO - Return code: 0 12:54:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54: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')]} 12:54:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54: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')]} 12:54:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:49 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 0x7f807cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', '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 12:54:49 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 12:54:49 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 12:54:49 INFO - Using env: {'DISPLAY': ':0', 12:54:49 INFO - 'HOME': '/home/cltbld', 12:54:49 INFO - 'LANG': 'en_US.UTF-8', 12:54:49 INFO - 'LANGUAGE': 'en_US:en', 12:54:49 INFO - 'LOGNAME': 'cltbld', 12:54:49 INFO - 'MAIL': '/var/mail/cltbld', 12:54:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:49 INFO - 'MOZ_NO_REMOTE': '1', 12:54:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:49 INFO - 'NO_EM_RESTART': '1', 12:54:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:49 INFO - 'PWD': '/builds/slave/test', 12:54:49 INFO - 'SHELL': '/bin/bash', 12:54:49 INFO - 'SHLVL': '1', 12:54:49 INFO - 'TERM': 'linux', 12:54:49 INFO - 'TMOUT': '86400', 12:54:49 INFO - 'USER': 'cltbld', 12:54:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:54:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:49 INFO - '_': '/tools/buildbot/bin/python'} 12:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:49 INFO - Running setup.py (path:/tmp/pip-KtsgtV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:49 INFO - Running setup.py (path:/tmp/pip-d46VJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:49 INFO - Running setup.py (path:/tmp/pip-PuwoGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:49 INFO - Running setup.py (path:/tmp/pip-F8mJXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:49 INFO - Running setup.py (path:/tmp/pip-1hAQIe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:49 INFO - Running setup.py (path:/tmp/pip-1PBvjc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:49 INFO - Running setup.py (path:/tmp/pip-m2E2df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:49 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)) 12:54:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:49 INFO - Running setup.py (path:/tmp/pip-BPo_JU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:50 INFO - Running setup.py (path:/tmp/pip-_uEJ_r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:50 INFO - Running setup.py (path:/tmp/pip-2zNUDD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:50 INFO - Running setup.py (path:/tmp/pip-gOqx4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:50 INFO - Running setup.py (path:/tmp/pip-PJbmYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:50 INFO - Running setup.py (path:/tmp/pip-nWtK8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:50 INFO - Running setup.py (path:/tmp/pip-BqknZh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:50 INFO - Running setup.py (path:/tmp/pip-J4VxGx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:50 INFO - Running setup.py (path:/tmp/pip-AdM9js-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:50 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)) 12:54:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:50 INFO - Running setup.py (path:/tmp/pip-kfoUCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:50 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)) 12:54:50 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)) 12:54:50 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)) 12:54:50 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)) 12:54:50 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)) 12:54:50 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)) 12:54:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:50 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 12:54:50 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 12:54:50 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 12:54:50 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 12:54:50 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 12:54:50 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 12:54:52 INFO - Downloading blessings-1.6.tar.gz 12:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:54:52 INFO - Installing collected packages: blessings 12:54:52 INFO - Running setup.py install for blessings 12:54:52 INFO - Successfully installed blessings 12:54:52 INFO - Cleaning up... 12:54:52 INFO - Return code: 0 12:54:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:54:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:53 INFO - Reading from file tmpfile_stdout 12:54:53 INFO - Current package versions: 12:54:53 INFO - argparse == 1.2.1 12:54:53 INFO - blessings == 1.6 12:54:53 INFO - blobuploader == 1.2.4 12:54:53 INFO - docopt == 0.6.1 12:54:53 INFO - functools32 == 3.2.3-2 12:54:53 INFO - jsonschema == 2.5.1 12:54:53 INFO - manifestparser == 1.1 12:54:53 INFO - mozInstall == 1.12 12:54:53 INFO - mozcrash == 1.0 12:54:53 INFO - mozdebug == 0.1 12:54:53 INFO - mozdevice == 0.48 12:54:53 INFO - mozfile == 1.2 12:54:53 INFO - mozhttpd == 0.7 12:54:53 INFO - mozinfo == 0.9 12:54:53 INFO - mozleak == 0.1 12:54:53 INFO - mozlog == 3.4 12:54:53 INFO - moznetwork == 0.27 12:54:53 INFO - mozprocess == 0.23 12:54:53 INFO - mozprofile == 0.28 12:54:53 INFO - mozrunner == 6.13 12:54:53 INFO - mozscreenshot == 0.1 12:54:53 INFO - mozsystemmonitor == 0.3 12:54:53 INFO - moztest == 0.7 12:54:53 INFO - mozversion == 1.4 12:54:53 INFO - psutil == 3.1.1 12:54:53 INFO - requests == 1.2.3 12:54:53 INFO - wsgiref == 0.1.2 12:54:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:53 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')]} 12:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:53 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')]} 12:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:53 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 0x7f807cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', '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 12:54:53 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 12:54:53 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 12:54:53 INFO - Using env: {'DISPLAY': ':0', 12:54:53 INFO - 'HOME': '/home/cltbld', 12:54:53 INFO - 'LANG': 'en_US.UTF-8', 12:54:53 INFO - 'LANGUAGE': 'en_US:en', 12:54:53 INFO - 'LOGNAME': 'cltbld', 12:54:53 INFO - 'MAIL': '/var/mail/cltbld', 12:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:53 INFO - 'MOZ_NO_REMOTE': '1', 12:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:53 INFO - 'NO_EM_RESTART': '1', 12:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:53 INFO - 'PWD': '/builds/slave/test', 12:54:53 INFO - 'SHELL': '/bin/bash', 12:54:53 INFO - 'SHLVL': '1', 12:54:53 INFO - 'TERM': 'linux', 12:54:53 INFO - 'TMOUT': '86400', 12:54:53 INFO - 'USER': 'cltbld', 12:54:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:53 INFO - '_': '/tools/buildbot/bin/python'} 12:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:53 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)) 12:54:53 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)) 12:54:53 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)) 12:54:53 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)) 12:54:53 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)) 12:54:53 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)) 12:54:53 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)) 12:54:53 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)) 12:54:53 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)) 12:54:53 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)) 12:54:53 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)) 12:54:53 INFO - Cleaning up... 12:54:53 INFO - Return code: 0 12:54:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54:53 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')]} 12:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:53 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')]} 12:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:53 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 0x7f807cb45f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22098a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', '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 12:54:53 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 12:54:53 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 12:54:53 INFO - Using env: {'DISPLAY': ':0', 12:54:53 INFO - 'HOME': '/home/cltbld', 12:54:53 INFO - 'LANG': 'en_US.UTF-8', 12:54:53 INFO - 'LANGUAGE': 'en_US:en', 12:54:53 INFO - 'LOGNAME': 'cltbld', 12:54:53 INFO - 'MAIL': '/var/mail/cltbld', 12:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:53 INFO - 'MOZ_NO_REMOTE': '1', 12:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:53 INFO - 'NO_EM_RESTART': '1', 12:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:53 INFO - 'PWD': '/builds/slave/test', 12:54:53 INFO - 'SHELL': '/bin/bash', 12:54:53 INFO - 'SHLVL': '1', 12:54:53 INFO - 'TERM': 'linux', 12:54:53 INFO - 'TMOUT': '86400', 12:54:53 INFO - 'USER': 'cltbld', 12:54:53 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:53 INFO - '_': '/tools/buildbot/bin/python'} 12:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:54:53 INFO - Cleaning up... 12:54:53 INFO - Return code: 0 12:54:53 INFO - Running post-action listener: _resource_record_post_action 12:54:53 INFO - Running post-action listener: _start_resource_monitoring 12:54:53 INFO - Starting resource monitoring. 12:54:53 INFO - [mozharness: 2016-11-14 20:54:53.565148Z] Finished create-virtualenv step (success) 12:54:53 INFO - [mozharness: 2016-11-14 20:54:53.565657Z] Running install step. 12:54:53 INFO - Running pre-action listener: _resource_record_pre_action 12:54:53 INFO - Running main action method: install 12:54:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:53 INFO - Reading from file tmpfile_stdout 12:54:53 INFO - Detecting whether we're running mozinstall >=1.0... 12:54:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:53 INFO - Reading from file tmpfile_stdout 12:54:53 INFO - Output received: 12:54:53 INFO - Usage: mozinstall [options] installer 12:54:53 INFO - Options: 12:54:53 INFO - -h, --help show this help message and exit 12:54:53 INFO - -d DEST, --destination=DEST 12:54:53 INFO - Directory to install application into. [default: 12:54:53 INFO - "/builds/slave/test"] 12:54:53 INFO - --app=APP Application being installed. [default: firefox] 12:54:53 INFO - mkdir: /builds/slave/test/build/application 12:54:53 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'] 12:54:53 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 12:55:09 INFO - Reading from file tmpfile_stdout 12:55:09 INFO - Output received: 12:55:09 INFO - /builds/slave/test/build/application/firefox/firefox 12:55:09 INFO - Running post-action listener: _resource_record_post_action 12:55:09 INFO - [mozharness: 2016-11-14 20:55:09.934346Z] Finished install step (success) 12:55:09 INFO - [mozharness: 2016-11-14 20:55:09.934590Z] Running run-tests step. 12:55:09 INFO - Running pre-action listener: _resource_record_pre_action 12:55:09 INFO - Running main action method: run_tests 12:55:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:55:09 INFO - Python 2.7.3 12:55:09 INFO - Return code: 0 12:55:09 INFO - grabbing minidump binary from tooltool 12:55: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')]} 12:55:09 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 0x22d3f60>, '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 0x22d4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22d51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:55:09 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 12:55:09 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 12:55:09 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 12:55:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:55:10 INFO - Return code: 0 12:55:10 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:55:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:55:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:55:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:55:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:55:10 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/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 12:55:10 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/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 12:55:10 INFO - Using env: {'DISPLAY': ':0', 12:55:10 INFO - 'HOME': '/home/cltbld', 12:55:10 INFO - 'LANG': 'en_US.UTF-8', 12:55:10 INFO - 'LANGUAGE': 'en_US:en', 12:55:10 INFO - 'LOGNAME': 'cltbld', 12:55:10 INFO - 'MAIL': '/var/mail/cltbld', 12:55:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:55:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:55:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:55:10 INFO - 'MOZ_NO_REMOTE': '1', 12:55:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:55:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:55:10 INFO - 'NO_EM_RESTART': '1', 12:55:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:55:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:55:10 INFO - 'PWD': '/builds/slave/test', 12:55:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:55:10 INFO - 'SHELL': '/bin/bash', 12:55:10 INFO - 'SHLVL': '1', 12:55:10 INFO - 'TERM': 'linux', 12:55:10 INFO - 'TMOUT': '86400', 12:55:10 INFO - 'USER': 'cltbld', 12:55:10 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091', 12:55:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:55:10 INFO - '_': '/tools/buildbot/bin/python'} 12:55:10 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/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 12:55:10 INFO - mozversion application_buildid: 20161114103043 12:55:10 INFO - mozversion application_changeset: 71fd23fa0803a548b6e571aa25d0533a06cd0421 12:55:10 INFO - mozversion application_display_name: Nightly 12:55:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:55:10 INFO - mozversion application_name: Firefox 12:55:10 INFO - mozversion application_remotingname: firefox 12:55:10 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:55:10 INFO - mozversion application_vendor: Mozilla 12:55:10 INFO - mozversion application_version: 53.0a1 12:55:10 INFO - mozversion platform_buildid: 20161114103043 12:55:10 INFO - mozversion platform_changeset: 71fd23fa0803a548b6e571aa25d0533a06cd0421 12:55:10 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:55:10 INFO - mozversion platform_version: 53.0a1 12:55:10 INFO - using testdate: 1479156910 12:55:10 INFO - actual date: 1479156910 12:55:10 INFO - starting webserver on 'localhost:34829' 12:55:10 INFO - SUITE-START | Running 2 tests 12:55:10 INFO - TEST-START | dromaeo_css 12:55:10 INFO - operating with platform_type : linux_ 12:55:10 INFO - Initialising browser for dromaeo_css test... 12:55:10 INFO - TEST-INFO | started process 24033 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32ds3Z/profile http://localhost:34829/getInfo.html) 12:55:14 INFO - PROCESS | 24033 | __metrics Screen width/height:1600/1200 12:55:14 INFO - PROCESS | 24033 | colorDepth:24 12:55:14 INFO - PROCESS | 24033 | Browser inner width/height: 1024/697 12:55:14 INFO - PROCESS | 24033 | __metrics 12:55:15 INFO - PROCESS | 24033 | 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" 12:55:15 INFO - PROCESS | 24033 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:55:16 INFO - PROCESS | 24033 | console.error: PushService: 12:55:16 INFO - PROCESS | 24033 | stateChangeProcessEnqueue: Error transitioning state 12:55:16 INFO - PROCESS | 24033 | UnknownError 12:55:16 INFO - TEST-INFO | 24033: exit 0 12:55:16 INFO - Browser initialized. 12:55:16 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:16 INFO - TEST-INFO | started process 24114 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp32ds3Z/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:29 INFO - PROCESS | 24114 | RSS: Main: 174333952 12:55:29 INFO - PROCESS | 24114 | 12:56:21 INFO - PROCESS | 24114 | 1479156981146 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] 12:58:33 INFO - PROCESS | 24114 | Cycle 1(1): loaded http://localhost:34829/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34829/tests/dromaeo/cssquery-ext.html) 12:58:35 INFO - PROCESS | 24114 | RSS: Main: 310833152 12:58:35 INFO - PROCESS | 24114 | 13:01:38 INFO - PROCESS | 24114 | Cycle 1(1): loaded http://localhost:34829/tests/dromaeo/cssquery-ext.html (next: http://localhost:34829/tests/dromaeo/cssquery-jquery.html) 13:01:38 INFO - PROCESS | 24114 | RSS: Main: 280625152 13:01:38 INFO - PROCESS | 24114 | 13:04:40 INFO - PROCESS | 24114 | Cycle 1(1): loaded http://localhost:34829/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34829/tests/dromaeo/cssquery-mootools.html) 13:04:41 INFO - PROCESS | 24114 | RSS: Main: 223776768 13:04:41 INFO - PROCESS | 24114 | 13:07:43 INFO - PROCESS | 24114 | Cycle 1(1): loaded http://localhost:34829/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34829/tests/dromaeo/cssquery-prototype.html) 13:07:44 INFO - PROCESS | 24114 | RSS: Main: 224542720 13:07:44 INFO - PROCESS | 24114 | 13:10:47 INFO - PROCESS | 24114 | Cycle 1(1): loaded http://localhost:34829/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34829/tests/dromaeo/cssquery-yui.html) 13:10:48 INFO - PROCESS | 24114 | RSS: Main: 220844032 13:10:48 INFO - PROCESS | 24114 | 13:13:51 INFO - PROCESS | 24114 | Cycle 1(1): loaded http://localhost:34829/tests/dromaeo/cssquery-yui.html (next: http://localhost:34829/tests/dromaeo/cssquery-dojo.html) 13:13:51 INFO - PROCESS | 24114 | RSS: Main: 316162048 13:13:51 INFO - PROCESS | 24114 | 13:13:51 INFO - PROCESS | 24114 | __start_tp_report 13:13:51 INFO - PROCESS | 24114 | _x_x_mozilla_page_load 13:13:51 INFO - PROCESS | 24114 | _x_x_mozilla_page_load_details 13:13:51 INFO - PROCESS | 24114 | |i|pagename|runs| 13:13:51 INFO - PROCESS | 24114 | |0;dojo.html;2582.5738753105734;2600.6099085137216;2630.132056421381;2640.74912883276;2647.9073232436867;4539.40987671603;4586.472555656101;4634.976825115874;4672.579467847893;4700.576948074672;4619.584237418631;4625.791839367228;4658.53414658534;4690.742009189493;4742.430908291001;4200.873973780792;4211.7051806373565;4246.596573325529;4264.978675106636;4275.7434553926705;3894.610538946111;4307.0739790944945;4376.912461750763;4408.470983481987;4459.0858873930765;4189.392538081992;4316.848910288156;4321.719088259285;4382.561743825608;4409.05205380843;4233.661307095425;4244.257254980366;4258.446401967755;4289.356596510548;4295.183915056129;4275.743455392686;4276.465441819772;4279.91440171198;4317.4819021717285;4319.50325712544;4621.098885717286;4639.652026098022;4648.186567350734;4649.325847752091;4650.0932318197965;4673.205555055649;4712.246040633517;4724.291356296583;4789.185838407444;4980.153373926441;4783.210770222909;4793.904121917577;4797.616190704735;4801.423829140491;4808;4616.53834616539;4658.161530924398;4673.042026384583;4718.504557021532;4725.8582242532775;5111.131107711698;5120.359955005624;5120.5391514763105;5123.308353372322;5168.0697474454955;4897.902041959141;4901.191303434894;4904.975475122602;4911.778969946361;4916.655834091579;4776.641751868624;4826.855194344175;4830.782614782343;4872.317875497433;4990.401151861727;4929.063477939252;4938.530839570235;4987.875303117378;5035.723035233097;5058.4435712071645;4990.076835785391;4991.625628077909;4997.0505603935135;5000.174971129795;5046.470120637354;4078.857239996586;4264.424302719155;4274.572542745701;4279.058607106432;4326.480822301344;3595.856165753393;3631.3100510903373;3639.9636003639625;3662.6703596676425;3689.0408493791806;4272.658187345005;4278.0374415756205;4278.4010238566625;4310.418093557392;4311.805968731414;4986.7257300848805;5004.274380214849;5006.524380183877;5008.924866127011;5057.848264552069;4167;4172.958270417257;4220.261454245495;4223;4255.319148936155;4392.143532011227;4459.152760975404;4469.262571675637;4476.060027394218;4476.350929115325;4590.747508886977;4594.655400844883;4597.862064138081;4599.126166028444;4641.048585040126;4933.679310844784;4933.97533012347;4938.678985865908;4944.678595891256;4989.675671081368;4515.796789144562;4581.770911454348;4609.769511524478;4633.513481084437;4658.836940707059;4914.852554423373;4916.631252656137;4918.1884988977845;4921.901561968669;4961.5534601886;4942.629302802232;4986.8753281168265;4993.27597498368;4993.750312484434;5030.346055012825;4745.240761478147;4811.9518804811505;4829.420469543677;4853.951460485491;4894.681845680019;4843.612510999041;4870.269459581091;4878.609711223023;4903.975480122719;4921.729304888122;4795.880102997453;4800.759962001816;4807.855764327076;4810.807567697253;4841.903161936812;4727.078219747116;4795.592374648194;4801.231802911518;4889.437714662717;4932.062908047459;4716.952830471651;4740.786664600032;4766.618670506282;4766.809327626856;4786.018866132504 13:13:51 INFO - PROCESS | 24114 | |1;ext.html;551.5752870289876;561.4217356123195;566.5750686984761;569.9715014249288;591.1694069831888;28447.14658560244;31505.11670691041;39600.603993960016;40652.39021414681;40669;39599.208015839664;39987.20025599486;39988.60011399885;40054.59945400545;40055;7480;7656.846863062736;7665.118511371208;7665.655045522964;7674.117476490219;7542.924570754277;7629.122650895162;7638.3889288857035;7639.885401718979;7641.121271053845;7621.657025433841;7656.464047516676;7664.808379790494;7680.654370553339;7682.462227644067;7631.313181813635;7657.731979380751;7670.846583068335;7672.117706463717;7682.231776822273;7553.924460755377;7605.315521603082;7611.314981651678;7613.771586852348;7620.657070431844;37483;37887.62112378868;37911;37951.24097518062;37955;2908.3601607646283;3129.186411532995;3466.757326987112;3492.8777492787885;3537.9292414151832;28265.293367665767;28277.717222827716;28496.572551411744;29772.8511357444;29845.253868653457;3409.8295085245886;3475.6176820549717;3525.6474352564796;3537.5931767846514;3566.465030245458;374162;382016;385670;386812;387234;50999.235011474855;51717;52015.21977170346;52125.478745212065;52190.73904630452;28880.277993050342;29629;29662.851685741432;29664.703352966626;54117;14329;14480.203588802717;14498.927505362406;14504.709905802036;14505;10914.181436392302;10988.505517251582;11008.449577521093;11012.50443730018;11013.174011949135;17428.12859357027;17538.123093845257;17571;17583.29666813313;17753.556161096076;6653.933460665428;6712.39588437043;6739.224989126215;6809;6945.51381403307;762.7406681728239;822.8148666550098;834.9582520873932;882.8719835623928;987.612404571578;26049.73950260511;26519.309400273705;26696.59955100675;27229.591556126674;27296.181114566596;755.6335177438938;928.3176865004217;931.3992474853817;934.1592566690033;1006.3961623026125;14080.788788168185;14277.500287490097;14285.785668244132;14506.637334066732;14913.701725965637;341643;343629;343867;344019;346766;49511.752441237564;49929;49941.25088123681;49968.750156248985;50017.24974125391;1021.7649940513575;1086.41333679812;1089.54239219528;1147.2198904744853;1188.3285943441927;24676;28909.277268068465;29236.561451577818;29438.705612943595;29531.40937181287;41158.1768364637;41696;42043.7897810509;42166.36750448807;42242.78878605587;233935;234161;234284;234373;234862;23962.16132435426;25067.498650026533;25134.497310054063;25244;26701;40976.38535422031;41218;41447;42208.36687449629;42596.36105458483;35284.117897052776;35403.82298088493;35465.468017979234;35753.46369804403;35815.82092089523;35131.824340878135;35323.29353412866;35369.292614148086;35604.287914242086;35628.82185589159;34312;34784.82607586946;35245.29509409746;35393.10675825606;35437;29715;32037.839810800797;32199.51700724538;32295.031149065566;32393.35213295768;24850.90354692583;24919;24963.75036249687;24981.87509062443;25007.374815629755 13:13:51 INFO - PROCESS | 24114 | |2;jquery.html;330.5917192267548;357.2889949001488;357.3424898187335;360.45391232283094;377.4677704436743;12508.749825003506;13510;15216.467423640175;15765.211739413013;15951.920240398811;16113.83886161138;16178.83821161788;16344.509664710047;16843.663126737458;16974.745378819327;4120;4778.498257682937;4992.201247800353;5003.899922001558;5004.474530174334;4938.135826230413;5010.749462526877;5022.9246561301425;5028.7988480460735;5030.37120359955;4924.652713650364;4992.925106123411;4996.575291100261;5001.149804533238;5005.399352077756;4882.121218180726;4978.800847966095;4991.301217829507;4994.225894986283;4999.075171093359;4454.933176002362;4457.777111144463;4462.821487140543;4463.910721785579;4468.4414448193975;19026;19104.808951910443;19619.215231390728;19672;19789.406317810488;1633.1915701727603;1737.2616637928957;1763.9647207055916;1766.8939863608095;1868.4955062133283;8791.428557143765;8849.646014159425;8877.201051905295;8941;9150.816983660356;1706.4795237452572;1757.1653464604337;1761.2954818072744;1794.5244510204675;1823.7955763045436;66743.66628166828;67372.6631366845;67617;68295;68756.31243687599;9717.805643887083;9767.951160244153;9945.055219754111;10031.899681003242;10037.297389182688;13494.460221591222;13497.257650829299;13504.86495135036;13512.324383780771;13515;6762.154730658668;6845.863082738318;6927.753004459246;7014.263502332284;7122.893156602655;6578.703958321887;6652.702722969071;6661.134052573135;6677.799666010027;6812.318768123148;4188.68584856137;4212.220739163265;4220.704550681423;4240.830366785294;4329.631981281564;1756.9385071522436;1796.4071856287394;1837.926482940694;1868.271374164077;1891.1206289075371;757.5114051436792;782.6165179062332;828.4656396624143;836.6653338664461;908.1554154636119;15341.693166136838;15601.297941592655;16103.355865765472;16389.754153687703;17283.222254998556;830.8172202115525;838.6603425612515;852.411835833273;856.1866227084295;878.6221924572495;9017.549122543847;9269.582868770922;9473.573689184002;9500.952495237618;9513.714588562354;267008;270498;347178;349218;353981;77636.61181694169;81220.59389703014;81940;82140.58929705313;82987;886.0873300500494;906.2025417632441;930.4882314726873;934.8597710343366;935.8502639577634;15147.697046059238;15148.848511514743;15864.286107124975;15935.36258549645;16155.192240388169;36422.27155456929;36581.45127823031;37377.43933841049;37526.249475010896;37980.810095949346;51228;51774.48225517697;52325.47674523358;52571.47428525819;53768.731156343965;7044.225135235222;7415.740449084256;7499.5875226863045;7529.774106776806;7579;6927.480438967198;10389.584416623251;11134.888651113386;11584.698360967084;11995.241094548128;6574.572652777554;9382.343235973416;9945.602175912882;10390.22073344487;10941.781164376509;10032.347897386939;10177.134943529883;10452.372857628567;10652.520636571218;10697.946510267398;10274.640387586398;10318.845217321596;10487.895121048998;10781.62264320745;10992.230543861853;7206.89189662145;7353.522021068614;7506.28690274423;7514.47398682087;7719.884201737091;9746.805063898824;9885.456299903575;9886.950565247127;9895;9906.157976571783 13:13:51 INFO - PROCESS | 24114 | |3;mootools.html;1218.031664826463;1311.5048396024592;1330.0822432521559;1388.9236092014942;1628.2672797241237;6057.39426057394;6630.9336906630915;6887.173539175294;6888.896666550006;7059.964700176505;6874.140732408449;6937.271586483423;6940.618265995368;6952.2352541220425;6954.408875245597;2045.969310460348;2086.645270304052;2086.9895650521803;2089.0390420406557;2089.550746589483;2010.4873257319437;2013.526821197025;2031.177373163871;2092.4559614500185;2095.832333413331;2040.3776848061336;2041.7243672104298;2056.0439395681005;2060.3715866660664;2060.9484762880898;2028.381343690174;2047.7337946066916;2052.322733497942;2053.712480252766;2053.9281125160546;1990.2934458267252;2016.3346095788502;2036.2058797069155;2040.2247146084542;2046.3860841747564;6757.324267573253;6842.931570684279;6853.760118395882;6890.069840571559;6938.41023513002;4128.483939507561;4310.4611923509565;4316.223079845627;4316.460442444694;4323.675724320657;2557.974420255792;2737.2335745991154;2761.6685997680406;2781.5410457274525;2791.567307067408;780.153533416244;794.8529522038441;806.9435139540235;808.3694718119876;809.0655293136437;8662.480251184948;8780.165884240923;8817.250533704642;8818.823623527558;8821.07378725231;3512.5609298837644;3689.8524059037873;3709.888703338904;3738.420544815558;3777.2823163598828;7322.414206863545;7327.194008659043;7334.3032411920785;7334.4132469403385;7340.816479588053;4220.577942205816;4222.915541689211;4224.66202703783;4227.365895115758;4234.809433575497;3428.5714285714284;3547.94678079829;3777.244551089793;3835.2137811748526;3904.7461914975434;2967.9076251242823;3021.6222972128485;3027.3188532580434;3117.516784898344;3119.9220019499694;969.2004096620317;978.2418625565101;982.8574856645889;989.9455529945922;990.7721224118349;701.4108149154632;815.979600509992;825.2531459029587;849.9957500212583;863.5552690364467;4831.4202295724735;4865.343178670834;4866.270059491105;4949.901001980013;5059.140879984451;354.71091060785375;359.42671439055187;368.5945459993985;369.45505379565463;375.32816258896815;3291.8847840325475;3338.21551935295;3411.0790086676952;3495.965040349615;3561.679448849616;7628.389728821681;7851.764447066597;7952.721654742057;7957.244061814118;7969.8406031880195;7888.921110788933;7899.881501777478;7901.644426000844;7909.644066017043;7915.683372665029;6254.6872656366995;6325.810225693236;6330.1454303668415;6340.461060809791;6342.5243106767175;4619.191641462798;4686.671932964659;4790.377250957354;4792.472827988988;4838.975805121093;7198.388137008413;7266.1280646322775;7383.667734951832;7408.62956852166;7457.142428620561;7417.8145546361775;7430.777076687708;7436.702531898663;7453.068366454193;7542.698292068256;5528.502434780889;5597.216389705363;5600.159976003632;5732.7706891723865;5881.500072493886;6586.176727909012;6719.328067193242;6721.462283017249;6724.596524208563;6733.2593414725325;5789.363170051375;5805.709714514173;5838.591298609056;6031.276246850406;6045;6017.669028203491;6021.187139736079;6028;6061.636301821904;6099.146119543356;5794.797182098607;5801.94198058014;5841.18223448709;5845.620034697731;5846.41535846412;4054.351303791379;4219.2194444027955;4307.418498502662;4320.848770293024;4422.093470838406;4447.466304043535;4461.241588929955;4471.664625153061;4529.162105010583;4582.793774280099 13:13:51 INFO - PROCESS | 24114 | |4;prototype.html;298.2008217975825;301.05768943207755;305.85777613409766;310.133177768138;311.0792055515672;4746.62027037837;4763.355728165037;4788.52114788521;4789.928151077736;4796.3045358423005;4668.649851261161;4676.251799712047;4721.551452612005;4733.231059830004;4737.786799594018;3527.5590551181167;3625.4199328107507;3639.290338384016;3642.271545690859;3805.162864169878;3714.826826306614;3739.682127019193;3760.905977350561;3765.9811700941596;3770.622937706235;3683.8710645127426;3687.612800655933;3689.966809293402;3694.4827724118645;3726.850925962958;3419.4186988212064;3473.7394695397948;3700.1859590890094;3720.4977328060772;3745.2696724138805;3233;3233.967660323414;3239.49787782894;3252.10567094051;3259.6903294187014;4551.7724113794175;4566.223741963841;4570.200214962369;4577.725336479822;4580.244259697146;4118.279301122292;4132.214879172978;4137.358709400048;4154.335306350969;4193.748375097504;4798.256270278112;4847.321375007502;4872.902541949176;4882.778335857177;4896.290037944514;3576.6065732769375;3579.6241394653707;3584.18998405806;3600.477930700034;3608.1701208722143;5084.262781896604;5096.235564665293;5113.2330150477355;5154.768035438452;5166.276721259027;3583;3649.0512466758305;3651.6348365163803;3678.6873115785456;3698.7410881238593;3668.3030224257304;3680.2639472105684;3686.4654625079215;3712.294664013829;3723.795191264452;4141.254574176617;4151;4157.251694694924;4165.75005499671;4173.9582604174175;4851.34506841579;4853.927191092136;4857.757112144379;4859.538343857399;4864.294677271847;1183.7395772929942;1246.6820960654975;1255.3409460033372;1269.7523982823445;1273.9108262421728;868.3487384461654;871.4466313890725;888.2139306713476;890.3678388344218;898.2454738019964;4079.8164082616354;4106.774127422961;4134.986928202549;4169.749815011109;4224.260754368035;4971.304017437562;4983.401991761012;5010.974945125251;5017;5030.823921162815;4316.827326906951;4321.222180007629;4322.351647252937;4324.56754324565;4346.521882592912;2501.949961000806;2553.3488960315;2558.7569180928153;2569.5460834902624;2572.4212052288085;4551.431071116111;4557.6581756368405;4565.452145742533;4566.74882881438;4567.2464043432465;4970.17992031318;4975.626827987843;4976;4984.77568509418;4995.751062234442;4516.458025037016;4592.540745925381;4603;4607.9308810367875;4784.234522476387;5080.720560369067;5088.567471764942;5108.872278192926;5115.769790359517;5140.30605868203;5005.899882002267;5010.7745151469;5012.3233363495465;5013.874653133701;5028.522290382408;4591.689618486027;4737.549932756383;4781.4501332345835;4783.904321913473;4789.4971028041555;3477.3740726669444;3494.161401263729;3512.5258090158522;3515.947260791039;3528.629493903103;5069.972011195551;5074.543291103819;5116.850922612586;5122.46214147524;5126.692398455955;4850.80596776125;4930.802767889388;4947.332110165082;4955.2567114933045;4959.851204463872;4893;4923.975380123076;4932.8520144395725;4933.72864492442;4937.77779999908;4864.467692676795;4869.975650121727;4888.60242131715;4892.412910450768;4892.80428782859;4800.7599620019555;4962.776675049704;4965.18074517715;4966.726830024383;4990.50094990498;4605.21711309085;4706.576408123286;4708.693934894221;4733.982193828343;4737.265723812815 13:13:51 INFO - PROCESS | 24114 | |5;yui.html;616.2235583165212;665.7603262825379;669.9095622091016;712.9893051604223;753.3333000294738;11305.26515776474;11764.529418823258;12133.696657583565;12136.089793265508;12452.937735311334;11777.23447975881;11945.104117191202;11949.283043017425;11951.64145075647;11970.82043769344;617.8053913017408;636.1570918532939;769.7652216074096;783.1307248953657;785.8860465232538;741.114368329846;763.7174245529162;776.316841179761;777.0325944199479;778.5484419036974;805.9597020148998;819.72948926854;821.0147822612859;821.3716506872247;822.268181318627;636.6498425865801;650.1061041068531;815.1318845429628;815.5392203405116;816.5549775372436;566.7506297229206;579.2440864671602;587.057772275496;587.430192713072;587.7443312159224;11998.340091294975;12013.219140755822;12473.251604903735;12482.750344993141;12492;11115.83326250107;11439.19925605208;11439.313641181472;11614.941925290404;11655.650330490098;8971.910280897173;9419.105185007413;10357.274990750651;10494.632687855965;10532.789344213073;3850.7523403664372;3916.980415097935;3919.0202449387652;3922.0587059105897;4006.6193711597352;47620.52379476195;48476.757616212046;48531.02937941257;48660;48734;9246.214071803837;9620.470874101851;9732.464714440632;10062.798744025078;10074.597016119273;16722.74915876263;17049.573760656083;17194;17195.05427201491;17257.56856078608;6304.464120549805;6315.210598675166;6317.46301564363;6406.647634380154;6444.677766111676;3190.9680903191133;3241.497567876983;3312.38720836646;3318.950215746766;3350.0787283497234;2521.684789401325;2589.7151313355516;2599.1942497825735;2600.154949641374;2603.6615240018677;439.8416570034849;442.3784582661366;445.1964204610709;448.92143874822426;461.186006698178;411.54935345796304;479.6786153277313;526.5050852198921;539.7598068859398;539.7975759090341;6895.011834055301;6961.512694111364;7452.627368631547;7514.774556763306;7657.272559106876;510.45891355163644;530.5808411355064;550.5155463192365;564.382001708129;566.3034467604787;3439.8968030959113;3581.212133330663;3619.7285203609836;3633.6729694327637;3763.8870833875026;43212.567874320855;69122.65438672775;69250;70593.29406705867;70625.29374706188;59631.70184149052;60395.39604603986;60402;60519.39480605226;60910;54477.72761136169;55350.72324638351;55464;55962.44037559654;56150;6894.207166175754;7021.332973367522;7043.6830342633675;7254.05697259374;7256.854862902818;27452.725472745016;29789.404211915207;36974;37693.62306376901;38853.805730971166;31923.521147182346;51153.488465114875;52378;52620.473795261554;53567;9175.862362064441;9259.398139120936;9426.198773104088;9471.147596716328;9596.520173991134;10919.508622111865;10980.945095274472;11370.260933039326;11585.6524304271;11679.532818687157;10282;10370.585176593153;10411.138933000146;10475.895241047492;10843.349399036084;10865.891341086488;11012.50443730018;11429.485673144894;11553.364564948672;11566.421678915853;9864.802703945737;10576.576936922436;10637.840432393676;10710.250282480152;10760.784784304427;8954.686585969459;9163.725088247364;9436.811263774549;9477.810443791224;9546;8882.245009174292;8947.552622368985;9189.586468608795;9339.626414943597;9361.344705870524 13:13:51 INFO - PROCESS | 24114 | __end_tp_report 13:13:51 INFO - PROCESS | 24114 | __start_cc_report 13:13:51 INFO - PROCESS | 24114 | _x_x_mozilla_cycle_collect,1329 13:13:51 INFO - PROCESS | 24114 | __end_cc_report 13:13:51 INFO - PROCESS | 24114 | __startTimestamp1479158031652__endTimestamp 13:13:51 INFO - PROCESS | 24114 | 13:13:51 INFO - PROCESS | 24114 | ------- Summary: start ------- 13:13:51 INFO - PROCESS | 24114 | Number of tests: 6 13:13:51 INFO - PROCESS | 24114 | 13:13:51 INFO - PROCESS | 24114 | [#0] dojo.html Cycles:165 Average:4579.92 Median:4700.58 stddev:477.27 (10.2%) stddev-sans-first:452.28 13:13:51 INFO - PROCESS | 24114 | Values: 2582.6 2600.6 2630.1 2640.7 2647.9 4539.4 4586.5 4635.0 4672.6 4700.6 4619.6 4625.8 4658.5 4690.7 4742.4 4200.9 4211.7 4246.6 4265.0 4275.7 3894.6 4307.1 4376.9 4408.5 4459.1 4189.4 4316.8 4321.7 4382.6 4409.1 4233.7 4244.3 4258.4 4289.4 4295.2 4275.7 4276.5 4279.9 4317.5 4319.5 4621.1 4639.7 4648.2 4649.3 4650.1 4673.2 4712.2 4724.3 4789.2 4980.2 4783.2 4793.9 4797.6 4801.4 4808.0 4616.5 4658.2 4673.0 4718.5 4725.9 5111.1 5120.4 5120.5 5123.3 5168.1 4897.9 4901.2 4905.0 4911.8 4916.7 4776.6 4826.9 4830.8 4872.3 4990.4 4929.1 4938.5 4987.9 5035.7 5058.4 4990.1 4991.6 4997.1 5000.2 5046.5 4078.9 4264.4 4274.6 4279.1 4326.5 3595.9 3631.3 3640.0 3662.7 3689.0 4272.7 4278.0 4278.4 4310.4 4311.8 4986.7 5004.3 5006.5 5008.9 5057.8 4167.0 4173.0 4220.3 4223.0 4255.3 4392.1 4459.2 4469.3 4476.1 4476.4 4590.7 4594.7 4597.9 4599.1 4641.0 4933.7 4934.0 4938.7 4944.7 4989.7 4515.8 4581.8 4609.8 4633.5 4658.8 4914.9 4916.6 4918.2 4921.9 4961.6 4942.6 4986.9 4993.3 4993.8 5030.3 4745.2 4812.0 4829.4 4854.0 4894.7 4843.6 4870.3 4878.6 4904.0 4921.7 4795.9 4800.8 4807.9 4810.8 4841.9 4727.1 4795.6 4801.2 4889.4 4932.1 4717.0 4740.8 4766.6 4766.8 4786.0 13:13:51 INFO - PROCESS | 24114 | 13:13:51 INFO - PROCESS | 24114 | [#1] ext.html Cycles:180 Average:46656.40 Median:35451.23 stddev:86134.92 (243.0%) stddev-sans-first:86306.99 13:13:51 INFO - PROCESS | 24114 | Values: 551.6 561.4 566.6 570.0 591.2 28447.1 31505.1 39600.6 40652.4 40669.0 39599.2 39987.2 39988.6 40054.6 40055.0 7480.0 7656.8 7665.1 7665.7 7674.1 7542.9 7629.1 7638.4 7639.9 7641.1 7621.7 7656.5 7664.8 7680.7 7682.5 7631.3 7657.7 7670.8 7672.1 7682.2 7553.9 7605.3 7611.3 7613.8 7620.7 37483.0 37887.6 37911.0 37951.2 37955.0 2908.4 3129.2 3466.8 3492.9 3537.9 28265.3 28277.7 28496.6 29772.9 29845.3 3409.8 3475.6 3525.6 3537.6 3566.5 374162.0 382016.0 385670.0 386812.0 387234.0 50999.2 51717.0 52015.2 52125.5 52190.7 28880.3 29629.0 29662.9 29664.7 54117.0 14329.0 14480.2 14498.9 14504.7 14505.0 10914.2 10988.5 11008.4 11012.5 11013.2 17428.1 17538.1 17571.0 17583.3 17753.6 6653.9 6712.4 6739.2 6809.0 6945.5 762.7 822.8 835.0 882.9 987.6 26049.7 26519.3 26696.6 27229.6 27296.2 755.6 928.3 931.4 934.2 1006.4 14080.8 14277.5 14285.8 14506.6 14913.7 341643.0 343629.0 343867.0 344019.0 346766.0 49511.8 49929.0 49941.3 49968.8 50017.2 1021.8 1086.4 1089.5 1147.2 1188.3 24676.0 28909.3 29236.6 29438.7 29531.4 41158.2 41696.0 42043.8 42166.4 42242.8 233935.0 234161.0 234284.0 234373.0 234862.0 23962.2 25067.5 25134.5 25244.0 26701.0 40976.4 41218.0 41447.0 42208.4 42596.4 35284.1 35403.8 35465.5 35753.5 35815.8 35131.8 35323.3 35369.3 35604.3 35628.8 34312.0 34784.8 35245.3 35393.1 35437.0 29715.0 32037.8 32199.5 32295.0 32393.4 24850.9 24919.0 24963.8 24981.9 25007.4 13:13:51 INFO - PROCESS | 24114 | 13:13:51 INFO - PROCESS | 24114 | [#2] jquery.html Cycles:180 Average:22109.64 Median:4903.39 stddev:53599.50 (1093.1%) stddev-sans-first:53724.92 13:13:51 INFO - PROCESS | 24114 | Values: 330.6 357.3 357.3 360.5 377.5 12508.7 13510.0 15216.5 15765.2 15951.9 16113.8 16178.8 16344.5 16843.7 16974.7 4120.0 4778.5 4992.2 5003.9 5004.5 4938.1 5010.7 5022.9 5028.8 5030.4 4924.7 4992.9 4996.6 5001.1 5005.4 4882.1 4978.8 4991.3 4994.2 4999.1 4454.9 4457.8 4462.8 4463.9 4468.4 19026.0 19104.8 19619.2 19672.0 19789.4 1633.2 1737.3 1764.0 1766.9 1868.5 8791.4 8849.6 8877.2 8941.0 9150.8 1706.5 1757.2 1761.3 1794.5 1823.8 66743.7 67372.7 67617.0 68295.0 68756.3 9717.8 9768.0 9945.1 10031.9 10037.3 13494.5 13497.3 13504.9 13512.3 13515.0 6762.2 6845.9 6927.8 7014.3 7122.9 6578.7 6652.7 6661.1 6677.8 6812.3 4188.7 4212.2 4220.7 4240.8 4329.6 1756.9 1796.4 1837.9 1868.3 1891.1 757.5 782.6 828.5 836.7 908.2 15341.7 15601.3 16103.4 16389.8 17283.2 830.8 838.7 852.4 856.2 878.6 9017.5 9269.6 9473.6 9501.0 9513.7 267008.0 270498.0 347178.0 349218.0 353981.0 77636.6 81220.6 81940.0 82140.6 82987.0 886.1 906.2 930.5 934.9 935.9 15147.7 15148.8 15864.3 15935.4 16155.2 36422.3 36581.5 37377.4 37526.2 37980.8 51228.0 51774.5 52325.5 52571.5 53768.7 7044.2 7415.7 7499.6 7529.8 7579.0 6927.5 10389.6 11134.9 11584.7 11995.2 6574.6 9382.3 9945.6 10390.2 10941.8 10032.3 10177.1 10452.4 10652.5 10697.9 10274.6 10318.8 10487.9 10781.6 10992.2 7206.9 7353.5 7506.3 7514.5 7719.9 9746.8 9885.5 9887.0 9895.0 9906.2 13:13:51 INFO - PROCESS | 24114 | 13:13:51 INFO - PROCESS | 24114 | [#3] mootools.html Cycles:180 Average:4492.59 Median:5562.86 stddev:2381.39 (42.8%) stddev-sans-first:2375.35 13:13:51 INFO - PROCESS | 24114 | Values: 1218.0 1311.5 1330.1 1388.9 1628.3 6057.4 6630.9 6887.2 6888.9 7060.0 6874.1 6937.3 6940.6 6952.2 6954.4 2046.0 2086.6 2087.0 2089.0 2089.6 2010.5 2013.5 2031.2 2092.5 2095.8 2040.4 2041.7 2056.0 2060.4 2060.9 2028.4 2047.7 2052.3 2053.7 2053.9 1990.3 2016.3 2036.2 2040.2 2046.4 6757.3 6842.9 6853.8 6890.1 6938.4 4128.5 4310.5 4316.2 4316.5 4323.7 2558.0 2737.2 2761.7 2781.5 2791.6 780.2 794.9 806.9 808.4 809.1 8662.5 8780.2 8817.3 8818.8 8821.1 3512.6 3689.9 3709.9 3738.4 3777.3 7322.4 7327.2 7334.3 7334.4 7340.8 4220.6 4222.9 4224.7 4227.4 4234.8 3428.6 3547.9 3777.2 3835.2 3904.7 2967.9 3021.6 3027.3 3117.5 3119.9 969.2 978.2 982.9 989.9 990.8 701.4 816.0 825.3 850.0 863.6 4831.4 4865.3 4866.3 4949.9 5059.1 354.7 359.4 368.6 369.5 375.3 3291.9 3338.2 3411.1 3496.0 3561.7 7628.4 7851.8 7952.7 7957.2 7969.8 7888.9 7899.9 7901.6 7909.6 7915.7 6254.7 6325.8 6330.1 6340.5 6342.5 4619.2 4686.7 4790.4 4792.5 4839.0 7198.4 7266.1 7383.7 7408.6 7457.1 7417.8 7430.8 7436.7 7453.1 7542.7 5528.5 5597.2 5600.2 5732.8 5881.5 6586.2 6719.3 6721.5 6724.6 6733.3 5789.4 5805.7 5838.6 6031.3 6045.0 6017.7 6021.2 6028.0 6061.6 6099.1 5794.8 5801.9 5841.2 5845.6 5846.4 4054.4 4219.2 4307.4 4320.8 4422.1 4447.5 4461.2 4471.7 4529.2 4582.8 13:13:51 INFO - PROCESS | 24114 | 13:13:51 INFO - PROCESS | 24114 | [#4] prototype.html Cycles:180 Average:4070.61 Median:4585.97 stddev:1175.12 (25.6%) stddev-sans-first:1143.79 13:13:51 INFO - PROCESS | 24114 | Values: 298.2 301.1 305.9 310.1 311.1 4746.6 4763.4 4788.5 4789.9 4796.3 4668.6 4676.3 4721.6 4733.2 4737.8 3527.6 3625.4 3639.3 3642.3 3805.2 3714.8 3739.7 3760.9 3766.0 3770.6 3683.9 3687.6 3690.0 3694.5 3726.9 3419.4 3473.7 3700.2 3720.5 3745.3 3233.0 3234.0 3239.5 3252.1 3259.7 4551.8 4566.2 4570.2 4577.7 4580.2 4118.3 4132.2 4137.4 4154.3 4193.7 4798.3 4847.3 4872.9 4882.8 4896.3 3576.6 3579.6 3584.2 3600.5 3608.2 5084.3 5096.2 5113.2 5154.8 5166.3 3583.0 3649.1 3651.6 3678.7 3698.7 3668.3 3680.3 3686.5 3712.3 3723.8 4141.3 4151.0 4157.3 4165.8 4174.0 4851.3 4853.9 4857.8 4859.5 4864.3 1183.7 1246.7 1255.3 1269.8 1273.9 868.3 871.4 888.2 890.4 898.2 4079.8 4106.8 4135.0 4169.7 4224.3 4971.3 4983.4 5011.0 5017.0 5030.8 4316.8 4321.2 4322.4 4324.6 4346.5 2501.9 2553.3 2558.8 2569.5 2572.4 4551.4 4557.7 4565.5 4566.7 4567.2 4970.2 4975.6 4976.0 4984.8 4995.8 4516.5 4592.5 4603.0 4607.9 4784.2 5080.7 5088.6 5108.9 5115.8 5140.3 5005.9 5010.8 5012.3 5013.9 5028.5 4591.7 4737.5 4781.5 4783.9 4789.5 3477.4 3494.2 3512.5 3515.9 3528.6 5070.0 5074.5 5116.9 5122.5 5126.7 4850.8 4930.8 4947.3 4955.3 4959.9 4893.0 4924.0 4932.9 4933.7 4937.8 4864.5 4870.0 4888.6 4892.4 4892.8 4800.8 4962.8 4965.2 4966.7 4990.5 4605.2 4706.6 4708.7 4734.0 4737.3 13:13:51 INFO - PROCESS | 24114 | 13:13:51 INFO - PROCESS | 24114 | [#5] yui.html Cycles:180 Average:14085.68 Median:26452.25 stddev:18139.67 (68.6%) stddev-sans-first:18162.36 13:13:51 INFO - PROCESS | 24114 | Values: 616.2 665.8 669.9 713.0 753.3 11305.3 11764.5 12133.7 12136.1 12452.9 11777.2 11945.1 11949.3 11951.6 11970.8 617.8 636.2 769.8 783.1 785.9 741.1 763.7 776.3 777.0 778.5 806.0 819.7 821.0 821.4 822.3 636.6 650.1 815.1 815.5 816.6 566.8 579.2 587.1 587.4 587.7 11998.3 12013.2 12473.3 12482.8 12492.0 11115.8 11439.2 11439.3 11614.9 11655.7 8971.9 9419.1 10357.3 10494.6 10532.8 3850.8 3917.0 3919.0 3922.1 4006.6 47620.5 48476.8 48531.0 48660.0 48734.0 9246.2 9620.5 9732.5 10062.8 10074.6 16722.7 17049.6 17194.0 17195.1 17257.6 6304.5 6315.2 6317.5 6406.6 6444.7 3191.0 3241.5 3312.4 3319.0 3350.1 2521.7 2589.7 2599.2 2600.2 2603.7 439.8 442.4 445.2 448.9 461.2 411.5 479.7 526.5 539.8 539.8 6895.0 6961.5 7452.6 7514.8 7657.3 510.5 530.6 550.5 564.4 566.3 3439.9 3581.2 3619.7 3633.7 3763.9 43212.6 69122.7 69250.0 70593.3 70625.3 59631.7 60395.4 60402.0 60519.4 60910.0 54477.7 55350.7 55464.0 55962.4 56150.0 6894.2 7021.3 7043.7 7254.1 7256.9 27452.7 29789.4 36974.0 37693.6 38853.8 31923.5 51153.5 52378.0 52620.5 53567.0 9175.9 9259.4 9426.2 9471.1 9596.5 10919.5 10980.9 11370.3 11585.7 11679.5 10282.0 10370.6 10411.1 10475.9 10843.3 10865.9 11012.5 11429.5 11553.4 11566.4 9864.8 10576.6 10637.8 10710.3 10760.8 8954.7 9163.7 9436.8 9477.8 9546.0 8882.2 8947.6 9189.6 9339.6 9361.3 13:13:51 INFO - PROCESS | 24114 | -------- Summary: end -------- 13:13:51 INFO - PROCESS | 24114 | 13:13:52 INFO - TEST-INFO | 24114: exit 0 13:13:52 INFO - TEST-OK | dromaeo_css | took 1122451ms 13:13:52 INFO - TEST-START | kraken 13:13:52 INFO - operating with platform_type : linux_ 13:13:52 INFO - Initialising browser for kraken test... 13:13:52 INFO - TEST-INFO | started process 24416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYQQRHi/profile http://localhost:34829/getInfo.html) 13:13:57 INFO - PROCESS | 24416 | __metrics Screen width/height:1600/1200 13:13:57 INFO - PROCESS | 24416 | colorDepth:24 13:13:57 INFO - PROCESS | 24416 | Browser inner width/height: 1024/697 13:13:57 INFO - PROCESS | 24416 | __metrics 13:13:57 INFO - PROCESS | 24416 | 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" 13:13:57 INFO - PROCESS | 24416 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:13:58 INFO - PROCESS | 24416 | console.error: PushService: 13:13:58 INFO - PROCESS | 24416 | stateChangeProcessEnqueue: Error transitioning state 13:13:58 INFO - PROCESS | 24416 | UnknownError 13:13:59 INFO - TEST-INFO | 24416: exit 0 13:13:59 INFO - Browser initialized. 13:13:59 INFO - Running cycle 1/1 for kraken test... 13:13:59 INFO - TEST-INFO | started process 24497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYQQRHi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:14:11 INFO - PROCESS | 24497 | RSS: Main: 174891008 13:14:11 INFO - PROCESS | 24497 | 13:14:14 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34829/tests/kraken/driver.html?testName=audio-beat-detection) 13:14:15 INFO - PROCESS | 24497 | RSS: Main: 236146688 13:14:15 INFO - PROCESS | 24497 | 13:14:18 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34829/tests/kraken/driver.html?testName=audio-dft) 13:14:18 INFO - PROCESS | 24497 | RSS: Main: 218779648 13:14:18 INFO - PROCESS | 24497 | 13:14:22 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34829/tests/kraken/driver.html?testName=audio-fft) 13:14:22 INFO - PROCESS | 24497 | RSS: Main: 300118016 13:14:22 INFO - PROCESS | 24497 | 13:14:24 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34829/tests/kraken/driver.html?testName=audio-oscillator) 13:14:25 INFO - PROCESS | 24497 | RSS: Main: 211066880 13:14:25 INFO - PROCESS | 24497 | 13:14:27 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34829/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:28 INFO - PROCESS | 24497 | RSS: Main: 215224320 13:14:28 INFO - PROCESS | 24497 | 13:14:31 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34829/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:32 INFO - PROCESS | 24497 | RSS: Main: 252874752 13:14:32 INFO - PROCESS | 24497 | 13:14:35 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34829/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:36 INFO - PROCESS | 24497 | RSS: Main: 252903424 13:14:36 INFO - PROCESS | 24497 | 13:14:38 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34829/tests/kraken/driver.html?testName=json-parse-financial) 13:14:39 INFO - PROCESS | 24497 | RSS: Main: 252264448 13:14:39 INFO - PROCESS | 24497 | 13:14:41 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34829/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:41 INFO - PROCESS | 24497 | RSS: Main: 214446080 13:14:41 INFO - PROCESS | 24497 | 13:14:43 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34829/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:44 INFO - PROCESS | 24497 | RSS: Main: 221786112 13:14:44 INFO - PROCESS | 24497 | 13:14:46 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34829/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:47 INFO - PROCESS | 24497 | RSS: Main: 230256640 13:14:47 INFO - PROCESS | 24497 | 13:14:50 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34829/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:50 INFO - PROCESS | 24497 | RSS: Main: 238772224 13:14:50 INFO - PROCESS | 24497 | 13:14:53 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34829/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:54 INFO - PROCESS | 24497 | RSS: Main: 235057152 13:14:54 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | Cycle 1(1): loaded http://localhost:34829/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34829/tests/kraken/driver.html?testName=ai-astar) 13:14:56 INFO - PROCESS | 24497 | RSS: Main: 285306880 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | __start_tp_report 13:14:56 INFO - PROCESS | 24497 | _x_x_mozilla_page_load 13:14:56 INFO - PROCESS | 24497 | _x_x_mozilla_page_load_details 13:14:56 INFO - PROCESS | 24497 | |i|pagename|runs| 13:14:56 INFO - PROCESS | 24497 | |0;ai-astar;113;115;118;115;115;116;114;115;117;115 13:14:56 INFO - PROCESS | 24497 | |1;audio-beat-detection;162;132;134;165;128;128;130;128;165;136 13:14:56 INFO - PROCESS | 24497 | |2;audio-dft;161;162;163;163;162;162;163;160;160;160 13:14:56 INFO - PROCESS | 24497 | |3;audio-fft;76;76;79;109;78;77;79;77;114;75 13:14:56 INFO - PROCESS | 24497 | |4;audio-oscillator;86;84;117;85;84;84;108;83;84;117 13:14:56 INFO - PROCESS | 24497 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;116 13:14:56 INFO - PROCESS | 24497 | |6;imaging-darkroom;147;147;146;146;146;146;147;146;146;146 13:14:56 INFO - PROCESS | 24497 | |7;imaging-desaturate;85;85;84;85;85;85;84;84;85;85 13:14:56 INFO - PROCESS | 24497 | |8;json-parse-financial;64;71;63;63;64;65;64;64;65;64 13:14:56 INFO - PROCESS | 24497 | |9;json-stringify-tinderbox;66;66;67;66;67;67;67;68;67;67 13:14:56 INFO - PROCESS | 24497 | |10;stanford-crypto-aes;85;85;93;85;84;83;89;84;84;87 13:14:56 INFO - PROCESS | 24497 | |11;stanford-crypto-ccm;142;142;142;143;143;144;141;145;183;155 13:14:56 INFO - PROCESS | 24497 | |12;stanford-crypto-pbkdf2;177;182;183;188;180;182;186;195;181;178 13:14:56 INFO - PROCESS | 24497 | |13;stanford-crypto-sha256-iterative;76;74;72;70;80;70;69;69;69;68 13:14:56 INFO - PROCESS | 24497 | __end_tp_report 13:14:56 INFO - PROCESS | 24497 | __start_cc_report 13:14:56 INFO - PROCESS | 24497 | _x_x_mozilla_cycle_collect,1993 13:14:56 INFO - PROCESS | 24497 | __end_cc_report 13:14:56 INFO - PROCESS | 24497 | __startTimestamp1479158096651__endTimestamp 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | ------- Summary: start ------- 13:14:56 INFO - PROCESS | 24497 | Number of tests: 14 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#0] ai-astar Cycles:10 Average:115.30 Median:115.00 stddev:1.42 (1.2%) stddev-sans-first:1.24 13:14:56 INFO - PROCESS | 24497 | Values: 113.0 115.0 118.0 115.0 115.0 116.0 114.0 115.0 117.0 115.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:135.00 stddev:16.25 (12.0%) stddev-sans-first:15.31 13:14:56 INFO - PROCESS | 24497 | Values: 162.0 132.0 134.0 165.0 128.0 128.0 130.0 128.0 165.0 136.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.26 (0.8%) stddev-sans-first:1.32 13:14:56 INFO - PROCESS | 24497 | Values: 161.0 162.0 163.0 163.0 162.0 162.0 163.0 160.0 160.0 160.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#3] audio-fft Cycles:10 Average:84.00 Median:77.00 stddev:14.60 (19.0%) stddev-sans-first:15.19 13:14:56 INFO - PROCESS | 24497 | Values: 76.0 76.0 79.0 109.0 78.0 77.0 79.0 77.0 114.0 75.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#4] audio-oscillator Cycles:10 Average:93.20 Median:84.00 stddev:14.58 (17.4%) stddev-sans-first:15.23 13:14:56 INFO - PROCESS | 24497 | Values: 86.0 84.0 117.0 85.0 84.0 84.0 108.0 83.0 84.0 117.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 13:14:56 INFO - PROCESS | 24497 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 116.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 13:14:56 INFO - PROCESS | 24497 | Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 13:14:56 INFO - PROCESS | 24497 | Values: 85.0 85.0 84.0 85.0 85.0 85.0 84.0 84.0 85.0 85.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:64.00 stddev:2.31 (3.6%) stddev-sans-first:2.44 13:14:56 INFO - PROCESS | 24497 | Values: 64.0 71.0 63.0 63.0 64.0 65.0 64.0 64.0 65.0 64.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 13:14:56 INFO - PROCESS | 24497 | Values: 66.0 66.0 67.0 66.0 67.0 67.0 67.0 68.0 67.0 67.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#10] stanford-crypto-aes Cycles:10 Average:85.90 Median:85.00 stddev:3.03 (3.6%) stddev-sans-first:3.20 13:14:56 INFO - PROCESS | 24497 | Values: 85.0 85.0 93.0 85.0 84.0 83.0 89.0 84.0 84.0 87.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#11] stanford-crypto-ccm Cycles:10 Average:148.00 Median:143.50 stddev:12.94 (9.0%) stddev-sans-first:13.54 13:14:56 INFO - PROCESS | 24497 | Values: 142.0 142.0 142.0 143.0 143.0 144.0 141.0 145.0 183.0 155.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.20 Median:182.50 stddev:5.31 (2.9%) stddev-sans-first:5.13 13:14:56 INFO - PROCESS | 24497 | Values: 177.0 182.0 183.0 188.0 180.0 182.0 186.0 195.0 181.0 178.0 13:14:56 INFO - PROCESS | 24497 | 13:14:56 INFO - PROCESS | 24497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:71.00 stddev:3.86 (5.4%) stddev-sans-first:3.77 13:14:56 INFO - PROCESS | 24497 | Values: 76.0 74.0 72.0 70.0 80.0 70.0 69.0 69.0 69.0 68.0 13:14:56 INFO - PROCESS | 24497 | -------- Summary: end -------- 13:14:56 INFO - PROCESS | 24497 | 13:14:58 INFO - TEST-INFO | 24497: exit 0 13:14:58 INFO - TEST-OK | kraken | took 65403ms 13:14:58 INFO - SUITE-END | took 1187s 13:14:58 INFO - Completed test suite (00:19:48) 13:14:58 INFO - javascript benchmark 13:14:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.5738753105734, 2600.6099085137216, 2630.132056421381, 2640.74912883276, 2647.9073232436867, 4539.40987671603, 4586.472555656101, 4634.976825115874, 4672.579467847893, 4700.576948074672, 4619.584237418631, 4625.791839367228, 4658.53414658534, 4690.742009189493, 4742.430908291001, 4200.873973780792, 4211.7051806373565, 4246.596573325529, 4264.978675106636, 4275.7434553926705, 3894.610538946111, 4307.0739790944945, 4376.912461750763, 4408.470983481987, 4459.0858873930765, 4189.392538081992, 4316.848910288156, 4321.719088259285, 4382.561743825608, 4409.05205380843, 4233.661307095425, 4244.257254980366, 4258.446401967755, 4289.356596510548, 4295.183915056129, 4275.743455392686, 4276.465441819772, 4279.91440171198, 4317.4819021717285, 4319.50325712544, 4621.098885717286, 4639.652026098022, 4648.186567350734, 4649.325847752091, 4650.0932318197965, 4673.205555055649, 4712.246040633517, 4724.291356296583, 4789.185838407444, 4980.153373926441, 4783.210770222909, 4793.904121917577, 4797.616190704735, 4801.423829140491, 4808.0, 4616.53834616539, 4658.161530924398, 4673.042026384583, 4718.504557021532, 4725.8582242532775, 5111.131107711698, 5120.359955005624, 5120.5391514763105, 5123.308353372322, 5168.0697474454955, 4897.902041959141, 4901.191303434894, 4904.975475122602, 4911.778969946361, 4916.655834091579, 4776.641751868624, 4826.855194344175, 4830.782614782343, 4872.317875497433, 4990.401151861727, 4929.063477939252, 4938.530839570235, 4987.875303117378, 5035.723035233097, 5058.4435712071645, 4990.076835785391, 4991.625628077909, 4997.0505603935135, 5000.174971129795, 5046.470120637354, 4078.857239996586, 4264.424302719155, 4274.572542745701, 4279.058607106432, 4326.480822301344, 3595.856165753393, 3631.3100510903373, 3639.9636003639625, 3662.6703596676425, 3689.0408493791806, 4272.658187345005, 4278.0374415756205, 4278.4010238566625, 4310.418093557392, 4311.805968731414, 4986.7257300848805, 5004.274380214849, 5006.524380183877, 5008.924866127011, 5057.848264552069, 4167.0, 4172.958270417257, 4220.261454245495, 4223.0, 4255.319148936155, 4392.143532011227, 4459.152760975404, 4469.262571675637, 4476.060027394218, 4476.350929115325, 4590.747508886977, 4594.655400844883, 4597.862064138081, 4599.126166028444, 4641.048585040126, 4933.679310844784, 4933.97533012347, 4938.678985865908, 4944.678595891256, 4989.675671081368, 4515.796789144562, 4581.770911454348, 4609.769511524478, 4633.513481084437, 4658.836940707059, 4914.852554423373, 4916.631252656137, 4918.1884988977845, 4921.901561968669, 4961.5534601886, 4942.629302802232, 4986.8753281168265, 4993.27597498368, 4993.750312484434, 5030.346055012825, 4745.240761478147, 4811.9518804811505, 4829.420469543677, 4853.951460485491, 4894.681845680019, 4843.612510999041, 4870.269459581091, 4878.609711223023, 4903.975480122719, 4921.729304888122, 4795.880102997453, 4800.759962001816, 4807.855764327076, 4810.807567697253, 4841.903161936812, 4727.078219747116, 4795.592374648194, 4801.231802911518, 4889.437714662717, 4932.062908047459, 4716.952830471651, 4740.786664600032, 4766.618670506282, 4766.809327626856, 4786.018866132504], "value": 4549.961739665817, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.5752870289876, 561.4217356123195, 566.5750686984761, 569.9715014249288, 591.1694069831888, 28447.14658560244, 31505.11670691041, 39600.603993960016, 40652.39021414681, 40669.0, 39599.208015839664, 39987.20025599486, 39988.60011399885, 40054.59945400545, 40055.0, 7480.0, 7656.846863062736, 7665.118511371208, 7665.655045522964, 7674.117476490219, 7542.924570754277, 7629.122650895162, 7638.3889288857035, 7639.885401718979, 7641.121271053845, 7621.657025433841, 7656.464047516676, 7664.808379790494, 7680.654370553339, 7682.462227644067, 7631.313181813635, 7657.731979380751, 7670.846583068335, 7672.117706463717, 7682.231776822273, 7553.924460755377, 7605.315521603082, 7611.314981651678, 7613.771586852348, 7620.657070431844, 37483.0, 37887.62112378868, 37911.0, 37951.24097518062, 37955.0, 2908.3601607646283, 3129.186411532995, 3466.757326987112, 3492.8777492787885, 3537.9292414151832, 28265.293367665767, 28277.717222827716, 28496.572551411744, 29772.8511357444, 29845.253868653457, 3409.8295085245886, 3475.6176820549717, 3525.6474352564796, 3537.5931767846514, 3566.465030245458, 374162.0, 382016.0, 385670.0, 386812.0, 387234.0, 50999.235011474855, 51717.0, 52015.21977170346, 52125.478745212065, 52190.73904630452, 28880.277993050342, 29629.0, 29662.851685741432, 29664.703352966626, 54117.0, 14329.0, 14480.203588802717, 14498.927505362406, 14504.709905802036, 14505.0, 10914.181436392302, 10988.505517251582, 11008.449577521093, 11012.50443730018, 11013.174011949135, 17428.12859357027, 17538.123093845257, 17571.0, 17583.29666813313, 17753.556161096076, 6653.933460665428, 6712.39588437043, 6739.224989126215, 6809.0, 6945.51381403307, 762.7406681728239, 822.8148666550098, 834.9582520873932, 882.8719835623928, 987.612404571578, 26049.73950260511, 26519.309400273705, 26696.59955100675, 27229.591556126674, 27296.181114566596, 755.6335177438938, 928.3176865004217, 931.3992474853817, 934.1592566690033, 1006.3961623026125, 14080.788788168185, 14277.500287490097, 14285.785668244132, 14506.637334066732, 14913.701725965637, 341643.0, 343629.0, 343867.0, 344019.0, 346766.0, 49511.752441237564, 49929.0, 49941.25088123681, 49968.750156248985, 50017.24974125391, 1021.7649940513575, 1086.41333679812, 1089.54239219528, 1147.2198904744853, 1188.3285943441927, 24676.0, 28909.277268068465, 29236.561451577818, 29438.705612943595, 29531.40937181287, 41158.1768364637, 41696.0, 42043.7897810509, 42166.36750448807, 42242.78878605587, 233935.0, 234161.0, 234284.0, 234373.0, 234862.0, 23962.16132435426, 25067.498650026533, 25134.497310054063, 25244.0, 26701.0, 40976.38535422031, 41218.0, 41447.0, 42208.36687449629, 42596.36105458483, 35284.117897052776, 35403.82298088493, 35465.468017979234, 35753.46369804403, 35815.82092089523, 35131.824340878135, 35323.29353412866, 35369.292614148086, 35604.287914242086, 35628.82185589159, 34312.0, 34784.82607586946, 35245.29509409746, 35393.10675825606, 35437.0, 29715.0, 32037.839810800797, 32199.51700724538, 32295.031149065566, 32393.35213295768, 24850.90354692583, 24919.0, 24963.75036249687, 24981.87509062443, 25007.374815629755], "value": 17016.390436233294, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [330.5917192267548, 357.2889949001488, 357.3424898187335, 360.45391232283094, 377.4677704436743, 12508.749825003506, 13510.0, 15216.467423640175, 15765.211739413013, 15951.920240398811, 16113.83886161138, 16178.83821161788, 16344.509664710047, 16843.663126737458, 16974.745378819327, 4120.0, 4778.498257682937, 4992.201247800353, 5003.899922001558, 5004.474530174334, 4938.135826230413, 5010.749462526877, 5022.9246561301425, 5028.7988480460735, 5030.37120359955, 4924.652713650364, 4992.925106123411, 4996.575291100261, 5001.149804533238, 5005.399352077756, 4882.121218180726, 4978.800847966095, 4991.301217829507, 4994.225894986283, 4999.075171093359, 4454.933176002362, 4457.777111144463, 4462.821487140543, 4463.910721785579, 4468.4414448193975, 19026.0, 19104.808951910443, 19619.215231390728, 19672.0, 19789.406317810488, 1633.1915701727603, 1737.2616637928957, 1763.9647207055916, 1766.8939863608095, 1868.4955062133283, 8791.428557143765, 8849.646014159425, 8877.201051905295, 8941.0, 9150.816983660356, 1706.4795237452572, 1757.1653464604337, 1761.2954818072744, 1794.5244510204675, 1823.7955763045436, 66743.66628166828, 67372.6631366845, 67617.0, 68295.0, 68756.31243687599, 9717.805643887083, 9767.951160244153, 9945.055219754111, 10031.899681003242, 10037.297389182688, 13494.460221591222, 13497.257650829299, 13504.86495135036, 13512.324383780771, 13515.0, 6762.154730658668, 6845.863082738318, 6927.753004459246, 7014.263502332284, 7122.893156602655, 6578.703958321887, 6652.702722969071, 6661.134052573135, 6677.799666010027, 6812.318768123148, 4188.68584856137, 4212.220739163265, 4220.704550681423, 4240.830366785294, 4329.631981281564, 1756.9385071522436, 1796.4071856287394, 1837.926482940694, 1868.271374164077, 1891.1206289075371, 757.5114051436792, 782.6165179062332, 828.4656396624143, 836.6653338664461, 908.1554154636119, 15341.693166136838, 15601.297941592655, 16103.355865765472, 16389.754153687703, 17283.222254998556, 830.8172202115525, 838.6603425612515, 852.411835833273, 856.1866227084295, 878.6221924572495, 9017.549122543847, 9269.582868770922, 9473.573689184002, 9500.952495237618, 9513.714588562354, 267008.0, 270498.0, 347178.0, 349218.0, 353981.0, 77636.61181694169, 81220.59389703014, 81940.0, 82140.58929705313, 82987.0, 886.0873300500494, 906.2025417632441, 930.4882314726873, 934.8597710343366, 935.8502639577634, 15147.697046059238, 15148.848511514743, 15864.286107124975, 15935.36258549645, 16155.192240388169, 36422.27155456929, 36581.45127823031, 37377.43933841049, 37526.249475010896, 37980.810095949346, 51228.0, 51774.48225517697, 52325.47674523358, 52571.47428525819, 53768.731156343965, 7044.225135235222, 7415.740449084256, 7499.5875226863045, 7529.774106776806, 7579.0, 6927.480438967198, 10389.584416623251, 11134.888651113386, 11584.698360967084, 11995.241094548128, 6574.572652777554, 9382.343235973416, 9945.602175912882, 10390.22073344487, 10941.781164376509, 10032.347897386939, 10177.134943529883, 10452.372857628567, 10652.520636571218, 10697.946510267398, 10274.640387586398, 10318.845217321596, 10487.895121048998, 10781.62264320745, 10992.230543861853, 7206.89189662145, 7353.522021068614, 7506.28690274423, 7514.47398682087, 7719.884201737091, 9746.805063898824, 9885.456299903575, 9886.950565247127, 9895.0, 9906.157976571783], "value": 7869.950477739949, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1218.031664826463, 1311.5048396024592, 1330.0822432521559, 1388.9236092014942, 1628.2672797241237, 6057.39426057394, 6630.9336906630915, 6887.173539175294, 6888.896666550006, 7059.964700176505, 6874.140732408449, 6937.271586483423, 6940.618265995368, 6952.2352541220425, 6954.408875245597, 2045.969310460348, 2086.645270304052, 2086.9895650521803, 2089.0390420406557, 2089.550746589483, 2010.4873257319437, 2013.526821197025, 2031.177373163871, 2092.4559614500185, 2095.832333413331, 2040.3776848061336, 2041.7243672104298, 2056.0439395681005, 2060.3715866660664, 2060.9484762880898, 2028.381343690174, 2047.7337946066916, 2052.322733497942, 2053.712480252766, 2053.9281125160546, 1990.2934458267252, 2016.3346095788502, 2036.2058797069155, 2040.2247146084542, 2046.3860841747564, 6757.324267573253, 6842.931570684279, 6853.760118395882, 6890.069840571559, 6938.41023513002, 4128.483939507561, 4310.4611923509565, 4316.223079845627, 4316.460442444694, 4323.675724320657, 2557.974420255792, 2737.2335745991154, 2761.6685997680406, 2781.5410457274525, 2791.567307067408, 780.153533416244, 794.8529522038441, 806.9435139540235, 808.3694718119876, 809.0655293136437, 8662.480251184948, 8780.165884240923, 8817.250533704642, 8818.823623527558, 8821.07378725231, 3512.5609298837644, 3689.8524059037873, 3709.888703338904, 3738.420544815558, 3777.2823163598828, 7322.414206863545, 7327.194008659043, 7334.3032411920785, 7334.4132469403385, 7340.816479588053, 4220.577942205816, 4222.915541689211, 4224.66202703783, 4227.365895115758, 4234.809433575497, 3428.5714285714284, 3547.94678079829, 3777.244551089793, 3835.2137811748526, 3904.7461914975434, 2967.9076251242823, 3021.6222972128485, 3027.3188532580434, 3117.516784898344, 3119.9220019499694, 969.2004096620317, 978.2418625565101, 982.8574856645889, 989.9455529945922, 990.7721224118349, 701.4108149154632, 815.979600509992, 825.2531459029587, 849.9957500212583, 863.5552690364467, 4831.4202295724735, 4865.343178670834, 4866.270059491105, 4949.901001980013, 5059.140879984451, 354.71091060785375, 359.42671439055187, 368.5945459993985, 369.45505379565463, 375.32816258896815, 3291.8847840325475, 3338.21551935295, 3411.0790086676952, 3495.965040349615, 3561.679448849616, 7628.389728821681, 7851.764447066597, 7952.721654742057, 7957.244061814118, 7969.8406031880195, 7888.921110788933, 7899.881501777478, 7901.644426000844, 7909.644066017043, 7915.683372665029, 6254.6872656366995, 6325.810225693236, 6330.1454303668415, 6340.461060809791, 6342.5243106767175, 4619.191641462798, 4686.671932964659, 4790.377250957354, 4792.472827988988, 4838.975805121093, 7198.388137008413, 7266.1280646322775, 7383.667734951832, 7408.62956852166, 7457.142428620561, 7417.8145546361775, 7430.777076687708, 7436.702531898663, 7453.068366454193, 7542.698292068256, 5528.502434780889, 5597.216389705363, 5600.159976003632, 5732.7706891723865, 5881.500072493886, 6586.176727909012, 6719.328067193242, 6721.462283017249, 6724.596524208563, 6733.2593414725325, 5789.363170051375, 5805.709714514173, 5838.591298609056, 6031.276246850406, 6045.0, 6017.669028203491, 6021.187139736079, 6028.0, 6061.636301821904, 6099.146119543356, 5794.797182098607, 5801.94198058014, 5841.18223448709, 5845.620034697731, 5846.41535846412, 4054.351303791379, 4219.2194444027955, 4307.418498502662, 4320.848770293024, 4422.093470838406, 4447.466304043535, 4461.241588929955, 4471.664625153061, 4529.162105010583, 4582.793774280099], "value": 3618.169433454306, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.2008217975825, 301.05768943207755, 305.85777613409766, 310.133177768138, 311.0792055515672, 4746.62027037837, 4763.355728165037, 4788.52114788521, 4789.928151077736, 4796.3045358423005, 4668.649851261161, 4676.251799712047, 4721.551452612005, 4733.231059830004, 4737.786799594018, 3527.5590551181167, 3625.4199328107507, 3639.290338384016, 3642.271545690859, 3805.162864169878, 3714.826826306614, 3739.682127019193, 3760.905977350561, 3765.9811700941596, 3770.622937706235, 3683.8710645127426, 3687.612800655933, 3689.966809293402, 3694.4827724118645, 3726.850925962958, 3419.4186988212064, 3473.7394695397948, 3700.1859590890094, 3720.4977328060772, 3745.2696724138805, 3233.0, 3233.967660323414, 3239.49787782894, 3252.10567094051, 3259.6903294187014, 4551.7724113794175, 4566.223741963841, 4570.200214962369, 4577.725336479822, 4580.244259697146, 4118.279301122292, 4132.214879172978, 4137.358709400048, 4154.335306350969, 4193.748375097504, 4798.256270278112, 4847.321375007502, 4872.902541949176, 4882.778335857177, 4896.290037944514, 3576.6065732769375, 3579.6241394653707, 3584.18998405806, 3600.477930700034, 3608.1701208722143, 5084.262781896604, 5096.235564665293, 5113.2330150477355, 5154.768035438452, 5166.276721259027, 3583.0, 3649.0512466758305, 3651.6348365163803, 3678.6873115785456, 3698.7410881238593, 3668.3030224257304, 3680.2639472105684, 3686.4654625079215, 3712.294664013829, 3723.795191264452, 4141.254574176617, 4151.0, 4157.251694694924, 4165.75005499671, 4173.9582604174175, 4851.34506841579, 4853.927191092136, 4857.757112144379, 4859.538343857399, 4864.294677271847, 1183.7395772929942, 1246.6820960654975, 1255.3409460033372, 1269.7523982823445, 1273.9108262421728, 868.3487384461654, 871.4466313890725, 888.2139306713476, 890.3678388344218, 898.2454738019964, 4079.8164082616354, 4106.774127422961, 4134.986928202549, 4169.749815011109, 4224.260754368035, 4971.304017437562, 4983.401991761012, 5010.974945125251, 5017.0, 5030.823921162815, 4316.827326906951, 4321.222180007629, 4322.351647252937, 4324.56754324565, 4346.521882592912, 2501.949961000806, 2553.3488960315, 2558.7569180928153, 2569.5460834902624, 2572.4212052288085, 4551.431071116111, 4557.6581756368405, 4565.452145742533, 4566.74882881438, 4567.2464043432465, 4970.17992031318, 4975.626827987843, 4976.0, 4984.77568509418, 4995.751062234442, 4516.458025037016, 4592.540745925381, 4603.0, 4607.9308810367875, 4784.234522476387, 5080.720560369067, 5088.567471764942, 5108.872278192926, 5115.769790359517, 5140.30605868203, 5005.899882002267, 5010.7745151469, 5012.3233363495465, 5013.874653133701, 5028.522290382408, 4591.689618486027, 4737.549932756383, 4781.4501332345835, 4783.904321913473, 4789.4971028041555, 3477.3740726669444, 3494.161401263729, 3512.5258090158522, 3515.947260791039, 3528.629493903103, 5069.972011195551, 5074.543291103819, 5116.850922612586, 5122.46214147524, 5126.692398455955, 4850.80596776125, 4930.802767889388, 4947.332110165082, 4955.2567114933045, 4959.851204463872, 4893.0, 4923.975380123076, 4932.8520144395725, 4933.72864492442, 4937.77779999908, 4864.467692676795, 4869.975650121727, 4888.60242131715, 4892.412910450768, 4892.80428782859, 4800.7599620019555, 4962.776675049704, 4965.18074517715, 4966.726830024383, 4990.50094990498, 4605.21711309085, 4706.576408123286, 4708.693934894221, 4733.982193828343, 4737.265723812815], "value": 3704.0592698954247, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.2235583165212, 665.7603262825379, 669.9095622091016, 712.9893051604223, 753.3333000294738, 11305.26515776474, 11764.529418823258, 12133.696657583565, 12136.089793265508, 12452.937735311334, 11777.23447975881, 11945.104117191202, 11949.283043017425, 11951.64145075647, 11970.82043769344, 617.8053913017408, 636.1570918532939, 769.7652216074096, 783.1307248953657, 785.8860465232538, 741.114368329846, 763.7174245529162, 776.316841179761, 777.0325944199479, 778.5484419036974, 805.9597020148998, 819.72948926854, 821.0147822612859, 821.3716506872247, 822.268181318627, 636.6498425865801, 650.1061041068531, 815.1318845429628, 815.5392203405116, 816.5549775372436, 566.7506297229206, 579.2440864671602, 587.057772275496, 587.430192713072, 587.7443312159224, 11998.340091294975, 12013.219140755822, 12473.251604903735, 12482.750344993141, 12492.0, 11115.83326250107, 11439.19925605208, 11439.313641181472, 11614.941925290404, 11655.650330490098, 8971.910280897173, 9419.105185007413, 10357.274990750651, 10494.632687855965, 10532.789344213073, 3850.7523403664372, 3916.980415097935, 3919.0202449387652, 3922.0587059105897, 4006.6193711597352, 47620.52379476195, 48476.757616212046, 48531.02937941257, 48660.0, 48734.0, 9246.214071803837, 9620.470874101851, 9732.464714440632, 10062.798744025078, 10074.597016119273, 16722.74915876263, 17049.573760656083, 17194.0, 17195.05427201491, 17257.56856078608, 6304.464120549805, 6315.210598675166, 6317.46301564363, 6406.647634380154, 6444.677766111676, 3190.9680903191133, 3241.497567876983, 3312.38720836646, 3318.950215746766, 3350.0787283497234, 2521.684789401325, 2589.7151313355516, 2599.1942497825735, 2600.154949641374, 2603.6615240018677, 439.8416570034849, 442.3784582661366, 445.1964204610709, 448.92143874822426, 461.186006698178, 411.54935345796304, 479.6786153277313, 526.5050852198921, 539.7598068859398, 539.7975759090341, 6895.011834055301, 6961.512694111364, 7452.627368631547, 7514.774556763306, 7657.272559106876, 510.45891355163644, 530.5808411355064, 550.5155463192365, 564.382001708129, 566.3034467604787, 3439.8968030959113, 3581.212133330663, 3619.7285203609836, 3633.6729694327637, 3763.8870833875026, 43212.567874320855, 69122.65438672775, 69250.0, 70593.29406705867, 70625.29374706188, 59631.70184149052, 60395.39604603986, 60402.0, 60519.39480605226, 60910.0, 54477.72761136169, 55350.72324638351, 55464.0, 55962.44037559654, 56150.0, 6894.207166175754, 7021.332973367522, 7043.6830342633675, 7254.05697259374, 7256.854862902818, 27452.725472745016, 29789.404211915207, 36974.0, 37693.62306376901, 38853.805730971166, 31923.521147182346, 51153.488465114875, 52378.0, 52620.473795261554, 53567.0, 9175.862362064441, 9259.398139120936, 9426.198773104088, 9471.147596716328, 9596.520173991134, 10919.508622111865, 10980.945095274472, 11370.260933039326, 11585.6524304271, 11679.532818687157, 10282.0, 10370.585176593153, 10411.138933000146, 10475.895241047492, 10843.349399036084, 10865.891341086488, 11012.50443730018, 11429.485673144894, 11553.364564948672, 11566.421678915853, 9864.802703945737, 10576.576936922436, 10637.840432393676, 10710.250282480152, 10760.784784304427, 8954.686585969459, 9163.725088247364, 9436.811263774549, 9477.810443791224, 9546.0, 8882.245009174292, 8947.552622368985, 9189.586468608795, 9339.626414943597, 9361.344705870524], "value": 5852.237763804866, "unit": "score"}], "name": "dromaeo_css", "value": 6024.187892871725, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 118.0, 115.0, 115.0, 116.0, 114.0, 115.0, 117.0, 115.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 134.0, 165.0, 128.0, 128.0, 130.0, 128.0, 165.0, 136.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 163.0, 162.0, 162.0, 163.0, 160.0, 160.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 79.0, 109.0, 78.0, 77.0, 79.0, 77.0, 114.0, 75.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 117.0, 85.0, 84.0, 84.0, 108.0, 83.0, 84.0, 117.0], "value": 93.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 63.0, 63.0, 64.0, 65.0, 64.0, 64.0, 65.0, 64.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 68.0, 67.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 93.0, 85.0, 84.0, 83.0, 89.0, 84.0, 84.0, 87.0], "value": 85.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 142.0, 143.0, 143.0, 144.0, 141.0, 145.0, 183.0, 155.0], "value": 148.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 182.0, 183.0, 188.0, 180.0, 182.0, 186.0, 195.0, 181.0, 178.0], "value": 183.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 72.0, 70.0, 80.0, 70.0, 69.0, 69.0, 69.0, 68.0], "value": 71.7, "unit": "score"}], "name": "kraken", "value": 1563.0000000000002, "alertThreshold": 2.0}]} 13:14:58 INFO - Return code: 0 13:14:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:14:58 INFO - # TBPL SUCCESS # 13:14:58 INFO - Running post-action listener: _resource_record_post_action 13:14:58 INFO - [mozharness: 2016-11-14 21:14:58.436658Z] Finished run-tests step (success) 13:14:58 INFO - Running post-run listener: _resource_record_post_run 13:14:58 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 393064448; Read time: 0; Write time: 433720 13:14:58 INFO - TinderboxPrint: CPU usage
13.1% 13:14:58 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:14:58 INFO - TinderboxPrint: I/O write bytes / time
393,064,448 / 433,720 13:14:58 INFO - TinderboxPrint: CPU idle
8,349.5 (86.9%) 13:14:58 INFO - TinderboxPrint: CPU user
1,206.2 (12.6%) 13:14:58 INFO - TinderboxPrint: Swap in / out
0 / 0 13:14:58 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 104656896; Read time: 0; Write time: 154248 13:14:58 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 288407552; Read time: 0; Write time: 279472 13:14:59 INFO - Running post-run listener: _upload_blobber_files 13:14:59 INFO - Blob upload gear active. 13:14:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14:59 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 13:14:59 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'] 13:14:59 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 13:14:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:14:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:15:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:00 INFO - (blobuploader) - INFO - Done attempting. 13:15:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:15:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:15:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:00 INFO - (blobuploader) - INFO - Done attempting. 13:15:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:15:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:15:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:15:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:15:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:15:06 INFO - (blobuploader) - INFO - Done attempting. 13:15:06 INFO - (blobuploader) - INFO - Iteration through files over. 13:15:06 INFO - Return code: 0 13:15:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:15:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:15:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeb2e43c3eca5a3ec75015047785e86d5149a857546421ddce1b6622bf6af71bb952efaff66d35b8113e1939e35f8b9c633e942b48509f8bf5148865eff54cbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca78390a3745aa1d51e164d5838a28fee51e035887633c7e4a8b6597c928bda1b47dde185276bc46bc1a7fc0e609fc9c3f57d35cee059c7885f994f5885310c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d24ed21bdb097e556d750644aca0086697df88bf6f46773b7e4a33511a4d8f42dcdffd11c407db3d07ca8308831f99c2fcf2de8e200867e1737190d216408247"} 13:15:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:15:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:15:06 INFO - Contents: 13:15:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aeb2e43c3eca5a3ec75015047785e86d5149a857546421ddce1b6622bf6af71bb952efaff66d35b8113e1939e35f8b9c633e942b48509f8bf5148865eff54cbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca78390a3745aa1d51e164d5838a28fee51e035887633c7e4a8b6597c928bda1b47dde185276bc46bc1a7fc0e609fc9c3f57d35cee059c7885f994f5885310c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d24ed21bdb097e556d750644aca0086697df88bf6f46773b7e4a33511a4d8f42dcdffd11c407db3d07ca8308831f99c2fcf2de8e200867e1737190d216408247"} 13:15:06 INFO - Running post-run listener: copy_logs_to_upload_dir 13:15:06 INFO - Copying logs to upload dir... 13:15:06 INFO - mkdir: /builds/slave/test/build/upload/logs 13:15:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.015012 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-11-14 13:15:05.963430) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 13:15:05.966919) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091 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/aeb2e43c3eca5a3ec75015047785e86d5149a857546421ddce1b6622bf6af71bb952efaff66d35b8113e1939e35f8b9c633e942b48509f8bf5148865eff54cbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca78390a3745aa1d51e164d5838a28fee51e035887633c7e4a8b6597c928bda1b47dde185276bc46bc1a7fc0e609fc9c3f57d35cee059c7885f994f5885310c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d24ed21bdb097e556d750644aca0086697df88bf6f46773b7e4a33511a4d8f42dcdffd11c407db3d07ca8308831f99c2fcf2de8e200867e1737190d216408247"} build_url:https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011234 build_url: 'https://queue.taskcluster.net/v1/task/GtJ7FKEwQLOGpcIMIFhOFQ/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/aeb2e43c3eca5a3ec75015047785e86d5149a857546421ddce1b6622bf6af71bb952efaff66d35b8113e1939e35f8b9c633e942b48509f8bf5148865eff54cbf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/5ca78390a3745aa1d51e164d5838a28fee51e035887633c7e4a8b6597c928bda1b47dde185276bc46bc1a7fc0e609fc9c3f57d35cee059c7885f994f5885310c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d24ed21bdb097e556d750644aca0086697df88bf6f46773b7e4a33511a4d8f42dcdffd11c407db3d07ca8308831f99c2fcf2de8e200867e1737190d216408247"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-14 13:15:05.991374) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 13:15:05.991726) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479156854.65247-1751944091 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004510 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-14 13:15:06.074119) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 13:15:06.074455) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-14 13:15:06.074768) ========= ========= Total master_lag: 0.17 =========