builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-036 starttime: 1475109838.75 results: success (0) buildid: 20160928162520 builduid: af2bd9bdef7f44ce946c12af2f812843 revision: 199c73e2737df4e74dce37cfa1d139f0ed873f02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 17:43:58.749799) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 17:43:58.750267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 17:43:58.750550) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 17:43:58.775911) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 17:43:58.776198) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 17:43:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 66.4M=0s 2016-09-28 17:43:58 (66.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.103038 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 17:43:58.893171) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 17:43:58.893505) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020394 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 17:43:58.943337) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-28 17:43:58.943718) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 199c73e2737df4e74dce37cfa1d139f0ed873f02 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 199c73e2737df4e74dce37cfa1d139f0ed873f02 --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=14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 17:43:58,980 truncating revision to first 12 chars 2016-09-28 17:43:58,980 Setting DEBUG logging. 2016-09-28 17:43:58,980 attempt 1/10 2016-09-28 17:43:58,980 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/199c73e2737d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 17:44:00,978 unpacking tar archive at: autoland-199c73e2737d/testing/mozharness/ program finished with exit code 0 elapsedTime=2.405697 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-09-28 17:44:01.363404) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 17:44:01.363731) ========= script_repo_revision: 199c73e2737df4e74dce37cfa1d139f0ed873f02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 17:44:01.364180) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 17:44:01.364528) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 17:44:01.373211) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-28 17:44:01.373626) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-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', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-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=14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:44:01 INFO - MultiFileLogger online at 20160928 17:44:01 in /builds/slave/test 17:44:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 17:44:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:44:01 INFO - {'append_to_log': False, 17:44:01 INFO - 'base_work_dir': '/builds/slave/test', 17:44:01 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 17:44:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:44:01 INFO - 'branch': 'Autoland-Non-PGO', 17:44:01 INFO - 'buildbot_json_path': 'buildprops.json', 17:44:01 INFO - 'config_files': ('talos/linux_config.py',), 17:44:01 INFO - 'default_actions': ('clobber', 17:44:01 INFO - 'read-buildbot-config', 17:44:01 INFO - 'download-and-extract', 17:44:01 INFO - 'populate-webroot', 17:44:01 INFO - 'create-virtualenv', 17:44:01 INFO - 'install', 17:44:01 INFO - 'run-tests'), 17:44:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:44:01 INFO - 'download_minidump_stackwalk': True, 17:44:01 INFO - 'download_symbols': 'ondemand', 17:44:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:44:01 INFO - 'tooltool.py': '/tools/tooltool.py', 17:44:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:44:01 INFO - '/tools/misc-python/virtualenv.py')}, 17:44:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:44:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:44:01 INFO - 'installer_path': 'installer.exe', 17:44:01 INFO - 'log_level': 'info', 17:44:01 INFO - 'log_name': 'talos', 17:44:01 INFO - 'log_to_console': True, 17:44:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:44:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:44:01 INFO - 'opt_config_files': (), 17:44:01 INFO - 'pip_index': False, 17:44:01 INFO - 'sps_profile': False, 17:44:01 INFO - 'sps_profile_interval': 0, 17:44:01 INFO - 'suite': 'dromaeojs', 17:44:01 INFO - 'system_bits': '32', 17:44:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:44:01 INFO - 'title': 'talos-linux64-ix-036', 17:44:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:44:01 INFO - 'use_talos_json': True, 17:44:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:44:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:44:01 INFO - 'work_dir': 'build'} 17:44:01 INFO - [mozharness: 2016-09-29 00:44:01.505417Z] Running clobber step. 17:44:01 INFO - Running pre-action listener: _resource_record_pre_action 17:44:01 INFO - Running main action method: clobber 17:44:01 INFO - rmtree: /builds/slave/test/build 17:44:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:44:01 INFO - Running post-action listener: _resource_record_post_action 17:44:01 INFO - [mozharness: 2016-09-29 00:44:01.962073Z] Finished clobber step (success) 17:44:01 INFO - [mozharness: 2016-09-29 00:44:01.962173Z] Running read-buildbot-config step. 17:44:01 INFO - Running pre-action listener: _resource_record_pre_action 17:44:01 INFO - Running main action method: read_buildbot_config 17:44:01 INFO - Using buildbot properties: 17:44:01 INFO - { 17:44:01 INFO - "project": "", 17:44:01 INFO - "product": "firefox", 17:44:01 INFO - "script_repo_revision": "production", 17:44:01 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 17:44:01 INFO - "repository": "", 17:44:01 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 17:44:01 INFO - "buildid": "20160928162520", 17:44:01 INFO - "pgo_build": "False", 17:44:01 INFO - "basedir": "/builds/slave/test", 17:44:01 INFO - "buildnumber": 561, 17:44:01 INFO - "slavename": "talos-linux64-ix-036", 17:44:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:44:01 INFO - "platform": "ubuntu64_hw", 17:44:01 INFO - "scheduler": "tests-autoland-linux64-talos", 17:44:01 INFO - "branch": "autoland", 17:44:01 INFO - "repo_path": "integration/autoland", 17:44:01 INFO - "revision": "199c73e2737df4e74dce37cfa1d139f0ed873f02", 17:44:01 INFO - "stage_platform": "linux64", 17:44:01 INFO - "builduid": "af2bd9bdef7f44ce946c12af2f812843", 17:44:01 INFO - "slavebuilddir": "test" 17:44:01 INFO - } 17:44:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 17:44:01 INFO - Running post-action listener: _resource_record_post_action 17:44:01 INFO - [mozharness: 2016-09-29 00:44:01.964604Z] Finished read-buildbot-config step (success) 17:44:01 INFO - [mozharness: 2016-09-29 00:44:01.964693Z] Running download-and-extract step. 17:44:01 INFO - Running pre-action listener: _resource_record_pre_action 17:44:01 INFO - Running main action method: download_and_extract 17:44:01 INFO - mkdir: /builds/slave/test/build/tests 17:44:01 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')]} 17:44:01 INFO - trying https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:44:01 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:44:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 17:44:02 INFO - Downloaded 1361 bytes. 17:44:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 17:44:02 INFO - Using the following test package requirements: 17:44:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:44:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:44:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 17:44:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:02 INFO - u'jsshell-linux-x86_64.zip'], 17:44:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:44:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 17:44:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:44:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:44:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:44:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 17:44:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:44:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:44:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:44:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:44:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:44:03 INFO - Http code: 200 17:44:03 INFO - Content-Encoding: None 17:44:03 INFO - Content-Type: application/zip 17:44:03 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 17:44:03 INFO - x-amz-cf-id: OpkdpTARojITPD7nRedXHSUbT1fsbuBAT0qI1oBGvBg566zryyf5nQ== 17:44:03 INFO - x-amz-version-id: G6Le8nRqBIScwyzgeZjwfzPGtHnGOWPM 17:44:03 INFO - x-cache: Hit from cloudfront 17:44:03 INFO - Expected file size: 20415804 17:44:03 INFO - Obtained file size: 20415804 17:44:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 17:44:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 17:44:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 17:44:07 INFO - Fetch https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 17:44:08 INFO - Http code: 200 17:44:08 INFO - Content-Encoding: None 17:44:08 INFO - Content-Type: application/zip 17:44:08 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 17:44:08 INFO - x-amz-cf-id: UT7hZCInLb-vDgCRbNhHsxGZM7Daw6bVk2pxumbHDgRypNxOdwEIbQ== 17:44:08 INFO - x-amz-version-id: G6Le8nRqBIScwyzgeZjwfzPGtHnGOWPM 17:44:08 INFO - x-cache: Hit from cloudfront 17:44:08 INFO - Expected file size: 20415804 17:44:08 INFO - Obtained file size: 20415804 17:44:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 17:44:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 17:44:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 17:44:13 INFO - Http code: 200 17:44:13 INFO - Content-Encoding: None 17:44:13 INFO - Content-Type: application/zip 17:44:13 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 17:44:13 INFO - x-amz-cf-id: ontK_KG1bGQCbE1KMf8yWgz9iudrIHKQd-KeQeQyYAV8Z76numKmpA== 17:44:13 INFO - x-amz-version-id: sWPQYe3gH9Oo9FKCEI3baQzzfwd65DID 17:44:13 INFO - x-cache: Hit from cloudfront 17:44:13 INFO - Expected file size: 14414067 17:44:13 INFO - Obtained file size: 14414067 17:44:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:13 INFO - trying https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:44:13 INFO - Downloading https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:44:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 17:44:14 INFO - Downloaded 55740404 bytes. 17:44:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:44:14 INFO - mkdir: /builds/slave/test/properties 17:44:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:44:14 INFO - Writing to file /builds/slave/test/properties/build_url 17:44:14 INFO - Contents: 17:44:14 INFO - build_url:https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 17:44:15 INFO - Running post-action listener: _resource_record_post_action 17:44:15 INFO - Running post-action listener: set_extra_try_arguments 17:44:15 INFO - [mozharness: 2016-09-29 00:44:15.490653Z] Finished download-and-extract step (success) 17:44:15 INFO - [mozharness: 2016-09-29 00:44:15.490878Z] Running populate-webroot step. 17:44:15 INFO - Running pre-action listener: _resource_record_pre_action 17:44:15 INFO - Running main action method: populate_webroot 17:44:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:44:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:44:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:44:15 INFO - '--tppagecycles', 17:44:15 INFO - '7'], 17:44:15 INFO - 'tests': ['tsvgm']}}, 17:44:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:44:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:44:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:44:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:44:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:15 INFO - 'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:44:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:15 INFO - 'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['damp', 'tps']}, 17:44:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:15 INFO - 'tests': ['damp', 'tps']}, 17:44:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['dromaeo_dom']}, 17:44:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:44:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['basic_compositor_video']}, 17:44:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:44:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['a11yr', 17:44:15 INFO - 'ts_paint', 17:44:15 INFO - 'tpaint', 17:44:15 INFO - 'sessionrestore', 17:44:15 INFO - 'sessionrestore_no_auto_restore', 17:44:15 INFO - 'tabpaint']}, 17:44:15 INFO - 'other-e10s': {'tests': ['a11yr', 17:44:15 INFO - 'ts_paint', 17:44:15 INFO - 'tpaint', 17:44:15 INFO - 'sessionrestore', 17:44:15 INFO - 'sessionrestore_no_auto_restore', 17:44:15 INFO - 'tabpaint']}, 17:44:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:44:15 INFO - 'ts_paint', 17:44:15 INFO - 'tpaint', 17:44:15 INFO - 'sessionrestore', 17:44:15 INFO - 'sessionrestore_no_auto_restore', 17:44:15 INFO - 'tabpaint']}, 17:44:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:44:15 INFO - 'ts_paint', 17:44:15 INFO - 'tpaint', 17:44:15 INFO - 'sessionrestore', 17:44:15 INFO - 'sessionrestore_no_auto_restore', 17:44:15 INFO - 'tabpaint']}, 17:44:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['a11yr', 17:44:15 INFO - 'ts_paint', 17:44:15 INFO - 'tpaint', 17:44:15 INFO - 'sessionrestore', 17:44:15 INFO - 'sessionrestore_no_auto_restore', 17:44:15 INFO - 'tabpaint']}, 17:44:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['a11yr', 17:44:15 INFO - 'ts_paint', 17:44:15 INFO - 'tpaint', 17:44:15 INFO - 'sessionrestore', 17:44:15 INFO - 'sessionrestore_no_auto_restore', 17:44:15 INFO - 'tabpaint']}, 17:44:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['tsvgx', 17:44:15 INFO - 'tsvgr_opacity', 17:44:15 INFO - 'tart', 17:44:15 INFO - 'tscrollx', 17:44:15 INFO - 'cart']}, 17:44:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:44:15 INFO - 'tsvgr_opacity', 17:44:15 INFO - 'tart', 17:44:15 INFO - 'tscrollx', 17:44:15 INFO - 'cart']}, 17:44:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:15 INFO - 'talos_options': ['--disable-e10s'], 17:44:15 INFO - 'tests': ['tp5o']}, 17:44:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:15 INFO - 'tests': ['tp5o']}, 17:44:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:15 INFO - 'talos_options': ['--disable-e10s', 17:44:15 INFO - '--xperf_path', 17:44:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:15 INFO - 'tests': ['tp5n']}, 17:44:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:44:15 INFO - 'talos_options': ['--xperf_path', 17:44:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:44:15 INFO - 'tests': ['tp5n']}}, 17:44:15 INFO - 'talos.zip': {'path': '', 17:44:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:44:15 INFO - Running post-action listener: _resource_record_post_action 17:44:15 INFO - [mozharness: 2016-09-29 00:44:15.513174Z] Finished populate-webroot step (success) 17:44:15 INFO - [mozharness: 2016-09-29 00:44:15.513262Z] Running create-virtualenv step. 17:44:15 INFO - Running pre-action listener: _resource_record_pre_action 17:44:15 INFO - Running main action method: create_virtualenv 17:44:15 INFO - Creating virtualenv /builds/slave/test/build/venv 17:44:15 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 17:44:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:44:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:44:15 INFO - Using real prefix '/usr' 17:44:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:44:16 INFO - Installing distribute.............................................................................................................................................................................................done. 17:44:18 INFO - Installing pip.................done. 17:44:18 INFO - Return code: 0 17:44:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:44:18 INFO - Reading from file tmpfile_stdout 17:44:18 INFO - Output received: 17:44:18 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) 17:44:18 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07ab200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', '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 17:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:44:18 INFO - Using env: {'DISPLAY': ':0', 17:44:18 INFO - 'HOME': '/home/cltbld', 17:44:18 INFO - 'LANG': 'en_US.UTF-8', 17:44:18 INFO - 'LANGUAGE': 'en_US:en', 17:44:18 INFO - 'LOGNAME': 'cltbld', 17:44:18 INFO - 'MAIL': '/var/mail/cltbld', 17:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:18 INFO - 'MOZ_NO_REMOTE': '1', 17:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:18 INFO - 'NO_EM_RESTART': '1', 17:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:18 INFO - 'PWD': '/builds/slave/test', 17:44:18 INFO - 'SHELL': '/bin/bash', 17:44:18 INFO - 'SHLVL': '1', 17:44:18 INFO - 'TERM': 'linux', 17:44:18 INFO - 'TMOUT': '86400', 17:44:18 INFO - 'USER': 'cltbld', 17:44:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:18 INFO - '_': '/tools/buildbot/bin/python'} 17:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:18 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 17:44:18 INFO - Cleaning up... 17:44:18 INFO - Return code: 0 17:44:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f07ab200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', '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 17:44:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:44:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:44:18 INFO - Using env: {'DISPLAY': ':0', 17:44:18 INFO - 'HOME': '/home/cltbld', 17:44:18 INFO - 'LANG': 'en_US.UTF-8', 17:44:18 INFO - 'LANGUAGE': 'en_US:en', 17:44:18 INFO - 'LOGNAME': 'cltbld', 17:44:18 INFO - 'MAIL': '/var/mail/cltbld', 17:44:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:18 INFO - 'MOZ_NO_REMOTE': '1', 17:44:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:18 INFO - 'NO_EM_RESTART': '1', 17:44:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:18 INFO - 'PWD': '/builds/slave/test', 17:44:18 INFO - 'SHELL': '/bin/bash', 17:44:18 INFO - 'SHLVL': '1', 17:44:18 INFO - 'TERM': 'linux', 17:44:18 INFO - 'TMOUT': '86400', 17:44:18 INFO - 'USER': 'cltbld', 17:44:18 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:18 INFO - '_': '/tools/buildbot/bin/python'} 17:44:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:18 INFO - Downloading/unpacking psutil>=3.1.1 17:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:44:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:44:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:44:20 INFO - Installing collected packages: psutil 17:44:20 INFO - Running setup.py install for psutil 17:44:20 INFO - building 'psutil._psutil_linux' extension 17:44:20 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 17:44:20 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 17:44:20 INFO - building 'psutil._psutil_posix' extension 17:44:20 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 17:44:21 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 17:44:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:44:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:44:21 INFO - Successfully installed psutil 17:44:21 INFO - Cleaning up... 17:44:21 INFO - Return code: 0 17:44:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:44:21 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')]} 17:44:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:21 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')]} 17:44:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:21 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 0x7f07ab200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', '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 17:44:21 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 17:44:21 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 17:44:21 INFO - Using env: {'DISPLAY': ':0', 17:44:21 INFO - 'HOME': '/home/cltbld', 17:44:21 INFO - 'LANG': 'en_US.UTF-8', 17:44:21 INFO - 'LANGUAGE': 'en_US:en', 17:44:21 INFO - 'LOGNAME': 'cltbld', 17:44:21 INFO - 'MAIL': '/var/mail/cltbld', 17:44:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:21 INFO - 'MOZ_NO_REMOTE': '1', 17:44:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:21 INFO - 'NO_EM_RESTART': '1', 17:44:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:21 INFO - 'PWD': '/builds/slave/test', 17:44:21 INFO - 'SHELL': '/bin/bash', 17:44:21 INFO - 'SHLVL': '1', 17:44:21 INFO - 'TERM': 'linux', 17:44:21 INFO - 'TMOUT': '86400', 17:44:21 INFO - 'USER': 'cltbld', 17:44:21 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:21 INFO - '_': '/tools/buildbot/bin/python'} 17:44:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:44:21 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 17:44:21 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 17:44:21 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 17:44:21 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 17:44:21 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 17:44:21 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 17:44:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:44:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:44:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:44:23 INFO - Installing collected packages: mozsystemmonitor 17:44:23 INFO - Running setup.py install for mozsystemmonitor 17:44:23 INFO - Successfully installed mozsystemmonitor 17:44:23 INFO - Cleaning up... 17:44:23 INFO - Return code: 0 17:44:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f07ab200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', '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 17:44:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:44:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:44:23 INFO - Using env: {'DISPLAY': ':0', 17:44:23 INFO - 'HOME': '/home/cltbld', 17:44:23 INFO - 'LANG': 'en_US.UTF-8', 17:44:23 INFO - 'LANGUAGE': 'en_US:en', 17:44:23 INFO - 'LOGNAME': 'cltbld', 17:44:23 INFO - 'MAIL': '/var/mail/cltbld', 17:44:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:23 INFO - 'MOZ_NO_REMOTE': '1', 17:44:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:23 INFO - 'NO_EM_RESTART': '1', 17:44:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:23 INFO - 'PWD': '/builds/slave/test', 17:44:23 INFO - 'SHELL': '/bin/bash', 17:44:23 INFO - 'SHLVL': '1', 17:44:23 INFO - 'TERM': 'linux', 17:44:23 INFO - 'TMOUT': '86400', 17:44:23 INFO - 'USER': 'cltbld', 17:44:23 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:23 INFO - '_': '/tools/buildbot/bin/python'} 17:44:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:23 INFO - Downloading/unpacking jsonschema==2.5.1 17:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:44:25 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:25 INFO - Downloading functools32-3.2.3-2.tar.gz 17:44:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:44:25 INFO - warning: no files found matching '*.txt' 17:44:25 INFO - no previously-included directories found matching 'build' 17:44:25 INFO - no previously-included directories found matching 'dist' 17:44:25 INFO - no previously-included directories found matching '.git*' 17:44:25 INFO - Installing collected packages: jsonschema, functools32 17:44:26 INFO - Running setup.py install for functools32 17:44:26 INFO - warning: no files found matching '*.txt' 17:44:26 INFO - no previously-included directories found matching 'build' 17:44:26 INFO - no previously-included directories found matching 'dist' 17:44:26 INFO - no previously-included directories found matching '.git*' 17:44:26 INFO - Successfully installed jsonschema functools32 17:44:26 INFO - Cleaning up... 17:44:26 INFO - Return code: 0 17:44:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:44:26 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')]} 17:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:26 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')]} 17:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:26 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 0x7f07ab200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', '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 17:44:26 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 17:44:26 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 17:44:26 INFO - Using env: {'DISPLAY': ':0', 17:44:26 INFO - 'HOME': '/home/cltbld', 17:44:26 INFO - 'LANG': 'en_US.UTF-8', 17:44:26 INFO - 'LANGUAGE': 'en_US:en', 17:44:26 INFO - 'LOGNAME': 'cltbld', 17:44:26 INFO - 'MAIL': '/var/mail/cltbld', 17:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:26 INFO - 'MOZ_NO_REMOTE': '1', 17:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:26 INFO - 'NO_EM_RESTART': '1', 17:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:26 INFO - 'PWD': '/builds/slave/test', 17:44:26 INFO - 'SHELL': '/bin/bash', 17:44:26 INFO - 'SHLVL': '1', 17:44:26 INFO - 'TERM': 'linux', 17:44:26 INFO - 'TMOUT': '86400', 17:44:26 INFO - 'USER': 'cltbld', 17:44:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:26 INFO - '_': '/tools/buildbot/bin/python'} 17:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:26 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:44:26 INFO - Cleaning up... 17:44:26 INFO - Return code: 0 17:44:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:44:26 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')]} 17:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:26 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')]} 17:44:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:26 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 0x7f07ab200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', '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 17:44:26 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 17:44:26 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 17:44:26 INFO - Using env: {'DISPLAY': ':0', 17:44:26 INFO - 'HOME': '/home/cltbld', 17:44:26 INFO - 'LANG': 'en_US.UTF-8', 17:44:26 INFO - 'LANGUAGE': 'en_US:en', 17:44:26 INFO - 'LOGNAME': 'cltbld', 17:44:26 INFO - 'MAIL': '/var/mail/cltbld', 17:44:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:26 INFO - 'MOZ_NO_REMOTE': '1', 17:44:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:26 INFO - 'NO_EM_RESTART': '1', 17:44:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:26 INFO - 'PWD': '/builds/slave/test', 17:44:26 INFO - 'SHELL': '/bin/bash', 17:44:26 INFO - 'SHLVL': '1', 17:44:26 INFO - 'TERM': 'linux', 17:44:26 INFO - 'TMOUT': '86400', 17:44:26 INFO - 'USER': 'cltbld', 17:44:26 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:26 INFO - '_': '/tools/buildbot/bin/python'} 17:44:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:26 INFO - Downloading/unpacking blobuploader==1.2.4 17:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:44:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:44:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:44:28 INFO - Downloading blobuploader-1.2.4.tar.gz 17:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:44:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:44:28 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 17:44:28 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 17:44:28 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 17:44:28 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 17:44:28 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 17:44:28 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 17:44:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:44:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:44:29 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 17:44:29 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 17:44:29 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 17:44:29 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 17:44:29 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 17:44:29 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 17:44:29 INFO - Downloading docopt-0.6.1.tar.gz 17:44:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:44:29 INFO - Installing collected packages: blobuploader, requests, docopt 17:44:29 INFO - Running setup.py install for blobuploader 17:44:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:44:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:44:29 INFO - Running setup.py install for requests 17:44:29 INFO - Running setup.py install for docopt 17:44:29 INFO - Successfully installed blobuploader requests docopt 17:44:29 INFO - Cleaning up... 17:44:29 INFO - Return code: 0 17:44:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44: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')]} 17:44:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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')]} 17:44:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:29 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 0x7f07ab200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', '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 17:44:29 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 17:44:29 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 17:44:29 INFO - Using env: {'DISPLAY': ':0', 17:44:29 INFO - 'HOME': '/home/cltbld', 17:44:29 INFO - 'LANG': 'en_US.UTF-8', 17:44:29 INFO - 'LANGUAGE': 'en_US:en', 17:44:29 INFO - 'LOGNAME': 'cltbld', 17:44:29 INFO - 'MAIL': '/var/mail/cltbld', 17:44:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:29 INFO - 'MOZ_NO_REMOTE': '1', 17:44:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:29 INFO - 'NO_EM_RESTART': '1', 17:44:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:29 INFO - 'PWD': '/builds/slave/test', 17:44:29 INFO - 'SHELL': '/bin/bash', 17:44:29 INFO - 'SHLVL': '1', 17:44:29 INFO - 'TERM': 'linux', 17:44:29 INFO - 'TMOUT': '86400', 17:44:29 INFO - 'USER': 'cltbld', 17:44:29 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:29 INFO - '_': '/tools/buildbot/bin/python'} 17:44:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:30 INFO - Running setup.py (path:/tmp/pip-4DHSb1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:30 INFO - Running setup.py (path:/tmp/pip-bgAatD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:30 INFO - Running setup.py (path:/tmp/pip-jjyGjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:30 INFO - Running setup.py (path:/tmp/pip-ezh3b5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:30 INFO - Running setup.py (path:/tmp/pip-w7WCQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:30 INFO - Running setup.py (path:/tmp/pip-LqLpc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:30 INFO - Running setup.py (path:/tmp/pip-ssyaM7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:30 INFO - Running setup.py (path:/tmp/pip-I6r_Lm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:30 INFO - Running setup.py (path:/tmp/pip-Xms5lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:30 INFO - Running setup.py (path:/tmp/pip-1Y0wS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:30 INFO - Running setup.py (path:/tmp/pip-8oSVu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:30 INFO - Running setup.py (path:/tmp/pip-ejECp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:31 INFO - Running setup.py (path:/tmp/pip-RN_X7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:31 INFO - Running setup.py (path:/tmp/pip-0hXW61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:31 INFO - Running setup.py (path:/tmp/pip-2wGnP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:31 INFO - Running setup.py (path:/tmp/pip-8wFhdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:31 INFO - Running setup.py (path:/tmp/pip-1Tuuyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:44:31 INFO - Running setup.py install for manifestparser 17:44:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:44:31 INFO - Running setup.py install for mozcrash 17:44:31 INFO - Running setup.py install for mozdebug 17:44:31 INFO - Running setup.py install for mozdevice 17:44:31 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:44:31 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:44:31 INFO - Running setup.py install for mozfile 17:44:31 INFO - Running setup.py install for mozhttpd 17:44:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:44:31 INFO - Running setup.py install for mozinfo 17:44:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Running setup.py install for mozInstall 17:44:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Running setup.py install for mozleak 17:44:32 INFO - Running setup.py install for mozlog 17:44:32 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Running setup.py install for moznetwork 17:44:32 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Running setup.py install for mozprocess 17:44:32 INFO - Running setup.py install for mozprofile 17:44:32 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Running setup.py install for mozrunner 17:44:32 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:44:32 INFO - Running setup.py install for mozscreenshot 17:44:32 INFO - Running setup.py install for moztest 17:44:33 INFO - Running setup.py install for mozversion 17:44:33 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:44:33 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:44:33 INFO - Cleaning up... 17:44:33 INFO - Return code: 0 17:44:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:44:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:33 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 0x7f07ab200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', '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 17:44:33 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 17:44:33 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 17:44:33 INFO - Using env: {'DISPLAY': ':0', 17:44:33 INFO - 'HOME': '/home/cltbld', 17:44:33 INFO - 'LANG': 'en_US.UTF-8', 17:44:33 INFO - 'LANGUAGE': 'en_US:en', 17:44:33 INFO - 'LOGNAME': 'cltbld', 17:44:33 INFO - 'MAIL': '/var/mail/cltbld', 17:44:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:33 INFO - 'MOZ_NO_REMOTE': '1', 17:44:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:33 INFO - 'NO_EM_RESTART': '1', 17:44:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:33 INFO - 'PWD': '/builds/slave/test', 17:44:33 INFO - 'SHELL': '/bin/bash', 17:44:33 INFO - 'SHLVL': '1', 17:44:33 INFO - 'TERM': 'linux', 17:44:33 INFO - 'TMOUT': '86400', 17:44:33 INFO - 'USER': 'cltbld', 17:44:33 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:33 INFO - '_': '/tools/buildbot/bin/python'} 17:44:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:44:33 INFO - Running setup.py (path:/tmp/pip-d3FtBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:44:33 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)) 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:44:33 INFO - Running setup.py (path:/tmp/pip-DE7sVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:44:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:44:33 INFO - Running setup.py (path:/tmp/pip-_LD7Gs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:44:33 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)) 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:44:33 INFO - Running setup.py (path:/tmp/pip-5iogjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:44:33 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)) 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:44:33 INFO - Running setup.py (path:/tmp/pip-ps272M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:44:33 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)) 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:44:33 INFO - Running setup.py (path:/tmp/pip-dHiy9p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:44:33 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)) 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:44:33 INFO - Running setup.py (path:/tmp/pip-czvLGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:44:33 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)) 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:44:33 INFO - Running setup.py (path:/tmp/pip-_zLONZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:44:33 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)) 17:44:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:44:33 INFO - Running setup.py (path:/tmp/pip-u7uFTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:44:34 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)) 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:44:34 INFO - Running setup.py (path:/tmp/pip-DwWHC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:44:34 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)) 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:44:34 INFO - Running setup.py (path:/tmp/pip-70xngD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:44:34 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)) 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:44:34 INFO - Running setup.py (path:/tmp/pip-52Ik3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:44:34 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)) 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:44:34 INFO - Running setup.py (path:/tmp/pip-EvL68w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:44:34 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)) 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:44:34 INFO - Running setup.py (path:/tmp/pip-IqDLzv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:34 INFO - Running setup.py (path:/tmp/pip-FngE8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:44:34 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)) 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:44:34 INFO - Running setup.py (path:/tmp/pip-V8pJHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:44:34 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)) 17:44:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:44:34 INFO - Running setup.py (path:/tmp/pip-CpudvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:44:34 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)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 17:44:34 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)) 17:44:34 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)) 17:44:34 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)) 17:44:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44: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 17:44:36 INFO - Downloading blessings-1.6.tar.gz 17:44:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:44:36 INFO - Installing collected packages: blessings 17:44:36 INFO - Running setup.py install for blessings 17:44:36 INFO - Successfully installed blessings 17:44:36 INFO - Cleaning up... 17:44:36 INFO - Return code: 0 17:44:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:44:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:36 INFO - Reading from file tmpfile_stdout 17:44:36 INFO - Current package versions: 17:44:36 INFO - argparse == 1.2.1 17:44:36 INFO - blessings == 1.6 17:44:36 INFO - blobuploader == 1.2.4 17:44:36 INFO - docopt == 0.6.1 17:44:36 INFO - functools32 == 3.2.3-2 17:44:36 INFO - jsonschema == 2.5.1 17:44:36 INFO - manifestparser == 1.1 17:44:36 INFO - mozInstall == 1.12 17:44:36 INFO - mozcrash == 0.17 17:44:36 INFO - mozdebug == 0.1 17:44:36 INFO - mozdevice == 0.48 17:44:36 INFO - mozfile == 1.2 17:44:36 INFO - mozhttpd == 0.7 17:44:36 INFO - mozinfo == 0.9 17:44:36 INFO - mozleak == 0.1 17:44:36 INFO - mozlog == 3.4 17:44:36 INFO - moznetwork == 0.27 17:44:36 INFO - mozprocess == 0.23 17:44:36 INFO - mozprofile == 0.28 17:44:36 INFO - mozrunner == 6.12 17:44:36 INFO - mozscreenshot == 0.1 17:44:36 INFO - mozsystemmonitor == 0.3 17:44:36 INFO - moztest == 0.7 17:44:36 INFO - mozversion == 1.4 17:44:36 INFO - psutil == 3.1.1 17:44:36 INFO - requests == 1.2.3 17:44:36 INFO - wsgiref == 0.1.2 17:44:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:44:36 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')]} 17:44:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:36 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')]} 17:44:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44:36 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 0x7f07ab200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', '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 17:44:36 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 17:44:36 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 17:44:36 INFO - Using env: {'DISPLAY': ':0', 17:44:36 INFO - 'HOME': '/home/cltbld', 17:44:36 INFO - 'LANG': 'en_US.UTF-8', 17:44:36 INFO - 'LANGUAGE': 'en_US:en', 17:44:36 INFO - 'LOGNAME': 'cltbld', 17:44:36 INFO - 'MAIL': '/var/mail/cltbld', 17:44:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:36 INFO - 'MOZ_NO_REMOTE': '1', 17:44:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:36 INFO - 'NO_EM_RESTART': '1', 17:44:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:36 INFO - 'PWD': '/builds/slave/test', 17:44:36 INFO - 'SHELL': '/bin/bash', 17:44:36 INFO - 'SHLVL': '1', 17:44:36 INFO - 'TERM': 'linux', 17:44:36 INFO - 'TMOUT': '86400', 17:44:36 INFO - 'USER': 'cltbld', 17:44:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:36 INFO - '_': '/tools/buildbot/bin/python'} 17:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:37 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)) 17:44:37 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)) 17:44:37 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)) 17:44:37 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)) 17:44:37 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)) 17:44:37 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)) 17:44:37 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)) 17:44:37 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)) 17:44:37 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)) 17:44:37 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)) 17:44:37 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)) 17:44:37 INFO - Cleaning up... 17:44:37 INFO - Return code: 0 17:44:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:44: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')]} 17:44:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:44:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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')]} 17:44:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:44:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:44: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f07ab200f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe688a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf35ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, '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': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', '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 17:44: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', 'jsonschema'] in /builds/slave/test/build 17:44: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 jsonschema 17:44:37 INFO - Using env: {'DISPLAY': ':0', 17:44:37 INFO - 'HOME': '/home/cltbld', 17:44:37 INFO - 'LANG': 'en_US.UTF-8', 17:44:37 INFO - 'LANGUAGE': 'en_US:en', 17:44:37 INFO - 'LOGNAME': 'cltbld', 17:44:37 INFO - 'MAIL': '/var/mail/cltbld', 17:44:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:37 INFO - 'MOZ_NO_REMOTE': '1', 17:44:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:37 INFO - 'NO_EM_RESTART': '1', 17:44:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:37 INFO - 'PWD': '/builds/slave/test', 17:44:37 INFO - 'SHELL': '/bin/bash', 17:44:37 INFO - 'SHLVL': '1', 17:44:37 INFO - 'TERM': 'linux', 17:44:37 INFO - 'TMOUT': '86400', 17:44:37 INFO - 'USER': 'cltbld', 17:44:37 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:37 INFO - '_': '/tools/buildbot/bin/python'} 17:44:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:44:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:44:37 INFO - Cleaning up... 17:44:37 INFO - Return code: 0 17:44:37 INFO - Running post-action listener: _resource_record_post_action 17:44:37 INFO - Running post-action listener: _start_resource_monitoring 17:44:37 INFO - Starting resource monitoring. 17:44:37 INFO - [mozharness: 2016-09-29 00:44:37.479524Z] Finished create-virtualenv step (success) 17:44:37 INFO - [mozharness: 2016-09-29 00:44:37.479977Z] Running install step. 17:44:37 INFO - Running pre-action listener: _resource_record_pre_action 17:44:37 INFO - Running main action method: install 17:44:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:44:37 INFO - Reading from file tmpfile_stdout 17:44:37 INFO - Detecting whether we're running mozinstall >=1.0... 17:44:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:44:37 INFO - Reading from file tmpfile_stdout 17:44:37 INFO - Output received: 17:44:37 INFO - Usage: mozinstall [options] installer 17:44:37 INFO - Options: 17:44:37 INFO - -h, --help show this help message and exit 17:44:37 INFO - -d DEST, --destination=DEST 17:44:37 INFO - Directory to install application into. [default: 17:44:37 INFO - "/builds/slave/test"] 17:44:37 INFO - --app=APP Application being installed. [default: firefox] 17:44:37 INFO - mkdir: /builds/slave/test/build/application 17:44:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 17:44:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 17:44:53 INFO - Reading from file tmpfile_stdout 17:44:53 INFO - Output received: 17:44:53 INFO - /builds/slave/test/build/application/firefox/firefox 17:44:53 INFO - Running post-action listener: _resource_record_post_action 17:44:53 INFO - [mozharness: 2016-09-29 00:44:53.886184Z] Finished install step (success) 17:44:53 INFO - [mozharness: 2016-09-29 00:44:53.886428Z] Running run-tests step. 17:44:53 INFO - Running pre-action listener: _resource_record_pre_action 17:44:53 INFO - Running main action method: run_tests 17:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:44:53 INFO - Python 2.7.3 17:44:53 INFO - Return code: 0 17:44:53 INFO - grabbing minidump binary from tooltool 17:44: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')]} 17:44:53 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 0xf32f60>, '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 0xf33d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf341d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:44:53 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 17:44:53 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 17:44:53 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 17:44:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:44:53 INFO - Return code: 0 17:44:53 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:44:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:44:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:44:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:44:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:44:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 17:44:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-036 --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 17:44:53 INFO - Using env: {'DISPLAY': ':0', 17:44:53 INFO - 'HOME': '/home/cltbld', 17:44:53 INFO - 'LANG': 'en_US.UTF-8', 17:44:53 INFO - 'LANGUAGE': 'en_US:en', 17:44:53 INFO - 'LOGNAME': 'cltbld', 17:44:53 INFO - 'MAIL': '/var/mail/cltbld', 17:44:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:44:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:44:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:44:53 INFO - 'MOZ_NO_REMOTE': '1', 17:44:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:44:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:44:53 INFO - 'NO_EM_RESTART': '1', 17:44:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:44:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:44:53 INFO - 'PWD': '/builds/slave/test', 17:44:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:44:53 INFO - 'SHELL': '/bin/bash', 17:44:53 INFO - 'SHLVL': '1', 17:44:53 INFO - 'TERM': 'linux', 17:44:53 INFO - 'TMOUT': '86400', 17:44:53 INFO - 'USER': 'cltbld', 17:44:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722', 17:44:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:44:53 INFO - '_': '/tools/buildbot/bin/python'} 17:44:53 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--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 17:44:54 INFO - mozversion application_buildid: 20160928162520 17:44:54 INFO - mozversion application_changeset: 199c73e2737df4e74dce37cfa1d139f0ed873f02 17:44:54 INFO - mozversion application_display_name: Nightly 17:44:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:44:54 INFO - mozversion application_name: Firefox 17:44:54 INFO - mozversion application_remotingname: firefox 17:44:54 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 17:44:54 INFO - mozversion application_vendor: Mozilla 17:44:54 INFO - mozversion application_version: 52.0a1 17:44:54 INFO - mozversion platform_buildid: 20160928162520 17:44:54 INFO - mozversion platform_changeset: 199c73e2737df4e74dce37cfa1d139f0ed873f02 17:44:54 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 17:44:54 INFO - mozversion platform_version: 52.0a1 17:44:54 INFO - using testdate: 1475109894 17:44:54 INFO - actual date: 1475109894 17:44:54 INFO - starting webserver on 'localhost:53455' 17:44:54 INFO - SUITE-START | Running 2 tests 17:44:54 INFO - TEST-START | dromaeo_css 17:44:54 INFO - operating with platform_type : linux_ 17:44:54 INFO - Initialising browser for dromaeo_css test... 17:44:54 INFO - TEST-INFO | started process 1884 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOFs0sS/profile http://localhost:53455/getInfo.html) 17:44:58 INFO - PROCESS | 1884 | __metrics Screen width/height:1600/1200 17:44:58 INFO - PROCESS | 1884 | colorDepth:24 17:44:58 INFO - PROCESS | 1884 | Browser inner width/height: 1024/697 17:44:58 INFO - PROCESS | 1884 | __metrics 17:44:59 INFO - PROCESS | 1884 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:44:59 INFO - PROCESS | 1884 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:45:00 INFO - PROCESS | 1884 | console.error: PushService: 17:45:00 INFO - PROCESS | 1884 | stateChangeProcessEnqueue: Error transitioning state 17:45:00 INFO - PROCESS | 1884 | UnknownError 17:45:00 INFO - TEST-INFO | 1884: exit 0 17:45:00 INFO - Browser initialized. 17:45:00 INFO - Running cycle 1/1 for dromaeo_css test... 17:45:00 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOFs0sS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:13 INFO - PROCESS | 1967 | RSS: Main: 175239168 17:45:13 INFO - PROCESS | 1967 | 17:46:04 INFO - PROCESS | 1967 | 1475109964604 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] 17:48:16 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53455/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53455/tests/dromaeo/cssquery-ext.html) 17:48:18 INFO - PROCESS | 1967 | RSS: Main: 267976704 17:48:18 INFO - PROCESS | 1967 | 17:51:20 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53455/tests/dromaeo/cssquery-ext.html (next: http://localhost:53455/tests/dromaeo/cssquery-jquery.html) 17:51:21 INFO - PROCESS | 1967 | RSS: Main: 275881984 17:51:21 INFO - PROCESS | 1967 | 17:54:23 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53455/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53455/tests/dromaeo/cssquery-mootools.html) 17:54:24 INFO - PROCESS | 1967 | RSS: Main: 220876800 17:54:24 INFO - PROCESS | 1967 | 17:57:26 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53455/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53455/tests/dromaeo/cssquery-prototype.html) 17:57:27 INFO - PROCESS | 1967 | RSS: Main: 219443200 17:57:27 INFO - PROCESS | 1967 | 18:00:30 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53455/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53455/tests/dromaeo/cssquery-yui.html) 18:00:30 INFO - PROCESS | 1967 | RSS: Main: 219975680 18:00:30 INFO - PROCESS | 1967 | 18:03:33 INFO - PROCESS | 1967 | Cycle 1(1): loaded http://localhost:53455/tests/dromaeo/cssquery-yui.html (next: http://localhost:53455/tests/dromaeo/cssquery-dojo.html) 18:03:34 INFO - PROCESS | 1967 | RSS: Main: 310317056 18:03:34 INFO - PROCESS | 1967 | 18:03:34 INFO - PROCESS | 1967 | __start_tp_report 18:03:34 INFO - PROCESS | 1967 | _x_x_mozilla_page_load 18:03:34 INFO - PROCESS | 1967 | _x_x_mozilla_page_load_details 18:03:34 INFO - PROCESS | 1967 | |i|pagename|runs| 18:03:34 INFO - PROCESS | 1967 | |0;dojo.html;2549.311685844822;2552.3619095226195;2604.6353510508525;2608.3479130217447;2622.5017246723132;4539.296409056601;4603.585677289043;4704.788284527201;4705.905881882364;4711.599514041306;4621.861344159681;4699.694519856207;4744.4306683198065;4770.356001939737;4821.807127714896;4226.830926762926;4259.659227261827;4311;4330.480342358921;4331.7617531035785;4349.7390156590545;4424.159409712161;4455.576720211591;4467.41923549938;4510.436195475566;4397.274449715793;4400.361947517608;4435.157320109185;4438.622717069021;4471.23988921884;4272.166927449149;4316.028893498969;4318.805653745589;4330.047389574289;4334.523202447728;4373.978130109329;4383.408239887606;4422.314541246112;4431.933520997188;4432.623227025707;4727.4163155343;4760.833370832004;4779.044191161782;4788.4253889533475;4839.7096174229655;4851.733154676492;4895.926561101586;4896.1186986342445;5102.4897510248675;5105.2086926526445;4984.77568509418;4992.87517812054;4998.700077995332;4999.275105109775;5000.174971129759;4613.0773845230415;4637.907241855178;4643.791029403685;4646.186917289495;4657.417822772153;5116.872078198075;5122.615803814729;5133.332666753298;5188.558972487305;5191.117510023305;4859.319695242669;4894.853154405374;4896.755162241873;4903.436104847917;4967.90064198714;4904.2643603459765;4935.111679897581;4950.653454258168;4975.975120124449;4977.328060711758;4892.730899800546;4989.376327959005;5039.042581909425;5046.116929537389;5051.621128415383;4959.578435832923;4970.329005584272;4973.055119527278;4974.925376119361;5025.120603894304;4162.354835000579;4197.097624010852;4254.3831144483875;4258.87223383299;4305.095929854766;3700.0749812546865;3712.1090938174643;3726.459663348799;3743.2139250757646;3789.1285004449132;4297.333913243452;4303.397524346594;4312.245357062501;4314.56854314566;4361.847335343247;5112.335396398519;5114.28400023997;5117.923231151536;5119.436861945183;5173.896522069537;4216.051388437577;4269.743815371087;4279.443672322641;4316.330968699856;4325.43769309994;4592.2193227151465;4593.28804035375;4599.7470139142;4623.884402889955;4655.557722016403;4756.120117778222;4756.16767065769;4761.738104404221;4807.831725889577;4822.71063736177;4939.604831613534;5014.749262536931;5030.0945829749535;5119.0273847968765;5122.667026643406;4698.412698412699;4716.410448693913;4723.811047558059;4781.521847815191;4788.880277993078;4983.875403114806;4987.0524600325825;4988.301637770787;4991.80032798684;5055.87360315995;4913.533214344631;4924.507549245047;5038.798448062036;5044.167712327425;5103.285540024473;4865.9756701216265;4892.902141957212;4907.509249075064;4922.680025798311;4986.975065124651;4892.877678058077;4911.950880491292;4920.21276595743;4924.704517728947;4948.851534453972;4657.4643915948745;4843.636727245541;4849.684770489906;4902.754862256944;4903.681260718042;4779.283107533898;4832;4878.658493905393;4889.682170658896;4963.131451995959;4835.6131509478455;4847.442544107332;4850.587700045395;4851.854444366674;4911.926321105258 18:03:34 INFO - PROCESS | 1967 | |1;ext.html;557.2560631556873;561.5900392713319;564.9661020338777;569.8917205730911;574.9913751293732;28081.43837123256;28854.278643033933;31126.68873311269;37013.814930925306;38258;39228.21543569127;39651;39666.603333966654;39690.801545992304;39709.801450992774;7571.6214189290595;7714.151443341228;7717.575533345664;7717.6912923483;7718.536887786723;7520.285572870568;7608.505447145945;7609.315161635452;7611.581363025031;7613.771586852404;7564.357029652459;7612.961935190317;7614.809629759245;7628.732994345199;7633.0458692663415;7618.314351708345;7636.541807491568;7641.656125474367;7654.234576542357;7666.233376662345;7270.745523906638;7320.633968301617;7323.121225452926;7335.743248986313;7342.5227360221415;37299;37457.43813842795;37490.68782592596;37534.8123259382;37583;2848.84331361775;3004.7746419018663;3215.8070515768895;3241.918952026195;3566.32239874423;25893.611595826078;25894.611580826302;25971.740282597122;26669.73330266711;27425.588616170775;3310.35448087623;3375.4261775498226;3461.705755010827;3499.982500087509;3536.6286539913194;192874;253164;253259;253695;254182.72908635525;30098.247543811143;30989.845050775053;52999;53652.73173634107;53690.77855328693;32286.515702264485;32727.345453091282;32752;32753.83623081917;32791;11966.401679915969;12052;12087.274763514217;12087.939560302319;12090.758184836253;9804.852927206097;9871.358361706467;9882.80234395308;9883.505824708736;9888.851667224997;7686.3082322591235;7689.807754806175;7767.883481747778;7770.572618505923;7773.883391749128;3019.5017822059554;3060.892868749583;3062;3068.324968506925;3078.107348868803;824.2664029014182;864.5504337744463;866.787637028932;887.2192470625808;931.59475628102;26731.33171670724;26776.59835102475;27482.725172748018;27634.585481217797;28113.57829632557;778.8014056415577;965.4641673870929;995.5619527408062;1000.4193374468323;1041.994790026045;12640.30478323701;13592.184468931895;13631.318434078456;13761.793573096411;13818.309084545934;371500;373805;373913;374488;375341;47351;47803;47851;48025.27962080572;48104.759476202395;1048.8531605575226;1083.3608171179042;1107.2415395453818;1137.5336112194127;1171.472837223253;25442.236732898044;28108.71891281061;28488.253064688957;29042.27394315159;29086.56370154407;35596.644033559336;35606.10984725299;35608;35625.82187089048;35888.10279743027;297327;298114;298273;298322;298528;21680.566388672454;21876.45308867291;22184.445388865406;22358.88820555887;24610.630840537764;40735.796321018206;40837.38743918784;40889.59110408977;40980.3852942212;41066.178676425705;35412;35690.28619427649;35717;35817.1045723859;35966.640333596326;35193.29613407769;35275.82362088276;35425;35429.114272142375;35762;34572.30855382828;34918.47622285617;35042.824785875906;35219.647803521635;35847.64152358547;30036.699633004264;32009.35981280408;32062.83968580142;32580;32848;24642.260732178063;24725.89905111238;24824.503509929338;25074.34340405284;25294.367640809127 18:03:34 INFO - PROCESS | 1967 | |2;jquery.html;336.1679842390083;350.7106637024454;351.8170551313317;355.86832871837424;379.0372453966924;12365.156014116747;15479.690406191869;16305.103219322948;16325.428609998653;17403;14433;14445.783313250284;14527.636809079779;14679.926600367009;14687.559373218794;4872.951270487294;5111.795528178868;5113.2074528447965;5116.411612664554;5119.948800511985;4068.837246510136;5917.171595976567;5958.5828991970575;6054.51563874889;6057.30341010785;5158.097332966716;6008.7296071676665;6018.097285407202;6018.7893423730175;6023.488003519684;5344.732763361836;5532.640378375393;5535.750891209906;5537.556995440355;5538.861528461821;5133.178691409356;5237.8428647140645;5253.816116435906;5365.382980957201;5369.3556773187465;11597.942010289978;11850.525978960832;11868.940655296754;11870.52517899283;11884.524619015228;1806.087925597565;1887.5375532994503;2083.5832833433374;2191.9150020739676;2359.1978727232654;8597.656093756243;8949.328800340001;9336.39313444624;9363.812723745486;9533.856992145124;1658.4858693804958;1722.5702666786663;1768.9027103509302;1769.619531800669;1772.1139430284857;70348;71991.64004179946;72129;72313.99999999948;73164.6341768293;9386.15524602789;9570.176797844653;9657.855132173023;9684.225261979165;9725.638410622518;12968.870311296954;12986.610401687965;13012.739745205043;13018.544350947861;13032.674183145496;6666.866662666816;6823.965880170666;6841.350071743176;7025.7189712411955;7059.470539709542;6515.7067931943175;6541.705623246965;6692.665366731741;6693.5943451875655;6705.932940670628;4064.7561146331313;4165.396017577435;4167.416561681367;4255.744655320691;4273.487181538173;1707.8548323392401;1711.9144042797811;1732.0300631646066;1735.7049301618756;1776.3693888669336;810.5866008335673;821.8479581277483;826.3802148388709;883.8143989762093;890.0076414797584;16098;16716.414925477795;17301.394451194148;17357;17593;776.8951191589176;791.7901756034655;793.9126696063429;814.9022117345838;828.4118276024091;8692.608832602547;9029.593668284942;9038.909610903938;9218.446893186296;9782.902170978341;372470;375891;387724;389022;389397;45424.54575454269;53889.46110538923;72123;74070;75585.24414755891;833.7623777223462;834.899812022549;846.517485033525;860.4536119564121;881.352206128495;14566.880277180688;14754.336054877771;14818.925905370405;14992.475263366166;15070.849291506944;33337.832500987395;33913.3217335647;36459.27081458409;36622.8168859154;36940.63059369372;48475.75762121167;48649;49054.50945490642;49540.25689614587;49647;7050.400715939202;7246;7335.303146201102;7373.5575865448245;7560.697572097274;8601.483910965111;10890.94554527254;11491.54033838637;11780.941095294469;11862.644120676394;9345.392549484262;9780.41317520951;9794.314397992357;10533.736656583647;10872.293300935415;9794.314397992071;10067.848982265125;10069.949650251701;10289.588416463557;10463.267571269938;10256.743581410226;10481.42352170638;10488.26582139243;10743.871893451074;10794.838077428687;7110.217876033736;7192.712291508281;7275.417966562556;7339.376153027052;7603.2776886195725;8536.44513106646;10260.640877569249;10262.384256944608;10446.320989135682;10786 18:03:34 INFO - PROCESS | 1967 | |3;mootools.html;1204.9819252711206;1356.9999999999998;1379.379279324304;1432.2194404049792;1634.6245004066602;6833.3508316709895;7561.584112873797;7816.882746758789;7829.686812527492;8069.677212911476;7917.841643167133;7980.760577182694;7985.4010949178755;7986.4010199235;7986.440949133563;2155.5150091229507;2179.1065663078143;2179.858309209896;2181.4873504726374;2184.159098746986;2046.6827641715558;2078.1998930411823;2087.03996161765;2106.8314534837177;2109.504266497372;2019.1216820682976;2053.4558342039372;2069.9586008279825;2079.511314841011;2083.4895450614545;2003.7294965179806;2016;2017.9697304540443;2023.8684485508543;2024.5748392837522;1968.2127149140315;1974.7235387045826;2001.3095482058666;2007.1569940624972;2008.2067583304658;7671.53970761756;7717.459777815555;7864.567448790314;7930.6431210595665;7959.243871832166;4222.2611043067645;4368.279233926399;4386.627136693385;4387.583179597965;4389.978050109729;2738.8493632850186;2838.4748821468093;2859.7140285971445;2896.174590241771;2898.2754311422145;945.6501094594975;946.9195118414943;950.6387572722322;953.9427634341962;982.1210017034714;10633.468326583717;10739;10753.247272690836;10755;10829.404382758867;3893.3381325174223;3953.110550126256;4043.6562892154498;4066.1461093170765;4095.1809638072505;8340.541270230196;8512.489250644981;8513.616887240089;8515.403921725543;8517.403781735344;4254.446921900133;4254.510731265944;4254.914901702011;4255.744655320691;4256.2551553478015;3616.782993020427;3729.533808273966;3842.3083844908183;3917.9020524486546;3922.843086276574;3202.8078315301154;3223.1458663454205;3309.9007029789145;3343.6823501767294;3346.28054968183;936.5879013234155;945.7610530205316;947.7441090905417;955.1546881010217;965.2229954886244;843.8692002739585;861.961211745473;870.8911386076741;871.5816408124009;874.8381549413378;5136.4606716295;5324.946750532523;5325.147976323769;5328.0675881720545;5329.467053294717;382.36336499728196;391.37966323377765;393.1998383290048;399.4427773256291;400.50737592761067;3531.646835316448;3622.2031153146268;3758.473813666089;3823.3559569384875;3940.822662980173;9304.813903721888;9567.521623918916;9687.70936871895;9697.6120955161;9705.951470242604;8973.50645714479;9383.343165978316;9509.5720692569;9565.521723913776;9664.275179361575;6813.625250611165;6996.405305549085;6998.930010699828;7006.894896576454;7012.088428504262;5278.313819203479;5335.546478549367;5411.594130440311;5450.8909821802545;5495.505404513613;8670.91329086701;8758.03661597211;8803.735887923373;8925.196732294125;9003.189712925607;8889.599968001326;8988.10118988096;9040.68357607507;9064.138906803842;9080.137386948229;6039.214902062704;6798.76204332846;6987.441004719712;6991.965040174767;6993.965030174817;6649.567778094409;6832.726690932307;7046.436285097077;7059.223485416497;7250.20247772734;6103.176071230327;6413.038044293393;6443.903341449788;6450.064740612679;6585.6377899216;6236.18929539157;6277.717502712298;6280.026595877646;6300.338464461165;6319.020551814476;6022.066579680157;6114.266288045463;6142.262928448615;6142.447179753844;6143.416375444325;4480.955190448054;4532.9093418132115;4545;4585.12882552314;4648.65135114861;4500.109953819469;4547.454305483231;4547.545245475559;4623.075384922961;4724.834630787906 18:03:34 INFO - PROCESS | 1967 | |4;prototype.html;279.95380762174244;290.7470500664422;291.5044424478386;294.2100460264191;296.9480340940335;4833.661643684939;4856.854294371175;4858.51414858514;4881.8291359802415;4896.265560165977;4813.205821039524;4823.758812059392;4844.128056949748;4844.4913284105105;4863.392075990501;3818.6945044396452;3823.655870971612;3845.576986531479;3846.7114966377494;3854.4989151410277;3711.5546134463902;3852;3856.4986551748234;3857.3442514772414;3868.1103346230384;3768.152165762695;3792.431135329695;3795.924081518368;3796.2597293527633;3802.6007269236748;3762.191128907271;3777.9811100944594;3792.4121761126794;3801.220749746309;3817.4655548223272;3132.483140281851;3251.9674803252137;3320.352531256406;3329.184349834282;3329.7502687298547;4568.680192386534;4694.08465349257;4697.271922851964;4701.365315682373;4714.669973101884;4296.312589985619;4309.547497512747;4334.176506463762;4353.193424728734;4354.129174165179;4935.679180853233;4972.975135124301;5019.623528235397;5035.823746168867;5051.924221136685;3627.365211088049;3633.2370202257293;3639.581448133472;3643.8178091095338;3643.8360273787744;5178.275041494194;5184.948150518484;5208.973955130238;5236.319278493809;5242.397124330674;3705.166337574024;3717.925641487155;3733.9253214935547;3748.1004558905665;3751.099736063325;3659.1766852457986;3787.5833658297565;3803.782789507331;3805.200907809391;3816.1795214029116;4264.914701705949;4270.380794784739;4270.850520231839;4295.29127693927;4305.5048669402795;4949.529794669501;4990.276409920614;4990.452959582541;4993.726599717049;4994.650374473825;1261.4827920552714;1306.4186437035428;1306.5231190615357;1318.4792007157118;1323.8676132386877;843.8649816029406;856.3021137772695;861.9225967540574;865;871.1680345270379;3904.531456225271;3909.354956432214;3921.2353591049473;3946.4080387941463;3958.980205098956;4541.751018469947;4556.681032327771;4585.701929374647;4586.495485496593;4603.95396046042;3872.7289089763444;3888.6305800948867;3916.686665066788;3921.1569512554365;3924.3132451820816;2461.360046387916;2466.8273220874726;2544.98727506365;2744.7529722325085;2758.434520923206;4560.908781824345;4674.953250467452;4701.905961880811;4795.688280261842;4855.198892182751;5251.369835619674;5276;5314.5748340132695;5330.081170778517;5348.91976620351;4793.849476125704;4816.8554943351755;4829.1790395632825;4886.877828054327;4890.557285600757;4976.30331753562;5094.745262736774;5125.8718532037;5149.356330458692;5150.484951504969;5050.595952323879;5051.2423136529815;5058.898822023465;5067.77195026232;5073.6955782651685;4796.544328288807;4823.421189457287;4832.637552183671;4844.563989240985;4846.660733748604;3438.484227365915;3651.8539258429364;3656.4149736042104;3685.723570732152;3706.7590606610484;5180.663256888291;5195.960363187578;5211.71335576547;5221.973890130525;5230.13702739059;5031.6226283029655;5040.57155141817;5052.621053420935;5061.987602479592;5067;4902.259697807227;4968.826091086795;4990.326305948795;4990.351254336913;4991.9001619966675;4925.21196608541;4929.950700493093;4930.112579735682;4933.383327084114;4942.382202224722;5007.724575148256;5023.397192336943;5032.6980381177245;5038.949610503848;5046.722430266371;4733.408323959505;4874.829380971649;4887.853364399074;4900.730459824744;4901.656884018084 18:03:34 INFO - PROCESS | 1967 | |5;yui.html;586.7887560478227;639.1595052505958;704.1057856522214;722.2741145149126;725.5356571794049;12635.431405586747;12877.162984406019;13347.466101355934;13576.796348054788;13952.511662091829;13289.468421263162;13321.400536975834;13360.933195334033;13424.261665608388;13435.596932092052;719.4532155561758;744.2408743082053;748.7678819565925;749.6589051981335;751.6467260387609;604.9001914684094;623.3517142172158;721.2643104033882;743.9888401673979;749.0150452155425;770.734096736625;771.3482107619053;772.382094324541;772.9072511298624;774.9496282741632;764.5718397697308;767.8195624028349;770.1797585571377;770.5607803551977;772.1467778105197;464.57723471640645;473.37514480885244;552.1937970562983;566.9886602267932;568.9886202275973;12364.258144511268;12392.256464612063;12403.62789116328;12413.379331033413;12414.068944829083;11864.940675296655;12564.81152782709;12635.74728505434;12764.744705105939;13215.141015834037;11850.822237666442;11992.64022079339;12074.818877716842;12179.573714919936;12474.313912734797;3949.1311911379453;3963.583823698499;3981.3231750602467;4165.937510937339;4195.958040419588;66412;67111.328886711;68031.31968680349;68557.65721171362;68616.6569167156;9237.815243695222;9387.10822471864;10043.497825108716;10361.430121343248;10412.531436085394;17843.37548185807;18149.364772233173;18242.543936401697;18294.542636434195;18297.634047319247;6634.568753031038;6708.161479815023;6786.083878676414;6895.896561551481;7137.750178743719;3454.170998960282;3527.100589349751;3551.538300020981;3561.358955388055;3684.207895302523;2810.3114736889183;2918.255844759573;2922.6054482644995;2926.429346277498;2930.120963710878;516.7235528991971;526.494565217388;527.8416475057544;530.6285600079959;537.2398056749734;504.46274717425825;537.7418838957323;537.7902617978991;537.9166229234474;543.9673619582837;7364.2635736427;7476.1776204617445;7748.4188685848785;7772.300492955661;8038.276555109951;464.6561544457077;509.6559822120054;551.4595696217729;553.8255449533384;573.1402895656515;3557.537520122419;3712.238991006891;3805.6955443564448;3809.2762375149186;3828.5405751309463;55698.49356778873;65351.673241633485;85398.14601853902;110304;110481.44759276153;84122.79386030675;94190.52904735433;95049;95762.52118739362;95849;76595.61702191565;79704;81347.5932620345;82339;82402.17597824064;7174.354308112086;7182.102237220348;7420.962895185706;7492.438067144877;7754.6898124074405;44739.77630111828;45962;46038.769806150754;47242.52757472519;47835.76082119567;45494.54505454903;65447.672761635884;66350.33649663441;67058.66470667615;68091.3190868085;8790.472571645721;9364.438133712;9369.765755856159;9488.762780930532;9845.31082824224;10202.642907498499;10401.791964160522;10470.685879423629;10521.21090918169;10753.301035432673;8542.74371768848;8781.077986811293;8830.602622882114;8962.238209752244;9272.58273377686;9909.801803963735;10033.498325083863;10593.788124237319;10727.570897164025;10901.890981090404;10647.520861561094;10797.676069717922;10985.121190304597;11012.669619911416;11306.378149201873;8914.37599368064;9426.198773104363;9608.27937904646;9636.807263854824;9670.758231044;8649.697260595849;8961.476548986819;9027.23268522183;9413.199878010446;9893.208543316661 18:03:34 INFO - PROCESS | 1967 | __end_tp_report 18:03:34 INFO - PROCESS | 1967 | __start_cc_report 18:03:34 INFO - PROCESS | 1967 | _x_x_mozilla_cycle_collect,1126 18:03:34 INFO - PROCESS | 1967 | __end_cc_report 18:03:34 INFO - PROCESS | 1967 | __startTimestamp1475111014163__endTimestamp 18:03:34 INFO - PROCESS | 1967 | 18:03:34 INFO - PROCESS | 1967 | ------- Summary: start ------- 18:03:34 INFO - PROCESS | 1967 | Number of tests: 6 18:03:34 INFO - PROCESS | 1967 | 18:03:34 INFO - PROCESS | 1967 | [#0] dojo.html Cycles:165 Average:4651.74 Median:4788.88 stddev:487.24 (10.2%) stddev-sans-first:459.97 18:03:34 INFO - PROCESS | 1967 | Values: 2549.3 2552.4 2604.6 2608.3 2622.5 4539.3 4603.6 4704.8 4705.9 4711.6 4621.9 4699.7 4744.4 4770.4 4821.8 4226.8 4259.7 4311.0 4330.5 4331.8 4349.7 4424.2 4455.6 4467.4 4510.4 4397.3 4400.4 4435.2 4438.6 4471.2 4272.2 4316.0 4318.8 4330.0 4334.5 4374.0 4383.4 4422.3 4431.9 4432.6 4727.4 4760.8 4779.0 4788.4 4839.7 4851.7 4895.9 4896.1 5102.5 5105.2 4984.8 4992.9 4998.7 4999.3 5000.2 4613.1 4637.9 4643.8 4646.2 4657.4 5116.9 5122.6 5133.3 5188.6 5191.1 4859.3 4894.9 4896.8 4903.4 4967.9 4904.3 4935.1 4950.7 4976.0 4977.3 4892.7 4989.4 5039.0 5046.1 5051.6 4959.6 4970.3 4973.1 4974.9 5025.1 4162.4 4197.1 4254.4 4258.9 4305.1 3700.1 3712.1 3726.5 3743.2 3789.1 4297.3 4303.4 4312.2 4314.6 4361.8 5112.3 5114.3 5117.9 5119.4 5173.9 4216.1 4269.7 4279.4 4316.3 4325.4 4592.2 4593.3 4599.7 4623.9 4655.6 4756.1 4756.2 4761.7 4807.8 4822.7 4939.6 5014.7 5030.1 5119.0 5122.7 4698.4 4716.4 4723.8 4781.5 4788.9 4983.9 4987.1 4988.3 4991.8 5055.9 4913.5 4924.5 5038.8 5044.2 5103.3 4866.0 4892.9 4907.5 4922.7 4987.0 4892.9 4912.0 4920.2 4924.7 4948.9 4657.5 4843.6 4849.7 4902.8 4903.7 4779.3 4832.0 4878.7 4889.7 4963.1 4835.6 4847.4 4850.6 4851.9 4911.9 18:03:34 INFO - PROCESS | 1967 | 18:03:34 INFO - PROCESS | 1967 | [#1] ext.html Cycles:180 Average:44055.01 Median:35601.38 stddev:81708.40 (229.5%) stddev-sans-first:81872.34 18:03:34 INFO - PROCESS | 1967 | Values: 557.3 561.6 565.0 569.9 575.0 28081.4 28854.3 31126.7 37013.8 38258.0 39228.2 39651.0 39666.6 39690.8 39709.8 7571.6 7714.2 7717.6 7717.7 7718.5 7520.3 7608.5 7609.3 7611.6 7613.8 7564.4 7613.0 7614.8 7628.7 7633.0 7618.3 7636.5 7641.7 7654.2 7666.2 7270.7 7320.6 7323.1 7335.7 7342.5 37299.0 37457.4 37490.7 37534.8 37583.0 2848.8 3004.8 3215.8 3241.9 3566.3 25893.6 25894.6 25971.7 26669.7 27425.6 3310.4 3375.4 3461.7 3500.0 3536.6 192874.0 253164.0 253259.0 253695.0 254182.7 30098.2 30989.8 52999.0 53652.7 53690.8 32286.5 32727.3 32752.0 32753.8 32791.0 11966.4 12052.0 12087.3 12087.9 12090.8 9804.9 9871.4 9882.8 9883.5 9888.9 7686.3 7689.8 7767.9 7770.6 7773.9 3019.5 3060.9 3062.0 3068.3 3078.1 824.3 864.6 866.8 887.2 931.6 26731.3 26776.6 27482.7 27634.6 28113.6 778.8 965.5 995.6 1000.4 1042.0 12640.3 13592.2 13631.3 13761.8 13818.3 371500.0 373805.0 373913.0 374488.0 375341.0 47351.0 47803.0 47851.0 48025.3 48104.8 1048.9 1083.4 1107.2 1137.5 1171.5 25442.2 28108.7 28488.3 29042.3 29086.6 35596.6 35606.1 35608.0 35625.8 35888.1 297327.0 298114.0 298273.0 298322.0 298528.0 21680.6 21876.5 22184.4 22358.9 24610.6 40735.8 40837.4 40889.6 40980.4 41066.2 35412.0 35690.3 35717.0 35817.1 35966.6 35193.3 35275.8 35425.0 35429.1 35762.0 34572.3 34918.5 35042.8 35219.6 35847.6 30036.7 32009.4 32062.8 32580.0 32848.0 24642.3 24725.9 24824.5 25074.3 25294.4 18:03:34 INFO - PROCESS | 1967 | 18:03:34 INFO - PROCESS | 1967 | [#2] jquery.html Cycles:180 Average:23280.34 Median:49593.63 stddev:63142.12 (127.3%) stddev-sans-first:63295.75 18:03:34 INFO - PROCESS | 1967 | Values: 336.2 350.7 351.8 355.9 379.0 12365.2 15479.7 16305.1 16325.4 17403.0 14433.0 14445.8 14527.6 14679.9 14687.6 4873.0 5111.8 5113.2 5116.4 5119.9 4068.8 5917.2 5958.6 6054.5 6057.3 5158.1 6008.7 6018.1 6018.8 6023.5 5344.7 5532.6 5535.8 5537.6 5538.9 5133.2 5237.8 5253.8 5365.4 5369.4 11597.9 11850.5 11868.9 11870.5 11884.5 1806.1 1887.5 2083.6 2191.9 2359.2 8597.7 8949.3 9336.4 9363.8 9533.9 1658.5 1722.6 1768.9 1769.6 1772.1 70348.0 71991.6 72129.0 72314.0 73164.6 9386.2 9570.2 9657.9 9684.2 9725.6 12968.9 12986.6 13012.7 13018.5 13032.7 6666.9 6824.0 6841.4 7025.7 7059.5 6515.7 6541.7 6692.7 6693.6 6705.9 4064.8 4165.4 4167.4 4255.7 4273.5 1707.9 1711.9 1732.0 1735.7 1776.4 810.6 821.8 826.4 883.8 890.0 16098.0 16716.4 17301.4 17357.0 17593.0 776.9 791.8 793.9 814.9 828.4 8692.6 9029.6 9038.9 9218.4 9782.9 372470.0 375891.0 387724.0 389022.0 389397.0 45424.5 53889.5 72123.0 74070.0 75585.2 833.8 834.9 846.5 860.5 881.4 14566.9 14754.3 14818.9 14992.5 15070.8 33337.8 33913.3 36459.3 36622.8 36940.6 48475.8 48649.0 49054.5 49540.3 49647.0 7050.4 7246.0 7335.3 7373.6 7560.7 8601.5 10890.9 11491.5 11780.9 11862.6 9345.4 9780.4 9794.3 10533.7 10872.3 9794.3 10067.8 10069.9 10289.6 10463.3 10256.7 10481.4 10488.3 10743.9 10794.8 7110.2 7192.7 7275.4 7339.4 7603.3 8536.4 10260.6 10262.4 10446.3 10786.0 18:03:34 INFO - PROCESS | 1967 | 18:03:34 INFO - PROCESS | 1967 | [#3] mootools.html Cycles:180 Average:5000.22 Median:5332.51 stddev:2878.99 (54.0%) stddev-sans-first:2872.94 18:03:34 INFO - PROCESS | 1967 | Values: 1205.0 1357.0 1379.4 1432.2 1634.6 6833.4 7561.6 7816.9 7829.7 8069.7 7917.8 7980.8 7985.4 7986.4 7986.4 2155.5 2179.1 2179.9 2181.5 2184.2 2046.7 2078.2 2087.0 2106.8 2109.5 2019.1 2053.5 2070.0 2079.5 2083.5 2003.7 2016.0 2018.0 2023.9 2024.6 1968.2 1974.7 2001.3 2007.2 2008.2 7671.5 7717.5 7864.6 7930.6 7959.2 4222.3 4368.3 4386.6 4387.6 4390.0 2738.8 2838.5 2859.7 2896.2 2898.3 945.7 946.9 950.6 953.9 982.1 10633.5 10739.0 10753.2 10755.0 10829.4 3893.3 3953.1 4043.7 4066.1 4095.2 8340.5 8512.5 8513.6 8515.4 8517.4 4254.4 4254.5 4254.9 4255.7 4256.3 3616.8 3729.5 3842.3 3917.9 3922.8 3202.8 3223.1 3309.9 3343.7 3346.3 936.6 945.8 947.7 955.2 965.2 843.9 862.0 870.9 871.6 874.8 5136.5 5324.9 5325.1 5328.1 5329.5 382.4 391.4 393.2 399.4 400.5 3531.6 3622.2 3758.5 3823.4 3940.8 9304.8 9567.5 9687.7 9697.6 9706.0 8973.5 9383.3 9509.6 9565.5 9664.3 6813.6 6996.4 6998.9 7006.9 7012.1 5278.3 5335.5 5411.6 5450.9 5495.5 8670.9 8758.0 8803.7 8925.2 9003.2 8889.6 8988.1 9040.7 9064.1 9080.1 6039.2 6798.8 6987.4 6992.0 6994.0 6649.6 6832.7 7046.4 7059.2 7250.2 6103.2 6413.0 6443.9 6450.1 6585.6 6236.2 6277.7 6280.0 6300.3 6319.0 6022.1 6114.3 6142.3 6142.4 6143.4 4481.0 4532.9 4545.0 4585.1 4648.7 4500.1 4547.5 4547.5 4623.1 4724.8 18:03:34 INFO - PROCESS | 1967 | 18:03:34 INFO - PROCESS | 1967 | [#4] prototype.html Cycles:180 Average:4134.40 Median:4701.64 stddev:1197.65 (25.5%) stddev-sans-first:1165.54 18:03:34 INFO - PROCESS | 1967 | Values: 280.0 290.7 291.5 294.2 296.9 4833.7 4856.9 4858.5 4881.8 4896.3 4813.2 4823.8 4844.1 4844.5 4863.4 3818.7 3823.7 3845.6 3846.7 3854.5 3711.6 3852.0 3856.5 3857.3 3868.1 3768.2 3792.4 3795.9 3796.3 3802.6 3762.2 3778.0 3792.4 3801.2 3817.5 3132.5 3252.0 3320.4 3329.2 3329.8 4568.7 4694.1 4697.3 4701.4 4714.7 4296.3 4309.5 4334.2 4353.2 4354.1 4935.7 4973.0 5019.6 5035.8 5051.9 3627.4 3633.2 3639.6 3643.8 3643.8 5178.3 5184.9 5209.0 5236.3 5242.4 3705.2 3717.9 3733.9 3748.1 3751.1 3659.2 3787.6 3803.8 3805.2 3816.2 4264.9 4270.4 4270.9 4295.3 4305.5 4949.5 4990.3 4990.5 4993.7 4994.7 1261.5 1306.4 1306.5 1318.5 1323.9 843.9 856.3 861.9 865.0 871.2 3904.5 3909.4 3921.2 3946.4 3959.0 4541.8 4556.7 4585.7 4586.5 4604.0 3872.7 3888.6 3916.7 3921.2 3924.3 2461.4 2466.8 2545.0 2744.8 2758.4 4560.9 4675.0 4701.9 4795.7 4855.2 5251.4 5276.0 5314.6 5330.1 5348.9 4793.8 4816.9 4829.2 4886.9 4890.6 4976.3 5094.7 5125.9 5149.4 5150.5 5050.6 5051.2 5058.9 5067.8 5073.7 4796.5 4823.4 4832.6 4844.6 4846.7 3438.5 3651.9 3656.4 3685.7 3706.8 5180.7 5196.0 5211.7 5222.0 5230.1 5031.6 5040.6 5052.6 5062.0 5067.0 4902.3 4968.8 4990.3 4990.4 4991.9 4925.2 4930.0 4930.1 4933.4 4942.4 5007.7 5023.4 5032.7 5038.9 5046.7 4733.4 4874.8 4887.9 4900.7 4901.7 18:03:34 INFO - PROCESS | 1967 | 18:03:34 INFO - PROCESS | 1967 | [#5] yui.html Cycles:180 Average:17722.56 Median:553.01 stddev:26164.03 (4731.2%) stddev-sans-first:26205.79 18:03:34 INFO - PROCESS | 1967 | Values: 586.8 639.2 704.1 722.3 725.5 12635.4 12877.2 13347.5 13576.8 13952.5 13289.5 13321.4 13360.9 13424.3 13435.6 719.5 744.2 748.8 749.7 751.6 604.9 623.4 721.3 744.0 749.0 770.7 771.3 772.4 772.9 774.9 764.6 767.8 770.2 770.6 772.1 464.6 473.4 552.2 567.0 569.0 12364.3 12392.3 12403.6 12413.4 12414.1 11864.9 12564.8 12635.7 12764.7 13215.1 11850.8 11992.6 12074.8 12179.6 12474.3 3949.1 3963.6 3981.3 4165.9 4196.0 66412.0 67111.3 68031.3 68557.7 68616.7 9237.8 9387.1 10043.5 10361.4 10412.5 17843.4 18149.4 18242.5 18294.5 18297.6 6634.6 6708.2 6786.1 6895.9 7137.8 3454.2 3527.1 3551.5 3561.4 3684.2 2810.3 2918.3 2922.6 2926.4 2930.1 516.7 526.5 527.8 530.6 537.2 504.5 537.7 537.8 537.9 544.0 7364.3 7476.2 7748.4 7772.3 8038.3 464.7 509.7 551.5 553.8 573.1 3557.5 3712.2 3805.7 3809.3 3828.5 55698.5 65351.7 85398.1 110304.0 110481.4 84122.8 94190.5 95049.0 95762.5 95849.0 76595.6 79704.0 81347.6 82339.0 82402.2 7174.4 7182.1 7421.0 7492.4 7754.7 44739.8 45962.0 46038.8 47242.5 47835.8 45494.5 65447.7 66350.3 67058.7 68091.3 8790.5 9364.4 9369.8 9488.8 9845.3 10202.6 10401.8 10470.7 10521.2 10753.3 8542.7 8781.1 8830.6 8962.2 9272.6 9909.8 10033.5 10593.8 10727.6 10901.9 10647.5 10797.7 10985.1 11012.7 11306.4 8914.4 9426.2 9608.3 9636.8 9670.8 8649.7 8961.5 9027.2 9413.2 9893.2 18:03:34 INFO - PROCESS | 1967 | -------- Summary: end -------- 18:03:34 INFO - PROCESS | 1967 | 18:03:35 INFO - TEST-INFO | 1967: exit 0 18:03:35 INFO - TEST-OK | dromaeo_css | took 1121011ms 18:03:35 INFO - TEST-START | kraken 18:03:35 INFO - operating with platform_type : linux_ 18:03:35 INFO - Initialising browser for kraken test... 18:03:35 INFO - TEST-INFO | started process 2268 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmparasWh/profile http://localhost:53455/getInfo.html) 18:03:39 INFO - PROCESS | 2268 | __metrics Screen width/height:1600/1200 18:03:39 INFO - PROCESS | 2268 | colorDepth:24 18:03:39 INFO - PROCESS | 2268 | Browser inner width/height: 1024/697 18:03:39 INFO - PROCESS | 2268 | __metrics 18:03:40 INFO - PROCESS | 2268 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:03:40 INFO - PROCESS | 2268 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:03:40 INFO - PROCESS | 2268 | console.error: PushService: 18:03:40 INFO - PROCESS | 2268 | stateChangeProcessEnqueue: Error transitioning state 18:03:40 INFO - PROCESS | 2268 | UnknownError 18:03:41 INFO - TEST-INFO | 2268: exit 0 18:03:41 INFO - Browser initialized. 18:03:41 INFO - Running cycle 1/1 for kraken test... 18:03:41 INFO - TEST-INFO | started process 2352 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmparasWh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:03:53 INFO - PROCESS | 2352 | RSS: Main: 177807360 18:03:53 INFO - PROCESS | 2352 | 18:03:56 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53455/tests/kraken/driver.html?testName=audio-beat-detection) 18:03:57 INFO - PROCESS | 2352 | RSS: Main: 234172416 18:03:57 INFO - PROCESS | 2352 | 18:04:00 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53455/tests/kraken/driver.html?testName=audio-dft) 18:04:00 INFO - PROCESS | 2352 | RSS: Main: 219529216 18:04:00 INFO - PROCESS | 2352 | 18:04:04 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53455/tests/kraken/driver.html?testName=audio-fft) 18:04:04 INFO - PROCESS | 2352 | RSS: Main: 301166592 18:04:04 INFO - PROCESS | 2352 | 18:04:07 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53455/tests/kraken/driver.html?testName=audio-oscillator) 18:04:07 INFO - PROCESS | 2352 | RSS: Main: 210833408 18:04:07 INFO - PROCESS | 2352 | 18:04:09 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53455/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:04:10 INFO - PROCESS | 2352 | RSS: Main: 213987328 18:04:10 INFO - PROCESS | 2352 | 18:04:13 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53455/tests/kraken/driver.html?testName=imaging-darkroom) 18:04:14 INFO - PROCESS | 2352 | RSS: Main: 251068416 18:04:14 INFO - PROCESS | 2352 | 18:04:17 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53455/tests/kraken/driver.html?testName=imaging-desaturate) 18:04:18 INFO - PROCESS | 2352 | RSS: Main: 244744192 18:04:18 INFO - PROCESS | 2352 | 18:04:21 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53455/tests/kraken/driver.html?testName=json-parse-financial) 18:04:21 INFO - PROCESS | 2352 | RSS: Main: 248270848 18:04:21 INFO - PROCESS | 2352 | 18:04:23 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53455/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:04:24 INFO - PROCESS | 2352 | RSS: Main: 211623936 18:04:24 INFO - PROCESS | 2352 | 18:04:26 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53455/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:04:26 INFO - PROCESS | 2352 | RSS: Main: 218669056 18:04:26 INFO - PROCESS | 2352 | 18:04:28 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53455/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:04:29 INFO - PROCESS | 2352 | RSS: Main: 222892032 18:04:29 INFO - PROCESS | 2352 | 18:04:32 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:04:33 INFO - PROCESS | 2352 | RSS: Main: 223461376 18:04:33 INFO - PROCESS | 2352 | 18:04:36 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:04:36 INFO - PROCESS | 2352 | RSS: Main: 222236672 18:04:36 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | Cycle 1(1): loaded http://localhost:53455/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53455/tests/kraken/driver.html?testName=ai-astar) 18:04:38 INFO - PROCESS | 2352 | RSS: Main: 273227776 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | __start_tp_report 18:04:38 INFO - PROCESS | 2352 | _x_x_mozilla_page_load 18:04:38 INFO - PROCESS | 2352 | _x_x_mozilla_page_load_details 18:04:38 INFO - PROCESS | 2352 | |i|pagename|runs| 18:04:38 INFO - PROCESS | 2352 | |0;ai-astar;112;114;115;114;113;114;113;113;113;113 18:04:38 INFO - PROCESS | 2352 | |1;audio-beat-detection;158;123;134;173;127;127;126;129;159;123 18:04:38 INFO - PROCESS | 2352 | |2;audio-dft;162;162;163;162;162;163;164;162;163;161 18:04:38 INFO - PROCESS | 2352 | |3;audio-fft;75;77;76;115;76;77;77;75;106;76 18:04:38 INFO - PROCESS | 2352 | |4;audio-oscillator;85;83;134;85;84;84;105;85;84;121 18:04:38 INFO - PROCESS | 2352 | |5;imaging-gaussian-blur;118;117;117;117;116;117;117;116;117;118 18:04:38 INFO - PROCESS | 2352 | |6;imaging-darkroom;148;149;148;146;146;147;146;146;146;146 18:04:38 INFO - PROCESS | 2352 | |7;imaging-desaturate;95;96;95;95;95;95;94;95;95;95 18:04:38 INFO - PROCESS | 2352 | |8;json-parse-financial;65;64;64;64;65;66;65;65;65;65 18:04:38 INFO - PROCESS | 2352 | |9;json-stringify-tinderbox;66;67;65;67;68;66;68;67;67;67 18:04:38 INFO - PROCESS | 2352 | |10;stanford-crypto-aes;89;82;87;84;82;85;86;81;80;80 18:04:38 INFO - PROCESS | 2352 | |11;stanford-crypto-ccm;143;132;132;137;141;134;143;142;168;136 18:04:38 INFO - PROCESS | 2352 | |12;stanford-crypto-pbkdf2;175;175;178;171;172;175;174;173;176;174 18:04:38 INFO - PROCESS | 2352 | |13;stanford-crypto-sha256-iterative;69;72;74;69;70;70;70;70;71;67 18:04:38 INFO - PROCESS | 2352 | __end_tp_report 18:04:38 INFO - PROCESS | 2352 | __start_cc_report 18:04:38 INFO - PROCESS | 2352 | _x_x_mozilla_cycle_collect,1912 18:04:38 INFO - PROCESS | 2352 | __end_cc_report 18:04:38 INFO - PROCESS | 2352 | __startTimestamp1475111078656__endTimestamp 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | ------- Summary: start ------- 18:04:38 INFO - PROCESS | 2352 | Number of tests: 14 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#0] ai-astar Cycles:10 Average:113.40 Median:113.50 stddev:0.84 (0.7%) stddev-sans-first:0.73 18:04:38 INFO - PROCESS | 2352 | Values: 112.0 114.0 115.0 114.0 113.0 114.0 113.0 113.0 113.0 113.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#1] audio-beat-detection Cycles:10 Average:137.90 Median:131.50 stddev:18.25 (13.9%) stddev-sans-first:17.85 18:04:38 INFO - PROCESS | 2352 | Values: 158.0 123.0 134.0 173.0 127.0 127.0 126.0 129.0 159.0 123.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#2] audio-dft Cycles:10 Average:162.40 Median:162.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 18:04:38 INFO - PROCESS | 2352 | Values: 162.0 162.0 163.0 162.0 162.0 163.0 164.0 162.0 163.0 161.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#3] audio-fft Cycles:10 Average:83.00 Median:76.00 stddev:14.67 (19.3%) stddev-sans-first:15.27 18:04:38 INFO - PROCESS | 2352 | Values: 75.0 77.0 76.0 115.0 76.0 77.0 77.0 75.0 106.0 76.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:84.00 stddev:18.57 (22.1%) stddev-sans-first:19.34 18:04:38 INFO - PROCESS | 2352 | Values: 85.0 83.0 134.0 85.0 84.0 84.0 105.0 85.0 84.0 121.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.60 18:04:38 INFO - PROCESS | 2352 | Values: 118.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 118.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:146.50 stddev:1.14 (0.8%) stddev-sans-first:1.12 18:04:38 INFO - PROCESS | 2352 | Values: 148.0 149.0 148.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 18:04:38 INFO - PROCESS | 2352 | Values: 95.0 96.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 18:04:38 INFO - PROCESS | 2352 | Values: 65.0 64.0 64.0 64.0 65.0 66.0 65.0 65.0 65.0 65.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 18:04:38 INFO - PROCESS | 2352 | Values: 66.0 67.0 65.0 67.0 68.0 66.0 68.0 67.0 67.0 67.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.50 stddev:3.10 (3.7%) stddev-sans-first:2.60 18:04:38 INFO - PROCESS | 2352 | Values: 89.0 82.0 87.0 84.0 82.0 85.0 86.0 81.0 80.0 80.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:141.50 stddev:10.49 (7.4%) stddev-sans-first:11.09 18:04:38 INFO - PROCESS | 2352 | Values: 143.0 132.0 132.0 137.0 141.0 134.0 143.0 142.0 168.0 136.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.30 Median:175.00 stddev:2.00 (1.1%) stddev-sans-first:2.11 18:04:38 INFO - PROCESS | 2352 | Values: 175.0 175.0 178.0 171.0 172.0 175.0 174.0 173.0 176.0 174.0 18:04:38 INFO - PROCESS | 2352 | 18:04:38 INFO - PROCESS | 2352 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.20 Median:70.00 stddev:1.87 (2.7%) stddev-sans-first:1.94 18:04:38 INFO - PROCESS | 2352 | Values: 69.0 72.0 74.0 69.0 70.0 70.0 70.0 70.0 71.0 67.0 18:04:38 INFO - PROCESS | 2352 | -------- Summary: end -------- 18:04:38 INFO - PROCESS | 2352 | 18:04:39 INFO - TEST-INFO | 2352: exit 0 18:04:40 INFO - TEST-OK | kraken | took 64845ms 18:04:40 INFO - SUITE-END | took 1185s 18:04:40 INFO - Completed test suite (00:19:46) 18:04:40 INFO - javascript benchmark 18:04:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2549.311685844822, 2552.3619095226195, 2604.6353510508525, 2608.3479130217447, 2622.5017246723132, 4539.296409056601, 4603.585677289043, 4704.788284527201, 4705.905881882364, 4711.599514041306, 4621.861344159681, 4699.694519856207, 4744.4306683198065, 4770.356001939737, 4821.807127714896, 4226.830926762926, 4259.659227261827, 4311.0, 4330.480342358921, 4331.7617531035785, 4349.7390156590545, 4424.159409712161, 4455.576720211591, 4467.41923549938, 4510.436195475566, 4397.274449715793, 4400.361947517608, 4435.157320109185, 4438.622717069021, 4471.23988921884, 4272.166927449149, 4316.028893498969, 4318.805653745589, 4330.047389574289, 4334.523202447728, 4373.978130109329, 4383.408239887606, 4422.314541246112, 4431.933520997188, 4432.623227025707, 4727.4163155343, 4760.833370832004, 4779.044191161782, 4788.4253889533475, 4839.7096174229655, 4851.733154676492, 4895.926561101586, 4896.1186986342445, 5102.4897510248675, 5105.2086926526445, 4984.77568509418, 4992.87517812054, 4998.700077995332, 4999.275105109775, 5000.174971129759, 4613.0773845230415, 4637.907241855178, 4643.791029403685, 4646.186917289495, 4657.417822772153, 5116.872078198075, 5122.615803814729, 5133.332666753298, 5188.558972487305, 5191.117510023305, 4859.319695242669, 4894.853154405374, 4896.755162241873, 4903.436104847917, 4967.90064198714, 4904.2643603459765, 4935.111679897581, 4950.653454258168, 4975.975120124449, 4977.328060711758, 4892.730899800546, 4989.376327959005, 5039.042581909425, 5046.116929537389, 5051.621128415383, 4959.578435832923, 4970.329005584272, 4973.055119527278, 4974.925376119361, 5025.120603894304, 4162.354835000579, 4197.097624010852, 4254.3831144483875, 4258.87223383299, 4305.095929854766, 3700.0749812546865, 3712.1090938174643, 3726.459663348799, 3743.2139250757646, 3789.1285004449132, 4297.333913243452, 4303.397524346594, 4312.245357062501, 4314.56854314566, 4361.847335343247, 5112.335396398519, 5114.28400023997, 5117.923231151536, 5119.436861945183, 5173.896522069537, 4216.051388437577, 4269.743815371087, 4279.443672322641, 4316.330968699856, 4325.43769309994, 4592.2193227151465, 4593.28804035375, 4599.7470139142, 4623.884402889955, 4655.557722016403, 4756.120117778222, 4756.16767065769, 4761.738104404221, 4807.831725889577, 4822.71063736177, 4939.604831613534, 5014.749262536931, 5030.0945829749535, 5119.0273847968765, 5122.667026643406, 4698.412698412699, 4716.410448693913, 4723.811047558059, 4781.521847815191, 4788.880277993078, 4983.875403114806, 4987.0524600325825, 4988.301637770787, 4991.80032798684, 5055.87360315995, 4913.533214344631, 4924.507549245047, 5038.798448062036, 5044.167712327425, 5103.285540024473, 4865.9756701216265, 4892.902141957212, 4907.509249075064, 4922.680025798311, 4986.975065124651, 4892.877678058077, 4911.950880491292, 4920.21276595743, 4924.704517728947, 4948.851534453972, 4657.4643915948745, 4843.636727245541, 4849.684770489906, 4902.754862256944, 4903.681260718042, 4779.283107533898, 4832.0, 4878.658493905393, 4889.682170658896, 4963.131451995959, 4835.6131509478455, 4847.442544107332, 4850.587700045395, 4851.854444366674, 4911.926321105258], "value": 4620.202737696959, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [557.2560631556873, 561.5900392713319, 564.9661020338777, 569.8917205730911, 574.9913751293732, 28081.43837123256, 28854.278643033933, 31126.68873311269, 37013.814930925306, 38258.0, 39228.21543569127, 39651.0, 39666.603333966654, 39690.801545992304, 39709.801450992774, 7571.6214189290595, 7714.151443341228, 7717.575533345664, 7717.6912923483, 7718.536887786723, 7520.285572870568, 7608.505447145945, 7609.315161635452, 7611.581363025031, 7613.771586852404, 7564.357029652459, 7612.961935190317, 7614.809629759245, 7628.732994345199, 7633.0458692663415, 7618.314351708345, 7636.541807491568, 7641.656125474367, 7654.234576542357, 7666.233376662345, 7270.745523906638, 7320.633968301617, 7323.121225452926, 7335.743248986313, 7342.5227360221415, 37299.0, 37457.43813842795, 37490.68782592596, 37534.8123259382, 37583.0, 2848.84331361775, 3004.7746419018663, 3215.8070515768895, 3241.918952026195, 3566.32239874423, 25893.611595826078, 25894.611580826302, 25971.740282597122, 26669.73330266711, 27425.588616170775, 3310.35448087623, 3375.4261775498226, 3461.705755010827, 3499.982500087509, 3536.6286539913194, 192874.0, 253164.0, 253259.0, 253695.0, 254182.72908635525, 30098.247543811143, 30989.845050775053, 52999.0, 53652.73173634107, 53690.77855328693, 32286.515702264485, 32727.345453091282, 32752.0, 32753.83623081917, 32791.0, 11966.401679915969, 12052.0, 12087.274763514217, 12087.939560302319, 12090.758184836253, 9804.852927206097, 9871.358361706467, 9882.80234395308, 9883.505824708736, 9888.851667224997, 7686.3082322591235, 7689.807754806175, 7767.883481747778, 7770.572618505923, 7773.883391749128, 3019.5017822059554, 3060.892868749583, 3062.0, 3068.324968506925, 3078.107348868803, 824.2664029014182, 864.5504337744463, 866.787637028932, 887.2192470625808, 931.59475628102, 26731.33171670724, 26776.59835102475, 27482.725172748018, 27634.585481217797, 28113.57829632557, 778.8014056415577, 965.4641673870929, 995.5619527408062, 1000.4193374468323, 1041.994790026045, 12640.30478323701, 13592.184468931895, 13631.318434078456, 13761.793573096411, 13818.309084545934, 371500.0, 373805.0, 373913.0, 374488.0, 375341.0, 47351.0, 47803.0, 47851.0, 48025.27962080572, 48104.759476202395, 1048.8531605575226, 1083.3608171179042, 1107.2415395453818, 1137.5336112194127, 1171.472837223253, 25442.236732898044, 28108.71891281061, 28488.253064688957, 29042.27394315159, 29086.56370154407, 35596.644033559336, 35606.10984725299, 35608.0, 35625.82187089048, 35888.10279743027, 297327.0, 298114.0, 298273.0, 298322.0, 298528.0, 21680.566388672454, 21876.45308867291, 22184.445388865406, 22358.88820555887, 24610.630840537764, 40735.796321018206, 40837.38743918784, 40889.59110408977, 40980.3852942212, 41066.178676425705, 35412.0, 35690.28619427649, 35717.0, 35817.1045723859, 35966.640333596326, 35193.29613407769, 35275.82362088276, 35425.0, 35429.114272142375, 35762.0, 34572.30855382828, 34918.47622285617, 35042.824785875906, 35219.647803521635, 35847.64152358547, 30036.699633004264, 32009.35981280408, 32062.83968580142, 32580.0, 32848.0, 24642.260732178063, 24725.89905111238, 24824.503509929338, 25074.34340405284, 25294.367640809127], "value": 15708.902191895202, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.1679842390083, 350.7106637024454, 351.8170551313317, 355.86832871837424, 379.0372453966924, 12365.156014116747, 15479.690406191869, 16305.103219322948, 16325.428609998653, 17403.0, 14433.0, 14445.783313250284, 14527.636809079779, 14679.926600367009, 14687.559373218794, 4872.951270487294, 5111.795528178868, 5113.2074528447965, 5116.411612664554, 5119.948800511985, 4068.837246510136, 5917.171595976567, 5958.5828991970575, 6054.51563874889, 6057.30341010785, 5158.097332966716, 6008.7296071676665, 6018.097285407202, 6018.7893423730175, 6023.488003519684, 5344.732763361836, 5532.640378375393, 5535.750891209906, 5537.556995440355, 5538.861528461821, 5133.178691409356, 5237.8428647140645, 5253.816116435906, 5365.382980957201, 5369.3556773187465, 11597.942010289978, 11850.525978960832, 11868.940655296754, 11870.52517899283, 11884.524619015228, 1806.087925597565, 1887.5375532994503, 2083.5832833433374, 2191.9150020739676, 2359.1978727232654, 8597.656093756243, 8949.328800340001, 9336.39313444624, 9363.812723745486, 9533.856992145124, 1658.4858693804958, 1722.5702666786663, 1768.9027103509302, 1769.619531800669, 1772.1139430284857, 70348.0, 71991.64004179946, 72129.0, 72313.99999999948, 73164.6341768293, 9386.15524602789, 9570.176797844653, 9657.855132173023, 9684.225261979165, 9725.638410622518, 12968.870311296954, 12986.610401687965, 13012.739745205043, 13018.544350947861, 13032.674183145496, 6666.866662666816, 6823.965880170666, 6841.350071743176, 7025.7189712411955, 7059.470539709542, 6515.7067931943175, 6541.705623246965, 6692.665366731741, 6693.5943451875655, 6705.932940670628, 4064.7561146331313, 4165.396017577435, 4167.416561681367, 4255.744655320691, 4273.487181538173, 1707.8548323392401, 1711.9144042797811, 1732.0300631646066, 1735.7049301618756, 1776.3693888669336, 810.5866008335673, 821.8479581277483, 826.3802148388709, 883.8143989762093, 890.0076414797584, 16098.0, 16716.414925477795, 17301.394451194148, 17357.0, 17593.0, 776.8951191589176, 791.7901756034655, 793.9126696063429, 814.9022117345838, 828.4118276024091, 8692.608832602547, 9029.593668284942, 9038.909610903938, 9218.446893186296, 9782.902170978341, 372470.0, 375891.0, 387724.0, 389022.0, 389397.0, 45424.54575454269, 53889.46110538923, 72123.0, 74070.0, 75585.24414755891, 833.7623777223462, 834.899812022549, 846.517485033525, 860.4536119564121, 881.352206128495, 14566.880277180688, 14754.336054877771, 14818.925905370405, 14992.475263366166, 15070.849291506944, 33337.832500987395, 33913.3217335647, 36459.27081458409, 36622.8168859154, 36940.63059369372, 48475.75762121167, 48649.0, 49054.50945490642, 49540.25689614587, 49647.0, 7050.400715939202, 7246.0, 7335.303146201102, 7373.5575865448245, 7560.697572097274, 8601.483910965111, 10890.94554527254, 11491.54033838637, 11780.941095294469, 11862.644120676394, 9345.392549484262, 9780.41317520951, 9794.314397992357, 10533.736656583647, 10872.293300935415, 9794.314397992071, 10067.848982265125, 10069.949650251701, 10289.588416463557, 10463.267571269938, 10256.743581410226, 10481.42352170638, 10488.26582139243, 10743.871893451074, 10794.838077428687, 7110.217876033736, 7192.712291508281, 7275.417966562556, 7339.376153027052, 7603.2776886195725, 8536.44513106646, 10260.640877569249, 10262.384256944608, 10446.320989135682, 10786.0], "value": 7847.938152181828, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1204.9819252711206, 1356.9999999999998, 1379.379279324304, 1432.2194404049792, 1634.6245004066602, 6833.3508316709895, 7561.584112873797, 7816.882746758789, 7829.686812527492, 8069.677212911476, 7917.841643167133, 7980.760577182694, 7985.4010949178755, 7986.4010199235, 7986.440949133563, 2155.5150091229507, 2179.1065663078143, 2179.858309209896, 2181.4873504726374, 2184.159098746986, 2046.6827641715558, 2078.1998930411823, 2087.03996161765, 2106.8314534837177, 2109.504266497372, 2019.1216820682976, 2053.4558342039372, 2069.9586008279825, 2079.511314841011, 2083.4895450614545, 2003.7294965179806, 2016.0, 2017.9697304540443, 2023.8684485508543, 2024.5748392837522, 1968.2127149140315, 1974.7235387045826, 2001.3095482058666, 2007.1569940624972, 2008.2067583304658, 7671.53970761756, 7717.459777815555, 7864.567448790314, 7930.6431210595665, 7959.243871832166, 4222.2611043067645, 4368.279233926399, 4386.627136693385, 4387.583179597965, 4389.978050109729, 2738.8493632850186, 2838.4748821468093, 2859.7140285971445, 2896.174590241771, 2898.2754311422145, 945.6501094594975, 946.9195118414943, 950.6387572722322, 953.9427634341962, 982.1210017034714, 10633.468326583717, 10739.0, 10753.247272690836, 10755.0, 10829.404382758867, 3893.3381325174223, 3953.110550126256, 4043.6562892154498, 4066.1461093170765, 4095.1809638072505, 8340.541270230196, 8512.489250644981, 8513.616887240089, 8515.403921725543, 8517.403781735344, 4254.446921900133, 4254.510731265944, 4254.914901702011, 4255.744655320691, 4256.2551553478015, 3616.782993020427, 3729.533808273966, 3842.3083844908183, 3917.9020524486546, 3922.843086276574, 3202.8078315301154, 3223.1458663454205, 3309.9007029789145, 3343.6823501767294, 3346.28054968183, 936.5879013234155, 945.7610530205316, 947.7441090905417, 955.1546881010217, 965.2229954886244, 843.8692002739585, 861.961211745473, 870.8911386076741, 871.5816408124009, 874.8381549413378, 5136.4606716295, 5324.946750532523, 5325.147976323769, 5328.0675881720545, 5329.467053294717, 382.36336499728196, 391.37966323377765, 393.1998383290048, 399.4427773256291, 400.50737592761067, 3531.646835316448, 3622.2031153146268, 3758.473813666089, 3823.3559569384875, 3940.822662980173, 9304.813903721888, 9567.521623918916, 9687.70936871895, 9697.6120955161, 9705.951470242604, 8973.50645714479, 9383.343165978316, 9509.5720692569, 9565.521723913776, 9664.275179361575, 6813.625250611165, 6996.405305549085, 6998.930010699828, 7006.894896576454, 7012.088428504262, 5278.313819203479, 5335.546478549367, 5411.594130440311, 5450.8909821802545, 5495.505404513613, 8670.91329086701, 8758.03661597211, 8803.735887923373, 8925.196732294125, 9003.189712925607, 8889.599968001326, 8988.10118988096, 9040.68357607507, 9064.138906803842, 9080.137386948229, 6039.214902062704, 6798.76204332846, 6987.441004719712, 6991.965040174767, 6993.965030174817, 6649.567778094409, 6832.726690932307, 7046.436285097077, 7059.223485416497, 7250.20247772734, 6103.176071230327, 6413.038044293393, 6443.903341449788, 6450.064740612679, 6585.6377899216, 6236.18929539157, 6277.717502712298, 6280.026595877646, 6300.338464461165, 6319.020551814476, 6022.066579680157, 6114.266288045463, 6142.262928448615, 6142.447179753844, 6143.416375444325, 4480.955190448054, 4532.9093418132115, 4545.0, 4585.12882552314, 4648.65135114861, 4500.109953819469, 4547.454305483231, 4547.545245475559, 4623.075384922961, 4724.834630787906], "value": 3926.39634601481, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.95380762174244, 290.7470500664422, 291.5044424478386, 294.2100460264191, 296.9480340940335, 4833.661643684939, 4856.854294371175, 4858.51414858514, 4881.8291359802415, 4896.265560165977, 4813.205821039524, 4823.758812059392, 4844.128056949748, 4844.4913284105105, 4863.392075990501, 3818.6945044396452, 3823.655870971612, 3845.576986531479, 3846.7114966377494, 3854.4989151410277, 3711.5546134463902, 3852.0, 3856.4986551748234, 3857.3442514772414, 3868.1103346230384, 3768.152165762695, 3792.431135329695, 3795.924081518368, 3796.2597293527633, 3802.6007269236748, 3762.191128907271, 3777.9811100944594, 3792.4121761126794, 3801.220749746309, 3817.4655548223272, 3132.483140281851, 3251.9674803252137, 3320.352531256406, 3329.184349834282, 3329.7502687298547, 4568.680192386534, 4694.08465349257, 4697.271922851964, 4701.365315682373, 4714.669973101884, 4296.312589985619, 4309.547497512747, 4334.176506463762, 4353.193424728734, 4354.129174165179, 4935.679180853233, 4972.975135124301, 5019.623528235397, 5035.823746168867, 5051.924221136685, 3627.365211088049, 3633.2370202257293, 3639.581448133472, 3643.8178091095338, 3643.8360273787744, 5178.275041494194, 5184.948150518484, 5208.973955130238, 5236.319278493809, 5242.397124330674, 3705.166337574024, 3717.925641487155, 3733.9253214935547, 3748.1004558905665, 3751.099736063325, 3659.1766852457986, 3787.5833658297565, 3803.782789507331, 3805.200907809391, 3816.1795214029116, 4264.914701705949, 4270.380794784739, 4270.850520231839, 4295.29127693927, 4305.5048669402795, 4949.529794669501, 4990.276409920614, 4990.452959582541, 4993.726599717049, 4994.650374473825, 1261.4827920552714, 1306.4186437035428, 1306.5231190615357, 1318.4792007157118, 1323.8676132386877, 843.8649816029406, 856.3021137772695, 861.9225967540574, 865.0, 871.1680345270379, 3904.531456225271, 3909.354956432214, 3921.2353591049473, 3946.4080387941463, 3958.980205098956, 4541.751018469947, 4556.681032327771, 4585.701929374647, 4586.495485496593, 4603.95396046042, 3872.7289089763444, 3888.6305800948867, 3916.686665066788, 3921.1569512554365, 3924.3132451820816, 2461.360046387916, 2466.8273220874726, 2544.98727506365, 2744.7529722325085, 2758.434520923206, 4560.908781824345, 4674.953250467452, 4701.905961880811, 4795.688280261842, 4855.198892182751, 5251.369835619674, 5276.0, 5314.5748340132695, 5330.081170778517, 5348.91976620351, 4793.849476125704, 4816.8554943351755, 4829.1790395632825, 4886.877828054327, 4890.557285600757, 4976.30331753562, 5094.745262736774, 5125.8718532037, 5149.356330458692, 5150.484951504969, 5050.595952323879, 5051.2423136529815, 5058.898822023465, 5067.77195026232, 5073.6955782651685, 4796.544328288807, 4823.421189457287, 4832.637552183671, 4844.563989240985, 4846.660733748604, 3438.484227365915, 3651.8539258429364, 3656.4149736042104, 3685.723570732152, 3706.7590606610484, 5180.663256888291, 5195.960363187578, 5211.71335576547, 5221.973890130525, 5230.13702739059, 5031.6226283029655, 5040.57155141817, 5052.621053420935, 5061.987602479592, 5067.0, 4902.259697807227, 4968.826091086795, 4990.326305948795, 4990.351254336913, 4991.9001619966675, 4925.21196608541, 4929.950700493093, 4930.112579735682, 4933.383327084114, 4942.382202224722, 5007.724575148256, 5023.397192336943, 5032.6980381177245, 5038.949610503848, 5046.722430266371, 4733.408323959505, 4874.829380971649, 4887.853364399074, 4900.730459824744, 4901.656884018084], "value": 3754.308569936369, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [586.7887560478227, 639.1595052505958, 704.1057856522214, 722.2741145149126, 725.5356571794049, 12635.431405586747, 12877.162984406019, 13347.466101355934, 13576.796348054788, 13952.511662091829, 13289.468421263162, 13321.400536975834, 13360.933195334033, 13424.261665608388, 13435.596932092052, 719.4532155561758, 744.2408743082053, 748.7678819565925, 749.6589051981335, 751.6467260387609, 604.9001914684094, 623.3517142172158, 721.2643104033882, 743.9888401673979, 749.0150452155425, 770.734096736625, 771.3482107619053, 772.382094324541, 772.9072511298624, 774.9496282741632, 764.5718397697308, 767.8195624028349, 770.1797585571377, 770.5607803551977, 772.1467778105197, 464.57723471640645, 473.37514480885244, 552.1937970562983, 566.9886602267932, 568.9886202275973, 12364.258144511268, 12392.256464612063, 12403.62789116328, 12413.379331033413, 12414.068944829083, 11864.940675296655, 12564.81152782709, 12635.74728505434, 12764.744705105939, 13215.141015834037, 11850.822237666442, 11992.64022079339, 12074.818877716842, 12179.573714919936, 12474.313912734797, 3949.1311911379453, 3963.583823698499, 3981.3231750602467, 4165.937510937339, 4195.958040419588, 66412.0, 67111.328886711, 68031.31968680349, 68557.65721171362, 68616.6569167156, 9237.815243695222, 9387.10822471864, 10043.497825108716, 10361.430121343248, 10412.531436085394, 17843.37548185807, 18149.364772233173, 18242.543936401697, 18294.542636434195, 18297.634047319247, 6634.568753031038, 6708.161479815023, 6786.083878676414, 6895.896561551481, 7137.750178743719, 3454.170998960282, 3527.100589349751, 3551.538300020981, 3561.358955388055, 3684.207895302523, 2810.3114736889183, 2918.255844759573, 2922.6054482644995, 2926.429346277498, 2930.120963710878, 516.7235528991971, 526.494565217388, 527.8416475057544, 530.6285600079959, 537.2398056749734, 504.46274717425825, 537.7418838957323, 537.7902617978991, 537.9166229234474, 543.9673619582837, 7364.2635736427, 7476.1776204617445, 7748.4188685848785, 7772.300492955661, 8038.276555109951, 464.6561544457077, 509.6559822120054, 551.4595696217729, 553.8255449533384, 573.1402895656515, 3557.537520122419, 3712.238991006891, 3805.6955443564448, 3809.2762375149186, 3828.5405751309463, 55698.49356778873, 65351.673241633485, 85398.14601853902, 110304.0, 110481.44759276153, 84122.79386030675, 94190.52904735433, 95049.0, 95762.52118739362, 95849.0, 76595.61702191565, 79704.0, 81347.5932620345, 82339.0, 82402.17597824064, 7174.354308112086, 7182.102237220348, 7420.962895185706, 7492.438067144877, 7754.6898124074405, 44739.77630111828, 45962.0, 46038.769806150754, 47242.52757472519, 47835.76082119567, 45494.54505454903, 65447.672761635884, 66350.33649663441, 67058.66470667615, 68091.3190868085, 8790.472571645721, 9364.438133712, 9369.765755856159, 9488.762780930532, 9845.31082824224, 10202.642907498499, 10401.791964160522, 10470.685879423629, 10521.21090918169, 10753.301035432673, 8542.74371768848, 8781.077986811293, 8830.602622882114, 8962.238209752244, 9272.58273377686, 9909.801803963735, 10033.498325083863, 10593.788124237319, 10727.570897164025, 10901.890981090404, 10647.520861561094, 10797.676069717922, 10985.121190304597, 11012.669619911416, 11306.378149201873, 8914.37599368064, 9426.198773104363, 9608.27937904646, 9636.807263854824, 9670.758231044, 8649.697260595849, 8961.476548986819, 9027.23268522183, 9413.199878010446, 9893.208543316661], "value": 6314.018864649688, "unit": "score"}], "name": "dromaeo_css", "value": 6129.238957960218, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 115.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 123.0, 134.0, 173.0, 127.0, 127.0, 126.0, 129.0, 159.0, 123.0], "value": 137.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 162.0, 162.0, 163.0, 164.0, 162.0, 163.0, 161.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 115.0, 76.0, 77.0, 77.0, 75.0, 106.0, 76.0], "value": 83.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 134.0, 85.0, 84.0, 84.0, 105.0, 85.0, 84.0, 121.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 118.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 148.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 64.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 67.0, 68.0, 66.0, 68.0, 67.0, 67.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 82.0, 87.0, 84.0, 82.0, 85.0, 86.0, 81.0, 80.0, 80.0], "value": 83.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 132.0, 132.0, 137.0, 141.0, 134.0, 143.0, 142.0, 168.0, 136.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 178.0, 171.0, 172.0, 175.0, 174.0, 173.0, 176.0, 174.0], "value": 174.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 72.0, 74.0, 69.0, 70.0, 70.0, 70.0, 70.0, 71.0, 67.0], "value": 70.2, "unit": "score"}], "name": "kraken", "value": 1550.9999999999998, "alertThreshold": 2.0}]} 18:04:40 INFO - Return code: 0 18:04:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:04:40 INFO - # TBPL SUCCESS # 18:04:40 INFO - Running post-action listener: _resource_record_post_action 18:04:40 INFO - [mozharness: 2016-09-29 01:04:40.482456Z] Finished run-tests step (success) 18:04:40 INFO - Running post-run listener: _resource_record_post_run 18:04:40 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 402182144; Read time: 0; Write time: 333068 18:04:40 INFO - TinderboxPrint: CPU usage
13.0% 18:04:40 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:04:40 INFO - TinderboxPrint: I/O write bytes / time
402,182,144 / 333,068 18:04:40 INFO - TinderboxPrint: CPU idle
8,340.1 (87.0%) 18:04:40 INFO - TinderboxPrint: CPU user
1,200.9 (12.5%) 18:04:40 INFO - TinderboxPrint: Swap in / out
0 / 0 18:04:40 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110485504; Read time: 0; Write time: 104420 18:04:40 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 290770944; Read time: 0; Write time: 228624 18:04:41 INFO - Running post-run listener: _upload_blobber_files 18:04:41 INFO - Blob upload gear active. 18:04:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:04:41 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 18:04:41 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:04:41 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:04:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:04:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:04:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:04:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:42 INFO - (blobuploader) - INFO - Done attempting. 18:04:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:04:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:04:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:43 INFO - (blobuploader) - INFO - Done attempting. 18:04:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:04:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:04:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:04:47 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:04:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:04:47 INFO - (blobuploader) - INFO - Done attempting. 18:04:47 INFO - (blobuploader) - INFO - Iteration through files over. 18:04:47 INFO - Return code: 0 18:04:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:04:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:04:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/959b802eca7c3554036d0f28817eadfd5e75be57a53ec8ea3ec9eb61b715d09bb618ca9f3aa80a456c54116f54988da8385d71b3c920c8f98e69633b2e17f92f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d48584ada214d0e465b560a9d777a5b749c7dcf875c915a036f98659980297f40565de09a9f43a01e9241257a85fb1bebf861f818c7ec173ba8ba5cdddbe5e92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e457d8429db4032e8ba07c3565e119c65186b136cc385734d56c8a828df640bb1b6c23ef29cd78b94e6ae06ff33c0a012c6106d2f631e71cecb9baf4068cedf3"} 18:04:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:04:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:04:47 INFO - Contents: 18:04:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/959b802eca7c3554036d0f28817eadfd5e75be57a53ec8ea3ec9eb61b715d09bb618ca9f3aa80a456c54116f54988da8385d71b3c920c8f98e69633b2e17f92f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d48584ada214d0e465b560a9d777a5b749c7dcf875c915a036f98659980297f40565de09a9f43a01e9241257a85fb1bebf861f818c7ec173ba8ba5cdddbe5e92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e457d8429db4032e8ba07c3565e119c65186b136cc385734d56c8a828df640bb1b6c23ef29cd78b94e6ae06ff33c0a012c6106d2f631e71cecb9baf4068cedf3"} 18:04:47 INFO - Running post-run listener: copy_logs_to_upload_dir 18:04:47 INFO - Copying logs to upload dir... 18:04:47 INFO - mkdir: /builds/slave/test/build/upload/logs 18:04:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.058520 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-09-28 18:04:47.454201) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 18:04:47.457632) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/959b802eca7c3554036d0f28817eadfd5e75be57a53ec8ea3ec9eb61b715d09bb618ca9f3aa80a456c54116f54988da8385d71b3c920c8f98e69633b2e17f92f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d48584ada214d0e465b560a9d777a5b749c7dcf875c915a036f98659980297f40565de09a9f43a01e9241257a85fb1bebf861f818c7ec173ba8ba5cdddbe5e92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e457d8429db4032e8ba07c3565e119c65186b136cc385734d56c8a828df640bb1b6c23ef29cd78b94e6ae06ff33c0a012c6106d2f631e71cecb9baf4068cedf3"} build_url:https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011492 build_url: 'https://queue.taskcluster.net/v1/task/Q0D5GjEoQUO1pupFoWLPMQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/959b802eca7c3554036d0f28817eadfd5e75be57a53ec8ea3ec9eb61b715d09bb618ca9f3aa80a456c54116f54988da8385d71b3c920c8f98e69633b2e17f92f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/d48584ada214d0e465b560a9d777a5b749c7dcf875c915a036f98659980297f40565de09a9f43a01e9241257a85fb1bebf861f818c7ec173ba8ba5cdddbe5e92", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e457d8429db4032e8ba07c3565e119c65186b136cc385734d56c8a828df640bb1b6c23ef29cd78b94e6ae06ff33c0a012c6106d2f631e71cecb9baf4068cedf3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 18:04:47.483492) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:04:47.483890) ========= 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=14ef55db36f7623abb31b9cf000001d5-1475109621.471100-1055671722 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 18:04:47.567348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 18:04:47.567701) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 18:04:47.568057) ========= ========= Total master_lag: 0.17 =========