builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-065 starttime: 1476399267.24 results: success (0) buildid: 20161013153808 builduid: 1987f42f773f4a86a5594c7f10120724 revision: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:27.240003) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:27.240492) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:27.240775) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:27.255695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:27.256088) ========= 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=523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-13 15:54:28-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 209M=0s 2016-10-13 15:54:28 (209 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077169 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:27.347249) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:27.347578) ========= 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=523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023392 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:27.397176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 15:54:27.397531) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 --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 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 --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=523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-13 15:54:28,250 truncating revision to first 12 chars 2016-10-13 15:54:28,250 Setting DEBUG logging. 2016-10-13 15:54:28,250 attempt 1/10 2016-10-13 15:54:28,251 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/62ccb498db3e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-13 15:54:29,540 unpacking tar archive at: fx-team-62ccb498db3e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.655411 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-13 15:54:29.066897) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:29.067285) ========= script_repo_revision: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:29.067680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:29.067991) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-13 15:54:29.077745) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-13 15:54:29.078065) ========= /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=523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:54:30 INFO - MultiFileLogger online at 20161013 15:54:30 in /builds/slave/test 15:54:30 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 15:54:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:54:30 INFO - {'append_to_log': False, 15:54:30 INFO - 'base_work_dir': '/builds/slave/test', 15:54:30 INFO - 'blob_upload_branch': 'Fx-Team', 15:54:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:54:30 INFO - 'branch': 'Fx-Team', 15:54:30 INFO - 'buildbot_json_path': 'buildprops.json', 15:54:30 INFO - 'config_files': ('talos/linux_config.py',), 15:54:30 INFO - 'default_actions': ('clobber', 15:54:30 INFO - 'read-buildbot-config', 15:54:30 INFO - 'download-and-extract', 15:54:30 INFO - 'populate-webroot', 15:54:30 INFO - 'create-virtualenv', 15:54:30 INFO - 'install', 15:54:30 INFO - 'run-tests'), 15:54:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:54:30 INFO - 'download_minidump_stackwalk': True, 15:54:30 INFO - 'download_symbols': 'ondemand', 15:54:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:54:30 INFO - 'tooltool.py': '/tools/tooltool.py', 15:54:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:54:30 INFO - '/tools/misc-python/virtualenv.py')}, 15:54:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:54:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:54:30 INFO - 'installer_path': 'installer.exe', 15:54:30 INFO - 'log_level': 'info', 15:54:30 INFO - 'log_name': 'talos', 15:54:30 INFO - 'log_to_console': True, 15:54:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:54:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:54:30 INFO - 'opt_config_files': (), 15:54:30 INFO - 'pip_index': False, 15:54:30 INFO - 'sps_profile': False, 15:54:30 INFO - 'sps_profile_interval': 0, 15:54:30 INFO - 'suite': 'dromaeojs-e10s', 15:54:30 INFO - 'system_bits': '32', 15:54:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:54:30 INFO - 'title': 'talos-linux64-ix-065', 15:54:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:54:30 INFO - 'use_talos_json': True, 15:54:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:54:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:54:30 INFO - 'work_dir': 'build'} 15:54:30 INFO - [mozharness: 2016-10-13 22:54:30.023008Z] Running clobber step. 15:54:30 INFO - Running pre-action listener: _resource_record_pre_action 15:54:30 INFO - Running main action method: clobber 15:54:30 INFO - rmtree: /builds/slave/test/build 15:54:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:54:31 INFO - Running post-action listener: _resource_record_post_action 15:54:31 INFO - [mozharness: 2016-10-13 22:54:31.007130Z] Finished clobber step (success) 15:54:31 INFO - [mozharness: 2016-10-13 22:54:31.007230Z] Running read-buildbot-config step. 15:54:31 INFO - Running pre-action listener: _resource_record_pre_action 15:54:31 INFO - Running main action method: read_buildbot_config 15:54:31 INFO - Using buildbot properties: 15:54:31 INFO - { 15:54:31 INFO - "project": "", 15:54:31 INFO - "product": "firefox", 15:54:31 INFO - "script_repo_revision": "production", 15:54:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 15:54:31 INFO - "repository": "", 15:54:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 15:54:31 INFO - "buildid": "20161013153808", 15:54:31 INFO - "stage_platform": "linux64-pgo", 15:54:31 INFO - "basedir": "/builds/slave/test", 15:54:31 INFO - "buildnumber": 822, 15:54:31 INFO - "platform": "ubuntu64_hw", 15:54:31 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 15:54:31 INFO - "slavebuilddir": "test", 15:54:31 INFO - "branch": "fx-team", 15:54:31 INFO - "revision": "62ccb498db3ec05bef1b6427d5b1b4b0e501cad5", 15:54:31 INFO - "slavename": "talos-linux64-ix-065", 15:54:31 INFO - "builduid": "1987f42f773f4a86a5594c7f10120724", 15:54:31 INFO - "repo_path": "integration/fx-team" 15:54:31 INFO - } 15:54:31 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 15:54:31 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 15:54:31 INFO - Running post-action listener: _resource_record_post_action 15:54:31 INFO - [mozharness: 2016-10-13 22:54:31.009585Z] Finished read-buildbot-config step (success) 15:54:31 INFO - [mozharness: 2016-10-13 22:54:31.009674Z] Running download-and-extract step. 15:54:31 INFO - Running pre-action listener: _resource_record_pre_action 15:54:31 INFO - Running main action method: download_and_extract 15:54:31 INFO - mkdir: /builds/slave/test/build/tests 15:54:31 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')]} 15:54:31 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:54:31 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/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 15:54:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/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 15:54:31 INFO - Downloaded 1361 bytes. 15:54:31 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 15:54:31 INFO - Using the following test package requirements: 15:54:31 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:31 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:54:31 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:54:31 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:31 INFO - u'jsshell-linux-x86_64.zip'], 15:54:31 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:54:31 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 15:54:31 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:54:31 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:54:31 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:54:31 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 15:54:31 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:54:31 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:54:31 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/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:54:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:31 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:54:31 INFO - Http code: 200 15:54:31 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 15:54:31 INFO - x-amz-cf-id: NmHVk9l0bPeIxCZ7oooNhEHP56s4p1LZBTNFJFGRAz90QntjUpKByw== 15:54:31 INFO - x-amz-replication-status: COMPLETED 15:54:31 INFO - x-amz-version-id: tjICeCD8Y5ch2GeB_RnlezlCnrKSCXML 15:54:31 INFO - Expected file size: 22120853 15:54:31 INFO - Obtained file size: 22120853 15:54:35 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 15:54:35 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/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 15:54:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:54:35 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:54:35 INFO - Http code: 200 15:54:35 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 15:54:35 INFO - x-amz-cf-id: ZiweafYnZT8XmJ8a3aDRZudVe9BPi7ia9xl13UBNEJRtMLLlbKGSqA== 15:54:35 INFO - x-amz-replication-status: COMPLETED 15:54:35 INFO - x-amz-version-id: tjICeCD8Y5ch2GeB_RnlezlCnrKSCXML 15:54:35 INFO - Expected file size: 22120853 15:54:35 INFO - Obtained file size: 22120853 15:54:40 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/1476387018/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 15:54:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:54:40 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:54:40 INFO - Http code: 200 15:54:40 INFO - via: 1.1 f1a40337a32137e1c23ceffead6a50d5.cloudfront.net (CloudFront) 15:54:40 INFO - x-amz-cf-id: FXuIBRqVP64UrxZLfu90FTwLDcQMemXsWO2DwCK8HkRuCCdcGLuEyQ== 15:54:40 INFO - x-amz-replication-status: COMPLETED 15:54:40 INFO - x-amz-version-id: jJ.RKjayqD.XS1aKf2hKqxq9ZQN0VoDf 15:54:40 INFO - Expected file size: 14409006 15:54:40 INFO - Obtained file size: 14409006 15:54:40 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')]} 15:54:40 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:54:40 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/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 15:54:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/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 15:54:41 INFO - Downloaded 59789533 bytes. 15:54:41 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:54:41 INFO - mkdir: /builds/slave/test/properties 15:54:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:54:41 INFO - Writing to file /builds/slave/test/properties/build_url 15:54:41 INFO - Contents: 15:54:41 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 15:54:41 INFO - Running post-action listener: _resource_record_post_action 15:54:41 INFO - Running post-action listener: set_extra_try_arguments 15:54:41 INFO - [mozharness: 2016-10-13 22:54:41.979119Z] Finished download-and-extract step (success) 15:54:41 INFO - [mozharness: 2016-10-13 22:54:41.979347Z] Running populate-webroot step. 15:54:41 INFO - Running pre-action listener: _resource_record_pre_action 15:54:41 INFO - Running main action method: populate_webroot 15:54:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:54:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:54:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:54:41 INFO - '--tppagecycles', 15:54:41 INFO - '7'], 15:54:41 INFO - 'tests': ['tsvgm']}}, 15:54:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:54:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:54:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:54:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:54:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:41 INFO - 'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:54:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:41 INFO - 'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['damp', 'tps']}, 15:54:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:41 INFO - 'tests': ['damp', 'tps']}, 15:54:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['dromaeo_dom']}, 15:54:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:54:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['basic_compositor_video']}, 15:54:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:54:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['a11yr', 15:54:41 INFO - 'ts_paint', 15:54:41 INFO - 'tpaint', 15:54:41 INFO - 'sessionrestore', 15:54:41 INFO - 'sessionrestore_no_auto_restore', 15:54:41 INFO - 'tabpaint']}, 15:54:41 INFO - 'other-e10s': {'tests': ['a11yr', 15:54:41 INFO - 'ts_paint', 15:54:41 INFO - 'tpaint', 15:54:41 INFO - 'sessionrestore', 15:54:41 INFO - 'sessionrestore_no_auto_restore', 15:54:41 INFO - 'tabpaint']}, 15:54:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:54:41 INFO - 'ts_paint', 15:54:41 INFO - 'tpaint', 15:54:41 INFO - 'sessionrestore', 15:54:41 INFO - 'sessionrestore_no_auto_restore', 15:54:41 INFO - 'tabpaint']}, 15:54:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:54:41 INFO - 'ts_paint', 15:54:41 INFO - 'tpaint', 15:54:41 INFO - 'sessionrestore', 15:54:41 INFO - 'sessionrestore_no_auto_restore', 15:54:41 INFO - 'tabpaint']}, 15:54:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['a11yr', 15:54:41 INFO - 'ts_paint', 15:54:41 INFO - 'tpaint', 15:54:41 INFO - 'sessionrestore', 15:54:41 INFO - 'sessionrestore_no_auto_restore', 15:54:41 INFO - 'tabpaint']}, 15:54:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['a11yr', 15:54:41 INFO - 'ts_paint', 15:54:41 INFO - 'tpaint', 15:54:41 INFO - 'sessionrestore', 15:54:41 INFO - 'sessionrestore_no_auto_restore', 15:54:41 INFO - 'tabpaint']}, 15:54:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['tsvgx', 15:54:41 INFO - 'tsvgr_opacity', 15:54:41 INFO - 'tart', 15:54:41 INFO - 'tscrollx', 15:54:41 INFO - 'cart']}, 15:54:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:54:41 INFO - 'tsvgr_opacity', 15:54:41 INFO - 'tart', 15:54:41 INFO - 'tscrollx', 15:54:41 INFO - 'cart']}, 15:54:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:41 INFO - 'talos_options': ['--disable-e10s'], 15:54:41 INFO - 'tests': ['tp5o']}, 15:54:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:41 INFO - 'tests': ['tp5o']}, 15:54:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:41 INFO - 'talos_options': ['--disable-e10s', 15:54:41 INFO - '--xperf_path', 15:54:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:41 INFO - 'tests': ['tp5n']}, 15:54:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:54:41 INFO - 'talos_options': ['--xperf_path', 15:54:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:54:41 INFO - 'tests': ['tp5n']}}, 15:54:41 INFO - 'talos.zip': {'path': '', 15:54:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:54:41 INFO - Running post-action listener: _resource_record_post_action 15:54:41 INFO - [mozharness: 2016-10-13 22:54:41.994553Z] Finished populate-webroot step (success) 15:54:41 INFO - [mozharness: 2016-10-13 22:54:41.994640Z] Running create-virtualenv step. 15:54:41 INFO - Running pre-action listener: _resource_record_pre_action 15:54:41 INFO - Running main action method: create_virtualenv 15:54:41 INFO - Creating virtualenv /builds/slave/test/build/venv 15:54:41 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 15:54:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:54:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:54:42 INFO - Using real prefix '/usr' 15:54:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:54:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:54:44 INFO - Installing pip.................done. 15:54:44 INFO - Return code: 0 15:54:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:54:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:54:44 INFO - Reading from file tmpfile_stdout 15:54:44 INFO - Output received: 15:54:44 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) 15:54:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:54:44 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')]} 15:54:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:44 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')]} 15:54:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:44 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 0x7fded8844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', '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 15:54:44 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 15:54:44 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 15:54:44 INFO - Using env: {'DISPLAY': ':0', 15:54:44 INFO - 'HOME': '/home/cltbld', 15:54:44 INFO - 'LANG': 'en_US.UTF-8', 15:54:44 INFO - 'LANGUAGE': 'en_US:en', 15:54:44 INFO - 'LOGNAME': 'cltbld', 15:54:44 INFO - 'MAIL': '/var/mail/cltbld', 15:54:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:44 INFO - 'MOZ_NO_REMOTE': '1', 15:54:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:44 INFO - 'NO_EM_RESTART': '1', 15:54:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:44 INFO - 'PWD': '/builds/slave/test', 15:54:44 INFO - 'SHELL': '/bin/bash', 15:54:44 INFO - 'SHLVL': '1', 15:54:44 INFO - 'TERM': 'linux', 15:54:44 INFO - 'TMOUT': '86400', 15:54:44 INFO - 'USER': 'cltbld', 15:54:44 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:54:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:44 INFO - '_': '/tools/buildbot/bin/python'} 15:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:45 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 15:54:45 INFO - Cleaning up... 15:54:45 INFO - Return code: 0 15:54:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fded8844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', '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 15:54:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:54:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:54:45 INFO - Using env: {'DISPLAY': ':0', 15:54:45 INFO - 'HOME': '/home/cltbld', 15:54:45 INFO - 'LANG': 'en_US.UTF-8', 15:54:45 INFO - 'LANGUAGE': 'en_US:en', 15:54:45 INFO - 'LOGNAME': 'cltbld', 15:54:45 INFO - 'MAIL': '/var/mail/cltbld', 15:54:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:45 INFO - 'MOZ_NO_REMOTE': '1', 15:54:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:45 INFO - 'NO_EM_RESTART': '1', 15:54:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:45 INFO - 'PWD': '/builds/slave/test', 15:54:45 INFO - 'SHELL': '/bin/bash', 15:54:45 INFO - 'SHLVL': '1', 15:54:45 INFO - 'TERM': 'linux', 15:54:45 INFO - 'TMOUT': '86400', 15:54:45 INFO - 'USER': 'cltbld', 15:54:45 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:54:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:45 INFO - '_': '/tools/buildbot/bin/python'} 15:54:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:45 INFO - Downloading/unpacking psutil>=3.1.1 15:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:54:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:47 INFO - Installing collected packages: psutil 15:54:47 INFO - Running setup.py install for psutil 15:54:47 INFO - building 'psutil._psutil_linux' extension 15:54:47 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 15:54:47 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 15:54:47 INFO - building 'psutil._psutil_posix' extension 15:54:47 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 15:54:47 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 15:54:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:54:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:54:47 INFO - Successfully installed psutil 15:54:47 INFO - Cleaning up... 15:54:47 INFO - Return code: 0 15:54:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:54:47 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')]} 15:54:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:47 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')]} 15:54:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:47 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 0x7fded8844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', '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 15:54:47 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 15:54:47 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 15:54:47 INFO - Using env: {'DISPLAY': ':0', 15:54:47 INFO - 'HOME': '/home/cltbld', 15:54:47 INFO - 'LANG': 'en_US.UTF-8', 15:54:47 INFO - 'LANGUAGE': 'en_US:en', 15:54:47 INFO - 'LOGNAME': 'cltbld', 15:54:47 INFO - 'MAIL': '/var/mail/cltbld', 15:54:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:47 INFO - 'MOZ_NO_REMOTE': '1', 15:54:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:47 INFO - 'NO_EM_RESTART': '1', 15:54:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:47 INFO - 'PWD': '/builds/slave/test', 15:54:47 INFO - 'SHELL': '/bin/bash', 15:54:47 INFO - 'SHLVL': '1', 15:54:47 INFO - 'TERM': 'linux', 15:54:47 INFO - 'TMOUT': '86400', 15:54:47 INFO - 'USER': 'cltbld', 15:54:47 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:54:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:47 INFO - '_': '/tools/buildbot/bin/python'} 15:54:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54: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 15:54:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:54:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:54:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:54:50 INFO - Installing collected packages: mozsystemmonitor 15:54:50 INFO - Running setup.py install for mozsystemmonitor 15:54:50 INFO - Successfully installed mozsystemmonitor 15:54:50 INFO - Cleaning up... 15:54:50 INFO - Return code: 0 15:54:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:54: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')]} 15:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54: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')]} 15:54:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:50 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 0x7fded8844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', '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 15:54:50 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 15:54:50 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 15:54:50 INFO - Using env: {'DISPLAY': ':0', 15:54:50 INFO - 'HOME': '/home/cltbld', 15:54:50 INFO - 'LANG': 'en_US.UTF-8', 15:54:50 INFO - 'LANGUAGE': 'en_US:en', 15:54:50 INFO - 'LOGNAME': 'cltbld', 15:54:50 INFO - 'MAIL': '/var/mail/cltbld', 15:54:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:50 INFO - 'MOZ_NO_REMOTE': '1', 15:54:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:50 INFO - 'NO_EM_RESTART': '1', 15:54:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:50 INFO - 'PWD': '/builds/slave/test', 15:54:50 INFO - 'SHELL': '/bin/bash', 15:54:50 INFO - 'SHLVL': '1', 15:54:50 INFO - 'TERM': 'linux', 15:54:50 INFO - 'TMOUT': '86400', 15:54:50 INFO - 'USER': 'cltbld', 15:54:50 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:54:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:50 INFO - '_': '/tools/buildbot/bin/python'} 15:54:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:50 INFO - Downloading/unpacking jsonschema==2.5.1 15:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:54:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:54:52 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 15:54:52 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 15:54:52 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 15:54:52 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 15:54:52 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 15:54:52 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 15:54:52 INFO - Downloading functools32-3.2.3-2.tar.gz 15:54:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:54:52 INFO - warning: no files found matching '*.txt' 15:54:52 INFO - no previously-included directories found matching 'build' 15:54:52 INFO - no previously-included directories found matching 'dist' 15:54:52 INFO - no previously-included directories found matching '.git*' 15:54:52 INFO - Installing collected packages: jsonschema, functools32 15:54:52 INFO - Running setup.py install for functools32 15:54:52 INFO - warning: no files found matching '*.txt' 15:54:52 INFO - no previously-included directories found matching 'build' 15:54:52 INFO - no previously-included directories found matching 'dist' 15:54:52 INFO - no previously-included directories found matching '.git*' 15:54:52 INFO - Successfully installed jsonschema functools32 15:54:52 INFO - Cleaning up... 15:54:52 INFO - Return code: 0 15:54:52 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:54:52 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')]} 15:54:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:52 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')]} 15:54:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:52 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 0x7fded8844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', '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 15:54:52 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 15:54:52 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 15:54:52 INFO - Using env: {'DISPLAY': ':0', 15:54:52 INFO - 'HOME': '/home/cltbld', 15:54:52 INFO - 'LANG': 'en_US.UTF-8', 15:54:52 INFO - 'LANGUAGE': 'en_US:en', 15:54:52 INFO - 'LOGNAME': 'cltbld', 15:54:52 INFO - 'MAIL': '/var/mail/cltbld', 15:54:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:52 INFO - 'MOZ_NO_REMOTE': '1', 15:54:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:52 INFO - 'NO_EM_RESTART': '1', 15:54:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:52 INFO - 'PWD': '/builds/slave/test', 15:54:52 INFO - 'SHELL': '/bin/bash', 15:54:52 INFO - 'SHLVL': '1', 15:54:52 INFO - 'TERM': 'linux', 15:54:52 INFO - 'TMOUT': '86400', 15:54:52 INFO - 'USER': 'cltbld', 15:54:52 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:54:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:52 INFO - '_': '/tools/buildbot/bin/python'} 15:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:54:53 INFO - Cleaning up... 15:54:53 INFO - Return code: 0 15:54:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:54:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fded8844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', '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 15:54:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:54:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:54:53 INFO - Using env: {'DISPLAY': ':0', 15:54:53 INFO - 'HOME': '/home/cltbld', 15:54:53 INFO - 'LANG': 'en_US.UTF-8', 15:54:53 INFO - 'LANGUAGE': 'en_US:en', 15:54:53 INFO - 'LOGNAME': 'cltbld', 15:54:53 INFO - 'MAIL': '/var/mail/cltbld', 15:54:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:53 INFO - 'MOZ_NO_REMOTE': '1', 15:54:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:53 INFO - 'NO_EM_RESTART': '1', 15:54:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:53 INFO - 'PWD': '/builds/slave/test', 15:54:53 INFO - 'SHELL': '/bin/bash', 15:54:53 INFO - 'SHLVL': '1', 15:54:53 INFO - 'TERM': 'linux', 15:54:53 INFO - 'TMOUT': '86400', 15:54:53 INFO - 'USER': 'cltbld', 15:54:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:54:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:53 INFO - '_': '/tools/buildbot/bin/python'} 15:54:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:53 INFO - Downloading/unpacking blobuploader==1.2.4 15:54:53 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 15:54:53 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 15:54:53 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 15:54:53 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 15:54:53 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 15:54:53 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 15:54:55 INFO - Downloading blobuploader-1.2.4.tar.gz 15:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:54:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:54:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:54:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:54:55 INFO - Downloading docopt-0.6.1.tar.gz 15:54:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:54:55 INFO - Installing collected packages: blobuploader, requests, docopt 15:54:55 INFO - Running setup.py install for blobuploader 15:54:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:54:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:54:56 INFO - Running setup.py install for requests 15:54:56 INFO - Running setup.py install for docopt 15:54:56 INFO - Successfully installed blobuploader requests docopt 15:54:56 INFO - Cleaning up... 15:54:56 INFO - Return code: 0 15:54:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:56 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')]} 15:54:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 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')]} 15:54:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:56 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 0x7fded8844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', '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 15:54:56 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 15:54:56 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 15:54:56 INFO - Using env: {'DISPLAY': ':0', 15:54:56 INFO - 'HOME': '/home/cltbld', 15:54:56 INFO - 'LANG': 'en_US.UTF-8', 15:54:56 INFO - 'LANGUAGE': 'en_US:en', 15:54:56 INFO - 'LOGNAME': 'cltbld', 15:54:56 INFO - 'MAIL': '/var/mail/cltbld', 15:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:56 INFO - 'MOZ_NO_REMOTE': '1', 15:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:56 INFO - 'NO_EM_RESTART': '1', 15:54:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:56 INFO - 'PWD': '/builds/slave/test', 15:54:56 INFO - 'SHELL': '/bin/bash', 15:54:56 INFO - 'SHLVL': '1', 15:54:56 INFO - 'TERM': 'linux', 15:54:56 INFO - 'TMOUT': '86400', 15:54:56 INFO - 'USER': 'cltbld', 15:54:56 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:56 INFO - '_': '/tools/buildbot/bin/python'} 15:54:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:54:56 INFO - Running setup.py (path:/tmp/pip-v8lzb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:54:56 INFO - Running setup.py (path:/tmp/pip-4orOJM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:54:56 INFO - Running setup.py (path:/tmp/pip-AHlwqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:54:57 INFO - Running setup.py (path:/tmp/pip-prsA3H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:54:57 INFO - Running setup.py (path:/tmp/pip-MhsHA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:54:57 INFO - Running setup.py (path:/tmp/pip-YCFRc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:54:57 INFO - Running setup.py (path:/tmp/pip-NcgVOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:54:57 INFO - Running setup.py (path:/tmp/pip-_cNXUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:54:57 INFO - Running setup.py (path:/tmp/pip-XIv69W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:54:57 INFO - Running setup.py (path:/tmp/pip-NrK9lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:54:57 INFO - Running setup.py (path:/tmp/pip-sYabmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:54:57 INFO - Running setup.py (path:/tmp/pip-QEAAgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:54:57 INFO - Running setup.py (path:/tmp/pip-TLOCmF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:54:57 INFO - Running setup.py (path:/tmp/pip-oQ1kGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:57 INFO - Running setup.py (path:/tmp/pip-qDxQUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:54:57 INFO - Running setup.py (path:/tmp/pip-gpj_F6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:54:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:54:57 INFO - Running setup.py (path:/tmp/pip-q_AwbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:54:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:54:57 INFO - Running setup.py install for manifestparser 15:54:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:54:58 INFO - Running setup.py install for mozcrash 15:54:58 INFO - Running setup.py install for mozdebug 15:54:58 INFO - Running setup.py install for mozdevice 15:54:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:54:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:54:58 INFO - Running setup.py install for mozfile 15:54:58 INFO - Running setup.py install for mozhttpd 15:54:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:54:58 INFO - Running setup.py install for mozinfo 15:54:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:54:58 INFO - Running setup.py install for mozInstall 15:54:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:54:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:54:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:54:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:54:58 INFO - Running setup.py install for mozleak 15:54:58 INFO - Running setup.py install for mozlog 15:54:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:54:59 INFO - Running setup.py install for moznetwork 15:54:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:54:59 INFO - Running setup.py install for mozprocess 15:54:59 INFO - Running setup.py install for mozprofile 15:54:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:54:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:54:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:54:59 INFO - Running setup.py install for mozrunner 15:54:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:54:59 INFO - Running setup.py install for mozscreenshot 15:54:59 INFO - Running setup.py install for moztest 15:54:59 INFO - Running setup.py install for mozversion 15:54:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:54:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:54:59 INFO - Cleaning up... 15:54:59 INFO - Return code: 0 15:54:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:54:59 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')]} 15:54:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:54:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:59 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')]} 15:54:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:54:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:54:59 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 0x7fded8844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', '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 15:54:59 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 15:54:59 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 15:54:59 INFO - Using env: {'DISPLAY': ':0', 15:54:59 INFO - 'HOME': '/home/cltbld', 15:54:59 INFO - 'LANG': 'en_US.UTF-8', 15:54:59 INFO - 'LANGUAGE': 'en_US:en', 15:54:59 INFO - 'LOGNAME': 'cltbld', 15:54:59 INFO - 'MAIL': '/var/mail/cltbld', 15:54:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:59 INFO - 'MOZ_NO_REMOTE': '1', 15:54:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:54:59 INFO - 'NO_EM_RESTART': '1', 15:54:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:54:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:59 INFO - 'PWD': '/builds/slave/test', 15:54:59 INFO - 'SHELL': '/bin/bash', 15:54:59 INFO - 'SHLVL': '1', 15:54:59 INFO - 'TERM': 'linux', 15:54:59 INFO - 'TMOUT': '86400', 15:54:59 INFO - 'USER': 'cltbld', 15:54:59 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:54:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:59 INFO - '_': '/tools/buildbot/bin/python'} 15:55:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:55:00 INFO - Running setup.py (path:/tmp/pip-Okcoyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:55:00 INFO - Running setup.py (path:/tmp/pip-BNjtDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:55:00 INFO - Running setup.py (path:/tmp/pip-xapXWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:55:00 INFO - Running setup.py (path:/tmp/pip-nlleR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:55:00 INFO - Running setup.py (path:/tmp/pip-8GIMYi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:55:00 INFO - Running setup.py (path:/tmp/pip-JUDMbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:55:00 INFO - Running setup.py (path:/tmp/pip-VtcQ8w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:55:00 INFO - Running setup.py (path:/tmp/pip-LIV1N2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:55:00 INFO - Running setup.py (path:/tmp/pip-Hrcoc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:55:00 INFO - Running setup.py (path:/tmp/pip-lQJB3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:55:00 INFO - Running setup.py (path:/tmp/pip-qtY_1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:55:00 INFO - Running setup.py (path:/tmp/pip-wcUCC6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:55:00 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)) 15:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:55:00 INFO - Running setup.py (path:/tmp/pip-KuWKO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:55:01 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)) 15:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:55:01 INFO - Running setup.py (path:/tmp/pip-W0_XHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:55:01 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)) 15:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:01 INFO - Running setup.py (path:/tmp/pip-Tbu49S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:55:01 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)) 15:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:55:01 INFO - Running setup.py (path:/tmp/pip-Cjq9IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:55:01 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)) 15:55:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:55:01 INFO - Running setup.py (path:/tmp/pip-y1iMDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:55:01 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)) 15:55:01 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)) 15:55:01 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)) 15:55:01 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)) 15:55:01 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)) 15:55:01 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)) 15:55:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:01 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 15:55:03 INFO - Downloading blessings-1.6.tar.gz 15:55:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:55:03 INFO - Installing collected packages: blessings 15:55:03 INFO - Running setup.py install for blessings 15:55:03 INFO - Successfully installed blessings 15:55:03 INFO - Cleaning up... 15:55:03 INFO - Return code: 0 15:55:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:55:03 INFO - Reading from file tmpfile_stdout 15:55:03 INFO - Current package versions: 15:55:03 INFO - argparse == 1.2.1 15:55:03 INFO - blessings == 1.6 15:55:03 INFO - blobuploader == 1.2.4 15:55:03 INFO - docopt == 0.6.1 15:55:03 INFO - functools32 == 3.2.3-2 15:55:03 INFO - jsonschema == 2.5.1 15:55:03 INFO - manifestparser == 1.1 15:55:03 INFO - mozInstall == 1.12 15:55:03 INFO - mozcrash == 0.17 15:55:03 INFO - mozdebug == 0.1 15:55:03 INFO - mozdevice == 0.48 15:55:03 INFO - mozfile == 1.2 15:55:03 INFO - mozhttpd == 0.7 15:55:03 INFO - mozinfo == 0.9 15:55:03 INFO - mozleak == 0.1 15:55:03 INFO - mozlog == 3.4 15:55:03 INFO - moznetwork == 0.27 15:55:03 INFO - mozprocess == 0.23 15:55:03 INFO - mozprofile == 0.28 15:55:03 INFO - mozrunner == 6.12 15:55:03 INFO - mozscreenshot == 0.1 15:55:03 INFO - mozsystemmonitor == 0.3 15:55:03 INFO - moztest == 0.7 15:55:03 INFO - mozversion == 1.4 15:55:03 INFO - psutil == 3.1.1 15:55:03 INFO - requests == 1.2.3 15:55:03 INFO - wsgiref == 0.1.2 15:55:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:55:03 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')]} 15:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:03 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')]} 15:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:03 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 0x7fded8844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', '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 15:55:03 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 15:55:03 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 15:55:03 INFO - Using env: {'DISPLAY': ':0', 15:55:03 INFO - 'HOME': '/home/cltbld', 15:55:03 INFO - 'LANG': 'en_US.UTF-8', 15:55:03 INFO - 'LANGUAGE': 'en_US:en', 15:55:03 INFO - 'LOGNAME': 'cltbld', 15:55:03 INFO - 'MAIL': '/var/mail/cltbld', 15:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:03 INFO - 'MOZ_NO_REMOTE': '1', 15:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:03 INFO - 'NO_EM_RESTART': '1', 15:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:03 INFO - 'PWD': '/builds/slave/test', 15:55:03 INFO - 'SHELL': '/bin/bash', 15:55:03 INFO - 'SHLVL': '1', 15:55:03 INFO - 'TERM': 'linux', 15:55:03 INFO - 'TMOUT': '86400', 15:55:03 INFO - 'USER': 'cltbld', 15:55:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:03 INFO - '_': '/tools/buildbot/bin/python'} 15:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:03 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)) 15:55:03 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)) 15:55:03 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)) 15:55:03 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)) 15:55:03 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)) 15:55:03 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)) 15:55:03 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)) 15:55:03 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)) 15:55:03 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)) 15:55:03 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)) 15:55:03 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)) 15:55:03 INFO - Cleaning up... 15:55:03 INFO - Return code: 0 15:55:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:55:03 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')]} 15:55:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:55:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:03 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')]} 15:55:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:55:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:55:03 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 0x7fded8844f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14048a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14d07b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, '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': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', '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 15:55:03 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 15:55:03 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 15:55:03 INFO - Using env: {'DISPLAY': ':0', 15:55:03 INFO - 'HOME': '/home/cltbld', 15:55:03 INFO - 'LANG': 'en_US.UTF-8', 15:55:03 INFO - 'LANGUAGE': 'en_US:en', 15:55:03 INFO - 'LOGNAME': 'cltbld', 15:55:03 INFO - 'MAIL': '/var/mail/cltbld', 15:55:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:03 INFO - 'MOZ_NO_REMOTE': '1', 15:55:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:03 INFO - 'NO_EM_RESTART': '1', 15:55:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:03 INFO - 'PWD': '/builds/slave/test', 15:55:03 INFO - 'SHELL': '/bin/bash', 15:55:03 INFO - 'SHLVL': '1', 15:55:03 INFO - 'TERM': 'linux', 15:55:03 INFO - 'TMOUT': '86400', 15:55:03 INFO - 'USER': 'cltbld', 15:55:03 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:55:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:03 INFO - '_': '/tools/buildbot/bin/python'} 15:55:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:55:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:55:04 INFO - Cleaning up... 15:55:04 INFO - Return code: 0 15:55:04 INFO - Running post-action listener: _resource_record_post_action 15:55:04 INFO - Running post-action listener: _start_resource_monitoring 15:55:04 INFO - Starting resource monitoring. 15:55:04 INFO - [mozharness: 2016-10-13 22:55:04.201314Z] Finished create-virtualenv step (success) 15:55:04 INFO - [mozharness: 2016-10-13 22:55:04.201825Z] Running install step. 15:55:04 INFO - Running pre-action listener: _resource_record_pre_action 15:55:04 INFO - Running main action method: install 15:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:55:04 INFO - Reading from file tmpfile_stdout 15:55:04 INFO - Detecting whether we're running mozinstall >=1.0... 15:55:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:55:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:55:04 INFO - Reading from file tmpfile_stdout 15:55:04 INFO - Output received: 15:55:04 INFO - Usage: mozinstall [options] installer 15:55:04 INFO - Options: 15:55:04 INFO - -h, --help show this help message and exit 15:55:04 INFO - -d DEST, --destination=DEST 15:55:04 INFO - Directory to install application into. [default: 15:55:04 INFO - "/builds/slave/test"] 15:55:04 INFO - --app=APP Application being installed. [default: firefox] 15:55:04 INFO - mkdir: /builds/slave/test/build/application 15:55:04 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'] 15:55:04 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 15:55:21 INFO - Reading from file tmpfile_stdout 15:55:21 INFO - Output received: 15:55:21 INFO - /builds/slave/test/build/application/firefox/firefox 15:55:21 INFO - Running post-action listener: _resource_record_post_action 15:55:21 INFO - [mozharness: 2016-10-13 22:55:21.533940Z] Finished install step (success) 15:55:21 INFO - [mozharness: 2016-10-13 22:55:21.534216Z] Running run-tests step. 15:55:21 INFO - Running pre-action listener: _resource_record_pre_action 15:55:21 INFO - Running main action method: run_tests 15:55:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:55:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:55:21 INFO - Python 2.7.3 15:55:21 INFO - Return code: 0 15:55:21 INFO - grabbing minidump binary from tooltool 15:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:55:21 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 0x155f790>, '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 0x1560690>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1560b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:55:21 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 15:55:21 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 15:55:21 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 15:55:21 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:55:21 INFO - Return code: 0 15:55:21 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:55:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:55:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:55:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:55:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:55:21 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/1476387018/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 15:55:21 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/1476387018/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 15:55:21 INFO - Using env: {'DISPLAY': ':0', 15:55:21 INFO - 'HOME': '/home/cltbld', 15:55:21 INFO - 'LANG': 'en_US.UTF-8', 15:55:21 INFO - 'LANGUAGE': 'en_US:en', 15:55:21 INFO - 'LOGNAME': 'cltbld', 15:55:21 INFO - 'MAIL': '/var/mail/cltbld', 15:55:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:55:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:55:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:55:21 INFO - 'MOZ_NO_REMOTE': '1', 15:55:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:55:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:55:21 INFO - 'NO_EM_RESTART': '1', 15:55:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:55:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:55:21 INFO - 'PWD': '/builds/slave/test', 15:55:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:55:21 INFO - 'SHELL': '/bin/bash', 15:55:21 INFO - 'SHLVL': '1', 15:55:21 INFO - 'TERM': 'linux', 15:55:21 INFO - 'TMOUT': '86400', 15:55:21 INFO - 'USER': 'cltbld', 15:55:21 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980', 15:55:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:55:21 INFO - '_': '/tools/buildbot/bin/python'} 15:55:21 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/1476387018/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 15:55:21 INFO - mozversion application_buildid: 20161013123018 15:55:21 INFO - mozversion application_changeset: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 15:55:21 INFO - mozversion application_display_name: Nightly 15:55:21 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:55:21 INFO - mozversion application_name: Firefox 15:55:21 INFO - mozversion application_remotingname: firefox 15:55:21 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:55:21 INFO - mozversion application_vendor: Mozilla 15:55:21 INFO - mozversion application_version: 52.0a1 15:55:21 INFO - mozversion platform_buildid: 20161013123018 15:55:21 INFO - mozversion platform_changeset: 62ccb498db3ec05bef1b6427d5b1b4b0e501cad5 15:55:21 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:55:21 INFO - mozversion platform_version: 52.0a1 15:55:21 INFO - using testdate: 1476399321 15:55:21 INFO - actual date: 1476399321 15:55:21 INFO - starting webserver on 'localhost:37608' 15:55:21 INFO - SUITE-START | Running 2 tests 15:55:21 INFO - TEST-START | dromaeo_css 15:55:21 INFO - operating with platform_type : linux_ 15:55:21 INFO - Initialising browser for dromaeo_css test... 15:55:21 INFO - TEST-INFO | started process 26524 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUHGk4l/profile http://localhost:37608/getInfo.html) 15:55:25 INFO - PROCESS | 26524 | __metrics Screen width/height:1600/1200 15:55:25 INFO - PROCESS | 26524 | colorDepth:24 15:55:25 INFO - PROCESS | 26524 | Browser inner width/height: 1024/697 15:55:25 INFO - PROCESS | 26524 | __metrics 15:55:26 ERROR - PROCESS | 26524 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 15:55:27 INFO - TEST-INFO | 26524: exit 0 15:55:27 INFO - Browser initialized. 15:55:27 INFO - Running cycle 1/1 for dromaeo_css test... 15:55:27 INFO - TEST-INFO | started process 26648 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUHGk4l/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:55:39 INFO - PROCESS | 26648 | RSS: Main: 185225216 15:55:39 INFO - PROCESS | 26648 | 15:56:29 INFO - PROCESS | 26648 | 1476399389314 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] 15:58:40 INFO - PROCESS | 26648 | Cycle 1(1): loaded http://localhost:37608/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37608/tests/dromaeo/cssquery-ext.html) 15:58:42 INFO - PROCESS | 26648 | RSS: Main: 201940992 15:58:42 INFO - PROCESS | 26648 | 16:01:44 INFO - PROCESS | 26648 | Cycle 1(1): loaded http://localhost:37608/tests/dromaeo/cssquery-ext.html (next: http://localhost:37608/tests/dromaeo/cssquery-jquery.html) 16:01:45 INFO - PROCESS | 26648 | RSS: Main: 201670656 16:01:45 INFO - PROCESS | 26648 | 16:04:46 INFO - PROCESS | 26648 | Cycle 1(1): loaded http://localhost:37608/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37608/tests/dromaeo/cssquery-mootools.html) 16:04:47 INFO - PROCESS | 26648 | RSS: Main: 198959104 16:04:47 INFO - PROCESS | 26648 | 16:07:49 INFO - PROCESS | 26648 | Cycle 1(1): loaded http://localhost:37608/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37608/tests/dromaeo/cssquery-prototype.html) 16:07:49 INFO - PROCESS | 26648 | RSS: Main: 195584000 16:07:49 INFO - PROCESS | 26648 | 16:10:52 INFO - PROCESS | 26648 | Cycle 1(1): loaded http://localhost:37608/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37608/tests/dromaeo/cssquery-yui.html) 16:10:53 INFO - PROCESS | 26648 | RSS: Main: 199098368 16:10:53 INFO - PROCESS | 26648 | 16:13:55 INFO - PROCESS | 26648 | Cycle 1(1): loaded http://localhost:37608/tests/dromaeo/cssquery-yui.html (next: http://localhost:37608/tests/dromaeo/cssquery-dojo.html) 16:13:56 INFO - PROCESS | 26648 | RSS: Main: 199331840 16:13:56 INFO - PROCESS | 26648 | 16:13:56 INFO - PROCESS | 26648 | __start_tp_report 16:13:56 INFO - PROCESS | 26648 | _x_x_mozilla_page_load 16:13:56 INFO - PROCESS | 26648 | _x_x_mozilla_page_load_details 16:13:56 INFO - PROCESS | 26648 | |i|pagename|runs| 16:13:56 INFO - PROCESS | 26648 | |0;dojo.html;3077.4922137847257;3079.676633953436;3101.426236146313;3125.7499400048;3139.9686003139977;5162.5611822995;5432.701201433924;5439.401665816757;5442.564594832414;5452.10518466968;5192.065428222918;5192.3249977502965;5269.499397557235;5272.736363181844;5280.973595132029;4749.477557468685;4777.4028246469015;4834.033193361324;4835.468098509179;4850.927236091444;4758.238681810911;4795.2807078938085;4842.782074806642;4845.806167753303;4855.344528488662;4838.298446725223;4840.249761287007;4840.878978025542;4844.927326090112;4845.6123510119105;4819.301201325806;4836.758162091881;4840.273958906175;4880.219164933629;4922.286268491084;4905.705657660516;4941.283513890466;4965.478624744386;4980.77586508608;4983.476734942815;5395.919061214085;5415.296011518478;5488.368837583689;5496.422875598045;5570.972145139248;5410.83767486976;5460.535854452376;5487.533559647395;5618;5779.133130030529;5725.456081672234;5784.768609255625;5789.565782566325;5841.0362290222065;5854.882902341972;5355.678659280456;5402;5405.702686352289;5417.160340147283;5431.511163995259;5597.776088956478;5637.154426836008;5845.590808643439;5882.55880808941;5896.941030589639;5590.972045139748;5604.131359639263;5623.831285061455;5651.4348565143155;5734.139879018097;5672.546196304285;5752.683602401824;5753.223314852525;5758.136279558016;5770.855728606818;5370.489803468664;5413.133898576209;5711.343195532567;5746.2529871116485;5753.539716822645;5567.693776842312;5644.943550564524;5645.5483561314995;5653.491185793216;5731.971340143273;4295.183915056129;4295.5489673583825;4297.67767417445;4303.031817840961;4306.956930430656;3708.1100535871196;3792.544894612664;3822.0253835272383;3854.036490877281;3856.5564960029396;5316.069687804618;5323.3079699639575;5353.170258609922;5410.972945135328;5511.641743286674;5739.167820666064;5748.942510574924;5749.338826035059;5752.050911599539;5766.711664416763;5165.328507294028;5216.26972223889;5409.377921538995;5445.1832225166545;5452.154915988028;4826.420829500412;4858.562729354375;4883.58489528387;4901.215805471179;4969;5907.616004959664;5920.911186332209;5926.081457374028;5932.644041357532;5933.851653708692;5488.368837583569;5660.88678226425;5705.258316418839;5717.113847353667;5731.627444216113;5716.914246286392;5861.413858614104;5930.881382372242;5935.0503919372695;6026.15633811258;5666.688332141772;5669.886602268014;5673;5673.205751194753;5673.978683836949;5733.913991290051;5778.566607504538;5784.2769653793275;5791.391903850204;5810.767569297181;5337.359516858002;5388.407275199646;5483.424240454695;5546.667199968015;5558.221848941071;5455.5908306876345;5502;5513.448655134454;5532.170174473861;5559.305086864142;5407.864803379947;5480.72596370172;5511.393746687781;5522.144067669517;5551.389347171727;5429.918551221814;5483.314585676791;5553.750081246434;5645.040343141758;5670.177824215383;5595.272614560081;5603.2155498231095;5614.466625670555;5644.463775941279;5657.15142728594 16:13:56 INFO - PROCESS | 26648 | |1;ext.html;537.7364458784082;571.7798647520705;589.7080944932256;591.6479694581723;599.4365296621177;40600;41988.37017444741;42039.57960420399;45984.54015459844;46019.76990115053;44139.77930110345;44268;44402;44426.11147777043;44639.77680111595;8567.271781898531;8810.647574097029;8840.33697472689;8846.380753347268;8848.46909185451;8560.272376847975;8594.226519613234;8624.611892464854;8666.176713212266;8717.520536370497;8659.65361385547;8688.044315125331;8759.2992560595;8780.517071561062;8802.29581633471;8647.827043459158;8686.391952563323;8698.782530436727;8720.999999999969;8742.606582703793;8258.710945116893;8343.207395297437;8360.916390836075;8373.330133589297;8389.790255243668;41906.580934190875;41984;42158.78920605408;42220.78889605563;42249.36625950613;3137.5293705944064;3192.7126558609602;3197.488401855692;3313.1717070732316;3435.158386195373;30378;30696.53955190674;31065.116860392453;31464.528032079535;32026.519602205986;3965.6232657897453;4015.297322968469;4061.695372847019;4218.303979843322;4224.514180869209;343956;345994.27002865076;346634;346931;347712;53460.46539534633;54084.72957635186;54156;54163.72918135384;54222.72888635532;55310;55643.721781390836;55691.16463253054;55716;55740.442595574335;14444.494442694455;14731.263436828116;14738.26308684583;14740.705185896222;14743.262836858114;10244.692659220234;10270.127039201601;10286.639967601099;10306.639267625596;10307.330023548446;14452.277386130652;14903.180325082008;14976.176310303037;15102.54692359231;15136.394544218108;5659;5769.94230057694;5900.232969713996;5905.940940590625;5937.554683398763;855.5422848775875;892.7500299916034;988.0695330301743;1012.8227560176939;1106.3583121789343;30393.544096838566;30777.49643064995;30926;31223.531647025313;31665;1037.2739082642029;1065.9626913058162;1078.8219943709357;1080.5461706083463;1131.3890499130541;16045.598860028593;16233.675326493403;16274.186290685418;16571.42000030017;16765.245563949407;458729;467199;469012;730414;730844;53833.46166538363;54868.72565637146;55328;55532.44467555353;55556.444435555124;1317.2952470428274;1324.602619214232;1333.6599167212298;1333.7665908466174;1378.0147194755798;29561.113166605035;30858.382832342777;31175.376492470477;31375.37249255048;31875.68124318727;47575.286370703776;47941.76029119832;48119.75940120277;48121.5187848131;48161.5183848157;424586;428279;429562;430418;431184;26279.21162365132;26392.20823375302;26434.86782566075;26556.601650974866;26593.468130637666;44360.77819610881;45034.77482612697;45077.77461112673;45250.32124518069;45405.09189816119;37482.81258593799;38271.23457530778;39056.60943390644;39159;39774.204515910096;38436;38503.229935401694;38736;38762.6123738759;38790.80604597072;38311.23377532378;39155.804220978716;40107;40168.7991560052;42289;31651.841740791147;35100.82449587736;35523.64476355203;36052.639473604926;36546.26907461889;26920.865395672896;27631.074630282765;27706.821770502418;27879.442411151256;28121.718782812728 16:13:56 INFO - PROCESS | 26648 | |2;jquery.html;385.6201641383239;394.52262762057904;396.383623465511;405.7687118342545;422.53170233438806;13753.31233438329;17686;18462.169202385892;19018.524536886584;19264.807351926476;18570.814291857077;18631.347902823403;19359.612807743837;19518.90240548799;19657.01714914252;5474.890502189964;5502.889942201154;5621.662700237999;5662.462066103734;5662.5753068520025;5512.91730624041;5634.267545219136;5640.5487560995025;5644.238027866227;5653;5408.3509978802595;5554.833354999336;5616.747246373902;5617.297837770278;5622.269105016363;5342.866428339284;5529.751161197756;5547.3343198816;5555.666660000393;5603.523700485443;4963.45402005779;5009.624278179114;5010.774515146827;5022.347094877679;5047.899042019176;21616.783832161633;22285.108595656155;22392.10431582751;22408.77591224083;22514.774852251594;2317.9768202317928;2485.8135639826905;2604.4265272317257;2650.363912660967;2767.266674331304;14028.649283767885;14361.281935903164;14377.353019114165;14589.124652520883;14653.706925861423;1836.0911348882255;1901.9429417117508;1912.3975947576469;1995.1919472613615;1998.41046891166;78420;80777.59611201964;82134;82650.58674706648;85322;10294.536745846455;10412.843807342895;10586.153107751361;10751.462426878781;10942.17933654979;13105.2136871788;15039.548813535612;15071;15095.698086038217;15159.772603410958;7082.681279342442;7411.59236242001;7581.279778421042;7596.924030759732;7893.447458677838;6810.353016463428;6981.476389270825;7034.155901291878;7097.964510177416;7297.489175757646;6418.711157997901;6556.147700798961;6573.408393244536;6601.966990165019;6653.538190869409;1959.6783452048926;1979.7129416234566;1987.5826076524093;1989.383291179739;1995.9401217963484;888.8311220868014;901.8827552418144;935.6257497001254;938.7653086728318;973.6105557776805;18424.447266582025;19241.80758192428;19627.21491140367;19744.23580698703;19855.882308879278;885.5262434597588;916.6654171227455;938.1790932933683;949.2121539122512;969.2488321550713;10975.725606859733;11120.165987550967;11234.550617975354;11257.15571332137;11316.71708207285;444435;447637;451307;453332;455247;75856.62071689607;75924.62037689776;76184;79899.20100799034;88637;983.4787562591838;999.515235110956;1043.3270540501335;1046;1051.9631812886512;16286.348546058025;16636.75044874352;17298.481045568653;17337.653246935242;17524.123793810002;40543.59456405398;40895.795521022206;41331.586684133974;41874;42019.36970945377;48605.27092093551;58700.4129958712;58770.70614646899;60175.69912150411;61169.38830611815;8163.346932245525;8482.109378515168;8525.44584601999;8683;8862.86705699402;7516.022917020752;11873.762524749283;13047.956163506708;13060.934695326843;13280.734385312046;10742.355458672504;11158.721031974266;11203.495842686936;11396.94301528487;11900.880991190324;10763.408012559072;10931.56273749041;11059.668209953714;11182.944085279521;11195.496202670736;11384;11479.540818367172;11595.478203481032;11633.767324653629;12232.571859984857;8487.490750554987;8570.528620925908;8746.300295976434;8821.161989611233;8866.916274675317;9710.70867873965;11456.369899655265;11608.245464045149;11643.243189192675;11649.941750291195 16:13:56 INFO - PROCESS | 26648 | |3;mootools.html;1482.7405204089284;1521.330614529607;1654.3548016273655;1770.2476447509805;1800.747895294659;8001.759947201579;8251.422400431971;8586.22723954844;9299.907000929998;9331.486768227745;8567.35744819138;8906.153915378045;8912.554372281393;9202;9203.723888283363;2360.89375978081;2393.640953856918;2395.053953688292;2396.3769419950763;2396.940076498093;2361.53949979754;2364.326167042393;2421.878906054699;2429.6112621980487;2432.622943443769;2369.135265628042;2370.3007612754277;2388.868612226327;2426.9029238830426;2436.305652888927;2309.0763694522157;2309.561183375153;2321.58211521926;2321.651752237161;2352.6353415220497;2228.832837537191;2241.9887900560393;2255.210676263311;2262.1403866530777;2275.70415845939;8896.37725359225;9024.729258122266;9056.909430905738;9122.270218382513;9123.31575131861;5203.427622961472;5341.332333458317;5346.438623944468;5353.518183363477;5362.329708786402;3571.7321200910037;3589.7846129232066;3639.344917914774;3728.4034554471427;3730.664240218366;1179.787638225119;1193.91045671575;1202.5370232460566;1202.7233736240626;1211.460899899545;12658;12695.047871409588;12696.809547856697;12734.872651273461;12738.617841464864;4449.57729015743;4658.301254811805;4853.878653033702;4877.731724755102;4908;10498.212634052477;10531.736706582396;10565.577376904837;10604.363738175734;10634.415107169025;5230.92153617696;5280.234366016906;5281.15501519755;5310.415854256029;5314.813981510706;4347.673924455678;4473.821047158142;4757.405324334458;4843.200871856175;4852.223644216909;3967.147063381387;3989.960100399017;4030.2544029354663;4101.958980410217;4139.606737359946;1275.330451512963;1313.5730887461614;1317.433503593464;1326.9137506062075;1330.255057167989;812.7196117339508;834.6869923778584;840.7982084299724;845.2730651639584;859.2438653984453;5393.7033463159905;5644.971775141098;5668.433156684298;5757.453041961007;6045.909311360333;928.2017464980112;940.5626383731598;942.1238248429026;948.9810203795886;953.6471505542994;3742.6070262622034;3972.483577134954;3977.423273625308;4019.095703466755;4089.1003979124544;11140.220184587;11334.319940803578;11456.312621242752;11465.08279337651;11485.827712584318;11219.990200881959;11306.152038597138;11384.487698053608;11390.829137562943;11428.085753139729;7868.134505204423;8222.424430289822;8346.874796878052;8349.165083491602;8424.831503369898;5827.329857066322;5946.583739138218;5961.986462301333;6077.604955677867;6162.630242185304;9962.800743985224;9995.850062248926;10163.847542286723;10185.236107291834;10272.486375681336;10057.647982320585;10343.431111288952;10352.016558426938;10428.374297542172;10432.426216558162;7550.471466997257;7712.228777122243;7815.218478152139;7877.881831772643;7943.801404964922;8336.166383361615;8454.408191426786;8458.873116903129;8500.107488713844;8515.48907065578;7654.923450765644;7660.463767536219;7777.727779527916;7939.28546430824;7974.362051036019;7457.403407727477;7490.4007679386605;7494.175640679412;7554.546727196386;7725.266099720518;6780.38976492118;6894.482913781386;6920.861582768417;6923.411510021705;6968.338007889445;4934.284528743384;4969.577585905094;5014.824481143142;5126.462740708899;5207.307625021807;5009.474005229544;5063.645544811975;5179.715115668674;5217.921731173959;5247.658902171346 16:13:56 INFO - PROCESS | 26648 | |4;prototype.html;314.6978900255756;325.7166762953961;331.17041810265283;335.83711899728644;338.98305084745755;5262.500062494067;5360.705161216131;5405.18922161676;5444.373897001851;5458.5087342139195;5201.55786758126;5248.790048398059;5250;5284.894302113965;5290.788368465266;4174.812133454002;4176.018635620627;4180.749155050699;4183.267928112583;4196.9370459443135;4014.919701605966;4166.9791651041705;4206.621404073633;4210.431591735122;4232.534421213664;4059.918801623966;4106.823383606678;4152.356384760352;4152.397902304164;4152.792360381984;4071.226466971266;4120.25835349637;4136.234796562646;4138.399932009842;4138.710290279681;3669.2478042001326;3672.467492213641;3681.8770275066095;3686.9631303687156;3690.6493883081066;5110.310108135429;5158.509941555546;5198.480151984809;5224.373075230958;5226.686398816083;4710.717356958594;4712.434507859079;4729.101470720587;4735.952640473585;4749.050189961987;5462.344518657746;5584.664920104766;5588.748506317225;5597.160425936101;5616.943830561683;4013.8996525086814;4022.7787471689044;4022.8189731462153;4028.113814960704;4028.617281358266;5835.183074369592;5848.298204215479;5897.734601942923;5903.822885313448;5909.7636094556165;4155.4182414462;4156.418101465797;4167.770772607475;4168.562300958356;4181.351890456984;4065.6137666921595;4173.4157217989505;4182.205380977604;4190.16196760643;4205.894852628648;4784.330193772875;4785.425748910153;4792.257200133915;4803.447603525639;4806.735629540409;5639.63342382752;5668.57485688575;5671.262735844314;5672.780352224291;5775.422457754191;1386.34148779329;1417.7518934186476;1422.544785668597;1433.6200906759716;1437.8490258522913;906.6962567539948;921.2998121427763;929.6142101027998;934.149923569562;939.8120375924842;4742;4766.689160480826;4815.614750819926;4834.444038935568;4841.830535931225;5063.265826455144;5070.8225212117395;5081.390233171969;5108.693478391234;5120.743962801845;4868.46643307357;4874.4150701916;4881.755912204447;4894.388201474816;5110.872228194251;3071.5392691096067;3078.7536997040183;3091.825106459531;3130.358276553301;3136.2316232523176;6048.395160484004;6067.393260673985;6135.533423615643;6145.26256849172;6158.599691020069;5610.579206559524;5942.227510423703;5981.581289309706;5981.760729570856;5985.551083668655;5984.222051133324;6038.788642397495;6102.420270074336;6170.451990105617;6182.1345011698395;5569.721513924369;5781.768729250783;5904.557158213065;5922.407759224043;5966.373530779206;5726.7709291629535;5817.360090390139;5836.824895253149;5860.179574859609;5867.73595188209;6133.04937734634;6136.110264011782;6143.1298282082;6160.691965401802;6175.475084617858;4064.329385651453;4084.591540845892;4227.450431443893;4243.851465198703;4277.50808656996;5821.243238378984;5838.795642152674;5843.357230704534;5843.737031833492;5850.882982340244;5659.377468478547;5703.6881517252095;5709.7430615623225;5715.114157305624;5731.942680573307;5420.701861397661;5562.443755624405;5595.006671430765;5614.410486898817;5627.777028073806;5576.470235327637;5588.832335029955;5625.690587017753;5661.207430959751;5690.459406356389;5455.345358556999;5620.690862002465;5652.85867853307;5656.60403771732;5664.5751568631695;5494.945050549443;5539.645650598399;5555.527780138734;5559.749811258423;5570.387257401601 16:13:56 INFO - PROCESS | 26648 | |5;yui.html;710.7157137145143;721.9819504512386;757.2587234212153;789.7393860026192;807.2371608829657;13921.930390348047;14896.180710060942;15023.023503472294;15049.548513544598;15063.849361506396;14505.564833055;15160.393584256617;15165.77251341228;15169.241537923088;15189.316480758365;646.0890144895686;663.0816319397621;777.3120788102542;795.5028107432854;810.3638643664724;800.1238643685156;804.5092493578912;807.9151689072651;808.7007807111377;808.720991258018;850.200811237438;850.2815121222557;851.0680804519042;851.7317045130795;851.8040850604365;839.064443145891;839.0812060793421;846.4117438380329;847.6100993542977;848.8259906719107;613.2702084519408;618.9381061893774;619.0034045187244;619.3373090792853;619.7211254935252;14761.852381476156;14841.480548180762;14853.885958553152;14866;14872.851271487254;15379.538613841603;15407.768883466757;15443.459478918296;15530.223488825513;15551.533453996286;11608.941955290255;11692.532298708042;11816;11900.940495297555;11915.463804128834;3790.1851102013197;3807.961920380816;3847.7883716395586;3850.4801851749935;3922.686185105185;82210;84787.15212847915;84834.57582712047;85335.14664853396;87271.56364218202;11218.214724969337;11286.322820630789;11392.715182120513;11439.885601143882;11562.132840036862;21472.926353682255;21504.56990860174;21540.892295538422;21614.675779863315;23596.410089747893;7768.65041073153;8007.7998050048045;8116.35069194463;8255;8267.710630127916;4312.223799716081;4349.195398851222;4382.276924307517;4511.684182107287;4530.818767249339;3356.714679252242;3572.517710109102;3592.173800026009;3613.1509095362567;3617.1138071172204;662.4435474201694;666.74330382802;674.1606699658857;681.5229339462396;687.4088284075691;683.4361651637419;684.6302996381997;702.9543079699803;708.4686485136148;743.6690672650618;9552.617895284111;9765.511724413751;9890.208783297463;10031.799364012679;10084.445355505517;655.1646650520529;656.6636893920848;663.5189487621436;684.6474065856088;689.3141324382171;4203.327467605169;4474.194644963938;4548.6133678637025;4657.347971284023;4689.718616882998;107572.9242707563;126477;128923.35538322436;129809;130022;107670.46164769126;108307;108418;109028;112606;94606.52696736473;95931.52034239784;98707;98787;99332.00667993372;8446.239838414573;8450.66197352099;8690.869636955324;8755.956220218859;8961.23829474502;52724.472755271956;54921.176182356496;55518.16722749081;55718;56776;45960.770196148806;46452.53547464482;53581;77694.611526942;79151;11501.53993840237;11873.762524749283;12041.397930103634;12174.75650487003;12470.376481176087;12747.107702460738;12832.871671283168;12859.549915752903;13010.93494532559;13216.603501894959;11641.47613357384;12303.446344914679;12694.111412201057;12913.031522635652;13150.27673477968;12250.693732656755;12256.142070055368;12547.74904501923;12931;12987.41556629935;11927.582534611247;11948.522059117538;12396.566120185751;12810.807837882625;12855.935720321339;10534.473276335999;10544.367337959748;10725.249232553646;10903.454827258447;11101.222914395914;9789.10500037272;10693.572257109628;10706.411147386969;10825.837612435977;10960.451977401257 16:13:56 INFO - PROCESS | 26648 | __end_tp_report 16:13:56 INFO - PROCESS | 26648 | __start_cc_report 16:13:56 INFO - PROCESS | 26648 | _x_x_mozilla_cycle_collect,338 16:13:56 INFO - PROCESS | 26648 | __end_cc_report 16:13:56 INFO - PROCESS | 26648 | __startTimestamp1476400435998__endTimestamp 16:13:56 INFO - PROCESS | 26648 | 16:13:56 INFO - PROCESS | 26648 | ------- Summary: start ------- 16:13:56 INFO - PROCESS | 26648 | Number of tests: 6 16:13:56 INFO - PROCESS | 26648 | 16:13:56 INFO - PROCESS | 26648 | [#0] dojo.html Cycles:165 Average:5293.70 Median:5483.42 stddev:610.22 (11.1%) stddev-sans-first:586.80 16:13:56 INFO - PROCESS | 26648 | Values: 3077.5 3079.7 3101.4 3125.7 3140.0 5162.6 5432.7 5439.4 5442.6 5452.1 5192.1 5192.3 5269.5 5272.7 5281.0 4749.5 4777.4 4834.0 4835.5 4850.9 4758.2 4795.3 4842.8 4845.8 4855.3 4838.3 4840.2 4840.9 4844.9 4845.6 4819.3 4836.8 4840.3 4880.2 4922.3 4905.7 4941.3 4965.5 4980.8 4983.5 5395.9 5415.3 5488.4 5496.4 5571.0 5410.8 5460.5 5487.5 5618.0 5779.1 5725.5 5784.8 5789.6 5841.0 5854.9 5355.7 5402.0 5405.7 5417.2 5431.5 5597.8 5637.2 5845.6 5882.6 5896.9 5591.0 5604.1 5623.8 5651.4 5734.1 5672.5 5752.7 5753.2 5758.1 5770.9 5370.5 5413.1 5711.3 5746.3 5753.5 5567.7 5644.9 5645.5 5653.5 5732.0 4295.2 4295.5 4297.7 4303.0 4307.0 3708.1 3792.5 3822.0 3854.0 3856.6 5316.1 5323.3 5353.2 5411.0 5511.6 5739.2 5748.9 5749.3 5752.1 5766.7 5165.3 5216.3 5409.4 5445.2 5452.2 4826.4 4858.6 4883.6 4901.2 4969.0 5907.6 5920.9 5926.1 5932.6 5933.9 5488.4 5660.9 5705.3 5717.1 5731.6 5716.9 5861.4 5930.9 5935.1 6026.2 5666.7 5669.9 5673.0 5673.2 5674.0 5733.9 5778.6 5784.3 5791.4 5810.8 5337.4 5388.4 5483.4 5546.7 5558.2 5455.6 5502.0 5513.4 5532.2 5559.3 5407.9 5480.7 5511.4 5522.1 5551.4 5429.9 5483.3 5553.8 5645.0 5670.2 5595.3 5603.2 5614.5 5644.5 5657.2 16:13:56 INFO - PROCESS | 26648 | 16:13:56 INFO - PROCESS | 26648 | [#1] ext.html Cycles:180 Average:59720.67 Median:41945.29 stddev:123841.90 (295.2%) stddev-sans-first:124109.59 16:13:56 INFO - PROCESS | 26648 | Values: 537.7 571.8 589.7 591.6 599.4 40600.0 41988.4 42039.6 45984.5 46019.8 44139.8 44268.0 44402.0 44426.1 44639.8 8567.3 8810.6 8840.3 8846.4 8848.5 8560.3 8594.2 8624.6 8666.2 8717.5 8659.7 8688.0 8759.3 8780.5 8802.3 8647.8 8686.4 8698.8 8721.0 8742.6 8258.7 8343.2 8360.9 8373.3 8389.8 41906.6 41984.0 42158.8 42220.8 42249.4 3137.5 3192.7 3197.5 3313.2 3435.2 30378.0 30696.5 31065.1 31464.5 32026.5 3965.6 4015.3 4061.7 4218.3 4224.5 343956.0 345994.3 346634.0 346931.0 347712.0 53460.5 54084.7 54156.0 54163.7 54222.7 55310.0 55643.7 55691.2 55716.0 55740.4 14444.5 14731.3 14738.3 14740.7 14743.3 10244.7 10270.1 10286.6 10306.6 10307.3 14452.3 14903.2 14976.2 15102.5 15136.4 5659.0 5769.9 5900.2 5905.9 5937.6 855.5 892.8 988.1 1012.8 1106.4 30393.5 30777.5 30926.0 31223.5 31665.0 1037.3 1066.0 1078.8 1080.5 1131.4 16045.6 16233.7 16274.2 16571.4 16765.2 458729.0 467199.0 469012.0 730414.0 730844.0 53833.5 54868.7 55328.0 55532.4 55556.4 1317.3 1324.6 1333.7 1333.8 1378.0 29561.1 30858.4 31175.4 31375.4 31875.7 47575.3 47941.8 48119.8 48121.5 48161.5 424586.0 428279.0 429562.0 430418.0 431184.0 26279.2 26392.2 26434.9 26556.6 26593.5 44360.8 45034.8 45077.8 45250.3 45405.1 37482.8 38271.2 39056.6 39159.0 39774.2 38436.0 38503.2 38736.0 38762.6 38790.8 38311.2 39155.8 40107.0 40168.8 42289.0 31651.8 35100.8 35523.6 36052.6 36546.3 26920.9 27631.1 27706.8 27879.4 28121.7 16:13:56 INFO - PROCESS | 26648 | 16:13:56 INFO - PROCESS | 26648 | [#2] jquery.html Cycles:180 Average:27472.89 Median:40719.70 stddev:74250.79 (182.3%) stddev-sans-first:74431.23 16:13:56 INFO - PROCESS | 26648 | Values: 385.6 394.5 396.4 405.8 422.5 13753.3 17686.0 18462.2 19018.5 19264.8 18570.8 18631.3 19359.6 19518.9 19657.0 5474.9 5502.9 5621.7 5662.5 5662.6 5512.9 5634.3 5640.5 5644.2 5653.0 5408.4 5554.8 5616.7 5617.3 5622.3 5342.9 5529.8 5547.3 5555.7 5603.5 4963.5 5009.6 5010.8 5022.3 5047.9 21616.8 22285.1 22392.1 22408.8 22514.8 2318.0 2485.8 2604.4 2650.4 2767.3 14028.6 14361.3 14377.4 14589.1 14653.7 1836.1 1901.9 1912.4 1995.2 1998.4 78420.0 80777.6 82134.0 82650.6 85322.0 10294.5 10412.8 10586.2 10751.5 10942.2 13105.2 15039.5 15071.0 15095.7 15159.8 7082.7 7411.6 7581.3 7596.9 7893.4 6810.4 6981.5 7034.2 7098.0 7297.5 6418.7 6556.1 6573.4 6602.0 6653.5 1959.7 1979.7 1987.6 1989.4 1995.9 888.8 901.9 935.6 938.8 973.6 18424.4 19241.8 19627.2 19744.2 19855.9 885.5 916.7 938.2 949.2 969.2 10975.7 11120.2 11234.6 11257.2 11316.7 444435.0 447637.0 451307.0 453332.0 455247.0 75856.6 75924.6 76184.0 79899.2 88637.0 983.5 999.5 1043.3 1046.0 1052.0 16286.3 16636.8 17298.5 17337.7 17524.1 40543.6 40895.8 41331.6 41874.0 42019.4 48605.3 58700.4 58770.7 60175.7 61169.4 8163.3 8482.1 8525.4 8683.0 8862.9 7516.0 11873.8 13048.0 13060.9 13280.7 10742.4 11158.7 11203.5 11396.9 11900.9 10763.4 10931.6 11059.7 11182.9 11195.5 11384.0 11479.5 11595.5 11633.8 12232.6 8487.5 8570.5 8746.3 8821.2 8866.9 9710.7 11456.4 11608.2 11643.2 11649.9 16:13:56 INFO - PROCESS | 26648 | 16:13:56 INFO - PROCESS | 26648 | [#3] mootools.html Cycles:180 Average:5864.15 Median:4865.81 stddev:3372.49 (69.3%) stddev-sans-first:3365.88 16:13:56 INFO - PROCESS | 26648 | Values: 1482.7 1521.3 1654.4 1770.2 1800.7 8001.8 8251.4 8586.2 9299.9 9331.5 8567.4 8906.2 8912.6 9202.0 9203.7 2360.9 2393.6 2395.1 2396.4 2396.9 2361.5 2364.3 2421.9 2429.6 2432.6 2369.1 2370.3 2388.9 2426.9 2436.3 2309.1 2309.6 2321.6 2321.7 2352.6 2228.8 2242.0 2255.2 2262.1 2275.7 8896.4 9024.7 9056.9 9122.3 9123.3 5203.4 5341.3 5346.4 5353.5 5362.3 3571.7 3589.8 3639.3 3728.4 3730.7 1179.8 1193.9 1202.5 1202.7 1211.5 12658.0 12695.0 12696.8 12734.9 12738.6 4449.6 4658.3 4853.9 4877.7 4908.0 10498.2 10531.7 10565.6 10604.4 10634.4 5230.9 5280.2 5281.2 5310.4 5314.8 4347.7 4473.8 4757.4 4843.2 4852.2 3967.1 3990.0 4030.3 4102.0 4139.6 1275.3 1313.6 1317.4 1326.9 1330.3 812.7 834.7 840.8 845.3 859.2 5393.7 5645.0 5668.4 5757.5 6045.9 928.2 940.6 942.1 949.0 953.6 3742.6 3972.5 3977.4 4019.1 4089.1 11140.2 11334.3 11456.3 11465.1 11485.8 11220.0 11306.2 11384.5 11390.8 11428.1 7868.1 8222.4 8346.9 8349.2 8424.8 5827.3 5946.6 5962.0 6077.6 6162.6 9962.8 9995.9 10163.8 10185.2 10272.5 10057.6 10343.4 10352.0 10428.4 10432.4 7550.5 7712.2 7815.2 7877.9 7943.8 8336.2 8454.4 8458.9 8500.1 8515.5 7654.9 7660.5 7777.7 7939.3 7974.4 7457.4 7490.4 7494.2 7554.5 7725.3 6780.4 6894.5 6920.9 6923.4 6968.3 4934.3 4969.6 5014.8 5126.5 5207.3 5009.5 5063.6 5179.7 5217.9 5247.7 16:13:56 INFO - PROCESS | 26648 | 16:13:56 INFO - PROCESS | 26648 | [#4] prototype.html Cycles:180 Average:4713.28 Median:5237.74 stddev:1399.81 (26.7%) stddev-sans-first:1364.25 16:13:56 INFO - PROCESS | 26648 | Values: 314.7 325.7 331.2 335.8 339.0 5262.5 5360.7 5405.2 5444.4 5458.5 5201.6 5248.8 5250.0 5284.9 5290.8 4174.8 4176.0 4180.7 4183.3 4196.9 4014.9 4167.0 4206.6 4210.4 4232.5 4059.9 4106.8 4152.4 4152.4 4152.8 4071.2 4120.3 4136.2 4138.4 4138.7 3669.2 3672.5 3681.9 3687.0 3690.6 5110.3 5158.5 5198.5 5224.4 5226.7 4710.7 4712.4 4729.1 4736.0 4749.1 5462.3 5584.7 5588.7 5597.2 5616.9 4013.9 4022.8 4022.8 4028.1 4028.6 5835.2 5848.3 5897.7 5903.8 5909.8 4155.4 4156.4 4167.8 4168.6 4181.4 4065.6 4173.4 4182.2 4190.2 4205.9 4784.3 4785.4 4792.3 4803.4 4806.7 5639.6 5668.6 5671.3 5672.8 5775.4 1386.3 1417.8 1422.5 1433.6 1437.8 906.7 921.3 929.6 934.1 939.8 4742.0 4766.7 4815.6 4834.4 4841.8 5063.3 5070.8 5081.4 5108.7 5120.7 4868.5 4874.4 4881.8 4894.4 5110.9 3071.5 3078.8 3091.8 3130.4 3136.2 6048.4 6067.4 6135.5 6145.3 6158.6 5610.6 5942.2 5981.6 5981.8 5985.6 5984.2 6038.8 6102.4 6170.5 6182.1 5569.7 5781.8 5904.6 5922.4 5966.4 5726.8 5817.4 5836.8 5860.2 5867.7 6133.0 6136.1 6143.1 6160.7 6175.5 4064.3 4084.6 4227.5 4243.9 4277.5 5821.2 5838.8 5843.4 5843.7 5850.9 5659.4 5703.7 5709.7 5715.1 5731.9 5420.7 5562.4 5595.0 5614.4 5627.8 5576.5 5588.8 5625.7 5661.2 5690.5 5455.3 5620.7 5652.9 5656.6 5664.6 5494.9 5539.6 5555.5 5559.7 5570.4 16:13:56 INFO - PROCESS | 26648 | 16:13:56 INFO - PROCESS | 26648 | [#5] yui.html Cycles:180 Average:21402.63 Median:4063.01 stddev:32427.60 (798.1%) stddev-sans-first:32481.35 16:13:56 INFO - PROCESS | 26648 | Values: 710.7 722.0 757.3 789.7 807.2 13921.9 14896.2 15023.0 15049.5 15063.8 14505.6 15160.4 15165.8 15169.2 15189.3 646.1 663.1 777.3 795.5 810.4 800.1 804.5 807.9 808.7 808.7 850.2 850.3 851.1 851.7 851.8 839.1 839.1 846.4 847.6 848.8 613.3 618.9 619.0 619.3 619.7 14761.9 14841.5 14853.9 14866.0 14872.9 15379.5 15407.8 15443.5 15530.2 15551.5 11608.9 11692.5 11816.0 11900.9 11915.5 3790.2 3808.0 3847.8 3850.5 3922.7 82210.0 84787.2 84834.6 85335.1 87271.6 11218.2 11286.3 11392.7 11439.9 11562.1 21472.9 21504.6 21540.9 21614.7 23596.4 7768.7 8007.8 8116.4 8255.0 8267.7 4312.2 4349.2 4382.3 4511.7 4530.8 3356.7 3572.5 3592.2 3613.2 3617.1 662.4 666.7 674.2 681.5 687.4 683.4 684.6 703.0 708.5 743.7 9552.6 9765.5 9890.2 10031.8 10084.4 655.2 656.7 663.5 684.6 689.3 4203.3 4474.2 4548.6 4657.3 4689.7 107572.9 126477.0 128923.4 129809.0 130022.0 107670.5 108307.0 108418.0 109028.0 112606.0 94606.5 95931.5 98707.0 98787.0 99332.0 8446.2 8450.7 8690.9 8756.0 8961.2 52724.5 54921.2 55518.2 55718.0 56776.0 45960.8 46452.5 53581.0 77694.6 79151.0 11501.5 11873.8 12041.4 12174.8 12470.4 12747.1 12832.9 12859.5 13010.9 13216.6 11641.5 12303.4 12694.1 12913.0 13150.3 12250.7 12256.1 12547.7 12931.0 12987.4 11927.6 11948.5 12396.6 12810.8 12855.9 10534.5 10544.4 10725.2 10903.5 11101.2 9789.1 10693.6 10706.4 10825.8 10960.5 16:13:56 INFO - PROCESS | 26648 | -------- Summary: end -------- 16:13:56 INFO - PROCESS | 26648 | 16:13:57 INFO - TEST-INFO | 26648: exit 0 16:13:57 INFO - TEST-OK | dromaeo_css | took 1115253ms 16:13:57 INFO - TEST-START | kraken 16:13:57 INFO - operating with platform_type : linux_ 16:13:57 INFO - Initialising browser for kraken test... 16:13:57 INFO - TEST-INFO | started process 27006 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCuCx2R/profile http://localhost:37608/getInfo.html) 16:14:01 INFO - PROCESS | 27006 | __metrics Screen width/height:1600/1200 16:14:01 INFO - PROCESS | 27006 | colorDepth:24 16:14:01 INFO - PROCESS | 27006 | Browser inner width/height: 1024/697 16:14:01 INFO - PROCESS | 27006 | __metrics 16:14:01 ERROR - PROCESS | 27006 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3083: TypeError: this.tabs is undefined 16:14:02 INFO - TEST-INFO | 27006: exit 0 16:14:02 INFO - Browser initialized. 16:14:02 INFO - Running cycle 1/1 for kraken test... 16:14:02 INFO - TEST-INFO | started process 27127 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCuCx2R/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:14:14 INFO - PROCESS | 27127 | RSS: Main: 184897536 16:14:14 INFO - PROCESS | 27127 | 16:14:17 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37608/tests/kraken/driver.html?testName=audio-beat-detection) 16:14:18 INFO - PROCESS | 27127 | RSS: Main: 198909952 16:14:18 INFO - PROCESS | 27127 | 16:14:21 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37608/tests/kraken/driver.html?testName=audio-dft) 16:14:21 INFO - PROCESS | 27127 | RSS: Main: 196718592 16:14:21 INFO - PROCESS | 27127 | 16:14:24 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37608/tests/kraken/driver.html?testName=audio-fft) 16:14:25 INFO - PROCESS | 27127 | RSS: Main: 192471040 16:14:25 INFO - PROCESS | 27127 | 16:14:27 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37608/tests/kraken/driver.html?testName=audio-oscillator) 16:14:28 INFO - PROCESS | 27127 | RSS: Main: 192987136 16:14:28 INFO - PROCESS | 27127 | 16:14:30 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37608/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:14:30 INFO - PROCESS | 27127 | RSS: Main: 193163264 16:14:30 INFO - PROCESS | 27127 | 16:14:33 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37608/tests/kraken/driver.html?testName=imaging-darkroom) 16:14:34 INFO - PROCESS | 27127 | RSS: Main: 193024000 16:14:34 INFO - PROCESS | 27127 | 16:14:38 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37608/tests/kraken/driver.html?testName=imaging-desaturate) 16:14:38 INFO - PROCESS | 27127 | RSS: Main: 191700992 16:14:38 INFO - PROCESS | 27127 | 16:14:41 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37608/tests/kraken/driver.html?testName=json-parse-financial) 16:14:42 INFO - PROCESS | 27127 | RSS: Main: 193163264 16:14:42 INFO - PROCESS | 27127 | 16:14:43 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37608/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:14:44 INFO - PROCESS | 27127 | RSS: Main: 193376256 16:14:44 INFO - PROCESS | 27127 | 16:14:46 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37608/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:14:46 INFO - PROCESS | 27127 | RSS: Main: 193404928 16:14:46 INFO - PROCESS | 27127 | 16:14:48 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37608/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:14:49 INFO - PROCESS | 27127 | RSS: Main: 193941504 16:14:49 INFO - PROCESS | 27127 | 16:14:52 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37608/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:14:52 INFO - PROCESS | 27127 | RSS: Main: 193724416 16:14:52 INFO - PROCESS | 27127 | 16:14:55 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37608/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:14:56 INFO - PROCESS | 27127 | RSS: Main: 194195456 16:14:56 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | Cycle 1(1): loaded http://localhost:37608/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37608/tests/kraken/driver.html?testName=ai-astar) 16:14:58 INFO - PROCESS | 27127 | RSS: Main: 195256320 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | __start_tp_report 16:14:58 INFO - PROCESS | 27127 | _x_x_mozilla_page_load 16:14:58 INFO - PROCESS | 27127 | _x_x_mozilla_page_load_details 16:14:58 INFO - PROCESS | 27127 | |i|pagename|runs| 16:14:58 INFO - PROCESS | 27127 | |0;ai-astar;111;115;113;113;112;114;110;112;113;112 16:14:58 INFO - PROCESS | 27127 | |1;audio-beat-detection;161;130;126;162;131;125;124;130;152;123 16:14:58 INFO - PROCESS | 27127 | |2;audio-dft;164;164;166;166;175;163;163;173;162;165 16:14:58 INFO - PROCESS | 27127 | |3;audio-fft;79;78;77;114;77;80;77;75;112;76 16:14:58 INFO - PROCESS | 27127 | |4;audio-oscillator;84;84;110;83;83;84;104;84;82;124 16:14:58 INFO - PROCESS | 27127 | |5;imaging-gaussian-blur;120;120;117;118;118;118;117;119;120;119 16:14:58 INFO - PROCESS | 27127 | |6;imaging-darkroom;147;148;147;148;148;146;147;147;149;148 16:14:58 INFO - PROCESS | 27127 | |7;imaging-desaturate;97;97;99;97;96;97;97;97;96;95 16:14:58 INFO - PROCESS | 27127 | |8;json-parse-financial;54;53;54;52;56;54;55;54;54;53 16:14:58 INFO - PROCESS | 27127 | |9;json-stringify-tinderbox;63;61;61;61;62;61;61;63;61;63 16:14:58 INFO - PROCESS | 27127 | |10;stanford-crypto-aes;81;81;81;81;82;82;81;85;83;83 16:14:58 INFO - PROCESS | 27127 | |11;stanford-crypto-ccm;134;132;134;131;132;140;138;132;187;139 16:14:58 INFO - PROCESS | 27127 | |12;stanford-crypto-pbkdf2;167;164;164;163;168;165;171;174;165;169 16:14:58 INFO - PROCESS | 27127 | |13;stanford-crypto-sha256-iterative;68;67;66;67;66;65;66;65;68;65 16:14:58 INFO - PROCESS | 27127 | __end_tp_report 16:14:58 INFO - PROCESS | 27127 | __start_cc_report 16:14:58 INFO - PROCESS | 27127 | _x_x_mozilla_cycle_collect,791 16:14:58 INFO - PROCESS | 27127 | __end_cc_report 16:14:58 INFO - PROCESS | 27127 | __startTimestamp1476400498352__endTimestamp 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | ------- Summary: start ------- 16:14:58 INFO - PROCESS | 27127 | Number of tests: 14 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:1.43 (1.3%) stddev-sans-first:1.41 16:14:58 INFO - PROCESS | 27127 | Values: 111.0 115.0 113.0 113.0 112.0 114.0 110.0 112.0 113.0 112.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:130.50 stddev:15.59 (11.9%) stddev-sans-first:13.76 16:14:58 INFO - PROCESS | 27127 | Values: 161.0 130.0 126.0 162.0 131.0 125.0 124.0 130.0 152.0 123.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.50 stddev:4.38 (2.6%) stddev-sans-first:4.58 16:14:58 INFO - PROCESS | 27127 | Values: 164.0 164.0 166.0 166.0 175.0 163.0 163.0 173.0 162.0 165.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#3] audio-fft Cycles:10 Average:84.50 Median:77.00 stddev:15.09 (19.6%) stddev-sans-first:15.88 16:14:58 INFO - PROCESS | 27127 | Values: 79.0 78.0 77.0 114.0 77.0 80.0 77.0 75.0 112.0 76.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#4] audio-oscillator Cycles:10 Average:92.20 Median:83.50 stddev:14.94 (17.9%) stddev-sans-first:15.55 16:14:58 INFO - PROCESS | 27127 | Values: 84.0 84.0 110.0 83.0 83.0 84.0 104.0 84.0 82.0 124.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:1.17 (1.0%) stddev-sans-first:1.13 16:14:58 INFO - PROCESS | 27127 | Values: 120.0 120.0 117.0 118.0 118.0 118.0 117.0 119.0 120.0 119.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.85 (0.6%) stddev-sans-first:0.88 16:14:58 INFO - PROCESS | 27127 | Values: 147.0 148.0 147.0 148.0 148.0 146.0 147.0 147.0 149.0 148.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:97.00 stddev:1.03 (1.1%) stddev-sans-first:1.09 16:14:58 INFO - PROCESS | 27127 | Values: 97.0 97.0 99.0 97.0 96.0 97.0 97.0 97.0 96.0 95.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#8] json-parse-financial Cycles:10 Average:53.90 Median:54.00 stddev:1.10 (2.0%) stddev-sans-first:1.17 16:14:58 INFO - PROCESS | 27127 | Values: 54.0 53.0 54.0 52.0 56.0 54.0 55.0 54.0 54.0 53.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.50 stddev:0.95 (1.5%) stddev-sans-first:0.88 16:14:58 INFO - PROCESS | 27127 | Values: 63.0 61.0 61.0 61.0 62.0 61.0 61.0 63.0 61.0 63.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:1.33 (1.6%) stddev-sans-first:1.36 16:14:58 INFO - PROCESS | 27127 | Values: 81.0 81.0 81.0 81.0 82.0 82.0 81.0 85.0 83.0 83.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:136.00 stddev:16.86 (12.4%) stddev-sans-first:17.75 16:14:58 INFO - PROCESS | 27127 | Values: 134.0 132.0 134.0 131.0 132.0 140.0 138.0 132.0 187.0 139.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.00 Median:167.50 stddev:3.53 (2.1%) stddev-sans-first:3.74 16:14:58 INFO - PROCESS | 27127 | Values: 167.0 164.0 164.0 163.0 168.0 165.0 171.0 174.0 165.0 169.0 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.30 Median:66.50 stddev:1.16 (1.7%) stddev-sans-first:1.05 16:14:58 INFO - PROCESS | 27127 | Values: 68.0 67.0 66.0 67.0 66.0 65.0 66.0 65.0 68.0 65.0 16:14:58 INFO - PROCESS | 27127 | -------- Summary: end -------- 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | 16:14:58 INFO - PROCESS | 27127 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 16:14:58 INFO - PROCESS | 27127 | 16:14:59 INFO - TEST-INFO | 27127: exit 0 16:14:59 INFO - TEST-OK | kraken | took 62436ms 16:14:59 INFO - SUITE-END | took 1177s 16:14:59 INFO - Completed test suite (00:19:37) 16:14:59 INFO - javascript benchmark 16:14:59 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7168.172303355391, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.4922137847257, 3079.676633953436, 3101.426236146313, 3125.7499400048, 3139.9686003139977, 5162.5611822995, 5432.701201433924, 5439.401665816757, 5442.564594832414, 5452.10518466968, 5192.065428222918, 5192.3249977502965, 5269.499397557235, 5272.736363181844, 5280.973595132029, 4749.477557468685, 4777.4028246469015, 4834.033193361324, 4835.468098509179, 4850.927236091444, 4758.238681810911, 4795.2807078938085, 4842.782074806642, 4845.806167753303, 4855.344528488662, 4838.298446725223, 4840.249761287007, 4840.878978025542, 4844.927326090112, 4845.6123510119105, 4819.301201325806, 4836.758162091881, 4840.273958906175, 4880.219164933629, 4922.286268491084, 4905.705657660516, 4941.283513890466, 4965.478624744386, 4980.77586508608, 4983.476734942815, 5395.919061214085, 5415.296011518478, 5488.368837583689, 5496.422875598045, 5570.972145139248, 5410.83767486976, 5460.535854452376, 5487.533559647395, 5618.0, 5779.133130030529, 5725.456081672234, 5784.768609255625, 5789.565782566325, 5841.0362290222065, 5854.882902341972, 5355.678659280456, 5402.0, 5405.702686352289, 5417.160340147283, 5431.511163995259, 5597.776088956478, 5637.154426836008, 5845.590808643439, 5882.55880808941, 5896.941030589639, 5590.972045139748, 5604.131359639263, 5623.831285061455, 5651.4348565143155, 5734.139879018097, 5672.546196304285, 5752.683602401824, 5753.223314852525, 5758.136279558016, 5770.855728606818, 5370.489803468664, 5413.133898576209, 5711.343195532567, 5746.2529871116485, 5753.539716822645, 5567.693776842312, 5644.943550564524, 5645.5483561314995, 5653.491185793216, 5731.971340143273, 4295.183915056129, 4295.5489673583825, 4297.67767417445, 4303.031817840961, 4306.956930430656, 3708.1100535871196, 3792.544894612664, 3822.0253835272383, 3854.036490877281, 3856.5564960029396, 5316.069687804618, 5323.3079699639575, 5353.170258609922, 5410.972945135328, 5511.641743286674, 5739.167820666064, 5748.942510574924, 5749.338826035059, 5752.050911599539, 5766.711664416763, 5165.328507294028, 5216.26972223889, 5409.377921538995, 5445.1832225166545, 5452.154915988028, 4826.420829500412, 4858.562729354375, 4883.58489528387, 4901.215805471179, 4969.0, 5907.616004959664, 5920.911186332209, 5926.081457374028, 5932.644041357532, 5933.851653708692, 5488.368837583569, 5660.88678226425, 5705.258316418839, 5717.113847353667, 5731.627444216113, 5716.914246286392, 5861.413858614104, 5930.881382372242, 5935.0503919372695, 6026.15633811258, 5666.688332141772, 5669.886602268014, 5673.0, 5673.205751194753, 5673.978683836949, 5733.913991290051, 5778.566607504538, 5784.2769653793275, 5791.391903850204, 5810.767569297181, 5337.359516858002, 5388.407275199646, 5483.424240454695, 5546.667199968015, 5558.221848941071, 5455.5908306876345, 5502.0, 5513.448655134454, 5532.170174473861, 5559.305086864142, 5407.864803379947, 5480.72596370172, 5511.393746687781, 5522.144067669517, 5551.389347171727, 5429.918551221814, 5483.314585676791, 5553.750081246434, 5645.040343141758, 5670.177824215383, 5595.272614560081, 5603.2155498231095, 5614.466625670555, 5644.463775941279, 5657.15142728594], "value": 5252.160890566513, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [537.7364458784082, 571.7798647520705, 589.7080944932256, 591.6479694581723, 599.4365296621177, 40600.0, 41988.37017444741, 42039.57960420399, 45984.54015459844, 46019.76990115053, 44139.77930110345, 44268.0, 44402.0, 44426.11147777043, 44639.77680111595, 8567.271781898531, 8810.647574097029, 8840.33697472689, 8846.380753347268, 8848.46909185451, 8560.272376847975, 8594.226519613234, 8624.611892464854, 8666.176713212266, 8717.520536370497, 8659.65361385547, 8688.044315125331, 8759.2992560595, 8780.517071561062, 8802.29581633471, 8647.827043459158, 8686.391952563323, 8698.782530436727, 8720.999999999969, 8742.606582703793, 8258.710945116893, 8343.207395297437, 8360.916390836075, 8373.330133589297, 8389.790255243668, 41906.580934190875, 41984.0, 42158.78920605408, 42220.78889605563, 42249.36625950613, 3137.5293705944064, 3192.7126558609602, 3197.488401855692, 3313.1717070732316, 3435.158386195373, 30378.0, 30696.53955190674, 31065.116860392453, 31464.528032079535, 32026.519602205986, 3965.6232657897453, 4015.297322968469, 4061.695372847019, 4218.303979843322, 4224.514180869209, 343956.0, 345994.27002865076, 346634.0, 346931.0, 347712.0, 53460.46539534633, 54084.72957635186, 54156.0, 54163.72918135384, 54222.72888635532, 55310.0, 55643.721781390836, 55691.16463253054, 55716.0, 55740.442595574335, 14444.494442694455, 14731.263436828116, 14738.26308684583, 14740.705185896222, 14743.262836858114, 10244.692659220234, 10270.127039201601, 10286.639967601099, 10306.639267625596, 10307.330023548446, 14452.277386130652, 14903.180325082008, 14976.176310303037, 15102.54692359231, 15136.394544218108, 5659.0, 5769.94230057694, 5900.232969713996, 5905.940940590625, 5937.554683398763, 855.5422848775875, 892.7500299916034, 988.0695330301743, 1012.8227560176939, 1106.3583121789343, 30393.544096838566, 30777.49643064995, 30926.0, 31223.531647025313, 31665.0, 1037.2739082642029, 1065.9626913058162, 1078.8219943709357, 1080.5461706083463, 1131.3890499130541, 16045.598860028593, 16233.675326493403, 16274.186290685418, 16571.42000030017, 16765.245563949407, 458729.0, 467199.0, 469012.0, 730414.0, 730844.0, 53833.46166538363, 54868.72565637146, 55328.0, 55532.44467555353, 55556.444435555124, 1317.2952470428274, 1324.602619214232, 1333.6599167212298, 1333.7665908466174, 1378.0147194755798, 29561.113166605035, 30858.382832342777, 31175.376492470477, 31375.37249255048, 31875.68124318727, 47575.286370703776, 47941.76029119832, 48119.75940120277, 48121.5187848131, 48161.5183848157, 424586.0, 428279.0, 429562.0, 430418.0, 431184.0, 26279.21162365132, 26392.20823375302, 26434.86782566075, 26556.601650974866, 26593.468130637666, 44360.77819610881, 45034.77482612697, 45077.77461112673, 45250.32124518069, 45405.09189816119, 37482.81258593799, 38271.23457530778, 39056.60943390644, 39159.0, 39774.204515910096, 38436.0, 38503.229935401694, 38736.0, 38762.6123738759, 38790.80604597072, 38311.23377532378, 39155.804220978716, 40107.0, 40168.7991560052, 42289.0, 31651.841740791147, 35100.82449587736, 35523.64476355203, 36052.639473604926, 36546.26907461889, 26920.865395672896, 27631.074630282765, 27706.821770502418, 27879.442411151256, 28121.718782812728], "value": 19079.805434485563, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.6201641383239, 394.52262762057904, 396.383623465511, 405.7687118342545, 422.53170233438806, 13753.31233438329, 17686.0, 18462.169202385892, 19018.524536886584, 19264.807351926476, 18570.814291857077, 18631.347902823403, 19359.612807743837, 19518.90240548799, 19657.01714914252, 5474.890502189964, 5502.889942201154, 5621.662700237999, 5662.462066103734, 5662.5753068520025, 5512.91730624041, 5634.267545219136, 5640.5487560995025, 5644.238027866227, 5653.0, 5408.3509978802595, 5554.833354999336, 5616.747246373902, 5617.297837770278, 5622.269105016363, 5342.866428339284, 5529.751161197756, 5547.3343198816, 5555.666660000393, 5603.523700485443, 4963.45402005779, 5009.624278179114, 5010.774515146827, 5022.347094877679, 5047.899042019176, 21616.783832161633, 22285.108595656155, 22392.10431582751, 22408.77591224083, 22514.774852251594, 2317.9768202317928, 2485.8135639826905, 2604.4265272317257, 2650.363912660967, 2767.266674331304, 14028.649283767885, 14361.281935903164, 14377.353019114165, 14589.124652520883, 14653.706925861423, 1836.0911348882255, 1901.9429417117508, 1912.3975947576469, 1995.1919472613615, 1998.41046891166, 78420.0, 80777.59611201964, 82134.0, 82650.58674706648, 85322.0, 10294.536745846455, 10412.843807342895, 10586.153107751361, 10751.462426878781, 10942.17933654979, 13105.2136871788, 15039.548813535612, 15071.0, 15095.698086038217, 15159.772603410958, 7082.681279342442, 7411.59236242001, 7581.279778421042, 7596.924030759732, 7893.447458677838, 6810.353016463428, 6981.476389270825, 7034.155901291878, 7097.964510177416, 7297.489175757646, 6418.711157997901, 6556.147700798961, 6573.408393244536, 6601.966990165019, 6653.538190869409, 1959.6783452048926, 1979.7129416234566, 1987.5826076524093, 1989.383291179739, 1995.9401217963484, 888.8311220868014, 901.8827552418144, 935.6257497001254, 938.7653086728318, 973.6105557776805, 18424.447266582025, 19241.80758192428, 19627.21491140367, 19744.23580698703, 19855.882308879278, 885.5262434597588, 916.6654171227455, 938.1790932933683, 949.2121539122512, 969.2488321550713, 10975.725606859733, 11120.165987550967, 11234.550617975354, 11257.15571332137, 11316.71708207285, 444435.0, 447637.0, 451307.0, 453332.0, 455247.0, 75856.62071689607, 75924.62037689776, 76184.0, 79899.20100799034, 88637.0, 983.4787562591838, 999.515235110956, 1043.3270540501335, 1046.0, 1051.9631812886512, 16286.348546058025, 16636.75044874352, 17298.481045568653, 17337.653246935242, 17524.123793810002, 40543.59456405398, 40895.795521022206, 41331.586684133974, 41874.0, 42019.36970945377, 48605.27092093551, 58700.4129958712, 58770.70614646899, 60175.69912150411, 61169.38830611815, 8163.346932245525, 8482.109378515168, 8525.44584601999, 8683.0, 8862.86705699402, 7516.022917020752, 11873.762524749283, 13047.956163506708, 13060.934695326843, 13280.734385312046, 10742.355458672504, 11158.721031974266, 11203.495842686936, 11396.94301528487, 11900.880991190324, 10763.408012559072, 10931.56273749041, 11059.668209953714, 11182.944085279521, 11195.496202670736, 11384.0, 11479.540818367172, 11595.478203481032, 11633.767324653629, 12232.571859984857, 8487.490750554987, 8570.528620925908, 8746.300295976434, 8821.161989611233, 8866.916274675317, 9710.70867873965, 11456.369899655265, 11608.245464045149, 11643.243189192675, 11649.941750291195], "value": 9117.979618384687, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1482.7405204089284, 1521.330614529607, 1654.3548016273655, 1770.2476447509805, 1800.747895294659, 8001.759947201579, 8251.422400431971, 8586.22723954844, 9299.907000929998, 9331.486768227745, 8567.35744819138, 8906.153915378045, 8912.554372281393, 9202.0, 9203.723888283363, 2360.89375978081, 2393.640953856918, 2395.053953688292, 2396.3769419950763, 2396.940076498093, 2361.53949979754, 2364.326167042393, 2421.878906054699, 2429.6112621980487, 2432.622943443769, 2369.135265628042, 2370.3007612754277, 2388.868612226327, 2426.9029238830426, 2436.305652888927, 2309.0763694522157, 2309.561183375153, 2321.58211521926, 2321.651752237161, 2352.6353415220497, 2228.832837537191, 2241.9887900560393, 2255.210676263311, 2262.1403866530777, 2275.70415845939, 8896.37725359225, 9024.729258122266, 9056.909430905738, 9122.270218382513, 9123.31575131861, 5203.427622961472, 5341.332333458317, 5346.438623944468, 5353.518183363477, 5362.329708786402, 3571.7321200910037, 3589.7846129232066, 3639.344917914774, 3728.4034554471427, 3730.664240218366, 1179.787638225119, 1193.91045671575, 1202.5370232460566, 1202.7233736240626, 1211.460899899545, 12658.0, 12695.047871409588, 12696.809547856697, 12734.872651273461, 12738.617841464864, 4449.57729015743, 4658.301254811805, 4853.878653033702, 4877.731724755102, 4908.0, 10498.212634052477, 10531.736706582396, 10565.577376904837, 10604.363738175734, 10634.415107169025, 5230.92153617696, 5280.234366016906, 5281.15501519755, 5310.415854256029, 5314.813981510706, 4347.673924455678, 4473.821047158142, 4757.405324334458, 4843.200871856175, 4852.223644216909, 3967.147063381387, 3989.960100399017, 4030.2544029354663, 4101.958980410217, 4139.606737359946, 1275.330451512963, 1313.5730887461614, 1317.433503593464, 1326.9137506062075, 1330.255057167989, 812.7196117339508, 834.6869923778584, 840.7982084299724, 845.2730651639584, 859.2438653984453, 5393.7033463159905, 5644.971775141098, 5668.433156684298, 5757.453041961007, 6045.909311360333, 928.2017464980112, 940.5626383731598, 942.1238248429026, 948.9810203795886, 953.6471505542994, 3742.6070262622034, 3972.483577134954, 3977.423273625308, 4019.095703466755, 4089.1003979124544, 11140.220184587, 11334.319940803578, 11456.312621242752, 11465.08279337651, 11485.827712584318, 11219.990200881959, 11306.152038597138, 11384.487698053608, 11390.829137562943, 11428.085753139729, 7868.134505204423, 8222.424430289822, 8346.874796878052, 8349.165083491602, 8424.831503369898, 5827.329857066322, 5946.583739138218, 5961.986462301333, 6077.604955677867, 6162.630242185304, 9962.800743985224, 9995.850062248926, 10163.847542286723, 10185.236107291834, 10272.486375681336, 10057.647982320585, 10343.431111288952, 10352.016558426938, 10428.374297542172, 10432.426216558162, 7550.471466997257, 7712.228777122243, 7815.218478152139, 7877.881831772643, 7943.801404964922, 8336.166383361615, 8454.408191426786, 8458.873116903129, 8500.107488713844, 8515.48907065578, 7654.923450765644, 7660.463767536219, 7777.727779527916, 7939.28546430824, 7974.362051036019, 7457.403407727477, 7490.4007679386605, 7494.175640679412, 7554.546727196386, 7725.266099720518, 6780.38976492118, 6894.482913781386, 6920.861582768417, 6923.411510021705, 6968.338007889445, 4934.284528743384, 4969.577585905094, 5014.824481143142, 5126.462740708899, 5207.307625021807, 5009.474005229544, 5063.645544811975, 5179.715115668674, 5217.921731173959, 5247.658902171346], "value": 4679.350520601046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.6978900255756, 325.7166762953961, 331.17041810265283, 335.83711899728644, 338.98305084745755, 5262.500062494067, 5360.705161216131, 5405.18922161676, 5444.373897001851, 5458.5087342139195, 5201.55786758126, 5248.790048398059, 5250.0, 5284.894302113965, 5290.788368465266, 4174.812133454002, 4176.018635620627, 4180.749155050699, 4183.267928112583, 4196.9370459443135, 4014.919701605966, 4166.9791651041705, 4206.621404073633, 4210.431591735122, 4232.534421213664, 4059.918801623966, 4106.823383606678, 4152.356384760352, 4152.397902304164, 4152.792360381984, 4071.226466971266, 4120.25835349637, 4136.234796562646, 4138.399932009842, 4138.710290279681, 3669.2478042001326, 3672.467492213641, 3681.8770275066095, 3686.9631303687156, 3690.6493883081066, 5110.310108135429, 5158.509941555546, 5198.480151984809, 5224.373075230958, 5226.686398816083, 4710.717356958594, 4712.434507859079, 4729.101470720587, 4735.952640473585, 4749.050189961987, 5462.344518657746, 5584.664920104766, 5588.748506317225, 5597.160425936101, 5616.943830561683, 4013.8996525086814, 4022.7787471689044, 4022.8189731462153, 4028.113814960704, 4028.617281358266, 5835.183074369592, 5848.298204215479, 5897.734601942923, 5903.822885313448, 5909.7636094556165, 4155.4182414462, 4156.418101465797, 4167.770772607475, 4168.562300958356, 4181.351890456984, 4065.6137666921595, 4173.4157217989505, 4182.205380977604, 4190.16196760643, 4205.894852628648, 4784.330193772875, 4785.425748910153, 4792.257200133915, 4803.447603525639, 4806.735629540409, 5639.63342382752, 5668.57485688575, 5671.262735844314, 5672.780352224291, 5775.422457754191, 1386.34148779329, 1417.7518934186476, 1422.544785668597, 1433.6200906759716, 1437.8490258522913, 906.6962567539948, 921.2998121427763, 929.6142101027998, 934.149923569562, 939.8120375924842, 4742.0, 4766.689160480826, 4815.614750819926, 4834.444038935568, 4841.830535931225, 5063.265826455144, 5070.8225212117395, 5081.390233171969, 5108.693478391234, 5120.743962801845, 4868.46643307357, 4874.4150701916, 4881.755912204447, 4894.388201474816, 5110.872228194251, 3071.5392691096067, 3078.7536997040183, 3091.825106459531, 3130.358276553301, 3136.2316232523176, 6048.395160484004, 6067.393260673985, 6135.533423615643, 6145.26256849172, 6158.599691020069, 5610.579206559524, 5942.227510423703, 5981.581289309706, 5981.760729570856, 5985.551083668655, 5984.222051133324, 6038.788642397495, 6102.420270074336, 6170.451990105617, 6182.1345011698395, 5569.721513924369, 5781.768729250783, 5904.557158213065, 5922.407759224043, 5966.373530779206, 5726.7709291629535, 5817.360090390139, 5836.824895253149, 5860.179574859609, 5867.73595188209, 6133.04937734634, 6136.110264011782, 6143.1298282082, 6160.691965401802, 6175.475084617858, 4064.329385651453, 4084.591540845892, 4227.450431443893, 4243.851465198703, 4277.50808656996, 5821.243238378984, 5838.795642152674, 5843.357230704534, 5843.737031833492, 5850.882982340244, 5659.377468478547, 5703.6881517252095, 5709.7430615623225, 5715.114157305624, 5731.942680573307, 5420.701861397661, 5562.443755624405, 5595.006671430765, 5614.410486898817, 5627.777028073806, 5576.470235327637, 5588.832335029955, 5625.690587017753, 5661.207430959751, 5690.459406356389, 5455.345358556999, 5620.690862002465, 5652.85867853307, 5656.60403771732, 5664.5751568631695, 5494.945050549443, 5539.645650598399, 5555.527780138734, 5559.749811258423, 5570.387257401601], "value": 4264.866923615726, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [710.7157137145143, 721.9819504512386, 757.2587234212153, 789.7393860026192, 807.2371608829657, 13921.930390348047, 14896.180710060942, 15023.023503472294, 15049.548513544598, 15063.849361506396, 14505.564833055, 15160.393584256617, 15165.77251341228, 15169.241537923088, 15189.316480758365, 646.0890144895686, 663.0816319397621, 777.3120788102542, 795.5028107432854, 810.3638643664724, 800.1238643685156, 804.5092493578912, 807.9151689072651, 808.7007807111377, 808.720991258018, 850.200811237438, 850.2815121222557, 851.0680804519042, 851.7317045130795, 851.8040850604365, 839.064443145891, 839.0812060793421, 846.4117438380329, 847.6100993542977, 848.8259906719107, 613.2702084519408, 618.9381061893774, 619.0034045187244, 619.3373090792853, 619.7211254935252, 14761.852381476156, 14841.480548180762, 14853.885958553152, 14866.0, 14872.851271487254, 15379.538613841603, 15407.768883466757, 15443.459478918296, 15530.223488825513, 15551.533453996286, 11608.941955290255, 11692.532298708042, 11816.0, 11900.940495297555, 11915.463804128834, 3790.1851102013197, 3807.961920380816, 3847.7883716395586, 3850.4801851749935, 3922.686185105185, 82210.0, 84787.15212847915, 84834.57582712047, 85335.14664853396, 87271.56364218202, 11218.214724969337, 11286.322820630789, 11392.715182120513, 11439.885601143882, 11562.132840036862, 21472.926353682255, 21504.56990860174, 21540.892295538422, 21614.675779863315, 23596.410089747893, 7768.65041073153, 8007.7998050048045, 8116.35069194463, 8255.0, 8267.710630127916, 4312.223799716081, 4349.195398851222, 4382.276924307517, 4511.684182107287, 4530.818767249339, 3356.714679252242, 3572.517710109102, 3592.173800026009, 3613.1509095362567, 3617.1138071172204, 662.4435474201694, 666.74330382802, 674.1606699658857, 681.5229339462396, 687.4088284075691, 683.4361651637419, 684.6302996381997, 702.9543079699803, 708.4686485136148, 743.6690672650618, 9552.617895284111, 9765.511724413751, 9890.208783297463, 10031.799364012679, 10084.445355505517, 655.1646650520529, 656.6636893920848, 663.5189487621436, 684.6474065856088, 689.3141324382171, 4203.327467605169, 4474.194644963938, 4548.6133678637025, 4657.347971284023, 4689.718616882998, 107572.9242707563, 126477.0, 128923.35538322436, 129809.0, 130022.0, 107670.46164769126, 108307.0, 108418.0, 109028.0, 112606.0, 94606.52696736473, 95931.52034239784, 98707.0, 98787.0, 99332.00667993372, 8446.239838414573, 8450.66197352099, 8690.869636955324, 8755.956220218859, 8961.23829474502, 52724.472755271956, 54921.176182356496, 55518.16722749081, 55718.0, 56776.0, 45960.770196148806, 46452.53547464482, 53581.0, 77694.611526942, 79151.0, 11501.53993840237, 11873.762524749283, 12041.397930103634, 12174.75650487003, 12470.376481176087, 12747.107702460738, 12832.871671283168, 12859.549915752903, 13010.93494532559, 13216.603501894959, 11641.47613357384, 12303.446344914679, 12694.111412201057, 12913.031522635652, 13150.27673477968, 12250.693732656755, 12256.142070055368, 12547.74904501923, 12931.0, 12987.41556629935, 11927.582534611247, 11948.522059117538, 12396.566120185751, 12810.807837882625, 12855.935720321339, 10534.473276335999, 10544.367337959748, 10725.249232553646, 10903.454827258447, 11101.222914395914, 9789.10500037272, 10693.572257109628, 10706.411147386969, 10825.837612435977, 10960.451977401257], "value": 7438.86023116496, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1525.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 115.0, 113.0, 113.0, 112.0, 114.0, 110.0, 112.0, 113.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 130.0, 126.0, 162.0, 131.0, 125.0, 124.0, 130.0, 152.0, 123.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 164.0, 166.0, 166.0, 175.0, 163.0, 163.0, 173.0, 162.0, 165.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 78.0, 77.0, 114.0, 77.0, 80.0, 77.0, 75.0, 112.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 110.0, 83.0, 83.0, 84.0, 104.0, 84.0, 82.0, 124.0], "value": 92.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 120.0, 117.0, 118.0, 118.0, 118.0, 117.0, 119.0, 120.0, 119.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 148.0, 148.0, 146.0, 147.0, 147.0, 149.0, 148.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 99.0, 97.0, 96.0, 97.0, 97.0, 97.0, 96.0, 95.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 52.0, 56.0, 54.0, 55.0, 54.0, 54.0, 53.0], "value": 53.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 61.0, 61.0, 61.0, 62.0, 61.0, 61.0, 63.0, 61.0, 63.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 81.0, 81.0, 82.0, 82.0, 81.0, 85.0, 83.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 132.0, 134.0, 131.0, 132.0, 140.0, 138.0, 132.0, 187.0, 139.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 164.0, 164.0, 163.0, 168.0, 165.0, 171.0, 174.0, 165.0, 169.0], "value": 167.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 68.0, 65.0], "value": 66.3, "unit": "score"}]}]} 16:14:59 INFO - Return code: 0 16:14:59 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:14:59 ERROR - # TBPL SUCCESS # 16:14:59 INFO - Running post-action listener: _resource_record_post_action 16:14:59 INFO - [mozharness: 2016-10-13 23:14:59.687382Z] Finished run-tests step (success) 16:14:59 INFO - Running post-run listener: _resource_record_post_run 16:14:59 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 397910016; Read time: 0; Write time: 278856 16:14:59 INFO - TinderboxPrint: CPU usage
13.4% 16:14:59 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 16:14:59 INFO - TinderboxPrint: I/O write bytes / time
397,910,016 / 278,856 16:14:59 INFO - TinderboxPrint: CPU idle
8,251.2 (86.6%) 16:14:59 INFO - TinderboxPrint: CPU user
1,216.4 (12.8%) 16:14:59 INFO - TinderboxPrint: Swap in / out
0 / 0 16:14:59 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 108023808; Read time: 0; Write time: 90424 16:14:59 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 289886208; Read time: 0; Write time: 188432 16:15:00 INFO - Running post-run listener: _upload_blobber_files 16:15:00 INFO - Blob upload gear active. 16:15:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:15:00 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 16:15:00 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'] 16:15:00 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 16:15:00 INFO - (blobuploader) - INFO - Open directory for files ... 16:15:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:15:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:15:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:01 INFO - (blobuploader) - INFO - Done attempting. 16:15:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:15:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:15:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:02 INFO - (blobuploader) - INFO - Done attempting. 16:15:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:15:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:15:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:15:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:15:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:15:05 INFO - (blobuploader) - INFO - Done attempting. 16:15:05 INFO - (blobuploader) - INFO - Iteration through files over. 16:15:05 INFO - Return code: 0 16:15:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:15:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:15:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c36dcd7d6730f57458c6e2e412a824d026c20139dde71c707c456a5fea6c481daafed7f541f819bf53d1992be8a77cddc73142af88172d459ac5a4fdd3237ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98cc44afdba972f85825cb474ea44468efd3b75999a4cea263bf53fec39c96f04f1eb1b3e6d0c1e6a7828265b20f0a439d833ea6abf46e2945ac7aafddeb0a73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3fd8521587e537a6afc363519f223aa484d41c049094876c2c0962795ae45d339be56c8d258fdcac999812045118a202192feba756030fc963ee4e5d95f4928"} 16:15:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:15:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:15:05 INFO - Contents: 16:15:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9c36dcd7d6730f57458c6e2e412a824d026c20139dde71c707c456a5fea6c481daafed7f541f819bf53d1992be8a77cddc73142af88172d459ac5a4fdd3237ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98cc44afdba972f85825cb474ea44468efd3b75999a4cea263bf53fec39c96f04f1eb1b3e6d0c1e6a7828265b20f0a439d833ea6abf46e2945ac7aafddeb0a73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3fd8521587e537a6afc363519f223aa484d41c049094876c2c0962795ae45d339be56c8d258fdcac999812045118a202192feba756030fc963ee4e5d95f4928"} 16:15:05 INFO - Running post-run listener: copy_logs_to_upload_dir 16:15:05 INFO - Copying logs to upload dir... 16:15:05 INFO - mkdir: /builds/slave/test/build/upload/logs 16:15:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.499197 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-10-13 16:15:04.580363) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 16:15:04.583771) ========= 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=523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980 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/9c36dcd7d6730f57458c6e2e412a824d026c20139dde71c707c456a5fea6c481daafed7f541f819bf53d1992be8a77cddc73142af88172d459ac5a4fdd3237ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98cc44afdba972f85825cb474ea44468efd3b75999a4cea263bf53fec39c96f04f1eb1b3e6d0c1e6a7828265b20f0a439d833ea6abf46e2945ac7aafddeb0a73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3fd8521587e537a6afc363519f223aa484d41c049094876c2c0962795ae45d339be56c8d258fdcac999812045118a202192feba756030fc963ee4e5d95f4928"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011223 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1476387018/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/9c36dcd7d6730f57458c6e2e412a824d026c20139dde71c707c456a5fea6c481daafed7f541f819bf53d1992be8a77cddc73142af88172d459ac5a4fdd3237ed", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/98cc44afdba972f85825cb474ea44468efd3b75999a4cea263bf53fec39c96f04f1eb1b3e6d0c1e6a7828265b20f0a439d833ea6abf46e2945ac7aafddeb0a73", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e3fd8521587e537a6afc363519f223aa484d41c049094876c2c0962795ae45d339be56c8d258fdcac999812045118a202192feba756030fc963ee4e5d95f4928"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-13 16:15:04.609098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 16:15:04.609475) ========= 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=523ca41ca1e0623de333ad52000001bf-1476399267.75297-156752980 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-13 16:15:04.690854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 16:15:04.691208) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-13 16:15:04.691519) ========= ========= Total master_lag: 0.15 =========