builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1476797789.83 results: success (0) buildid: 20161018062546 builduid: 561298f7bab04f2ea7b80e58bf7157aa revision: dc89484d4b45abf442162e5ea2dd46f9de40197d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:29.830964) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:29.831437) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:29.831714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:29.846335) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:29.846642) ========= 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=bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-18 06:36:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.9M=0s 2016-10-18 06:36:30 (37.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149895 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:30.010321) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:30.010631) ========= 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=bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016793 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:30.060123) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 06:36:30.060500) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dc89484d4b45abf442162e5ea2dd46f9de40197d --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 dc89484d4b45abf442162e5ea2dd46f9de40197d --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=bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-18 06:36:30,603 truncating revision to first 12 chars 2016-10-18 06:36:30,603 Setting DEBUG logging. 2016-10-18 06:36:30,603 attempt 1/10 2016-10-18 06:36:30,603 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dc89484d4b45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-18 06:36:31,461 unpacking tar archive at: fx-team-dc89484d4b45/testing/mozharness/ program finished with exit code 0 elapsedTime=1.169011 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-18 06:36:31.244072) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:31.244448) ========= script_repo_revision: dc89484d4b45abf442162e5ea2dd46f9de40197d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:31.244874) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:31.245386) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-18 06:36:31.255498) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-18 06:36:31.255902) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:36:31 INFO - MultiFileLogger online at 20161018 06:36:31 in /builds/slave/test 06:36:31 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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:36:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:36:31 INFO - {'append_to_log': False, 06:36:31 INFO - 'base_work_dir': '/builds/slave/test', 06:36:31 INFO - 'blob_upload_branch': 'Fx-Team', 06:36:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:36:31 INFO - 'branch': 'Fx-Team', 06:36:31 INFO - 'buildbot_json_path': 'buildprops.json', 06:36:31 INFO - 'config_files': ('talos/linux_config.py',), 06:36:31 INFO - 'default_actions': ('clobber', 06:36:31 INFO - 'read-buildbot-config', 06:36:31 INFO - 'download-and-extract', 06:36:31 INFO - 'populate-webroot', 06:36:31 INFO - 'create-virtualenv', 06:36:31 INFO - 'install', 06:36:31 INFO - 'run-tests'), 06:36:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:36:31 INFO - 'download_minidump_stackwalk': True, 06:36:31 INFO - 'download_symbols': 'ondemand', 06:36:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:36:31 INFO - 'tooltool.py': '/tools/tooltool.py', 06:36:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:36:31 INFO - '/tools/misc-python/virtualenv.py')}, 06:36:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:36:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:36:31 INFO - 'installer_path': 'installer.exe', 06:36:31 INFO - 'log_level': 'info', 06:36:31 INFO - 'log_name': 'talos', 06:36:31 INFO - 'log_to_console': True, 06:36:31 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:36:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:36:31 INFO - 'opt_config_files': (), 06:36:31 INFO - 'pip_index': False, 06:36:31 INFO - 'sps_profile': False, 06:36:31 INFO - 'sps_profile_interval': 0, 06:36:31 INFO - 'suite': 'dromaeojs-e10s', 06:36:31 INFO - 'system_bits': '32', 06:36:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:36:31 INFO - 'title': 'talos-linux64-ix-055', 06:36:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:36:31 INFO - 'use_talos_json': True, 06:36:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:36:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:36:31 INFO - 'work_dir': 'build'} 06:36:31 INFO - [mozharness: 2016-10-18 13:36:31.901232Z] Running clobber step. 06:36:31 INFO - Running pre-action listener: _resource_record_pre_action 06:36:31 INFO - Running main action method: clobber 06:36:31 INFO - rmtree: /builds/slave/test/build 06:36:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:36:32 INFO - Running post-action listener: _resource_record_post_action 06:36:32 INFO - [mozharness: 2016-10-18 13:36:32.363542Z] Finished clobber step (success) 06:36:32 INFO - [mozharness: 2016-10-18 13:36:32.363643Z] Running read-buildbot-config step. 06:36:32 INFO - Running pre-action listener: _resource_record_pre_action 06:36:32 INFO - Running main action method: read_buildbot_config 06:36:32 INFO - Using buildbot properties: 06:36:32 INFO - { 06:36:32 INFO - "project": "", 06:36:32 INFO - "product": "firefox", 06:36:32 INFO - "script_repo_revision": "production", 06:36:32 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 06:36:32 INFO - "repository": "", 06:36:32 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 06:36:32 INFO - "buildid": "20161018062546", 06:36:32 INFO - "stage_platform": "linux64-pgo", 06:36:32 INFO - "basedir": "/builds/slave/test", 06:36:32 INFO - "buildnumber": 826, 06:36:32 INFO - "platform": "ubuntu64_hw", 06:36:32 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 06:36:32 INFO - "slavebuilddir": "test", 06:36:32 INFO - "branch": "fx-team", 06:36:32 INFO - "revision": "dc89484d4b45abf442162e5ea2dd46f9de40197d", 06:36:32 INFO - "slavename": "talos-linux64-ix-055", 06:36:32 INFO - "builduid": "561298f7bab04f2ea7b80e58bf7157aa", 06:36:32 INFO - "repo_path": "integration/fx-team" 06:36:32 INFO - } 06:36:32 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 06:36:32 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 06:36:32 INFO - Running post-action listener: _resource_record_post_action 06:36:32 INFO - [mozharness: 2016-10-18 13:36:32.366028Z] Finished read-buildbot-config step (success) 06:36:32 INFO - [mozharness: 2016-10-18 13:36:32.366116Z] Running download-and-extract step. 06:36:32 INFO - Running pre-action listener: _resource_record_pre_action 06:36:32 INFO - Running main action method: download_and_extract 06:36:32 INFO - mkdir: /builds/slave/test/build/tests 06:36:32 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:36:32 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:36:32 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/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:36:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/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:36:32 INFO - Downloaded 1361 bytes. 06:36:32 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 06:36:32 INFO - Using the following test package requirements: 06:36:32 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:36:32 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:36:32 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 06:36:32 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:32 INFO - u'jsshell-linux-x86_64.zip'], 06:36:32 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:36:32 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 06:36:32 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:36:32 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:36:32 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:36:32 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 06:36:32 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:36:32 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:36:32 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/1476786616/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:36:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:36:32 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:36:32 INFO - Http code: 200 06:36:32 INFO - via: 1.1 20f1c35f343f4b271ae8dcacfd7ea0e9.cloudfront.net (CloudFront) 06:36:32 INFO - x-amz-cf-id: XlmDM0H8gtSKI-FBlpvOdMB-a09OOy5P5_7t5dv682H9TqYd8iT75Q== 06:36:32 INFO - x-amz-replication-status: COMPLETED 06:36:32 INFO - x-amz-version-id: qvnGSvvlURsDbCc9nUOY_3tO5113X.h9 06:36:32 INFO - Expected file size: 22090426 06:36:32 INFO - Obtained file size: 22090426 06:36:36 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:36:36 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/1476786616/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 06:36:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 06:36:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 06:36:36 INFO - Http code: 200 06:36:36 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 06:36:36 INFO - x-amz-cf-id: bwABr8quMionY5doxejUCquqEs3cyVIf8T8HT1koDVCZNUdeog8Sag== 06:36:36 INFO - x-amz-replication-status: COMPLETED 06:36:36 INFO - x-amz-version-id: qvnGSvvlURsDbCc9nUOY_3tO5113X.h9 06:36:37 INFO - Expected file size: 22090426 06:36:37 INFO - Obtained file size: 22090426 06:36:41 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/1476786616/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 06:36:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 06:36:41 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 06:36:41 INFO - Http code: 200 06:36:41 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 06:36:41 INFO - x-amz-cf-id: knQQihOi6IQSsQZRokOrkpchOQFWMLUZrJBjMcJQMqcMjiQm87a7wg== 06:36:41 INFO - x-amz-replication-status: COMPLETED 06:36:41 INFO - x-amz-version-id: cJpeD_KFrXWBJYRyuLhjwwo6uCOh9UD4 06:36:41 INFO - Expected file size: 14409028 06:36:41 INFO - Obtained file size: 14409028 06:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:42 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:42 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/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:36:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/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:36:42 INFO - Downloaded 59486961 bytes. 06:36:42 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:42 INFO - mkdir: /builds/slave/test/properties 06:36:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:36:42 INFO - Writing to file /builds/slave/test/properties/build_url 06:36:42 INFO - Contents: 06:36:42 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 06:36:43 INFO - Running post-action listener: _resource_record_post_action 06:36:43 INFO - Running post-action listener: set_extra_try_arguments 06:36:43 INFO - [mozharness: 2016-10-18 13:36:43.138333Z] Finished download-and-extract step (success) 06:36:43 INFO - [mozharness: 2016-10-18 13:36:43.138559Z] Running populate-webroot step. 06:36:43 INFO - Running pre-action listener: _resource_record_pre_action 06:36:43 INFO - Running main action method: populate_webroot 06:36:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:36:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:36:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:36:43 INFO - '--tppagecycles', 06:36:43 INFO - '7'], 06:36:43 INFO - 'tests': ['tsvgm']}}, 06:36:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:36:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:36:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:36:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:36:43 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:43 INFO - 'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:43 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:36:43 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:43 INFO - 'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['damp', 'tps']}, 06:36:43 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:43 INFO - 'tests': ['damp', 'tps']}, 06:36:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['dromaeo_dom']}, 06:36:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:36:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['basic_compositor_video']}, 06:36:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:36:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['a11yr', 06:36:43 INFO - 'ts_paint', 06:36:43 INFO - 'tpaint', 06:36:43 INFO - 'sessionrestore', 06:36:43 INFO - 'sessionrestore_no_auto_restore', 06:36:43 INFO - 'tabpaint']}, 06:36:43 INFO - 'other-e10s': {'tests': ['a11yr', 06:36:43 INFO - 'ts_paint', 06:36:43 INFO - 'tpaint', 06:36:43 INFO - 'sessionrestore', 06:36:43 INFO - 'sessionrestore_no_auto_restore', 06:36:43 INFO - 'tabpaint']}, 06:36:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:36:43 INFO - 'ts_paint', 06:36:43 INFO - 'tpaint', 06:36:43 INFO - 'sessionrestore', 06:36:43 INFO - 'sessionrestore_no_auto_restore', 06:36:43 INFO - 'tabpaint']}, 06:36:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:36:43 INFO - 'ts_paint', 06:36:43 INFO - 'tpaint', 06:36:43 INFO - 'sessionrestore', 06:36:43 INFO - 'sessionrestore_no_auto_restore', 06:36:43 INFO - 'tabpaint']}, 06:36:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['a11yr', 06:36:43 INFO - 'ts_paint', 06:36:43 INFO - 'tpaint', 06:36:43 INFO - 'sessionrestore', 06:36:43 INFO - 'sessionrestore_no_auto_restore', 06:36:43 INFO - 'tabpaint']}, 06:36:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['a11yr', 06:36:43 INFO - 'ts_paint', 06:36:43 INFO - 'tpaint', 06:36:43 INFO - 'sessionrestore', 06:36:43 INFO - 'sessionrestore_no_auto_restore', 06:36:43 INFO - 'tabpaint']}, 06:36:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['tsvgx', 06:36:43 INFO - 'tsvgr_opacity', 06:36:43 INFO - 'tart', 06:36:43 INFO - 'tscrollx', 06:36:43 INFO - 'cart']}, 06:36:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:36:43 INFO - 'tsvgr_opacity', 06:36:43 INFO - 'tart', 06:36:43 INFO - 'tscrollx', 06:36:43 INFO - 'cart']}, 06:36:43 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:43 INFO - 'talos_options': ['--disable-e10s'], 06:36:43 INFO - 'tests': ['tp5o']}, 06:36:43 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:43 INFO - 'tests': ['tp5o']}, 06:36:43 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:43 INFO - 'talos_options': ['--disable-e10s', 06:36:43 INFO - '--xperf_path', 06:36:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:43 INFO - 'tests': ['tp5n']}, 06:36:43 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:36:43 INFO - 'talos_options': ['--xperf_path', 06:36:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:36:43 INFO - 'tests': ['tp5n']}}, 06:36:43 INFO - 'talos.zip': {'path': '', 06:36:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:36:43 INFO - Running post-action listener: _resource_record_post_action 06:36:43 INFO - [mozharness: 2016-10-18 13:36:43.153959Z] Finished populate-webroot step (success) 06:36:43 INFO - [mozharness: 2016-10-18 13:36:43.154048Z] Running create-virtualenv step. 06:36:43 INFO - Running pre-action listener: _resource_record_pre_action 06:36:43 INFO - Running main action method: create_virtualenv 06:36:43 INFO - Creating virtualenv /builds/slave/test/build/venv 06:36:43 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:36:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:36:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:36:43 INFO - Using real prefix '/usr' 06:36:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:36:43 INFO - Installing distribute.............................................................................................................................................................................................done. 06:36:45 INFO - Installing pip.................done. 06:36:45 INFO - Return code: 0 06:36:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 06:36:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 06:36:45 INFO - Reading from file tmpfile_stdout 06:36:45 INFO - Output received: 06:36:45 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:36:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:36:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:45 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 0x7f058015cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', '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:36:45 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:36:45 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:36:45 INFO - Using env: {'DISPLAY': ':0', 06:36:45 INFO - 'HOME': '/home/cltbld', 06:36:45 INFO - 'LANG': 'en_US.UTF-8', 06:36:45 INFO - 'LANGUAGE': 'en_US:en', 06:36:45 INFO - 'LOGNAME': 'cltbld', 06:36:45 INFO - 'MAIL': '/var/mail/cltbld', 06:36:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:45 INFO - 'MOZ_NO_REMOTE': '1', 06:36:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:45 INFO - 'NO_EM_RESTART': '1', 06:36:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:45 INFO - 'PWD': '/builds/slave/test', 06:36:45 INFO - 'SHELL': '/bin/bash', 06:36:45 INFO - 'SHLVL': '1', 06:36:45 INFO - 'TERM': 'linux', 06:36:45 INFO - 'TMOUT': '86400', 06:36:45 INFO - 'USER': 'cltbld', 06:36:45 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:36:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:45 INFO - '_': '/tools/buildbot/bin/python'} 06:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:46 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:36:46 INFO - Cleaning up... 06:36:46 INFO - Return code: 0 06:36:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:36:46 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:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:46 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:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:46 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 0x7f058015cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', '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:36:46 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:36:46 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:36:46 INFO - Using env: {'DISPLAY': ':0', 06:36:46 INFO - 'HOME': '/home/cltbld', 06:36:46 INFO - 'LANG': 'en_US.UTF-8', 06:36:46 INFO - 'LANGUAGE': 'en_US:en', 06:36:46 INFO - 'LOGNAME': 'cltbld', 06:36:46 INFO - 'MAIL': '/var/mail/cltbld', 06:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:46 INFO - 'MOZ_NO_REMOTE': '1', 06:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:46 INFO - 'NO_EM_RESTART': '1', 06:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:46 INFO - 'PWD': '/builds/slave/test', 06:36:46 INFO - 'SHELL': '/bin/bash', 06:36:46 INFO - 'SHLVL': '1', 06:36:46 INFO - 'TERM': 'linux', 06:36:46 INFO - 'TMOUT': '86400', 06:36:46 INFO - 'USER': 'cltbld', 06:36:46 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:46 INFO - '_': '/tools/buildbot/bin/python'} 06:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:46 INFO - Downloading/unpacking psutil>=3.1.1 06:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:36:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:48 INFO - Installing collected packages: psutil 06:36:48 INFO - Running setup.py install for psutil 06:36:48 INFO - building 'psutil._psutil_linux' extension 06:36:48 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:36:48 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:36:48 INFO - building 'psutil._psutil_posix' extension 06:36:48 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:36:48 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:36:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:36:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:36:48 INFO - Successfully installed psutil 06:36:48 INFO - Cleaning up... 06:36:48 INFO - Return code: 0 06:36:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:36:48 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:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:48 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:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:48 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 0x7f058015cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', '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:36:48 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:36:48 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:36:48 INFO - Using env: {'DISPLAY': ':0', 06:36:48 INFO - 'HOME': '/home/cltbld', 06:36:48 INFO - 'LANG': 'en_US.UTF-8', 06:36:48 INFO - 'LANGUAGE': 'en_US:en', 06:36:48 INFO - 'LOGNAME': 'cltbld', 06:36:48 INFO - 'MAIL': '/var/mail/cltbld', 06:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:48 INFO - 'MOZ_NO_REMOTE': '1', 06:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:48 INFO - 'NO_EM_RESTART': '1', 06:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:48 INFO - 'PWD': '/builds/slave/test', 06:36:48 INFO - 'SHELL': '/bin/bash', 06:36:48 INFO - 'SHLVL': '1', 06:36:48 INFO - 'TERM': 'linux', 06:36:48 INFO - 'TMOUT': '86400', 06:36:48 INFO - 'USER': 'cltbld', 06:36:48 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:48 INFO - '_': '/tools/buildbot/bin/python'} 06:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:36:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:36:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:36:51 INFO - Installing collected packages: mozsystemmonitor 06:36:51 INFO - Running setup.py install for mozsystemmonitor 06:36:51 INFO - Successfully installed mozsystemmonitor 06:36:51 INFO - Cleaning up... 06:36:51 INFO - Return code: 0 06:36:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:36:51 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:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:51 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:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:51 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 0x7f058015cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', '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:36:51 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:36:51 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:36:51 INFO - Using env: {'DISPLAY': ':0', 06:36:51 INFO - 'HOME': '/home/cltbld', 06:36:51 INFO - 'LANG': 'en_US.UTF-8', 06:36:51 INFO - 'LANGUAGE': 'en_US:en', 06:36:51 INFO - 'LOGNAME': 'cltbld', 06:36:51 INFO - 'MAIL': '/var/mail/cltbld', 06:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:51 INFO - 'MOZ_NO_REMOTE': '1', 06:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:51 INFO - 'NO_EM_RESTART': '1', 06:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:51 INFO - 'PWD': '/builds/slave/test', 06:36:51 INFO - 'SHELL': '/bin/bash', 06:36:51 INFO - 'SHLVL': '1', 06:36:51 INFO - 'TERM': 'linux', 06:36:51 INFO - 'TMOUT': '86400', 06:36:51 INFO - 'USER': 'cltbld', 06:36:51 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:51 INFO - '_': '/tools/buildbot/bin/python'} 06:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:51 INFO - Downloading/unpacking jsonschema==2.5.1 06:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:36:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:54 INFO - Downloading functools32-3.2.3-2.tar.gz 06:36:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:36:54 INFO - warning: no files found matching '*.txt' 06:36:54 INFO - no previously-included directories found matching 'build' 06:36:54 INFO - no previously-included directories found matching 'dist' 06:36:54 INFO - no previously-included directories found matching '.git*' 06:36:54 INFO - Installing collected packages: jsonschema, functools32 06:36:54 INFO - Running setup.py install for functools32 06:36:55 INFO - warning: no files found matching '*.txt' 06:36:55 INFO - no previously-included directories found matching 'build' 06:36:55 INFO - no previously-included directories found matching 'dist' 06:36:55 INFO - no previously-included directories found matching '.git*' 06:36:55 INFO - Successfully installed jsonschema functools32 06:36:55 INFO - Cleaning up... 06:36:55 INFO - Return code: 0 06:36:55 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:36: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:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:55 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 0x7f058015cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', '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:36:55 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:36:55 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:36:55 INFO - Using env: {'DISPLAY': ':0', 06:36:55 INFO - 'HOME': '/home/cltbld', 06:36:55 INFO - 'LANG': 'en_US.UTF-8', 06:36:55 INFO - 'LANGUAGE': 'en_US:en', 06:36:55 INFO - 'LOGNAME': 'cltbld', 06:36:55 INFO - 'MAIL': '/var/mail/cltbld', 06:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:55 INFO - 'MOZ_NO_REMOTE': '1', 06:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:55 INFO - 'NO_EM_RESTART': '1', 06:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:55 INFO - 'PWD': '/builds/slave/test', 06:36:55 INFO - 'SHELL': '/bin/bash', 06:36:55 INFO - 'SHLVL': '1', 06:36:55 INFO - 'TERM': 'linux', 06:36:55 INFO - 'TMOUT': '86400', 06:36:55 INFO - 'USER': 'cltbld', 06:36:55 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:55 INFO - '_': '/tools/buildbot/bin/python'} 06:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:55 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:36:55 INFO - Cleaning up... 06:36:55 INFO - Return code: 0 06:36:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:36: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:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36: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:36:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:55 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 0x7f058015cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', '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:36:55 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:36:55 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:36:55 INFO - Using env: {'DISPLAY': ':0', 06:36:55 INFO - 'HOME': '/home/cltbld', 06:36:55 INFO - 'LANG': 'en_US.UTF-8', 06:36:55 INFO - 'LANGUAGE': 'en_US:en', 06:36:55 INFO - 'LOGNAME': 'cltbld', 06:36:55 INFO - 'MAIL': '/var/mail/cltbld', 06:36:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:55 INFO - 'MOZ_NO_REMOTE': '1', 06:36:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:55 INFO - 'NO_EM_RESTART': '1', 06:36:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:55 INFO - 'PWD': '/builds/slave/test', 06:36:55 INFO - 'SHELL': '/bin/bash', 06:36:55 INFO - 'SHLVL': '1', 06:36:55 INFO - 'TERM': 'linux', 06:36:55 INFO - 'TMOUT': '86400', 06:36:55 INFO - 'USER': 'cltbld', 06:36:55 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:36:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:55 INFO - '_': '/tools/buildbot/bin/python'} 06:36:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:55 INFO - Downloading/unpacking blobuploader==1.2.4 06:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:57 INFO - Downloading blobuploader-1.2.4.tar.gz 06:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:36:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:36:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:36:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:36:58 INFO - Downloading docopt-0.6.1.tar.gz 06:36:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:36:58 INFO - Installing collected packages: blobuploader, requests, docopt 06:36:58 INFO - Running setup.py install for blobuploader 06:36:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:36:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:36:58 INFO - Running setup.py install for requests 06:36:58 INFO - Running setup.py install for docopt 06:36:58 INFO - Successfully installed blobuploader requests docopt 06:36:58 INFO - Cleaning up... 06:36:58 INFO - Return code: 0 06:36:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:36:58 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:36:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:36:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:58 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:36:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:36:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:36:58 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 0x7f058015cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', '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:36:58 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:36:58 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:36:58 INFO - Using env: {'DISPLAY': ':0', 06:36:58 INFO - 'HOME': '/home/cltbld', 06:36:58 INFO - 'LANG': 'en_US.UTF-8', 06:36:58 INFO - 'LANGUAGE': 'en_US:en', 06:36:58 INFO - 'LOGNAME': 'cltbld', 06:36:58 INFO - 'MAIL': '/var/mail/cltbld', 06:36:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:36:58 INFO - 'MOZ_NO_REMOTE': '1', 06:36:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:36:58 INFO - 'NO_EM_RESTART': '1', 06:36:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:36:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:36:58 INFO - 'PWD': '/builds/slave/test', 06:36:58 INFO - 'SHELL': '/bin/bash', 06:36:58 INFO - 'SHLVL': '1', 06:36:58 INFO - 'TERM': 'linux', 06:36:58 INFO - 'TMOUT': '86400', 06:36:58 INFO - 'USER': 'cltbld', 06:36:58 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:36:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:36:58 INFO - '_': '/tools/buildbot/bin/python'} 06:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:36:59 INFO - Running setup.py (path:/tmp/pip-0wVkO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:36:59 INFO - Running setup.py (path:/tmp/pip-Q48peY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:36:59 INFO - Running setup.py (path:/tmp/pip-csGnUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:36:59 INFO - Running setup.py (path:/tmp/pip-6fetcv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:36:59 INFO - Running setup.py (path:/tmp/pip-k5MLQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:36:59 INFO - Running setup.py (path:/tmp/pip-ss5nRc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:36:59 INFO - Running setup.py (path:/tmp/pip-jalcv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:36:59 INFO - Running setup.py (path:/tmp/pip-MDMd74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:36:59 INFO - Running setup.py (path:/tmp/pip-O7Ewlt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:36:59 INFO - Running setup.py (path:/tmp/pip-DTKCU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:36:59 INFO - Running setup.py (path:/tmp/pip-RVpvlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:36:59 INFO - Running setup.py (path:/tmp/pip-HtFAdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:36:59 INFO - Running setup.py (path:/tmp/pip-FF1tIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:00 INFO - Running setup.py (path:/tmp/pip-p9NoEB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:00 INFO - Running setup.py (path:/tmp/pip-PVSO5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:00 INFO - Running setup.py (path:/tmp/pip-YNtR2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:00 INFO - Running setup.py (path:/tmp/pip-Lp9y7A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:37:00 INFO - Running setup.py install for manifestparser 06:37:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:37:00 INFO - Running setup.py install for mozcrash 06:37:00 INFO - Running setup.py install for mozdebug 06:37:00 INFO - Running setup.py install for mozdevice 06:37:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:37:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:37:00 INFO - Running setup.py install for mozfile 06:37:00 INFO - Running setup.py install for mozhttpd 06:37:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:37:00 INFO - Running setup.py install for mozinfo 06:37:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:37:00 INFO - Running setup.py install for mozInstall 06:37:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for mozleak 06:37:01 INFO - Running setup.py install for mozlog 06:37:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for moznetwork 06:37:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for mozprocess 06:37:01 INFO - Running setup.py install for mozprofile 06:37:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for mozrunner 06:37:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:37:01 INFO - Running setup.py install for mozscreenshot 06:37:01 INFO - Running setup.py install for moztest 06:37:01 INFO - Running setup.py install for mozversion 06:37:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:37:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:37:02 INFO - Cleaning up... 06:37:02 INFO - Return code: 0 06:37:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:02 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 0x7f058015cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', '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:37:02 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:37:02 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:37:02 INFO - Using env: {'DISPLAY': ':0', 06:37:02 INFO - 'HOME': '/home/cltbld', 06:37:02 INFO - 'LANG': 'en_US.UTF-8', 06:37:02 INFO - 'LANGUAGE': 'en_US:en', 06:37:02 INFO - 'LOGNAME': 'cltbld', 06:37:02 INFO - 'MAIL': '/var/mail/cltbld', 06:37:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:02 INFO - 'MOZ_NO_REMOTE': '1', 06:37:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:02 INFO - 'NO_EM_RESTART': '1', 06:37:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:02 INFO - 'PWD': '/builds/slave/test', 06:37:02 INFO - 'SHELL': '/bin/bash', 06:37:02 INFO - 'SHLVL': '1', 06:37:02 INFO - 'TERM': 'linux', 06:37:02 INFO - 'TMOUT': '86400', 06:37:02 INFO - 'USER': 'cltbld', 06:37:02 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:37:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:02 INFO - '_': '/tools/buildbot/bin/python'} 06:37:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:37:02 INFO - Running setup.py (path:/tmp/pip-FU7jd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:37:02 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:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:37:02 INFO - Running setup.py (path:/tmp/pip-UTSlvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:37:02 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:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:37:02 INFO - Running setup.py (path:/tmp/pip-Aul30p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:37:02 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:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:37:02 INFO - Running setup.py (path:/tmp/pip-4eY6sv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:37:02 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:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:37:02 INFO - Running setup.py (path:/tmp/pip-RS68FB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:37:02 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:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:37:02 INFO - Running setup.py (path:/tmp/pip-6nWr40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:37:02 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:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:37:02 INFO - Running setup.py (path:/tmp/pip-AV_nKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:37:02 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:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:37:02 INFO - Running setup.py (path:/tmp/pip-07Ozta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:37:02 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:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:37:02 INFO - Running setup.py (path:/tmp/pip-voh6zS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:37:02 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:37:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:37:02 INFO - Running setup.py (path:/tmp/pip-b0kilq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:37:03 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:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:37:03 INFO - Running setup.py (path:/tmp/pip-CfmWwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:37:03 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:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:37:03 INFO - Running setup.py (path:/tmp/pip-i8AJZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:37:03 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:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:37:03 INFO - Running setup.py (path:/tmp/pip-kkGS_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:37:03 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:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:37:03 INFO - Running setup.py (path:/tmp/pip-dwZODE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:37:03 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:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:03 INFO - Running setup.py (path:/tmp/pip-TxQkk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:37:03 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:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:37:03 INFO - Running setup.py (path:/tmp/pip-hJFFjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:37:03 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:37:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:37:03 INFO - Running setup.py (path:/tmp/pip-Thgx2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:03 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:37:05 INFO - Downloading blessings-1.6.tar.gz 06:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:37:05 INFO - Installing collected packages: blessings 06:37:05 INFO - Running setup.py install for blessings 06:37:05 INFO - Successfully installed blessings 06:37:05 INFO - Cleaning up... 06:37:05 INFO - Return code: 0 06:37:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:37:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:05 INFO - Reading from file tmpfile_stdout 06:37:05 INFO - Current package versions: 06:37:05 INFO - argparse == 1.2.1 06:37:05 INFO - blessings == 1.6 06:37:05 INFO - blobuploader == 1.2.4 06:37:05 INFO - docopt == 0.6.1 06:37:05 INFO - functools32 == 3.2.3-2 06:37:05 INFO - jsonschema == 2.5.1 06:37:05 INFO - manifestparser == 1.1 06:37:05 INFO - mozInstall == 1.12 06:37:05 INFO - mozcrash == 0.17 06:37:05 INFO - mozdebug == 0.1 06:37:05 INFO - mozdevice == 0.48 06:37:05 INFO - mozfile == 1.2 06:37:05 INFO - mozhttpd == 0.7 06:37:05 INFO - mozinfo == 0.9 06:37:05 INFO - mozleak == 0.1 06:37:05 INFO - mozlog == 3.4 06:37:05 INFO - moznetwork == 0.27 06:37:05 INFO - mozprocess == 0.23 06:37:05 INFO - mozprofile == 0.28 06:37:05 INFO - mozrunner == 6.12 06:37:05 INFO - mozscreenshot == 0.1 06:37:05 INFO - mozsystemmonitor == 0.3 06:37:05 INFO - moztest == 0.7 06:37:05 INFO - mozversion == 1.4 06:37:05 INFO - psutil == 3.1.1 06:37:05 INFO - requests == 1.2.3 06:37:05 INFO - wsgiref == 0.1.2 06:37:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:37: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:37:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37: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:37:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:05 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 0x7f058015cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', '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:37:05 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:37:05 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:37:05 INFO - Using env: {'DISPLAY': ':0', 06:37:05 INFO - 'HOME': '/home/cltbld', 06:37:05 INFO - 'LANG': 'en_US.UTF-8', 06:37:05 INFO - 'LANGUAGE': 'en_US:en', 06:37:05 INFO - 'LOGNAME': 'cltbld', 06:37:05 INFO - 'MAIL': '/var/mail/cltbld', 06:37:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:05 INFO - 'MOZ_NO_REMOTE': '1', 06:37:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:05 INFO - 'NO_EM_RESTART': '1', 06:37:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:05 INFO - 'PWD': '/builds/slave/test', 06:37:05 INFO - 'SHELL': '/bin/bash', 06:37:05 INFO - 'SHLVL': '1', 06:37:05 INFO - 'TERM': 'linux', 06:37:05 INFO - 'TMOUT': '86400', 06:37:05 INFO - 'USER': 'cltbld', 06:37:05 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:37:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:05 INFO - '_': '/tools/buildbot/bin/python'} 06:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:06 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:37:06 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:37:06 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:37:06 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:37:06 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:37:06 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:37:06 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:37:06 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:37:06 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:37:06 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:37:06 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:37:06 INFO - Cleaning up... 06:37:06 INFO - Return code: 0 06:37:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:37:06 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 0x7f058015cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27ec8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28b9790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, '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': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', '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:37:06 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:37:06 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:37:06 INFO - Using env: {'DISPLAY': ':0', 06:37:06 INFO - 'HOME': '/home/cltbld', 06:37:06 INFO - 'LANG': 'en_US.UTF-8', 06:37:06 INFO - 'LANGUAGE': 'en_US:en', 06:37:06 INFO - 'LOGNAME': 'cltbld', 06:37:06 INFO - 'MAIL': '/var/mail/cltbld', 06:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:06 INFO - 'MOZ_NO_REMOTE': '1', 06:37:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:06 INFO - 'NO_EM_RESTART': '1', 06:37:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:06 INFO - 'PWD': '/builds/slave/test', 06:37:06 INFO - 'SHELL': '/bin/bash', 06:37:06 INFO - 'SHLVL': '1', 06:37:06 INFO - 'TERM': 'linux', 06:37:06 INFO - 'TMOUT': '86400', 06:37:06 INFO - 'USER': 'cltbld', 06:37:06 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:06 INFO - '_': '/tools/buildbot/bin/python'} 06:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:37:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:37:06 INFO - Cleaning up... 06:37:06 INFO - Return code: 0 06:37:06 INFO - Running post-action listener: _resource_record_post_action 06:37:06 INFO - Running post-action listener: _start_resource_monitoring 06:37:06 INFO - Starting resource monitoring. 06:37:06 INFO - [mozharness: 2016-10-18 13:37:06.430641Z] Finished create-virtualenv step (success) 06:37:06 INFO - [mozharness: 2016-10-18 13:37:06.431147Z] Running install step. 06:37:06 INFO - Running pre-action listener: _resource_record_pre_action 06:37:06 INFO - Running main action method: install 06:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:37:06 INFO - Reading from file tmpfile_stdout 06:37:06 INFO - Detecting whether we're running mozinstall >=1.0... 06:37:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:37:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:37:06 INFO - Reading from file tmpfile_stdout 06:37:06 INFO - Output received: 06:37:06 INFO - Usage: mozinstall [options] installer 06:37:06 INFO - Options: 06:37:06 INFO - -h, --help show this help message and exit 06:37:06 INFO - -d DEST, --destination=DEST 06:37:06 INFO - Directory to install application into. [default: 06:37:06 INFO - "/builds/slave/test"] 06:37:06 INFO - --app=APP Application being installed. [default: firefox] 06:37:06 INFO - mkdir: /builds/slave/test/build/application 06:37:06 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:37:06 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:37:23 INFO - Reading from file tmpfile_stdout 06:37:23 INFO - Output received: 06:37:23 INFO - /builds/slave/test/build/application/firefox/firefox 06:37:23 INFO - Running post-action listener: _resource_record_post_action 06:37:23 INFO - [mozharness: 2016-10-18 13:37:23.651083Z] Finished install step (success) 06:37:23 INFO - [mozharness: 2016-10-18 13:37:23.651353Z] Running run-tests step. 06:37:23 INFO - Running pre-action listener: _resource_record_pre_action 06:37:23 INFO - Running main action method: run_tests 06:37:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:37:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:37:23 INFO - Python 2.7.3 06:37:23 INFO - Return code: 0 06:37:23 INFO - grabbing minidump binary from tooltool 06:37:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:37:23 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 0x28b6930>, '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 0x28b7830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28b7cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:37:23 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:37:23 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:37:23 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:37:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:37:23 INFO - Return code: 0 06:37:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:37:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:37:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:37:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:37:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:37:23 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 06:37:23 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 06:37:23 INFO - Using env: {'DISPLAY': ':0', 06:37:23 INFO - 'HOME': '/home/cltbld', 06:37:23 INFO - 'LANG': 'en_US.UTF-8', 06:37:23 INFO - 'LANGUAGE': 'en_US:en', 06:37:23 INFO - 'LOGNAME': 'cltbld', 06:37:23 INFO - 'MAIL': '/var/mail/cltbld', 06:37:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:37:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:37:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:37:23 INFO - 'MOZ_NO_REMOTE': '1', 06:37:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:37:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:37:23 INFO - 'NO_EM_RESTART': '1', 06:37:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:37:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:37:23 INFO - 'PWD': '/builds/slave/test', 06:37:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:37:23 INFO - 'SHELL': '/bin/bash', 06:37:23 INFO - 'SHLVL': '1', 06:37:23 INFO - 'TERM': 'linux', 06:37:23 INFO - 'TMOUT': '86400', 06:37:23 INFO - 'USER': 'cltbld', 06:37:23 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531', 06:37:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:37:23 INFO - '_': '/tools/buildbot/bin/python'} 06:37:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 06:37:23 INFO - mozversion application_buildid: 20161018033016 06:37:23 INFO - mozversion application_changeset: dc89484d4b45abf442162e5ea2dd46f9de40197d 06:37:23 INFO - mozversion application_display_name: Nightly 06:37:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:37:23 INFO - mozversion application_name: Firefox 06:37:23 INFO - mozversion application_remotingname: firefox 06:37:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:37:23 INFO - mozversion application_vendor: Mozilla 06:37:23 INFO - mozversion application_version: 52.0a1 06:37:23 INFO - mozversion platform_buildid: 20161018033016 06:37:23 INFO - mozversion platform_changeset: dc89484d4b45abf442162e5ea2dd46f9de40197d 06:37:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:37:23 INFO - mozversion platform_version: 52.0a1 06:37:23 INFO - using testdate: 1476797843 06:37:23 INFO - actual date: 1476797843 06:37:23 INFO - starting webserver on 'localhost:33850' 06:37:23 INFO - SUITE-START | Running 2 tests 06:37:23 INFO - TEST-START | dromaeo_css 06:37:23 INFO - operating with platform_type : linux_ 06:37:23 INFO - Initialising browser for dromaeo_css test... 06:37:23 INFO - TEST-INFO | started process 12857 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQHxLN4/profile http://localhost:33850/getInfo.html) 06:37:28 INFO - PROCESS | 12857 | __metrics Screen width/height:1600/1200 06:37:28 INFO - PROCESS | 12857 | colorDepth:24 06:37:28 INFO - PROCESS | 12857 | Browser inner width/height: 1024/697 06:37:28 INFO - PROCESS | 12857 | __metrics 06:37:28 ERROR - PROCESS | 12857 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 06:37:29 INFO - TEST-INFO | 12857: exit 0 06:37:29 INFO - Browser initialized. 06:37:29 INFO - Running cycle 1/1 for dromaeo_css test... 06:37:29 INFO - TEST-INFO | started process 12978 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQHxLN4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:37:41 INFO - PROCESS | 12978 | RSS: Main: 182951936 06:37:41 INFO - PROCESS | 12978 | 06:38:31 INFO - PROCESS | 12978 | 1476797911673 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:40:43 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:33850/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33850/tests/dromaeo/cssquery-ext.html) 06:40:44 INFO - PROCESS | 12978 | RSS: Main: 196321280 06:40:44 INFO - PROCESS | 12978 | 06:43:46 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:33850/tests/dromaeo/cssquery-ext.html (next: http://localhost:33850/tests/dromaeo/cssquery-jquery.html) 06:43:47 INFO - PROCESS | 12978 | RSS: Main: 194707456 06:43:47 INFO - PROCESS | 12978 | 06:46:49 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:33850/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33850/tests/dromaeo/cssquery-mootools.html) 06:46:49 INFO - PROCESS | 12978 | RSS: Main: 196829184 06:46:49 INFO - PROCESS | 12978 | 06:49:51 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:33850/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33850/tests/dromaeo/cssquery-prototype.html) 06:49:52 INFO - PROCESS | 12978 | RSS: Main: 193339392 06:49:52 INFO - PROCESS | 12978 | 06:52:54 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:33850/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33850/tests/dromaeo/cssquery-yui.html) 06:52:55 INFO - PROCESS | 12978 | RSS: Main: 196886528 06:52:55 INFO - PROCESS | 12978 | 06:55:58 INFO - PROCESS | 12978 | Cycle 1(1): loaded http://localhost:33850/tests/dromaeo/cssquery-yui.html (next: http://localhost:33850/tests/dromaeo/cssquery-dojo.html) 06:55:59 INFO - PROCESS | 12978 | RSS: Main: 196206592 06:55:59 INFO - PROCESS | 12978 | 06:55:59 INFO - PROCESS | 12978 | __start_tp_report 06:55:59 INFO - PROCESS | 12978 | _x_x_mozilla_page_load 06:55:59 INFO - PROCESS | 12978 | _x_x_mozilla_page_load_details 06:55:59 INFO - PROCESS | 12978 | |i|pagename|runs| 06:55:59 INFO - PROCESS | 12978 | |0;dojo.html;3082.383523295341;3097.4424603571347;3111.9844400777993;3134.0441165444536;3137.513685378767;5288.233206185101;5299.258103865457;5411.404745477999;5460.262864513289;5564.304461942257;5292.153255479124;5344.22508736233;5410.08028635132;5470.753816078276;5485.232067510552;4879.463259041502;4891.706497610146;4921.941782516758;4924.650161463941;4947.307376967227;4918.877028074291;5000.349954505909;5084.644074914758;5085.211792172201;5123.436421993596;4841.7579121044155;4853.563179313844;5015.3730783652045;5049.394072711261;5084;4902.681325713817;4931.65478416511;4952.108620448318;4976.004799040206;5028.145215313405;4924.187509061001;4926.33494478248;4927.211646136601;4935.876603084916;5022.397312322545;5264.341957255343;5424.186372044185;5451.209574611698;5478.808241711561;5491.560675145979;5655.1517272409465;5762.711864406763;5802.82591522255;5828.358880523139;5914.8817023659285;5902.2622172228475;5909.940900590982;5911.615744976606;5923.526117910556;5935.9406405935815;5460.099083651193;5485.561155107622;5487.6981766002855;5493.093639549509;5499.257600223998;5781.653100813965;5881.794137205177;5898.14476900847;5971.58198926071;5973.611715238582;5736.827895163152;5752.827415177551;5761.135829625589;5766.88466230673;5815.069588865761;5811.15738217956;5836.241288632451;5864.941350586525;5871.6183448075735;5891.705414729332;5587.469190426903;5612.747426365823;5688.943110568925;5788.594798364074;5790.160426738099;5814;5824.563157763185;5825.126231065374;5825.7378417971295;5881.617694849821;4490.12442573695;4504.752238626841;4510.255807791743;4511.390962220124;4578.175928332932;3866.149447121629;3883.5533913599734;3949.565547789741;3987.441758153861;3994.400839873984;5499.642523235977;5544.69504177266;5569.749361278752;5587.720613969285;5602.075657516464;5800.158976948319;5828.912566311508;5831.504322132581;5857.238558987389;5867.647941123546;5223.817166399158;5315.176147697113;5547.334319881559;5547.528460080857;5555.138953462219;5019.698818070928;5065.062963351792;5070.163423035232;5070.416902056237;5129.076766182048;5991.700414979234;6015.699215039143;6034.275886893513;6034.306054803666;6056;5661.631993920382;5838.912416313674;5853.765849365977;5855.151003104611;5856.94143058564;5881.852953676022;5937.554683398676;6043.607165534227;6077.604955677867;6090.756835501955;5723.7996670116345;5767.307923049261;5792.333881603501;5793.652380857162;5847.707614619337;5850.824475265749;5854;5873.207117039145;5885.411458854252;5891.263592050994;5450.645708028966;5471.151971444273;5676.772929082956;5697.4302569742695;5719.828405147852;5684.317881854204;5698.31620205578;5703.7433315500075;5711.029125048669;5730.484256416776;5352.678839269656;5452.6183167177915;5627.971860140673;5645.463680950304;5648.971755141362;5706.714664266853;5783.566232532661;5787.826365209051;5809.709514524341;5862.208601838697;5637.830865074055;5677.489025987681;5688.54491640676;5694.4590263924865;5695.914561281667 06:55:59 INFO - PROCESS | 12978 | |1;ext.html;552.7880443515988;561.2619405481792;582.2256398989344;593.4895989449074;602.0126991733556;40540.59459405405;41863.673857075046;42162.36756448656;44887.10225795482;45277;42349.15301693964;43054.13891722164;43101.353479697755;43166.13667726643;43237;8758.693445729401;8933.46399216046;8951.328650351217;8962.37263391563;8964.641414343418;8801.427907186044;8880.378373513857;8883;8887.20015198632;8901.465912045298;8939.195472407482;8977.551122443885;8978.955105224464;8981.14679105484;8984.910150898473;8870.86693699595;8940.910590894138;8941.150590693906;8946.55267236642;8961.641534338618;8787.516686582236;8833.33749968755;8840.955795220983;8853.203211710912;8859.069797671216;40515.797421013;40580.59419405827;40735.796321018504;40818.38772418416;40950.38574421386;3311.3708395404797;3332.266901281714;3432.433648448003;3490.494635145354;3494.4059509883127;30505;30562.235944101576;30580.38839223203;31565.36869262625;32496.6750332496;4223.239816832969;4326.459192600925;4423.424954755893;4440.289553671397;4480.596746292849;217567;217730;218960;219045.80954190413;219388;53648.46351536435;54408;54691.72654136783;54729.726351367986;54745.72627136839;57290.713546432;57358.7132064337;57380.71309643425;57442;57573.13640295399;14427.422903083969;14562.85437145615;14578.198199099152;14598.124112553069;14723.852761472248;12188.878111218952;12205.694857628452;12243.142979991493;12243.326617035971;12278.079144064232;14844.480443184437;15559.377624895104;15610.531684049496;15778.526644200692;15829.68340633181;5772.624779389326;5878.088896221093;5899.823005309848;5962.761489540457;5973.223480947449;902.8961669408102;983.680303901235;1022.7903279827617;1058.730023843915;1099.5766629847567;30669.69330306713;30739.05883527131;30775.538366924513;30918.845405772827;31563.21091972719;1029.2435060230725;1052.6736711619421;1074.415237524645;1104.5871742389206;1110.9277896936674;15602.609934751723;16391;16632.25154868034;16650.417235396704;16696.37256171037;447359;447462;449269;454139;454163;52452.73773631107;52699.568069109526;53001.2049819253;53025;53384.73307633437;1176.405915012913;1206.1255589697398;1267.5056727876135;1282.7819270723812;1305.092960392518;28915.566266505597;31219.531707023958;31750.841245793625;33806.830965845016;34063.65936340704;50505;51103.233451497515;51186.74406627943;51218.48781512286;51235.46293611197;424281;428379;429553;430623;433783;25596.23211303664;26492.205233843015;38100;38298.42552361773;38375.80812095922;44095.55904440914;44522.3321650169;45732;45922.77038614786;46071.539284608065;38189;38825;39304;39400.802995984835;39439.60560394359;37702;38483.80758096192;38564;38843.41734874035;39325.60674393219;38753;39305.80347098361;39698.206035879695;40309.39535906905;42381.36427953521;30471.390572188877;35417;35653.82173089118;36261;36300;27563.724362756115;27747.722522775322;27757;27795.58306625443;27843.87580214443 06:55:59 INFO - PROCESS | 12978 | |2;jquery.html;366.81659170414775;369.090192675056;370.5701386391786;383.78508035500107;384.47711112886486;17854;19522.511937201543;19817.40547783567;20021.899890500565;20259.59480810383;18644.254229830825;18712.438626841184;18948.905255473703;19202.327918522853;19253.229870805186;4714.717116972993;5575;5837.854053648651;5844.941550584504;5853.560982926277;6287.717052732638;6514.446272066856;6541.116949211867;6558.344165583451;6564.573302735331;6185.103160041791;6356.841078973016;6392.968035159818;6411.294757576663;6439.8068057958335;6256.468200202989;6328.303886572473;6382.4255816976465;6451.612903225798;6457.806265812057;5470.316210473691;5515.179990603131;5542.196381524656;5543.833684989457;5557.805476808292;22159.778402215932;22718.318450446513;22808.429789255235;22864.54270914589;22934.77065229343;2403.098837935774;2440.377703685549;2853.529167687329;3070.8464576771294;3108.984455077733;13903.4438622456;14305.213213273266;14513;14551;15119;1902.6289873474677;1939.8836069835854;1946.3456062347034;1970.1429878003114;2005.1878989009474;76521.40335938951;77105.61447192784;77452;78115.6094219531;78473;10106.242031847642;10357.119644830123;10359.533820978075;11112.999660061267;11160.330380177214;14353;14455.204963726886;14466.349014294383;14469.421223151166;14481.565553033426;7291.125064992235;7299.963500182571;7540.849183016309;7603.9619801900635;7605.543667379975;6927.792166235021;6989.37095661393;7031.8242043948285;7170.282971702893;7219.133703955559;6406.4554512866;6426.678666066771;6432.260290066609;6481.157449531625;6564.245111812107;1816.5013863562613;1878.2674756844842;1879.1355976250804;1886.8396186324317;1890.3194849854042;889.9466032037969;965.358036905464;1006.8942761009988;1043.0351924469835;1050.9579616815395;19411.805881941284;19454.124564394635;19564.413067607995;19619.117139728747;19774.60450790976;979.3291595257272;982.7199248214224;1004.9598016079422;1007.6221416968637;1020.9642662506776;10414.304056113078;11246.156538259664;11280.887191127984;11328.886711132947;11359.829602555968;428034;454034;457954;461274;469613;75310.62344688241;75537.62231188809;75901;76469.61765191138;79517;949.1789601994363;970.6069042037844;992.1021475564626;998.7752755630071;1001.7595777013464;16611.335546578484;16782.748258776373;17384.304627814745;17396.130193490528;17698.203580838635;36103.27793444169;37044.6295537052;37346.626533735405;37362.8131859339;38139.80930095332;51734.22398664098;52235.47764522306;52476;54519;54619.45380546144;7981.241782030698;8222.83554328922;8224.424290299621;8297.543635100128;8322.08457069734;10972.341659500455;12483.438245278803;12656.303903285409;12826.61520154397;12913.741725165257;11140.888591113986;11190.272632278877;11266.549338026387;11404.714882128013;11981.700457488632;10969.286996345212;11128.554857805597;11239.719007024889;11322.716932076435;11638.418079095842;6303.936960630335;11526;11645.475953582278;11675.548134891767;11686.24039437434;8066.919330806852;8138.959305203436;8381.245687888118;8452.239298463168;8550.78623034429;11139.94430027877;11148.665540033811;11459;11678.766424671288;12003.63989080294 06:55:59 INFO - PROCESS | 12978 | |3;mootools.html;1427.536050783495;1430.6494908747356;1567.4670611991921;1655.892366996146;1711.4865540337903;8374.371922105844;8754.86867696985;9096.0449152839;9118.08819118088;9153.908460915389;8866.955665221682;9011.459312441259;9022.278217742582;9026.368154229207;9030.864537031934;2256.8533045352;2289.988550057256;2292.7019487466605;2293.174457195417;2300.482391461916;2224.343818573525;2265.8300627452923;2303.216906251874;2306.3657494189065;2307.14635584833;2276.4536511237347;2293.495431005176;2296.1619009061737;2296.9655455168186;2304.7119110111234;2175.945601359963;2187.84685072045;2192.177933275022;2195.5169862630196;2219;2200.702905107806;2203.9889800551055;2222.9663206608843;2230.2863083813186;2230.9665355019524;8994.370394072417;9154;9162.86255706165;9209.769755756093;9231.44611323316;5019.799208031674;5173.430922598511;5181.481851814826;5183.688978661255;5184.196449550326;3176.4123637126972;3282.0810173151553;3387.983060084684;3405.3359594879007;3419.4357930941364;1112.8831472695413;1145.1697519298525;1175.1538891997748;1176.682295780143;1215.8540975082958;12492.625221243286;12496.500139994389;12504.687382815411;12508.687282818002;12521.686957826036;4238.173556156582;4391.297392417198;4506.752128632957;4536.387587675687;4591.655625828076;9849.753756156153;9903.653372131941;9914.40513569188;9945.751356216153;9977.301588888708;5100.974495127575;5121.385433747974;5144.61415393847;5144.768485418165;5150.587952963754;4143.08852052548;4207.810648520824;4618.214903466419;4788.569028787426;4803.495632958559;3740.4576336431064;3788.412796016622;3863.4011728182177;3872.5740168581433;3920.8235629396745;1158.2876530933584;1173.7593793272358;1186.768580126867;1187.6080893305189;1194.3192380343294;931.2503434734967;938.7653086728318;944.6032666280179;963.3064193780467;964.7636329099415;5837.482254613831;5857.7949771757785;6143.201383820164;6234.688265586793;6435.131257280301;873.4890089297832;880.9647614095364;899.6941040046415;995.8456439251928;1000.0299709281985;4045.2718510667773;4080.4287399764057;4150.335946248586;4174.666026717855;4176.373543968429;10754.408507532004;11025.779484410266;11030.393328367018;11050.613228536962;11135.051366010915;10773.299735517166;10842.837357439645;10973.83539246912;11034.227604067799;11052.060574851228;7912.802179945433;8002.119766825645;8019.719309824245;8035.316998055114;8058.476199047043;5969.910451343147;6007.8197654070445;6080.331163572092;6091.604045737013;6201.658908760061;9300.674476393564;9715.9028409715;9777.560009799434;9838.75403114928;9980.451075190935;9872.506374681094;10079.193664506969;10093.899061009295;10098.192144628265;10107.39355638664;6795.184577850492;6903.89644155328;7583.544987300779;7585.848283034198;7710.190430004993;8148.062972758209;8215.424920255524;8227.42408031456;8237.835243294981;8265.132161122996;7435.293647103516;7482;7489.850202996018;7787.532748035136;7844.607769611611;7324.853502929805;7488.251174882468;7528.096628404626;7707.152213256425;7778.727744528915;6950.3049695030095;7063.82340441493;7077.292270772881;7092.9645351772915;7102.289771022856;4769.952300476951;4895.33912921751;4913.213885778258;4926;4946.851594452172;5001.42483614389;5104.591632669303;5186.922196167136;5188.688678679291;5201.349831271091 06:55:59 INFO - PROCESS | 12978 | |4;prototype.html;315.75844478973585;319.5953783123174;327.7738360531233;329.2131804986084;330.98345082745857;5444.3194600674915;5562.833115006551;5575.163725441181;5590.413006634306;5597.468240517154;5420.864478388043;5443.101888188444;5469.507744303012;5476.7535460904255;5541.224228607998;4072.226277007359;4117.629413352797;4192.182524407742;4261.957380426187;4288.228118938589;4248.893777655552;4258.87223383299;4268.701190916637;4285.635720963722;4301.268784306675;4232.132412855372;4256.638185754215;4270.487541495025;4270.551592082833;4283.67872409569;4002.619751123624;4244.490661120654;4255.3616957456625;4257.595528424826;4312.935305970397;3717.2565486902727;3719.6237392164803;3722.5346831646043;3725.1990821973136;3730;5318.9202161967605;5415.972920135414;5419.566434685215;5420.728963551806;5433.320834895638;4626.884327891796;4883.438404583483;4889.706617602919;4902.877428064291;4913.803447862081;5777.277840269966;5814.941850581525;5820.447057529528;5860.7948721794955;5896.410358964112;4065.5324637666454;4097.405876147972;4113.8971525711795;4123.484564429446;4129.318662420697;5876.735546900357;6008.75964961401;6031.728572214217;6049;6089.208402907594;4105.67154627635;4112.835486580563;4139.834406623701;4145.502539695196;4188.267053265667;4166.895827604334;4186.958130418718;4189.622933935961;4215.725977811432;4220.915581688349;4737.194676904865;4829.710217386898;4851.126797176542;4858.372445230817;4910.821402863287;5748.885022299531;5758.136279558016;5778.913316300259;5783.277090363705;5819.73811178498;1436.4685066525453;1448.5943935698022;1460.2844606143126;1469.2433396800657;1475.7491226491522;878.9471236571688;932.5710173320213;950.1733491862125;969.4619486185094;991.6529214774915;5531;5540.556755459635;5608.681959739458;5622.409646987089;5640.294963129609;5903.852403689943;5957.165996760457;5963.761449541969;5992.400759923973;5999.370066142992;5435.701036443033;5531.806386776443;5558.6942718150085;5570.693611851306;5632.774689012475;3139.434901717713;3160.8893688720786;3173.873045078171;3190.5852239208753;3216.7426605871474;5984.970075149597;6041.184440100618;6066;6141.140240366352;6181.196444462281;5936.198613187251;5983.19226904371;6015.1428071665605;6027.306859711101;6082.391760823883;6047.12316714074;6060.8181404625675;6068.33248342682;6127.693615319216;6160.457736801268;5735.942640573541;5845.473907348189;5867.589268751317;5875.882482350415;5886.58793884424;5762.423757624204;5831.591788574759;5840.328362238397;5875.059990401515;5884.264466941632;5992.490638295793;6118.235220597426;6123.357047509948;6170.5372097092;6190.473809726043;4099.877003689894;4144.756573028139;4156;4158.771267580312;4188.6649068073875;5827.79602713903;5871.324797648154;5890.852728681646;5912.320083190316;5921.526277897672;5508.338999320107;5735.419061422293;5757.366689664217;5767.365589785204;5849.736761845642;5716.742316690322;5729.71351432435;5741.598088133791;5752;5761.913571296518;5504.889902202013;5638.633488823378;5644.3508996465935;5723.170140329712;5736.512396446182;5872.119182122716;5882;5910.852228694317;5956.731947062479;5961.4038596140035;5668.829935101953;5733.226014487991;5812.331581868139;5816;5823.94176058234 06:55:59 INFO - PROCESS | 12978 | |5;yui.html;711.8754218011849;723.486324709456;733.6845156582671;778.8792737125746;781.0978320040356;14605.050671706345;15463.381464741411;15483.69032619347;15505.14721690308;15528.767068493953;14912.105273683586;14972.401103955828;15018.399264029453;15020.098794072363;15046.699066018673;641.1312671330327;658.6048370977423;751.6955632968657;752.9397648188145;777.3392616276149;767.2634271099723;775.4378075894988;775.5153029356652;775.9961200193991;776.5690042026673;822.284612387224;822.761399194236;824.4558591329724;825.5830805443243;825.7151282807422;819.3813670678629;820.8235229425702;821.9876701849477;822.7408366364576;822.8272062866805;600.7356763024299;603.3664652115261;603.5171862509975;605.4520658803746;606.7724603273772;13424.731505369935;13464.326783660777;13484.662883427894;13501.662458438519;13502.122362046435;14945.459271923799;15202;15217.847821521755;15347.769783453257;15413.152276624782;11652.592159274469;11704.941475292655;11728;11784.587539436165;12441.626751197478;3750.249950010009;3780.130569968895;3863.130795571002;3953.367461206222;3954.2486927483687;72562.27437725608;72744.27255727428;74145;74498.62750686212;75554.24445755527;10647;10735.677929662123;10739.516721747385;10754.408507532004;10878.347299162075;21707.13171473155;21715.34853954384;21788.782112178993;21947.231846885603;21971.121155153935;7968.681252749825;8096.878546821802;8471;8537.890074290426;8575.914240857512;4437.400950871655;4632.25883858581;4656.185167595657;4669.789859456333;4737.644676649265;3407.6421975692197;3480.965190348115;3486;3495.94756078659;3508.2281897982402;561.6012631031931;564.3369041376367;568.1449418624943;575.4878158438993;576.127167341478;691.512483698991;701.051078003152;740.9962950185214;757.6552668535803;759.8442319324525;8799.604017819214;9156.450612963243;9212.309076819265;9231.215346695606;9354.71935841926;601.4977493792732;660.207750699163;683.4122654517112;702.7610612391811;709.7161135545823;4214.325707886724;4432.401625780479;4527.7736113194205;4569.223232050559;4636.397268355092;67295.66352168207;117452;118024;119165;122515.38742306232;76916.2308376909;80928.59535702284;81072.18927810765;106594;107787;71566;75269;76972.23027769763;77124.61437692776;77882.6105869467;8846.646134154562;9697.272704547046;9825.312228143961;9830.115289623967;9998.400095994264;46773.766131169126;47525.28712069253;49366.50633493619;49427.258591121885;49956.500434995185;64668.676656616415;67282;70968.64515677388;71366.28633713597;71540.64229678818;12632.936835316132;12788.680282992627;12976.091673582758;13092.739408528776;13262.668433289246;13418.261995590336;13799.379027943565;13908.026438149232;13939.16365018102;14576.635584110481;13333.466661333827;13569.118007329493;13700.65748356299;13817.765271310269;13916.234607096707;12917.935410322889;13536.661583460098;13705.862941370458;13710.17738935667;14174.716505670036;12023.819642705192;12692.111552191627;12782.48870045225;12999.805002925154;13043.844982163264;10554.2084343673;10619.522121504397;10972.598494466742;11057.778844422906;11423.543058277575;10508.367039416278;11376.260543064674;11602.825957610474;11681.123915706186;11690.590829320932 06:55:59 INFO - PROCESS | 12978 | __end_tp_report 06:55:59 INFO - PROCESS | 12978 | __start_cc_report 06:55:59 INFO - PROCESS | 12978 | _x_x_mozilla_cycle_collect,312 06:55:59 INFO - PROCESS | 12978 | __end_cc_report 06:55:59 INFO - PROCESS | 12978 | __startTimestamp1476798959144__endTimestamp 06:55:59 INFO - PROCESS | 12978 | 06:55:59 INFO - PROCESS | 12978 | ------- Summary: start ------- 06:55:59 INFO - PROCESS | 12978 | Number of tests: 6 06:55:59 INFO - PROCESS | 12978 | 06:55:59 INFO - PROCESS | 12978 | [#0] dojo.html Cycles:165 Average:5412.17 Median:5637.83 stddev:618.42 (11.0%) stddev-sans-first:592.70 06:55:59 INFO - PROCESS | 12978 | Values: 3082.4 3097.4 3112.0 3134.0 3137.5 5288.2 5299.3 5411.4 5460.3 5564.3 5292.2 5344.2 5410.1 5470.8 5485.2 4879.5 4891.7 4921.9 4924.7 4947.3 4918.9 5000.3 5084.6 5085.2 5123.4 4841.8 4853.6 5015.4 5049.4 5084.0 4902.7 4931.7 4952.1 4976.0 5028.1 4924.2 4926.3 4927.2 4935.9 5022.4 5264.3 5424.2 5451.2 5478.8 5491.6 5655.2 5762.7 5802.8 5828.4 5914.9 5902.3 5909.9 5911.6 5923.5 5935.9 5460.1 5485.6 5487.7 5493.1 5499.3 5781.7 5881.8 5898.1 5971.6 5973.6 5736.8 5752.8 5761.1 5766.9 5815.1 5811.2 5836.2 5864.9 5871.6 5891.7 5587.5 5612.7 5688.9 5788.6 5790.2 5814.0 5824.6 5825.1 5825.7 5881.6 4490.1 4504.8 4510.3 4511.4 4578.2 3866.1 3883.6 3949.6 3987.4 3994.4 5499.6 5544.7 5569.7 5587.7 5602.1 5800.2 5828.9 5831.5 5857.2 5867.6 5223.8 5315.2 5547.3 5547.5 5555.1 5019.7 5065.1 5070.2 5070.4 5129.1 5991.7 6015.7 6034.3 6034.3 6056.0 5661.6 5838.9 5853.8 5855.2 5856.9 5881.9 5937.6 6043.6 6077.6 6090.8 5723.8 5767.3 5792.3 5793.7 5847.7 5850.8 5854.0 5873.2 5885.4 5891.3 5450.6 5471.2 5676.8 5697.4 5719.8 5684.3 5698.3 5703.7 5711.0 5730.5 5352.7 5452.6 5628.0 5645.5 5649.0 5706.7 5783.6 5787.8 5809.7 5862.2 5637.8 5677.5 5688.5 5694.5 5695.9 06:55:59 INFO - PROCESS | 12978 | 06:55:59 INFO - PROCESS | 12978 | [#1] ext.html Cycles:180 Average:53183.19 Median:40777.09 stddev:100879.06 (247.4%) stddev-sans-first:101084.66 06:55:59 INFO - PROCESS | 12978 | Values: 552.8 561.3 582.2 593.5 602.0 40540.6 41863.7 42162.4 44887.1 45277.0 42349.2 43054.1 43101.4 43166.1 43237.0 8758.7 8933.5 8951.3 8962.4 8964.6 8801.4 8880.4 8883.0 8887.2 8901.5 8939.2 8977.6 8979.0 8981.1 8984.9 8870.9 8940.9 8941.2 8946.6 8961.6 8787.5 8833.3 8841.0 8853.2 8859.1 40515.8 40580.6 40735.8 40818.4 40950.4 3311.4 3332.3 3432.4 3490.5 3494.4 30505.0 30562.2 30580.4 31565.4 32496.7 4223.2 4326.5 4423.4 4440.3 4480.6 217567.0 217730.0 218960.0 219045.8 219388.0 53648.5 54408.0 54691.7 54729.7 54745.7 57290.7 57358.7 57380.7 57442.0 57573.1 14427.4 14562.9 14578.2 14598.1 14723.9 12188.9 12205.7 12243.1 12243.3 12278.1 14844.5 15559.4 15610.5 15778.5 15829.7 5772.6 5878.1 5899.8 5962.8 5973.2 902.9 983.7 1022.8 1058.7 1099.6 30669.7 30739.1 30775.5 30918.8 31563.2 1029.2 1052.7 1074.4 1104.6 1110.9 15602.6 16391.0 16632.3 16650.4 16696.4 447359.0 447462.0 449269.0 454139.0 454163.0 52452.7 52699.6 53001.2 53025.0 53384.7 1176.4 1206.1 1267.5 1282.8 1305.1 28915.6 31219.5 31750.8 33806.8 34063.7 50505.0 51103.2 51186.7 51218.5 51235.5 424281.0 428379.0 429553.0 430623.0 433783.0 25596.2 26492.2 38100.0 38298.4 38375.8 44095.6 44522.3 45732.0 45922.8 46071.5 38189.0 38825.0 39304.0 39400.8 39439.6 37702.0 38483.8 38564.0 38843.4 39325.6 38753.0 39305.8 39698.2 40309.4 42381.4 30471.4 35417.0 35653.8 36261.0 36300.0 27563.7 27747.7 27757.0 27795.6 27843.9 06:55:59 INFO - PROCESS | 12978 | 06:55:59 INFO - PROCESS | 12978 | [#2] jquery.html Cycles:180 Average:27277.80 Median:19606.13 stddev:74651.30 (380.8%) stddev-sans-first:74833.37 06:55:59 INFO - PROCESS | 12978 | Values: 366.8 369.1 370.6 383.8 384.5 17854.0 19522.5 19817.4 20021.9 20259.6 18644.3 18712.4 18948.9 19202.3 19253.2 4714.7 5575.0 5837.9 5844.9 5853.6 6287.7 6514.4 6541.1 6558.3 6564.6 6185.1 6356.8 6393.0 6411.3 6439.8 6256.5 6328.3 6382.4 6451.6 6457.8 5470.3 5515.2 5542.2 5543.8 5557.8 22159.8 22718.3 22808.4 22864.5 22934.8 2403.1 2440.4 2853.5 3070.8 3109.0 13903.4 14305.2 14513.0 14551.0 15119.0 1902.6 1939.9 1946.3 1970.1 2005.2 76521.4 77105.6 77452.0 78115.6 78473.0 10106.2 10357.1 10359.5 11113.0 11160.3 14353.0 14455.2 14466.3 14469.4 14481.6 7291.1 7300.0 7540.8 7604.0 7605.5 6927.8 6989.4 7031.8 7170.3 7219.1 6406.5 6426.7 6432.3 6481.2 6564.2 1816.5 1878.3 1879.1 1886.8 1890.3 889.9 965.4 1006.9 1043.0 1051.0 19411.8 19454.1 19564.4 19619.1 19774.6 979.3 982.7 1005.0 1007.6 1021.0 10414.3 11246.2 11280.9 11328.9 11359.8 428034.0 454034.0 457954.0 461274.0 469613.0 75310.6 75537.6 75901.0 76469.6 79517.0 949.2 970.6 992.1 998.8 1001.8 16611.3 16782.7 17384.3 17396.1 17698.2 36103.3 37044.6 37346.6 37362.8 38139.8 51734.2 52235.5 52476.0 54519.0 54619.5 7981.2 8222.8 8224.4 8297.5 8322.1 10972.3 12483.4 12656.3 12826.6 12913.7 11140.9 11190.3 11266.5 11404.7 11981.7 10969.3 11128.6 11239.7 11322.7 11638.4 6303.9 11526.0 11645.5 11675.5 11686.2 8066.9 8139.0 8381.2 8452.2 8550.8 11139.9 11148.7 11459.0 11678.8 12003.6 06:55:59 INFO - PROCESS | 12978 | 06:55:59 INFO - PROCESS | 12978 | [#3] mootools.html Cycles:180 Average:5742.79 Median:5010.61 stddev:3303.50 (65.9%) stddev-sans-first:3296.85 06:55:59 INFO - PROCESS | 12978 | Values: 1427.5 1430.6 1567.5 1655.9 1711.5 8374.4 8754.9 9096.0 9118.1 9153.9 8867.0 9011.5 9022.3 9026.4 9030.9 2256.9 2290.0 2292.7 2293.2 2300.5 2224.3 2265.8 2303.2 2306.4 2307.1 2276.5 2293.5 2296.2 2297.0 2304.7 2175.9 2187.8 2192.2 2195.5 2219.0 2200.7 2204.0 2223.0 2230.3 2231.0 8994.4 9154.0 9162.9 9209.8 9231.4 5019.8 5173.4 5181.5 5183.7 5184.2 3176.4 3282.1 3388.0 3405.3 3419.4 1112.9 1145.2 1175.2 1176.7 1215.9 12492.6 12496.5 12504.7 12508.7 12521.7 4238.2 4391.3 4506.8 4536.4 4591.7 9849.8 9903.7 9914.4 9945.8 9977.3 5101.0 5121.4 5144.6 5144.8 5150.6 4143.1 4207.8 4618.2 4788.6 4803.5 3740.5 3788.4 3863.4 3872.6 3920.8 1158.3 1173.8 1186.8 1187.6 1194.3 931.3 938.8 944.6 963.3 964.8 5837.5 5857.8 6143.2 6234.7 6435.1 873.5 881.0 899.7 995.8 1000.0 4045.3 4080.4 4150.3 4174.7 4176.4 10754.4 11025.8 11030.4 11050.6 11135.1 10773.3 10842.8 10973.8 11034.2 11052.1 7912.8 8002.1 8019.7 8035.3 8058.5 5969.9 6007.8 6080.3 6091.6 6201.7 9300.7 9715.9 9777.6 9838.8 9980.5 9872.5 10079.2 10093.9 10098.2 10107.4 6795.2 6903.9 7583.5 7585.8 7710.2 8148.1 8215.4 8227.4 8237.8 8265.1 7435.3 7482.0 7489.9 7787.5 7844.6 7324.9 7488.3 7528.1 7707.2 7778.7 6950.3 7063.8 7077.3 7093.0 7102.3 4770.0 4895.3 4913.2 4926.0 4946.9 5001.4 5104.6 5186.9 5188.7 5201.3 06:55:59 INFO - PROCESS | 12978 | 06:55:59 INFO - PROCESS | 12978 | [#4] prototype.html Cycles:180 Average:4851.41 Median:5582.79 stddev:1445.25 (25.9%) stddev-sans-first:1408.64 06:55:59 INFO - PROCESS | 12978 | Values: 315.8 319.6 327.8 329.2 331.0 5444.3 5562.8 5575.2 5590.4 5597.5 5420.9 5443.1 5469.5 5476.8 5541.2 4072.2 4117.6 4192.2 4262.0 4288.2 4248.9 4258.9 4268.7 4285.6 4301.3 4232.1 4256.6 4270.5 4270.6 4283.7 4002.6 4244.5 4255.4 4257.6 4312.9 3717.3 3719.6 3722.5 3725.2 3730.0 5318.9 5416.0 5419.6 5420.7 5433.3 4626.9 4883.4 4889.7 4902.9 4913.8 5777.3 5814.9 5820.4 5860.8 5896.4 4065.5 4097.4 4113.9 4123.5 4129.3 5876.7 6008.8 6031.7 6049.0 6089.2 4105.7 4112.8 4139.8 4145.5 4188.3 4166.9 4187.0 4189.6 4215.7 4220.9 4737.2 4829.7 4851.1 4858.4 4910.8 5748.9 5758.1 5778.9 5783.3 5819.7 1436.5 1448.6 1460.3 1469.2 1475.7 878.9 932.6 950.2 969.5 991.7 5531.0 5540.6 5608.7 5622.4 5640.3 5903.9 5957.2 5963.8 5992.4 5999.4 5435.7 5531.8 5558.7 5570.7 5632.8 3139.4 3160.9 3173.9 3190.6 3216.7 5985.0 6041.2 6066.0 6141.1 6181.2 5936.2 5983.2 6015.1 6027.3 6082.4 6047.1 6060.8 6068.3 6127.7 6160.5 5735.9 5845.5 5867.6 5875.9 5886.6 5762.4 5831.6 5840.3 5875.1 5884.3 5992.5 6118.2 6123.4 6170.5 6190.5 4099.9 4144.8 4156.0 4158.8 4188.7 5827.8 5871.3 5890.9 5912.3 5921.5 5508.3 5735.4 5757.4 5767.4 5849.7 5716.7 5729.7 5741.6 5752.0 5761.9 5504.9 5638.6 5644.4 5723.2 5736.5 5872.1 5882.0 5910.9 5956.7 5961.4 5668.8 5733.2 5812.3 5816.0 5823.9 06:55:59 INFO - PROCESS | 12978 | 06:55:59 INFO - PROCESS | 12978 | [#5] yui.html Cycles:180 Average:19711.59 Median:4600.74 stddev:28037.41 (609.4%) stddev-sans-first:28079.77 06:55:59 INFO - PROCESS | 12978 | Values: 711.9 723.5 733.7 778.9 781.1 14605.1 15463.4 15483.7 15505.1 15528.8 14912.1 14972.4 15018.4 15020.1 15046.7 641.1 658.6 751.7 752.9 777.3 767.3 775.4 775.5 776.0 776.6 822.3 822.8 824.5 825.6 825.7 819.4 820.8 822.0 822.7 822.8 600.7 603.4 603.5 605.5 606.8 13424.7 13464.3 13484.7 13501.7 13502.1 14945.5 15202.0 15217.8 15347.8 15413.2 11652.6 11704.9 11728.0 11784.6 12441.6 3750.2 3780.1 3863.1 3953.4 3954.2 72562.3 72744.3 74145.0 74498.6 75554.2 10647.0 10735.7 10739.5 10754.4 10878.3 21707.1 21715.3 21788.8 21947.2 21971.1 7968.7 8096.9 8471.0 8537.9 8575.9 4437.4 4632.3 4656.2 4669.8 4737.6 3407.6 3481.0 3486.0 3495.9 3508.2 561.6 564.3 568.1 575.5 576.1 691.5 701.1 741.0 757.7 759.8 8799.6 9156.5 9212.3 9231.2 9354.7 601.5 660.2 683.4 702.8 709.7 4214.3 4432.4 4527.8 4569.2 4636.4 67295.7 117452.0 118024.0 119165.0 122515.4 76916.2 80928.6 81072.2 106594.0 107787.0 71566.0 75269.0 76972.2 77124.6 77882.6 8846.6 9697.3 9825.3 9830.1 9998.4 46773.8 47525.3 49366.5 49427.3 49956.5 64668.7 67282.0 70968.6 71366.3 71540.6 12632.9 12788.7 12976.1 13092.7 13262.7 13418.3 13799.4 13908.0 13939.2 14576.6 13333.5 13569.1 13700.7 13817.8 13916.2 12917.9 13536.7 13705.9 13710.2 14174.7 12023.8 12692.1 12782.5 12999.8 13043.8 10554.2 10619.5 10972.6 11057.8 11423.5 10508.4 11376.3 11602.8 11681.1 11690.6 06:55:59 INFO - PROCESS | 12978 | -------- Summary: end -------- 06:55:59 INFO - PROCESS | 12978 | 06:56:00 INFO - TEST-INFO | 12978: exit 0 06:56:00 INFO - TEST-OK | dromaeo_css | took 1116125ms 06:56:00 INFO - TEST-START | kraken 06:56:00 INFO - operating with platform_type : linux_ 06:56:00 INFO - Initialising browser for kraken test... 06:56:00 INFO - TEST-INFO | started process 13332 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzFjhSY/profile http://localhost:33850/getInfo.html) 06:56:04 INFO - PROCESS | 13332 | __metrics Screen width/height:1600/1200 06:56:04 INFO - PROCESS | 13332 | colorDepth:24 06:56:04 INFO - PROCESS | 13332 | Browser inner width/height: 1024/697 06:56:04 INFO - PROCESS | 13332 | __metrics 06:56:05 ERROR - PROCESS | 13332 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 06:56:06 INFO - TEST-INFO | 13332: exit 0 06:56:06 INFO - Browser initialized. 06:56:06 INFO - Running cycle 1/1 for kraken test... 06:56:06 INFO - TEST-INFO | started process 13454 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzFjhSY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:56:18 INFO - PROCESS | 13454 | RSS: Main: 182571008 06:56:18 INFO - PROCESS | 13454 | 06:56:21 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33850/tests/kraken/driver.html?testName=audio-beat-detection) 06:56:21 INFO - PROCESS | 13454 | RSS: Main: 196915200 06:56:21 INFO - PROCESS | 13454 | 06:56:24 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33850/tests/kraken/driver.html?testName=audio-dft) 06:56:25 INFO - PROCESS | 13454 | RSS: Main: 194764800 06:56:25 INFO - PROCESS | 13454 | 06:56:28 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33850/tests/kraken/driver.html?testName=audio-fft) 06:56:28 INFO - PROCESS | 13454 | RSS: Main: 191123456 06:56:28 INFO - PROCESS | 13454 | 06:56:30 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33850/tests/kraken/driver.html?testName=audio-oscillator) 06:56:31 INFO - PROCESS | 13454 | RSS: Main: 191426560 06:56:31 INFO - PROCESS | 13454 | 06:56:33 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33850/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:56:34 INFO - PROCESS | 13454 | RSS: Main: 191873024 06:56:34 INFO - PROCESS | 13454 | 06:56:37 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33850/tests/kraken/driver.html?testName=imaging-darkroom) 06:56:38 INFO - PROCESS | 13454 | RSS: Main: 191799296 06:56:38 INFO - PROCESS | 13454 | 06:56:41 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33850/tests/kraken/driver.html?testName=imaging-desaturate) 06:56:42 INFO - PROCESS | 13454 | RSS: Main: 190447616 06:56:42 INFO - PROCESS | 13454 | 06:56:44 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33850/tests/kraken/driver.html?testName=json-parse-financial) 06:56:45 INFO - PROCESS | 13454 | RSS: Main: 191897600 06:56:45 INFO - PROCESS | 13454 | 06:56:46 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33850/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:56:47 INFO - PROCESS | 13454 | RSS: Main: 192245760 06:56:47 INFO - PROCESS | 13454 | 06:56:49 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33850/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:56:50 INFO - PROCESS | 13454 | RSS: Main: 192008192 06:56:50 INFO - PROCESS | 13454 | 06:56:52 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33850/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:56:52 INFO - PROCESS | 13454 | RSS: Main: 192253952 06:56:52 INFO - PROCESS | 13454 | 06:56:55 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:56:56 INFO - PROCESS | 13454 | RSS: Main: 192405504 06:56:56 INFO - PROCESS | 13454 | 06:56:59 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:56:59 INFO - PROCESS | 13454 | RSS: Main: 192929792 06:56:59 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | Cycle 1(1): loaded http://localhost:33850/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33850/tests/kraken/driver.html?testName=ai-astar) 06:57:01 INFO - PROCESS | 13454 | RSS: Main: 193851392 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | __start_tp_report 06:57:01 INFO - PROCESS | 13454 | _x_x_mozilla_page_load 06:57:01 INFO - PROCESS | 13454 | _x_x_mozilla_page_load_details 06:57:01 INFO - PROCESS | 13454 | |i|pagename|runs| 06:57:01 INFO - PROCESS | 13454 | |0;ai-astar;105;113;113;112;112;115;112;111;113;113 06:57:01 INFO - PROCESS | 13454 | |1;audio-beat-detection;158;126;124;178;136;125;126;126;153;125 06:57:01 INFO - PROCESS | 13454 | |2;audio-dft;163;169;165;169;164;162;162;164;163;163 06:57:01 INFO - PROCESS | 13454 | |3;audio-fft;77;75;76;113;76;76;84;80;109;76 06:57:01 INFO - PROCESS | 13454 | |4;audio-oscillator;83;83;121;83;83;84;107;84;83;112 06:57:01 INFO - PROCESS | 13454 | |5;imaging-gaussian-blur;118;118;117;118;119;118;117;117;117;119 06:57:01 INFO - PROCESS | 13454 | |6;imaging-darkroom;149;148;147;148;147;148;149;147;148;148 06:57:01 INFO - PROCESS | 13454 | |7;imaging-desaturate;86;84;86;85;85;86;86;84;86;85 06:57:01 INFO - PROCESS | 13454 | |8;json-parse-financial;54;55;54;55;54;55;57;57;56;59 06:57:01 INFO - PROCESS | 13454 | |9;json-stringify-tinderbox;59;59;59;59;60;58;60;60;59;60 06:57:01 INFO - PROCESS | 13454 | |10;stanford-crypto-aes;82;81;82;83;88;82;81;82;86;81 06:57:01 INFO - PROCESS | 13454 | |11;stanford-crypto-ccm;138;131;140;133;153;140;133;138;172;137 06:57:01 INFO - PROCESS | 13454 | |12;stanford-crypto-pbkdf2;171;171;164;169;165;166;168;165;167;164 06:57:01 INFO - PROCESS | 13454 | |13;stanford-crypto-sha256-iterative;70;65;69;66;66;66;65;69;66;66 06:57:01 INFO - PROCESS | 13454 | __end_tp_report 06:57:01 INFO - PROCESS | 13454 | __start_cc_report 06:57:01 INFO - PROCESS | 13454 | _x_x_mozilla_cycle_collect,794 06:57:01 INFO - PROCESS | 13454 | __end_cc_report 06:57:01 INFO - PROCESS | 13454 | __startTimestamp1476799021672__endTimestamp 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | ------- Summary: start ------- 06:57:01 INFO - PROCESS | 13454 | Number of tests: 14 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:2.64 (2.3%) stddev-sans-first:1.12 06:57:01 INFO - PROCESS | 13454 | Values: 105.0 113.0 113.0 112.0 112.0 115.0 112.0 111.0 113.0 113.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:131.00 stddev:18.84 (14.4%) stddev-sans-first:18.49 06:57:01 INFO - PROCESS | 13454 | Values: 158.0 126.0 124.0 178.0 136.0 125.0 126.0 126.0 153.0 125.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.59 (1.6%) stddev-sans-first:2.70 06:57:01 INFO - PROCESS | 13454 | Values: 163.0 169.0 165.0 169.0 164.0 162.0 162.0 164.0 163.0 163.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#3] audio-fft Cycles:10 Average:84.20 Median:76.00 stddev:14.41 (19.0%) stddev-sans-first:15.04 06:57:01 INFO - PROCESS | 13454 | Values: 77.0 75.0 76.0 113.0 76.0 76.0 84.0 80.0 109.0 76.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#4] audio-oscillator Cycles:10 Average:92.30 Median:83.00 stddev:14.90 (18.0%) stddev-sans-first:15.42 06:57:01 INFO - PROCESS | 13454 | Values: 83.0 83.0 121.0 83.0 83.0 84.0 107.0 84.0 83.0 112.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 06:57:01 INFO - PROCESS | 13454 | Values: 118.0 118.0 117.0 118.0 119.0 118.0 117.0 117.0 117.0 119.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 06:57:01 INFO - PROCESS | 13454 | Values: 149.0 148.0 147.0 148.0 147.0 148.0 149.0 147.0 148.0 148.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:86.00 stddev:0.82 (1.0%) stddev-sans-first:0.83 06:57:01 INFO - PROCESS | 13454 | Values: 86.0 84.0 86.0 85.0 85.0 86.0 86.0 84.0 86.0 85.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.50 stddev:1.65 (3.0%) stddev-sans-first:1.64 06:57:01 INFO - PROCESS | 13454 | Values: 54.0 55.0 54.0 55.0 54.0 55.0 57.0 57.0 56.0 59.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#9] json-stringify-tinderbox Cycles:10 Average:59.30 Median:59.50 stddev:0.67 (1.1%) stddev-sans-first:0.71 06:57:01 INFO - PROCESS | 13454 | Values: 59.0 59.0 59.0 59.0 60.0 58.0 60.0 60.0 59.0 60.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:82.00 stddev:2.35 (2.9%) stddev-sans-first:2.47 06:57:01 INFO - PROCESS | 13454 | Values: 82.0 81.0 82.0 83.0 88.0 82.0 81.0 82.0 86.0 81.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#11] stanford-crypto-ccm Cycles:10 Average:141.50 Median:139.00 stddev:12.32 (8.9%) stddev-sans-first:13.00 06:57:01 INFO - PROCESS | 13454 | Values: 138.0 131.0 140.0 133.0 153.0 140.0 133.0 138.0 172.0 137.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.50 stddev:2.67 (1.6%) stddev-sans-first:2.40 06:57:01 INFO - PROCESS | 13454 | Values: 171.0 171.0 164.0 169.0 165.0 166.0 168.0 165.0 167.0 164.0 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.00 stddev:1.81 (2.7%) stddev-sans-first:1.51 06:57:01 INFO - PROCESS | 13454 | Values: 70.0 65.0 69.0 66.0 66.0 66.0 65.0 69.0 66.0 66.0 06:57:01 INFO - PROCESS | 13454 | -------- Summary: end -------- 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | 06:57:01 INFO - PROCESS | 13454 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:57:01 INFO - PROCESS | 13454 | 06:57:02 INFO - TEST-INFO | 13454: exit 0 06:57:02 INFO - TEST-OK | kraken | took 62782ms 06:57:02 INFO - SUITE-END | took 1178s 06:57:03 INFO - Completed test suite (00:19:39) 06:57:03 INFO - javascript benchmark 06:57:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7191.067243898869, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3082.383523295341, 3097.4424603571347, 3111.9844400777993, 3134.0441165444536, 3137.513685378767, 5288.233206185101, 5299.258103865457, 5411.404745477999, 5460.262864513289, 5564.304461942257, 5292.153255479124, 5344.22508736233, 5410.08028635132, 5470.753816078276, 5485.232067510552, 4879.463259041502, 4891.706497610146, 4921.941782516758, 4924.650161463941, 4947.307376967227, 4918.877028074291, 5000.349954505909, 5084.644074914758, 5085.211792172201, 5123.436421993596, 4841.7579121044155, 4853.563179313844, 5015.3730783652045, 5049.394072711261, 5084.0, 4902.681325713817, 4931.65478416511, 4952.108620448318, 4976.004799040206, 5028.145215313405, 4924.187509061001, 4926.33494478248, 4927.211646136601, 4935.876603084916, 5022.397312322545, 5264.341957255343, 5424.186372044185, 5451.209574611698, 5478.808241711561, 5491.560675145979, 5655.1517272409465, 5762.711864406763, 5802.82591522255, 5828.358880523139, 5914.8817023659285, 5902.2622172228475, 5909.940900590982, 5911.615744976606, 5923.526117910556, 5935.9406405935815, 5460.099083651193, 5485.561155107622, 5487.6981766002855, 5493.093639549509, 5499.257600223998, 5781.653100813965, 5881.794137205177, 5898.14476900847, 5971.58198926071, 5973.611715238582, 5736.827895163152, 5752.827415177551, 5761.135829625589, 5766.88466230673, 5815.069588865761, 5811.15738217956, 5836.241288632451, 5864.941350586525, 5871.6183448075735, 5891.705414729332, 5587.469190426903, 5612.747426365823, 5688.943110568925, 5788.594798364074, 5790.160426738099, 5814.0, 5824.563157763185, 5825.126231065374, 5825.7378417971295, 5881.617694849821, 4490.12442573695, 4504.752238626841, 4510.255807791743, 4511.390962220124, 4578.175928332932, 3866.149447121629, 3883.5533913599734, 3949.565547789741, 3987.441758153861, 3994.400839873984, 5499.642523235977, 5544.69504177266, 5569.749361278752, 5587.720613969285, 5602.075657516464, 5800.158976948319, 5828.912566311508, 5831.504322132581, 5857.238558987389, 5867.647941123546, 5223.817166399158, 5315.176147697113, 5547.334319881559, 5547.528460080857, 5555.138953462219, 5019.698818070928, 5065.062963351792, 5070.163423035232, 5070.416902056237, 5129.076766182048, 5991.700414979234, 6015.699215039143, 6034.275886893513, 6034.306054803666, 6056.0, 5661.631993920382, 5838.912416313674, 5853.765849365977, 5855.151003104611, 5856.94143058564, 5881.852953676022, 5937.554683398676, 6043.607165534227, 6077.604955677867, 6090.756835501955, 5723.7996670116345, 5767.307923049261, 5792.333881603501, 5793.652380857162, 5847.707614619337, 5850.824475265749, 5854.0, 5873.207117039145, 5885.411458854252, 5891.263592050994, 5450.645708028966, 5471.151971444273, 5676.772929082956, 5697.4302569742695, 5719.828405147852, 5684.317881854204, 5698.31620205578, 5703.7433315500075, 5711.029125048669, 5730.484256416776, 5352.678839269656, 5452.6183167177915, 5627.971860140673, 5645.463680950304, 5648.971755141362, 5706.714664266853, 5783.566232532661, 5787.826365209051, 5809.709514524341, 5862.208601838697, 5637.830865074055, 5677.489025987681, 5688.54491640676, 5694.4590263924865, 5695.914561281667], "value": 5369.9569265721675, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.7880443515988, 561.2619405481792, 582.2256398989344, 593.4895989449074, 602.0126991733556, 40540.59459405405, 41863.673857075046, 42162.36756448656, 44887.10225795482, 45277.0, 42349.15301693964, 43054.13891722164, 43101.353479697755, 43166.13667726643, 43237.0, 8758.693445729401, 8933.46399216046, 8951.328650351217, 8962.37263391563, 8964.641414343418, 8801.427907186044, 8880.378373513857, 8883.0, 8887.20015198632, 8901.465912045298, 8939.195472407482, 8977.551122443885, 8978.955105224464, 8981.14679105484, 8984.910150898473, 8870.86693699595, 8940.910590894138, 8941.150590693906, 8946.55267236642, 8961.641534338618, 8787.516686582236, 8833.33749968755, 8840.955795220983, 8853.203211710912, 8859.069797671216, 40515.797421013, 40580.59419405827, 40735.796321018504, 40818.38772418416, 40950.38574421386, 3311.3708395404797, 3332.266901281714, 3432.433648448003, 3490.494635145354, 3494.4059509883127, 30505.0, 30562.235944101576, 30580.38839223203, 31565.36869262625, 32496.6750332496, 4223.239816832969, 4326.459192600925, 4423.424954755893, 4440.289553671397, 4480.596746292849, 217567.0, 217730.0, 218960.0, 219045.80954190413, 219388.0, 53648.46351536435, 54408.0, 54691.72654136783, 54729.726351367986, 54745.72627136839, 57290.713546432, 57358.7132064337, 57380.71309643425, 57442.0, 57573.13640295399, 14427.422903083969, 14562.85437145615, 14578.198199099152, 14598.124112553069, 14723.852761472248, 12188.878111218952, 12205.694857628452, 12243.142979991493, 12243.326617035971, 12278.079144064232, 14844.480443184437, 15559.377624895104, 15610.531684049496, 15778.526644200692, 15829.68340633181, 5772.624779389326, 5878.088896221093, 5899.823005309848, 5962.761489540457, 5973.223480947449, 902.8961669408102, 983.680303901235, 1022.7903279827617, 1058.730023843915, 1099.5766629847567, 30669.69330306713, 30739.05883527131, 30775.538366924513, 30918.845405772827, 31563.21091972719, 1029.2435060230725, 1052.6736711619421, 1074.415237524645, 1104.5871742389206, 1110.9277896936674, 15602.609934751723, 16391.0, 16632.25154868034, 16650.417235396704, 16696.37256171037, 447359.0, 447462.0, 449269.0, 454139.0, 454163.0, 52452.73773631107, 52699.568069109526, 53001.2049819253, 53025.0, 53384.73307633437, 1176.405915012913, 1206.1255589697398, 1267.5056727876135, 1282.7819270723812, 1305.092960392518, 28915.566266505597, 31219.531707023958, 31750.841245793625, 33806.830965845016, 34063.65936340704, 50505.0, 51103.233451497515, 51186.74406627943, 51218.48781512286, 51235.46293611197, 424281.0, 428379.0, 429553.0, 430623.0, 433783.0, 25596.23211303664, 26492.205233843015, 38100.0, 38298.42552361773, 38375.80812095922, 44095.55904440914, 44522.3321650169, 45732.0, 45922.77038614786, 46071.539284608065, 38189.0, 38825.0, 39304.0, 39400.802995984835, 39439.60560394359, 37702.0, 38483.80758096192, 38564.0, 38843.41734874035, 39325.60674393219, 38753.0, 39305.80347098361, 39698.206035879695, 40309.39535906905, 42381.36427953521, 30471.390572188877, 35417.0, 35653.82173089118, 36261.0, 36300.0, 27563.724362756115, 27747.722522775322, 27757.0, 27795.58306625443, 27843.87580214443], "value": 19090.02759353455, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.81659170414775, 369.090192675056, 370.5701386391786, 383.78508035500107, 384.47711112886486, 17854.0, 19522.511937201543, 19817.40547783567, 20021.899890500565, 20259.59480810383, 18644.254229830825, 18712.438626841184, 18948.905255473703, 19202.327918522853, 19253.229870805186, 4714.717116972993, 5575.0, 5837.854053648651, 5844.941550584504, 5853.560982926277, 6287.717052732638, 6514.446272066856, 6541.116949211867, 6558.344165583451, 6564.573302735331, 6185.103160041791, 6356.841078973016, 6392.968035159818, 6411.294757576663, 6439.8068057958335, 6256.468200202989, 6328.303886572473, 6382.4255816976465, 6451.612903225798, 6457.806265812057, 5470.316210473691, 5515.179990603131, 5542.196381524656, 5543.833684989457, 5557.805476808292, 22159.778402215932, 22718.318450446513, 22808.429789255235, 22864.54270914589, 22934.77065229343, 2403.098837935774, 2440.377703685549, 2853.529167687329, 3070.8464576771294, 3108.984455077733, 13903.4438622456, 14305.213213273266, 14513.0, 14551.0, 15119.0, 1902.6289873474677, 1939.8836069835854, 1946.3456062347034, 1970.1429878003114, 2005.1878989009474, 76521.40335938951, 77105.61447192784, 77452.0, 78115.6094219531, 78473.0, 10106.242031847642, 10357.119644830123, 10359.533820978075, 11112.999660061267, 11160.330380177214, 14353.0, 14455.204963726886, 14466.349014294383, 14469.421223151166, 14481.565553033426, 7291.125064992235, 7299.963500182571, 7540.849183016309, 7603.9619801900635, 7605.543667379975, 6927.792166235021, 6989.37095661393, 7031.8242043948285, 7170.282971702893, 7219.133703955559, 6406.4554512866, 6426.678666066771, 6432.260290066609, 6481.157449531625, 6564.245111812107, 1816.5013863562613, 1878.2674756844842, 1879.1355976250804, 1886.8396186324317, 1890.3194849854042, 889.9466032037969, 965.358036905464, 1006.8942761009988, 1043.0351924469835, 1050.9579616815395, 19411.805881941284, 19454.124564394635, 19564.413067607995, 19619.117139728747, 19774.60450790976, 979.3291595257272, 982.7199248214224, 1004.9598016079422, 1007.6221416968637, 1020.9642662506776, 10414.304056113078, 11246.156538259664, 11280.887191127984, 11328.886711132947, 11359.829602555968, 428034.0, 454034.0, 457954.0, 461274.0, 469613.0, 75310.62344688241, 75537.62231188809, 75901.0, 76469.61765191138, 79517.0, 949.1789601994363, 970.6069042037844, 992.1021475564626, 998.7752755630071, 1001.7595777013464, 16611.335546578484, 16782.748258776373, 17384.304627814745, 17396.130193490528, 17698.203580838635, 36103.27793444169, 37044.6295537052, 37346.626533735405, 37362.8131859339, 38139.80930095332, 51734.22398664098, 52235.47764522306, 52476.0, 54519.0, 54619.45380546144, 7981.241782030698, 8222.83554328922, 8224.424290299621, 8297.543635100128, 8322.08457069734, 10972.341659500455, 12483.438245278803, 12656.303903285409, 12826.61520154397, 12913.741725165257, 11140.888591113986, 11190.272632278877, 11266.549338026387, 11404.714882128013, 11981.700457488632, 10969.286996345212, 11128.554857805597, 11239.719007024889, 11322.716932076435, 11638.418079095842, 6303.936960630335, 11526.0, 11645.475953582278, 11675.548134891767, 11686.24039437434, 8066.919330806852, 8138.959305203436, 8381.245687888118, 8452.239298463168, 8550.78623034429, 11139.94430027877, 11148.665540033811, 11459.0, 11678.766424671288, 12003.63989080294], "value": 9202.05615328051, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.536050783495, 1430.6494908747356, 1567.4670611991921, 1655.892366996146, 1711.4865540337903, 8374.371922105844, 8754.86867696985, 9096.0449152839, 9118.08819118088, 9153.908460915389, 8866.955665221682, 9011.459312441259, 9022.278217742582, 9026.368154229207, 9030.864537031934, 2256.8533045352, 2289.988550057256, 2292.7019487466605, 2293.174457195417, 2300.482391461916, 2224.343818573525, 2265.8300627452923, 2303.216906251874, 2306.3657494189065, 2307.14635584833, 2276.4536511237347, 2293.495431005176, 2296.1619009061737, 2296.9655455168186, 2304.7119110111234, 2175.945601359963, 2187.84685072045, 2192.177933275022, 2195.5169862630196, 2219.0, 2200.702905107806, 2203.9889800551055, 2222.9663206608843, 2230.2863083813186, 2230.9665355019524, 8994.370394072417, 9154.0, 9162.86255706165, 9209.769755756093, 9231.44611323316, 5019.799208031674, 5173.430922598511, 5181.481851814826, 5183.688978661255, 5184.196449550326, 3176.4123637126972, 3282.0810173151553, 3387.983060084684, 3405.3359594879007, 3419.4357930941364, 1112.8831472695413, 1145.1697519298525, 1175.1538891997748, 1176.682295780143, 1215.8540975082958, 12492.625221243286, 12496.500139994389, 12504.687382815411, 12508.687282818002, 12521.686957826036, 4238.173556156582, 4391.297392417198, 4506.752128632957, 4536.387587675687, 4591.655625828076, 9849.753756156153, 9903.653372131941, 9914.40513569188, 9945.751356216153, 9977.301588888708, 5100.974495127575, 5121.385433747974, 5144.61415393847, 5144.768485418165, 5150.587952963754, 4143.08852052548, 4207.810648520824, 4618.214903466419, 4788.569028787426, 4803.495632958559, 3740.4576336431064, 3788.412796016622, 3863.4011728182177, 3872.5740168581433, 3920.8235629396745, 1158.2876530933584, 1173.7593793272358, 1186.768580126867, 1187.6080893305189, 1194.3192380343294, 931.2503434734967, 938.7653086728318, 944.6032666280179, 963.3064193780467, 964.7636329099415, 5837.482254613831, 5857.7949771757785, 6143.201383820164, 6234.688265586793, 6435.131257280301, 873.4890089297832, 880.9647614095364, 899.6941040046415, 995.8456439251928, 1000.0299709281985, 4045.2718510667773, 4080.4287399764057, 4150.335946248586, 4174.666026717855, 4176.373543968429, 10754.408507532004, 11025.779484410266, 11030.393328367018, 11050.613228536962, 11135.051366010915, 10773.299735517166, 10842.837357439645, 10973.83539246912, 11034.227604067799, 11052.060574851228, 7912.802179945433, 8002.119766825645, 8019.719309824245, 8035.316998055114, 8058.476199047043, 5969.910451343147, 6007.8197654070445, 6080.331163572092, 6091.604045737013, 6201.658908760061, 9300.674476393564, 9715.9028409715, 9777.560009799434, 9838.75403114928, 9980.451075190935, 9872.506374681094, 10079.193664506969, 10093.899061009295, 10098.192144628265, 10107.39355638664, 6795.184577850492, 6903.89644155328, 7583.544987300779, 7585.848283034198, 7710.190430004993, 8148.062972758209, 8215.424920255524, 8227.42408031456, 8237.835243294981, 8265.132161122996, 7435.293647103516, 7482.0, 7489.850202996018, 7787.532748035136, 7844.607769611611, 7324.853502929805, 7488.251174882468, 7528.096628404626, 7707.152213256425, 7778.727744528915, 6950.3049695030095, 7063.82340441493, 7077.292270772881, 7092.9645351772915, 7102.289771022856, 4769.952300476951, 4895.33912921751, 4913.213885778258, 4926.0, 4946.851594452172, 5001.42483614389, 5104.591632669303, 5186.922196167136, 5188.688678679291, 5201.349831271091], "value": 4576.325007941122, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.75844478973585, 319.5953783123174, 327.7738360531233, 329.2131804986084, 330.98345082745857, 5444.3194600674915, 5562.833115006551, 5575.163725441181, 5590.413006634306, 5597.468240517154, 5420.864478388043, 5443.101888188444, 5469.507744303012, 5476.7535460904255, 5541.224228607998, 4072.226277007359, 4117.629413352797, 4192.182524407742, 4261.957380426187, 4288.228118938589, 4248.893777655552, 4258.87223383299, 4268.701190916637, 4285.635720963722, 4301.268784306675, 4232.132412855372, 4256.638185754215, 4270.487541495025, 4270.551592082833, 4283.67872409569, 4002.619751123624, 4244.490661120654, 4255.3616957456625, 4257.595528424826, 4312.935305970397, 3717.2565486902727, 3719.6237392164803, 3722.5346831646043, 3725.1990821973136, 3730.0, 5318.9202161967605, 5415.972920135414, 5419.566434685215, 5420.728963551806, 5433.320834895638, 4626.884327891796, 4883.438404583483, 4889.706617602919, 4902.877428064291, 4913.803447862081, 5777.277840269966, 5814.941850581525, 5820.447057529528, 5860.7948721794955, 5896.410358964112, 4065.5324637666454, 4097.405876147972, 4113.8971525711795, 4123.484564429446, 4129.318662420697, 5876.735546900357, 6008.75964961401, 6031.728572214217, 6049.0, 6089.208402907594, 4105.67154627635, 4112.835486580563, 4139.834406623701, 4145.502539695196, 4188.267053265667, 4166.895827604334, 4186.958130418718, 4189.622933935961, 4215.725977811432, 4220.915581688349, 4737.194676904865, 4829.710217386898, 4851.126797176542, 4858.372445230817, 4910.821402863287, 5748.885022299531, 5758.136279558016, 5778.913316300259, 5783.277090363705, 5819.73811178498, 1436.4685066525453, 1448.5943935698022, 1460.2844606143126, 1469.2433396800657, 1475.7491226491522, 878.9471236571688, 932.5710173320213, 950.1733491862125, 969.4619486185094, 991.6529214774915, 5531.0, 5540.556755459635, 5608.681959739458, 5622.409646987089, 5640.294963129609, 5903.852403689943, 5957.165996760457, 5963.761449541969, 5992.400759923973, 5999.370066142992, 5435.701036443033, 5531.806386776443, 5558.6942718150085, 5570.693611851306, 5632.774689012475, 3139.434901717713, 3160.8893688720786, 3173.873045078171, 3190.5852239208753, 3216.7426605871474, 5984.970075149597, 6041.184440100618, 6066.0, 6141.140240366352, 6181.196444462281, 5936.198613187251, 5983.19226904371, 6015.1428071665605, 6027.306859711101, 6082.391760823883, 6047.12316714074, 6060.8181404625675, 6068.33248342682, 6127.693615319216, 6160.457736801268, 5735.942640573541, 5845.473907348189, 5867.589268751317, 5875.882482350415, 5886.58793884424, 5762.423757624204, 5831.591788574759, 5840.328362238397, 5875.059990401515, 5884.264466941632, 5992.490638295793, 6118.235220597426, 6123.357047509948, 6170.5372097092, 6190.473809726043, 4099.877003689894, 4144.756573028139, 4156.0, 4158.771267580312, 4188.6649068073875, 5827.79602713903, 5871.324797648154, 5890.852728681646, 5912.320083190316, 5921.526277897672, 5508.338999320107, 5735.419061422293, 5757.366689664217, 5767.365589785204, 5849.736761845642, 5716.742316690322, 5729.71351432435, 5741.598088133791, 5752.0, 5761.913571296518, 5504.889902202013, 5638.633488823378, 5644.3508996465935, 5723.170140329712, 5736.512396446182, 5872.119182122716, 5882.0, 5910.852228694317, 5956.731947062479, 5961.4038596140035, 5668.829935101953, 5733.226014487991, 5812.331581868139, 5816.0, 5823.94176058234], "value": 4381.9482649275005, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.8754218011849, 723.486324709456, 733.6845156582671, 778.8792737125746, 781.0978320040356, 14605.050671706345, 15463.381464741411, 15483.69032619347, 15505.14721690308, 15528.767068493953, 14912.105273683586, 14972.401103955828, 15018.399264029453, 15020.098794072363, 15046.699066018673, 641.1312671330327, 658.6048370977423, 751.6955632968657, 752.9397648188145, 777.3392616276149, 767.2634271099723, 775.4378075894988, 775.5153029356652, 775.9961200193991, 776.5690042026673, 822.284612387224, 822.761399194236, 824.4558591329724, 825.5830805443243, 825.7151282807422, 819.3813670678629, 820.8235229425702, 821.9876701849477, 822.7408366364576, 822.8272062866805, 600.7356763024299, 603.3664652115261, 603.5171862509975, 605.4520658803746, 606.7724603273772, 13424.731505369935, 13464.326783660777, 13484.662883427894, 13501.662458438519, 13502.122362046435, 14945.459271923799, 15202.0, 15217.847821521755, 15347.769783453257, 15413.152276624782, 11652.592159274469, 11704.941475292655, 11728.0, 11784.587539436165, 12441.626751197478, 3750.249950010009, 3780.130569968895, 3863.130795571002, 3953.367461206222, 3954.2486927483687, 72562.27437725608, 72744.27255727428, 74145.0, 74498.62750686212, 75554.24445755527, 10647.0, 10735.677929662123, 10739.516721747385, 10754.408507532004, 10878.347299162075, 21707.13171473155, 21715.34853954384, 21788.782112178993, 21947.231846885603, 21971.121155153935, 7968.681252749825, 8096.878546821802, 8471.0, 8537.890074290426, 8575.914240857512, 4437.400950871655, 4632.25883858581, 4656.185167595657, 4669.789859456333, 4737.644676649265, 3407.6421975692197, 3480.965190348115, 3486.0, 3495.94756078659, 3508.2281897982402, 561.6012631031931, 564.3369041376367, 568.1449418624943, 575.4878158438993, 576.127167341478, 691.512483698991, 701.051078003152, 740.9962950185214, 757.6552668535803, 759.8442319324525, 8799.604017819214, 9156.450612963243, 9212.309076819265, 9231.215346695606, 9354.71935841926, 601.4977493792732, 660.207750699163, 683.4122654517112, 702.7610612391811, 709.7161135545823, 4214.325707886724, 4432.401625780479, 4527.7736113194205, 4569.223232050559, 4636.397268355092, 67295.66352168207, 117452.0, 118024.0, 119165.0, 122515.38742306232, 76916.2308376909, 80928.59535702284, 81072.18927810765, 106594.0, 107787.0, 71566.0, 75269.0, 76972.23027769763, 77124.61437692776, 77882.6105869467, 8846.646134154562, 9697.272704547046, 9825.312228143961, 9830.115289623967, 9998.400095994264, 46773.766131169126, 47525.28712069253, 49366.50633493619, 49427.258591121885, 49956.500434995185, 64668.676656616415, 67282.0, 70968.64515677388, 71366.28633713597, 71540.64229678818, 12632.936835316132, 12788.680282992627, 12976.091673582758, 13092.739408528776, 13262.668433289246, 13418.261995590336, 13799.379027943565, 13908.026438149232, 13939.16365018102, 14576.635584110481, 13333.466661333827, 13569.118007329493, 13700.65748356299, 13817.765271310269, 13916.234607096707, 12917.935410322889, 13536.661583460098, 13705.862941370458, 13710.17738935667, 14174.716505670036, 12023.819642705192, 12692.111552191627, 12782.48870045225, 12999.805002925154, 13043.844982163264, 10554.2084343673, 10619.522121504397, 10972.598494466742, 11057.778844422906, 11423.543058277575, 10508.367039416278, 11376.260543064674, 11602.825957610474, 11681.123915706186, 11690.590829320932], "value": 7309.234260829251, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1514.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 112.0, 112.0, 115.0, 112.0, 111.0, 113.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 124.0, 178.0, 136.0, 125.0, 126.0, 126.0, 153.0, 125.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 169.0, 165.0, 169.0, 164.0, 162.0, 162.0, 164.0, 163.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 113.0, 76.0, 76.0, 84.0, 80.0, 109.0, 76.0], "value": 84.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 121.0, 83.0, 83.0, 84.0, 107.0, 84.0, 83.0, 112.0], "value": 92.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 118.0, 119.0, 118.0, 117.0, 117.0, 117.0, 119.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 148.0, 147.0, 148.0, 147.0, 148.0, 149.0, 147.0, 148.0, 148.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 86.0, 85.0, 85.0, 86.0, 86.0, 84.0, 86.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 55.0, 54.0, 55.0, 54.0, 55.0, 57.0, 57.0, 56.0, 59.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 59.0, 60.0, 58.0, 60.0, 60.0, 59.0, 60.0], "value": 59.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 82.0, 83.0, 88.0, 82.0, 81.0, 82.0, 86.0, 81.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 131.0, 140.0, 133.0, 153.0, 140.0, 133.0, 138.0, 172.0, 137.0], "value": 141.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 164.0, 169.0, 165.0, 166.0, 168.0, 165.0, 167.0, 164.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 65.0, 69.0, 66.0, 66.0, 66.0, 65.0, 69.0, 66.0, 66.0], "value": 66.8, "unit": "score"}]}]} 06:57:03 INFO - Return code: 0 06:57:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:57:03 ERROR - # TBPL SUCCESS # 06:57:03 INFO - Running post-action listener: _resource_record_post_action 06:57:03 INFO - [mozharness: 2016-10-18 13:57:03.484032Z] Finished run-tests step (success) 06:57:03 INFO - Running post-run listener: _resource_record_post_run 06:57:03 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 393277440; Read time: 0; Write time: 253744 06:57:03 INFO - TinderboxPrint: CPU usage
13.4% 06:57:03 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 06:57:03 INFO - TinderboxPrint: I/O write bytes / time
393,277,440 / 253,744 06:57:03 INFO - TinderboxPrint: CPU idle
8,257.5 (86.6%) 06:57:03 INFO - TinderboxPrint: CPU user
1,218.8 (12.8%) 06:57:03 INFO - TinderboxPrint: Swap in / out
0 / 0 06:57:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104943616; Read time: 0; Write time: 76704 06:57:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287367168; Read time: 0; Write time: 176980 06:57:04 INFO - Running post-run listener: _upload_blobber_files 06:57:04 INFO - Blob upload gear active. 06:57:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:57:04 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 06:57:04 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'] 06:57:04 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 06:57:04 INFO - (blobuploader) - INFO - Open directory for files ... 06:57:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:57:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:57:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:05 INFO - (blobuploader) - INFO - Done attempting. 06:57:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:57:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:57:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:09 INFO - (blobuploader) - INFO - Done attempting. 06:57:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:57:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:57:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:57:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:57:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:57:09 INFO - (blobuploader) - INFO - Done attempting. 06:57:09 INFO - (blobuploader) - INFO - Iteration through files over. 06:57:09 INFO - Return code: 0 06:57:09 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:57:09 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:57:09 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a2c4114f6d8001a489575882807ffe164596bc91e29fc33465500697199d08a78b01fff19b94cc5dc977845479ea109318f1e64896ff176264302ff54fe6fac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f66d2556e34978852b1f434bc965e0a8b84ce9a637613460309dca9e9307c9033a9f7fa16ed968e8923fcd83f727951069dae3846267741ebb230efc548382a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42fef80c0c953332a1799849de0af9b235223574d2caddfc3787a5b9875fafd8e5856b092d42d5bb410120e82811446d59141b33474c4e9143d997e693212781"} 06:57:09 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:57:09 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:57:09 INFO - Contents: 06:57:09 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a2c4114f6d8001a489575882807ffe164596bc91e29fc33465500697199d08a78b01fff19b94cc5dc977845479ea109318f1e64896ff176264302ff54fe6fac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f66d2556e34978852b1f434bc965e0a8b84ce9a637613460309dca9e9307c9033a9f7fa16ed968e8923fcd83f727951069dae3846267741ebb230efc548382a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42fef80c0c953332a1799849de0af9b235223574d2caddfc3787a5b9875fafd8e5856b092d42d5bb410120e82811446d59141b33474c4e9143d997e693212781"} 06:57:09 INFO - Running post-run listener: copy_logs_to_upload_dir 06:57:09 INFO - Copying logs to upload dir... 06:57:09 INFO - mkdir: /builds/slave/test/build/upload/logs 06:57:09 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.034885 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-10-18 06:57:09.300170) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 06:57:09.303643) ========= 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=bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a2c4114f6d8001a489575882807ffe164596bc91e29fc33465500697199d08a78b01fff19b94cc5dc977845479ea109318f1e64896ff176264302ff54fe6fac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f66d2556e34978852b1f434bc965e0a8b84ce9a637613460309dca9e9307c9033a9f7fa16ed968e8923fcd83f727951069dae3846267741ebb230efc548382a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42fef80c0c953332a1799849de0af9b235223574d2caddfc3787a5b9875fafd8e5856b092d42d5bb410120e82811446d59141b33474c4e9143d997e693212781"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011497 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476786616/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1a2c4114f6d8001a489575882807ffe164596bc91e29fc33465500697199d08a78b01fff19b94cc5dc977845479ea109318f1e64896ff176264302ff54fe6fac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f66d2556e34978852b1f434bc965e0a8b84ce9a637613460309dca9e9307c9033a9f7fa16ed968e8923fcd83f727951069dae3846267741ebb230efc548382a8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/42fef80c0c953332a1799849de0af9b235223574d2caddfc3787a5b9875fafd8e5856b092d42d5bb410120e82811446d59141b33474c4e9143d997e693212781"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-18 06:57:09.329926) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:57:09.330312) ========= 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=bb9b54edd4a927dc735d112f000001d9-1476797789.698004-1853785531 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004420 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-18 06:57:09.416293) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 06:57:09.416633) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-18 06:57:09.416964) ========= ========= Total master_lag: 0.17 =========