builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-041 starttime: 1479416043.33 results: success (0) buildid: 20161117123321 builduid: 217c37d6308c43589232677a71e29431 revision: eee080a43674dbd60de1347a4852721177d59192 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:03.334429) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:03.335282) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:03.335566) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:03.350189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:03.350601) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 12:54:03-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.6M=0s 2016-11-17 12:54:04 (45.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097054 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:03.462972) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:03.463452) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018355 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:03.514532) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 12:54:03.514900) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev eee080a43674dbd60de1347a4852721177d59192 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev eee080a43674dbd60de1347a4852721177d59192 --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=8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 12:54:04,168 truncating revision to first 12 chars 2016-11-17 12:54:04,168 Setting DEBUG logging. 2016-11-17 12:54:04,168 attempt 1/10 2016-11-17 12:54:04,168 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/eee080a43674?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 12:54:05,588 unpacking tar archive at: mozilla-inbound-eee080a43674/testing/mozharness/ program finished with exit code 0 elapsedTime=1.754333 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-17 12:54:05.398161) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:05.398474) ========= script_repo_revision: eee080a43674dbd60de1347a4852721177d59192 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:05.398878) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:05.399149) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 12:54:05.413554) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-17 12:54:05.413853) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:54:06 INFO - MultiFileLogger online at 20161117 12:54:06 in /builds/slave/test 12:54:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 12:54:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:54:06 INFO - {'append_to_log': False, 12:54:06 INFO - 'base_work_dir': '/builds/slave/test', 12:54:06 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 12:54:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:54:06 INFO - 'branch': 'Mozilla-Inbound', 12:54:06 INFO - 'buildbot_json_path': 'buildprops.json', 12:54:06 INFO - 'config_files': ('talos/linux_config.py',), 12:54:06 INFO - 'default_actions': ('clobber', 12:54:06 INFO - 'read-buildbot-config', 12:54:06 INFO - 'download-and-extract', 12:54:06 INFO - 'populate-webroot', 12:54:06 INFO - 'create-virtualenv', 12:54:06 INFO - 'install', 12:54:06 INFO - 'run-tests'), 12:54:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:54:06 INFO - 'download_minidump_stackwalk': True, 12:54:06 INFO - 'download_symbols': 'ondemand', 12:54:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:54:06 INFO - 'tooltool.py': '/tools/tooltool.py', 12:54:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:54:06 INFO - '/tools/misc-python/virtualenv.py')}, 12:54:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:54:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:54:06 INFO - 'installer_path': 'installer.exe', 12:54:06 INFO - 'log_level': 'info', 12:54:06 INFO - 'log_name': 'talos', 12:54:06 INFO - 'log_to_console': True, 12:54:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:54:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:54:06 INFO - 'opt_config_files': (), 12:54:06 INFO - 'pip_index': False, 12:54:06 INFO - 'sps_profile': False, 12:54:06 INFO - 'sps_profile_interval': 0, 12:54:06 INFO - 'suite': 'dromaeojs-e10s', 12:54:06 INFO - 'system_bits': '32', 12:54:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:54:06 INFO - 'title': 'talos-linux64-ix-041', 12:54:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:54:06 INFO - 'use_talos_json': True, 12:54:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:54:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:54:06 INFO - 'work_dir': 'build'} 12:54:06 INFO - [mozharness: 2016-11-17 20:54:06.160194Z] Running clobber step. 12:54:06 INFO - Running pre-action listener: _resource_record_pre_action 12:54:06 INFO - Running main action method: clobber 12:54:06 INFO - rmtree: /builds/slave/test/build 12:54:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:54:06 INFO - Running post-action listener: _resource_record_post_action 12:54:06 INFO - [mozharness: 2016-11-17 20:54:06.626801Z] Finished clobber step (success) 12:54:06 INFO - [mozharness: 2016-11-17 20:54:06.626899Z] Running read-buildbot-config step. 12:54:06 INFO - Running pre-action listener: _resource_record_pre_action 12:54:06 INFO - Running main action method: read_buildbot_config 12:54:06 INFO - Using buildbot properties: 12:54:06 INFO - { 12:54:06 INFO - "project": "", 12:54:06 INFO - "product": "firefox", 12:54:06 INFO - "script_repo_revision": "production", 12:54:06 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 12:54:06 INFO - "repository": "", 12:54:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 12:54:06 INFO - "buildid": "20161117123321", 12:54:06 INFO - "stage_platform": "linux64-pgo", 12:54:06 INFO - "basedir": "/builds/slave/test", 12:54:06 INFO - "buildnumber": 2083, 12:54:06 INFO - "platform": "ubuntu64_hw", 12:54:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:54:06 INFO - "slavebuilddir": "test", 12:54:06 INFO - "branch": "mozilla-inbound", 12:54:06 INFO - "revision": "eee080a43674dbd60de1347a4852721177d59192", 12:54:06 INFO - "slavename": "talos-linux64-ix-041", 12:54:06 INFO - "builduid": "217c37d6308c43589232677a71e29431", 12:54:06 INFO - "repo_path": "integration/mozilla-inbound" 12:54:06 INFO - } 12:54:06 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 12:54:06 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 12:54:06 INFO - Running post-action listener: _resource_record_post_action 12:54:06 INFO - [mozharness: 2016-11-17 20:54:06.629231Z] Finished read-buildbot-config step (success) 12:54:06 INFO - [mozharness: 2016-11-17 20:54:06.629319Z] Running download-and-extract step. 12:54:06 INFO - Running pre-action listener: _resource_record_pre_action 12:54:06 INFO - Running main action method: download_and_extract 12:54:06 INFO - mkdir: /builds/slave/test/build/tests 12:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:06 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:54:06 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:54:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 12:54:06 INFO - Downloaded 1361 bytes. 12:54:06 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 12:54:06 INFO - Using the following test package requirements: 12:54:06 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:06 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:54:06 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 12:54:06 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:06 INFO - u'jsshell-linux-x86_64.zip'], 12:54:06 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:54:06 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 12:54:06 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:54:06 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:54:06 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:54:06 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 12:54:06 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:54:06 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:54:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:54:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:54:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:54:06 INFO - Http code: 200 12:54:06 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 12:54:06 INFO - x-amz-cf-id: 6SF7GagnCS42EWMJMhQ46_3X4OdxU-P9weZ7AZnv8Oloql5AYjDVhg== 12:54:06 INFO - x-amz-replication-status: COMPLETED 12:54:06 INFO - x-amz-version-id: 2JqLVZ8oQ6cRVDZGoM9NN.6Zfn_VMHWT 12:54:07 INFO - Expected file size: 21917787 12:54:07 INFO - Obtained file size: 21917787 12:54:10 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:54:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 12:54:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:54:10 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 12:54:10 INFO - Http code: 200 12:54:10 INFO - via: 1.1 0302e8c462515ae281b72d9c815a5698.cloudfront.net (CloudFront) 12:54:10 INFO - x-amz-cf-id: u2ORLtIM23lTU5pnmlas2MLnlgZ8efUjmM4jRb9WDW3C2DiSZ9URgg== 12:54:10 INFO - x-amz-replication-status: COMPLETED 12:54:10 INFO - x-amz-version-id: 2JqLVZ8oQ6cRVDZGoM9NN.6Zfn_VMHWT 12:54:11 INFO - Expected file size: 21917787 12:54:11 INFO - Obtained file size: 21917787 12:54:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 12:54:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:54:15 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 12:54:15 INFO - Http code: 200 12:54:15 INFO - via: 1.1 41b2ee7cbe95749816a7586d9ab4629d.cloudfront.net (CloudFront) 12:54:15 INFO - x-amz-cf-id: wJo2HBntMGec_8-LG1NCiK4g6pH7m8pEXoEgc30-ErPPW1ASwRNJfA== 12:54:15 INFO - x-amz-replication-status: COMPLETED 12:54:15 INFO - x-amz-version-id: Mb3kmWAa0tsVpNJzdTRAZUj5gnbEK2yD 12:54:15 INFO - Expected file size: 14409282 12:54:15 INFO - Obtained file size: 14409282 12:54:16 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')]} 12:54:16 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:54:16 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:54:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:54:16 INFO - Downloaded 59565835 bytes. 12:54:16 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:54:16 INFO - mkdir: /builds/slave/test/properties 12:54:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:54:16 INFO - Writing to file /builds/slave/test/properties/build_url 12:54:16 INFO - Contents: 12:54:16 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 12:54:17 INFO - Running post-action listener: _resource_record_post_action 12:54:17 INFO - Running post-action listener: set_extra_try_arguments 12:54:17 INFO - [mozharness: 2016-11-17 20:54:17.157797Z] Finished download-and-extract step (success) 12:54:17 INFO - [mozharness: 2016-11-17 20:54:17.158024Z] Running populate-webroot step. 12:54:17 INFO - Running pre-action listener: _resource_record_pre_action 12:54:17 INFO - Running main action method: populate_webroot 12:54:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:54:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:54:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:54:17 INFO - '--tppagecycles', 12:54:17 INFO - '7'], 12:54:17 INFO - 'tests': ['tsvgm']}}, 12:54:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:54:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:54:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:54:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:54:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:54:17 INFO - 'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:54:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:54:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:54:17 INFO - 'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['damp', 'tps']}, 12:54:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:54:17 INFO - 'tests': ['damp', 'tps']}, 12:54:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['dromaeo_dom']}, 12:54:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:54:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['basic_compositor_video']}, 12:54:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:54:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['a11yr', 12:54:17 INFO - 'ts_paint', 12:54:17 INFO - 'tpaint', 12:54:17 INFO - 'sessionrestore', 12:54:17 INFO - 'sessionrestore_no_auto_restore', 12:54:17 INFO - 'tabpaint']}, 12:54:17 INFO - 'other-e10s': {'tests': ['a11yr', 12:54:17 INFO - 'ts_paint', 12:54:17 INFO - 'tpaint', 12:54:17 INFO - 'sessionrestore', 12:54:17 INFO - 'sessionrestore_no_auto_restore', 12:54:17 INFO - 'tabpaint']}, 12:54:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:54:17 INFO - 'ts_paint', 12:54:17 INFO - 'tpaint', 12:54:17 INFO - 'sessionrestore', 12:54:17 INFO - 'sessionrestore_no_auto_restore', 12:54:17 INFO - 'tabpaint']}, 12:54:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:54:17 INFO - 'ts_paint', 12:54:17 INFO - 'tpaint', 12:54:17 INFO - 'sessionrestore', 12:54:17 INFO - 'sessionrestore_no_auto_restore', 12:54:17 INFO - 'tabpaint']}, 12:54:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['a11yr', 12:54:17 INFO - 'ts_paint', 12:54:17 INFO - 'tpaint', 12:54:17 INFO - 'sessionrestore', 12:54:17 INFO - 'sessionrestore_no_auto_restore', 12:54:17 INFO - 'tabpaint']}, 12:54:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['a11yr', 12:54:17 INFO - 'ts_paint', 12:54:17 INFO - 'tpaint', 12:54:17 INFO - 'sessionrestore', 12:54:17 INFO - 'sessionrestore_no_auto_restore', 12:54:17 INFO - 'tabpaint']}, 12:54:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['tsvgx', 12:54:17 INFO - 'tsvgr_opacity', 12:54:17 INFO - 'tart', 12:54:17 INFO - 'tscrollx', 12:54:17 INFO - 'cart']}, 12:54:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:54:17 INFO - 'tsvgr_opacity', 12:54:17 INFO - 'tart', 12:54:17 INFO - 'tscrollx', 12:54:17 INFO - 'cart']}, 12:54:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:54:17 INFO - 'talos_options': ['--disable-e10s'], 12:54:17 INFO - 'tests': ['tp5o']}, 12:54:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:54:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:54:17 INFO - 'talos_options': ['--disable-e10s', 12:54:17 INFO - '--xperf_path', 12:54:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:17 INFO - 'tests': ['tp5n']}, 12:54:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:54:17 INFO - 'talos_options': ['--xperf_path', 12:54:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:54:17 INFO - 'tests': ['tp5n']}}, 12:54:17 INFO - 'talos.zip': {'path': '', 12:54:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:54:17 INFO - Running post-action listener: _resource_record_post_action 12:54:17 INFO - [mozharness: 2016-11-17 20:54:17.178072Z] Finished populate-webroot step (success) 12:54:17 INFO - [mozharness: 2016-11-17 20:54:17.178159Z] Running create-virtualenv step. 12:54:17 INFO - Running pre-action listener: _resource_record_pre_action 12:54:17 INFO - Running main action method: create_virtualenv 12:54:17 INFO - Creating virtualenv /builds/slave/test/build/venv 12:54:17 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 12:54:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:54:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:54:17 INFO - Using real prefix '/usr' 12:54:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:54:17 INFO - Installing distribute.............................................................................................................................................................................................done. 12:54:19 INFO - Installing pip.................done. 12:54:19 INFO - Return code: 0 12:54:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:54:19 INFO - Reading from file tmpfile_stdout 12:54:19 INFO - Output received: 12:54:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 12:54:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5841bf5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2621130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', '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 12:54:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:54:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:54:19 INFO - Using env: {'DISPLAY': ':0', 12:54:19 INFO - 'HOME': '/home/cltbld', 12:54:19 INFO - 'LANG': 'en_US.UTF-8', 12:54:19 INFO - 'LANGUAGE': 'en_US:en', 12:54:19 INFO - 'LOGNAME': 'cltbld', 12:54:19 INFO - 'MAIL': '/var/mail/cltbld', 12:54:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:19 INFO - 'MOZ_NO_REMOTE': '1', 12:54:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:19 INFO - 'NO_EM_RESTART': '1', 12:54:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:19 INFO - 'PWD': '/builds/slave/test', 12:54:19 INFO - 'SHELL': '/bin/bash', 12:54:19 INFO - 'SHLVL': '1', 12:54:19 INFO - 'TERM': 'linux', 12:54:19 INFO - 'TMOUT': '86400', 12:54:19 INFO - 'USER': 'cltbld', 12:54:19 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:19 INFO - '_': '/tools/buildbot/bin/python'} 12:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:20 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 12:54:20 INFO - Cleaning up... 12:54:20 INFO - Return code: 0 12:54:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:54:20 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')]} 12:54:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:20 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')]} 12:54:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:20 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 0x7f5841bf5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2621130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', '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 12:54:20 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 12:54:20 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 12:54:20 INFO - Using env: {'DISPLAY': ':0', 12:54:20 INFO - 'HOME': '/home/cltbld', 12:54:20 INFO - 'LANG': 'en_US.UTF-8', 12:54:20 INFO - 'LANGUAGE': 'en_US:en', 12:54:20 INFO - 'LOGNAME': 'cltbld', 12:54:20 INFO - 'MAIL': '/var/mail/cltbld', 12:54:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:20 INFO - 'MOZ_NO_REMOTE': '1', 12:54:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:20 INFO - 'NO_EM_RESTART': '1', 12:54:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:20 INFO - 'PWD': '/builds/slave/test', 12:54:20 INFO - 'SHELL': '/bin/bash', 12:54:20 INFO - 'SHLVL': '1', 12:54:20 INFO - 'TERM': 'linux', 12:54:20 INFO - 'TMOUT': '86400', 12:54:20 INFO - 'USER': 'cltbld', 12:54:20 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:20 INFO - '_': '/tools/buildbot/bin/python'} 12:54:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:20 INFO - Downloading/unpacking psutil>=3.1.1 12:54:20 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 12:54:20 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 12:54:20 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 12:54:20 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 12:54:20 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 12:54:20 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 12:54:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:54:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:22 INFO - Installing collected packages: psutil 12:54:22 INFO - Running setup.py install for psutil 12:54:22 INFO - building 'psutil._psutil_linux' extension 12:54:22 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 12:54:22 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 12:54:22 INFO - building 'psutil._psutil_posix' extension 12:54:22 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 12:54:22 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 12:54:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:54:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:54:22 INFO - Successfully installed psutil 12:54:22 INFO - Cleaning up... 12:54:22 INFO - Return code: 0 12:54:22 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5841bf5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2621130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', '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 12:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:54:23 INFO - Using env: {'DISPLAY': ':0', 12:54:23 INFO - 'HOME': '/home/cltbld', 12:54:23 INFO - 'LANG': 'en_US.UTF-8', 12:54:23 INFO - 'LANGUAGE': 'en_US:en', 12:54:23 INFO - 'LOGNAME': 'cltbld', 12:54:23 INFO - 'MAIL': '/var/mail/cltbld', 12:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:23 INFO - 'MOZ_NO_REMOTE': '1', 12:54:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:23 INFO - 'NO_EM_RESTART': '1', 12:54:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:23 INFO - 'PWD': '/builds/slave/test', 12:54:23 INFO - 'SHELL': '/bin/bash', 12:54:23 INFO - 'SHLVL': '1', 12:54:23 INFO - 'TERM': 'linux', 12:54:23 INFO - 'TMOUT': '86400', 12:54:23 INFO - 'USER': 'cltbld', 12:54:23 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:23 INFO - '_': '/tools/buildbot/bin/python'} 12:54:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:23 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:25 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:54:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:54:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:54:25 INFO - Installing collected packages: mozsystemmonitor 12:54:25 INFO - Running setup.py install for mozsystemmonitor 12:54:25 INFO - Successfully installed mozsystemmonitor 12:54:25 INFO - Cleaning up... 12:54:25 INFO - Return code: 0 12:54:25 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:54:25 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')]} 12:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:25 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')]} 12:54:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:25 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 0x7f5841bf5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2621130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', '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 12:54:25 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 12:54:25 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 12:54:25 INFO - Using env: {'DISPLAY': ':0', 12:54:25 INFO - 'HOME': '/home/cltbld', 12:54:25 INFO - 'LANG': 'en_US.UTF-8', 12:54:25 INFO - 'LANGUAGE': 'en_US:en', 12:54:25 INFO - 'LOGNAME': 'cltbld', 12:54:25 INFO - 'MAIL': '/var/mail/cltbld', 12:54:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:25 INFO - 'MOZ_NO_REMOTE': '1', 12:54:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:25 INFO - 'NO_EM_RESTART': '1', 12:54:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:25 INFO - 'PWD': '/builds/slave/test', 12:54:25 INFO - 'SHELL': '/bin/bash', 12:54:25 INFO - 'SHLVL': '1', 12:54:25 INFO - 'TERM': 'linux', 12:54:25 INFO - 'TMOUT': '86400', 12:54:25 INFO - 'USER': 'cltbld', 12:54:25 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:25 INFO - '_': '/tools/buildbot/bin/python'} 12:54:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:25 INFO - Downloading/unpacking jsonschema==2.5.1 12:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:54:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:27 INFO - Downloading functools32-3.2.3-2.tar.gz 12:54:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:54:27 INFO - warning: no files found matching '*.txt' 12:54:27 INFO - no previously-included directories found matching 'build' 12:54:27 INFO - no previously-included directories found matching 'dist' 12:54:27 INFO - no previously-included directories found matching '.git*' 12:54:27 INFO - Installing collected packages: jsonschema, functools32 12:54:27 INFO - Running setup.py install for functools32 12:54:27 INFO - warning: no files found matching '*.txt' 12:54:27 INFO - no previously-included directories found matching 'build' 12:54:27 INFO - no previously-included directories found matching 'dist' 12:54:27 INFO - no previously-included directories found matching '.git*' 12:54:27 INFO - Successfully installed jsonschema functools32 12:54:27 INFO - Cleaning up... 12:54:27 INFO - Return code: 0 12:54:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5841bf5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2621130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', '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 12:54:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:54:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:54:27 INFO - Using env: {'DISPLAY': ':0', 12:54:27 INFO - 'HOME': '/home/cltbld', 12:54:27 INFO - 'LANG': 'en_US.UTF-8', 12:54:27 INFO - 'LANGUAGE': 'en_US:en', 12:54:27 INFO - 'LOGNAME': 'cltbld', 12:54:27 INFO - 'MAIL': '/var/mail/cltbld', 12:54:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:27 INFO - 'MOZ_NO_REMOTE': '1', 12:54:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:27 INFO - 'NO_EM_RESTART': '1', 12:54:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:27 INFO - 'PWD': '/builds/slave/test', 12:54:27 INFO - 'SHELL': '/bin/bash', 12:54:27 INFO - 'SHLVL': '1', 12:54:27 INFO - 'TERM': 'linux', 12:54:27 INFO - 'TMOUT': '86400', 12:54:27 INFO - 'USER': 'cltbld', 12:54:27 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:27 INFO - '_': '/tools/buildbot/bin/python'} 12:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:54:28 INFO - Cleaning up... 12:54:28 INFO - Return code: 0 12:54:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:54:28 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')]} 12:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:28 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')]} 12:54:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:28 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 0x7f5841bf5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2621130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', '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 12:54:28 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 12:54:28 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 12:54:28 INFO - Using env: {'DISPLAY': ':0', 12:54:28 INFO - 'HOME': '/home/cltbld', 12:54:28 INFO - 'LANG': 'en_US.UTF-8', 12:54:28 INFO - 'LANGUAGE': 'en_US:en', 12:54:28 INFO - 'LOGNAME': 'cltbld', 12:54:28 INFO - 'MAIL': '/var/mail/cltbld', 12:54:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:28 INFO - 'MOZ_NO_REMOTE': '1', 12:54:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:28 INFO - 'NO_EM_RESTART': '1', 12:54:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:28 INFO - 'PWD': '/builds/slave/test', 12:54:28 INFO - 'SHELL': '/bin/bash', 12:54:28 INFO - 'SHLVL': '1', 12:54:28 INFO - 'TERM': 'linux', 12:54:28 INFO - 'TMOUT': '86400', 12:54:28 INFO - 'USER': 'cltbld', 12:54:28 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:28 INFO - '_': '/tools/buildbot/bin/python'} 12:54:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:28 INFO - Downloading/unpacking blobuploader==1.2.4 12:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:54:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:54:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:54:30 INFO - Downloading blobuploader-1.2.4.tar.gz 12:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:54:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:54:30 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 12:54:30 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 12:54:30 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 12:54:30 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 12:54:30 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 12:54:30 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 12:54:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:54:30 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:54:30 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 12:54:30 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 12:54:30 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 12:54:30 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 12:54:30 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 12:54:30 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 12:54:31 INFO - Downloading docopt-0.6.1.tar.gz 12:54:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:54:31 INFO - Installing collected packages: blobuploader, requests, docopt 12:54:31 INFO - Running setup.py install for blobuploader 12:54:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:54:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:54:31 INFO - Running setup.py install for requests 12:54:31 INFO - Running setup.py install for docopt 12:54:31 INFO - Successfully installed blobuploader requests docopt 12:54:31 INFO - Cleaning up... 12:54:31 INFO - Return code: 0 12:54:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12: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')]} 12:54:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12: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')]} 12:54:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:31 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 0x7f5841bf5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2621130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', '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 12:54:31 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 12:54:31 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 12:54:31 INFO - Using env: {'DISPLAY': ':0', 12:54:31 INFO - 'HOME': '/home/cltbld', 12:54:31 INFO - 'LANG': 'en_US.UTF-8', 12:54:31 INFO - 'LANGUAGE': 'en_US:en', 12:54:31 INFO - 'LOGNAME': 'cltbld', 12:54:31 INFO - 'MAIL': '/var/mail/cltbld', 12:54:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:31 INFO - 'MOZ_NO_REMOTE': '1', 12:54:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:31 INFO - 'NO_EM_RESTART': '1', 12:54:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:31 INFO - 'PWD': '/builds/slave/test', 12:54:31 INFO - 'SHELL': '/bin/bash', 12:54:31 INFO - 'SHLVL': '1', 12:54:31 INFO - 'TERM': 'linux', 12:54:31 INFO - 'TMOUT': '86400', 12:54:31 INFO - 'USER': 'cltbld', 12:54:31 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:31 INFO - '_': '/tools/buildbot/bin/python'} 12:54:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:31 INFO - Running setup.py (path:/tmp/pip-grGVCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:31 INFO - Running setup.py (path:/tmp/pip-KinbVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:32 INFO - Running setup.py (path:/tmp/pip-dEnyCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:32 INFO - Running setup.py (path:/tmp/pip-B6Prpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:32 INFO - Running setup.py (path:/tmp/pip-kstHj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:32 INFO - Running setup.py (path:/tmp/pip-isKX8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:32 INFO - Running setup.py (path:/tmp/pip-g8vRGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:32 INFO - Running setup.py (path:/tmp/pip-GoDS6v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:32 INFO - Running setup.py (path:/tmp/pip-koSwSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:32 INFO - Running setup.py (path:/tmp/pip-HhxPH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:32 INFO - Running setup.py (path:/tmp/pip-lUS9S3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:32 INFO - Running setup.py (path:/tmp/pip-nLDIaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:32 INFO - Running setup.py (path:/tmp/pip-7ewTNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:32 INFO - Running setup.py (path:/tmp/pip-Y7PPJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:32 INFO - Running setup.py (path:/tmp/pip-rkaI5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:32 INFO - Running setup.py (path:/tmp/pip-g9LshG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:33 INFO - Running setup.py (path:/tmp/pip-DMcQr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:33 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:54:33 INFO - Running setup.py install for manifestparser 12:54:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:54:33 INFO - Running setup.py install for mozcrash 12:54:33 INFO - Running setup.py install for mozdebug 12:54:33 INFO - Running setup.py install for mozdevice 12:54:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:54:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:54:33 INFO - Running setup.py install for mozfile 12:54:33 INFO - Running setup.py install for mozhttpd 12:54:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:54:33 INFO - Running setup.py install for mozinfo 12:54:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:54:33 INFO - Running setup.py install for mozInstall 12:54:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:54:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:54:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:54:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:54:33 INFO - Running setup.py install for mozleak 12:54:34 INFO - Running setup.py install for mozlog 12:54:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:54:34 INFO - Running setup.py install for moznetwork 12:54:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:54:34 INFO - Running setup.py install for mozprocess 12:54:34 INFO - Running setup.py install for mozprofile 12:54:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:54:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:54:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:54:34 INFO - Running setup.py install for mozrunner 12:54:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:54:34 INFO - Running setup.py install for mozscreenshot 12:54:34 INFO - Running setup.py install for moztest 12:54:34 INFO - Running setup.py install for mozversion 12:54:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:54:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:54:34 INFO - Cleaning up... 12:54:34 INFO - Return code: 0 12:54:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5841bf5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2621130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', '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 12:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:54:34 INFO - Using env: {'DISPLAY': ':0', 12:54:34 INFO - 'HOME': '/home/cltbld', 12:54:34 INFO - 'LANG': 'en_US.UTF-8', 12:54:34 INFO - 'LANGUAGE': 'en_US:en', 12:54:34 INFO - 'LOGNAME': 'cltbld', 12:54:34 INFO - 'MAIL': '/var/mail/cltbld', 12:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:34 INFO - 'MOZ_NO_REMOTE': '1', 12:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:34 INFO - 'NO_EM_RESTART': '1', 12:54:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:34 INFO - 'PWD': '/builds/slave/test', 12:54:34 INFO - 'SHELL': '/bin/bash', 12:54:34 INFO - 'SHLVL': '1', 12:54:34 INFO - 'TERM': 'linux', 12:54:34 INFO - 'TMOUT': '86400', 12:54:34 INFO - 'USER': 'cltbld', 12:54:34 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:34 INFO - '_': '/tools/buildbot/bin/python'} 12:54:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:54:35 INFO - Running setup.py (path:/tmp/pip-L_BMrx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:54:35 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)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:54:35 INFO - Running setup.py (path:/tmp/pip-Sa2Vcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:54:35 INFO - Running setup.py (path:/tmp/pip-vOSWAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:54:35 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)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:54:35 INFO - Running setup.py (path:/tmp/pip-RUOR3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:54:35 INFO - Running setup.py (path:/tmp/pip-AQQrec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:54:35 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)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:54:35 INFO - Running setup.py (path:/tmp/pip-hInkDz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:54:35 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)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:54:35 INFO - Running setup.py (path:/tmp/pip-MOG8az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:54:35 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)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:54:35 INFO - Running setup.py (path:/tmp/pip-FSFxnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:54:35 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)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:54:35 INFO - Running setup.py (path:/tmp/pip-LfuFbN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:54:35 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)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:54:35 INFO - Running setup.py (path:/tmp/pip-gHQmmK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:54:35 INFO - Running setup.py (path:/tmp/pip-jqzApo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:54:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:54:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:54:35 INFO - Running setup.py (path:/tmp/pip-zTrVX2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:54:36 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)) 12:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:54:36 INFO - Running setup.py (path:/tmp/pip-dVO4Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:54:36 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)) 12:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:54:36 INFO - Running setup.py (path:/tmp/pip-BzhFvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 12:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:36 INFO - Running setup.py (path:/tmp/pip-hpYBVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:54:36 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)) 12:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:54:36 INFO - Running setup.py (path:/tmp/pip-ewOmKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:54:36 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)) 12:54:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:54:36 INFO - Running setup.py (path:/tmp/pip-hibGVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:54:36 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)) 12:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:54:36 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)) 12:54:36 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:54:36 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:54:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:36 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 12:54:38 INFO - Downloading blessings-1.6.tar.gz 12:54:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:54:38 INFO - Installing collected packages: blessings 12:54:38 INFO - Running setup.py install for blessings 12:54:38 INFO - Successfully installed blessings 12:54:38 INFO - Cleaning up... 12:54:38 INFO - Return code: 0 12:54:38 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:54:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:38 INFO - Reading from file tmpfile_stdout 12:54:38 INFO - Current package versions: 12:54:38 INFO - argparse == 1.2.1 12:54:38 INFO - blessings == 1.6 12:54:38 INFO - blobuploader == 1.2.4 12:54:38 INFO - docopt == 0.6.1 12:54:38 INFO - functools32 == 3.2.3-2 12:54:38 INFO - jsonschema == 2.5.1 12:54:38 INFO - manifestparser == 1.1 12:54:38 INFO - mozInstall == 1.12 12:54:38 INFO - mozcrash == 1.0 12:54:38 INFO - mozdebug == 0.1 12:54:38 INFO - mozdevice == 0.49 12:54:38 INFO - mozfile == 1.2 12:54:38 INFO - mozhttpd == 0.7 12:54:38 INFO - mozinfo == 0.9 12:54:38 INFO - mozleak == 0.1 12:54:38 INFO - mozlog == 3.4 12:54:38 INFO - moznetwork == 0.27 12:54:38 INFO - mozprocess == 0.23 12:54:38 INFO - mozprofile == 0.28 12:54:38 INFO - mozrunner == 6.13 12:54:38 INFO - mozscreenshot == 0.1 12:54:38 INFO - mozsystemmonitor == 0.3 12:54:38 INFO - moztest == 0.7 12:54:38 INFO - mozversion == 1.4 12:54:38 INFO - psutil == 3.1.1 12:54:38 INFO - requests == 1.2.3 12:54:38 INFO - wsgiref == 0.1.2 12:54:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:54:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f5841bf5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2621130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', '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 12:54:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:54:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:54:38 INFO - Using env: {'DISPLAY': ':0', 12:54:38 INFO - 'HOME': '/home/cltbld', 12:54:38 INFO - 'LANG': 'en_US.UTF-8', 12:54:38 INFO - 'LANGUAGE': 'en_US:en', 12:54:38 INFO - 'LOGNAME': 'cltbld', 12:54:38 INFO - 'MAIL': '/var/mail/cltbld', 12:54:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:38 INFO - 'MOZ_NO_REMOTE': '1', 12:54:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:38 INFO - 'NO_EM_RESTART': '1', 12:54:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:38 INFO - 'PWD': '/builds/slave/test', 12:54:38 INFO - 'SHELL': '/bin/bash', 12:54:38 INFO - 'SHLVL': '1', 12:54:38 INFO - 'TERM': 'linux', 12:54:38 INFO - 'TMOUT': '86400', 12:54:38 INFO - 'USER': 'cltbld', 12:54:38 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:38 INFO - '_': '/tools/buildbot/bin/python'} 12:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 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)) 12:54:39 INFO - Cleaning up... 12:54:39 INFO - Return code: 0 12:54:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:54:39 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')]} 12:54:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:54:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:39 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')]} 12:54:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:54:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:54:39 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 0x7f5841bf5e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2485b70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2621130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, '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': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', '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 12:54:39 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 12:54:39 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 12:54:39 INFO - Using env: {'DISPLAY': ':0', 12:54:39 INFO - 'HOME': '/home/cltbld', 12:54:39 INFO - 'LANG': 'en_US.UTF-8', 12:54:39 INFO - 'LANGUAGE': 'en_US:en', 12:54:39 INFO - 'LOGNAME': 'cltbld', 12:54:39 INFO - 'MAIL': '/var/mail/cltbld', 12:54:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:39 INFO - 'MOZ_NO_REMOTE': '1', 12:54:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:39 INFO - 'NO_EM_RESTART': '1', 12:54:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:39 INFO - 'PWD': '/builds/slave/test', 12:54:39 INFO - 'SHELL': '/bin/bash', 12:54:39 INFO - 'SHLVL': '1', 12:54:39 INFO - 'TERM': 'linux', 12:54:39 INFO - 'TMOUT': '86400', 12:54:39 INFO - 'USER': 'cltbld', 12:54:39 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:39 INFO - '_': '/tools/buildbot/bin/python'} 12:54:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:54:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:54:39 INFO - Cleaning up... 12:54:39 INFO - Return code: 0 12:54:39 INFO - Running post-action listener: _resource_record_post_action 12:54:39 INFO - Running post-action listener: _start_resource_monitoring 12:54:39 INFO - Starting resource monitoring. 12:54:39 INFO - [mozharness: 2016-11-17 20:54:39.326222Z] Finished create-virtualenv step (success) 12:54:39 INFO - [mozharness: 2016-11-17 20:54:39.326742Z] Running install step. 12:54:39 INFO - Running pre-action listener: _resource_record_pre_action 12:54:39 INFO - Running main action method: install 12:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:54:39 INFO - Reading from file tmpfile_stdout 12:54:39 INFO - Detecting whether we're running mozinstall >=1.0... 12:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:54:39 INFO - Reading from file tmpfile_stdout 12:54:39 INFO - Output received: 12:54:39 INFO - Usage: mozinstall [options] installer 12:54:39 INFO - Options: 12:54:39 INFO - -h, --help show this help message and exit 12:54:39 INFO - -d DEST, --destination=DEST 12:54:39 INFO - Directory to install application into. [default: 12:54:39 INFO - "/builds/slave/test"] 12:54:39 INFO - --app=APP Application being installed. [default: firefox] 12:54:39 INFO - mkdir: /builds/slave/test/build/application 12:54:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:54:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 12:54:56 INFO - Reading from file tmpfile_stdout 12:54:56 INFO - Output received: 12:54:56 INFO - /builds/slave/test/build/application/firefox/firefox 12:54:56 INFO - Running post-action listener: _resource_record_post_action 12:54:56 INFO - [mozharness: 2016-11-17 20:54:56.534302Z] Finished install step (success) 12:54:56 INFO - [mozharness: 2016-11-17 20:54:56.534573Z] Running run-tests step. 12:54:56 INFO - Running pre-action listener: _resource_record_pre_action 12:54:56 INFO - Running main action method: run_tests 12:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:54:56 INFO - Python 2.7.3 12:54:56 INFO - Return code: 0 12:54:56 INFO - grabbing minidump binary from tooltool 12: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')]} 12:54:56 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 0x26affc0>, '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 0x26b0ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26b1350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:54:56 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 12:54:56 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 12:54:56 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 12:54:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:54:56 INFO - Return code: 0 12:54:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:54:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:54:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:54:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:54:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:54:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 12:54:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-041 --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 12:54:56 INFO - Using env: {'DISPLAY': ':0', 12:54:56 INFO - 'HOME': '/home/cltbld', 12:54:56 INFO - 'LANG': 'en_US.UTF-8', 12:54:56 INFO - 'LANGUAGE': 'en_US:en', 12:54:56 INFO - 'LOGNAME': 'cltbld', 12:54:56 INFO - 'MAIL': '/var/mail/cltbld', 12:54:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:54:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:54:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:54:56 INFO - 'MOZ_NO_REMOTE': '1', 12:54:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:54:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:54:56 INFO - 'NO_EM_RESTART': '1', 12:54:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:54:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:54:56 INFO - 'PWD': '/builds/slave/test', 12:54:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:54:56 INFO - 'SHELL': '/bin/bash', 12:54:56 INFO - 'SHLVL': '1', 12:54:56 INFO - 'TERM': 'linux', 12:54:56 INFO - 'TMOUT': '86400', 12:54:56 INFO - 'USER': 'cltbld', 12:54:56 INFO - 'XDG_SESSION_COOKIE': '8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115', 12:54:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:54:56 INFO - '_': '/tools/buildbot/bin/python'} 12:54:56 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-041', '--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 12:54:56 INFO - mozversion application_buildid: 20161117093608 12:54:56 INFO - mozversion application_changeset: eee080a43674dbd60de1347a4852721177d59192 12:54:56 INFO - mozversion application_display_name: Nightly 12:54:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:54:56 INFO - mozversion application_name: Firefox 12:54:56 INFO - mozversion application_remotingname: firefox 12:54:56 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:54:56 INFO - mozversion application_vendor: Mozilla 12:54:56 INFO - mozversion application_version: 53.0a1 12:54:56 INFO - mozversion platform_buildid: 20161117093608 12:54:56 INFO - mozversion platform_changeset: eee080a43674dbd60de1347a4852721177d59192 12:54:56 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 12:54:56 INFO - mozversion platform_version: 53.0a1 12:54:56 INFO - using testdate: 1479416096 12:54:56 INFO - actual date: 1479416096 12:54:56 INFO - starting webserver on 'localhost:52401' 12:54:56 INFO - SUITE-START | Running 2 tests 12:54:56 INFO - TEST-START | dromaeo_css 12:54:56 INFO - operating with platform_type : linux_ 12:54:56 INFO - Initialising browser for dromaeo_css test... 12:54:56 INFO - TEST-INFO | started process 7470 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCnoI1U/profile http://localhost:52401/getInfo.html) 12:55:01 INFO - PROCESS | 7470 | __metrics Screen width/height:1600/1200 12:55:01 INFO - PROCESS | 7470 | colorDepth:24 12:55:01 INFO - PROCESS | 7470 | Browser inner width/height: 1024/697 12:55:01 INFO - PROCESS | 7470 | __metrics 12:55:01 ERROR - PROCESS | 7470 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3201: TypeError: this.tabs is undefined 12:55:02 INFO - TEST-INFO | 7470: exit 0 12:55:02 INFO - Browser initialized. 12:55:02 INFO - Running cycle 1/1 for dromaeo_css test... 12:55:02 INFO - TEST-INFO | started process 7593 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCnoI1U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:55:14 INFO - PROCESS | 7593 | RSS: Main: 186351616 12:55:14 INFO - PROCESS | 7593 | 12:56:04 INFO - PROCESS | 7593 | 1479416164683 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] 12:58:16 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:52401/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52401/tests/dromaeo/cssquery-ext.html) 12:58:17 INFO - PROCESS | 7593 | RSS: Main: 198377472 12:58:17 INFO - PROCESS | 7593 | 13:01:20 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:52401/tests/dromaeo/cssquery-ext.html (next: http://localhost:52401/tests/dromaeo/cssquery-jquery.html) 13:01:20 INFO - PROCESS | 7593 | RSS: Main: 196993024 13:01:20 INFO - PROCESS | 7593 | 13:04:22 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:52401/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52401/tests/dromaeo/cssquery-mootools.html) 13:04:23 INFO - PROCESS | 7593 | RSS: Main: 199192576 13:04:23 INFO - PROCESS | 7593 | 13:07:25 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:52401/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52401/tests/dromaeo/cssquery-prototype.html) 13:07:25 INFO - PROCESS | 7593 | RSS: Main: 195715072 13:07:25 INFO - PROCESS | 7593 | 13:10:28 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:52401/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52401/tests/dromaeo/cssquery-yui.html) 13:10:29 INFO - PROCESS | 7593 | RSS: Main: 199311360 13:10:29 INFO - PROCESS | 7593 | 13:13:31 INFO - PROCESS | 7593 | Cycle 1(1): loaded http://localhost:52401/tests/dromaeo/cssquery-yui.html (next: http://localhost:52401/tests/dromaeo/cssquery-dojo.html) 13:13:32 INFO - PROCESS | 7593 | RSS: Main: 199020544 13:13:32 INFO - PROCESS | 7593 | 13:13:32 INFO - PROCESS | 7593 | __start_tp_report 13:13:32 INFO - PROCESS | 7593 | _x_x_mozilla_page_load 13:13:32 INFO - PROCESS | 7593 | _x_x_mozilla_page_load_details 13:13:32 INFO - PROCESS | 7593 | |i|pagename|runs| 13:13:32 INFO - PROCESS | 7593 | |0;dojo.html;3092.1651154188385;3099.6280446346436;3112.704293092157;3122.172624254573;3140.6074240719904;5255.395629502608;5286.259923610693;5315.309009828717;5318.414974352818;5321.787128514855;5386.515213630772;5448.37343705474;5463.945360546393;5474.959757646045;5479.232907392969;4900.093482705711;4917.188663870466;4983.875403114915;4991.7504124793795;4998.200287953928;4901.926471102936;4997.6501644884875;5008.173651347523;5014.047331007116;5041.319421878036;4907.2393778964315;5007.32401125847;5091.465396133408;5093.465186155456;5095.745212739367;4863.27050942358;4921.360223171001;4944.110060189165;4971.477994810565;4971.52770486805;4812.903741925177;4918.360613120271;4937.407511098655;4943.456219815817;4952.108620448318;5271.262023316739;5312.309399778004;5339.332583427033;5364.946350536523;5380.542653874386;5747.741351639186;5783.768649254025;5787.189793428924;5856.209411729405;5862.97068514659;5843.795467158671;5853.795117170878;5879.735411906475;5880.500157486619;5897.439743224387;5349.22436246742;5355.30381050461;5365.195220716884;5383.596230282745;5400.91898621521;5804.767809287666;5842.649441033466;5853.2976042875125;5867.119932010147;5880.588358814927;5483.725813709299;5495.6153069285565;5633.380328163898;5649.887002259932;5668.9716551417805;5646.153077038395;5658.179563963285;5663.80176693822;5727.942720572824;5782.843431313754;5838.795642152504;5847.06446968483;5857.70711464425;5865.266841644794;5905.675187864708;5646.548276137899;5702.45826646468;5743.597948143673;5842.678652674059;5846.795362162304;4468.642508599304;4509.6392288616835;4519.344695019204;4550.294704320836;4556.612687921497;3912.295786758411;3946.092398748304;3964.1873415949663;4035.6973227008093;4059.127287633114;5380.461953804588;5433.130699088127;5441.6190866639745;5441.809536666197;5449.64577302482;5771.711414429262;5832.88334233313;5849;5862.677552734641;5884.705764711747;5276.472352764693;5331.413544510101;5519.227308176858;5536.944630553723;5572.5263352614675;4858.489858564871;4876.5854902333695;4891.437484689235;4895.730734809548;4915.778789954461;5881.5588830837005;5946.316173640087;5963.194968679173;5994.160817485643;6021.277446706424;5760.6255593386295;5761.193432919311;5773.480386765212;5784.1034639630925;5788.160716696139;5873.706314684163;5873.765049397976;5927.703614819328;5979.790707325223;6010.128531363015;5601.915971260353;5669.291338582677;5680.744366503434;5694.886102278014;5739.9139012915675;5785.971070144622;5822.475977162076;5873.060310350495;5904.763809447574;5934.376890426443;5710.2576665033275;5711.600187986801;5713.8285851424525;5718.056520674042;5741.483266506035;5596.86007849807;5647.265855438931;5651.463111004448;5660.433956604306;5723.5707321950185;5523.33719953592;5584;5626.746796394254;5630.4369563045;5638;5611.831645050655;5712.7714891403875;5731.799387021601;5732.3121225453215;5781.306243250837;5540.335159780852;5546.889062218814;5550.222968784293;5551.916721249266;5580.302462192226 13:13:32 INFO - PROCESS | 7593 | |1;ext.html;545.2617301819208;568.9630174038684;575.9020966435705;579.9449052340027;588.9676067816271;40156.799216003914;41373.37939930896;41385.37921931173;44793.7760311198;44911.326330105076;42167.578324216745;42364.364534532004;42584.14831703364;42626;42862;8353.331733461324;8488.53313067781;8494.277986371135;8501.914980850204;8502.192291732306;8427.789305267386;8551.871721924144;8552.61513231903;8560.101189375087;8582.313414926823;8586.828263434727;8587.227149556538;8601.827963440728;8645.092265312145;8647.30821534279;8549.316054715608;8553.947052707337;8567.228949394585;8582.699605513839;8602.569871506399;8481.279091277249;8543.102974187683;8549.487030778173;8554.35842311829;8560.47465997526;39975.600243997476;40249;40430.79784601088;40764.38853417201;40894.591054089375;3175.3649270145834;3270.9509357359657;3307.5038744188564;3312.3540909522653;3786.697064234882;30267.848660756554;30842.691573084205;30843.38313233745;30894.845525772453;30896.845515772504;3993.800309984518;4075.4701888754566;4198.706090573661;4218.346156345771;4358.7166834156;336300;336750;336965;337766;338378;53795.46204537983;53848.73075634597;54161;54644.72677636586;54694;59429;59596;59601;59968;60206;14380.496682616058;14414.855851441562;14415;14547.854521454861;14579.198144101963;10752;10758.515866786014;10862.945685271681;10888.564457421773;10929.726756831144;16571.25429355682;16577.254023568727;16736.41422550205;16864.915675421544;16887;5416.702081385482;5556.721744084905;5603.299587551556;5622.554188927829;5645.23789288449;978.9314747967574;1015.3907655406697;1037.3412882819314;1063.2185343772321;1078.5308390850005;29506.704932950826;31185.8440707795;31201;31248.84375578153;31572.842135789175;972.5720682899502;1110.2394859521253;1113.471613439278;1130.559081958037;1138.320976559568;15242.847571524364;15877.920610396874;16296.918515407348;16299.674006519803;16607.750883736753;497225;497794;507267;508705;516311;53672.194917076275;54047.72976135094;54054.45945540494;54103;54335.45664543383;1300.8178854960313;1311.475409836054;1313.2317594207304;1331.6604265912324;1347.2657401716087;28875.278118046375;31483;32537;32537.186570335933;32979.34041319208;47584.2862357058;48069.75965120152;48071;48079.75960120177;48272.75863620659;361256;362053;363810;364379.8496120251;365200;27413.45173096567;27559.586606201323;27803.16590502288;27865.16404507868;27950;44100.55899441093;44590.3311450335;44960.550394495636;45162.548374515834;45793;38818.80590597142;39096.609033910434;39268.80365598154;39330.60669393384;39870.60129398785;38032.429513556766;38646.420303694904;38656.2268754629;39497.407538886364;39991.2001759969;38396;38474;39030.60969390383;39480;42144.578554214066;32924.835375822964;35621.465678014334;36036.81981590075;36046.639533605376;36213.45679814752;27324.590131148445;27375.589366159922;27403.725962740118;27419;27634.447311054068 13:13:32 INFO - PROCESS | 7593 | |2;jquery.html;380.7410960546827;386.41072364643907;390.31499717994916;390.42412441648565;420.7664746065934;18251.634967300644;18446.815531844677;18596.53508662284;19222.51943701408;19249.326273580427;18208.180631871564;18510.722339164924;18857.811421885777;18916.71624925627;18995.240190392367;5255.185446255818;5362.329708786392;5463.644863083907;5601.971990140044;5631.4087020862835;5482.890342193154;5515.034868897927;5519.116941289394;5524.723763811813;5552.3892371839065;5419.078756611366;5561.304836895388;5581.330240371161;5612.466815652507;5627.634203776762;5587.189857470665;5594.916076258859;5613.80351687691;5615;5621.8594535136535;5179.715115668637;5259.421463638997;5279.656822306538;5292.708901010443;5425.159100339453;11985.640430787003;12121.27272363661;12274.815877761841;12295.262284262883;12344.753104937941;2132.86136401135;2292.2435596253194;2423.1155628195756;2681.209043332222;2853.443578502172;9513.476758778264;9682.225421966226;9878.110970012733;10029.348092373972;12663.746725065539;1880.5110671225443;1932.3526618582791;1965.6560101982238;1970.8226259636558;1971.3593082248326;82069;82618.58690706568;83463;83642.58178709068;83701.58149209277;10076.093151616244;10116.645917393003;10500.264981451224;10548.789024219474;10786.838197427045;14489.710205796036;14538.200398977946;14545;14604.196769177797;14617.049891757002;7175.354218120394;7276.745313913988;7468.21583733711;7546.924530754732;7637.579933103621;7051.8237044073285;7054;7072.71709131629;7231.746888858865;7280.6723697433745;4279.16556271524;4283.807228674717;4285.078708077778;4373.934390984138;4436.134953684065;1775.325376356976;1829.6798060339388;1838.2187570282576;1848.6579982702974;1864.4593068010397;885.3758100539104;999.6651121874108;1013.3160116921049;1015.1422048369263;1044.5143008501084;17837.643247134984;18215.36246231402;19215.711764323547;19442.319518816774;19456.513587160433;952.9237660987104;954.4178051388648;975.4683697384942;978.7993461340408;996.6312464388078;10183.388996660076;10520.10579100785;10681.145508359312;10718.624848130434;10759.085477734323;420272;432600;439284;439584;447148;84739;89064;93601;97451.51274243584;97559;1010.4038617215878;1013.5236438873718;1033.2921948465325;1046.5447530324182;1051.4795176387738;16592.66814663676;17151.313947441962;17486.213120409357;17888.821111788715;17899.04583573999;42123.57876421197;42433.36349954815;43330.350044748724;43807.78096109499;43809.78095109504;58484;60659;62198.689006554676;63049;64167.67916160389;7792.220777922389;8059.717909873127;8229.46508476947;8434.451760635538;8752.387332886638;9148.496832674267;13165.736685266433;13309.134906231064;13421.32893355348;13439.529616463376;11556.226505638755;11804.350760708243;11950.701232469259;12047.216930899463;12066;11363.715907102389;11366.374849383363;11464.885351146382;11480.253783504046;11605.535778568763;11617.941910290394;11744.94127529357;11925.880741192825;11932.463039163085;11944.701382465508;6963.512554121366;6991.405730512964;7185;7384.335409813142;8668.133186681282;8929.508877011827;11239.213255072067;11683.240589361665;11839.58561450345;11881.168318217642 13:13:32 INFO - PROCESS | 7593 | |3;mootools.html;1424.9287535623216;1442.5095467541037;1547.1722628393811;1653.5535405440523;1666.4667306461922;7086;7285.672144753486;7451.776446706601;8010.519368837874;8022.358211343086;7593.354564861993;7872.212778722125;7878.212178782133;8047.4769140006;8058.073321568021;2225.2434172381386;2249.6513040478753;2261.0390584001816;2263.388885001049;2264.1962103453284;2203.5482726041205;2239.4401399650087;2308.56137333906;2309.099451214028;2309.145616122037;2261.547690461906;2266.5126997695493;2283.1438210671;2285.440067183534;2290.1068583252545;2122.564874200785;2124.7875212478784;2165.653495440722;2172.359154049559;2174.0108250745952;2194.659827726705;2195.3852921182092;2217.1242359268;2217.6562632791943;2223.822094232474;7755.224477552256;7921.445498815086;7935;7935.285824275843;7944.761657150295;4833.830815921461;4948.38145231846;4959.082569724576;4966.106100901836;4972.154733695281;3065.984670076635;3069;3220.6940340667834;3246.8863589774246;3248.512723091555;1123.2305870478667;1153.469404074127;1179.204037274836;1186.0274574848627;1192.070185255502;10617.41604211768;10778.461076946121;10780.73048173794;10782.245242833005;10909.34543927367;4210.410542524049;4422.823087076546;4439.445069366329;4545.454545454567;4557.498675145731;8961.372703910663;9143.908560914439;9157.587908544132;9170.90829091714;9187.908120918839;4919.2867034279825;4932.21084626458;4934.925976110361;4935.975320123376;4944.802207911644;4104.343305071175;4259.850905218303;4477.059817438374;4568.977155114203;4578.130155270488;3592.209713862946;3669.9816500917323;3780.1494663700996;3796.1079146400575;3805.219929914361;1256.6481385212155;1268.2897577356525;1274.7386785708907;1280.9359532023361;1310.829592153033;905.4657751926263;918.8392031394479;926.937563920272;930.6463543853428;966.2801213096288;5400.378956420062;5443.129099344086;5454.481824226771;5508.586855985737;5517.917231241535;895.6462197431978;908.927285817133;916.7799728065349;936.1387523478417;938.4322484896676;3399.7790143640586;3517.771344862576;3528.2767032758225;3536.1866770642896;3602.6037135915553;9188.26493880488;9735.41587504752;9740.415575065519;9745.31782775199;9751.90248097524;8971.282297416192;9339.346245762867;9459.858102128474;9670.613175473043;9759.512024398751;6988.965055174692;7033;7056.682449289794;7182.174049984319;7227.602481863548;5450.482204190595;5522.930510304237;5572.216890594971;5619.185218143428;5711.543076553949;8854.203121719076;8866.290696744374;8920.420172688755;8953.641854325753;9010.50442225684;8377.246047855722;8708.521031343336;8725.52009639476;8954.238889694449;9002.549872506217;6423.100765892872;6605.273419923708;6713.597184168965;6998.930010699828;7143.1428228612895;7297.854042919218;7622.123455802432;7630.351420129351;7662.540247585162;7667.156612772702;6727.562708424132;6871.793846184622;6909.2399836019;6910.619915904473;6984.40632546219;6821.1814582250445;6839.2476827547935;6908.2400935896;6953.617551034742;6991.2309645937885;6355.618662880242;6481.902771458337;6512.73949042033;6527.184101987252;6582.967085164543;4761.142994261067;4920.92618610714;4956.207006878882;4990.026944745885;5033.043721692867;4888.60891128716;4902.166631672553;4956.256561515657;5038.748062596929;5085.542301192911 13:13:32 INFO - PROCESS | 7593 | |4;prototype.html;313.4233011259282;315.3126184916881;325.11730651281766;325.4548631043002;327.15267457285626;5240.60695447841;5357.598180136486;5365.792696643253;5379.488948549886;5400.189971504276;5167;5292.729744861234;5321.467853214676;5323.840284791453;5324.41431442541;4198.383622305404;4215.430916826235;4220.388043733649;4221.366794980762;4235.131797981407;4144.937825932613;4158.8544400945975;4197.8530751423705;4226.957730422687;4239.47006624172;4181.351890456969;4182.749035057891;4188.617756140482;4192.67930601861;4201.642860356873;4176.749395036292;4187;4194.3918131870705;4196.9781757134815;4231.534531201565;3765.8870233892753;3766.435034744783;3774.471573979645;3776.2258736959134;3781.9243615127543;5064.164412871872;5293.417724050351;5307.867303317409;5313.415524292324;5345.518903298683;4782.736949467778;4787.736674482902;4790.736509491977;4803.327534145223;4810.903781924342;5440.211169380417;5681.176229446707;5688.232088668018;5690.630109042899;5709.086546152637;3998.1803730235233;4019.658329042035;4027.677785777131;4030;4060.2691515527194;5926.140709597127;5930.258717660293;5933.961556727599;5939.851503712399;5948.643081415085;3994;4066.7153299269357;4082.4284600156;4090.4068910008477;4117.279476091672;4086;4089.6728261739586;4096.242195193899;4117.958820411817;4122.608352206596;4722.173619616553;4727.739974301447;4729.12511185425;4736.739479328601;4741;5564;5707.1724599933605;5715.514181294637;5731.914021289684;5736.196932429463;1378.1248906944163;1378.3659516622265;1385.210430054859;1391.5199256256778;1391.7355702416507;902.4540153207346;926.0693003531408;939.4551160326994;941.87755591774;945.7493764152505;5258.1849813279005;5260.631755777059;5269.394019687785;5274.446183150791;5289.3917199521775;5596.888062238732;5622.987862184846;5629.915551266734;5631.621027383537;5681.045856154777;5143.717095559706;5198.376194856642;5294.364676238799;5307.946920530745;5353.785848566014;2943.632045994251;2965.8072225305286;2972.821630702165;2986.4176485585103;2987.4025194961096;5811.709414529341;5815.680137592473;5820.185174075633;5828.406359170213;5846.269216347957;5372.334576281365;5605.467480589337;5672.14917762339;5672.574556908248;5691.743871525791;5793.479836271235;5797.623154494944;5816.389279125716;5816.76732930678;5825.446582574648;5358.687121655219;5474.972625136849;5576.442355764391;5610.551155907436;5627.212190293444;5488.74961265895;5494.1758736189895;5494.560435165257;5499.560035197094;5535.667859928417;5739.483446489836;5746.310442746897;5751.482366587027;5775.451332123442;5793.594448388572;3779.508663873679;3911.2568611963634;3912.3349030664285;3926.293267211929;3936.68506519472;5543.417941116125;5596.440355964533;5611.382747897646;5613.810613860516;5622.803201887914;5471.835844924659;5482.890342193214;5514.6139770217305;5529.861753456195;5531.170324451365;5318.4310628363955;5376.650517716336;5393.029254734185;5396.730163491731;5410.323709536308;5304.336957880265;5338.932213557382;5374;5381.520081977487;5392.218128371285;5267.4469180737005;5483.862903427446;5516.779328826802;5519.862003449946;5541.501264886018;5323.7071961040965;5331.3868905076415;5333.73331333424;5353.644396465543;5384.596155288291 13:13:32 INFO - PROCESS | 7593 | |5;yui.html;653.532724102267;690.8134803603026;737.4137560639294;738.6454501839117;808.7129069180437;13346.933265333671;15154.318055687492;15203.77194342083;15228.695426091484;15384.23078846056;12152.513899444033;12222.266664000166;12335.074869384787;12797.872021279785;12887.226766394024;761.5202422473834;779.8050487378156;784.6469088910013;785.9371250299962;786.453414876661;773.3967505345811;794.5471081483556;795.0657976877175;801.7634797734682;801.8997625296838;834.2950207075042;845.6786421159951;846.9153084691543;847.821957388946;849.0363437498422;827.995860020702;831.787894087007;833.62903507939;837.1628371628371;839.3536976528039;614.8493619063313;616.3189675408654;616.747133675191;618.761776715963;620.0420350558398;14389.06471079387;14421.78367324491;14431.206283654396;14449.49426770058;14544.418223271057;13094.279814610192;13315.800262996063;13758.862411375858;13835.30823458823;14023.859761402357;10751.623693170779;10824;10830.566777328897;10948.507317170666;11370.772584548346;3573.5890372607223;3622.5290712207507;3683.4843121962945;3807.58116607173;3808.6000969898037;61032.389676103114;62599;62910.370896291366;64350.999999999534;64578.67710661464;9880.456574888307;9928.652497162564;10103.747406314755;10278.972202430434;10303.433311167808;18995.62008759817;19060.904695476434;19331.710024349646;19440.90279548593;19455.708164377545;7338.889916651255;7590.8861367079535;7656.124249558894;7731.884021739678;7795.961020194863;4328.156009578165;4414.889627759268;4451.399061126771;4460.4137036205175;4466.129104824528;3317.701406873393;3380.9492857607156;3399.3881101401985;3457.135716070982;3611.94582081269;653.0856800479366;656.4846595422571;665.1153965226238;667.8029981155571;669.6584741781629;616.8488720263564;655.6852710698796;665.112075379374;693.5318659904544;695.5791745993702;8393.496390216484;9052.551205073094;9063.54682265884;9068.954655226813;9188.448693078437;509.630517874538;643.8004218692126;673.9292374300726;675.378651640492;712.8895021271711;4014;4264.6801489888385;4287.634207147375;4433.4236549249035;4541.205289074399;51812.48187518152;63836.361636383044;68489;82771;82972.92567685856;75572.62213688897;75697.62151189208;77531;78288;78319.60840195762;68671.3132868665;69589;69740;70540.2945970544;71087;9044.14080662336;9106.908930910606;9116.954415227881;9176.35765496409;9204.585793639437;43863;44313.33529996988;45048;45345.77327113343;46657.76671116623;59805.700971494865;61576;64733.35266647273;64870.35129648832;65218;12497;12711.491540338282;12802.935985320013;12833.935830321163;12910.289934053342;13314.533991310258;13381.464741410624;13609.727805444034;13663.521776737767;13671.453141874214;12343.07426942965;12554.937225313815;12968.700349539138;13350.666233344244;13469.528566500125;11761.381662436384;11851;11864.822027669765;11957.103217258915;12341.259524428204;12300.569480068512;12872.485100595872;13009.674758131123;13132.671683207996;13268.203907765565;8853.247473964786;9214.677486287948;9308.906910930804;9486.33595648298;9840.261980351359;8692.78268043304;9169.312301577542;9533.61865525399;10161;10166.6441674544 13:13:32 INFO - PROCESS | 7593 | __end_tp_report 13:13:32 INFO - PROCESS | 7593 | __start_cc_report 13:13:32 INFO - PROCESS | 7593 | _x_x_mozilla_cycle_collect,307 13:13:32 INFO - PROCESS | 7593 | __end_cc_report 13:13:32 INFO - PROCESS | 7593 | __startTimestamp1479417212090__endTimestamp 13:13:32 INFO - PROCESS | 7593 | 13:13:32 INFO - PROCESS | 7593 | ------- Summary: start ------- 13:13:32 INFO - PROCESS | 7593 | Number of tests: 6 13:13:32 INFO - PROCESS | 7593 | 13:13:32 INFO - PROCESS | 7593 | [#0] dojo.html Cycles:165 Average:5375.65 Median:5580.30 stddev:602.33 (10.8%) stddev-sans-first:576.93 13:13:32 INFO - PROCESS | 7593 | Values: 3092.2 3099.6 3112.7 3122.2 3140.6 5255.4 5286.3 5315.3 5318.4 5321.8 5386.5 5448.4 5463.9 5475.0 5479.2 4900.1 4917.2 4983.9 4991.8 4998.2 4901.9 4997.7 5008.2 5014.0 5041.3 4907.2 5007.3 5091.5 5093.5 5095.7 4863.3 4921.4 4944.1 4971.5 4971.5 4812.9 4918.4 4937.4 4943.5 4952.1 5271.3 5312.3 5339.3 5364.9 5380.5 5747.7 5783.8 5787.2 5856.2 5863.0 5843.8 5853.8 5879.7 5880.5 5897.4 5349.2 5355.3 5365.2 5383.6 5400.9 5804.8 5842.6 5853.3 5867.1 5880.6 5483.7 5495.6 5633.4 5649.9 5669.0 5646.2 5658.2 5663.8 5727.9 5782.8 5838.8 5847.1 5857.7 5865.3 5905.7 5646.5 5702.5 5743.6 5842.7 5846.8 4468.6 4509.6 4519.3 4550.3 4556.6 3912.3 3946.1 3964.2 4035.7 4059.1 5380.5 5433.1 5441.6 5441.8 5449.6 5771.7 5832.9 5849.0 5862.7 5884.7 5276.5 5331.4 5519.2 5536.9 5572.5 4858.5 4876.6 4891.4 4895.7 4915.8 5881.6 5946.3 5963.2 5994.2 6021.3 5760.6 5761.2 5773.5 5784.1 5788.2 5873.7 5873.8 5927.7 5979.8 6010.1 5601.9 5669.3 5680.7 5694.9 5739.9 5786.0 5822.5 5873.1 5904.8 5934.4 5710.3 5711.6 5713.8 5718.1 5741.5 5596.9 5647.3 5651.5 5660.4 5723.6 5523.3 5584.0 5626.7 5630.4 5638.0 5611.8 5712.8 5731.8 5732.3 5781.3 5540.3 5546.9 5550.2 5551.9 5580.3 13:13:32 INFO - PROCESS | 7593 | 13:13:32 INFO - PROCESS | 7593 | [#1] ext.html Cycles:180 Average:55891.68 Median:21932.20 stddev:108241.57 (493.5%) stddev-sans-first:108465.45 13:13:32 INFO - PROCESS | 7593 | Values: 545.3 569.0 575.9 579.9 589.0 40156.8 41373.4 41385.4 44793.8 44911.3 42167.6 42364.4 42584.1 42626.0 42862.0 8353.3 8488.5 8494.3 8501.9 8502.2 8427.8 8551.9 8552.6 8560.1 8582.3 8586.8 8587.2 8601.8 8645.1 8647.3 8549.3 8553.9 8567.2 8582.7 8602.6 8481.3 8543.1 8549.5 8554.4 8560.5 39975.6 40249.0 40430.8 40764.4 40894.6 3175.4 3271.0 3307.5 3312.4 3786.7 30267.8 30842.7 30843.4 30894.8 30896.8 3993.8 4075.5 4198.7 4218.3 4358.7 336300.0 336750.0 336965.0 337766.0 338378.0 53795.5 53848.7 54161.0 54644.7 54694.0 59429.0 59596.0 59601.0 59968.0 60206.0 14380.5 14414.9 14415.0 14547.9 14579.2 10752.0 10758.5 10862.9 10888.6 10929.7 16571.3 16577.3 16736.4 16864.9 16887.0 5416.7 5556.7 5603.3 5622.6 5645.2 978.9 1015.4 1037.3 1063.2 1078.5 29506.7 31185.8 31201.0 31248.8 31572.8 972.6 1110.2 1113.5 1130.6 1138.3 15242.8 15877.9 16296.9 16299.7 16607.8 497225.0 497794.0 507267.0 508705.0 516311.0 53672.2 54047.7 54054.5 54103.0 54335.5 1300.8 1311.5 1313.2 1331.7 1347.3 28875.3 31483.0 32537.0 32537.2 32979.3 47584.3 48069.8 48071.0 48079.8 48272.8 361256.0 362053.0 363810.0 364379.8 365200.0 27413.5 27559.6 27803.2 27865.2 27950.0 44100.6 44590.3 44960.6 45162.5 45793.0 38818.8 39096.6 39268.8 39330.6 39870.6 38032.4 38646.4 38656.2 39497.4 39991.2 38396.0 38474.0 39030.6 39480.0 42144.6 32924.8 35621.5 36036.8 36046.6 36213.5 27324.6 27375.6 27403.7 27419.0 27634.4 13:13:32 INFO - PROCESS | 7593 | 13:13:32 INFO - PROCESS | 7593 | [#2] jquery.html Cycles:180 Average:27177.77 Median:390.37 stddev:72410.32 (18549.2%) stddev-sans-first:72585.50 13:13:32 INFO - PROCESS | 7593 | Values: 380.7 386.4 390.3 390.4 420.8 18251.6 18446.8 18596.5 19222.5 19249.3 18208.2 18510.7 18857.8 18916.7 18995.2 5255.2 5362.3 5463.6 5602.0 5631.4 5482.9 5515.0 5519.1 5524.7 5552.4 5419.1 5561.3 5581.3 5612.5 5627.6 5587.2 5594.9 5613.8 5615.0 5621.9 5179.7 5259.4 5279.7 5292.7 5425.2 11985.6 12121.3 12274.8 12295.3 12344.8 2132.9 2292.2 2423.1 2681.2 2853.4 9513.5 9682.2 9878.1 10029.3 12663.7 1880.5 1932.4 1965.7 1970.8 1971.4 82069.0 82618.6 83463.0 83642.6 83701.6 10076.1 10116.6 10500.3 10548.8 10786.8 14489.7 14538.2 14545.0 14604.2 14617.0 7175.4 7276.7 7468.2 7546.9 7637.6 7051.8 7054.0 7072.7 7231.7 7280.7 4279.2 4283.8 4285.1 4373.9 4436.1 1775.3 1829.7 1838.2 1848.7 1864.5 885.4 999.7 1013.3 1015.1 1044.5 17837.6 18215.4 19215.7 19442.3 19456.5 952.9 954.4 975.5 978.8 996.6 10183.4 10520.1 10681.1 10718.6 10759.1 420272.0 432600.0 439284.0 439584.0 447148.0 84739.0 89064.0 93601.0 97451.5 97559.0 1010.4 1013.5 1033.3 1046.5 1051.5 16592.7 17151.3 17486.2 17888.8 17899.0 42123.6 42433.4 43330.4 43807.8 43809.8 58484.0 60659.0 62198.7 63049.0 64167.7 7792.2 8059.7 8229.5 8434.5 8752.4 9148.5 13165.7 13309.1 13421.3 13439.5 11556.2 11804.4 11950.7 12047.2 12066.0 11363.7 11366.4 11464.9 11480.3 11605.5 11617.9 11744.9 11925.9 11932.5 11944.7 6963.5 6991.4 7185.0 7384.3 8668.1 8929.5 11239.2 11683.2 11839.6 11881.2 13:13:32 INFO - PROCESS | 7593 | 13:13:32 INFO - PROCESS | 7593 | [#3] mootools.html Cycles:180 Average:5244.49 Median:5421.75 stddev:2830.17 (52.2%) stddev-sans-first:2823.55 13:13:32 INFO - PROCESS | 7593 | Values: 1424.9 1442.5 1547.2 1653.6 1666.5 7086.0 7285.7 7451.8 8010.5 8022.4 7593.4 7872.2 7878.2 8047.5 8058.1 2225.2 2249.7 2261.0 2263.4 2264.2 2203.5 2239.4 2308.6 2309.1 2309.1 2261.5 2266.5 2283.1 2285.4 2290.1 2122.6 2124.8 2165.7 2172.4 2174.0 2194.7 2195.4 2217.1 2217.7 2223.8 7755.2 7921.4 7935.0 7935.3 7944.8 4833.8 4948.4 4959.1 4966.1 4972.2 3066.0 3069.0 3220.7 3246.9 3248.5 1123.2 1153.5 1179.2 1186.0 1192.1 10617.4 10778.5 10780.7 10782.2 10909.3 4210.4 4422.8 4439.4 4545.5 4557.5 8961.4 9143.9 9157.6 9170.9 9187.9 4919.3 4932.2 4934.9 4936.0 4944.8 4104.3 4259.9 4477.1 4569.0 4578.1 3592.2 3670.0 3780.1 3796.1 3805.2 1256.6 1268.3 1274.7 1280.9 1310.8 905.5 918.8 926.9 930.6 966.3 5400.4 5443.1 5454.5 5508.6 5517.9 895.6 908.9 916.8 936.1 938.4 3399.8 3517.8 3528.3 3536.2 3602.6 9188.3 9735.4 9740.4 9745.3 9751.9 8971.3 9339.3 9459.9 9670.6 9759.5 6989.0 7033.0 7056.7 7182.2 7227.6 5450.5 5522.9 5572.2 5619.2 5711.5 8854.2 8866.3 8920.4 8953.6 9010.5 8377.2 8708.5 8725.5 8954.2 9002.5 6423.1 6605.3 6713.6 6998.9 7143.1 7297.9 7622.1 7630.4 7662.5 7667.2 6727.6 6871.8 6909.2 6910.6 6984.4 6821.2 6839.2 6908.2 6953.6 6991.2 6355.6 6481.9 6512.7 6527.2 6583.0 4761.1 4920.9 4956.2 4990.0 5033.0 4888.6 4902.2 4956.3 5038.7 5085.5 13:13:32 INFO - PROCESS | 7593 | 13:13:32 INFO - PROCESS | 7593 | [#4] prototype.html Cycles:180 Average:4661.47 Median:5323.77 stddev:1360.12 (25.5%) stddev-sans-first:1324.20 13:13:32 INFO - PROCESS | 7593 | Values: 313.4 315.3 325.1 325.5 327.2 5240.6 5357.6 5365.8 5379.5 5400.2 5167.0 5292.7 5321.5 5323.8 5324.4 4198.4 4215.4 4220.4 4221.4 4235.1 4144.9 4158.9 4197.9 4227.0 4239.5 4181.4 4182.7 4188.6 4192.7 4201.6 4176.7 4187.0 4194.4 4197.0 4231.5 3765.9 3766.4 3774.5 3776.2 3781.9 5064.2 5293.4 5307.9 5313.4 5345.5 4782.7 4787.7 4790.7 4803.3 4810.9 5440.2 5681.2 5688.2 5690.6 5709.1 3998.2 4019.7 4027.7 4030.0 4060.3 5926.1 5930.3 5934.0 5939.9 5948.6 3994.0 4066.7 4082.4 4090.4 4117.3 4086.0 4089.7 4096.2 4118.0 4122.6 4722.2 4727.7 4729.1 4736.7 4741.0 5564.0 5707.2 5715.5 5731.9 5736.2 1378.1 1378.4 1385.2 1391.5 1391.7 902.5 926.1 939.5 941.9 945.7 5258.2 5260.6 5269.4 5274.4 5289.4 5596.9 5623.0 5629.9 5631.6 5681.0 5143.7 5198.4 5294.4 5307.9 5353.8 2943.6 2965.8 2972.8 2986.4 2987.4 5811.7 5815.7 5820.2 5828.4 5846.3 5372.3 5605.5 5672.1 5672.6 5691.7 5793.5 5797.6 5816.4 5816.8 5825.4 5358.7 5475.0 5576.4 5610.6 5627.2 5488.7 5494.2 5494.6 5499.6 5535.7 5739.5 5746.3 5751.5 5775.5 5793.6 3779.5 3911.3 3912.3 3926.3 3936.7 5543.4 5596.4 5611.4 5613.8 5622.8 5471.8 5482.9 5514.6 5529.9 5531.2 5318.4 5376.7 5393.0 5396.7 5410.3 5304.3 5338.9 5374.0 5381.5 5392.2 5267.4 5483.9 5516.8 5519.9 5541.5 5323.7 5331.4 5333.7 5353.6 5384.6 13:13:32 INFO - PROCESS | 7593 | 13:13:32 INFO - PROCESS | 7593 | [#5] yui.html Cycles:180 Average:17088.09 Median:31096.16 stddev:22442.50 (72.2%) stddev-sans-first:22471.53 13:13:32 INFO - PROCESS | 7593 | Values: 653.5 690.8 737.4 738.6 808.7 13346.9 15154.3 15203.8 15228.7 15384.2 12152.5 12222.3 12335.1 12797.9 12887.2 761.5 779.8 784.6 785.9 786.5 773.4 794.5 795.1 801.8 801.9 834.3 845.7 846.9 847.8 849.0 828.0 831.8 833.6 837.2 839.4 614.8 616.3 616.7 618.8 620.0 14389.1 14421.8 14431.2 14449.5 14544.4 13094.3 13315.8 13758.9 13835.3 14023.9 10751.6 10824.0 10830.6 10948.5 11370.8 3573.6 3622.5 3683.5 3807.6 3808.6 61032.4 62599.0 62910.4 64351.0 64578.7 9880.5 9928.7 10103.7 10279.0 10303.4 18995.6 19060.9 19331.7 19440.9 19455.7 7338.9 7590.9 7656.1 7731.9 7796.0 4328.2 4414.9 4451.4 4460.4 4466.1 3317.7 3380.9 3399.4 3457.1 3611.9 653.1 656.5 665.1 667.8 669.7 616.8 655.7 665.1 693.5 695.6 8393.5 9052.6 9063.5 9069.0 9188.4 509.6 643.8 673.9 675.4 712.9 4014.0 4264.7 4287.6 4433.4 4541.2 51812.5 63836.4 68489.0 82771.0 82972.9 75572.6 75697.6 77531.0 78288.0 78319.6 68671.3 69589.0 69740.0 70540.3 71087.0 9044.1 9106.9 9117.0 9176.4 9204.6 43863.0 44313.3 45048.0 45345.8 46657.8 59805.7 61576.0 64733.4 64870.4 65218.0 12497.0 12711.5 12802.9 12833.9 12910.3 13314.5 13381.5 13609.7 13663.5 13671.5 12343.1 12554.9 12968.7 13350.7 13469.5 11761.4 11851.0 11864.8 11957.1 12341.3 12300.6 12872.5 13009.7 13132.7 13268.2 8853.2 9214.7 9308.9 9486.3 9840.3 8692.8 9169.3 9533.6 10161.0 10166.6 13:13:32 INFO - PROCESS | 7593 | -------- Summary: end -------- 13:13:32 INFO - PROCESS | 7593 | 13:13:33 INFO - TEST-INFO | 7593: exit 0 13:13:33 INFO - TEST-OK | dromaeo_css | took 1116271ms 13:13:33 INFO - TEST-START | kraken 13:13:33 INFO - operating with platform_type : linux_ 13:13:33 INFO - Initialising browser for kraken test... 13:13:33 INFO - TEST-INFO | started process 7948 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyhPRRr/profile http://localhost:52401/getInfo.html) 13:13:37 INFO - PROCESS | 7948 | __metrics Screen width/height:1600/1200 13:13:37 INFO - PROCESS | 7948 | colorDepth:24 13:13:37 INFO - PROCESS | 7948 | Browser inner width/height: 1024/697 13:13:37 INFO - PROCESS | 7948 | __metrics 13:13:37 ERROR - PROCESS | 7948 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3201: TypeError: this.tabs is undefined 13:13:39 INFO - TEST-INFO | 7948: exit 0 13:13:39 INFO - Browser initialized. 13:13:39 INFO - Running cycle 1/1 for kraken test... 13:13:39 INFO - TEST-INFO | started process 8072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyhPRRr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:13:51 INFO - PROCESS | 8072 | RSS: Main: 186396672 13:13:51 INFO - PROCESS | 8072 | 13:13:53 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52401/tests/kraken/driver.html?testName=audio-beat-detection) 13:13:54 INFO - PROCESS | 8072 | RSS: Main: 198905856 13:13:54 INFO - PROCESS | 8072 | 13:13:57 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52401/tests/kraken/driver.html?testName=audio-dft) 13:13:58 INFO - PROCESS | 8072 | RSS: Main: 196677632 13:13:58 INFO - PROCESS | 8072 | 13:14:00 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52401/tests/kraken/driver.html?testName=audio-fft) 13:14:01 INFO - PROCESS | 8072 | RSS: Main: 193462272 13:14:01 INFO - PROCESS | 8072 | 13:14:03 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52401/tests/kraken/driver.html?testName=audio-oscillator) 13:14:04 INFO - PROCESS | 8072 | RSS: Main: 193900544 13:14:04 INFO - PROCESS | 8072 | 13:14:06 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52401/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:14:06 INFO - PROCESS | 8072 | RSS: Main: 194183168 13:14:06 INFO - PROCESS | 8072 | 13:14:10 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52401/tests/kraken/driver.html?testName=imaging-darkroom) 13:14:10 INFO - PROCESS | 8072 | RSS: Main: 198426624 13:14:10 INFO - PROCESS | 8072 | 13:14:14 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52401/tests/kraken/driver.html?testName=imaging-desaturate) 13:14:14 INFO - PROCESS | 8072 | RSS: Main: 198246400 13:14:14 INFO - PROCESS | 8072 | 13:14:17 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52401/tests/kraken/driver.html?testName=json-parse-financial) 13:14:18 INFO - PROCESS | 8072 | RSS: Main: 197828608 13:14:18 INFO - PROCESS | 8072 | 13:14:19 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52401/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:14:20 INFO - PROCESS | 8072 | RSS: Main: 197398528 13:14:20 INFO - PROCESS | 8072 | 13:14:22 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52401/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:14:22 INFO - PROCESS | 8072 | RSS: Main: 197423104 13:14:22 INFO - PROCESS | 8072 | 13:14:24 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52401/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:14:25 INFO - PROCESS | 8072 | RSS: Main: 197410816 13:14:25 INFO - PROCESS | 8072 | 13:14:28 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:14:29 INFO - PROCESS | 8072 | RSS: Main: 197697536 13:14:29 INFO - PROCESS | 8072 | 13:14:31 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:14:32 INFO - PROCESS | 8072 | RSS: Main: 198242304 13:14:32 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | Cycle 1(1): loaded http://localhost:52401/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52401/tests/kraken/driver.html?testName=ai-astar) 13:14:34 INFO - PROCESS | 8072 | RSS: Main: 199667712 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | __start_tp_report 13:14:34 INFO - PROCESS | 8072 | _x_x_mozilla_page_load 13:14:34 INFO - PROCESS | 8072 | _x_x_mozilla_page_load_details 13:14:34 INFO - PROCESS | 8072 | |i|pagename|runs| 13:14:34 INFO - PROCESS | 8072 | |0;ai-astar;105;115;114;115;114;116;116;115;113;112 13:14:34 INFO - PROCESS | 8072 | |1;audio-beat-detection;151;130;124;166;126;126;128;125;157;130 13:14:34 INFO - PROCESS | 8072 | |2;audio-dft;163;163;164;166;175;164;161;164;166;161 13:14:34 INFO - PROCESS | 8072 | |3;audio-fft;76;76;77;106;77;76;75;75;117;78 13:14:34 INFO - PROCESS | 8072 | |4;audio-oscillator;84;84;124;83;84;82;97;83;82;107 13:14:34 INFO - PROCESS | 8072 | |5;imaging-gaussian-blur;118;118;118;118;118;117;120;119;119;118 13:14:34 INFO - PROCESS | 8072 | |6;imaging-darkroom;147;148;148;148;146;148;146;147;147;146 13:14:34 INFO - PROCESS | 8072 | |7;imaging-desaturate;97;95;98;95;97;97;96;96;96;96 13:14:34 INFO - PROCESS | 8072 | |8;json-parse-financial;53;54;55;56;54;56;54;55;57;55 13:14:34 INFO - PROCESS | 8072 | |9;json-stringify-tinderbox;63;64;64;63;64;63;63;63;64;64 13:14:34 INFO - PROCESS | 8072 | |10;stanford-crypto-aes;82;82;82;81;82;82;82;82;82;83 13:14:34 INFO - PROCESS | 8072 | |11;stanford-crypto-ccm;145;152;141;135;139;135;141;142;188;141 13:14:34 INFO - PROCESS | 8072 | |12;stanford-crypto-pbkdf2;165;170;171;170;179;168;166;172;167;167 13:14:34 INFO - PROCESS | 8072 | |13;stanford-crypto-sha256-iterative;66;69;65;68;68;68;65;64;66;65 13:14:34 INFO - PROCESS | 8072 | __end_tp_report 13:14:34 INFO - PROCESS | 8072 | __start_cc_report 13:14:34 INFO - PROCESS | 8072 | _x_x_mozilla_cycle_collect,819 13:14:34 INFO - PROCESS | 8072 | __end_cc_report 13:14:34 INFO - PROCESS | 8072 | __startTimestamp1479417274502__endTimestamp 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | ------- Summary: start ------- 13:14:34 INFO - PROCESS | 8072 | Number of tests: 14 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.24 (2.8%) stddev-sans-first:1.33 13:14:34 INFO - PROCESS | 8072 | Values: 105.0 115.0 114.0 115.0 114.0 116.0 116.0 115.0 113.0 112.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:130.00 stddev:15.51 (11.9%) stddev-sans-first:15.52 13:14:34 INFO - PROCESS | 8072 | Values: 151.0 130.0 124.0 166.0 126.0 126.0 128.0 125.0 157.0 130.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.00 stddev:4.00 (2.4%) stddev-sans-first:4.20 13:14:34 INFO - PROCESS | 8072 | Values: 163.0 163.0 164.0 166.0 175.0 164.0 161.0 164.0 166.0 161.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:15.11 (19.9%) stddev-sans-first:15.80 13:14:34 INFO - PROCESS | 8072 | Values: 76.0 76.0 77.0 106.0 77.0 76.0 75.0 75.0 117.0 78.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:83.50 stddev:14.21 (17.0%) stddev-sans-first:14.85 13:14:34 INFO - PROCESS | 8072 | Values: 84.0 84.0 124.0 83.0 84.0 82.0 97.0 83.0 82.0 107.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 13:14:34 INFO - PROCESS | 8072 | Values: 118.0 118.0 118.0 118.0 118.0 117.0 120.0 119.0 119.0 118.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#6] imaging-darkroom Cycles:10 Average:147.10 Median:147.50 stddev:0.88 (0.6%) stddev-sans-first:0.93 13:14:34 INFO - PROCESS | 8072 | Values: 147.0 148.0 148.0 148.0 146.0 148.0 146.0 147.0 147.0 146.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.95 (1.0%) stddev-sans-first:0.97 13:14:34 INFO - PROCESS | 8072 | Values: 97.0 95.0 98.0 95.0 97.0 97.0 96.0 96.0 96.0 96.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.20 (2.2%) stddev-sans-first:1.05 13:14:34 INFO - PROCESS | 8072 | Values: 53.0 54.0 55.0 56.0 54.0 56.0 54.0 55.0 57.0 55.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:64.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 13:14:34 INFO - PROCESS | 8072 | Values: 63.0 64.0 64.0 63.0 64.0 63.0 63.0 63.0 64.0 64.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.00 stddev:0.47 (0.6%) stddev-sans-first:0.50 13:14:34 INFO - PROCESS | 8072 | Values: 82.0 82.0 82.0 81.0 82.0 82.0 82.0 82.0 82.0 83.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#11] stanford-crypto-ccm Cycles:10 Average:145.90 Median:141.50 stddev:15.57 (11.0%) stddev-sans-first:16.52 13:14:34 INFO - PROCESS | 8072 | Values: 145.0 152.0 141.0 135.0 139.0 135.0 141.0 142.0 188.0 141.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:170.00 stddev:4.03 (2.4%) stddev-sans-first:3.94 13:14:34 INFO - PROCESS | 8072 | Values: 165.0 170.0 171.0 170.0 179.0 168.0 166.0 172.0 167.0 167.0 13:14:34 INFO - PROCESS | 8072 | 13:14:34 INFO - PROCESS | 8072 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.00 stddev:1.71 (2.6%) stddev-sans-first:1.81 13:14:34 INFO - PROCESS | 8072 | Values: 66.0 69.0 65.0 68.0 68.0 68.0 65.0 64.0 66.0 65.0 13:14:34 INFO - PROCESS | 8072 | -------- Summary: end -------- 13:14:34 INFO - PROCESS | 8072 | 13:14:35 INFO - TEST-INFO | 8072: exit 0 13:14:35 INFO - TEST-OK | kraken | took 62643ms 13:14:35 INFO - SUITE-END | took 1178s 13:14:36 INFO - Completed test suite (00:19:39) 13:14:36 INFO - javascript benchmark 13:14:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6937.055307809114, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3092.1651154188385, 3099.6280446346436, 3112.704293092157, 3122.172624254573, 3140.6074240719904, 5255.395629502608, 5286.259923610693, 5315.309009828717, 5318.414974352818, 5321.787128514855, 5386.515213630772, 5448.37343705474, 5463.945360546393, 5474.959757646045, 5479.232907392969, 4900.093482705711, 4917.188663870466, 4983.875403114915, 4991.7504124793795, 4998.200287953928, 4901.926471102936, 4997.6501644884875, 5008.173651347523, 5014.047331007116, 5041.319421878036, 4907.2393778964315, 5007.32401125847, 5091.465396133408, 5093.465186155456, 5095.745212739367, 4863.27050942358, 4921.360223171001, 4944.110060189165, 4971.477994810565, 4971.52770486805, 4812.903741925177, 4918.360613120271, 4937.407511098655, 4943.456219815817, 4952.108620448318, 5271.262023316739, 5312.309399778004, 5339.332583427033, 5364.946350536523, 5380.542653874386, 5747.741351639186, 5783.768649254025, 5787.189793428924, 5856.209411729405, 5862.97068514659, 5843.795467158671, 5853.795117170878, 5879.735411906475, 5880.500157486619, 5897.439743224387, 5349.22436246742, 5355.30381050461, 5365.195220716884, 5383.596230282745, 5400.91898621521, 5804.767809287666, 5842.649441033466, 5853.2976042875125, 5867.119932010147, 5880.588358814927, 5483.725813709299, 5495.6153069285565, 5633.380328163898, 5649.887002259932, 5668.9716551417805, 5646.153077038395, 5658.179563963285, 5663.80176693822, 5727.942720572824, 5782.843431313754, 5838.795642152504, 5847.06446968483, 5857.70711464425, 5865.266841644794, 5905.675187864708, 5646.548276137899, 5702.45826646468, 5743.597948143673, 5842.678652674059, 5846.795362162304, 4468.642508599304, 4509.6392288616835, 4519.344695019204, 4550.294704320836, 4556.612687921497, 3912.295786758411, 3946.092398748304, 3964.1873415949663, 4035.6973227008093, 4059.127287633114, 5380.461953804588, 5433.130699088127, 5441.6190866639745, 5441.809536666197, 5449.64577302482, 5771.711414429262, 5832.88334233313, 5849.0, 5862.677552734641, 5884.705764711747, 5276.472352764693, 5331.413544510101, 5519.227308176858, 5536.944630553723, 5572.5263352614675, 4858.489858564871, 4876.5854902333695, 4891.437484689235, 4895.730734809548, 4915.778789954461, 5881.5588830837005, 5946.316173640087, 5963.194968679173, 5994.160817485643, 6021.277446706424, 5760.6255593386295, 5761.193432919311, 5773.480386765212, 5784.1034639630925, 5788.160716696139, 5873.706314684163, 5873.765049397976, 5927.703614819328, 5979.790707325223, 6010.128531363015, 5601.915971260353, 5669.291338582677, 5680.744366503434, 5694.886102278014, 5739.9139012915675, 5785.971070144622, 5822.475977162076, 5873.060310350495, 5904.763809447574, 5934.376890426443, 5710.2576665033275, 5711.600187986801, 5713.8285851424525, 5718.056520674042, 5741.483266506035, 5596.86007849807, 5647.265855438931, 5651.463111004448, 5660.433956604306, 5723.5707321950185, 5523.33719953592, 5584.0, 5626.746796394254, 5630.4369563045, 5638.0, 5611.831645050655, 5712.7714891403875, 5731.799387021601, 5732.3121225453215, 5781.306243250837, 5540.335159780852, 5546.889062218814, 5550.222968784293, 5551.916721249266, 5580.302462192226], "value": 5335.324358032094, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.2617301819208, 568.9630174038684, 575.9020966435705, 579.9449052340027, 588.9676067816271, 40156.799216003914, 41373.37939930896, 41385.37921931173, 44793.7760311198, 44911.326330105076, 42167.578324216745, 42364.364534532004, 42584.14831703364, 42626.0, 42862.0, 8353.331733461324, 8488.53313067781, 8494.277986371135, 8501.914980850204, 8502.192291732306, 8427.789305267386, 8551.871721924144, 8552.61513231903, 8560.101189375087, 8582.313414926823, 8586.828263434727, 8587.227149556538, 8601.827963440728, 8645.092265312145, 8647.30821534279, 8549.316054715608, 8553.947052707337, 8567.228949394585, 8582.699605513839, 8602.569871506399, 8481.279091277249, 8543.102974187683, 8549.487030778173, 8554.35842311829, 8560.47465997526, 39975.600243997476, 40249.0, 40430.79784601088, 40764.38853417201, 40894.591054089375, 3175.3649270145834, 3270.9509357359657, 3307.5038744188564, 3312.3540909522653, 3786.697064234882, 30267.848660756554, 30842.691573084205, 30843.38313233745, 30894.845525772453, 30896.845515772504, 3993.800309984518, 4075.4701888754566, 4198.706090573661, 4218.346156345771, 4358.7166834156, 336300.0, 336750.0, 336965.0, 337766.0, 338378.0, 53795.46204537983, 53848.73075634597, 54161.0, 54644.72677636586, 54694.0, 59429.0, 59596.0, 59601.0, 59968.0, 60206.0, 14380.496682616058, 14414.855851441562, 14415.0, 14547.854521454861, 14579.198144101963, 10752.0, 10758.515866786014, 10862.945685271681, 10888.564457421773, 10929.726756831144, 16571.25429355682, 16577.254023568727, 16736.41422550205, 16864.915675421544, 16887.0, 5416.702081385482, 5556.721744084905, 5603.299587551556, 5622.554188927829, 5645.23789288449, 978.9314747967574, 1015.3907655406697, 1037.3412882819314, 1063.2185343772321, 1078.5308390850005, 29506.704932950826, 31185.8440707795, 31201.0, 31248.84375578153, 31572.842135789175, 972.5720682899502, 1110.2394859521253, 1113.471613439278, 1130.559081958037, 1138.320976559568, 15242.847571524364, 15877.920610396874, 16296.918515407348, 16299.674006519803, 16607.750883736753, 497225.0, 497794.0, 507267.0, 508705.0, 516311.0, 53672.194917076275, 54047.72976135094, 54054.45945540494, 54103.0, 54335.45664543383, 1300.8178854960313, 1311.475409836054, 1313.2317594207304, 1331.6604265912324, 1347.2657401716087, 28875.278118046375, 31483.0, 32537.0, 32537.186570335933, 32979.34041319208, 47584.2862357058, 48069.75965120152, 48071.0, 48079.75960120177, 48272.75863620659, 361256.0, 362053.0, 363810.0, 364379.8496120251, 365200.0, 27413.45173096567, 27559.586606201323, 27803.16590502288, 27865.16404507868, 27950.0, 44100.55899441093, 44590.3311450335, 44960.550394495636, 45162.548374515834, 45793.0, 38818.80590597142, 39096.609033910434, 39268.80365598154, 39330.60669393384, 39870.60129398785, 38032.429513556766, 38646.420303694904, 38656.2268754629, 39497.407538886364, 39991.2001759969, 38396.0, 38474.0, 39030.60969390383, 39480.0, 42144.578554214066, 32924.835375822964, 35621.465678014334, 36036.81981590075, 36046.639533605376, 36213.45679814752, 27324.590131148445, 27375.589366159922, 27403.725962740118, 27419.0, 27634.447311054068], "value": 18998.616260022336, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.7410960546827, 386.41072364643907, 390.31499717994916, 390.42412441648565, 420.7664746065934, 18251.634967300644, 18446.815531844677, 18596.53508662284, 19222.51943701408, 19249.326273580427, 18208.180631871564, 18510.722339164924, 18857.811421885777, 18916.71624925627, 18995.240190392367, 5255.185446255818, 5362.329708786392, 5463.644863083907, 5601.971990140044, 5631.4087020862835, 5482.890342193154, 5515.034868897927, 5519.116941289394, 5524.723763811813, 5552.3892371839065, 5419.078756611366, 5561.304836895388, 5581.330240371161, 5612.466815652507, 5627.634203776762, 5587.189857470665, 5594.916076258859, 5613.80351687691, 5615.0, 5621.8594535136535, 5179.715115668637, 5259.421463638997, 5279.656822306538, 5292.708901010443, 5425.159100339453, 11985.640430787003, 12121.27272363661, 12274.815877761841, 12295.262284262883, 12344.753104937941, 2132.86136401135, 2292.2435596253194, 2423.1155628195756, 2681.209043332222, 2853.443578502172, 9513.476758778264, 9682.225421966226, 9878.110970012733, 10029.348092373972, 12663.746725065539, 1880.5110671225443, 1932.3526618582791, 1965.6560101982238, 1970.8226259636558, 1971.3593082248326, 82069.0, 82618.58690706568, 83463.0, 83642.58178709068, 83701.58149209277, 10076.093151616244, 10116.645917393003, 10500.264981451224, 10548.789024219474, 10786.838197427045, 14489.710205796036, 14538.200398977946, 14545.0, 14604.196769177797, 14617.049891757002, 7175.354218120394, 7276.745313913988, 7468.21583733711, 7546.924530754732, 7637.579933103621, 7051.8237044073285, 7054.0, 7072.71709131629, 7231.746888858865, 7280.6723697433745, 4279.16556271524, 4283.807228674717, 4285.078708077778, 4373.934390984138, 4436.134953684065, 1775.325376356976, 1829.6798060339388, 1838.2187570282576, 1848.6579982702974, 1864.4593068010397, 885.3758100539104, 999.6651121874108, 1013.3160116921049, 1015.1422048369263, 1044.5143008501084, 17837.643247134984, 18215.36246231402, 19215.711764323547, 19442.319518816774, 19456.513587160433, 952.9237660987104, 954.4178051388648, 975.4683697384942, 978.7993461340408, 996.6312464388078, 10183.388996660076, 10520.10579100785, 10681.145508359312, 10718.624848130434, 10759.085477734323, 420272.0, 432600.0, 439284.0, 439584.0, 447148.0, 84739.0, 89064.0, 93601.0, 97451.51274243584, 97559.0, 1010.4038617215878, 1013.5236438873718, 1033.2921948465325, 1046.5447530324182, 1051.4795176387738, 16592.66814663676, 17151.313947441962, 17486.213120409357, 17888.821111788715, 17899.04583573999, 42123.57876421197, 42433.36349954815, 43330.350044748724, 43807.78096109499, 43809.78095109504, 58484.0, 60659.0, 62198.689006554676, 63049.0, 64167.67916160389, 7792.220777922389, 8059.717909873127, 8229.46508476947, 8434.451760635538, 8752.387332886638, 9148.496832674267, 13165.736685266433, 13309.134906231064, 13421.32893355348, 13439.529616463376, 11556.226505638755, 11804.350760708243, 11950.701232469259, 12047.216930899463, 12066.0, 11363.715907102389, 11366.374849383363, 11464.885351146382, 11480.253783504046, 11605.535778568763, 11617.941910290394, 11744.94127529357, 11925.880741192825, 11932.463039163085, 11944.701382465508, 6963.512554121366, 6991.405730512964, 7185.0, 7384.335409813142, 8668.133186681282, 8929.508877011827, 11239.213255072067, 11683.240589361665, 11839.58561450345, 11881.168318217642], "value": 8828.260226946282, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.9287535623216, 1442.5095467541037, 1547.1722628393811, 1653.5535405440523, 1666.4667306461922, 7086.0, 7285.672144753486, 7451.776446706601, 8010.519368837874, 8022.358211343086, 7593.354564861993, 7872.212778722125, 7878.212178782133, 8047.4769140006, 8058.073321568021, 2225.2434172381386, 2249.6513040478753, 2261.0390584001816, 2263.388885001049, 2264.1962103453284, 2203.5482726041205, 2239.4401399650087, 2308.56137333906, 2309.099451214028, 2309.145616122037, 2261.547690461906, 2266.5126997695493, 2283.1438210671, 2285.440067183534, 2290.1068583252545, 2122.564874200785, 2124.7875212478784, 2165.653495440722, 2172.359154049559, 2174.0108250745952, 2194.659827726705, 2195.3852921182092, 2217.1242359268, 2217.6562632791943, 2223.822094232474, 7755.224477552256, 7921.445498815086, 7935.0, 7935.285824275843, 7944.761657150295, 4833.830815921461, 4948.38145231846, 4959.082569724576, 4966.106100901836, 4972.154733695281, 3065.984670076635, 3069.0, 3220.6940340667834, 3246.8863589774246, 3248.512723091555, 1123.2305870478667, 1153.469404074127, 1179.204037274836, 1186.0274574848627, 1192.070185255502, 10617.41604211768, 10778.461076946121, 10780.73048173794, 10782.245242833005, 10909.34543927367, 4210.410542524049, 4422.823087076546, 4439.445069366329, 4545.454545454567, 4557.498675145731, 8961.372703910663, 9143.908560914439, 9157.587908544132, 9170.90829091714, 9187.908120918839, 4919.2867034279825, 4932.21084626458, 4934.925976110361, 4935.975320123376, 4944.802207911644, 4104.343305071175, 4259.850905218303, 4477.059817438374, 4568.977155114203, 4578.130155270488, 3592.209713862946, 3669.9816500917323, 3780.1494663700996, 3796.1079146400575, 3805.219929914361, 1256.6481385212155, 1268.2897577356525, 1274.7386785708907, 1280.9359532023361, 1310.829592153033, 905.4657751926263, 918.8392031394479, 926.937563920272, 930.6463543853428, 966.2801213096288, 5400.378956420062, 5443.129099344086, 5454.481824226771, 5508.586855985737, 5517.917231241535, 895.6462197431978, 908.927285817133, 916.7799728065349, 936.1387523478417, 938.4322484896676, 3399.7790143640586, 3517.771344862576, 3528.2767032758225, 3536.1866770642896, 3602.6037135915553, 9188.26493880488, 9735.41587504752, 9740.415575065519, 9745.31782775199, 9751.90248097524, 8971.282297416192, 9339.346245762867, 9459.858102128474, 9670.613175473043, 9759.512024398751, 6988.965055174692, 7033.0, 7056.682449289794, 7182.174049984319, 7227.602481863548, 5450.482204190595, 5522.930510304237, 5572.216890594971, 5619.185218143428, 5711.543076553949, 8854.203121719076, 8866.290696744374, 8920.420172688755, 8953.641854325753, 9010.50442225684, 8377.246047855722, 8708.521031343336, 8725.52009639476, 8954.238889694449, 9002.549872506217, 6423.100765892872, 6605.273419923708, 6713.597184168965, 6998.930010699828, 7143.1428228612895, 7297.854042919218, 7622.123455802432, 7630.351420129351, 7662.540247585162, 7667.156612772702, 6727.562708424132, 6871.793846184622, 6909.2399836019, 6910.619915904473, 6984.40632546219, 6821.1814582250445, 6839.2476827547935, 6908.2400935896, 6953.617551034742, 6991.2309645937885, 6355.618662880242, 6481.902771458337, 6512.73949042033, 6527.184101987252, 6582.967085164543, 4761.142994261067, 4920.92618610714, 4956.207006878882, 4990.026944745885, 5033.043721692867, 4888.60891128716, 4902.166631672553, 4956.256561515657, 5038.748062596929, 5085.542301192911], "value": 4292.451715693463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.4233011259282, 315.3126184916881, 325.11730651281766, 325.4548631043002, 327.15267457285626, 5240.60695447841, 5357.598180136486, 5365.792696643253, 5379.488948549886, 5400.189971504276, 5167.0, 5292.729744861234, 5321.467853214676, 5323.840284791453, 5324.41431442541, 4198.383622305404, 4215.430916826235, 4220.388043733649, 4221.366794980762, 4235.131797981407, 4144.937825932613, 4158.8544400945975, 4197.8530751423705, 4226.957730422687, 4239.47006624172, 4181.351890456969, 4182.749035057891, 4188.617756140482, 4192.67930601861, 4201.642860356873, 4176.749395036292, 4187.0, 4194.3918131870705, 4196.9781757134815, 4231.534531201565, 3765.8870233892753, 3766.435034744783, 3774.471573979645, 3776.2258736959134, 3781.9243615127543, 5064.164412871872, 5293.417724050351, 5307.867303317409, 5313.415524292324, 5345.518903298683, 4782.736949467778, 4787.736674482902, 4790.736509491977, 4803.327534145223, 4810.903781924342, 5440.211169380417, 5681.176229446707, 5688.232088668018, 5690.630109042899, 5709.086546152637, 3998.1803730235233, 4019.658329042035, 4027.677785777131, 4030.0, 4060.2691515527194, 5926.140709597127, 5930.258717660293, 5933.961556727599, 5939.851503712399, 5948.643081415085, 3994.0, 4066.7153299269357, 4082.4284600156, 4090.4068910008477, 4117.279476091672, 4086.0, 4089.6728261739586, 4096.242195193899, 4117.958820411817, 4122.608352206596, 4722.173619616553, 4727.739974301447, 4729.12511185425, 4736.739479328601, 4741.0, 5564.0, 5707.1724599933605, 5715.514181294637, 5731.914021289684, 5736.196932429463, 1378.1248906944163, 1378.3659516622265, 1385.210430054859, 1391.5199256256778, 1391.7355702416507, 902.4540153207346, 926.0693003531408, 939.4551160326994, 941.87755591774, 945.7493764152505, 5258.1849813279005, 5260.631755777059, 5269.394019687785, 5274.446183150791, 5289.3917199521775, 5596.888062238732, 5622.987862184846, 5629.915551266734, 5631.621027383537, 5681.045856154777, 5143.717095559706, 5198.376194856642, 5294.364676238799, 5307.946920530745, 5353.785848566014, 2943.632045994251, 2965.8072225305286, 2972.821630702165, 2986.4176485585103, 2987.4025194961096, 5811.709414529341, 5815.680137592473, 5820.185174075633, 5828.406359170213, 5846.269216347957, 5372.334576281365, 5605.467480589337, 5672.14917762339, 5672.574556908248, 5691.743871525791, 5793.479836271235, 5797.623154494944, 5816.389279125716, 5816.76732930678, 5825.446582574648, 5358.687121655219, 5474.972625136849, 5576.442355764391, 5610.551155907436, 5627.212190293444, 5488.74961265895, 5494.1758736189895, 5494.560435165257, 5499.560035197094, 5535.667859928417, 5739.483446489836, 5746.310442746897, 5751.482366587027, 5775.451332123442, 5793.594448388572, 3779.508663873679, 3911.2568611963634, 3912.3349030664285, 3926.293267211929, 3936.68506519472, 5543.417941116125, 5596.440355964533, 5611.382747897646, 5613.810613860516, 5622.803201887914, 5471.835844924659, 5482.890342193214, 5514.6139770217305, 5529.861753456195, 5531.170324451365, 5318.4310628363955, 5376.650517716336, 5393.029254734185, 5396.730163491731, 5410.323709536308, 5304.336957880265, 5338.932213557382, 5374.0, 5381.520081977487, 5392.218128371285, 5267.4469180737005, 5483.862903427446, 5516.779328826802, 5519.862003449946, 5541.501264886018, 5323.7071961040965, 5331.3868905076415, 5333.73331333424, 5353.644396465543, 5384.596155288291], "value": 4221.575984514549, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [653.532724102267, 690.8134803603026, 737.4137560639294, 738.6454501839117, 808.7129069180437, 13346.933265333671, 15154.318055687492, 15203.77194342083, 15228.695426091484, 15384.23078846056, 12152.513899444033, 12222.266664000166, 12335.074869384787, 12797.872021279785, 12887.226766394024, 761.5202422473834, 779.8050487378156, 784.6469088910013, 785.9371250299962, 786.453414876661, 773.3967505345811, 794.5471081483556, 795.0657976877175, 801.7634797734682, 801.8997625296838, 834.2950207075042, 845.6786421159951, 846.9153084691543, 847.821957388946, 849.0363437498422, 827.995860020702, 831.787894087007, 833.62903507939, 837.1628371628371, 839.3536976528039, 614.8493619063313, 616.3189675408654, 616.747133675191, 618.761776715963, 620.0420350558398, 14389.06471079387, 14421.78367324491, 14431.206283654396, 14449.49426770058, 14544.418223271057, 13094.279814610192, 13315.800262996063, 13758.862411375858, 13835.30823458823, 14023.859761402357, 10751.623693170779, 10824.0, 10830.566777328897, 10948.507317170666, 11370.772584548346, 3573.5890372607223, 3622.5290712207507, 3683.4843121962945, 3807.58116607173, 3808.6000969898037, 61032.389676103114, 62599.0, 62910.370896291366, 64350.999999999534, 64578.67710661464, 9880.456574888307, 9928.652497162564, 10103.747406314755, 10278.972202430434, 10303.433311167808, 18995.62008759817, 19060.904695476434, 19331.710024349646, 19440.90279548593, 19455.708164377545, 7338.889916651255, 7590.8861367079535, 7656.124249558894, 7731.884021739678, 7795.961020194863, 4328.156009578165, 4414.889627759268, 4451.399061126771, 4460.4137036205175, 4466.129104824528, 3317.701406873393, 3380.9492857607156, 3399.3881101401985, 3457.135716070982, 3611.94582081269, 653.0856800479366, 656.4846595422571, 665.1153965226238, 667.8029981155571, 669.6584741781629, 616.8488720263564, 655.6852710698796, 665.112075379374, 693.5318659904544, 695.5791745993702, 8393.496390216484, 9052.551205073094, 9063.54682265884, 9068.954655226813, 9188.448693078437, 509.630517874538, 643.8004218692126, 673.9292374300726, 675.378651640492, 712.8895021271711, 4014.0, 4264.6801489888385, 4287.634207147375, 4433.4236549249035, 4541.205289074399, 51812.48187518152, 63836.361636383044, 68489.0, 82771.0, 82972.92567685856, 75572.62213688897, 75697.62151189208, 77531.0, 78288.0, 78319.60840195762, 68671.3132868665, 69589.0, 69740.0, 70540.2945970544, 71087.0, 9044.14080662336, 9106.908930910606, 9116.954415227881, 9176.35765496409, 9204.585793639437, 43863.0, 44313.33529996988, 45048.0, 45345.77327113343, 46657.76671116623, 59805.700971494865, 61576.0, 64733.35266647273, 64870.35129648832, 65218.0, 12497.0, 12711.491540338282, 12802.935985320013, 12833.935830321163, 12910.289934053342, 13314.533991310258, 13381.464741410624, 13609.727805444034, 13663.521776737767, 13671.453141874214, 12343.07426942965, 12554.937225313815, 12968.700349539138, 13350.666233344244, 13469.528566500125, 11761.381662436384, 11851.0, 11864.822027669765, 11957.103217258915, 12341.259524428204, 12300.569480068512, 12872.485100595872, 13009.674758131123, 13132.671683207996, 13268.203907765565, 8853.247473964786, 9214.677486287948, 9308.906910930804, 9486.33595648298, 9840.261980351359, 8692.78268043304, 9169.312301577542, 9533.61865525399, 10161.0, 10166.6441674544], "value": 6871.759120828773, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1532.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 115.0, 114.0, 115.0, 114.0, 116.0, 116.0, 115.0, 113.0, 112.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 130.0, 124.0, 166.0, 126.0, 126.0, 128.0, 125.0, 157.0, 130.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 164.0, 166.0, 175.0, 164.0, 161.0, 164.0, 166.0, 161.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 106.0, 77.0, 76.0, 75.0, 75.0, 117.0, 78.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 124.0, 83.0, 84.0, 82.0, 97.0, 83.0, 82.0, 107.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 120.0, 119.0, 119.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 148.0, 148.0, 146.0, 148.0, 146.0, 147.0, 147.0, 146.0], "value": 147.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 98.0, 95.0, 97.0, 97.0, 96.0, 96.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 55.0, 56.0, 54.0, 56.0, 54.0, 55.0, 57.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 64.0, 63.0, 64.0, 63.0, 63.0, 63.0, 64.0, 64.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 81.0, 82.0, 82.0, 82.0, 82.0, 82.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 152.0, 141.0, 135.0, 139.0, 135.0, 141.0, 142.0, 188.0, 141.0], "value": 145.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 171.0, 170.0, 179.0, 168.0, 166.0, 172.0, 167.0, 167.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 65.0, 68.0, 68.0, 68.0, 65.0, 64.0, 66.0, 65.0], "value": 66.4, "unit": "score"}]}]} 13:14:36 INFO - Return code: 0 13:14:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:14:36 ERROR - # TBPL SUCCESS # 13:14:36 INFO - Running post-action listener: _resource_record_post_action 13:14:36 INFO - [mozharness: 2016-11-17 21:14:36.327156Z] Finished run-tests step (success) 13:14:36 INFO - Running post-run listener: _resource_record_post_run 13:14:36 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 0; Write bytes: 402534400; Read time: 0; Write time: 276020 13:14:36 INFO - TinderboxPrint: CPU usage
13.5% 13:14:36 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 13:14:36 INFO - TinderboxPrint: I/O write bytes / time
402,534,400 / 276,020 13:14:36 INFO - TinderboxPrint: CPU idle
8,249.6 (86.5%) 13:14:36 INFO - TinderboxPrint: CPU user
1,225.6 (12.8%) 13:14:36 INFO - TinderboxPrint: Swap in / out
0 / 0 13:14:36 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114601984; Read time: 0; Write time: 92012 13:14:36 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287461376; Read time: 0; Write time: 184004 13:14:36 INFO - Running post-run listener: _upload_blobber_files 13:14:36 INFO - Blob upload gear active. 13:14:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:14:36 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:14:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:14:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:14:37 INFO - (blobuploader) - INFO - Open directory for files ... 13:14:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:14:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:42 INFO - (blobuploader) - INFO - Done attempting. 13:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:14:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:42 INFO - (blobuploader) - INFO - Done attempting. 13:14:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:14:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:14:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:14:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:14:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:14:43 INFO - (blobuploader) - INFO - Done attempting. 13:14:43 INFO - (blobuploader) - INFO - Iteration through files over. 13:14:43 INFO - Return code: 0 13:14:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:14:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:14:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/323d951c3fc7f49b3aa2609054ab79d84b5d747755f5149553ae1e6b4727bbcfde2ccb5e6abe38b14687b49015cb524c03f8c02af623350179d39280c9e1e049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32d1dfd805b8b15158ef8b6f4f2c16e02575a75b0dfd6557b4dfed56367d21af8ad3e3e8926fd2082222dca28bf9bd4aa00b1d4cd10706c717aec5139e94712d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2640cf4adf01a0529ca766139da6b8023aed5cce19d34a5d1edc4a8355c581d69ec7860c06abef7afc8748084e0b309af3ef6ca6b79cd9ac9ffab475cfa7b634"} 13:14:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:14:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:14:43 INFO - Contents: 13:14:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/323d951c3fc7f49b3aa2609054ab79d84b5d747755f5149553ae1e6b4727bbcfde2ccb5e6abe38b14687b49015cb524c03f8c02af623350179d39280c9e1e049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32d1dfd805b8b15158ef8b6f4f2c16e02575a75b0dfd6557b4dfed56367d21af8ad3e3e8926fd2082222dca28bf9bd4aa00b1d4cd10706c717aec5139e94712d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2640cf4adf01a0529ca766139da6b8023aed5cce19d34a5d1edc4a8355c581d69ec7860c06abef7afc8748084e0b309af3ef6ca6b79cd9ac9ffab475cfa7b634"} 13:14:43 INFO - Running post-run listener: copy_logs_to_upload_dir 13:14:43 INFO - Copying logs to upload dir... 13:14:43 INFO - mkdir: /builds/slave/test/build/upload/logs 13:14:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.873094 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-17 13:14:43.299515) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 13:14:43.302941) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115 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/Mozilla-Inbound/sha512/323d951c3fc7f49b3aa2609054ab79d84b5d747755f5149553ae1e6b4727bbcfde2ccb5e6abe38b14687b49015cb524c03f8c02af623350179d39280c9e1e049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32d1dfd805b8b15158ef8b6f4f2c16e02575a75b0dfd6557b4dfed56367d21af8ad3e3e8926fd2082222dca28bf9bd4aa00b1d4cd10706c717aec5139e94712d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2640cf4adf01a0529ca766139da6b8023aed5cce19d34a5d1edc4a8355c581d69ec7860c06abef7afc8748084e0b309af3ef6ca6b79cd9ac9ffab475cfa7b634"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011829 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479404168/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/323d951c3fc7f49b3aa2609054ab79d84b5d747755f5149553ae1e6b4727bbcfde2ccb5e6abe38b14687b49015cb524c03f8c02af623350179d39280c9e1e049", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/32d1dfd805b8b15158ef8b6f4f2c16e02575a75b0dfd6557b4dfed56367d21af8ad3e3e8926fd2082222dca28bf9bd4aa00b1d4cd10706c717aec5139e94712d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2640cf4adf01a0529ca766139da6b8023aed5cce19d34a5d1edc4a8355c581d69ec7860c06abef7afc8748084e0b309af3ef6ca6b79cd9ac9ffab475cfa7b634"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 13:14:43.328490) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:14:43.328867) ========= 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=8c6b6742ce8f6f39ef4ce27d000001f1-1479416043.237283-1969722115 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 13:14:43.413511) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 13:14:43.413820) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 13:14:43.414087) ========= ========= Total master_lag: 0.28 =========