builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1477403283.06 results: success (0) buildid: 20161025064418 builduid: ab4e21074c2b4e72b3534ca9910287fc revision: 78b863e9fcd9d44d75c817b6495b4585167ba255 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.056180) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.056667) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.056972) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.071706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.072049) ========= 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=ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-25 06:48:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.1M=0s 2016-10-25 06:48:03 (47.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.079410 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.165306) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.165614) ========= 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=ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017027 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.215184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.215539) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 78b863e9fcd9d44d75c817b6495b4585167ba255 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 78b863e9fcd9d44d75c817b6495b4585167ba255 --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=ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-25 06:48:04,100 truncating revision to first 12 chars 2016-10-25 06:48:04,101 Setting DEBUG logging. 2016-10-25 06:48:04,101 attempt 1/10 2016-10-25 06:48:04,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/78b863e9fcd9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-25 06:48:04,515 unpacking tar archive at: fx-team-78b863e9fcd9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.716099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.945033) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.945373) ========= script_repo_revision: 78b863e9fcd9d44d75c817b6495b4585167ba255 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.945746) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.946006) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-25 06:48:03.955595) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-25 06:48:03.956003) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:48:04 INFO - MultiFileLogger online at 20161025 06:48:04 in /builds/slave/test 06:48:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 06:48:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:48:04 INFO - {'append_to_log': False, 06:48:04 INFO - 'base_work_dir': '/builds/slave/test', 06:48:04 INFO - 'blob_upload_branch': 'Fx-Team', 06:48:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:48:04 INFO - 'branch': 'Fx-Team', 06:48:04 INFO - 'buildbot_json_path': 'buildprops.json', 06:48:04 INFO - 'config_files': ('talos/linux_config.py',), 06:48:04 INFO - 'default_actions': ('clobber', 06:48:04 INFO - 'read-buildbot-config', 06:48:04 INFO - 'download-and-extract', 06:48:04 INFO - 'populate-webroot', 06:48:04 INFO - 'create-virtualenv', 06:48:04 INFO - 'install', 06:48:04 INFO - 'run-tests'), 06:48:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:48:04 INFO - 'download_minidump_stackwalk': True, 06:48:04 INFO - 'download_symbols': 'ondemand', 06:48:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:48:04 INFO - 'tooltool.py': '/tools/tooltool.py', 06:48:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:48:04 INFO - '/tools/misc-python/virtualenv.py')}, 06:48:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:48:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:48:04 INFO - 'installer_path': 'installer.exe', 06:48:04 INFO - 'log_level': 'info', 06:48:04 INFO - 'log_name': 'talos', 06:48:04 INFO - 'log_to_console': True, 06:48:04 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:48:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:48:04 INFO - 'opt_config_files': (), 06:48:04 INFO - 'pip_index': False, 06:48:04 INFO - 'sps_profile': False, 06:48:04 INFO - 'sps_profile_interval': 0, 06:48:04 INFO - 'suite': 'dromaeojs', 06:48:04 INFO - 'system_bits': '32', 06:48:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:48:04 INFO - 'title': 'talos-linux64-ix-035', 06:48:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:48:04 INFO - 'use_talos_json': True, 06:48:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:48:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:48:04 INFO - 'work_dir': 'build'} 06:48:04 INFO - [mozharness: 2016-10-25 13:48:04.944791Z] Running clobber step. 06:48:04 INFO - Running pre-action listener: _resource_record_pre_action 06:48:04 INFO - Running main action method: clobber 06:48:04 INFO - rmtree: /builds/slave/test/build 06:48:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:48:05 INFO - Running post-action listener: _resource_record_post_action 06:48:05 INFO - [mozharness: 2016-10-25 13:48:05.451358Z] Finished clobber step (success) 06:48:05 INFO - [mozharness: 2016-10-25 13:48:05.451460Z] Running read-buildbot-config step. 06:48:05 INFO - Running pre-action listener: _resource_record_pre_action 06:48:05 INFO - Running main action method: read_buildbot_config 06:48:05 INFO - Using buildbot properties: 06:48:05 INFO - { 06:48:05 INFO - "project": "", 06:48:05 INFO - "product": "firefox", 06:48:05 INFO - "script_repo_revision": "production", 06:48:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 06:48:05 INFO - "repository": "", 06:48:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 06:48:05 INFO - "buildid": "20161025064418", 06:48:05 INFO - "stage_platform": "linux64-pgo", 06:48:05 INFO - "basedir": "/builds/slave/test", 06:48:05 INFO - "buildnumber": 1660, 06:48:05 INFO - "platform": "ubuntu64_hw", 06:48:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 06:48:05 INFO - "slavebuilddir": "test", 06:48:05 INFO - "branch": "fx-team", 06:48:05 INFO - "revision": "78b863e9fcd9d44d75c817b6495b4585167ba255", 06:48:05 INFO - "slavename": "talos-linux64-ix-035", 06:48:05 INFO - "builduid": "ab4e21074c2b4e72b3534ca9910287fc", 06:48:05 INFO - "repo_path": "integration/fx-team" 06:48:05 INFO - } 06:48:05 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:48:05 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 06:48:05 INFO - Running post-action listener: _resource_record_post_action 06:48:05 INFO - [mozharness: 2016-10-25 13:48:05.453936Z] Finished read-buildbot-config step (success) 06:48:05 INFO - [mozharness: 2016-10-25 13:48:05.454023Z] Running download-and-extract step. 06:48:05 INFO - Running pre-action listener: _resource_record_pre_action 06:48:05 INFO - Running main action method: download_and_extract 06:48:05 INFO - mkdir: /builds/slave/test/build/tests 06:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:05 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:48:05 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/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 06:48:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/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 06:48:05 INFO - Downloaded 1361 bytes. 06:48:05 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:48:05 INFO - Using the following test package requirements: 06:48:05 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:48:05 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:48:05 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:48:05 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:05 INFO - u'jsshell-linux-x86_64.zip'], 06:48:05 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:48:05 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:48:05 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:48:05 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:48:05 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:48:05 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:48:05 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:48:05 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:48:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:48:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:48:05 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:48:05 INFO - Http code: 200 06:48:05 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 06:48:05 INFO - x-amz-cf-id: kNvbHA1VSumosyhpJ1oJbB24tjBfLn_4ilP9fHR7I7U--Mz_OH9SFg== 06:48:05 INFO - x-amz-replication-status: COMPLETED 06:48:05 INFO - x-amz-version-id: NnebP.b6.8LovvTNplPa9bFXtYazM1UK 06:48:05 INFO - Expected file size: 22036043 06:48:05 INFO - Obtained file size: 22036043 06:48:09 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 06:48:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:48:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:48:09 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:48:09 INFO - Http code: 200 06:48:09 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 06:48:09 INFO - x-amz-cf-id: bF-D3x1pc4zvfYu5bn25-dstCMPabo57UF8A_x40UR4F1XXD5N3NKg== 06:48:09 INFO - x-amz-replication-status: COMPLETED 06:48:09 INFO - x-amz-version-id: NnebP.b6.8LovvTNplPa9bFXtYazM1UK 06:48:10 INFO - Expected file size: 22036043 06:48:10 INFO - Obtained file size: 22036043 06:48:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:48:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:48:14 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:48:14 INFO - Http code: 200 06:48:14 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 06:48:14 INFO - x-amz-cf-id: AlE4ygbTz-sqz-hgiPdaFEFHgKLy0edsL0f6iTLU0RkjZqSRUOJOrA== 06:48:14 INFO - x-amz-replication-status: COMPLETED 06:48:14 INFO - x-amz-version-id: cs.EQQIbI08T9ellsjquWkU6r90u07CN 06:48:14 INFO - Expected file size: 14409028 06:48:14 INFO - Obtained file size: 14409028 06:48:15 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')]} 06:48:15 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:48:15 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/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 06:48:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/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 06:48:15 INFO - Downloaded 59323139 bytes. 06:48:15 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:48:15 INFO - mkdir: /builds/slave/test/properties 06:48:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:48:15 INFO - Writing to file /builds/slave/test/properties/build_url 06:48:15 INFO - Contents: 06:48:15 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:48:16 INFO - Running post-action listener: _resource_record_post_action 06:48:16 INFO - Running post-action listener: set_extra_try_arguments 06:48:16 INFO - [mozharness: 2016-10-25 13:48:16.229050Z] Finished download-and-extract step (success) 06:48:16 INFO - [mozharness: 2016-10-25 13:48:16.229277Z] Running populate-webroot step. 06:48:16 INFO - Running pre-action listener: _resource_record_pre_action 06:48:16 INFO - Running main action method: populate_webroot 06:48:16 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:48:16 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:48:16 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:48:16 INFO - '--tppagecycles', 06:48:16 INFO - '7'], 06:48:16 INFO - 'tests': ['tsvgm']}}, 06:48:16 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:48:16 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:48:16 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:48:16 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:48:16 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:16 INFO - 'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:48:16 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:16 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:48:16 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:16 INFO - 'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['damp', 'tps']}, 06:48:16 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:16 INFO - 'tests': ['damp', 'tps']}, 06:48:16 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['dromaeo_dom']}, 06:48:16 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:48:16 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['basic_compositor_video']}, 06:48:16 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:48:16 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['a11yr', 06:48:16 INFO - 'ts_paint', 06:48:16 INFO - 'tpaint', 06:48:16 INFO - 'sessionrestore', 06:48:16 INFO - 'sessionrestore_no_auto_restore', 06:48:16 INFO - 'tabpaint']}, 06:48:16 INFO - 'other-e10s': {'tests': ['a11yr', 06:48:16 INFO - 'ts_paint', 06:48:16 INFO - 'tpaint', 06:48:16 INFO - 'sessionrestore', 06:48:16 INFO - 'sessionrestore_no_auto_restore', 06:48:16 INFO - 'tabpaint']}, 06:48:16 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:48:16 INFO - 'ts_paint', 06:48:16 INFO - 'tpaint', 06:48:16 INFO - 'sessionrestore', 06:48:16 INFO - 'sessionrestore_no_auto_restore', 06:48:16 INFO - 'tabpaint']}, 06:48:16 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:48:16 INFO - 'ts_paint', 06:48:16 INFO - 'tpaint', 06:48:16 INFO - 'sessionrestore', 06:48:16 INFO - 'sessionrestore_no_auto_restore', 06:48:16 INFO - 'tabpaint']}, 06:48:16 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['a11yr', 06:48:16 INFO - 'ts_paint', 06:48:16 INFO - 'tpaint', 06:48:16 INFO - 'sessionrestore', 06:48:16 INFO - 'sessionrestore_no_auto_restore', 06:48:16 INFO - 'tabpaint']}, 06:48:16 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['a11yr', 06:48:16 INFO - 'ts_paint', 06:48:16 INFO - 'tpaint', 06:48:16 INFO - 'sessionrestore', 06:48:16 INFO - 'sessionrestore_no_auto_restore', 06:48:16 INFO - 'tabpaint']}, 06:48:16 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['tsvgx', 06:48:16 INFO - 'tsvgr_opacity', 06:48:16 INFO - 'tart', 06:48:16 INFO - 'tscrollx', 06:48:16 INFO - 'cart']}, 06:48:16 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:48:16 INFO - 'tsvgr_opacity', 06:48:16 INFO - 'tart', 06:48:16 INFO - 'tscrollx', 06:48:16 INFO - 'cart']}, 06:48:16 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:16 INFO - 'talos_options': ['--disable-e10s'], 06:48:16 INFO - 'tests': ['tp5o']}, 06:48:16 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:16 INFO - 'tests': ['tp5o']}, 06:48:16 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:16 INFO - 'talos_options': ['--disable-e10s', 06:48:16 INFO - '--xperf_path', 06:48:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:48:16 INFO - 'tests': ['tp5n']}, 06:48:16 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:48:16 INFO - 'talos_options': ['--xperf_path', 06:48:16 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:48:16 INFO - 'tests': ['tp5n']}}, 06:48:16 INFO - 'talos.zip': {'path': '', 06:48:16 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:48:16 INFO - Running post-action listener: _resource_record_post_action 06:48:16 INFO - [mozharness: 2016-10-25 13:48:16.245197Z] Finished populate-webroot step (success) 06:48:16 INFO - [mozharness: 2016-10-25 13:48:16.245285Z] Running create-virtualenv step. 06:48:16 INFO - Running pre-action listener: _resource_record_pre_action 06:48:16 INFO - Running main action method: create_virtualenv 06:48:16 INFO - Creating virtualenv /builds/slave/test/build/venv 06:48:16 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 06:48:16 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:48:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:48:16 INFO - Using real prefix '/usr' 06:48:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:48:16 INFO - Installing distribute.............................................................................................................................................................................................done. 06:48:18 INFO - Installing pip.................done. 06:48:18 INFO - Return code: 0 06:48:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:48:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:48:19 INFO - Reading from file tmpfile_stdout 06:48:19 INFO - Output received: 06:48:19 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) 06:48:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:48:19 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')]} 06:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:19 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')]} 06:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:19 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 0x7f66dc48ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24567b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', '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 06:48:19 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 06:48:19 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 06:48:19 INFO - Using env: {'DISPLAY': ':0', 06:48:19 INFO - 'HOME': '/home/cltbld', 06:48:19 INFO - 'LANG': 'en_US.UTF-8', 06:48:19 INFO - 'LANGUAGE': 'en_US:en', 06:48:19 INFO - 'LOGNAME': 'cltbld', 06:48:19 INFO - 'MAIL': '/var/mail/cltbld', 06:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:19 INFO - 'MOZ_NO_REMOTE': '1', 06:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:19 INFO - 'NO_EM_RESTART': '1', 06:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:19 INFO - 'PWD': '/builds/slave/test', 06:48:19 INFO - 'SHELL': '/bin/bash', 06:48:19 INFO - 'SHLVL': '1', 06:48:19 INFO - 'TERM': 'linux', 06:48:19 INFO - 'TMOUT': '86400', 06:48:19 INFO - 'USER': 'cltbld', 06:48:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:19 INFO - '_': '/tools/buildbot/bin/python'} 06:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:19 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 06:48:19 INFO - Cleaning up... 06:48:19 INFO - Return code: 0 06:48:19 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:48:19 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')]} 06:48:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:19 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')]} 06:48:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:19 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 0x7f66dc48ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24567b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', '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 06:48:19 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 06:48:19 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 06:48:19 INFO - Using env: {'DISPLAY': ':0', 06:48:19 INFO - 'HOME': '/home/cltbld', 06:48:19 INFO - 'LANG': 'en_US.UTF-8', 06:48:19 INFO - 'LANGUAGE': 'en_US:en', 06:48:19 INFO - 'LOGNAME': 'cltbld', 06:48:19 INFO - 'MAIL': '/var/mail/cltbld', 06:48:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:19 INFO - 'MOZ_NO_REMOTE': '1', 06:48:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:19 INFO - 'NO_EM_RESTART': '1', 06:48:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:19 INFO - 'PWD': '/builds/slave/test', 06:48:19 INFO - 'SHELL': '/bin/bash', 06:48:19 INFO - 'SHLVL': '1', 06:48:19 INFO - 'TERM': 'linux', 06:48:19 INFO - 'TMOUT': '86400', 06:48:19 INFO - 'USER': 'cltbld', 06:48:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:19 INFO - '_': '/tools/buildbot/bin/python'} 06:48:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:19 INFO - Downloading/unpacking psutil>=3.1.1 06:48:19 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 06:48:19 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 06:48:19 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 06:48:19 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 06:48:19 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 06:48:19 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 06:48:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:48:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:48:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:48:21 INFO - Installing collected packages: psutil 06:48:21 INFO - Running setup.py install for psutil 06:48:21 INFO - building 'psutil._psutil_linux' extension 06:48:21 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 06:48: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_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 06:48:21 INFO - building 'psutil._psutil_posix' extension 06:48:21 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 06:48: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 06:48:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:48:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:48:21 INFO - Successfully installed psutil 06:48:21 INFO - Cleaning up... 06:48:22 INFO - Return code: 0 06:48:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:48:22 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')]} 06:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:22 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')]} 06:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:22 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 0x7f66dc48ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24567b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', '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 06:48:22 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 06:48:22 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 06:48:22 INFO - Using env: {'DISPLAY': ':0', 06:48:22 INFO - 'HOME': '/home/cltbld', 06:48:22 INFO - 'LANG': 'en_US.UTF-8', 06:48:22 INFO - 'LANGUAGE': 'en_US:en', 06:48:22 INFO - 'LOGNAME': 'cltbld', 06:48:22 INFO - 'MAIL': '/var/mail/cltbld', 06:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:22 INFO - 'MOZ_NO_REMOTE': '1', 06:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:22 INFO - 'NO_EM_RESTART': '1', 06:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:22 INFO - 'PWD': '/builds/slave/test', 06:48:22 INFO - 'SHELL': '/bin/bash', 06:48:22 INFO - 'SHLVL': '1', 06:48:22 INFO - 'TERM': 'linux', 06:48:22 INFO - 'TMOUT': '86400', 06:48:22 INFO - 'USER': 'cltbld', 06:48:22 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:22 INFO - '_': '/tools/buildbot/bin/python'} 06:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:48:22 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 06:48:22 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 06:48:22 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 06:48:22 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 06:48:22 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 06:48:22 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 06:48:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:48:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:48:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:48:24 INFO - Installing collected packages: mozsystemmonitor 06:48:24 INFO - Running setup.py install for mozsystemmonitor 06:48:24 INFO - Successfully installed mozsystemmonitor 06:48:24 INFO - Cleaning up... 06:48:24 INFO - Return code: 0 06:48:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:48:24 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')]} 06:48:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:24 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')]} 06:48:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:24 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 0x7f66dc48ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24567b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', '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 06:48:24 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 06:48:24 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 06:48:24 INFO - Using env: {'DISPLAY': ':0', 06:48:24 INFO - 'HOME': '/home/cltbld', 06:48:24 INFO - 'LANG': 'en_US.UTF-8', 06:48:24 INFO - 'LANGUAGE': 'en_US:en', 06:48:24 INFO - 'LOGNAME': 'cltbld', 06:48:24 INFO - 'MAIL': '/var/mail/cltbld', 06:48:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:24 INFO - 'MOZ_NO_REMOTE': '1', 06:48:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:24 INFO - 'NO_EM_RESTART': '1', 06:48:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:24 INFO - 'PWD': '/builds/slave/test', 06:48:24 INFO - 'SHELL': '/bin/bash', 06:48:24 INFO - 'SHLVL': '1', 06:48:24 INFO - 'TERM': 'linux', 06:48:24 INFO - 'TMOUT': '86400', 06:48:24 INFO - 'USER': 'cltbld', 06:48:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:24 INFO - '_': '/tools/buildbot/bin/python'} 06:48:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:24 INFO - Downloading/unpacking jsonschema==2.5.1 06:48:24 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 06:48:24 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 06:48:24 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 06:48:24 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 06:48:24 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 06:48:24 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 06:48:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:48:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48:26 INFO - Downloading functools32-3.2.3-2.tar.gz 06:48:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:48:26 INFO - warning: no files found matching '*.txt' 06:48:26 INFO - no previously-included directories found matching 'build' 06:48:26 INFO - no previously-included directories found matching 'dist' 06:48:26 INFO - no previously-included directories found matching '.git*' 06:48:26 INFO - Installing collected packages: jsonschema, functools32 06:48:26 INFO - Running setup.py install for functools32 06:48:26 INFO - warning: no files found matching '*.txt' 06:48:26 INFO - no previously-included directories found matching 'build' 06:48:26 INFO - no previously-included directories found matching 'dist' 06:48:26 INFO - no previously-included directories found matching '.git*' 06:48:26 INFO - Successfully installed jsonschema functools32 06:48:26 INFO - Cleaning up... 06:48:27 INFO - Return code: 0 06:48:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:48:27 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')]} 06:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:27 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')]} 06:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:27 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 0x7f66dc48ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24567b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', '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 06:48:27 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 06:48:27 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 06:48:27 INFO - Using env: {'DISPLAY': ':0', 06:48:27 INFO - 'HOME': '/home/cltbld', 06:48:27 INFO - 'LANG': 'en_US.UTF-8', 06:48:27 INFO - 'LANGUAGE': 'en_US:en', 06:48:27 INFO - 'LOGNAME': 'cltbld', 06:48:27 INFO - 'MAIL': '/var/mail/cltbld', 06:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:27 INFO - 'MOZ_NO_REMOTE': '1', 06:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:27 INFO - 'NO_EM_RESTART': '1', 06:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:27 INFO - 'PWD': '/builds/slave/test', 06:48:27 INFO - 'SHELL': '/bin/bash', 06:48:27 INFO - 'SHLVL': '1', 06:48:27 INFO - 'TERM': 'linux', 06:48:27 INFO - 'TMOUT': '86400', 06:48:27 INFO - 'USER': 'cltbld', 06:48:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:27 INFO - '_': '/tools/buildbot/bin/python'} 06:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:48:27 INFO - Cleaning up... 06:48:27 INFO - Return code: 0 06:48:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:48:27 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')]} 06:48:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:27 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')]} 06:48:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:27 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 0x7f66dc48ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24567b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', '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 06:48:27 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 06:48:27 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 06:48:27 INFO - Using env: {'DISPLAY': ':0', 06:48:27 INFO - 'HOME': '/home/cltbld', 06:48:27 INFO - 'LANG': 'en_US.UTF-8', 06:48:27 INFO - 'LANGUAGE': 'en_US:en', 06:48:27 INFO - 'LOGNAME': 'cltbld', 06:48:27 INFO - 'MAIL': '/var/mail/cltbld', 06:48:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:27 INFO - 'MOZ_NO_REMOTE': '1', 06:48:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:27 INFO - 'NO_EM_RESTART': '1', 06:48:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:27 INFO - 'PWD': '/builds/slave/test', 06:48:27 INFO - 'SHELL': '/bin/bash', 06:48:27 INFO - 'SHLVL': '1', 06:48:27 INFO - 'TERM': 'linux', 06:48:27 INFO - 'TMOUT': '86400', 06:48:27 INFO - 'USER': 'cltbld', 06:48:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:27 INFO - '_': '/tools/buildbot/bin/python'} 06:48:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:27 INFO - Downloading/unpacking blobuploader==1.2.4 06:48:27 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 06:48:27 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 06:48:27 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 06:48:27 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 06:48:27 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 06:48:27 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 06:48:29 INFO - Downloading blobuploader-1.2.4.tar.gz 06:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:48:29 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:48:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48: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 06:48:30 INFO - Downloading docopt-0.6.1.tar.gz 06:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:48:30 INFO - Installing collected packages: blobuploader, requests, docopt 06:48:30 INFO - Running setup.py install for blobuploader 06:48:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:48:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:48:30 INFO - Running setup.py install for requests 06:48:30 INFO - Running setup.py install for docopt 06:48:30 INFO - Successfully installed blobuploader requests docopt 06:48:30 INFO - Cleaning up... 06:48:30 INFO - Return code: 0 06:48:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:30 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 0x7f66dc48ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24567b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', '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 06:48:30 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 06:48:30 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 06:48:30 INFO - Using env: {'DISPLAY': ':0', 06:48:30 INFO - 'HOME': '/home/cltbld', 06:48:30 INFO - 'LANG': 'en_US.UTF-8', 06:48:30 INFO - 'LANGUAGE': 'en_US:en', 06:48:30 INFO - 'LOGNAME': 'cltbld', 06:48:30 INFO - 'MAIL': '/var/mail/cltbld', 06:48:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:30 INFO - 'MOZ_NO_REMOTE': '1', 06:48:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:30 INFO - 'NO_EM_RESTART': '1', 06:48:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:30 INFO - 'PWD': '/builds/slave/test', 06:48:30 INFO - 'SHELL': '/bin/bash', 06:48:30 INFO - 'SHLVL': '1', 06:48:30 INFO - 'TERM': 'linux', 06:48:30 INFO - 'TMOUT': '86400', 06:48:30 INFO - 'USER': 'cltbld', 06:48:30 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:30 INFO - '_': '/tools/buildbot/bin/python'} 06:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:31 INFO - Running setup.py (path:/tmp/pip-hMlW5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:31 INFO - Running setup.py (path:/tmp/pip-IU1UA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:31 INFO - Running setup.py (path:/tmp/pip-HSBuhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:31 INFO - Running setup.py (path:/tmp/pip-13Lzlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:31 INFO - Running setup.py (path:/tmp/pip-2yXM0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:31 INFO - Running setup.py (path:/tmp/pip-lhkqHt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:31 INFO - Running setup.py (path:/tmp/pip-GZf7RA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:31 INFO - Running setup.py (path:/tmp/pip-_Du0qh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:31 INFO - Running setup.py (path:/tmp/pip-JqJrBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:31 INFO - Running setup.py (path:/tmp/pip-2BKRzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:31 INFO - Running setup.py (path:/tmp/pip-avAMKC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:31 INFO - Running setup.py (path:/tmp/pip-e88Oh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:31 INFO - Running setup.py (path:/tmp/pip-mqnNkO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:31 INFO - Running setup.py (path:/tmp/pip-6Cb6xw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:32 INFO - Running setup.py (path:/tmp/pip-r5ZUT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:32 INFO - Running setup.py (path:/tmp/pip-3bxmZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:32 INFO - Running setup.py (path:/tmp/pip-atIUQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:48:32 INFO - Running setup.py install for manifestparser 06:48:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:48:32 INFO - Running setup.py install for mozcrash 06:48:32 INFO - Running setup.py install for mozdebug 06:48:32 INFO - Running setup.py install for mozdevice 06:48:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:48:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:48:32 INFO - Running setup.py install for mozfile 06:48:32 INFO - Running setup.py install for mozhttpd 06:48:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:48:32 INFO - Running setup.py install for mozinfo 06:48:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:48:32 INFO - Running setup.py install for mozInstall 06:48:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:48:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:48:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:48:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:48:33 INFO - Running setup.py install for mozleak 06:48:33 INFO - Running setup.py install for mozlog 06:48:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:48:33 INFO - Running setup.py install for moznetwork 06:48:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:48:33 INFO - Running setup.py install for mozprocess 06:48:33 INFO - Running setup.py install for mozprofile 06:48:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:48:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:48:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:48:33 INFO - Running setup.py install for mozrunner 06:48:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:48:33 INFO - Running setup.py install for mozscreenshot 06:48:33 INFO - Running setup.py install for moztest 06:48:33 INFO - Running setup.py install for mozversion 06:48:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:48:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:48:34 INFO - Cleaning up... 06:48:34 INFO - Return code: 0 06:48:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:34 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 0x7f66dc48ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24567b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', '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 06:48:34 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 06:48:34 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 06:48:34 INFO - Using env: {'DISPLAY': ':0', 06:48:34 INFO - 'HOME': '/home/cltbld', 06:48:34 INFO - 'LANG': 'en_US.UTF-8', 06:48:34 INFO - 'LANGUAGE': 'en_US:en', 06:48:34 INFO - 'LOGNAME': 'cltbld', 06:48:34 INFO - 'MAIL': '/var/mail/cltbld', 06:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:34 INFO - 'MOZ_NO_REMOTE': '1', 06:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:34 INFO - 'NO_EM_RESTART': '1', 06:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:34 INFO - 'PWD': '/builds/slave/test', 06:48:34 INFO - 'SHELL': '/bin/bash', 06:48:34 INFO - 'SHLVL': '1', 06:48:34 INFO - 'TERM': 'linux', 06:48:34 INFO - 'TMOUT': '86400', 06:48:34 INFO - 'USER': 'cltbld', 06:48:34 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:34 INFO - '_': '/tools/buildbot/bin/python'} 06:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:48:34 INFO - Running setup.py (path:/tmp/pip-YKpzY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:48:34 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)) 06:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:48:34 INFO - Running setup.py (path:/tmp/pip-eLc29v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:48:34 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)) 06:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:48:34 INFO - Running setup.py (path:/tmp/pip-UKaV0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:48:34 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)) 06:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:48:34 INFO - Running setup.py (path:/tmp/pip-yhIap6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:48:34 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)) 06:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:48:34 INFO - Running setup.py (path:/tmp/pip-t_zku1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:48:34 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)) 06:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:48:34 INFO - Running setup.py (path:/tmp/pip-aL4jHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:48:34 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)) 06:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:48:34 INFO - Running setup.py (path:/tmp/pip-MJclNS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:48:34 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)) 06:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:48:34 INFO - Running setup.py (path:/tmp/pip-klLMDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:48:34 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)) 06:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:48:34 INFO - Running setup.py (path:/tmp/pip-61Sl2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:48: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)) 06:48:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:48:34 INFO - Running setup.py (path:/tmp/pip-RjjDro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:48:35 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)) 06:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:48:35 INFO - Running setup.py (path:/tmp/pip-UQFhgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:48:35 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)) 06:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:48:35 INFO - Running setup.py (path:/tmp/pip-SwMoJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:48:35 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)) 06:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:48:35 INFO - Running setup.py (path:/tmp/pip-f_TOvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:48:35 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)) 06:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:48:35 INFO - Running setup.py (path:/tmp/pip-UVHE06-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:48:35 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)) 06:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:35 INFO - Running setup.py (path:/tmp/pip-dXfZX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:48:35 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)) 06:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:48:35 INFO - Running setup.py (path:/tmp/pip-YJ2XIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:48:35 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)) 06:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:48:35 INFO - Running setup.py (path:/tmp/pip-UsHbYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:48:35 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)) 06:48:35 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)) 06:48:35 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)) 06:48:35 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)) 06:48:35 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)) 06:48:35 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)) 06:48:35 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:48:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:48:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:48:37 INFO - Downloading blessings-1.6.tar.gz 06:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:48:37 INFO - Installing collected packages: blessings 06:48:37 INFO - Running setup.py install for blessings 06:48:37 INFO - Successfully installed blessings 06:48:37 INFO - Cleaning up... 06:48:37 INFO - Return code: 0 06:48:37 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:48:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:38 INFO - Reading from file tmpfile_stdout 06:48:38 INFO - Current package versions: 06:48:38 INFO - argparse == 1.2.1 06:48:38 INFO - blessings == 1.6 06:48:38 INFO - blobuploader == 1.2.4 06:48:38 INFO - docopt == 0.6.1 06:48:38 INFO - functools32 == 3.2.3-2 06:48:38 INFO - jsonschema == 2.5.1 06:48:38 INFO - manifestparser == 1.1 06:48:38 INFO - mozInstall == 1.12 06:48:38 INFO - mozcrash == 0.17 06:48:38 INFO - mozdebug == 0.1 06:48:38 INFO - mozdevice == 0.48 06:48:38 INFO - mozfile == 1.2 06:48:38 INFO - mozhttpd == 0.7 06:48:38 INFO - mozinfo == 0.9 06:48:38 INFO - mozleak == 0.1 06:48:38 INFO - mozlog == 3.4 06:48:38 INFO - moznetwork == 0.27 06:48:38 INFO - mozprocess == 0.23 06:48:38 INFO - mozprofile == 0.28 06:48:38 INFO - mozrunner == 6.12 06:48:38 INFO - mozscreenshot == 0.1 06:48:38 INFO - mozsystemmonitor == 0.3 06:48:38 INFO - moztest == 0.7 06:48:38 INFO - mozversion == 1.4 06:48:38 INFO - psutil == 3.1.1 06:48:38 INFO - requests == 1.2.3 06:48:38 INFO - wsgiref == 0.1.2 06:48:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:38 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 0x7f66dc48ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24567b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', '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 06:48:38 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 06:48:38 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 06:48:38 INFO - Using env: {'DISPLAY': ':0', 06:48:38 INFO - 'HOME': '/home/cltbld', 06:48:38 INFO - 'LANG': 'en_US.UTF-8', 06:48:38 INFO - 'LANGUAGE': 'en_US:en', 06:48:38 INFO - 'LOGNAME': 'cltbld', 06:48:38 INFO - 'MAIL': '/var/mail/cltbld', 06:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:38 INFO - 'MOZ_NO_REMOTE': '1', 06:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:38 INFO - 'NO_EM_RESTART': '1', 06:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:38 INFO - 'PWD': '/builds/slave/test', 06:48:38 INFO - 'SHELL': '/bin/bash', 06:48:38 INFO - 'SHLVL': '1', 06:48:38 INFO - 'TERM': 'linux', 06:48:38 INFO - 'TMOUT': '86400', 06:48:38 INFO - 'USER': 'cltbld', 06:48:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:38 INFO - '_': '/tools/buildbot/bin/python'} 06:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:38 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)) 06:48:38 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)) 06:48:38 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)) 06:48:38 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)) 06:48:38 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)) 06:48:38 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)) 06:48:38 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)) 06:48:38 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)) 06:48:38 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)) 06:48:38 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)) 06:48:38 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)) 06:48:38 INFO - Cleaning up... 06:48:38 INFO - Return code: 0 06:48:38 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:48:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f66dc48ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24567b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, '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': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', '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 06:48:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 06:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 06:48:38 INFO - Using env: {'DISPLAY': ':0', 06:48:38 INFO - 'HOME': '/home/cltbld', 06:48:38 INFO - 'LANG': 'en_US.UTF-8', 06:48:38 INFO - 'LANGUAGE': 'en_US:en', 06:48:38 INFO - 'LOGNAME': 'cltbld', 06:48:38 INFO - 'MAIL': '/var/mail/cltbld', 06:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:38 INFO - 'MOZ_NO_REMOTE': '1', 06:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:38 INFO - 'NO_EM_RESTART': '1', 06:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:38 INFO - 'PWD': '/builds/slave/test', 06:48:38 INFO - 'SHELL': '/bin/bash', 06:48:38 INFO - 'SHLVL': '1', 06:48:38 INFO - 'TERM': 'linux', 06:48:38 INFO - 'TMOUT': '86400', 06:48:38 INFO - 'USER': 'cltbld', 06:48:38 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:38 INFO - '_': '/tools/buildbot/bin/python'} 06:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:48:38 INFO - Cleaning up... 06:48:38 INFO - Return code: 0 06:48:38 INFO - Running post-action listener: _resource_record_post_action 06:48:38 INFO - Running post-action listener: _start_resource_monitoring 06:48:38 INFO - Starting resource monitoring. 06:48:38 INFO - [mozharness: 2016-10-25 13:48:38.615986Z] Finished create-virtualenv step (success) 06:48:38 INFO - [mozharness: 2016-10-25 13:48:38.616495Z] Running install step. 06:48:38 INFO - Running pre-action listener: _resource_record_pre_action 06:48:38 INFO - Running main action method: install 06:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:48:38 INFO - Reading from file tmpfile_stdout 06:48:38 INFO - Detecting whether we're running mozinstall >=1.0... 06:48:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:48:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:48:38 INFO - Reading from file tmpfile_stdout 06:48:38 INFO - Output received: 06:48:38 INFO - Usage: mozinstall [options] installer 06:48:38 INFO - Options: 06:48:38 INFO - -h, --help show this help message and exit 06:48:38 INFO - -d DEST, --destination=DEST 06:48:38 INFO - Directory to install application into. [default: 06:48:38 INFO - "/builds/slave/test"] 06:48:38 INFO - --app=APP Application being installed. [default: firefox] 06:48:38 INFO - mkdir: /builds/slave/test/build/application 06:48:38 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'] 06:48:38 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 06:48:55 INFO - Reading from file tmpfile_stdout 06:48:55 INFO - Output received: 06:48:55 INFO - /builds/slave/test/build/application/firefox/firefox 06:48:55 INFO - Running post-action listener: _resource_record_post_action 06:48:55 INFO - [mozharness: 2016-10-25 13:48:55.813160Z] Finished install step (success) 06:48:55 INFO - [mozharness: 2016-10-25 13:48:55.813503Z] Running run-tests step. 06:48:55 INFO - Running pre-action listener: _resource_record_pre_action 06:48:55 INFO - Running main action method: run_tests 06:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:48:55 INFO - Python 2.7.3 06:48:55 INFO - Return code: 0 06:48:55 INFO - grabbing minidump binary from tooltool 06:48:55 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')]} 06:48:55 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 0x24e5790>, '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 0x24e6690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e6b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:48:55 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 06:48:55 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 06:48:55 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 06:48:55 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:48:55 INFO - Return code: 0 06:48:55 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:48:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:48:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:48:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:48:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:48:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 06:48:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 06:48:55 INFO - Using env: {'DISPLAY': ':0', 06:48:55 INFO - 'HOME': '/home/cltbld', 06:48:55 INFO - 'LANG': 'en_US.UTF-8', 06:48:55 INFO - 'LANGUAGE': 'en_US:en', 06:48:55 INFO - 'LOGNAME': 'cltbld', 06:48:55 INFO - 'MAIL': '/var/mail/cltbld', 06:48:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:48:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:48:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:48:55 INFO - 'MOZ_NO_REMOTE': '1', 06:48:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:48:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:48:55 INFO - 'NO_EM_RESTART': '1', 06:48:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:48:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:48:55 INFO - 'PWD': '/builds/slave/test', 06:48:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:48:55 INFO - 'SHELL': '/bin/bash', 06:48:55 INFO - 'SHLVL': '1', 06:48:55 INFO - 'TERM': 'linux', 06:48:55 INFO - 'TMOUT': '86400', 06:48:55 INFO - 'USER': 'cltbld', 06:48:55 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207', 06:48:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:48:55 INFO - '_': '/tools/buildbot/bin/python'} 06:48:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 06:48:56 INFO - mozversion application_buildid: 20161025033004 06:48:56 INFO - mozversion application_changeset: 78b863e9fcd9d44d75c817b6495b4585167ba255 06:48:56 INFO - mozversion application_display_name: Nightly 06:48:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:48:56 INFO - mozversion application_name: Firefox 06:48:56 INFO - mozversion application_remotingname: firefox 06:48:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:48:56 INFO - mozversion application_vendor: Mozilla 06:48:56 INFO - mozversion application_version: 52.0a1 06:48:56 INFO - mozversion platform_buildid: 20161025033004 06:48:56 INFO - mozversion platform_changeset: 78b863e9fcd9d44d75c817b6495b4585167ba255 06:48:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:48:56 INFO - mozversion platform_version: 52.0a1 06:48:56 INFO - using testdate: 1477403336 06:48:56 INFO - actual date: 1477403336 06:48:56 INFO - starting webserver on 'localhost:51090' 06:48:56 INFO - SUITE-START | Running 2 tests 06:48:56 INFO - TEST-START | dromaeo_css 06:48:56 INFO - operating with platform_type : linux_ 06:48:56 INFO - Initialising browser for dromaeo_css test... 06:48:56 INFO - TEST-INFO | started process 19196 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSZHeNf/profile http://localhost:51090/getInfo.html) 06:48:59 INFO - PROCESS | 19196 | __metrics Screen width/height:1600/1200 06:48:59 INFO - PROCESS | 19196 | colorDepth:24 06:48:59 INFO - PROCESS | 19196 | Browser inner width/height: 1024/697 06:48:59 INFO - PROCESS | 19196 | __metrics 06:49:00 INFO - PROCESS | 19196 | 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" 06:49:00 INFO - PROCESS | 19196 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:49:01 INFO - PROCESS | 19196 | console.error: PushService: 06:49:01 INFO - PROCESS | 19196 | stateChangeProcessEnqueue: Error transitioning state 06:49:01 INFO - PROCESS | 19196 | UnknownError 06:49:01 INFO - TEST-INFO | 19196: exit 0 06:49:01 INFO - Browser initialized. 06:49:01 INFO - Running cycle 1/1 for dromaeo_css test... 06:49:01 INFO - TEST-INFO | started process 19281 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSZHeNf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:49:13 INFO - PROCESS | 19281 | RSS: Main: 171393024 06:49:13 INFO - PROCESS | 19281 | 06:50:04 INFO - PROCESS | 19281 | 1477403404921 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] 06:52:16 INFO - PROCESS | 19281 | Cycle 1(1): loaded http://localhost:51090/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51090/tests/dromaeo/cssquery-ext.html) 06:52:18 INFO - PROCESS | 19281 | RSS: Main: 317984768 06:52:18 INFO - PROCESS | 19281 | 06:55:20 INFO - PROCESS | 19281 | Cycle 1(1): loaded http://localhost:51090/tests/dromaeo/cssquery-ext.html (next: http://localhost:51090/tests/dromaeo/cssquery-jquery.html) 06:55:21 INFO - PROCESS | 19281 | RSS: Main: 282001408 06:55:21 INFO - PROCESS | 19281 | 06:58:23 INFO - PROCESS | 19281 | Cycle 1(1): loaded http://localhost:51090/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51090/tests/dromaeo/cssquery-mootools.html) 06:58:24 INFO - PROCESS | 19281 | RSS: Main: 220168192 06:58:24 INFO - PROCESS | 19281 | 07:01:26 INFO - PROCESS | 19281 | Cycle 1(1): loaded http://localhost:51090/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51090/tests/dromaeo/cssquery-prototype.html) 07:01:26 INFO - PROCESS | 19281 | RSS: Main: 227348480 07:01:26 INFO - PROCESS | 19281 | 07:04:29 INFO - PROCESS | 19281 | Cycle 1(1): loaded http://localhost:51090/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51090/tests/dromaeo/cssquery-yui.html) 07:04:30 INFO - PROCESS | 19281 | RSS: Main: 220979200 07:04:30 INFO - PROCESS | 19281 | 07:07:33 INFO - PROCESS | 19281 | Cycle 1(1): loaded http://localhost:51090/tests/dromaeo/cssquery-yui.html (next: http://localhost:51090/tests/dromaeo/cssquery-dojo.html) 07:07:33 INFO - PROCESS | 19281 | RSS: Main: 312754176 07:07:33 INFO - PROCESS | 19281 | 07:07:33 INFO - PROCESS | 19281 | __start_tp_report 07:07:33 INFO - PROCESS | 19281 | _x_x_mozilla_page_load 07:07:33 INFO - PROCESS | 19281 | _x_x_mozilla_page_load_details 07:07:33 INFO - PROCESS | 19281 | |i|pagename|runs| 07:07:33 INFO - PROCESS | 19281 | |0;dojo.html;3097.0399176255364;3115.5482455044007;3145.795523290986;3156.0374085903804;3160.668129846366;5249.947500524993;5262.079136151167;5340.866478338039;5423.349198096229;5435.619506634537;5350.464953504647;5366.812161574346;5372.7313634318225;5378.381486129097;5387.4073851876265;4855.198892182794;4872.561469467747;4891.388576427947;4920.8277710280145;4958.355413796201;4938.901221975559;5009.724465154415;5010.223415370605;5012.198048312271;5017.021680772251;4928.728919909404;4958.404991401037;4981.427135879384;4996.275540046691;5005.699658020512;5014.02226565818;5032.370953630796;5038.722870242135;5045.167547354682;5097.209932460438;4814.542618451242;4857.514248575114;4863.003084367696;4938.1111399947995;4946.2580612908;5339.733013349317;5378.784848606051;5383.300170977787;5406.675599464044;5492.286002819648;5744.913826292609;5771.451712087345;5776.4801167894675;5776.508996735282;5781.913271300934;5738.397468265814;5750.367459579443;5792.218050563162;5798.333191682968;5800.419958004208;5387.272718183073;5418.834950485664;5423.783048678088;5474.972625136928;5484.177373393943;5910.290765108214;5910.586258961917;5915.467607915309;5920.111983202468;5921.822345329647;5541.251930989345;5650.3502097258515;5661.547076233891;5662.5753068520025;5670.376258611549;5656.2929633795775;5735.254416925773;5735.8528294341295;5735.942640573541;5737.684427356452;5669.31968163823;5706.115552089433;5710.8001219957105;5718.170865224519;5725;5716.514096301861;5717.971410142923;5728.885422291531;5731.111677689964;5732.226149469851;4389.495208051051;4393.253146965024;4398.47218333802;4398.626116780109;4398.670099742532;3964.1278918637854;3972.08642012333;3974;3974.642282194616;3974.980125099356;5453.836384908459;5484.8354549363585;5494.642848214853;5499.972500137554;5500.972495137578;5726.112452569859;5801.216835727208;5821.767129314865;5822.1266809978;5824.650520968756;5456.890862182734;5468.261784659099;5477.75350109246;5478.096114141202;5489.862753431116;4904.60763138948;4950.257461380822;4954.727489988085;4988.127077761377;5043.697378157322;5980.641161530322;6025.18659980897;6026.035834266497;6061.515078793686;6093.421124993119;5817.825465236049;5823.301203855564;5824.912626310524;5825.330087040044;5833.066709326487;5853.707314634336;5897.970510147422;5996.910046349221;5998.430149135826;6000.039993601003;5653.915191272052;5662.8301150965535;5683.7442315095095;5721.885562288648;5790.305163380252;5826.854328641818;5828.883422331445;5836.678982655994;5840.386759390372;5844.26946631671;5539.446055394589;5545.306836645419;5663.32040155184;5667.121596152603;5675.035244008446;5567.749451274622;5588.329400471969;5631.211630371669;5648.943510564842;5711.857203569944;5582.637128586629;5608.383077861514;5616.157576363578;5629.127485239795;5635.971820140873;5577.8047768327915;5674.716264186692;5681.062624667049;5685.090385538294;5689.829305120853;5445.891082178255;5453.182022696627;5459.535939445032;5491.423400543045;5539.944600553943 07:07:33 INFO - PROCESS | 19281 | |1;ext.html;556.3185098254638;584.0654952076678;586.3023002626874;598.9727617136609;601.2574470528899;31662;32409;43292.48476303326;44160.558394416046;44294.335584966255;45730;46083;46154.538454615446;46176.3073553897;46238.30642540364;8933.731988040354;9082.137196966278;9092.136247056518;9093.863592046124;9094.681686140986;8071.717489887855;8251.381146414044;10563.207759418035;10813.621523246688;10816.459177041155;10984.560617575327;11047.281926674781;11074.114070874351;11080.944595277053;11090.279131856443;10764.416540030335;10843.891561084407;10873.347599143997;10917.945410272938;10921.672349829518;10493.895061049368;10557.577696892115;10566.894331056668;10567.682969510926;10571.471426428649;41801.790991045156;42123.368149477785;42236;42240.577594224276;42275;3289.983550082234;3373.96626033739;3385.661433856619;3679.466477360768;3932.0956180078456;30952.380952380827;32049.6795032049;32053.51919721206;32199.356012879845;32329;4185.895352616179;4266.893327666833;4290.42079319291;4351.129774045204;4493.326001099828;325997;326373;327623;328855;328959;57168.42831571631;57609;57917.71041144852;58140.70929645409;58178.7091064542;62080.37919620836;62562.374376256565;62626.686866565375;62688.37311626825;62704.68647656824;14069.155850648995;14249.715005699827;14251.643708907153;14255.714885702228;14263.07290026145;10176.491175441199;10183.949080254552;10184.490775461198;10256.846147307797;10638;16880;17327.094019657827;17423;17455;17479.38822141219;5772.884542309214;5810.970945145247;5862;6001.339852616209;6012.158297838306;898.3980732908967;928.3779867488798;969.6460791810938;983.5475681186591;1057.4289883462843;30018.099457016324;30061.549076763866;30206.54690179649;30224.44977119193;30333.848330758206;1054.1988089052375;1073.1146803886825;1093.327603523827;1115.8660960684608;1129.4691494997337;15851.445199418196;15900.840991589936;16314.347426102822;16372.754408683879;16575.25411356492;128776;490363;500272.99181024625;502447;738586;57074;57744.42255577474;57794.999999999156;57834.421655782906;57878.42121578815;1205.7889869273017;1233.481937586216;1287.8712128787233;1289.6711338608782;1310.600266918599;30459;35201.29597407986;35469.29061418809;35496.64503355037;35560;54586.454135459724;55116;55171;55213;55261.44738552724;431626;433762;434758;436418;437967;23816.761832382148;24480.51038979246;26134.778543823988;27195.864020679768;27243.182704518895;45768;47558.762206190135;47672.2849157256;49110.75444622754;52619.473805261456;39094.80452597719;40097.39853902252;40833.18333633251;41574.584254157075;42631.36052959146;40412.53399456073;40540.59459405486;41161;41645.375319369625;42038.36942445927;40576.79711601423;41657;41700.58299416967;42070.78964605158;42132.78933605312;32836.50745238871;35270.64729352674;36114;36507;36544;26859.865700671373;26955.86522067377;27377.726222738314;27394.452110958067;27425.86287068552 07:07:33 INFO - PROCESS | 19281 | |2;jquery.html;361.65461983805466;378.42668357438504;387.90496328399547;394.986175483858;415.7276983575757;14433.566992990201;18245.452636420912;18932.810671893294;19497.61004779907;19709.113089910952;16535.83464165358;16646.24244054559;16990.32038718453;17013.2344044518;17045.977241365526;5512.228288039678;5826.504747096481;5826.825195244128;5829.242198514208;5831.183634291203;4198.727082739628;4337.761423121727;5734.483896449318;5735.569832262576;6413.8717225655455;6451.7096730647;6481.09264702942;6487.253965793923;6497.350264973488;6498.155239818817;6239.2824825145235;6387.041943708435;6418.19772528434;6431.42117209451;6431.646259455728;5465;5540.473655002768;5646.237757902672;5672.829815105512;5679.914801277984;21909.890450547806;22208;22212.555748884934;23020.964056617493;23113.653295200584;2547.312225699051;2702.7567518923192;2798.6221860048836;2823.9576406353717;3031.2876474028585;14231.85768142326;14306.356213970397;14343.56969290923;14397.712045759026;14941.551753447415;1896.1656870976865;1898.734177215191;1912.6652835753825;1919.2323070771663;1952.2581419060807;78881;78974.96913009346;79678;79971.6001419995;80754.59622701908;8880.1563851434;9483.099105584959;9489.90510094904;9631.436368543684;10352.585896564053;13061.281629510468;13153.60539183826;13162.078654494093;13163.407646655924;13170.07809453329;6992.79021629352;7010.964945175241;7206.099237595301;7225.74709885162;7266.200717921024;6696.096027036385;6709.463242940553;6808.863822723518;6962.895556566656;7082.681279342442;3979.6219359161414;3985.940210896839;4007.7394969327484;4089.2639324921206;4166.0834616384345;1785.8749887508009;1793.8923664580168;1814.383109742694;1816.1827177770056;1845.6124213915227;889.8487257166297;928.7167413938679;935.780091678455;968.5351031504918;1024.8360262357987;18049.187786549635;19658;19780.30768923081;20002.799972000095;20060.799392006185;936.6628013914985;966.3622009473713;990.8513722941473;993.1210878372692;1000.1348833259324;10316.638917637847;11033.503492342863;11064.557417703201;11102.389368584805;11110.833337499944;428815;439059;448738;449683;453937;56572.717136414874;73622.63188684022;88283.11716882877;94912.52543737237;96582.51708741412;990.945497997617;1010.939343639384;1021.5760459409411;1035.7151783259665;1043.6399442192583;14112.506062288181;16727.414540491023;17546.210420531363;17672.116394180495;17940.820591793916;41047.794761026;41413.792931035154;41832;41842.79078604587;43376;54608.45391546033;57229.427705724076;59542;60095.611645059165;61870.38129618646;8373.33013358942;8441.493510389397;8568.957155214184;8752.956235218782;8755.912440875765;9669.70990870275;12944.139695560829;13765.862341376458;13855.37650805696;13987.860121399062;11518;11688.88311116878;11753.529858805552;11825.113116516124;11895.345755983504;11353.432328383713;11520.654380368602;11722.179447438597;11815.70460738454;12003;11802.82295765547;12005;12026.639200823989;12088.637340879788;12202.81695774582;7039.296070392919;7385.113786345458;8301.916980830114;8688.13118688126;8843.91156088431;10386;11698.824517632072;11802.704932376759;11851.288922664668;12297.294595189043 07:07:33 INFO - PROCESS | 19281 | |3;mootools.html;1292.2182079841689;1428.2858570714643;1491.2990894279687;1591.2123498868061;1760.683077046131;7434.479586428952;8434.704785332515;8645.438046526971;8657.567121643908;8856.158664926821;8624.26693731032;8695.304375649948;8703.91296087039;8707.869381959259;8711.215990560848;2260.4348912771766;2278.7580768481134;2279.4415368234722;2281.9885900570557;2285.63429851223;2237.641977283635;2286.16554957441;2294.093832935989;2295.8048565871923;2300.919467818627;2274.8293877959136;2287.2795069553035;2305.7924786769186;2312.629979203319;2327.1156960355124;2215.944601384962;2231.7210348706412;2233.1290796589424;2236.2173239366175;2247.9325620231257;2198.5712786006734;2202.2072054060686;2204.7244094488187;2205.8014778669835;2207.7129973103556;8545.27365173961;8575.914240857574;8585.441946273471;8599.699010534601;8695.478271303742;5123;5326.094563924142;5329.786808527654;5332.30680011596;5367.2485851980755;3287.3589650018257;3437.3984552703178;3491.2319289756465;3509.7016753575977;3532.3288575170636;1069.4652673663168;1113.4544073404054;1117.814672315621;1134.444122380036;1137.124414201069;12026.939865300617;12087.637370878887;12220.511179552806;12227.14409991301;12239.265644061385;4249.447571815706;4376.365427013129;4545.227311357077;4550.203714349976;4594.862154135381;9610.711678649652;9628.614855405845;9630.47032413224;9632.90367096334;9642.903570964341;5266.578673706171;5274.446183150791;5278.287431196816;5278.788848446096;5280.366356037223;4135;4344.478662560513;4397.560243975641;4423.977880110643;4942.777575009133;3606.6032736398975;3629.5281613390616;3716.6655001050035;3719;3735.1969326594913;1106.8450416941473;1110.5724296146043;1124.2355198465123;1127.7575321305958;1167.830664553652;859.4413631139685;863.2144748279161;897.708244820436;908.8273228086642;942.1379437814323;5657.405972372924;5707.71461426927;5815.912761308584;5831.562632802472;6011.278646562353;868.4832524647825;876.8114855306139;891.572045418203;896.6413434626202;902.120432578231;3720.516332876763;3887.8833634990997;3914.2758589661003;3937.3897045957924;3948.58539853317;10850.457477126112;10991.945040274908;11094.278871873303;11166.162537809696;11205.775884482264;10953.945230273797;10972.341659500455;10983.066439352584;10987.121030317556;10994.065504432054;7859.371250299962;8062.355011599058;8064.55644939534;8171.223733745284;8283.668653253802;5707.831024210774;5821.330546987151;5830.62100963436;5947.137665038632;5979.611325263844;9438.48088355147;9668.468234247184;9769;9798.314118011956;9838.212942964688;8902.910970890209;9094.636214551343;9857.704268871945;9984.400935943866;9992.10071093605;7485.438592105723;7725.111612164673;7834.451588388758;7911.050673919167;8090.555019473985;8287.41988060854;8347.415680902279;8381.916180838114;8395.496270223806;8401.495910245405;7228.674709637974;7511.399088072832;7529.698812047457;7555.055618047744;7653.119891212582;7131.393831524171;7207.13514378257;7212.855742885008;7259.891101633374;7298.744543940937;6567.770128045687;6599.185224063421;6654.201495820533;6660.333966603494;6672.266050734318;4801.5438533339275;4956.405231372259;5005.549500544968;5007.223880298559;5037.471065538066;4580.908381832278;4588.862334129982;4623.630109591158;4649.418822647169;4741.466795376379 07:07:33 INFO - PROCESS | 19281 | |4;prototype.html;326.5346880695009;326.75656635806314;331.3075671845842;335.89083547846957;342.2982885085574;5201.921971170426;5317.361916570012;5340.706261155635;5381.892362152755;5384.811531596395;5102.132637451633;5174.611904107188;5195.324607800981;5218.1650935850275;5223.86940326492;4121.278776214151;4128.071183983609;4130.132672138847;4135.710500264982;4138.441310423084;4027.295223335919;4123.855665051724;4137.9172416551655;4155.106652069804;4182.832686692529;4061.4923134608175;4084.6732261419015;4091.365838295069;4108.774017429055;4126.6079722426475;4084.223997440477;4088.4480595119576;4094.5259706505785;4099.754014759094;4120.608542188517;3635.600083990759;3638.5815631202486;3646.74472786905;3655.1227705350525;3671.1739858531882;4976.328195693572;5097.311862898536;5123.308353372322;5128.794733237686;5165.63840531163;4673.182193116225;4734.668573199878;4748.171953797778;4755.286706993944;4755.904881902377;5447.700376479292;5460.426655201187;5474.178873169017;5487.067198576252;5499.670019798825;3806.1816709407335;3976.622220889011;3985.9800700996598;3992.920141597152;3996;5719.742611582489;5738.913916291259;5743.483086522191;5782.161586569924;5786.305643322786;4075.857344992911;4083.530394004668;4093.815778289984;4105.220008198433;4106.2198182345255;3936.291467535814;4081.97959010209;4102.466679331727;4102.876913692594;4135.483064616923;4658.254679251304;4673.205555055581;4684.320773487893;4692.085043416501;4698.483166851644;5517.586181036439;5527.474889885454;5537;5558.166275058774;5558.333000040021;1329.2224048931485;1333.6665833541615;1410.4005797536006;1415.4762737787084;1420.2259768426231;886.7073865624328;901.7970956534858;919.845593779802;924.902885197058;927.9025702301296;4723.291506274018;4725.9527404726205;4730.290456431494;4732.763361831963;4746.95253047472;4914.311996320518;4919.4834542373255;4954.727489988013;4964.205727083649;4966.850994470172;4484.708493947883;4663.440387153563;4684.4378674559275;4688.343631891538;4723.149833030087;2566.5380231558497;2595.4549544595848;2603.5443797335392;2611.3993781430377;2613.882375293116;5012.924806127911;5025.447200807908;5043.621728370387;5056.646034777604;5087.771050302746;4628.930566041512;4907.711833071779;4921.87695307613;4927.260910863399;4942.813724706045;4966.404031516241;5004.524570165901;5009.674371165863;5021.246812978083;5074.422532114851;4883.487233840538;4888.291197776373;4890.584300334369;4913.041956818386;4944.1100601892;4686.976565117153;4832.613390928647;4863.4650188479945;4871.464138944642;5235.267062611161;5845;5860.941390586039;5888.735006924613;5924.7926322578505;5939.584229104094;4022.7586344819406;4022.7586344819406;4033.757974521538;4070.898227544335;4080.959355364363;5395.70323632204;5691.7438715257085;5698.914516282342;5772.249607550992;5773.884522309614;5556.305461817273;5558.833235002957;5563.833085007456;5582.916256256078;5603.411641777718;5484;5564.248826408545;5569.220309156803;5612.803551875665;5620.775168993195;5350.866228344167;5530.80642177538;5580.302462192226;5592.412796656293;5603.131514615241;5631.7184140793615;5647.29408823897;5651.971740141437;5656.943430565641;5684.431556844283;5191.377034755854;5470.72646367672;5504.862378440411;5507.118860982224;5526.778928842801 07:07:33 INFO - PROCESS | 19281 | |5;yui.html;624.2789578037368;626.1797045869907;713.2902761752058;729.766474728087;842.1326034184788;13580.185188888661;14262;14506.492272770454;14578.489752858652;14739.557813265606;13730.794038089436;13741.381637826296;13743.93128034361;13817.51638692646;13821.239831809247;776.9067711874583;801.046754362307;804.2078552625659;804.5132694719698;805.9919400806004;666.7333066773306;675.0245894682187;783.0877028262067;807.6204184033495;810.1979040749645;852.1138016462871;863.6329559937033;865.7013330401002;870.1689886158704;872.4852337121097;855.9058503564603;856.3021137772727;856.3491746272815;858.5063588436674;859.6045818923303;499.2526158445441;506.05115408608856;619.8946179149556;620.7765204526412;621.4531212532987;12325.383730813424;12646.936765316115;12751.043671724565;13015.414306356237;13053.412596433183;13834.515791947335;14319.57041288763;14532.782008269778;14598.489052883098;14681.926590367086;10616.734581635445;10770.246082774209;10799.352038877692;10903;11121.610743623934;3180.890828133588;3295.555100061485;3306.537084808129;3348.045806945009;3380.695737383647;62357.37642623561;63076.36923630797;65078.023829642596;66380.3361966379;66579;10992.780144397067;11036.28264162843;11132.443377831238;11133.554657813596;11164.873835326121;21175.258865939617;21239;21290.893545532483;21336.359909202438;21376.893115534323;7941.324987376022;7950.840983180419;8039.638216280165;8153.306968907591;8226.341892648574;4369.148016136823;4474.418325617649;4482.148391805546;4506.1663592235545;4617.699849509771;3314.950275745866;3327.434336162858;3348.68187522185;3393.372226138123;3446.638102999199;583.3379114704841;583.3990989281048;584.3455330030308;584.4914924016133;594.7115648910275;588.7040541886677;608.8599622086945;639.3446717114995;647.4941974558488;719.219646683344;8528.488290702579;8861.499707615456;9131.863022054675;9691.70924872255;9764.755881103029;708.9787306380816;721.5057685485459;738.5162718419443;739.2053542441789;742.1576510660332;3874.3994680824517;4332.35014747784;4566.725996440225;4717.481077081518;4720.598749106296;73385;79412.60293698494;79805;80464.59767701241;80742;66310.33689663041;68178.3182168182;68484;68655;68709;63701.362986369546;64088.35911640824;64424.35575644184;64669.38326541874;65002.67498662476;8468.322534197372;8501;8626.78433039179;8635.481871087755;8668.739937801876;32412;37551;37899.24201515899;43089.78455107704;44755;39811.40282895817;39956;40652.18695626012;53890.73054634702;54563.727181363836;12155.75688486243;12232.266064036186;12234.755304893673;12335.794443308918;12390.752184956431;13595.660108497366;13864.722705546033;14144.646383840487;14266.643333916734;14447.855521444651;13261.602151935458;13339.799903001656;13378.13042152257;13382.598522044354;13483.932580337036;12563.309018004098;12650.810237846625;12724.74550508966;13191.40638671243;13491.932540337235;12634.2419454833;12687.619371418872;13143.474261029834;13264.403101860247;13822.93088534551;10329.328593641389;10360.326578772356;10527.842082368617;10610.363378197333;10738.570457181937;10081.29436884178;10997.230193886671;11261.887381126084;11265.549378024787;11305.152113591677 07:07:33 INFO - PROCESS | 19281 | __end_tp_report 07:07:33 INFO - PROCESS | 19281 | __start_cc_report 07:07:33 INFO - PROCESS | 19281 | _x_x_mozilla_cycle_collect,1308 07:07:33 INFO - PROCESS | 19281 | __end_cc_report 07:07:33 INFO - PROCESS | 19281 | __startTimestamp1477404453416__endTimestamp 07:07:33 INFO - PROCESS | 19281 | 07:07:33 INFO - PROCESS | 19281 | ------- Summary: start ------- 07:07:33 INFO - PROCESS | 19281 | Number of tests: 6 07:07:33 INFO - PROCESS | 19281 | 07:07:33 INFO - PROCESS | 19281 | [#0] dojo.html Cycles:165 Average:5369.25 Median:5545.31 stddev:600.64 (10.8%) stddev-sans-first:575.42 07:07:33 INFO - PROCESS | 19281 | Values: 3097.0 3115.5 3145.8 3156.0 3160.7 5249.9 5262.1 5340.9 5423.3 5435.6 5350.5 5366.8 5372.7 5378.4 5387.4 4855.2 4872.6 4891.4 4920.8 4958.4 4938.9 5009.7 5010.2 5012.2 5017.0 4928.7 4958.4 4981.4 4996.3 5005.7 5014.0 5032.4 5038.7 5045.2 5097.2 4814.5 4857.5 4863.0 4938.1 4946.3 5339.7 5378.8 5383.3 5406.7 5492.3 5744.9 5771.5 5776.5 5776.5 5781.9 5738.4 5750.4 5792.2 5798.3 5800.4 5387.3 5418.8 5423.8 5475.0 5484.2 5910.3 5910.6 5915.5 5920.1 5921.8 5541.3 5650.4 5661.5 5662.6 5670.4 5656.3 5735.3 5735.9 5735.9 5737.7 5669.3 5706.1 5710.8 5718.2 5725.0 5716.5 5718.0 5728.9 5731.1 5732.2 4389.5 4393.3 4398.5 4398.6 4398.7 3964.1 3972.1 3974.0 3974.6 3975.0 5453.8 5484.8 5494.6 5500.0 5501.0 5726.1 5801.2 5821.8 5822.1 5824.7 5456.9 5468.3 5477.8 5478.1 5489.9 4904.6 4950.3 4954.7 4988.1 5043.7 5980.6 6025.2 6026.0 6061.5 6093.4 5817.8 5823.3 5824.9 5825.3 5833.1 5853.7 5898.0 5996.9 5998.4 6000.0 5653.9 5662.8 5683.7 5721.9 5790.3 5826.9 5828.9 5836.7 5840.4 5844.3 5539.4 5545.3 5663.3 5667.1 5675.0 5567.7 5588.3 5631.2 5648.9 5711.9 5582.6 5608.4 5616.2 5629.1 5636.0 5577.8 5674.7 5681.1 5685.1 5689.8 5445.9 5453.2 5459.5 5491.4 5539.9 07:07:33 INFO - PROCESS | 19281 | 07:07:33 INFO - PROCESS | 19281 | [#1] ext.html Cycles:180 Average:57751.24 Median:21387.14 stddev:114728.65 (536.4%) stddev-sans-first:114970.13 07:07:33 INFO - PROCESS | 19281 | Values: 556.3 584.1 586.3 599.0 601.3 31662.0 32409.0 43292.5 44160.6 44294.3 45730.0 46083.0 46154.5 46176.3 46238.3 8933.7 9082.1 9092.1 9093.9 9094.7 8071.7 8251.4 10563.2 10813.6 10816.5 10984.6 11047.3 11074.1 11080.9 11090.3 10764.4 10843.9 10873.3 10917.9 10921.7 10493.9 10557.6 10566.9 10567.7 10571.5 41801.8 42123.4 42236.0 42240.6 42275.0 3290.0 3374.0 3385.7 3679.5 3932.1 30952.4 32049.7 32053.5 32199.4 32329.0 4185.9 4266.9 4290.4 4351.1 4493.3 325997.0 326373.0 327623.0 328855.0 328959.0 57168.4 57609.0 57917.7 58140.7 58178.7 62080.4 62562.4 62626.7 62688.4 62704.7 14069.2 14249.7 14251.6 14255.7 14263.1 10176.5 10183.9 10184.5 10256.8 10638.0 16880.0 17327.1 17423.0 17455.0 17479.4 5772.9 5811.0 5862.0 6001.3 6012.2 898.4 928.4 969.6 983.5 1057.4 30018.1 30061.5 30206.5 30224.4 30333.8 1054.2 1073.1 1093.3 1115.9 1129.5 15851.4 15900.8 16314.3 16372.8 16575.3 128776.0 490363.0 500273.0 502447.0 738586.0 57074.0 57744.4 57795.0 57834.4 57878.4 1205.8 1233.5 1287.9 1289.7 1310.6 30459.0 35201.3 35469.3 35496.6 35560.0 54586.5 55116.0 55171.0 55213.0 55261.4 431626.0 433762.0 434758.0 436418.0 437967.0 23816.8 24480.5 26134.8 27195.9 27243.2 45768.0 47558.8 47672.3 49110.8 52619.5 39094.8 40097.4 40833.2 41574.6 42631.4 40412.5 40540.6 41161.0 41645.4 42038.4 40576.8 41657.0 41700.6 42070.8 42132.8 32836.5 35270.6 36114.0 36507.0 36544.0 26859.9 26955.9 27377.7 27394.5 27425.9 07:07:33 INFO - PROCESS | 19281 | 07:07:33 INFO - PROCESS | 19281 | [#2] jquery.html Cycles:180 Average:27279.99 Median:3982.78 stddev:73332.17 (1841.2%) stddev-sans-first:73510.03 07:07:33 INFO - PROCESS | 19281 | Values: 361.7 378.4 387.9 395.0 415.7 14433.6 18245.5 18932.8 19497.6 19709.1 16535.8 16646.2 16990.3 17013.2 17046.0 5512.2 5826.5 5826.8 5829.2 5831.2 4198.7 4337.8 5734.5 5735.6 6413.9 6451.7 6481.1 6487.3 6497.4 6498.2 6239.3 6387.0 6418.2 6431.4 6431.6 5465.0 5540.5 5646.2 5672.8 5679.9 21909.9 22208.0 22212.6 23021.0 23113.7 2547.3 2702.8 2798.6 2824.0 3031.3 14231.9 14306.4 14343.6 14397.7 14941.6 1896.2 1898.7 1912.7 1919.2 1952.3 78881.0 78975.0 79678.0 79971.6 80754.6 8880.2 9483.1 9489.9 9631.4 10352.6 13061.3 13153.6 13162.1 13163.4 13170.1 6992.8 7011.0 7206.1 7225.7 7266.2 6696.1 6709.5 6808.9 6962.9 7082.7 3979.6 3985.9 4007.7 4089.3 4166.1 1785.9 1793.9 1814.4 1816.2 1845.6 889.8 928.7 935.8 968.5 1024.8 18049.2 19658.0 19780.3 20002.8 20060.8 936.7 966.4 990.9 993.1 1000.1 10316.6 11033.5 11064.6 11102.4 11110.8 428815.0 439059.0 448738.0 449683.0 453937.0 56572.7 73622.6 88283.1 94912.5 96582.5 990.9 1010.9 1021.6 1035.7 1043.6 14112.5 16727.4 17546.2 17672.1 17940.8 41047.8 41413.8 41832.0 41842.8 43376.0 54608.5 57229.4 59542.0 60095.6 61870.4 8373.3 8441.5 8569.0 8753.0 8755.9 9669.7 12944.1 13765.9 13855.4 13987.9 11518.0 11688.9 11753.5 11825.1 11895.3 11353.4 11520.7 11722.2 11815.7 12003.0 11802.8 12005.0 12026.6 12088.6 12202.8 7039.3 7385.1 8301.9 8688.1 8843.9 10386.0 11698.8 11802.7 11851.3 12297.3 07:07:33 INFO - PROCESS | 19281 | 07:07:33 INFO - PROCESS | 19281 | [#3] mootools.html Cycles:180 Average:5638.74 Median:5194.79 stddev:3241.71 (62.4%) stddev-sans-first:3234.35 07:07:33 INFO - PROCESS | 19281 | Values: 1292.2 1428.3 1491.3 1591.2 1760.7 7434.5 8434.7 8645.4 8657.6 8856.2 8624.3 8695.3 8703.9 8707.9 8711.2 2260.4 2278.8 2279.4 2282.0 2285.6 2237.6 2286.2 2294.1 2295.8 2300.9 2274.8 2287.3 2305.8 2312.6 2327.1 2215.9 2231.7 2233.1 2236.2 2247.9 2198.6 2202.2 2204.7 2205.8 2207.7 8545.3 8575.9 8585.4 8599.7 8695.5 5123.0 5326.1 5329.8 5332.3 5367.2 3287.4 3437.4 3491.2 3509.7 3532.3 1069.5 1113.5 1117.8 1134.4 1137.1 12026.9 12087.6 12220.5 12227.1 12239.3 4249.4 4376.4 4545.2 4550.2 4594.9 9610.7 9628.6 9630.5 9632.9 9642.9 5266.6 5274.4 5278.3 5278.8 5280.4 4135.0 4344.5 4397.6 4424.0 4942.8 3606.6 3629.5 3716.7 3719.0 3735.2 1106.8 1110.6 1124.2 1127.8 1167.8 859.4 863.2 897.7 908.8 942.1 5657.4 5707.7 5815.9 5831.6 6011.3 868.5 876.8 891.6 896.6 902.1 3720.5 3887.9 3914.3 3937.4 3948.6 10850.5 10991.9 11094.3 11166.2 11205.8 10953.9 10972.3 10983.1 10987.1 10994.1 7859.4 8062.4 8064.6 8171.2 8283.7 5707.8 5821.3 5830.6 5947.1 5979.6 9438.5 9668.5 9769.0 9798.3 9838.2 8902.9 9094.6 9857.7 9984.4 9992.1 7485.4 7725.1 7834.5 7911.1 8090.6 8287.4 8347.4 8381.9 8395.5 8401.5 7228.7 7511.4 7529.7 7555.1 7653.1 7131.4 7207.1 7212.9 7259.9 7298.7 6567.8 6599.2 6654.2 6660.3 6672.3 4801.5 4956.4 5005.5 5007.2 5037.5 4580.9 4588.9 4623.6 4649.4 4741.5 07:07:33 INFO - PROCESS | 19281 | 07:07:33 INFO - PROCESS | 19281 | [#4] prototype.html Cycles:180 Average:4490.39 Median:4916.90 stddev:1308.07 (26.6%) stddev-sans-first:1273.86 07:07:33 INFO - PROCESS | 19281 | Values: 326.5 326.8 331.3 335.9 342.3 5201.9 5317.4 5340.7 5381.9 5384.8 5102.1 5174.6 5195.3 5218.2 5223.9 4121.3 4128.1 4130.1 4135.7 4138.4 4027.3 4123.9 4137.9 4155.1 4182.8 4061.5 4084.7 4091.4 4108.8 4126.6 4084.2 4088.4 4094.5 4099.8 4120.6 3635.6 3638.6 3646.7 3655.1 3671.2 4976.3 5097.3 5123.3 5128.8 5165.6 4673.2 4734.7 4748.2 4755.3 4755.9 5447.7 5460.4 5474.2 5487.1 5499.7 3806.2 3976.6 3986.0 3992.9 3996.0 5719.7 5738.9 5743.5 5782.2 5786.3 4075.9 4083.5 4093.8 4105.2 4106.2 3936.3 4082.0 4102.5 4102.9 4135.5 4658.3 4673.2 4684.3 4692.1 4698.5 5517.6 5527.5 5537.0 5558.2 5558.3 1329.2 1333.7 1410.4 1415.5 1420.2 886.7 901.8 919.8 924.9 927.9 4723.3 4726.0 4730.3 4732.8 4747.0 4914.3 4919.5 4954.7 4964.2 4966.9 4484.7 4663.4 4684.4 4688.3 4723.1 2566.5 2595.5 2603.5 2611.4 2613.9 5012.9 5025.4 5043.6 5056.6 5087.8 4628.9 4907.7 4921.9 4927.3 4942.8 4966.4 5004.5 5009.7 5021.2 5074.4 4883.5 4888.3 4890.6 4913.0 4944.1 4687.0 4832.6 4863.5 4871.5 5235.3 5845.0 5860.9 5888.7 5924.8 5939.6 4022.8 4022.8 4033.8 4070.9 4081.0 5395.7 5691.7 5698.9 5772.2 5773.9 5556.3 5558.8 5563.8 5582.9 5603.4 5484.0 5564.2 5569.2 5612.8 5620.8 5350.9 5530.8 5580.3 5592.4 5603.1 5631.7 5647.3 5652.0 5656.9 5684.4 5191.4 5470.7 5504.9 5507.1 5526.8 07:07:33 INFO - PROCESS | 19281 | 07:07:33 INFO - PROCESS | 19281 | [#5] yui.html Cycles:180 Average:16513.05 Median:24614.71 stddev:21076.43 (85.6%) stddev-sans-first:21101.78 07:07:33 INFO - PROCESS | 19281 | Values: 624.3 626.2 713.3 729.8 842.1 13580.2 14262.0 14506.5 14578.5 14739.6 13730.8 13741.4 13743.9 13817.5 13821.2 776.9 801.0 804.2 804.5 806.0 666.7 675.0 783.1 807.6 810.2 852.1 863.6 865.7 870.2 872.5 855.9 856.3 856.3 858.5 859.6 499.3 506.1 619.9 620.8 621.5 12325.4 12646.9 12751.0 13015.4 13053.4 13834.5 14319.6 14532.8 14598.5 14681.9 10616.7 10770.2 10799.4 10903.0 11121.6 3180.9 3295.6 3306.5 3348.0 3380.7 62357.4 63076.4 65078.0 66380.3 66579.0 10992.8 11036.3 11132.4 11133.6 11164.9 21175.3 21239.0 21290.9 21336.4 21376.9 7941.3 7950.8 8039.6 8153.3 8226.3 4369.1 4474.4 4482.1 4506.2 4617.7 3315.0 3327.4 3348.7 3393.4 3446.6 583.3 583.4 584.3 584.5 594.7 588.7 608.9 639.3 647.5 719.2 8528.5 8861.5 9131.9 9691.7 9764.8 709.0 721.5 738.5 739.2 742.2 3874.4 4332.4 4566.7 4717.5 4720.6 73385.0 79412.6 79805.0 80464.6 80742.0 66310.3 68178.3 68484.0 68655.0 68709.0 63701.4 64088.4 64424.4 64669.4 65002.7 8468.3 8501.0 8626.8 8635.5 8668.7 32412.0 37551.0 37899.2 43089.8 44755.0 39811.4 39956.0 40652.2 53890.7 54563.7 12155.8 12232.3 12234.8 12335.8 12390.8 13595.7 13864.7 14144.6 14266.6 14447.9 13261.6 13339.8 13378.1 13382.6 13483.9 12563.3 12650.8 12724.7 13191.4 13491.9 12634.2 12687.6 13143.5 13264.4 13822.9 10329.3 10360.3 10527.8 10610.4 10738.6 10081.3 10997.2 11261.9 11265.5 11305.2 07:07:33 INFO - PROCESS | 19281 | -------- Summary: end -------- 07:07:33 INFO - PROCESS | 19281 | 07:07:34 INFO - TEST-INFO | 19281: exit 0 07:07:34 INFO - TEST-OK | dromaeo_css | took 1118249ms 07:07:34 INFO - TEST-START | kraken 07:07:34 INFO - operating with platform_type : linux_ 07:07:34 INFO - Initialising browser for kraken test... 07:07:34 INFO - TEST-INFO | started process 19584 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz7wj2w/profile http://localhost:51090/getInfo.html) 07:07:38 INFO - PROCESS | 19584 | __metrics Screen width/height:1600/1200 07:07:38 INFO - PROCESS | 19584 | colorDepth:24 07:07:38 INFO - PROCESS | 19584 | Browser inner width/height: 1024/697 07:07:38 INFO - PROCESS | 19584 | __metrics 07:07:38 INFO - PROCESS | 19584 | 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" 07:07:38 INFO - PROCESS | 19584 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:07:39 INFO - PROCESS | 19584 | console.error: PushService: 07:07:39 INFO - PROCESS | 19584 | stateChangeProcessEnqueue: Error transitioning state 07:07:39 INFO - PROCESS | 19584 | UnknownError 07:07:40 INFO - TEST-INFO | 19584: exit 0 07:07:40 INFO - Browser initialized. 07:07:40 INFO - Running cycle 1/1 for kraken test... 07:07:40 INFO - TEST-INFO | started process 19669 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpz7wj2w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:07:52 INFO - PROCESS | 19669 | RSS: Main: 172097536 07:07:52 INFO - PROCESS | 19669 | 07:07:54 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51090/tests/kraken/driver.html?testName=audio-beat-detection) 07:07:55 INFO - PROCESS | 19669 | RSS: Main: 228831232 07:07:55 INFO - PROCESS | 19669 | 07:07:58 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51090/tests/kraken/driver.html?testName=audio-dft) 07:07:58 INFO - PROCESS | 19669 | RSS: Main: 215654400 07:07:58 INFO - PROCESS | 19669 | 07:08:01 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51090/tests/kraken/driver.html?testName=audio-fft) 07:08:02 INFO - PROCESS | 19669 | RSS: Main: 297525248 07:08:02 INFO - PROCESS | 19669 | 07:08:04 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51090/tests/kraken/driver.html?testName=audio-oscillator) 07:08:05 INFO - PROCESS | 19669 | RSS: Main: 206528512 07:08:05 INFO - PROCESS | 19669 | 07:08:07 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51090/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:08:07 INFO - PROCESS | 19669 | RSS: Main: 212176896 07:08:07 INFO - PROCESS | 19669 | 07:08:10 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51090/tests/kraken/driver.html?testName=imaging-darkroom) 07:08:11 INFO - PROCESS | 19669 | RSS: Main: 248193024 07:08:11 INFO - PROCESS | 19669 | 07:08:14 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51090/tests/kraken/driver.html?testName=imaging-desaturate) 07:08:15 INFO - PROCESS | 19669 | RSS: Main: 246767616 07:08:15 INFO - PROCESS | 19669 | 07:08:18 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51090/tests/kraken/driver.html?testName=json-parse-financial) 07:08:18 INFO - PROCESS | 19669 | RSS: Main: 246288384 07:08:18 INFO - PROCESS | 19669 | 07:08:20 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51090/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:08:20 INFO - PROCESS | 19669 | RSS: Main: 208797696 07:08:20 INFO - PROCESS | 19669 | 07:08:22 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51090/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:08:23 INFO - PROCESS | 19669 | RSS: Main: 215699456 07:08:23 INFO - PROCESS | 19669 | 07:08:25 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51090/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:08:25 INFO - PROCESS | 19669 | RSS: Main: 226127872 07:08:25 INFO - PROCESS | 19669 | 07:08:28 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:08:29 INFO - PROCESS | 19669 | RSS: Main: 229609472 07:08:29 INFO - PROCESS | 19669 | 07:08:31 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:08:32 INFO - PROCESS | 19669 | RSS: Main: 231600128 07:08:32 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | Cycle 1(1): loaded http://localhost:51090/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51090/tests/kraken/driver.html?testName=ai-astar) 07:08:34 INFO - PROCESS | 19669 | RSS: Main: 280477696 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | __start_tp_report 07:08:34 INFO - PROCESS | 19669 | _x_x_mozilla_page_load 07:08:34 INFO - PROCESS | 19669 | _x_x_mozilla_page_load_details 07:08:34 INFO - PROCESS | 19669 | |i|pagename|runs| 07:08:34 INFO - PROCESS | 19669 | |0;ai-astar;103;111;112;111;113;112;111;111;112;112 07:08:34 INFO - PROCESS | 19669 | |1;audio-beat-detection;152;126;123;160;124;121;126;121;148;127 07:08:34 INFO - PROCESS | 19669 | |2;audio-dft;161;160;162;161;162;162;162;160;161;162 07:08:34 INFO - PROCESS | 19669 | |3;audio-fft;77;76;75;114;76;77;76;75;105;75 07:08:34 INFO - PROCESS | 19669 | |4;audio-oscillator;83;83;128;84;83;83;111;82;82;118 07:08:34 INFO - PROCESS | 19669 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 07:08:34 INFO - PROCESS | 19669 | |6;imaging-darkroom;147;146;147;146;146;146;146;146;146;146 07:08:34 INFO - PROCESS | 19669 | |7;imaging-desaturate;84;85;85;84;84;84;85;84;85;84 07:08:34 INFO - PROCESS | 19669 | |8;json-parse-financial;55;52;54;52;52;54;53;54;53;55 07:08:34 INFO - PROCESS | 19669 | |9;json-stringify-tinderbox;61;61;60;61;61;61;62;61;65;62 07:08:34 INFO - PROCESS | 19669 | |10;stanford-crypto-aes;87;80;88;79;80;88;83;81;86;79 07:08:34 INFO - PROCESS | 19669 | |11;stanford-crypto-ccm;133;139;132;132;131;135;149;132;182;149 07:08:34 INFO - PROCESS | 19669 | |12;stanford-crypto-pbkdf2;169;174;163;169;166;165;165;166;170;169 07:08:34 INFO - PROCESS | 19669 | |13;stanford-crypto-sha256-iterative;66;69;66;67;71;65;64;66;67;66 07:08:34 INFO - PROCESS | 19669 | __end_tp_report 07:08:34 INFO - PROCESS | 19669 | __start_cc_report 07:08:34 INFO - PROCESS | 19669 | _x_x_mozilla_cycle_collect,1711 07:08:34 INFO - PROCESS | 19669 | __end_cc_report 07:08:34 INFO - PROCESS | 19669 | __startTimestamp1477404514447__endTimestamp 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | ------- Summary: start ------- 07:08:34 INFO - PROCESS | 19669 | Number of tests: 14 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.82 (2.5%) stddev-sans-first:0.71 07:08:34 INFO - PROCESS | 19669 | Values: 103.0 111.0 112.0 111.0 113.0 112.0 111.0 111.0 112.0 112.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#1] audio-beat-detection Cycles:10 Average:132.80 Median:126.50 stddev:14.60 (11.5%) stddev-sans-first:13.73 07:08:34 INFO - PROCESS | 19669 | Values: 152.0 126.0 123.0 160.0 124.0 121.0 126.0 121.0 148.0 127.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 07:08:34 INFO - PROCESS | 19669 | Values: 161.0 160.0 162.0 161.0 162.0 162.0 162.0 160.0 161.0 162.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:14.35 (18.9%) stddev-sans-first:15.08 07:08:34 INFO - PROCESS | 19669 | Values: 77.0 76.0 75.0 114.0 76.0 77.0 76.0 75.0 105.0 75.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:83.00 stddev:17.93 (21.6%) stddev-sans-first:18.59 07:08:34 INFO - PROCESS | 19669 | Values: 83.0 83.0 128.0 84.0 83.0 83.0 111.0 82.0 82.0 118.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:08:34 INFO - PROCESS | 19669 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 07:08:34 INFO - PROCESS | 19669 | Values: 147.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 07:08:34 INFO - PROCESS | 19669 | Values: 84.0 85.0 85.0 84.0 84.0 84.0 85.0 84.0 85.0 84.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:54.00 stddev:1.17 (2.2%) stddev-sans-first:1.09 07:08:34 INFO - PROCESS | 19669 | Values: 55.0 52.0 54.0 52.0 52.0 54.0 53.0 54.0 53.0 55.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:1.35 (2.2%) stddev-sans-first:1.42 07:08:34 INFO - PROCESS | 19669 | Values: 61.0 61.0 60.0 61.0 61.0 61.0 62.0 61.0 65.0 62.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#10] stanford-crypto-aes Cycles:10 Average:83.10 Median:84.50 stddev:3.78 (4.5%) stddev-sans-first:3.74 07:08:34 INFO - PROCESS | 19669 | Values: 87.0 80.0 88.0 79.0 80.0 88.0 83.0 81.0 86.0 79.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#11] stanford-crypto-ccm Cycles:10 Average:141.40 Median:137.00 stddev:15.83 (11.6%) stddev-sans-first:16.49 07:08:34 INFO - PROCESS | 19669 | Values: 133.0 139.0 132.0 132.0 131.0 135.0 149.0 132.0 182.0 149.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.60 Median:169.00 stddev:3.20 (1.9%) stddev-sans-first:3.36 07:08:34 INFO - PROCESS | 19669 | Values: 169.0 174.0 163.0 169.0 166.0 165.0 165.0 166.0 170.0 169.0 07:08:34 INFO - PROCESS | 19669 | 07:08:34 INFO - PROCESS | 19669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.50 stddev:2.00 (3.0%) stddev-sans-first:2.11 07:08:34 INFO - PROCESS | 19669 | Values: 66.0 69.0 66.0 67.0 71.0 65.0 64.0 66.0 67.0 66.0 07:08:34 INFO - PROCESS | 19669 | -------- Summary: end -------- 07:08:34 INFO - PROCESS | 19669 | 07:08:35 INFO - TEST-INFO | 19669: exit 0 07:08:35 INFO - TEST-OK | kraken | took 61322ms 07:08:35 INFO - SUITE-END | took 1179s 07:08:36 INFO - Completed test suite (00:19:40) 07:08:36 INFO - javascript benchmark 07:08:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3097.0399176255364, 3115.5482455044007, 3145.795523290986, 3156.0374085903804, 3160.668129846366, 5249.947500524993, 5262.079136151167, 5340.866478338039, 5423.349198096229, 5435.619506634537, 5350.464953504647, 5366.812161574346, 5372.7313634318225, 5378.381486129097, 5387.4073851876265, 4855.198892182794, 4872.561469467747, 4891.388576427947, 4920.8277710280145, 4958.355413796201, 4938.901221975559, 5009.724465154415, 5010.223415370605, 5012.198048312271, 5017.021680772251, 4928.728919909404, 4958.404991401037, 4981.427135879384, 4996.275540046691, 5005.699658020512, 5014.02226565818, 5032.370953630796, 5038.722870242135, 5045.167547354682, 5097.209932460438, 4814.542618451242, 4857.514248575114, 4863.003084367696, 4938.1111399947995, 4946.2580612908, 5339.733013349317, 5378.784848606051, 5383.300170977787, 5406.675599464044, 5492.286002819648, 5744.913826292609, 5771.451712087345, 5776.4801167894675, 5776.508996735282, 5781.913271300934, 5738.397468265814, 5750.367459579443, 5792.218050563162, 5798.333191682968, 5800.419958004208, 5387.272718183073, 5418.834950485664, 5423.783048678088, 5474.972625136928, 5484.177373393943, 5910.290765108214, 5910.586258961917, 5915.467607915309, 5920.111983202468, 5921.822345329647, 5541.251930989345, 5650.3502097258515, 5661.547076233891, 5662.5753068520025, 5670.376258611549, 5656.2929633795775, 5735.254416925773, 5735.8528294341295, 5735.942640573541, 5737.684427356452, 5669.31968163823, 5706.115552089433, 5710.8001219957105, 5718.170865224519, 5725.0, 5716.514096301861, 5717.971410142923, 5728.885422291531, 5731.111677689964, 5732.226149469851, 4389.495208051051, 4393.253146965024, 4398.47218333802, 4398.626116780109, 4398.670099742532, 3964.1278918637854, 3972.08642012333, 3974.0, 3974.642282194616, 3974.980125099356, 5453.836384908459, 5484.8354549363585, 5494.642848214853, 5499.972500137554, 5500.972495137578, 5726.112452569859, 5801.216835727208, 5821.767129314865, 5822.1266809978, 5824.650520968756, 5456.890862182734, 5468.261784659099, 5477.75350109246, 5478.096114141202, 5489.862753431116, 4904.60763138948, 4950.257461380822, 4954.727489988085, 4988.127077761377, 5043.697378157322, 5980.641161530322, 6025.18659980897, 6026.035834266497, 6061.515078793686, 6093.421124993119, 5817.825465236049, 5823.301203855564, 5824.912626310524, 5825.330087040044, 5833.066709326487, 5853.707314634336, 5897.970510147422, 5996.910046349221, 5998.430149135826, 6000.039993601003, 5653.915191272052, 5662.8301150965535, 5683.7442315095095, 5721.885562288648, 5790.305163380252, 5826.854328641818, 5828.883422331445, 5836.678982655994, 5840.386759390372, 5844.26946631671, 5539.446055394589, 5545.306836645419, 5663.32040155184, 5667.121596152603, 5675.035244008446, 5567.749451274622, 5588.329400471969, 5631.211630371669, 5648.943510564842, 5711.857203569944, 5582.637128586629, 5608.383077861514, 5616.157576363578, 5629.127485239795, 5635.971820140873, 5577.8047768327915, 5674.716264186692, 5681.062624667049, 5685.090385538294, 5689.829305120853, 5445.891082178255, 5453.182022696627, 5459.535939445032, 5491.423400543045, 5539.944600553943], "value": 5329.097270081006, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.3185098254638, 584.0654952076678, 586.3023002626874, 598.9727617136609, 601.2574470528899, 31662.0, 32409.0, 43292.48476303326, 44160.558394416046, 44294.335584966255, 45730.0, 46083.0, 46154.538454615446, 46176.3073553897, 46238.30642540364, 8933.731988040354, 9082.137196966278, 9092.136247056518, 9093.863592046124, 9094.681686140986, 8071.717489887855, 8251.381146414044, 10563.207759418035, 10813.621523246688, 10816.459177041155, 10984.560617575327, 11047.281926674781, 11074.114070874351, 11080.944595277053, 11090.279131856443, 10764.416540030335, 10843.891561084407, 10873.347599143997, 10917.945410272938, 10921.672349829518, 10493.895061049368, 10557.577696892115, 10566.894331056668, 10567.682969510926, 10571.471426428649, 41801.790991045156, 42123.368149477785, 42236.0, 42240.577594224276, 42275.0, 3289.983550082234, 3373.96626033739, 3385.661433856619, 3679.466477360768, 3932.0956180078456, 30952.380952380827, 32049.6795032049, 32053.51919721206, 32199.356012879845, 32329.0, 4185.895352616179, 4266.893327666833, 4290.42079319291, 4351.129774045204, 4493.326001099828, 325997.0, 326373.0, 327623.0, 328855.0, 328959.0, 57168.42831571631, 57609.0, 57917.71041144852, 58140.70929645409, 58178.7091064542, 62080.37919620836, 62562.374376256565, 62626.686866565375, 62688.37311626825, 62704.68647656824, 14069.155850648995, 14249.715005699827, 14251.643708907153, 14255.714885702228, 14263.07290026145, 10176.491175441199, 10183.949080254552, 10184.490775461198, 10256.846147307797, 10638.0, 16880.0, 17327.094019657827, 17423.0, 17455.0, 17479.38822141219, 5772.884542309214, 5810.970945145247, 5862.0, 6001.339852616209, 6012.158297838306, 898.3980732908967, 928.3779867488798, 969.6460791810938, 983.5475681186591, 1057.4289883462843, 30018.099457016324, 30061.549076763866, 30206.54690179649, 30224.44977119193, 30333.848330758206, 1054.1988089052375, 1073.1146803886825, 1093.327603523827, 1115.8660960684608, 1129.4691494997337, 15851.445199418196, 15900.840991589936, 16314.347426102822, 16372.754408683879, 16575.25411356492, 128776.0, 490363.0, 500272.99181024625, 502447.0, 738586.0, 57074.0, 57744.42255577474, 57794.999999999156, 57834.421655782906, 57878.42121578815, 1205.7889869273017, 1233.481937586216, 1287.8712128787233, 1289.6711338608782, 1310.600266918599, 30459.0, 35201.29597407986, 35469.29061418809, 35496.64503355037, 35560.0, 54586.454135459724, 55116.0, 55171.0, 55213.0, 55261.44738552724, 431626.0, 433762.0, 434758.0, 436418.0, 437967.0, 23816.761832382148, 24480.51038979246, 26134.778543823988, 27195.864020679768, 27243.182704518895, 45768.0, 47558.762206190135, 47672.2849157256, 49110.75444622754, 52619.473805261456, 39094.80452597719, 40097.39853902252, 40833.18333633251, 41574.584254157075, 42631.36052959146, 40412.53399456073, 40540.59459405486, 41161.0, 41645.375319369625, 42038.36942445927, 40576.79711601423, 41657.0, 41700.58299416967, 42070.78964605158, 42132.78933605312, 32836.50745238871, 35270.64729352674, 36114.0, 36507.0, 36544.0, 26859.865700671373, 26955.86522067377, 27377.726222738314, 27394.452110958067, 27425.86287068552], "value": 19857.656777505752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.65461983805466, 378.42668357438504, 387.90496328399547, 394.986175483858, 415.7276983575757, 14433.566992990201, 18245.452636420912, 18932.810671893294, 19497.61004779907, 19709.113089910952, 16535.83464165358, 16646.24244054559, 16990.32038718453, 17013.2344044518, 17045.977241365526, 5512.228288039678, 5826.504747096481, 5826.825195244128, 5829.242198514208, 5831.183634291203, 4198.727082739628, 4337.761423121727, 5734.483896449318, 5735.569832262576, 6413.8717225655455, 6451.7096730647, 6481.09264702942, 6487.253965793923, 6497.350264973488, 6498.155239818817, 6239.2824825145235, 6387.041943708435, 6418.19772528434, 6431.42117209451, 6431.646259455728, 5465.0, 5540.473655002768, 5646.237757902672, 5672.829815105512, 5679.914801277984, 21909.890450547806, 22208.0, 22212.555748884934, 23020.964056617493, 23113.653295200584, 2547.312225699051, 2702.7567518923192, 2798.6221860048836, 2823.9576406353717, 3031.2876474028585, 14231.85768142326, 14306.356213970397, 14343.56969290923, 14397.712045759026, 14941.551753447415, 1896.1656870976865, 1898.734177215191, 1912.6652835753825, 1919.2323070771663, 1952.2581419060807, 78881.0, 78974.96913009346, 79678.0, 79971.6001419995, 80754.59622701908, 8880.1563851434, 9483.099105584959, 9489.90510094904, 9631.436368543684, 10352.585896564053, 13061.281629510468, 13153.60539183826, 13162.078654494093, 13163.407646655924, 13170.07809453329, 6992.79021629352, 7010.964945175241, 7206.099237595301, 7225.74709885162, 7266.200717921024, 6696.096027036385, 6709.463242940553, 6808.863822723518, 6962.895556566656, 7082.681279342442, 3979.6219359161414, 3985.940210896839, 4007.7394969327484, 4089.2639324921206, 4166.0834616384345, 1785.8749887508009, 1793.8923664580168, 1814.383109742694, 1816.1827177770056, 1845.6124213915227, 889.8487257166297, 928.7167413938679, 935.780091678455, 968.5351031504918, 1024.8360262357987, 18049.187786549635, 19658.0, 19780.30768923081, 20002.799972000095, 20060.799392006185, 936.6628013914985, 966.3622009473713, 990.8513722941473, 993.1210878372692, 1000.1348833259324, 10316.638917637847, 11033.503492342863, 11064.557417703201, 11102.389368584805, 11110.833337499944, 428815.0, 439059.0, 448738.0, 449683.0, 453937.0, 56572.717136414874, 73622.63188684022, 88283.11716882877, 94912.52543737237, 96582.51708741412, 990.945497997617, 1010.939343639384, 1021.5760459409411, 1035.7151783259665, 1043.6399442192583, 14112.506062288181, 16727.414540491023, 17546.210420531363, 17672.116394180495, 17940.820591793916, 41047.794761026, 41413.792931035154, 41832.0, 41842.79078604587, 43376.0, 54608.45391546033, 57229.427705724076, 59542.0, 60095.611645059165, 61870.38129618646, 8373.33013358942, 8441.493510389397, 8568.957155214184, 8752.956235218782, 8755.912440875765, 9669.70990870275, 12944.139695560829, 13765.862341376458, 13855.37650805696, 13987.860121399062, 11518.0, 11688.88311116878, 11753.529858805552, 11825.113116516124, 11895.345755983504, 11353.432328383713, 11520.654380368602, 11722.179447438597, 11815.70460738454, 12003.0, 11802.82295765547, 12005.0, 12026.639200823989, 12088.637340879788, 12202.81695774582, 7039.296070392919, 7385.113786345458, 8301.916980830114, 8688.13118688126, 8843.91156088431, 10386.0, 11698.824517632072, 11802.704932376759, 11851.288922664668, 12297.294595189043], "value": 9045.26776005969, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1292.2182079841689, 1428.2858570714643, 1491.2990894279687, 1591.2123498868061, 1760.683077046131, 7434.479586428952, 8434.704785332515, 8645.438046526971, 8657.567121643908, 8856.158664926821, 8624.26693731032, 8695.304375649948, 8703.91296087039, 8707.869381959259, 8711.215990560848, 2260.4348912771766, 2278.7580768481134, 2279.4415368234722, 2281.9885900570557, 2285.63429851223, 2237.641977283635, 2286.16554957441, 2294.093832935989, 2295.8048565871923, 2300.919467818627, 2274.8293877959136, 2287.2795069553035, 2305.7924786769186, 2312.629979203319, 2327.1156960355124, 2215.944601384962, 2231.7210348706412, 2233.1290796589424, 2236.2173239366175, 2247.9325620231257, 2198.5712786006734, 2202.2072054060686, 2204.7244094488187, 2205.8014778669835, 2207.7129973103556, 8545.27365173961, 8575.914240857574, 8585.441946273471, 8599.699010534601, 8695.478271303742, 5123.0, 5326.094563924142, 5329.786808527654, 5332.30680011596, 5367.2485851980755, 3287.3589650018257, 3437.3984552703178, 3491.2319289756465, 3509.7016753575977, 3532.3288575170636, 1069.4652673663168, 1113.4544073404054, 1117.814672315621, 1134.444122380036, 1137.124414201069, 12026.939865300617, 12087.637370878887, 12220.511179552806, 12227.14409991301, 12239.265644061385, 4249.447571815706, 4376.365427013129, 4545.227311357077, 4550.203714349976, 4594.862154135381, 9610.711678649652, 9628.614855405845, 9630.47032413224, 9632.90367096334, 9642.903570964341, 5266.578673706171, 5274.446183150791, 5278.287431196816, 5278.788848446096, 5280.366356037223, 4135.0, 4344.478662560513, 4397.560243975641, 4423.977880110643, 4942.777575009133, 3606.6032736398975, 3629.5281613390616, 3716.6655001050035, 3719.0, 3735.1969326594913, 1106.8450416941473, 1110.5724296146043, 1124.2355198465123, 1127.7575321305958, 1167.830664553652, 859.4413631139685, 863.2144748279161, 897.708244820436, 908.8273228086642, 942.1379437814323, 5657.405972372924, 5707.71461426927, 5815.912761308584, 5831.562632802472, 6011.278646562353, 868.4832524647825, 876.8114855306139, 891.572045418203, 896.6413434626202, 902.120432578231, 3720.516332876763, 3887.8833634990997, 3914.2758589661003, 3937.3897045957924, 3948.58539853317, 10850.457477126112, 10991.945040274908, 11094.278871873303, 11166.162537809696, 11205.775884482264, 10953.945230273797, 10972.341659500455, 10983.066439352584, 10987.121030317556, 10994.065504432054, 7859.371250299962, 8062.355011599058, 8064.55644939534, 8171.223733745284, 8283.668653253802, 5707.831024210774, 5821.330546987151, 5830.62100963436, 5947.137665038632, 5979.611325263844, 9438.48088355147, 9668.468234247184, 9769.0, 9798.314118011956, 9838.212942964688, 8902.910970890209, 9094.636214551343, 9857.704268871945, 9984.400935943866, 9992.10071093605, 7485.438592105723, 7725.111612164673, 7834.451588388758, 7911.050673919167, 8090.555019473985, 8287.41988060854, 8347.415680902279, 8381.916180838114, 8395.496270223806, 8401.495910245405, 7228.674709637974, 7511.399088072832, 7529.698812047457, 7555.055618047744, 7653.119891212582, 7131.393831524171, 7207.13514378257, 7212.855742885008, 7259.891101633374, 7298.744543940937, 6567.770128045687, 6599.185224063421, 6654.201495820533, 6660.333966603494, 6672.266050734318, 4801.5438533339275, 4956.405231372259, 5005.549500544968, 5007.223880298559, 5037.471065538066, 4580.908381832278, 4588.862334129982, 4623.630109591158, 4649.418822647169, 4741.466795376379], "value": 4488.75445255681, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.5346880695009, 326.75656635806314, 331.3075671845842, 335.89083547846957, 342.2982885085574, 5201.921971170426, 5317.361916570012, 5340.706261155635, 5381.892362152755, 5384.811531596395, 5102.132637451633, 5174.611904107188, 5195.324607800981, 5218.1650935850275, 5223.86940326492, 4121.278776214151, 4128.071183983609, 4130.132672138847, 4135.710500264982, 4138.441310423084, 4027.295223335919, 4123.855665051724, 4137.9172416551655, 4155.106652069804, 4182.832686692529, 4061.4923134608175, 4084.6732261419015, 4091.365838295069, 4108.774017429055, 4126.6079722426475, 4084.223997440477, 4088.4480595119576, 4094.5259706505785, 4099.754014759094, 4120.608542188517, 3635.600083990759, 3638.5815631202486, 3646.74472786905, 3655.1227705350525, 3671.1739858531882, 4976.328195693572, 5097.311862898536, 5123.308353372322, 5128.794733237686, 5165.63840531163, 4673.182193116225, 4734.668573199878, 4748.171953797778, 4755.286706993944, 4755.904881902377, 5447.700376479292, 5460.426655201187, 5474.178873169017, 5487.067198576252, 5499.670019798825, 3806.1816709407335, 3976.622220889011, 3985.9800700996598, 3992.920141597152, 3996.0, 5719.742611582489, 5738.913916291259, 5743.483086522191, 5782.161586569924, 5786.305643322786, 4075.857344992911, 4083.530394004668, 4093.815778289984, 4105.220008198433, 4106.2198182345255, 3936.291467535814, 4081.97959010209, 4102.466679331727, 4102.876913692594, 4135.483064616923, 4658.254679251304, 4673.205555055581, 4684.320773487893, 4692.085043416501, 4698.483166851644, 5517.586181036439, 5527.474889885454, 5537.0, 5558.166275058774, 5558.333000040021, 1329.2224048931485, 1333.6665833541615, 1410.4005797536006, 1415.4762737787084, 1420.2259768426231, 886.7073865624328, 901.7970956534858, 919.845593779802, 924.902885197058, 927.9025702301296, 4723.291506274018, 4725.9527404726205, 4730.290456431494, 4732.763361831963, 4746.95253047472, 4914.311996320518, 4919.4834542373255, 4954.727489988013, 4964.205727083649, 4966.850994470172, 4484.708493947883, 4663.440387153563, 4684.4378674559275, 4688.343631891538, 4723.149833030087, 2566.5380231558497, 2595.4549544595848, 2603.5443797335392, 2611.3993781430377, 2613.882375293116, 5012.924806127911, 5025.447200807908, 5043.621728370387, 5056.646034777604, 5087.771050302746, 4628.930566041512, 4907.711833071779, 4921.87695307613, 4927.260910863399, 4942.813724706045, 4966.404031516241, 5004.524570165901, 5009.674371165863, 5021.246812978083, 5074.422532114851, 4883.487233840538, 4888.291197776373, 4890.584300334369, 4913.041956818386, 4944.1100601892, 4686.976565117153, 4832.613390928647, 4863.4650188479945, 4871.464138944642, 5235.267062611161, 5845.0, 5860.941390586039, 5888.735006924613, 5924.7926322578505, 5939.584229104094, 4022.7586344819406, 4022.7586344819406, 4033.757974521538, 4070.898227544335, 4080.959355364363, 5395.70323632204, 5691.7438715257085, 5698.914516282342, 5772.249607550992, 5773.884522309614, 5556.305461817273, 5558.833235002957, 5563.833085007456, 5582.916256256078, 5603.411641777718, 5484.0, 5564.248826408545, 5569.220309156803, 5612.803551875665, 5620.775168993195, 5350.866228344167, 5530.80642177538, 5580.302462192226, 5592.412796656293, 5603.131514615241, 5631.7184140793615, 5647.29408823897, 5651.971740141437, 5656.943430565641, 5684.431556844283, 5191.377034755854, 5470.72646367672, 5504.862378440411, 5507.118860982224, 5526.778928842801], "value": 4076.8859668801974, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [624.2789578037368, 626.1797045869907, 713.2902761752058, 729.766474728087, 842.1326034184788, 13580.185188888661, 14262.0, 14506.492272770454, 14578.489752858652, 14739.557813265606, 13730.794038089436, 13741.381637826296, 13743.93128034361, 13817.51638692646, 13821.239831809247, 776.9067711874583, 801.046754362307, 804.2078552625659, 804.5132694719698, 805.9919400806004, 666.7333066773306, 675.0245894682187, 783.0877028262067, 807.6204184033495, 810.1979040749645, 852.1138016462871, 863.6329559937033, 865.7013330401002, 870.1689886158704, 872.4852337121097, 855.9058503564603, 856.3021137772727, 856.3491746272815, 858.5063588436674, 859.6045818923303, 499.2526158445441, 506.05115408608856, 619.8946179149556, 620.7765204526412, 621.4531212532987, 12325.383730813424, 12646.936765316115, 12751.043671724565, 13015.414306356237, 13053.412596433183, 13834.515791947335, 14319.57041288763, 14532.782008269778, 14598.489052883098, 14681.926590367086, 10616.734581635445, 10770.246082774209, 10799.352038877692, 10903.0, 11121.610743623934, 3180.890828133588, 3295.555100061485, 3306.537084808129, 3348.045806945009, 3380.695737383647, 62357.37642623561, 63076.36923630797, 65078.023829642596, 66380.3361966379, 66579.0, 10992.780144397067, 11036.28264162843, 11132.443377831238, 11133.554657813596, 11164.873835326121, 21175.258865939617, 21239.0, 21290.893545532483, 21336.359909202438, 21376.893115534323, 7941.324987376022, 7950.840983180419, 8039.638216280165, 8153.306968907591, 8226.341892648574, 4369.148016136823, 4474.418325617649, 4482.148391805546, 4506.1663592235545, 4617.699849509771, 3314.950275745866, 3327.434336162858, 3348.68187522185, 3393.372226138123, 3446.638102999199, 583.3379114704841, 583.3990989281048, 584.3455330030308, 584.4914924016133, 594.7115648910275, 588.7040541886677, 608.8599622086945, 639.3446717114995, 647.4941974558488, 719.219646683344, 8528.488290702579, 8861.499707615456, 9131.863022054675, 9691.70924872255, 9764.755881103029, 708.9787306380816, 721.5057685485459, 738.5162718419443, 739.2053542441789, 742.1576510660332, 3874.3994680824517, 4332.35014747784, 4566.725996440225, 4717.481077081518, 4720.598749106296, 73385.0, 79412.60293698494, 79805.0, 80464.59767701241, 80742.0, 66310.33689663041, 68178.3182168182, 68484.0, 68655.0, 68709.0, 63701.362986369546, 64088.35911640824, 64424.35575644184, 64669.38326541874, 65002.67498662476, 8468.322534197372, 8501.0, 8626.78433039179, 8635.481871087755, 8668.739937801876, 32412.0, 37551.0, 37899.24201515899, 43089.78455107704, 44755.0, 39811.40282895817, 39956.0, 40652.18695626012, 53890.73054634702, 54563.727181363836, 12155.75688486243, 12232.266064036186, 12234.755304893673, 12335.794443308918, 12390.752184956431, 13595.660108497366, 13864.722705546033, 14144.646383840487, 14266.643333916734, 14447.855521444651, 13261.602151935458, 13339.799903001656, 13378.13042152257, 13382.598522044354, 13483.932580337036, 12563.309018004098, 12650.810237846625, 12724.74550508966, 13191.40638671243, 13491.932540337235, 12634.2419454833, 12687.619371418872, 13143.474261029834, 13264.403101860247, 13822.93088534551, 10329.328593641389, 10360.326578772356, 10527.842082368617, 10610.363378197333, 10738.570457181937, 10081.29436884178, 10997.230193886671, 11261.887381126084, 11265.549378024787, 11305.152113591677], "value": 6843.646331759796, "unit": "score"}], "name": "dromaeo_css", "value": 7022.073071640225, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 111.0, 113.0, 112.0, 111.0, 111.0, 112.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 123.0, 160.0, 124.0, 121.0, 126.0, 121.0, 148.0, 127.0], "value": 132.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 161.0, 162.0, 162.0, 162.0, 160.0, 161.0, 162.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 114.0, 76.0, 77.0, 76.0, 75.0, 105.0, 75.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 128.0, 84.0, 83.0, 83.0, 111.0, 82.0, 82.0, 118.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 85.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 54.0, 52.0, 52.0, 54.0, 53.0, 54.0, 53.0, 55.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 60.0, 61.0, 61.0, 61.0, 62.0, 61.0, 65.0, 62.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 88.0, 79.0, 80.0, 88.0, 83.0, 81.0, 86.0, 79.0], "value": 83.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 139.0, 132.0, 132.0, 131.0, 135.0, 149.0, 132.0, 182.0, 149.0], "value": 141.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 174.0, 163.0, 169.0, 166.0, 165.0, 165.0, 166.0, 170.0, 169.0], "value": 167.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 66.0, 67.0, 71.0, 65.0, 64.0, 66.0, 67.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1502.3999999999999, "alertThreshold": 2.0}]} 07:08:36 INFO - Return code: 0 07:08:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:08:36 INFO - # TBPL SUCCESS # 07:08:36 INFO - Running post-action listener: _resource_record_post_action 07:08:36 INFO - [mozharness: 2016-10-25 14:08:36.254092Z] Finished run-tests step (success) 07:08:36 INFO - Running post-run listener: _resource_record_post_run 07:08:36 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 402989056; Read time: 0; Write time: 299976 07:08:36 INFO - TinderboxPrint: CPU usage
13.1% 07:08:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 07:08:36 INFO - TinderboxPrint: I/O write bytes / time
402,989,056 / 299,976 07:08:36 INFO - TinderboxPrint: CPU idle
8,297.2 (86.9%) 07:08:36 INFO - TinderboxPrint: CPU user
1,204.0 (12.6%) 07:08:36 INFO - TinderboxPrint: Swap in / out
0 / 0 07:08:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114458624; Read time: 0; Write time: 94684 07:08:36 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 288063488; Read time: 0; Write time: 205252 07:08:36 INFO - Running post-run listener: _upload_blobber_files 07:08:36 INFO - Blob upload gear active. 07:08:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:08:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:08:36 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:08:36 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:08:37 INFO - (blobuploader) - INFO - Open directory for files ... 07:08:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:08:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:08:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:38 INFO - (blobuploader) - INFO - Done attempting. 07:08:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:08:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:08:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:42 INFO - (blobuploader) - INFO - Done attempting. 07:08:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:08:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:08:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:08:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:08:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:08:42 INFO - (blobuploader) - INFO - Done attempting. 07:08:42 INFO - (blobuploader) - INFO - Iteration through files over. 07:08:42 INFO - Return code: 0 07:08:42 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:08:42 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:08:42 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f06323b35773484b14ee8083ec3c690b0e3b6e7c0be56bdf9e1f96730e9d2fa80d2b954862621cbed8763d4b907c1d75b2311eea1f0988ef71a3b9907f4ffba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfab660dbe35b227c2cdfbe1a51fb7fa28fef059fdccee99bb883833e6d8d7d2e2ef24e7f77a844968b9960253ca8b4fd85b9356cf41f8e3aa2ee14e4bac716d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc6e172a5798eee17211ed6bf2238254c81bbd7b7e07e409ba86a744c71bd9b1f1bd1c5b4553090057e314df065bdebf86a2e5f64fa451df2fbe4353e29f484a"} 07:08:42 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:08:42 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:08:42 INFO - Contents: 07:08:42 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f06323b35773484b14ee8083ec3c690b0e3b6e7c0be56bdf9e1f96730e9d2fa80d2b954862621cbed8763d4b907c1d75b2311eea1f0988ef71a3b9907f4ffba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfab660dbe35b227c2cdfbe1a51fb7fa28fef059fdccee99bb883833e6d8d7d2e2ef24e7f77a844968b9960253ca8b4fd85b9356cf41f8e3aa2ee14e4bac716d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc6e172a5798eee17211ed6bf2238254c81bbd7b7e07e409ba86a744c71bd9b1f1bd1c5b4553090057e314df065bdebf86a2e5f64fa451df2fbe4353e29f484a"} 07:08:42 INFO - Running post-run listener: copy_logs_to_upload_dir 07:08:42 INFO - Copying logs to upload dir... 07:08:42 INFO - mkdir: /builds/slave/test/build/upload/logs 07:08:42 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.945356 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-25 07:08:41.910849) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 07:08:41.914784) ========= 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=ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f06323b35773484b14ee8083ec3c690b0e3b6e7c0be56bdf9e1f96730e9d2fa80d2b954862621cbed8763d4b907c1d75b2311eea1f0988ef71a3b9907f4ffba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfab660dbe35b227c2cdfbe1a51fb7fa28fef059fdccee99bb883833e6d8d7d2e2ef24e7f77a844968b9960253ca8b4fd85b9356cf41f8e3aa2ee14e4bac716d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc6e172a5798eee17211ed6bf2238254c81bbd7b7e07e409ba86a744c71bd9b1f1bd1c5b4553090057e314df065bdebf86a2e5f64fa451df2fbe4353e29f484a"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011323 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1477391404/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f06323b35773484b14ee8083ec3c690b0e3b6e7c0be56bdf9e1f96730e9d2fa80d2b954862621cbed8763d4b907c1d75b2311eea1f0988ef71a3b9907f4ffba9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bfab660dbe35b227c2cdfbe1a51fb7fa28fef059fdccee99bb883833e6d8d7d2e2ef24e7f77a844968b9960253ca8b4fd85b9356cf41f8e3aa2ee14e4bac716d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc6e172a5798eee17211ed6bf2238254c81bbd7b7e07e409ba86a744c71bd9b1f1bd1c5b4553090057e314df065bdebf86a2e5f64fa451df2fbe4353e29f484a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-25 07:08:41.940123) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 07:08:41.940545) ========= 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=ed14279e38b05397cf4aa391000001a4-1477403283.223180-403508207 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-25 07:08:42.025772) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 07:08:42.026183) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-25 07:08:42.026579) ========= ========= Total master_lag: 0.16 =========