builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-055 starttime: 1476685881.27 results: success (0) buildid: 20161016232531 builduid: 7e11e6fd8900468bb1278094436324d6 revision: 687572ea20cb84f1842ad00dcc8ca1712868a361 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:21.269327) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:21.269816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:21.270107) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:21.288202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:21.288736) ========= 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-1476685881.552490-1638668301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-16 23:31:22-- 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% 45.8M=0s 2016-10-16 23:31:22 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.101867 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:21.409769) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:21.410202) ========= 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-1476685881.552490-1638668301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021794 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:21.460131) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:21.461291) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 687572ea20cb84f1842ad00dcc8ca1712868a361 --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 687572ea20cb84f1842ad00dcc8ca1712868a361 --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-1476685881.552490-1638668301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-16 23:31:22,762 truncating revision to first 12 chars 2016-10-16 23:31:22,762 Setting DEBUG logging. 2016-10-16 23:31:22,762 attempt 1/10 2016-10-16 23:31:22,762 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/687572ea20cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-16 23:31:23,283 unpacking tar archive at: fx-team-687572ea20cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.833625 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:22.311690) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:22.312066) ========= script_repo_revision: 687572ea20cb84f1842ad00dcc8ca1712868a361 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:22.312498) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:22.312773) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-16 23:31:22.325739) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-16 23:31:22.326155) ========= /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-1476685881.552490-1638668301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:31:23 INFO - MultiFileLogger online at 20161016 23:31:23 in /builds/slave/test 23:31:23 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 23:31:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:31:23 INFO - {'append_to_log': False, 23:31:23 INFO - 'base_work_dir': '/builds/slave/test', 23:31:23 INFO - 'blob_upload_branch': 'Fx-Team', 23:31:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:31:23 INFO - 'branch': 'Fx-Team', 23:31:23 INFO - 'buildbot_json_path': 'buildprops.json', 23:31:23 INFO - 'config_files': ('talos/linux_config.py',), 23:31:23 INFO - 'default_actions': ('clobber', 23:31:23 INFO - 'read-buildbot-config', 23:31:23 INFO - 'download-and-extract', 23:31:23 INFO - 'populate-webroot', 23:31:23 INFO - 'create-virtualenv', 23:31:23 INFO - 'install', 23:31:23 INFO - 'run-tests'), 23:31:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:31:23 INFO - 'download_minidump_stackwalk': True, 23:31:23 INFO - 'download_symbols': 'ondemand', 23:31:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:31:23 INFO - 'tooltool.py': '/tools/tooltool.py', 23:31:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:31:23 INFO - '/tools/misc-python/virtualenv.py')}, 23:31:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:31:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:31:23 INFO - 'installer_path': 'installer.exe', 23:31:23 INFO - 'log_level': 'info', 23:31:23 INFO - 'log_name': 'talos', 23:31:23 INFO - 'log_to_console': True, 23:31:23 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:31:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:31:23 INFO - 'opt_config_files': (), 23:31:23 INFO - 'pip_index': False, 23:31:23 INFO - 'sps_profile': False, 23:31:23 INFO - 'sps_profile_interval': 0, 23:31:23 INFO - 'suite': 'dromaeojs-e10s', 23:31:23 INFO - 'system_bits': '32', 23:31:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:31:23 INFO - 'title': 'talos-linux64-ix-055', 23:31:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:31:23 INFO - 'use_talos_json': True, 23:31:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:31:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:31:23 INFO - 'work_dir': 'build'} 23:31:23 INFO - [mozharness: 2016-10-17 06:31:23.717858Z] Running clobber step. 23:31:23 INFO - Running pre-action listener: _resource_record_pre_action 23:31:23 INFO - Running main action method: clobber 23:31:23 INFO - rmtree: /builds/slave/test/build 23:31:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:31:24 INFO - Running post-action listener: _resource_record_post_action 23:31:24 INFO - [mozharness: 2016-10-17 06:31:24.688397Z] Finished clobber step (success) 23:31:24 INFO - [mozharness: 2016-10-17 06:31:24.688498Z] Running read-buildbot-config step. 23:31:24 INFO - Running pre-action listener: _resource_record_pre_action 23:31:24 INFO - Running main action method: read_buildbot_config 23:31:24 INFO - Using buildbot properties: 23:31:24 INFO - { 23:31:24 INFO - "project": "", 23:31:24 INFO - "product": "firefox", 23:31:24 INFO - "script_repo_revision": "production", 23:31:24 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:31:24 INFO - "repository": "", 23:31:24 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:31:24 INFO - "buildid": "20161016232531", 23:31:24 INFO - "stage_platform": "linux64-pgo", 23:31:24 INFO - "basedir": "/builds/slave/test", 23:31:24 INFO - "buildnumber": 824, 23:31:24 INFO - "platform": "ubuntu64_hw", 23:31:24 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:31:24 INFO - "slavebuilddir": "test", 23:31:24 INFO - "branch": "fx-team", 23:31:24 INFO - "revision": "687572ea20cb84f1842ad00dcc8ca1712868a361", 23:31:24 INFO - "slavename": "talos-linux64-ix-055", 23:31:24 INFO - "builduid": "7e11e6fd8900468bb1278094436324d6", 23:31:24 INFO - "repo_path": "integration/fx-team" 23:31:24 INFO - } 23:31:24 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 23:31:24 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 23:31:24 INFO - Running post-action listener: _resource_record_post_action 23:31:24 INFO - [mozharness: 2016-10-17 06:31:24.690861Z] Finished read-buildbot-config step (success) 23:31:24 INFO - [mozharness: 2016-10-17 06:31:24.690948Z] Running download-and-extract step. 23:31:24 INFO - Running pre-action listener: _resource_record_pre_action 23:31:24 INFO - Running main action method: download_and_extract 23:31:24 INFO - mkdir: /builds/slave/test/build/tests 23:31:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:24 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:31:24 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/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 23:31:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/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 23:31:24 INFO - Downloaded 1361 bytes. 23:31:24 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 23:31:24 INFO - Using the following test package requirements: 23:31:24 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:31:24 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:31:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:31:24 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:31:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:31:24 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:31:24 INFO - u'jsshell-linux-x86_64.zip'], 23:31:24 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:31:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:31:24 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 23:31:24 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:31:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:31:24 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:31:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:31:24 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:31:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:31:24 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 23:31:24 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:31:24 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:31:24 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/1476674095/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:31:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:31:24 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:31:24 INFO - Http code: 200 23:31:24 INFO - via: 1.1 0cf1d7257c633ae75623c5e75bf3805e.cloudfront.net (CloudFront) 23:31:24 INFO - x-amz-cf-id: ocSl617Kgrd20ybQJH8b695jOMa6i51jFWzku3aQ-WmkDg_-pyVR2A== 23:31:24 INFO - x-amz-replication-status: COMPLETED 23:31:24 INFO - x-amz-version-id: 874ZdZOgDpYhUqe7nky92SN2QOZkIN17 23:31:25 INFO - Expected file size: 22100551 23:31:25 INFO - Obtained file size: 22100551 23:31:29 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 23:31:29 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/1476674095/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 23:31:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:31:29 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 23:31:29 INFO - Http code: 200 23:31:29 INFO - via: 1.1 423912f2b1c5569e2fa5017167c61fa0.cloudfront.net (CloudFront) 23:31:29 INFO - x-amz-cf-id: wZypQ-M7ACiTWVfG8T56YERsgYJyF_ZjbbXcFcuEq4l7n37nPSxARw== 23:31:29 INFO - x-amz-replication-status: COMPLETED 23:31:29 INFO - x-amz-version-id: 874ZdZOgDpYhUqe7nky92SN2QOZkIN17 23:31:29 INFO - Expected file size: 22100551 23:31:29 INFO - Obtained file size: 22100551 23:31:33 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/1476674095/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 23:31:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:31:33 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 23:31:33 INFO - Http code: 200 23:31:33 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 23:31:33 INFO - x-amz-cf-id: 6kW-Qq9cNiZl1bD2AboHe1lP3-QthrFS9TFM8wYFXn2wTtZ-vWq89w== 23:31:33 INFO - x-amz-replication-status: COMPLETED 23:31:33 INFO - x-amz-version-id: pa1fpRG_G5hkdabdf16hqjPYG9SfXLTW 23:31:34 INFO - Expected file size: 14409006 23:31:34 INFO - Obtained file size: 14409006 23:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:34 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:31:34 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/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 23:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/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 23:31:35 INFO - Downloaded 59780329 bytes. 23:31:35 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:31:35 INFO - mkdir: /builds/slave/test/properties 23:31:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:31:35 INFO - Writing to file /builds/slave/test/properties/build_url 23:31:35 INFO - Contents: 23:31:35 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 23:31:35 INFO - Running post-action listener: _resource_record_post_action 23:31:35 INFO - Running post-action listener: set_extra_try_arguments 23:31:35 INFO - [mozharness: 2016-10-17 06:31:35.476991Z] Finished download-and-extract step (success) 23:31:35 INFO - [mozharness: 2016-10-17 06:31:35.477220Z] Running populate-webroot step. 23:31:35 INFO - Running pre-action listener: _resource_record_pre_action 23:31:35 INFO - Running main action method: populate_webroot 23:31:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:31:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:31:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:31:35 INFO - '--tppagecycles', 23:31:35 INFO - '7'], 23:31:35 INFO - 'tests': ['tsvgm']}}, 23:31:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:31:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:31:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:31:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:31:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:31:35 INFO - 'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:31:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:31:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:31:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:31:35 INFO - 'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['damp', 'tps']}, 23:31:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:31:35 INFO - 'tests': ['damp', 'tps']}, 23:31:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['dromaeo_dom']}, 23:31:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:31:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['basic_compositor_video']}, 23:31:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:31:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['a11yr', 23:31:35 INFO - 'ts_paint', 23:31:35 INFO - 'tpaint', 23:31:35 INFO - 'sessionrestore', 23:31:35 INFO - 'sessionrestore_no_auto_restore', 23:31:35 INFO - 'tabpaint']}, 23:31:35 INFO - 'other-e10s': {'tests': ['a11yr', 23:31:35 INFO - 'ts_paint', 23:31:35 INFO - 'tpaint', 23:31:35 INFO - 'sessionrestore', 23:31:35 INFO - 'sessionrestore_no_auto_restore', 23:31:35 INFO - 'tabpaint']}, 23:31:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:31:35 INFO - 'ts_paint', 23:31:35 INFO - 'tpaint', 23:31:35 INFO - 'sessionrestore', 23:31:35 INFO - 'sessionrestore_no_auto_restore', 23:31:35 INFO - 'tabpaint']}, 23:31:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:31:35 INFO - 'ts_paint', 23:31:35 INFO - 'tpaint', 23:31:35 INFO - 'sessionrestore', 23:31:35 INFO - 'sessionrestore_no_auto_restore', 23:31:35 INFO - 'tabpaint']}, 23:31:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['a11yr', 23:31:35 INFO - 'ts_paint', 23:31:35 INFO - 'tpaint', 23:31:35 INFO - 'sessionrestore', 23:31:35 INFO - 'sessionrestore_no_auto_restore', 23:31:35 INFO - 'tabpaint']}, 23:31:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['a11yr', 23:31:35 INFO - 'ts_paint', 23:31:35 INFO - 'tpaint', 23:31:35 INFO - 'sessionrestore', 23:31:35 INFO - 'sessionrestore_no_auto_restore', 23:31:35 INFO - 'tabpaint']}, 23:31:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['tsvgx', 23:31:35 INFO - 'tsvgr_opacity', 23:31:35 INFO - 'tart', 23:31:35 INFO - 'tscrollx', 23:31:35 INFO - 'cart']}, 23:31:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:31:35 INFO - 'tsvgr_opacity', 23:31:35 INFO - 'tart', 23:31:35 INFO - 'tscrollx', 23:31:35 INFO - 'cart']}, 23:31:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:31:35 INFO - 'talos_options': ['--disable-e10s'], 23:31:35 INFO - 'tests': ['tp5o']}, 23:31:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:31:35 INFO - 'tests': ['tp5o']}, 23:31:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:31:35 INFO - 'talos_options': ['--disable-e10s', 23:31:35 INFO - '--xperf_path', 23:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:31:35 INFO - 'tests': ['tp5n']}, 23:31:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:31:35 INFO - 'talos_options': ['--xperf_path', 23:31:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:31:35 INFO - 'tests': ['tp5n']}}, 23:31:35 INFO - 'talos.zip': {'path': '', 23:31:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:31:35 INFO - Running post-action listener: _resource_record_post_action 23:31:35 INFO - [mozharness: 2016-10-17 06:31:35.495844Z] Finished populate-webroot step (success) 23:31:35 INFO - [mozharness: 2016-10-17 06:31:35.495932Z] Running create-virtualenv step. 23:31:35 INFO - Running pre-action listener: _resource_record_pre_action 23:31:35 INFO - Running main action method: create_virtualenv 23:31:35 INFO - Creating virtualenv /builds/slave/test/build/venv 23:31:35 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 23:31:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:31:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:31:35 INFO - Using real prefix '/usr' 23:31:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:31:36 INFO - Installing distribute.............................................................................................................................................................................................done. 23:31:38 INFO - Installing pip.................done. 23:31:38 INFO - Return code: 0 23:31:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:31:38 INFO - Reading from file tmpfile_stdout 23:31:38 INFO - Output received: 23:31:38 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) 23:31:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19ee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, '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-1476685881.552490-1638668301', '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 23:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:31:38 INFO - Using env: {'DISPLAY': ':0', 23:31:38 INFO - 'HOME': '/home/cltbld', 23:31:38 INFO - 'LANG': 'en_US.UTF-8', 23:31:38 INFO - 'LANGUAGE': 'en_US:en', 23:31:38 INFO - 'LOGNAME': 'cltbld', 23:31:38 INFO - 'MAIL': '/var/mail/cltbld', 23:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:38 INFO - 'MOZ_NO_REMOTE': '1', 23:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:38 INFO - 'NO_EM_RESTART': '1', 23:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:38 INFO - 'PWD': '/builds/slave/test', 23:31:38 INFO - 'SHELL': '/bin/bash', 23:31:38 INFO - 'SHLVL': '1', 23:31:38 INFO - 'TERM': 'linux', 23:31:38 INFO - 'TMOUT': '86400', 23:31:38 INFO - 'USER': 'cltbld', 23:31:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:38 INFO - '_': '/tools/buildbot/bin/python'} 23:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:38 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 23:31:38 INFO - Cleaning up... 23:31:38 INFO - Return code: 0 23:31:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe19ee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, '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-1476685881.552490-1638668301', '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 23:31:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:31:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:31:38 INFO - Using env: {'DISPLAY': ':0', 23:31:38 INFO - 'HOME': '/home/cltbld', 23:31:38 INFO - 'LANG': 'en_US.UTF-8', 23:31:38 INFO - 'LANGUAGE': 'en_US:en', 23:31:38 INFO - 'LOGNAME': 'cltbld', 23:31:38 INFO - 'MAIL': '/var/mail/cltbld', 23:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:38 INFO - 'MOZ_NO_REMOTE': '1', 23:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:38 INFO - 'NO_EM_RESTART': '1', 23:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:38 INFO - 'PWD': '/builds/slave/test', 23:31:38 INFO - 'SHELL': '/bin/bash', 23:31:38 INFO - 'SHLVL': '1', 23:31:38 INFO - 'TERM': 'linux', 23:31:38 INFO - 'TMOUT': '86400', 23:31:38 INFO - 'USER': 'cltbld', 23:31:38 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:38 INFO - '_': '/tools/buildbot/bin/python'} 23:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:38 INFO - Downloading/unpacking psutil>=3.1.1 23:31:38 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 23:31:38 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 23:31:38 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 23:31:38 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 23:31:38 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 23:31:38 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 23:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:31:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:31:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:31:40 INFO - Installing collected packages: psutil 23:31:40 INFO - Running setup.py install for psutil 23:31:40 INFO - building 'psutil._psutil_linux' extension 23:31:40 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 23:31:40 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 23:31:41 INFO - building 'psutil._psutil_posix' extension 23:31:41 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 23:31:41 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 23:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:31:41 INFO - Successfully installed psutil 23:31:41 INFO - Cleaning up... 23:31:41 INFO - Return code: 0 23:31:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:31:41 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')]} 23:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:41 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')]} 23:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:41 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 0x7fe19ee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, '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-1476685881.552490-1638668301', '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 23:31:41 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 23:31:41 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 23:31:41 INFO - Using env: {'DISPLAY': ':0', 23:31:41 INFO - 'HOME': '/home/cltbld', 23:31:41 INFO - 'LANG': 'en_US.UTF-8', 23:31:41 INFO - 'LANGUAGE': 'en_US:en', 23:31:41 INFO - 'LOGNAME': 'cltbld', 23:31:41 INFO - 'MAIL': '/var/mail/cltbld', 23:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:41 INFO - 'MOZ_NO_REMOTE': '1', 23:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:41 INFO - 'NO_EM_RESTART': '1', 23:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:41 INFO - 'PWD': '/builds/slave/test', 23:31:41 INFO - 'SHELL': '/bin/bash', 23:31:41 INFO - 'SHLVL': '1', 23:31:41 INFO - 'TERM': 'linux', 23:31:41 INFO - 'TMOUT': '86400', 23:31:41 INFO - 'USER': 'cltbld', 23:31:41 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:41 INFO - '_': '/tools/buildbot/bin/python'} 23:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:31:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:31:43 INFO - Installing collected packages: mozsystemmonitor 23:31:43 INFO - Running setup.py install for mozsystemmonitor 23:31:43 INFO - Successfully installed mozsystemmonitor 23:31:43 INFO - Cleaning up... 23:31:43 INFO - Return code: 0 23:31:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:31:43 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')]} 23:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:43 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')]} 23:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:43 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 0x7fe19ee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, '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-1476685881.552490-1638668301', '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 23:31:43 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 23:31:43 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 23:31:43 INFO - Using env: {'DISPLAY': ':0', 23:31:43 INFO - 'HOME': '/home/cltbld', 23:31:43 INFO - 'LANG': 'en_US.UTF-8', 23:31:43 INFO - 'LANGUAGE': 'en_US:en', 23:31:43 INFO - 'LOGNAME': 'cltbld', 23:31:43 INFO - 'MAIL': '/var/mail/cltbld', 23:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:43 INFO - 'MOZ_NO_REMOTE': '1', 23:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:43 INFO - 'NO_EM_RESTART': '1', 23:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:43 INFO - 'PWD': '/builds/slave/test', 23:31:43 INFO - 'SHELL': '/bin/bash', 23:31:43 INFO - 'SHLVL': '1', 23:31:43 INFO - 'TERM': 'linux', 23:31:43 INFO - 'TMOUT': '86400', 23:31:43 INFO - 'USER': 'cltbld', 23:31:43 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:43 INFO - '_': '/tools/buildbot/bin/python'} 23:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:43 INFO - Downloading/unpacking jsonschema==2.5.1 23:31:43 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 23:31:43 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 23:31:43 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 23:31:43 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 23:31:43 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 23:31:43 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 23:31:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:31:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:31:46 INFO - Downloading functools32-3.2.3-2.tar.gz 23:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:31:46 INFO - warning: no files found matching '*.txt' 23:31:46 INFO - no previously-included directories found matching 'build' 23:31:46 INFO - no previously-included directories found matching 'dist' 23:31:46 INFO - no previously-included directories found matching '.git*' 23:31:46 INFO - Installing collected packages: jsonschema, functools32 23:31:46 INFO - Running setup.py install for functools32 23:31:46 INFO - warning: no files found matching '*.txt' 23:31:46 INFO - no previously-included directories found matching 'build' 23:31:46 INFO - no previously-included directories found matching 'dist' 23:31:46 INFO - no previously-included directories found matching '.git*' 23:31:46 INFO - Successfully installed jsonschema functools32 23:31:46 INFO - Cleaning up... 23:31:46 INFO - Return code: 0 23:31:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:31: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')]} 23:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31: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')]} 23:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31: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', '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 0x7fe19ee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, '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-1476685881.552490-1638668301', '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 23:31: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:31: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 functools32==3.2.3-2 23:31:46 INFO - Using env: {'DISPLAY': ':0', 23:31:46 INFO - 'HOME': '/home/cltbld', 23:31:46 INFO - 'LANG': 'en_US.UTF-8', 23:31:46 INFO - 'LANGUAGE': 'en_US:en', 23:31:46 INFO - 'LOGNAME': 'cltbld', 23:31:46 INFO - 'MAIL': '/var/mail/cltbld', 23:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:46 INFO - 'MOZ_NO_REMOTE': '1', 23:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:46 INFO - 'NO_EM_RESTART': '1', 23:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:46 INFO - 'PWD': '/builds/slave/test', 23:31:46 INFO - 'SHELL': '/bin/bash', 23:31:46 INFO - 'SHLVL': '1', 23:31:46 INFO - 'TERM': 'linux', 23:31:46 INFO - 'TMOUT': '86400', 23:31:46 INFO - 'USER': 'cltbld', 23:31:46 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:46 INFO - '_': '/tools/buildbot/bin/python'} 23:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:31:46 INFO - Cleaning up... 23:31:46 INFO - Return code: 0 23:31:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:31: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')]} 23:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31: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')]} 23:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31: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', '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 0x7fe19ee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, '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-1476685881.552490-1638668301', '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 23:31: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:31: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 blobuploader==1.2.4 23:31:46 INFO - Using env: {'DISPLAY': ':0', 23:31:46 INFO - 'HOME': '/home/cltbld', 23:31:46 INFO - 'LANG': 'en_US.UTF-8', 23:31:46 INFO - 'LANGUAGE': 'en_US:en', 23:31:46 INFO - 'LOGNAME': 'cltbld', 23:31:46 INFO - 'MAIL': '/var/mail/cltbld', 23:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:46 INFO - 'MOZ_NO_REMOTE': '1', 23:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:46 INFO - 'NO_EM_RESTART': '1', 23:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:46 INFO - 'PWD': '/builds/slave/test', 23:31:46 INFO - 'SHELL': '/bin/bash', 23:31:46 INFO - 'SHLVL': '1', 23:31:46 INFO - 'TERM': 'linux', 23:31:46 INFO - 'TMOUT': '86400', 23:31:46 INFO - 'USER': 'cltbld', 23:31:46 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:46 INFO - '_': '/tools/buildbot/bin/python'} 23:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:46 INFO - Downloading/unpacking blobuploader==1.2.4 23:31: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 23:31: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 23:31: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 23:31: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 23:31: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 23:31: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 23:31:48 INFO - Downloading blobuploader-1.2.4.tar.gz 23:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:31:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:31:48 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 23:31:48 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 23:31:48 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 23:31:48 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 23:31:48 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 23:31:48 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 23:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:31:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:31: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 23:31: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 23:31: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 23:31: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 23:31: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 23:31: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 23:31:49 INFO - Downloading docopt-0.6.1.tar.gz 23:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:31:49 INFO - Installing collected packages: blobuploader, requests, docopt 23:31:49 INFO - Running setup.py install for blobuploader 23:31:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:31:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:31:49 INFO - Running setup.py install for requests 23:31:50 INFO - Running setup.py install for docopt 23:31:50 INFO - Successfully installed blobuploader requests docopt 23:31:50 INFO - Cleaning up... 23:31:50 INFO - Return code: 0 23:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:31:50 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')]} 23:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:50 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')]} 23:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:50 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 0x7fe19ee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, '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-1476685881.552490-1638668301', '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 23:31:50 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 23:31:50 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 23:31:50 INFO - Using env: {'DISPLAY': ':0', 23:31:50 INFO - 'HOME': '/home/cltbld', 23:31:50 INFO - 'LANG': 'en_US.UTF-8', 23:31:50 INFO - 'LANGUAGE': 'en_US:en', 23:31:50 INFO - 'LOGNAME': 'cltbld', 23:31:50 INFO - 'MAIL': '/var/mail/cltbld', 23:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:50 INFO - 'MOZ_NO_REMOTE': '1', 23:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:50 INFO - 'NO_EM_RESTART': '1', 23:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:50 INFO - 'PWD': '/builds/slave/test', 23:31:50 INFO - 'SHELL': '/bin/bash', 23:31:50 INFO - 'SHLVL': '1', 23:31:50 INFO - 'TERM': 'linux', 23:31:50 INFO - 'TMOUT': '86400', 23:31:50 INFO - 'USER': 'cltbld', 23:31:50 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:50 INFO - '_': '/tools/buildbot/bin/python'} 23:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:31:50 INFO - Running setup.py (path:/tmp/pip-CIytc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:31:50 INFO - Running setup.py (path:/tmp/pip-T7bHmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:31:50 INFO - Running setup.py (path:/tmp/pip-42aSH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:31:50 INFO - Running setup.py (path:/tmp/pip-gvxiAB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:31:50 INFO - Running setup.py (path:/tmp/pip-6ii27V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:31:50 INFO - Running setup.py (path:/tmp/pip-Mq3BK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:31:50 INFO - Running setup.py (path:/tmp/pip-UzDC2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:31:50 INFO - Running setup.py (path:/tmp/pip-xA4fwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:31:50 INFO - Running setup.py (path:/tmp/pip-3ydCYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:31:51 INFO - Running setup.py (path:/tmp/pip-dhfJ0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:31:51 INFO - Running setup.py (path:/tmp/pip-EHAc_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:31:51 INFO - Running setup.py (path:/tmp/pip-ckpa9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:31:51 INFO - Running setup.py (path:/tmp/pip-PwoAoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:31:51 INFO - Running setup.py (path:/tmp/pip-WWVbGz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:31:51 INFO - Running setup.py (path:/tmp/pip-H_Yv2x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:31:51 INFO - Running setup.py (path:/tmp/pip-vZiEjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:31:51 INFO - Running setup.py (path:/tmp/pip-TmtX3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:31:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:31:51 INFO - Running setup.py install for manifestparser 23:31:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:31:51 INFO - Running setup.py install for mozcrash 23:31:51 INFO - Running setup.py install for mozdebug 23:31:51 INFO - Running setup.py install for mozdevice 23:31:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Running setup.py install for mozfile 23:31:52 INFO - Running setup.py install for mozhttpd 23:31:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Running setup.py install for mozinfo 23:31:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Running setup.py install for mozInstall 23:31:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Running setup.py install for mozleak 23:31:52 INFO - Running setup.py install for mozlog 23:31:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Running setup.py install for moznetwork 23:31:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Running setup.py install for mozprocess 23:31:52 INFO - Running setup.py install for mozprofile 23:31:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:31:52 INFO - Running setup.py install for mozrunner 23:31:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:31:53 INFO - Running setup.py install for mozscreenshot 23:31:53 INFO - Running setup.py install for moztest 23:31:53 INFO - Running setup.py install for mozversion 23:31:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:31:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:31:53 INFO - Cleaning up... 23:31:53 INFO - Return code: 0 23:31:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:53 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 0x7fe19ee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, '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-1476685881.552490-1638668301', '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 23:31:53 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 23:31:53 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 23:31:53 INFO - Using env: {'DISPLAY': ':0', 23:31:53 INFO - 'HOME': '/home/cltbld', 23:31:53 INFO - 'LANG': 'en_US.UTF-8', 23:31:53 INFO - 'LANGUAGE': 'en_US:en', 23:31:53 INFO - 'LOGNAME': 'cltbld', 23:31:53 INFO - 'MAIL': '/var/mail/cltbld', 23:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:53 INFO - 'MOZ_NO_REMOTE': '1', 23:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:53 INFO - 'NO_EM_RESTART': '1', 23:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:53 INFO - 'PWD': '/builds/slave/test', 23:31:53 INFO - 'SHELL': '/bin/bash', 23:31:53 INFO - 'SHLVL': '1', 23:31:53 INFO - 'TERM': 'linux', 23:31:53 INFO - 'TMOUT': '86400', 23:31:53 INFO - 'USER': 'cltbld', 23:31:53 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:53 INFO - '_': '/tools/buildbot/bin/python'} 23:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:31:53 INFO - Running setup.py (path:/tmp/pip-foyykD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:31:53 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)) 23:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:31:53 INFO - Running setup.py (path:/tmp/pip-JVMbEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:31:53 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)) 23:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:31:53 INFO - Running setup.py (path:/tmp/pip-MOnmfP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:31:53 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)) 23:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:31:53 INFO - Running setup.py (path:/tmp/pip-POMk0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:31:53 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)) 23:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:31:53 INFO - Running setup.py (path:/tmp/pip-yW2DL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:31:54 INFO - Running setup.py (path:/tmp/pip-0Dcq94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:31:54 INFO - Running setup.py (path:/tmp/pip-T7cvj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:31:54 INFO - Running setup.py (path:/tmp/pip-hbu9ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:31:54 INFO - Running setup.py (path:/tmp/pip-pUtecB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:31:54 INFO - Running setup.py (path:/tmp/pip-sEfX5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:31:54 INFO - Running setup.py (path:/tmp/pip-QC0HIV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:31:54 INFO - Running setup.py (path:/tmp/pip-7fXnlY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:31:54 INFO - Running setup.py (path:/tmp/pip-ZYjioQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:31:54 INFO - Running setup.py (path:/tmp/pip-jcodRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:31:54 INFO - Running setup.py (path:/tmp/pip-yc9Toq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:31:54 INFO - Running setup.py (path:/tmp/pip-DMtdtj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:31:54 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)) 23:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:31:54 INFO - Running setup.py (path:/tmp/pip-_MMkzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:31:54 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)) 23:31:54 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)) 23:31:54 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)) 23:31:54 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)) 23:31:54 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)) 23:31:54 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)) 23:31:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:31: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 23:31: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 23:31: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 23:31: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 23:31: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 23:31: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 23:31:56 INFO - Downloading blessings-1.6.tar.gz 23:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:31:56 INFO - Installing collected packages: blessings 23:31:56 INFO - Running setup.py install for blessings 23:31:56 INFO - Successfully installed blessings 23:31:56 INFO - Cleaning up... 23:31:57 INFO - Return code: 0 23:31:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:31:57 INFO - Reading from file tmpfile_stdout 23:31:57 INFO - Current package versions: 23:31:57 INFO - argparse == 1.2.1 23:31:57 INFO - blessings == 1.6 23:31:57 INFO - blobuploader == 1.2.4 23:31:57 INFO - docopt == 0.6.1 23:31:57 INFO - functools32 == 3.2.3-2 23:31:57 INFO - jsonschema == 2.5.1 23:31:57 INFO - manifestparser == 1.1 23:31:57 INFO - mozInstall == 1.12 23:31:57 INFO - mozcrash == 0.17 23:31:57 INFO - mozdebug == 0.1 23:31:57 INFO - mozdevice == 0.48 23:31:57 INFO - mozfile == 1.2 23:31:57 INFO - mozhttpd == 0.7 23:31:57 INFO - mozinfo == 0.9 23:31:57 INFO - mozleak == 0.1 23:31:57 INFO - mozlog == 3.4 23:31:57 INFO - moznetwork == 0.27 23:31:57 INFO - mozprocess == 0.23 23:31:57 INFO - mozprofile == 0.28 23:31:57 INFO - mozrunner == 6.12 23:31:57 INFO - mozscreenshot == 0.1 23:31:57 INFO - mozsystemmonitor == 0.3 23:31:57 INFO - moztest == 0.7 23:31:57 INFO - mozversion == 1.4 23:31:57 INFO - psutil == 3.1.1 23:31:57 INFO - requests == 1.2.3 23:31:57 INFO - wsgiref == 0.1.2 23:31:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:57 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 0x7fe19ee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, '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-1476685881.552490-1638668301', '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 23:31:57 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 23:31:57 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 23:31:57 INFO - Using env: {'DISPLAY': ':0', 23:31:57 INFO - 'HOME': '/home/cltbld', 23:31:57 INFO - 'LANG': 'en_US.UTF-8', 23:31:57 INFO - 'LANGUAGE': 'en_US:en', 23:31:57 INFO - 'LOGNAME': 'cltbld', 23:31:57 INFO - 'MAIL': '/var/mail/cltbld', 23:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:57 INFO - 'MOZ_NO_REMOTE': '1', 23:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:57 INFO - 'NO_EM_RESTART': '1', 23:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:57 INFO - 'PWD': '/builds/slave/test', 23:31:57 INFO - 'SHELL': '/bin/bash', 23:31:57 INFO - 'SHLVL': '1', 23:31:57 INFO - 'TERM': 'linux', 23:31:57 INFO - 'TMOUT': '86400', 23:31:57 INFO - 'USER': 'cltbld', 23:31:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:57 INFO - '_': '/tools/buildbot/bin/python'} 23:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:57 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)) 23:31:57 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)) 23:31:57 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)) 23:31:57 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)) 23:31:57 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)) 23:31:57 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)) 23:31:57 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)) 23:31:57 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)) 23:31:57 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)) 23:31:57 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)) 23:31:57 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)) 23:31:57 INFO - Cleaning up... 23:31:57 INFO - Return code: 0 23:31:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:31:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe19ee66f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17168a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e3790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, '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-1476685881.552490-1638668301', '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 23:31:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 23:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 23:31:57 INFO - Using env: {'DISPLAY': ':0', 23:31:57 INFO - 'HOME': '/home/cltbld', 23:31:57 INFO - 'LANG': 'en_US.UTF-8', 23:31:57 INFO - 'LANGUAGE': 'en_US:en', 23:31:57 INFO - 'LOGNAME': 'cltbld', 23:31:57 INFO - 'MAIL': '/var/mail/cltbld', 23:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:31:57 INFO - 'MOZ_NO_REMOTE': '1', 23:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:31:57 INFO - 'NO_EM_RESTART': '1', 23:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:31:57 INFO - 'PWD': '/builds/slave/test', 23:31:57 INFO - 'SHELL': '/bin/bash', 23:31:57 INFO - 'SHLVL': '1', 23:31:57 INFO - 'TERM': 'linux', 23:31:57 INFO - 'TMOUT': '86400', 23:31:57 INFO - 'USER': 'cltbld', 23:31:57 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:31:57 INFO - '_': '/tools/buildbot/bin/python'} 23:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:31:57 INFO - Cleaning up... 23:31:57 INFO - Return code: 0 23:31:57 INFO - Running post-action listener: _resource_record_post_action 23:31:57 INFO - Running post-action listener: _start_resource_monitoring 23:31:57 INFO - Starting resource monitoring. 23:31:57 INFO - [mozharness: 2016-10-17 06:31:57.783603Z] Finished create-virtualenv step (success) 23:31:57 INFO - [mozharness: 2016-10-17 06:31:57.784120Z] Running install step. 23:31:57 INFO - Running pre-action listener: _resource_record_pre_action 23:31:57 INFO - Running main action method: install 23:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:31:57 INFO - Reading from file tmpfile_stdout 23:31:58 INFO - Detecting whether we're running mozinstall >=1.0... 23:31:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:31:58 INFO - Reading from file tmpfile_stdout 23:31:58 INFO - Output received: 23:31:58 INFO - Usage: mozinstall [options] installer 23:31:58 INFO - Options: 23:31:58 INFO - -h, --help show this help message and exit 23:31:58 INFO - -d DEST, --destination=DEST 23:31:58 INFO - Directory to install application into. [default: 23:31:58 INFO - "/builds/slave/test"] 23:31:58 INFO - --app=APP Application being installed. [default: firefox] 23:31:58 INFO - mkdir: /builds/slave/test/build/application 23:31:58 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'] 23:31:58 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 23:32:15 INFO - Reading from file tmpfile_stdout 23:32:15 INFO - Output received: 23:32:15 INFO - /builds/slave/test/build/application/firefox/firefox 23:32:15 INFO - Running post-action listener: _resource_record_post_action 23:32:15 INFO - [mozharness: 2016-10-17 06:32:15.115860Z] Finished install step (success) 23:32:15 INFO - [mozharness: 2016-10-17 06:32:15.116136Z] Running run-tests step. 23:32:15 INFO - Running pre-action listener: _resource_record_pre_action 23:32:15 INFO - Running main action method: run_tests 23:32:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:32:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:32:15 INFO - Python 2.7.3 23:32:15 INFO - Return code: 0 23:32:15 INFO - grabbing minidump binary from tooltool 23:32:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:32:15 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 0x17e0930>, '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 0x17e1830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e1cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:32:15 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 23:32:15 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 23:32:15 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 23:32:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:32:15 INFO - Return code: 0 23:32:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:32:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:32:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:32:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:32:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:32:15 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/1476674095/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 23:32:15 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/1476674095/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 23:32:15 INFO - Using env: {'DISPLAY': ':0', 23:32:15 INFO - 'HOME': '/home/cltbld', 23:32:15 INFO - 'LANG': 'en_US.UTF-8', 23:32:15 INFO - 'LANGUAGE': 'en_US:en', 23:32:15 INFO - 'LOGNAME': 'cltbld', 23:32:15 INFO - 'MAIL': '/var/mail/cltbld', 23:32:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:32:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:32:15 INFO - 'MOZ_NO_REMOTE': '1', 23:32:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:32:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:32:15 INFO - 'NO_EM_RESTART': '1', 23:32:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:32:15 INFO - 'PWD': '/builds/slave/test', 23:32:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:32:15 INFO - 'SHELL': '/bin/bash', 23:32:15 INFO - 'SHLVL': '1', 23:32:15 INFO - 'TERM': 'linux', 23:32:15 INFO - 'TMOUT': '86400', 23:32:15 INFO - 'USER': 'cltbld', 23:32:15 INFO - 'XDG_SESSION_COOKIE': 'bb9b54edd4a927dc735d112f000001d9-1476685881.552490-1638668301', 23:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:32:15 INFO - '_': '/tools/buildbot/bin/python'} 23:32:15 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/1476674095/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 23:32:15 INFO - mozversion application_buildid: 20161016201455 23:32:15 INFO - mozversion application_changeset: 687572ea20cb84f1842ad00dcc8ca1712868a361 23:32:15 INFO - mozversion application_display_name: Nightly 23:32:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:32:15 INFO - mozversion application_name: Firefox 23:32:15 INFO - mozversion application_remotingname: firefox 23:32:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:32:15 INFO - mozversion application_vendor: Mozilla 23:32:15 INFO - mozversion application_version: 52.0a1 23:32:15 INFO - mozversion platform_buildid: 20161016201455 23:32:15 INFO - mozversion platform_changeset: 687572ea20cb84f1842ad00dcc8ca1712868a361 23:32:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:32:15 INFO - mozversion platform_version: 52.0a1 23:32:15 INFO - using testdate: 1476685935 23:32:15 INFO - actual date: 1476685935 23:32:15 INFO - starting webserver on 'localhost:59162' 23:32:15 INFO - SUITE-START | Running 2 tests 23:32:15 INFO - TEST-START | dromaeo_css 23:32:15 INFO - operating with platform_type : linux_ 23:32:15 INFO - Initialising browser for dromaeo_css test... 23:32:15 INFO - TEST-INFO | started process 10686 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppwaHFz/profile http://localhost:59162/getInfo.html) 23:32:19 INFO - PROCESS | 10686 | __metrics Screen width/height:1600/1200 23:32:19 INFO - PROCESS | 10686 | colorDepth:24 23:32:19 INFO - PROCESS | 10686 | Browser inner width/height: 1024/697 23:32:19 INFO - PROCESS | 10686 | __metrics 23:32:20 ERROR - PROCESS | 10686 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 23:32:21 INFO - TEST-INFO | 10686: exit 0 23:32:21 INFO - Browser initialized. 23:32:21 INFO - Running cycle 1/1 for dromaeo_css test... 23:32:21 INFO - TEST-INFO | started process 10811 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppwaHFz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:32:33 INFO - PROCESS | 10811 | RSS: Main: 184963072 23:32:33 INFO - PROCESS | 10811 | 23:33:23 INFO - PROCESS | 10811 | 1476686003158 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] 23:35:33 INFO - PROCESS | 10811 | Cycle 1(1): loaded http://localhost:59162/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59162/tests/dromaeo/cssquery-ext.html) 23:35:35 INFO - PROCESS | 10811 | RSS: Main: 201293824 23:35:35 INFO - PROCESS | 10811 | 23:38:37 INFO - PROCESS | 10811 | Cycle 1(1): loaded http://localhost:59162/tests/dromaeo/cssquery-ext.html (next: http://localhost:59162/tests/dromaeo/cssquery-jquery.html) 23:38:38 INFO - PROCESS | 10811 | RSS: Main: 203227136 23:38:38 INFO - PROCESS | 10811 | 23:41:40 INFO - PROCESS | 10811 | Cycle 1(1): loaded http://localhost:59162/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59162/tests/dromaeo/cssquery-mootools.html) 23:41:40 INFO - PROCESS | 10811 | RSS: Main: 204238848 23:41:40 INFO - PROCESS | 10811 | 23:44:42 INFO - PROCESS | 10811 | Cycle 1(1): loaded http://localhost:59162/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59162/tests/dromaeo/cssquery-prototype.html) 23:44:43 INFO - PROCESS | 10811 | RSS: Main: 197206016 23:44:43 INFO - PROCESS | 10811 | 23:47:45 INFO - PROCESS | 10811 | Cycle 1(1): loaded http://localhost:59162/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59162/tests/dromaeo/cssquery-yui.html) 23:47:46 INFO - PROCESS | 10811 | RSS: Main: 199606272 23:47:46 INFO - PROCESS | 10811 | 23:50:49 INFO - PROCESS | 10811 | Cycle 1(1): loaded http://localhost:59162/tests/dromaeo/cssquery-yui.html (next: http://localhost:59162/tests/dromaeo/cssquery-dojo.html) 23:50:49 INFO - PROCESS | 10811 | RSS: Main: 197955584 23:50:49 INFO - PROCESS | 10811 | 23:50:49 INFO - PROCESS | 10811 | __start_tp_report 23:50:49 INFO - PROCESS | 10811 | _x_x_mozilla_page_load 23:50:49 INFO - PROCESS | 10811 | _x_x_mozilla_page_load_details 23:50:49 INFO - PROCESS | 10811 | |i|pagename|runs| 23:50:49 INFO - PROCESS | 10811 | |0;dojo.html;3011.759059275258;3018.8037777544473;3021.456137895178;3025.5764193012983;3038.9544156837637;5090.490950904908;5196.896062078757;5207.6875387476775;5224.660397074197;5327.946720532794;5145.253938178962;5159.71621560814;5274.525292723654;5336.199570064483;5357.330333708286;4684;4729.054189162164;4793.209120495114;4821.252705830602;4878.853634390974;4720.929186062212;4793.32893394925;4831.565159135677;4859;4891.706497610137;4636.09596128755;4666.463356713987;4678.461976872669;4859.514048595148;4931.038447502739;4726.503717109688;4730.148573256813;4756.881077973044;4795.520447955211;4814.6870453420415;4719.551642593948;4725.1730947084125;4732.313814496879;4736.455307639631;4761.999980004203;5077.1876499759865;5081.060003899291;5134;5180.6891586504935;5225.2162175673575;5434.809781657623;5473.972630136864;5485.177223416519;5604.467575580314;5626.240457538221;5568.582356323292;5569.303837020372;5573.944260557383;5583.944160558383;5586.1062230043;5160.329157209539;5203.869903252374;5212.192110222922;5232.110541208004;5264.315638966948;5560.694161821139;5594.608377413542;5634.211210430543;5716.399778023331;5731.8567035824435;5510.641808282448;5512.586556008316;5522.972385138129;5530.640508366943;5569.749361278752;5528.308961379827;5599.0761524348845;5604.915926261027;5612.691301978431;5625.324961004706;5278.81524146653;5281.735913204325;5547.861303467445;5581.413951535112;5608.46719561641;5644.717764111778;5647.011772939802;5649.491545760901;5653.943460565341;5686.943130568641;4320.870373888788;4349.325854492558;4353.9129217415475;4359.346098085249;4420.668449866273;3702.426123950792;3713.090292878262;3810.6951443884423;3835.712321575893;3926.2343842950922;5310;5359.330083739533;5386.865328366744;5425.186222066722;5425.647332923426;5626.1842032905815;5655.519280861091;5665.971670141623;5677.14842773579;5688.971555142198;5192.792288308501;5227.2420499028185;5296.311479507639;5351.759170837244;5441.863953401196;4807.735574543433;4848.393950756155;4855.295982082649;4896.902061958812;4911.557959783637;5845.064789633639;5870.471657550841;5871.618344807659;5879.059350503899;5884.411558844081;5516.889662206813;5573.359063707726;5619.828170365681;5661.971690141523;5736.42635736423;5893.381194974466;5915.615484993462;5956.166136740773;5985.610935289193;6044.909326360196;5596.076647353304;5635.520980716521;5637.379888212376;5642.238297829905;5642.5485961122195;5730.398308177748;5731.140328950524;5736.4550367715;5742.799002034909;5745.195672605755;5274.604404669589;5323.574114070788;5503.064479038493;5553.0837411828215;5554.638948468337;5581.804636837691;5585.385607583082;5586.804461843816;5590;5635.126555383922;5145.61407894402;5209.583233341399;5395.055865223491;5466.890662186814;5484.643498172606;5511.366192887709;5583.134614134816;5593.664380137205;5621.550275977994;5685.800996965252;5464.262324586289;5478.123500239943;5494.615376923737;5496;5503.7798488061635 23:50:49 INFO - PROCESS | 10811 | |1;ext.html;549.527183463974;577.8324285957071;589.2045738253361;589.3193361667276;598.6288501129301;41823.372649410245;43446.56553434465;43514.56485435145;46766.532334676645;46900.29649555251;44211;44223.557764422425;44751.55248447515;44859.77570112153;44884.775576122156;8827.337949653785;8894.421862578944;8965.058668839776;8975.102489751038;9008.324375671818;8697.217250447458;8810.163034511712;8823.426477278988;8876.644934202624;8879.33404994628;8754.168354006391;8914.955425222865;8930.642774289021;8934.195922367018;8965.148310910487;8860.689875854347;8871.157240062184;8879;8883.822323553557;8893.155150260714;8677.132286771335;8792.296616270747;8794.736157915273;8805.911940880573;8806.823863522757;42071.36892946608;42104.36843447351;42165;42232.57767422317;42358;3271.574695289597;3312.801231926092;3450.27544215715;3454.3264063507627;3519.964800352015;28700;31162.688373116205;31649.52525712116;31743;31842.681573184203;4097.938530922039;4102.159057393257;4106.691998100125;4174.3321068628875;4326.464105242625;319667;320103;320256;320923;322255.3887230572;59016.40983590195;59369.40630593725;59372.406275936686;59725.40274597285;59796;62839.371606284265;62903;62998.37001629925;63272.36727632757;63390;17259.568510787332;17441.7383739244;17469;17484;17556.122193890253;13493;13551.661208469866;13572.86427135716;13626.386812593457;13666.93166534161;17717.26949762772;18845.528861778566;18886.3389781357;18995.715064274045;19076.33232836844;7164.498485105993;7338.559686418832;7402.407807375397;7617.352525035434;7704.460687751804;908.8454962656365;1012.5696578953915;1022.1414012229762;1022.8261195596617;1116.7040734205443;31453.68546314553;31535.684643153734;31741.682583174334;32150.35699286001;32221.838890805397;1058.2962330050584;1060.6977011551671;1101.251149218539;1104.751430928051;1168.9426609167926;15533.378664853506;16724.83275167257;16838.747418788727;16852.662946741242;16853.073080980663;470508;486462;487601;487889;489212;55999.44000559942;56246.71876640591;57004.42995570074;57060.144097838565;57289;1338.805873148388;1363.3728484897058;1403.6350548857167;1425.137791636066;1432.6203556057653;29422.264443389085;31220.219494512818;31405;31686.366272673957;32037.67962320347;51061.744691276304;51750.223746643074;51772.74113629408;52014.73992630013;52024.47975520348;468429;471487;471731;473143;473249;41275.58724412838;42190.789046054575;42707.3593896098;42825.143497130506;43001;45535.54464455313;46593.3011004842;46756.53243467522;46929.2960605598;47034.29448558206;39063.41404878872;39505.407418889314;39648;39651;39966.40050399304;36699.63300366962;37344.43983340306;38016;41320.586794132876;41400.58599413967;39366;39799.80100099481;39971;39973;40951.7952410236;33457;36109.45835812517;36437.635623644484;36646.633533664324;36936;27215.59176612313;27932.30169245785;27970.860145699957;28162.2959426016;28200.43599128047 23:50:49 INFO - PROCESS | 10811 | |2;jquery.html;387.6162599026963;391.40506430226037;395.1681710000449;398.3486998757031;421.4794728510289;13813.240271785047;17807.910960445195;18361.081945902686;19457.70813437798;19563.804361956376;17445.21496532656;17635.118244087807;18565.350212742556;19647.115879785408;19822.306219282327;4965.577925876305;5030.195168772988;5096.719680417576;5141.408737995141;5145.691258524501;5075.619328550355;5130.717810520438;5132.332796736419;5134.127198376266;5375.892482150354;5660.235868157808;5779.768809247625;5780.682062486561;5783.421657834225;5784.045632470637;5502.312210973629;5723.341815691187;5741.569382296345;5745.856353591152;5785.334686511063;5665.773369065232;5674.290713660793;5677.034904066319;5687.232223649796;5688.317401911756;12915.483380664762;15586.688266234612;21277.68083478749;23058.538829223322;23190.884045579834;2188.9233876814237;2189.9562008759735;2233.1848875160613;2237;2360.386299562109;9081.818363632756;9425.858612120825;9740.366876153028;9951.55218015191;10131.746706332327;1887.7168424736262;1890.7258447525032;1920.6158768246407;1928.1104517572717;1933.584279379926;83291.5835420825;84951;85673.57163214206;86474.56762716146;86959.13040869574;11008.229423940247;11105.944470277758;11205.719857003478;11213.981483333078;11618.186726929203;12400.317982510867;15956.521304360656;16014.519564413085;16028.435450327892;16046.598835028984;7738.148803631596;7823.647935842901;8034.47775894565;8094.757157285291;8151.592420378957;7848.686052557948;7878.251566101211;7911.604419778988;8122.55325957078;8191.672333106609;4007.6192761687594;4201.180769749931;4212.08350200658;4239.342901850218;4276.786160692015;1879.595886884299;1889.7165425186058;1944.270898413095;2053.158205135917;2098.2551194325792;980.6371642492323;991.4745185051934;1010.3028910052041;1030.8196065688473;1051.2168434516182;19025.42923712291;19184.752991055535;19279.614407712048;19723.506912327306;19830.603387932162;923.2244914272044;970.3498655900563;985.5860538573817;993.5826952679892;1015.1979935850595;9965.750856228507;10987.61543345979;10987.725306867393;10999.780004400027;11014.44927753609;338815;342169;343603;492123;510300;59587;77736.2226377729;90427.54786226027;96627.51686241524;99645.50177249212;982.7199248214367;1000.4497526360473;1040.6669865643073;1044.6448207609449;1049.9947500262297;17155.228014739616;17314.907298359183;18060.81939180644;18161.818381816014;18167.909160454114;40151;40655.59344406518;40938.38592421057;41926.58073419227;42861.57138428576;54527.72736136294;55844.44155558392;56427.15359269697;58781.11828322664;59324.703376482845;8238.546879921661;8280.254777070093;8360.540170290693;8395.370347223861;8605.65577376898;12634.873651263737;12647.241165530098;13092.476300948236;13151.473941042252;13472.9895257858;11168.553257869595;11180.968564146004;11810.940945295219;11817.290962542274;11827.759371755945;11174.888251117385;11255.549778008788;11299.604513841976;11330.660080197607;11557.537698492302;10629.787404251718;10828.296160749525;10956.726081848017;11043.226974112056;11633.185677002528;8314.667413303641;8323.584990551499;8482.109378515168;8498.660053598034;8865;8443.155684431507;10300.433476158883;10777.62278320255;10925.672229833117;11123.886461572276 23:50:49 INFO - PROCESS | 10811 | |3;mootools.html;1442.5744405400405;1475.8376578576356;1591.7214487464698;1672.2140593920867;1731.740238964156;7462.291082347182;7701.075870895486;7985.843822168011;8683.869741953877;8708;8023.558704271278;8454.450460720049;8455.281301089415;8603.91396086039;8632.43889147205;2160.91356345746;2180.8800515971616;2181.5745929543746;2182.8035476807086;2185.25701261571;2240.6975058367075;2245.0682966568857;2322.3613506285737;2326.348622385735;2331.0326214620914;2293.2776175504664;2312.93604941727;2318.686977258074;2320.477892474188;2325.534893021394;2232.944176395595;2254.706888104536;2264.9660255096105;2268.750437451879;2270.727512698487;2198.670199470076;2199.3182113544694;2201.3175915466095;2207.3708992936936;2241.0587553227683;8598.828023439559;8606.741797746077;8630.309575234029;8685.609147588311;8706.956465217634;5024.271480635288;5232.6598771080135;5237.16205407133;5238.97380513095;5249.606279529051;3257.9022629321157;3277.311764529428;3444.156181735466;3466.5666791651042;3489.668481494254;1175.723704929341;1184.7334349771318;1191.3923898811668;1203.9398030098548;1209.2260952990093;11874.465649045813;11907.523699052028;11911.225770324987;11912.940435297767;11951.282923024559;4317.762523061262;4438.381355000565;4582.014866803654;4610.377599024089;4730.834420795256;9896.455694936847;9906.851397229048;9908.20734341251;9951.800963980824;9957.502124893726;5172.948270517322;5180.222966555047;5191.273221748958;5195.636305458582;5208.479152084761;4088.366303223005;4195.517515485697;4713.9764301178275;4762.261849413347;4787.4494433139935;3818.0836599216545;3828.502294701671;3968.960310396859;3988.6011398859882;4020.5175378954714;1285.222440423549;1285.7878450055637;1295.695511554784;1297.4096785962365;1328.023902431712;868.9565521723888;890.1899271662755;902.1339514066569;904.9954750226207;918.9724308270762;5216.686998780086;5258.211268309784;5431.972840135774;5452.372977107604;5486.890262194734;435.62753845462305;445.97547134907893;446.2547545598858;447.95744404281544;449.1869715814386;3772.3775577030033;3825.5791862895057;3844.7116466265143;3850.3454412749898;3968.6825053995613;10184.898151018544;10473.9476302618;10507.369557826554;10547.578096876192;10622.20333474977;10214.029667181605;10316.587336506456;10458.633947811943;10461.790764184674;10474;7911.841763164704;8029.277365037175;8057.0734365548715;8059.073206581201;8094.190580941859;5509.724513774215;5526.796133935746;5529.861753456195;5636.2954630671165;5692.459216374438;9598;9601.807963840824;9684.837819461709;9796.118349348593;9796.608135674493;9651.951740241253;9758.9024109758;9771;9791.363561368487;9856.310058296138;7403.444741644291;7416.629168541659;7430.925690743024;7457.216992215956;7592;7673.462857599914;7801.531908085533;7804.882926756217;7822.295993360625;7833.1383547808555;6960.895586566105;7209.062821833338;7332.78001659951;7412.6664300107705;7415.295546923034;6961.060256865258;7020.403265722471;7100.751473698396;7157.284271572801;7160.248173941869;6581;6610.975298828689;6614.206295244601;6645.9003114954285;6692.966535167293;4675.4155730533685;4797.712137271775;4797.808087676453;4855.514448555257;4885.853424397274;4660.091282200074;4790.257510085942;4854.708717476963;4949.059678661187;5100.923486147785 23:50:49 INFO - PROCESS | 10811 | |4;prototype.html;321.37332202205704;328.4498465071006;332.9633740288568;334.9028781653321;338.8542926541586;5308.362996440423;5433.266509021281;5529;5589.972050139749;5591.245181900442;5224.608154388427;5441.537469315113;5465.398806131322;5484.670919744818;5487.149491828763;4239.2793225151645;4252.766097864616;4257.552956939523;4263.550392866425;4296.5059018213;4169.124483858378;4257.233697934371;4275.722078064931;4313.8783916181865;4334.826606935719;4246.2356775780345;4253.51084625269;4258.382534532491;4259.318509038554;4276.807543660543;4239;4243.745375277494;4261.190373828978;4279.828806847722;4290.184864875664;3592.7305452091196;3732.570754363229;3732.8880133596035;3750.606186350421;3814.408766641175;5284.656497327662;5317.893642127175;5345.946540534584;5378.515933565959;5386;4817.445993710733;4836.347093142416;4865.586425153866;4891.437484689235;4908.680935739166;5517.806876759334;5695.202671625934;5712.971435142797;5732.140178973145;5773.422657734193;4101.97949010256;4121.443605113302;4122.690798190148;4125.463689720347;4146.067134894654;6004.759809607611;6025.668588227646;6031.095335699636;6036.96981515094;6043.939560604382;4115;4146.523149837807;4148.854790082332;4159.750414975111;4184.142250838631;4181.26827805139;4201.45381100455;4215.683823713233;4238.682098842599;4250.872473825791;4803.879903002383;4824.421069471616;4847.151748444008;4855.562999330006;4863.9513604864205;5523.7790488380815;5725.736330291694;5739.282589676291;5770.596058275881;5794.594378393472;1411.5835828430431;1448.5726710620393;1458.2646650485888;1458.824941007086;1462.5173692681603;880.9383343165916;923.0354279777514;935.373299889076;938.5260443476001;940.9320421321848;4815.903681926342;4840.394950631171;4872.171730805771;4889.266610008456;4905.828296009622;5065.822696205689;5066.949330506722;5114.514121158484;5153.4073581538605;5163.793448262102;4785.976070119627;4820.421549414023;4856.3201151838775;4905.601903457497;5131.974340128276;3092.2578581140815;3102.64319603244;3135.153508552678;3172.460681684119;3185.442547554169;6152.938470615326;6161.353057928943;6182;6201.651108401413;6213.099100630474;5813.273340832396;5866.823995280149;5905.527557795366;5907.586468947218;5924.674142922181;5995.700214989321;6093.329733729286;6103.8474038148515;6119;6126.479249263773;5624.268845050281;5922.5261979040715;5964.224650795369;5974.342822289458;6003.159557662018;5776.508996735157;5789;5801.564882633735;5868.413158684098;5893.6463812171405;6094.177286066324;6135;6186.412290832363;6188.597741146811;6207.844803879939;3936.7441116327345;4122.299209134394;4156.418101465737;4160.209560183555;4164.3961625564725;5662.575306852085;5849.385814489588;5874.856951531081;5896.086106653475;5901.262342207224;5581.916271255853;5674.829755107354;5708.286464191976;5755.539556835527;5817.883642327214;5762.654240745569;5771.047777116729;5772.682502462405;5787.363390027178;5800.651960882361;5598.10430331145;5625.943740562542;5657.227958300486;5660.9150862737915;5679.77280908759;5735.7418916148035;5761.942380576141;5774.682392468455;5779.543693930147;5802.622829516068;5388.488093631099;5618.775248989995;5623.156526521055;5638.436156384329;5656.943430565806 23:50:49 INFO - PROCESS | 10811 | |5;yui.html;747.2490147401863;765.7932358263268;784.3990642603851;803.533950308821;867.4491697771915;13548.18710877348;14200.644983875396;14230.146191228509;14234.359453824576;14248.857511424896;14637.92681036596;14894.627634309149;14946.103233805952;15024.17367044812;15112.924435377809;789.4947233770378;808.9919100809005;811.3225456743626;812.8496228197773;813.2314962360572;797.2505844506146;825.8018075661828;826.7230477789917;829.9253067223949;831.0816547714779;864.2006144316514;868.0278088540844;868.2576397180414;872.0276891266225;872.289084396215;860.8407444622765;863.2489733931488;867.9783005424852;869.7347309070731;870.7431307764225;636.5289685632645;637.3339859846425;637.7098420218789;638.1894993358409;638.7668500997103;14513.274336283144;14554.417823287056;14578.562643120616;14609.70780584393;14624.26878656063;14982.475613353588;15184.848151518454;15271.541853744295;15300.693986120326;15493.535193944199;11450.8569464714;11776.88223117775;11879.703007424798;11898.762024759457;12728.80906786399;3797.905052373685;3812.8474861005525;3917.2557214129224;3991.5409727881374;3996.7402118862183;56620;57413.42586574123;57427.712861435844;57822.7108864453;77876.22123778747;11401;11513.194076414738;11609.825852612217;11765.941170294265;11813.763724725457;21575.029123689157;21644.675329870064;21648.35054948354;21649.13403463875;21656.675149872764;8266.214709602578;8342.082370939192;8677.958644962644;8813.559322033872;8839;4774.522547745267;4778.641601879873;4962.404511458648;4976.626752993468;5108.361454818148;3607.7835329879767;3733.701303895682;3757.4739536464917;3759.436084587334;3799.905002374963;628.0673200297555;638.7700427845972;649.5777744466135;660.9688885338886;665.5208250059949;671.9025741267488;730.8647900138385;737.1189941892387;753.3634079203065;775.3483087839602;8926.330525210635;9065.501397423073;9308;9763.090537510563;10232.846507302396;724.3625609463638;737.4616529933072;737.8782500887401;738.7229788829189;745.8327717122686;4662.463816661059;4862.465128835825;4921.384826896638;4974.427940786783;4977.626677999165;93810;97634.23657634322;97918.51040744751;113862;127186.36406817907;89547;92785;92817.53591232;94059.52970235242;98256;53629;74848;76691.61654191805;85192;88720;9182.586783594888;9765.951170244103;9831.852522212315;9864.605415783288;9876.012613630071;48011.519884800706;49435.258471122244;49451.50548494469;49864;51007.48992510027;66487;73554;73678.42180516498;75947.62026189834;76980.23019769731;13316.201027938354;13338.666533336744;13511.189328640314;13822.93088534551;14211.644708881948;14594.635134121732;14726.337314821074;14896;15050;15074.664591686515;14060.929695351459;14266.407259441945;14364.712705745618;15374.846251537789;15399.923000384926;13670.691853977458;13833.170009799444;14474.638134046312;14709.117452952856;15306.15816130079;13378.799318010042;13927.442902283796;14005.859941400864;14052.718945620825;14123.364448600043;10646.148308135176;10672.62645807393;10778.29941053829;10898.291611045257;11501.884981150417;10291.897081029094;10446.843297350393;11769.823452648046;12076.319864142439;12324.137310388187 23:50:49 INFO - PROCESS | 10811 | __end_tp_report 23:50:49 INFO - PROCESS | 10811 | __start_cc_report 23:50:49 INFO - PROCESS | 10811 | _x_x_mozilla_cycle_collect,342 23:50:49 INFO - PROCESS | 10811 | __end_cc_report 23:50:49 INFO - PROCESS | 10811 | __startTimestamp1476687049850__endTimestamp 23:50:49 INFO - PROCESS | 10811 | 23:50:49 INFO - PROCESS | 10811 | ------- Summary: start ------- 23:50:49 INFO - PROCESS | 10811 | Number of tests: 6 23:50:49 INFO - PROCESS | 10811 | 23:50:49 INFO - PROCESS | 10811 | [#0] dojo.html Cycles:165 Average:5222.32 Median:5441.86 stddev:604.26 (11.1%) stddev-sans-first:580.69 23:50:49 INFO - PROCESS | 10811 | Values: 3011.8 3018.8 3021.5 3025.6 3039.0 5090.5 5196.9 5207.7 5224.7 5327.9 5145.3 5159.7 5274.5 5336.2 5357.3 4684.0 4729.1 4793.2 4821.3 4878.9 4720.9 4793.3 4831.6 4859.0 4891.7 4636.1 4666.5 4678.5 4859.5 4931.0 4726.5 4730.1 4756.9 4795.5 4814.7 4719.6 4725.2 4732.3 4736.5 4762.0 5077.2 5081.1 5134.0 5180.7 5225.2 5434.8 5474.0 5485.2 5604.5 5626.2 5568.6 5569.3 5573.9 5583.9 5586.1 5160.3 5203.9 5212.2 5232.1 5264.3 5560.7 5594.6 5634.2 5716.4 5731.9 5510.6 5512.6 5523.0 5530.6 5569.7 5528.3 5599.1 5604.9 5612.7 5625.3 5278.8 5281.7 5547.9 5581.4 5608.5 5644.7 5647.0 5649.5 5653.9 5686.9 4320.9 4349.3 4353.9 4359.3 4420.7 3702.4 3713.1 3810.7 3835.7 3926.2 5310.0 5359.3 5386.9 5425.2 5425.6 5626.2 5655.5 5666.0 5677.1 5689.0 5192.8 5227.2 5296.3 5351.8 5441.9 4807.7 4848.4 4855.3 4896.9 4911.6 5845.1 5870.5 5871.6 5879.1 5884.4 5516.9 5573.4 5619.8 5662.0 5736.4 5893.4 5915.6 5956.2 5985.6 6044.9 5596.1 5635.5 5637.4 5642.2 5642.5 5730.4 5731.1 5736.5 5742.8 5745.2 5274.6 5323.6 5503.1 5553.1 5554.6 5581.8 5585.4 5586.8 5590.0 5635.1 5145.6 5209.6 5395.1 5466.9 5484.6 5511.4 5583.1 5593.7 5621.6 5685.8 5464.3 5478.1 5494.6 5496.0 5503.8 23:50:49 INFO - PROCESS | 10811 | 23:50:49 INFO - PROCESS | 10811 | [#1] ext.html Cycles:180 Average:59273.09 Median:42087.87 stddev:114311.70 (271.6%) stddev-sans-first:114547.34 23:50:49 INFO - PROCESS | 10811 | Values: 549.5 577.8 589.2 589.3 598.6 41823.4 43446.6 43514.6 46766.5 46900.3 44211.0 44223.6 44751.6 44859.8 44884.8 8827.3 8894.4 8965.1 8975.1 9008.3 8697.2 8810.2 8823.4 8876.6 8879.3 8754.2 8915.0 8930.6 8934.2 8965.1 8860.7 8871.2 8879.0 8883.8 8893.2 8677.1 8792.3 8794.7 8805.9 8806.8 42071.4 42104.4 42165.0 42232.6 42358.0 3271.6 3312.8 3450.3 3454.3 3520.0 28700.0 31162.7 31649.5 31743.0 31842.7 4097.9 4102.2 4106.7 4174.3 4326.5 319667.0 320103.0 320256.0 320923.0 322255.4 59016.4 59369.4 59372.4 59725.4 59796.0 62839.4 62903.0 62998.4 63272.4 63390.0 17259.6 17441.7 17469.0 17484.0 17556.1 13493.0 13551.7 13572.9 13626.4 13666.9 17717.3 18845.5 18886.3 18995.7 19076.3 7164.5 7338.6 7402.4 7617.4 7704.5 908.8 1012.6 1022.1 1022.8 1116.7 31453.7 31535.7 31741.7 32150.4 32221.8 1058.3 1060.7 1101.3 1104.8 1168.9 15533.4 16724.8 16838.7 16852.7 16853.1 470508.0 486462.0 487601.0 487889.0 489212.0 55999.4 56246.7 57004.4 57060.1 57289.0 1338.8 1363.4 1403.6 1425.1 1432.6 29422.3 31220.2 31405.0 31686.4 32037.7 51061.7 51750.2 51772.7 52014.7 52024.5 468429.0 471487.0 471731.0 473143.0 473249.0 41275.6 42190.8 42707.4 42825.1 43001.0 45535.5 46593.3 46756.5 46929.3 47034.3 39063.4 39505.4 39648.0 39651.0 39966.4 36699.6 37344.4 38016.0 41320.6 41400.6 39366.0 39799.8 39971.0 39973.0 40951.8 33457.0 36109.5 36437.6 36646.6 36936.0 27215.6 27932.3 27970.9 28162.3 28200.4 23:50:49 INFO - PROCESS | 10811 | 23:50:49 INFO - PROCESS | 10811 | [#2] jquery.html Cycles:180 Average:26247.49 Median:389.51 stddev:68668.45 (17629.4%) stddev-sans-first:68833.64 23:50:49 INFO - PROCESS | 10811 | Values: 387.6 391.4 395.2 398.3 421.5 13813.2 17807.9 18361.1 19457.7 19563.8 17445.2 17635.1 18565.4 19647.1 19822.3 4965.6 5030.2 5096.7 5141.4 5145.7 5075.6 5130.7 5132.3 5134.1 5375.9 5660.2 5779.8 5780.7 5783.4 5784.0 5502.3 5723.3 5741.6 5745.9 5785.3 5665.8 5674.3 5677.0 5687.2 5688.3 12915.5 15586.7 21277.7 23058.5 23190.9 2188.9 2190.0 2233.2 2237.0 2360.4 9081.8 9425.9 9740.4 9951.6 10131.7 1887.7 1890.7 1920.6 1928.1 1933.6 83291.6 84951.0 85673.6 86474.6 86959.1 11008.2 11105.9 11205.7 11214.0 11618.2 12400.3 15956.5 16014.5 16028.4 16046.6 7738.1 7823.6 8034.5 8094.8 8151.6 7848.7 7878.3 7911.6 8122.6 8191.7 4007.6 4201.2 4212.1 4239.3 4276.8 1879.6 1889.7 1944.3 2053.2 2098.3 980.6 991.5 1010.3 1030.8 1051.2 19025.4 19184.8 19279.6 19723.5 19830.6 923.2 970.3 985.6 993.6 1015.2 9965.8 10987.6 10987.7 10999.8 11014.4 338815.0 342169.0 343603.0 492123.0 510300.0 59587.0 77736.2 90427.5 96627.5 99645.5 982.7 1000.4 1040.7 1044.6 1050.0 17155.2 17314.9 18060.8 18161.8 18167.9 40151.0 40655.6 40938.4 41926.6 42861.6 54527.7 55844.4 56427.2 58781.1 59324.7 8238.5 8280.3 8360.5 8395.4 8605.7 12634.9 12647.2 13092.5 13151.5 13473.0 11168.6 11181.0 11810.9 11817.3 11827.8 11174.9 11255.5 11299.6 11330.7 11557.5 10629.8 10828.3 10956.7 11043.2 11633.2 8314.7 8323.6 8482.1 8498.7 8865.0 8443.2 10300.4 10777.6 10925.7 11123.9 23:50:49 INFO - PROCESS | 10811 | 23:50:49 INFO - PROCESS | 10811 | [#3] mootools.html Cycles:180 Average:5541.03 Median:4855.11 stddev:3157.79 (65.0%) stddev-sans-first:3151.63 23:50:49 INFO - PROCESS | 10811 | Values: 1442.6 1475.8 1591.7 1672.2 1731.7 7462.3 7701.1 7985.8 8683.9 8708.0 8023.6 8454.5 8455.3 8603.9 8632.4 2160.9 2180.9 2181.6 2182.8 2185.3 2240.7 2245.1 2322.4 2326.3 2331.0 2293.3 2312.9 2318.7 2320.5 2325.5 2232.9 2254.7 2265.0 2268.8 2270.7 2198.7 2199.3 2201.3 2207.4 2241.1 8598.8 8606.7 8630.3 8685.6 8707.0 5024.3 5232.7 5237.2 5239.0 5249.6 3257.9 3277.3 3444.2 3466.6 3489.7 1175.7 1184.7 1191.4 1203.9 1209.2 11874.5 11907.5 11911.2 11912.9 11951.3 4317.8 4438.4 4582.0 4610.4 4730.8 9896.5 9906.9 9908.2 9951.8 9957.5 5172.9 5180.2 5191.3 5195.6 5208.5 4088.4 4195.5 4714.0 4762.3 4787.4 3818.1 3828.5 3969.0 3988.6 4020.5 1285.2 1285.8 1295.7 1297.4 1328.0 869.0 890.2 902.1 905.0 919.0 5216.7 5258.2 5432.0 5452.4 5486.9 435.6 446.0 446.3 448.0 449.2 3772.4 3825.6 3844.7 3850.3 3968.7 10184.9 10473.9 10507.4 10547.6 10622.2 10214.0 10316.6 10458.6 10461.8 10474.0 7911.8 8029.3 8057.1 8059.1 8094.2 5509.7 5526.8 5529.9 5636.3 5692.5 9598.0 9601.8 9684.8 9796.1 9796.6 9652.0 9758.9 9771.0 9791.4 9856.3 7403.4 7416.6 7430.9 7457.2 7592.0 7673.5 7801.5 7804.9 7822.3 7833.1 6960.9 7209.1 7332.8 7412.7 7415.3 6961.1 7020.4 7100.8 7157.3 7160.2 6581.0 6611.0 6614.2 6645.9 6693.0 4675.4 4797.7 4797.8 4855.5 4885.9 4660.1 4790.3 4854.7 4949.1 5100.9 23:50:49 INFO - PROCESS | 10811 | 23:50:49 INFO - PROCESS | 10811 | [#4] prototype.html Cycles:180 Average:4773.39 Median:5382.26 stddev:1413.14 (26.3%) stddev-sans-first:1377.02 23:50:49 INFO - PROCESS | 10811 | Values: 321.4 328.4 333.0 334.9 338.9 5308.4 5433.3 5529.0 5590.0 5591.2 5224.6 5441.5 5465.4 5484.7 5487.1 4239.3 4252.8 4257.6 4263.6 4296.5 4169.1 4257.2 4275.7 4313.9 4334.8 4246.2 4253.5 4258.4 4259.3 4276.8 4239.0 4243.7 4261.2 4279.8 4290.2 3592.7 3732.6 3732.9 3750.6 3814.4 5284.7 5317.9 5345.9 5378.5 5386.0 4817.4 4836.3 4865.6 4891.4 4908.7 5517.8 5695.2 5713.0 5732.1 5773.4 4102.0 4121.4 4122.7 4125.5 4146.1 6004.8 6025.7 6031.1 6037.0 6043.9 4115.0 4146.5 4148.9 4159.8 4184.1 4181.3 4201.5 4215.7 4238.7 4250.9 4803.9 4824.4 4847.2 4855.6 4864.0 5523.8 5725.7 5739.3 5770.6 5794.6 1411.6 1448.6 1458.3 1458.8 1462.5 880.9 923.0 935.4 938.5 940.9 4815.9 4840.4 4872.2 4889.3 4905.8 5065.8 5066.9 5114.5 5153.4 5163.8 4786.0 4820.4 4856.3 4905.6 5132.0 3092.3 3102.6 3135.2 3172.5 3185.4 6152.9 6161.4 6182.0 6201.7 6213.1 5813.3 5866.8 5905.5 5907.6 5924.7 5995.7 6093.3 6103.8 6119.0 6126.5 5624.3 5922.5 5964.2 5974.3 6003.2 5776.5 5789.0 5801.6 5868.4 5893.6 6094.2 6135.0 6186.4 6188.6 6207.8 3936.7 4122.3 4156.4 4160.2 4164.4 5662.6 5849.4 5874.9 5896.1 5901.3 5581.9 5674.8 5708.3 5755.5 5817.9 5762.7 5771.0 5772.7 5787.4 5800.7 5598.1 5625.9 5657.2 5660.9 5679.8 5735.7 5761.9 5774.7 5779.5 5802.6 5388.5 5618.8 5623.2 5638.4 5656.9 23:50:49 INFO - PROCESS | 10811 | 23:50:49 INFO - PROCESS | 10811 | [#5] yui.html Cycles:180 Average:19711.89 Median:27206.95 stddev:27455.36 (100.9%) stddev-sans-first:27495.45 23:50:49 INFO - PROCESS | 10811 | Values: 747.2 765.8 784.4 803.5 867.4 13548.2 14200.6 14230.1 14234.4 14248.9 14637.9 14894.6 14946.1 15024.2 15112.9 789.5 809.0 811.3 812.8 813.2 797.3 825.8 826.7 829.9 831.1 864.2 868.0 868.3 872.0 872.3 860.8 863.2 868.0 869.7 870.7 636.5 637.3 637.7 638.2 638.8 14513.3 14554.4 14578.6 14609.7 14624.3 14982.5 15184.8 15271.5 15300.7 15493.5 11450.9 11776.9 11879.7 11898.8 12728.8 3797.9 3812.8 3917.3 3991.5 3996.7 56620.0 57413.4 57427.7 57822.7 77876.2 11401.0 11513.2 11609.8 11765.9 11813.8 21575.0 21644.7 21648.4 21649.1 21656.7 8266.2 8342.1 8678.0 8813.6 8839.0 4774.5 4778.6 4962.4 4976.6 5108.4 3607.8 3733.7 3757.5 3759.4 3799.9 628.1 638.8 649.6 661.0 665.5 671.9 730.9 737.1 753.4 775.3 8926.3 9065.5 9308.0 9763.1 10232.8 724.4 737.5 737.9 738.7 745.8 4662.5 4862.5 4921.4 4974.4 4977.6 93810.0 97634.2 97918.5 113862.0 127186.4 89547.0 92785.0 92817.5 94059.5 98256.0 53629.0 74848.0 76691.6 85192.0 88720.0 9182.6 9766.0 9831.9 9864.6 9876.0 48011.5 49435.3 49451.5 49864.0 51007.5 66487.0 73554.0 73678.4 75947.6 76980.2 13316.2 13338.7 13511.2 13822.9 14211.6 14594.6 14726.3 14896.0 15050.0 15074.7 14060.9 14266.4 14364.7 15374.8 15399.9 13670.7 13833.2 14474.6 14709.1 15306.2 13378.8 13927.4 14005.9 14052.7 14123.4 10646.1 10672.6 10778.3 10898.3 11501.9 10291.9 10446.8 11769.8 12076.3 12324.1 23:50:49 INFO - PROCESS | 10811 | -------- Summary: end -------- 23:50:49 INFO - PROCESS | 10811 | 23:50:50 INFO - TEST-INFO | 10811: exit 0 23:50:50 INFO - TEST-OK | dromaeo_css | took 1115407ms 23:50:50 INFO - TEST-START | kraken 23:50:50 INFO - operating with platform_type : linux_ 23:50:50 INFO - Initialising browser for kraken test... 23:50:50 INFO - TEST-INFO | started process 11171 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2FmB23/profile http://localhost:59162/getInfo.html) 23:50:55 INFO - PROCESS | 11171 | __metrics Screen width/height:1600/1200 23:50:55 INFO - PROCESS | 11171 | colorDepth:24 23:50:55 INFO - PROCESS | 11171 | Browser inner width/height: 1024/697 23:50:55 INFO - PROCESS | 11171 | __metrics 23:50:55 ERROR - PROCESS | 11171 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 23:50:56 INFO - TEST-INFO | 11171: exit 0 23:50:56 INFO - Browser initialized. 23:50:56 INFO - Running cycle 1/1 for kraken test... 23:50:56 INFO - TEST-INFO | started process 11294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2FmB23/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:51:09 INFO - PROCESS | 11294 | RSS: Main: 184774656 23:51:09 INFO - PROCESS | 11294 | 23:51:11 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59162/tests/kraken/driver.html?testName=audio-beat-detection) 23:51:12 INFO - PROCESS | 11294 | RSS: Main: 198860800 23:51:12 INFO - PROCESS | 11294 | 23:51:15 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59162/tests/kraken/driver.html?testName=audio-dft) 23:51:16 INFO - PROCESS | 11294 | RSS: Main: 196526080 23:51:16 INFO - PROCESS | 11294 | 23:51:18 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59162/tests/kraken/driver.html?testName=audio-fft) 23:51:19 INFO - PROCESS | 11294 | RSS: Main: 192217088 23:51:19 INFO - PROCESS | 11294 | 23:51:21 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59162/tests/kraken/driver.html?testName=audio-oscillator) 23:51:22 INFO - PROCESS | 11294 | RSS: Main: 193208320 23:51:22 INFO - PROCESS | 11294 | 23:51:24 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59162/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:51:25 INFO - PROCESS | 11294 | RSS: Main: 193236992 23:51:25 INFO - PROCESS | 11294 | 23:51:28 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59162/tests/kraken/driver.html?testName=imaging-darkroom) 23:51:28 INFO - PROCESS | 11294 | RSS: Main: 193753088 23:51:28 INFO - PROCESS | 11294 | 23:51:32 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59162/tests/kraken/driver.html?testName=imaging-desaturate) 23:51:32 INFO - PROCESS | 11294 | RSS: Main: 192311296 23:51:32 INFO - PROCESS | 11294 | 23:51:35 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59162/tests/kraken/driver.html?testName=json-parse-financial) 23:51:36 INFO - PROCESS | 11294 | RSS: Main: 193052672 23:51:36 INFO - PROCESS | 11294 | 23:51:38 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59162/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:51:38 INFO - PROCESS | 11294 | RSS: Main: 193290240 23:51:38 INFO - PROCESS | 11294 | 23:51:40 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59162/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:51:41 INFO - PROCESS | 11294 | RSS: Main: 193216512 23:51:41 INFO - PROCESS | 11294 | 23:51:43 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59162/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:51:43 INFO - PROCESS | 11294 | RSS: Main: 193605632 23:51:43 INFO - PROCESS | 11294 | 23:51:46 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:51:47 INFO - PROCESS | 11294 | RSS: Main: 193843200 23:51:47 INFO - PROCESS | 11294 | 23:51:50 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:51:50 INFO - PROCESS | 11294 | RSS: Main: 194207744 23:51:50 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | Cycle 1(1): loaded http://localhost:59162/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59162/tests/kraken/driver.html?testName=ai-astar) 23:51:52 INFO - PROCESS | 11294 | RSS: Main: 195375104 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | __start_tp_report 23:51:52 INFO - PROCESS | 11294 | _x_x_mozilla_page_load 23:51:52 INFO - PROCESS | 11294 | _x_x_mozilla_page_load_details 23:51:52 INFO - PROCESS | 11294 | |i|pagename|runs| 23:51:52 INFO - PROCESS | 11294 | |0;ai-astar;104;112;112;112;111;110;111;111;109;114 23:51:52 INFO - PROCESS | 11294 | |1;audio-beat-detection;158;136;126;169;129;126;124;125;159;124 23:51:52 INFO - PROCESS | 11294 | |2;audio-dft;163;172;168;176;165;164;162;167;163;162 23:51:52 INFO - PROCESS | 11294 | |3;audio-fft;87;86;77;112;77;76;76;76;119;76 23:51:52 INFO - PROCESS | 11294 | |4;audio-oscillator;83;84;120;83;83;82;102;85;81;113 23:51:52 INFO - PROCESS | 11294 | |5;imaging-gaussian-blur;119;119;117;118;117;118;118;118;118;119 23:51:52 INFO - PROCESS | 11294 | |6;imaging-darkroom;147;148;147;148;146;147;149;147;147;148 23:51:52 INFO - PROCESS | 11294 | |7;imaging-desaturate;96;96;96;96;96;96;96;95;100;97 23:51:52 INFO - PROCESS | 11294 | |8;json-parse-financial;57;56;54;57;56;69;54;55;55;54 23:51:52 INFO - PROCESS | 11294 | |9;json-stringify-tinderbox;61;61;61;61;61;62;61;61;65;61 23:51:52 INFO - PROCESS | 11294 | |10;stanford-crypto-aes;83;82;80;81;81;80;82;80;81;80 23:51:52 INFO - PROCESS | 11294 | |11;stanford-crypto-ccm;142;136;135;136;132;135;138;149;170;139 23:51:52 INFO - PROCESS | 11294 | |12;stanford-crypto-pbkdf2;167;172;163;167;170;164;168;168;164;165 23:51:52 INFO - PROCESS | 11294 | |13;stanford-crypto-sha256-iterative;67;66;66;74;67;66;72;66;63;66 23:51:52 INFO - PROCESS | 11294 | __end_tp_report 23:51:52 INFO - PROCESS | 11294 | __start_cc_report 23:51:52 INFO - PROCESS | 11294 | _x_x_mozilla_cycle_collect,792 23:51:52 INFO - PROCESS | 11294 | __end_cc_report 23:51:52 INFO - PROCESS | 11294 | __startTimestamp1476687112817__endTimestamp 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | ------- Summary: start ------- 23:51:52 INFO - PROCESS | 11294 | Number of tests: 14 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#0] ai-astar Cycles:10 Average:110.60 Median:111.50 stddev:2.67 (2.4%) stddev-sans-first:1.41 23:51:52 INFO - PROCESS | 11294 | Values: 104.0 112.0 112.0 112.0 111.0 110.0 111.0 111.0 109.0 114.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:132.50 stddev:17.43 (13.2%) stddev-sans-first:16.85 23:51:52 INFO - PROCESS | 11294 | Values: 158.0 136.0 126.0 169.0 129.0 126.0 124.0 125.0 159.0 124.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#2] audio-dft Cycles:10 Average:166.20 Median:166.00 stddev:4.66 (2.8%) stddev-sans-first:4.80 23:51:52 INFO - PROCESS | 11294 | Values: 163.0 172.0 168.0 176.0 165.0 164.0 162.0 167.0 163.0 162.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#3] audio-fft Cycles:10 Average:86.20 Median:76.50 stddev:16.08 (21.0%) stddev-sans-first:17.05 23:51:52 INFO - PROCESS | 11294 | Values: 87.0 86.0 77.0 112.0 77.0 76.0 76.0 76.0 119.0 76.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:83.00 stddev:14.53 (17.5%) stddev-sans-first:15.08 23:51:52 INFO - PROCESS | 11294 | Values: 83.0 84.0 120.0 83.0 83.0 82.0 102.0 85.0 81.0 113.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:0.74 (0.6%) stddev-sans-first:0.71 23:51:52 INFO - PROCESS | 11294 | Values: 119.0 119.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 119.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#6] imaging-darkroom Cycles:10 Average:147.40 Median:147.50 stddev:0.84 (0.6%) stddev-sans-first:0.88 23:51:52 INFO - PROCESS | 11294 | Values: 147.0 148.0 147.0 148.0 146.0 147.0 149.0 147.0 147.0 148.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.00 stddev:1.35 (1.4%) stddev-sans-first:1.42 23:51:52 INFO - PROCESS | 11294 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 95.0 100.0 97.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:4.47 (8.0%) stddev-sans-first:4.74 23:51:52 INFO - PROCESS | 11294 | Values: 57.0 56.0 54.0 57.0 56.0 69.0 54.0 55.0 55.0 54.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#9] json-stringify-tinderbox Cycles:10 Average:61.50 Median:61.00 stddev:1.27 (2.1%) stddev-sans-first:1.33 23:51:52 INFO - PROCESS | 11294 | Values: 61.0 61.0 61.0 61.0 61.0 62.0 61.0 61.0 65.0 61.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#10] stanford-crypto-aes Cycles:10 Average:81.00 Median:81.00 stddev:1.05 (1.3%) stddev-sans-first:0.83 23:51:52 INFO - PROCESS | 11294 | Values: 83.0 82.0 80.0 81.0 81.0 80.0 82.0 80.0 81.0 80.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#11] stanford-crypto-ccm Cycles:10 Average:141.20 Median:138.50 stddev:11.16 (8.1%) stddev-sans-first:11.84 23:51:52 INFO - PROCESS | 11294 | Values: 142.0 136.0 135.0 136.0 132.0 135.0 138.0 149.0 170.0 139.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.80 Median:167.50 stddev:2.86 (1.7%) stddev-sans-first:3.03 23:51:52 INFO - PROCESS | 11294 | Values: 167.0 172.0 163.0 167.0 170.0 164.0 168.0 168.0 164.0 165.0 23:51:52 INFO - PROCESS | 11294 | 23:51:52 INFO - PROCESS | 11294 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:66.50 stddev:3.23 (4.9%) stddev-sans-first:3.43 23:51:52 INFO - PROCESS | 11294 | Values: 67.0 66.0 66.0 74.0 67.0 66.0 72.0 66.0 63.0 66.0 23:51:52 INFO - PROCESS | 11294 | -------- Summary: end -------- 23:51:52 INFO - PROCESS | 11294 | 23:51:53 INFO - PROCESS | 11294 | 23:51:53 INFO - PROCESS | 11294 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:51:53 INFO - PROCESS | 11294 | 23:51:53 INFO - PROCESS | 11294 | 23:51:53 INFO - PROCESS | 11294 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:51:53 INFO - PROCESS | 11294 | 23:51:53 INFO - PROCESS | 11294 | 23:51:53 INFO - PROCESS | 11294 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:51:53 INFO - PROCESS | 11294 | 23:51:53 INFO - PROCESS | 11294 | 23:51:53 INFO - PROCESS | 11294 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 23:51:53 INFO - PROCESS | 11294 | 23:51:53 INFO - PROCESS | 11294 | 23:51:53 INFO - PROCESS | 11294 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 23:51:53 INFO - PROCESS | 11294 | 23:51:53 INFO - TEST-INFO | 11294: exit 0 23:51:53 INFO - TEST-OK | kraken | took 63179ms 23:51:53 INFO - SUITE-END | took 1178s 23:51:53 INFO - Completed test suite (00:19:38) 23:51:53 INFO - javascript benchmark 23:51:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7151.334161910026, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3011.759059275258, 3018.8037777544473, 3021.456137895178, 3025.5764193012983, 3038.9544156837637, 5090.490950904908, 5196.896062078757, 5207.6875387476775, 5224.660397074197, 5327.946720532794, 5145.253938178962, 5159.71621560814, 5274.525292723654, 5336.199570064483, 5357.330333708286, 4684.0, 4729.054189162164, 4793.209120495114, 4821.252705830602, 4878.853634390974, 4720.929186062212, 4793.32893394925, 4831.565159135677, 4859.0, 4891.706497610137, 4636.09596128755, 4666.463356713987, 4678.461976872669, 4859.514048595148, 4931.038447502739, 4726.503717109688, 4730.148573256813, 4756.881077973044, 4795.520447955211, 4814.6870453420415, 4719.551642593948, 4725.1730947084125, 4732.313814496879, 4736.455307639631, 4761.999980004203, 5077.1876499759865, 5081.060003899291, 5134.0, 5180.6891586504935, 5225.2162175673575, 5434.809781657623, 5473.972630136864, 5485.177223416519, 5604.467575580314, 5626.240457538221, 5568.582356323292, 5569.303837020372, 5573.944260557383, 5583.944160558383, 5586.1062230043, 5160.329157209539, 5203.869903252374, 5212.192110222922, 5232.110541208004, 5264.315638966948, 5560.694161821139, 5594.608377413542, 5634.211210430543, 5716.399778023331, 5731.8567035824435, 5510.641808282448, 5512.586556008316, 5522.972385138129, 5530.640508366943, 5569.749361278752, 5528.308961379827, 5599.0761524348845, 5604.915926261027, 5612.691301978431, 5625.324961004706, 5278.81524146653, 5281.735913204325, 5547.861303467445, 5581.413951535112, 5608.46719561641, 5644.717764111778, 5647.011772939802, 5649.491545760901, 5653.943460565341, 5686.943130568641, 4320.870373888788, 4349.325854492558, 4353.9129217415475, 4359.346098085249, 4420.668449866273, 3702.426123950792, 3713.090292878262, 3810.6951443884423, 3835.712321575893, 3926.2343842950922, 5310.0, 5359.330083739533, 5386.865328366744, 5425.186222066722, 5425.647332923426, 5626.1842032905815, 5655.519280861091, 5665.971670141623, 5677.14842773579, 5688.971555142198, 5192.792288308501, 5227.2420499028185, 5296.311479507639, 5351.759170837244, 5441.863953401196, 4807.735574543433, 4848.393950756155, 4855.295982082649, 4896.902061958812, 4911.557959783637, 5845.064789633639, 5870.471657550841, 5871.618344807659, 5879.059350503899, 5884.411558844081, 5516.889662206813, 5573.359063707726, 5619.828170365681, 5661.971690141523, 5736.42635736423, 5893.381194974466, 5915.615484993462, 5956.166136740773, 5985.610935289193, 6044.909326360196, 5596.076647353304, 5635.520980716521, 5637.379888212376, 5642.238297829905, 5642.5485961122195, 5730.398308177748, 5731.140328950524, 5736.4550367715, 5742.799002034909, 5745.195672605755, 5274.604404669589, 5323.574114070788, 5503.064479038493, 5553.0837411828215, 5554.638948468337, 5581.804636837691, 5585.385607583082, 5586.804461843816, 5590.0, 5635.126555383922, 5145.61407894402, 5209.583233341399, 5395.055865223491, 5466.890662186814, 5484.643498172606, 5511.366192887709, 5583.134614134816, 5593.664380137205, 5621.550275977994, 5685.800996965252, 5464.262324586289, 5478.123500239943, 5494.615376923737, 5496.0, 5503.7798488061635], "value": 5181.014285445334, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.527183463974, 577.8324285957071, 589.2045738253361, 589.3193361667276, 598.6288501129301, 41823.372649410245, 43446.56553434465, 43514.56485435145, 46766.532334676645, 46900.29649555251, 44211.0, 44223.557764422425, 44751.55248447515, 44859.77570112153, 44884.775576122156, 8827.337949653785, 8894.421862578944, 8965.058668839776, 8975.102489751038, 9008.324375671818, 8697.217250447458, 8810.163034511712, 8823.426477278988, 8876.644934202624, 8879.33404994628, 8754.168354006391, 8914.955425222865, 8930.642774289021, 8934.195922367018, 8965.148310910487, 8860.689875854347, 8871.157240062184, 8879.0, 8883.822323553557, 8893.155150260714, 8677.132286771335, 8792.296616270747, 8794.736157915273, 8805.911940880573, 8806.823863522757, 42071.36892946608, 42104.36843447351, 42165.0, 42232.57767422317, 42358.0, 3271.574695289597, 3312.801231926092, 3450.27544215715, 3454.3264063507627, 3519.964800352015, 28700.0, 31162.688373116205, 31649.52525712116, 31743.0, 31842.681573184203, 4097.938530922039, 4102.159057393257, 4106.691998100125, 4174.3321068628875, 4326.464105242625, 319667.0, 320103.0, 320256.0, 320923.0, 322255.3887230572, 59016.40983590195, 59369.40630593725, 59372.406275936686, 59725.40274597285, 59796.0, 62839.371606284265, 62903.0, 62998.37001629925, 63272.36727632757, 63390.0, 17259.568510787332, 17441.7383739244, 17469.0, 17484.0, 17556.122193890253, 13493.0, 13551.661208469866, 13572.86427135716, 13626.386812593457, 13666.93166534161, 17717.26949762772, 18845.528861778566, 18886.3389781357, 18995.715064274045, 19076.33232836844, 7164.498485105993, 7338.559686418832, 7402.407807375397, 7617.352525035434, 7704.460687751804, 908.8454962656365, 1012.5696578953915, 1022.1414012229762, 1022.8261195596617, 1116.7040734205443, 31453.68546314553, 31535.684643153734, 31741.682583174334, 32150.35699286001, 32221.838890805397, 1058.2962330050584, 1060.6977011551671, 1101.251149218539, 1104.751430928051, 1168.9426609167926, 15533.378664853506, 16724.83275167257, 16838.747418788727, 16852.662946741242, 16853.073080980663, 470508.0, 486462.0, 487601.0, 487889.0, 489212.0, 55999.44000559942, 56246.71876640591, 57004.42995570074, 57060.144097838565, 57289.0, 1338.805873148388, 1363.3728484897058, 1403.6350548857167, 1425.137791636066, 1432.6203556057653, 29422.264443389085, 31220.219494512818, 31405.0, 31686.366272673957, 32037.67962320347, 51061.744691276304, 51750.223746643074, 51772.74113629408, 52014.73992630013, 52024.47975520348, 468429.0, 471487.0, 471731.0, 473143.0, 473249.0, 41275.58724412838, 42190.789046054575, 42707.3593896098, 42825.143497130506, 43001.0, 45535.54464455313, 46593.3011004842, 46756.53243467522, 46929.2960605598, 47034.29448558206, 39063.41404878872, 39505.407418889314, 39648.0, 39651.0, 39966.40050399304, 36699.63300366962, 37344.43983340306, 38016.0, 41320.586794132876, 41400.58599413967, 39366.0, 39799.80100099481, 39971.0, 39973.0, 40951.7952410236, 33457.0, 36109.45835812517, 36437.635623644484, 36646.633533664324, 36936.0, 27215.59176612313, 27932.30169245785, 27970.860145699957, 28162.2959426016, 28200.43599128047], "value": 20192.60257366278, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.6162599026963, 391.40506430226037, 395.1681710000449, 398.3486998757031, 421.4794728510289, 13813.240271785047, 17807.910960445195, 18361.081945902686, 19457.70813437798, 19563.804361956376, 17445.21496532656, 17635.118244087807, 18565.350212742556, 19647.115879785408, 19822.306219282327, 4965.577925876305, 5030.195168772988, 5096.719680417576, 5141.408737995141, 5145.691258524501, 5075.619328550355, 5130.717810520438, 5132.332796736419, 5134.127198376266, 5375.892482150354, 5660.235868157808, 5779.768809247625, 5780.682062486561, 5783.421657834225, 5784.045632470637, 5502.312210973629, 5723.341815691187, 5741.569382296345, 5745.856353591152, 5785.334686511063, 5665.773369065232, 5674.290713660793, 5677.034904066319, 5687.232223649796, 5688.317401911756, 12915.483380664762, 15586.688266234612, 21277.68083478749, 23058.538829223322, 23190.884045579834, 2188.9233876814237, 2189.9562008759735, 2233.1848875160613, 2237.0, 2360.386299562109, 9081.818363632756, 9425.858612120825, 9740.366876153028, 9951.55218015191, 10131.746706332327, 1887.7168424736262, 1890.7258447525032, 1920.6158768246407, 1928.1104517572717, 1933.584279379926, 83291.5835420825, 84951.0, 85673.57163214206, 86474.56762716146, 86959.13040869574, 11008.229423940247, 11105.944470277758, 11205.719857003478, 11213.981483333078, 11618.186726929203, 12400.317982510867, 15956.521304360656, 16014.519564413085, 16028.435450327892, 16046.598835028984, 7738.148803631596, 7823.647935842901, 8034.47775894565, 8094.757157285291, 8151.592420378957, 7848.686052557948, 7878.251566101211, 7911.604419778988, 8122.55325957078, 8191.672333106609, 4007.6192761687594, 4201.180769749931, 4212.08350200658, 4239.342901850218, 4276.786160692015, 1879.595886884299, 1889.7165425186058, 1944.270898413095, 2053.158205135917, 2098.2551194325792, 980.6371642492323, 991.4745185051934, 1010.3028910052041, 1030.8196065688473, 1051.2168434516182, 19025.42923712291, 19184.752991055535, 19279.614407712048, 19723.506912327306, 19830.603387932162, 923.2244914272044, 970.3498655900563, 985.5860538573817, 993.5826952679892, 1015.1979935850595, 9965.750856228507, 10987.61543345979, 10987.725306867393, 10999.780004400027, 11014.44927753609, 338815.0, 342169.0, 343603.0, 492123.0, 510300.0, 59587.0, 77736.2226377729, 90427.54786226027, 96627.51686241524, 99645.50177249212, 982.7199248214367, 1000.4497526360473, 1040.6669865643073, 1044.6448207609449, 1049.9947500262297, 17155.228014739616, 17314.907298359183, 18060.81939180644, 18161.818381816014, 18167.909160454114, 40151.0, 40655.59344406518, 40938.38592421057, 41926.58073419227, 42861.57138428576, 54527.72736136294, 55844.44155558392, 56427.15359269697, 58781.11828322664, 59324.703376482845, 8238.546879921661, 8280.254777070093, 8360.540170290693, 8395.370347223861, 8605.65577376898, 12634.873651263737, 12647.241165530098, 13092.476300948236, 13151.473941042252, 13472.9895257858, 11168.553257869595, 11180.968564146004, 11810.940945295219, 11817.290962542274, 11827.759371755945, 11174.888251117385, 11255.549778008788, 11299.604513841976, 11330.660080197607, 11557.537698492302, 10629.787404251718, 10828.296160749525, 10956.726081848017, 11043.226974112056, 11633.185677002528, 8314.667413303641, 8323.584990551499, 8482.109378515168, 8498.660053598034, 8865.0, 8443.155684431507, 10300.433476158883, 10777.62278320255, 10925.672229833117, 11123.886461572276], "value": 8926.77273620177, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1442.5744405400405, 1475.8376578576356, 1591.7214487464698, 1672.2140593920867, 1731.740238964156, 7462.291082347182, 7701.075870895486, 7985.843822168011, 8683.869741953877, 8708.0, 8023.558704271278, 8454.450460720049, 8455.281301089415, 8603.91396086039, 8632.43889147205, 2160.91356345746, 2180.8800515971616, 2181.5745929543746, 2182.8035476807086, 2185.25701261571, 2240.6975058367075, 2245.0682966568857, 2322.3613506285737, 2326.348622385735, 2331.0326214620914, 2293.2776175504664, 2312.93604941727, 2318.686977258074, 2320.477892474188, 2325.534893021394, 2232.944176395595, 2254.706888104536, 2264.9660255096105, 2268.750437451879, 2270.727512698487, 2198.670199470076, 2199.3182113544694, 2201.3175915466095, 2207.3708992936936, 2241.0587553227683, 8598.828023439559, 8606.741797746077, 8630.309575234029, 8685.609147588311, 8706.956465217634, 5024.271480635288, 5232.6598771080135, 5237.16205407133, 5238.97380513095, 5249.606279529051, 3257.9022629321157, 3277.311764529428, 3444.156181735466, 3466.5666791651042, 3489.668481494254, 1175.723704929341, 1184.7334349771318, 1191.3923898811668, 1203.9398030098548, 1209.2260952990093, 11874.465649045813, 11907.523699052028, 11911.225770324987, 11912.940435297767, 11951.282923024559, 4317.762523061262, 4438.381355000565, 4582.014866803654, 4610.377599024089, 4730.834420795256, 9896.455694936847, 9906.851397229048, 9908.20734341251, 9951.800963980824, 9957.502124893726, 5172.948270517322, 5180.222966555047, 5191.273221748958, 5195.636305458582, 5208.479152084761, 4088.366303223005, 4195.517515485697, 4713.9764301178275, 4762.261849413347, 4787.4494433139935, 3818.0836599216545, 3828.502294701671, 3968.960310396859, 3988.6011398859882, 4020.5175378954714, 1285.222440423549, 1285.7878450055637, 1295.695511554784, 1297.4096785962365, 1328.023902431712, 868.9565521723888, 890.1899271662755, 902.1339514066569, 904.9954750226207, 918.9724308270762, 5216.686998780086, 5258.211268309784, 5431.972840135774, 5452.372977107604, 5486.890262194734, 435.62753845462305, 445.97547134907893, 446.2547545598858, 447.95744404281544, 449.1869715814386, 3772.3775577030033, 3825.5791862895057, 3844.7116466265143, 3850.3454412749898, 3968.6825053995613, 10184.898151018544, 10473.9476302618, 10507.369557826554, 10547.578096876192, 10622.20333474977, 10214.029667181605, 10316.587336506456, 10458.633947811943, 10461.790764184674, 10474.0, 7911.841763164704, 8029.277365037175, 8057.0734365548715, 8059.073206581201, 8094.190580941859, 5509.724513774215, 5526.796133935746, 5529.861753456195, 5636.2954630671165, 5692.459216374438, 9598.0, 9601.807963840824, 9684.837819461709, 9796.118349348593, 9796.608135674493, 9651.951740241253, 9758.9024109758, 9771.0, 9791.363561368487, 9856.310058296138, 7403.444741644291, 7416.629168541659, 7430.925690743024, 7457.216992215956, 7592.0, 7673.462857599914, 7801.531908085533, 7804.882926756217, 7822.295993360625, 7833.1383547808555, 6960.895586566105, 7209.062821833338, 7332.78001659951, 7412.6664300107705, 7415.295546923034, 6961.060256865258, 7020.403265722471, 7100.751473698396, 7157.284271572801, 7160.248173941869, 6581.0, 6610.975298828689, 6614.206295244601, 6645.9003114954285, 6692.966535167293, 4675.4155730533685, 4797.712137271775, 4797.808087676453, 4855.514448555257, 4885.853424397274, 4660.091282200074, 4790.257510085942, 4854.708717476963, 4949.059678661187, 5100.923486147785], "value": 4384.32655464292, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.37332202205704, 328.4498465071006, 332.9633740288568, 334.9028781653321, 338.8542926541586, 5308.362996440423, 5433.266509021281, 5529.0, 5589.972050139749, 5591.245181900442, 5224.608154388427, 5441.537469315113, 5465.398806131322, 5484.670919744818, 5487.149491828763, 4239.2793225151645, 4252.766097864616, 4257.552956939523, 4263.550392866425, 4296.5059018213, 4169.124483858378, 4257.233697934371, 4275.722078064931, 4313.8783916181865, 4334.826606935719, 4246.2356775780345, 4253.51084625269, 4258.382534532491, 4259.318509038554, 4276.807543660543, 4239.0, 4243.745375277494, 4261.190373828978, 4279.828806847722, 4290.184864875664, 3592.7305452091196, 3732.570754363229, 3732.8880133596035, 3750.606186350421, 3814.408766641175, 5284.656497327662, 5317.893642127175, 5345.946540534584, 5378.515933565959, 5386.0, 4817.445993710733, 4836.347093142416, 4865.586425153866, 4891.437484689235, 4908.680935739166, 5517.806876759334, 5695.202671625934, 5712.971435142797, 5732.140178973145, 5773.422657734193, 4101.97949010256, 4121.443605113302, 4122.690798190148, 4125.463689720347, 4146.067134894654, 6004.759809607611, 6025.668588227646, 6031.095335699636, 6036.96981515094, 6043.939560604382, 4115.0, 4146.523149837807, 4148.854790082332, 4159.750414975111, 4184.142250838631, 4181.26827805139, 4201.45381100455, 4215.683823713233, 4238.682098842599, 4250.872473825791, 4803.879903002383, 4824.421069471616, 4847.151748444008, 4855.562999330006, 4863.9513604864205, 5523.7790488380815, 5725.736330291694, 5739.282589676291, 5770.596058275881, 5794.594378393472, 1411.5835828430431, 1448.5726710620393, 1458.2646650485888, 1458.824941007086, 1462.5173692681603, 880.9383343165916, 923.0354279777514, 935.373299889076, 938.5260443476001, 940.9320421321848, 4815.903681926342, 4840.394950631171, 4872.171730805771, 4889.266610008456, 4905.828296009622, 5065.822696205689, 5066.949330506722, 5114.514121158484, 5153.4073581538605, 5163.793448262102, 4785.976070119627, 4820.421549414023, 4856.3201151838775, 4905.601903457497, 5131.974340128276, 3092.2578581140815, 3102.64319603244, 3135.153508552678, 3172.460681684119, 3185.442547554169, 6152.938470615326, 6161.353057928943, 6182.0, 6201.651108401413, 6213.099100630474, 5813.273340832396, 5866.823995280149, 5905.527557795366, 5907.586468947218, 5924.674142922181, 5995.700214989321, 6093.329733729286, 6103.8474038148515, 6119.0, 6126.479249263773, 5624.268845050281, 5922.5261979040715, 5964.224650795369, 5974.342822289458, 6003.159557662018, 5776.508996735157, 5789.0, 5801.564882633735, 5868.413158684098, 5893.6463812171405, 6094.177286066324, 6135.0, 6186.412290832363, 6188.597741146811, 6207.844803879939, 3936.7441116327345, 4122.299209134394, 4156.418101465737, 4160.209560183555, 4164.3961625564725, 5662.575306852085, 5849.385814489588, 5874.856951531081, 5896.086106653475, 5901.262342207224, 5581.916271255853, 5674.829755107354, 5708.286464191976, 5755.539556835527, 5817.883642327214, 5762.654240745569, 5771.047777116729, 5772.682502462405, 5787.363390027178, 5800.651960882361, 5598.10430331145, 5625.943740562542, 5657.227958300486, 5660.9150862737915, 5679.77280908759, 5735.7418916148035, 5761.942380576141, 5774.682392468455, 5779.543693930147, 5802.622829516068, 5388.488093631099, 5618.775248989995, 5623.156526521055, 5638.436156384329, 5656.943430565806], "value": 4318.757461180517, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.2490147401863, 765.7932358263268, 784.3990642603851, 803.533950308821, 867.4491697771915, 13548.18710877348, 14200.644983875396, 14230.146191228509, 14234.359453824576, 14248.857511424896, 14637.92681036596, 14894.627634309149, 14946.103233805952, 15024.17367044812, 15112.924435377809, 789.4947233770378, 808.9919100809005, 811.3225456743626, 812.8496228197773, 813.2314962360572, 797.2505844506146, 825.8018075661828, 826.7230477789917, 829.9253067223949, 831.0816547714779, 864.2006144316514, 868.0278088540844, 868.2576397180414, 872.0276891266225, 872.289084396215, 860.8407444622765, 863.2489733931488, 867.9783005424852, 869.7347309070731, 870.7431307764225, 636.5289685632645, 637.3339859846425, 637.7098420218789, 638.1894993358409, 638.7668500997103, 14513.274336283144, 14554.417823287056, 14578.562643120616, 14609.70780584393, 14624.26878656063, 14982.475613353588, 15184.848151518454, 15271.541853744295, 15300.693986120326, 15493.535193944199, 11450.8569464714, 11776.88223117775, 11879.703007424798, 11898.762024759457, 12728.80906786399, 3797.905052373685, 3812.8474861005525, 3917.2557214129224, 3991.5409727881374, 3996.7402118862183, 56620.0, 57413.42586574123, 57427.712861435844, 57822.7108864453, 77876.22123778747, 11401.0, 11513.194076414738, 11609.825852612217, 11765.941170294265, 11813.763724725457, 21575.029123689157, 21644.675329870064, 21648.35054948354, 21649.13403463875, 21656.675149872764, 8266.214709602578, 8342.082370939192, 8677.958644962644, 8813.559322033872, 8839.0, 4774.522547745267, 4778.641601879873, 4962.404511458648, 4976.626752993468, 5108.361454818148, 3607.7835329879767, 3733.701303895682, 3757.4739536464917, 3759.436084587334, 3799.905002374963, 628.0673200297555, 638.7700427845972, 649.5777744466135, 660.9688885338886, 665.5208250059949, 671.9025741267488, 730.8647900138385, 737.1189941892387, 753.3634079203065, 775.3483087839602, 8926.330525210635, 9065.501397423073, 9308.0, 9763.090537510563, 10232.846507302396, 724.3625609463638, 737.4616529933072, 737.8782500887401, 738.7229788829189, 745.8327717122686, 4662.463816661059, 4862.465128835825, 4921.384826896638, 4974.427940786783, 4977.626677999165, 93810.0, 97634.23657634322, 97918.51040744751, 113862.0, 127186.36406817907, 89547.0, 92785.0, 92817.53591232, 94059.52970235242, 98256.0, 53629.0, 74848.0, 76691.61654191805, 85192.0, 88720.0, 9182.586783594888, 9765.951170244103, 9831.852522212315, 9864.605415783288, 9876.012613630071, 48011.519884800706, 49435.258471122244, 49451.50548494469, 49864.0, 51007.48992510027, 66487.0, 73554.0, 73678.42180516498, 75947.62026189834, 76980.23019769731, 13316.201027938354, 13338.666533336744, 13511.189328640314, 13822.93088534551, 14211.644708881948, 14594.635134121732, 14726.337314821074, 14896.0, 15050.0, 15074.664591686515, 14060.929695351459, 14266.407259441945, 14364.712705745618, 15374.846251537789, 15399.923000384926, 13670.691853977458, 13833.170009799444, 14474.638134046312, 14709.117452952856, 15306.15816130079, 13378.799318010042, 13927.442902283796, 14005.859941400864, 14052.718945620825, 14123.364448600043, 10646.148308135176, 10672.62645807393, 10778.29941053829, 10898.291611045257, 11501.884981150417, 10291.897081029094, 10446.843297350393, 11769.823452648046, 12076.319864142439, 12324.137310388187], "value": 7563.3208469885985, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1528.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 112.0, 111.0, 110.0, 111.0, 111.0, 109.0, 114.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 136.0, 126.0, 169.0, 129.0, 126.0, 124.0, 125.0, 159.0, 124.0], "value": 137.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 172.0, 168.0, 176.0, 165.0, 164.0, 162.0, 167.0, 163.0, 162.0], "value": 166.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 77.0, 112.0, 77.0, 76.0, 76.0, 76.0, 119.0, 76.0], "value": 86.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 120.0, 83.0, 83.0, 82.0, 102.0, 85.0, 81.0, 113.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 119.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 146.0, 147.0, 149.0, 147.0, 147.0, 148.0], "value": 147.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 100.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 54.0, 57.0, 56.0, 69.0, 54.0, 55.0, 55.0, 54.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 65.0, 61.0], "value": 61.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 80.0, 81.0, 81.0, 80.0, 82.0, 80.0, 81.0, 80.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 136.0, 135.0, 136.0, 132.0, 135.0, 138.0, 149.0, 170.0, 139.0], "value": 141.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 172.0, 163.0, 167.0, 170.0, 164.0, 168.0, 168.0, 164.0, 165.0], "value": 166.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 74.0, 67.0, 66.0, 72.0, 66.0, 63.0, 66.0], "value": 67.3, "unit": "score"}]}]} 23:51:54 INFO - Return code: 0 23:51:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:51:54 ERROR - # TBPL SUCCESS # 23:51:54 INFO - Running post-action listener: _resource_record_post_action 23:51:54 INFO - [mozharness: 2016-10-17 06:51:54.150942Z] Finished run-tests step (success) 23:51:54 INFO - Running post-run listener: _resource_record_post_run 23:51:54 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 395063296; Read time: 12; Write time: 235824 23:51:54 INFO - TinderboxPrint: CPU usage
13.4% 23:51:54 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 23:51:54 INFO - TinderboxPrint: I/O write bytes / time
395,063,296 / 235,824 23:51:54 INFO - TinderboxPrint: CPU idle
8,257.5 (86.6%) 23:51:54 INFO - TinderboxPrint: CPU user
1,220.0 (12.8%) 23:51:54 INFO - TinderboxPrint: Swap in / out
0 / 0 23:51:54 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106471424; Read time: 0; Write time: 76096 23:51:54 INFO - run-tests - Wall time: 1179s; CPU: 13.0%; Read bytes: 0; Write bytes: 288591872; Read time: 0; Write time: 159728 23:51:54 INFO - Running post-run listener: _upload_blobber_files 23:51:54 INFO - Blob upload gear active. 23:51:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:51:54 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 23:51:54 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'] 23:51:54 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 23:51:55 INFO - (blobuploader) - INFO - Open directory for files ... 23:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:51:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:51:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:51:56 INFO - (blobuploader) - INFO - Done attempting. 23:51:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:51:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:51:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:51:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:51:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:51:59 INFO - (blobuploader) - INFO - Done attempting. 23:51:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:51:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:51:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:51:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:51:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:51:59 INFO - (blobuploader) - INFO - Done attempting. 23:51:59 INFO - (blobuploader) - INFO - Iteration through files over. 23:51:59 INFO - Return code: 0 23:51:59 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:51:59 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:51:59 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a90527a1a46f668fd0c9783afc56681fa4684a83cdc66f1334a74831ea011eb57a5ecf7c56a562a94bd5f77edea8782d083971ef657c2eb9a310017194315315", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d93a796cad8597968c63c582ea2de2f51ab0843793aaf5af6078c6138c079c44264256e086a2f705fd89a3901bad31bcb2fe1ce4b457401e819f48cc15fea1d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f769bbc0153813e5dd447803f725aabd847e873bf6ef7849534dc08e80a488086ee4b3c4cbc62cc731ce89fd0be923374380c5e702c5469ffdc4e6acd8edb4f"} 23:51:59 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:51:59 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:51:59 INFO - Contents: 23:51:59 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/a90527a1a46f668fd0c9783afc56681fa4684a83cdc66f1334a74831ea011eb57a5ecf7c56a562a94bd5f77edea8782d083971ef657c2eb9a310017194315315", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d93a796cad8597968c63c582ea2de2f51ab0843793aaf5af6078c6138c079c44264256e086a2f705fd89a3901bad31bcb2fe1ce4b457401e819f48cc15fea1d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f769bbc0153813e5dd447803f725aabd847e873bf6ef7849534dc08e80a488086ee4b3c4cbc62cc731ce89fd0be923374380c5e702c5469ffdc4e6acd8edb4f"} 23:51:59 INFO - Running post-run listener: copy_logs_to_upload_dir 23:51:59 INFO - Copying logs to upload dir... 23:51:59 INFO - mkdir: /builds/slave/test/build/upload/logs 23:51:59 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.326177 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-10-16 23:51:58.660975) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 23:51:58.664646) ========= 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-1476685881.552490-1638668301 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/a90527a1a46f668fd0c9783afc56681fa4684a83cdc66f1334a74831ea011eb57a5ecf7c56a562a94bd5f77edea8782d083971ef657c2eb9a310017194315315", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d93a796cad8597968c63c582ea2de2f51ab0843793aaf5af6078c6138c079c44264256e086a2f705fd89a3901bad31bcb2fe1ce4b457401e819f48cc15fea1d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f769bbc0153813e5dd447803f725aabd847e873bf6ef7849534dc08e80a488086ee4b3c4cbc62cc731ce89fd0be923374380c5e702c5469ffdc4e6acd8edb4f"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011371 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476674095/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/a90527a1a46f668fd0c9783afc56681fa4684a83cdc66f1334a74831ea011eb57a5ecf7c56a562a94bd5f77edea8782d083971ef657c2eb9a310017194315315", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d93a796cad8597968c63c582ea2de2f51ab0843793aaf5af6078c6138c079c44264256e086a2f705fd89a3901bad31bcb2fe1ce4b457401e819f48cc15fea1d7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8f769bbc0153813e5dd447803f725aabd847e873bf6ef7849534dc08e80a488086ee4b3c4cbc62cc731ce89fd0be923374380c5e702c5469ffdc4e6acd8edb4f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-16 23:51:58.690165) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:51:58.690475) ========= 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-1476685881.552490-1638668301 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004418 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-16 23:51:58.774062) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 23:51:58.774891) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-16 23:51:58.775600) ========= ========= Total master_lag: 0.17 =========