builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-019 starttime: 1479371390.8 results: success (0) buildid: 20161117002903 builduid: e548db27faef41cf9d34ead1bb57a2d7 revision: b1ad7c0aadfbcff130dc8570784148f1e4e85d85 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:50.796532) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:50.797288) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:50.797602) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:50.821594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:50.821928) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-17 00:29:51-- 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% 65.9M=0s 2016-11-17 00:29:51 (65.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.082041 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:50.930152) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:50.930639) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014986 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:51.002321) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:51.002674) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev b1ad7c0aadfbcff130dc8570784148f1e4e85d85 --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 b1ad7c0aadfbcff130dc8570784148f1e4e85d85 --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=78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-17 00:29:51,408 truncating revision to first 12 chars 2016-11-17 00:29:51,408 Setting DEBUG logging. 2016-11-17 00:29:51,408 attempt 1/10 2016-11-17 00:29:51,408 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/b1ad7c0aadfb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-17 00:29:51,735 unpacking tar archive at: mozilla-inbound-b1ad7c0aadfb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.681739 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:51.704937) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:51.705662) ========= script_repo_revision: b1ad7c0aadfbcff130dc8570784148f1e4e85d85 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:51.706638) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:51.707357) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-17 00:29:51.725658) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-17 00:29:51.726033) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:29:52 INFO - MultiFileLogger online at 20161117 00:29:52 in /builds/slave/test 00:29:52 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 00:29:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:29:52 INFO - {'append_to_log': False, 00:29:52 INFO - 'base_work_dir': '/builds/slave/test', 00:29:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 00:29:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:29:52 INFO - 'branch': 'Mozilla-Inbound', 00:29:52 INFO - 'buildbot_json_path': 'buildprops.json', 00:29:52 INFO - 'config_files': ('talos/linux_config.py',), 00:29:52 INFO - 'default_actions': ('clobber', 00:29:52 INFO - 'read-buildbot-config', 00:29:52 INFO - 'download-and-extract', 00:29:52 INFO - 'populate-webroot', 00:29:52 INFO - 'create-virtualenv', 00:29:52 INFO - 'install', 00:29:52 INFO - 'run-tests'), 00:29:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:29:52 INFO - 'download_minidump_stackwalk': True, 00:29:52 INFO - 'download_symbols': 'ondemand', 00:29:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:29:52 INFO - 'tooltool.py': '/tools/tooltool.py', 00:29:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:29:52 INFO - '/tools/misc-python/virtualenv.py')}, 00:29:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:29:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:29:52 INFO - 'installer_path': 'installer.exe', 00:29:52 INFO - 'log_level': 'info', 00:29:52 INFO - 'log_name': 'talos', 00:29:52 INFO - 'log_to_console': True, 00:29:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:29:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:29:52 INFO - 'opt_config_files': (), 00:29:52 INFO - 'pip_index': False, 00:29:52 INFO - 'sps_profile': False, 00:29:52 INFO - 'sps_profile_interval': 0, 00:29:52 INFO - 'suite': 'dromaeojs-e10s', 00:29:52 INFO - 'system_bits': '32', 00:29:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:29:52 INFO - 'title': 'talos-linux64-ix-019', 00:29:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:29:52 INFO - 'use_talos_json': True, 00:29:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:29:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:29:52 INFO - 'work_dir': 'build'} 00:29:52 INFO - [mozharness: 2016-11-17 08:29:52.222003Z] Running clobber step. 00:29:52 INFO - Running pre-action listener: _resource_record_pre_action 00:29:52 INFO - Running main action method: clobber 00:29:52 INFO - rmtree: /builds/slave/test/build 00:29:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:29:52 INFO - Running post-action listener: _resource_record_post_action 00:29:52 INFO - [mozharness: 2016-11-17 08:29:52.677896Z] Finished clobber step (success) 00:29:52 INFO - [mozharness: 2016-11-17 08:29:52.677994Z] Running read-buildbot-config step. 00:29:52 INFO - Running pre-action listener: _resource_record_pre_action 00:29:52 INFO - Running main action method: read_buildbot_config 00:29:52 INFO - Using buildbot properties: 00:29:52 INFO - { 00:29:52 INFO - "project": "", 00:29:52 INFO - "product": "firefox", 00:29:52 INFO - "script_repo_revision": "production", 00:29:52 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 00:29:52 INFO - "repository": "", 00:29:52 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 00:29:52 INFO - "buildid": "20161117002903", 00:29:52 INFO - "stage_platform": "linux64-pgo", 00:29:52 INFO - "basedir": "/builds/slave/test", 00:29:52 INFO - "buildnumber": 1880, 00:29:52 INFO - "platform": "ubuntu64_hw", 00:29:52 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:29:52 INFO - "slavebuilddir": "test", 00:29:52 INFO - "branch": "mozilla-inbound", 00:29:52 INFO - "revision": "b1ad7c0aadfbcff130dc8570784148f1e4e85d85", 00:29:52 INFO - "slavename": "talos-linux64-ix-019", 00:29:52 INFO - "builduid": "e548db27faef41cf9d34ead1bb57a2d7", 00:29:52 INFO - "repo_path": "integration/mozilla-inbound" 00:29:52 INFO - } 00:29:52 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 00:29:52 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 00:29:52 INFO - Running post-action listener: _resource_record_post_action 00:29:52 INFO - [mozharness: 2016-11-17 08:29:52.680350Z] Finished read-buildbot-config step (success) 00:29:52 INFO - [mozharness: 2016-11-17 08:29:52.680438Z] Running download-and-extract step. 00:29:52 INFO - Running pre-action listener: _resource_record_pre_action 00:29:52 INFO - Running main action method: download_and_extract 00:29:52 INFO - mkdir: /builds/slave/test/build/tests 00:29:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:29:52 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:29:52 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/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 00:29:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/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 00:29:52 INFO - Downloaded 1361 bytes. 00:29:52 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 00:29:52 INFO - Using the following test package requirements: 00:29:52 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 00:29:52 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:29:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:29:52 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:29:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 00:29:52 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:29:52 INFO - u'jsshell-linux-x86_64.zip'], 00:29:52 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:29:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:29:52 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 00:29:52 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:29:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:29:52 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:29:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:29:52 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:29:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:29:52 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 00:29:52 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:29:52 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:29:52 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/1479360608/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 00:29:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:29:52 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:29:52 INFO - Http code: 200 00:29:52 INFO - via: 1.1 9baadab4e4d95afe7af7bcba342b29c6.cloudfront.net (CloudFront) 00:29:52 INFO - x-amz-cf-id: KNiccS0VWMWuz3-hiL5JjPrt9UtEYSlve6HJYwYD7BDM8ChXJLeESg== 00:29:52 INFO - x-amz-replication-status: COMPLETED 00:29:52 INFO - x-amz-version-id: xtbDW8suFg3v1AHb5FGH8tDrel3yWZmP 00:29:53 INFO - Expected file size: 21916462 00:29:53 INFO - Obtained file size: 21916462 00:29:57 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 00:29:57 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/1479360608/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 00:29:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 00:29:57 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 00:29:57 INFO - Http code: 200 00:29:57 INFO - via: 1.1 bfd7406fdd888e34dfca79886cb7c964.cloudfront.net (CloudFront) 00:29:57 INFO - x-amz-cf-id: Y_NyT-CvOZQeoK_IRqIajDK__bJmMwB2wrSip7lIA9FR3NSr9zf3vQ== 00:29:57 INFO - x-amz-replication-status: COMPLETED 00:29:57 INFO - x-amz-version-id: xtbDW8suFg3v1AHb5FGH8tDrel3yWZmP 00:29:57 INFO - Expected file size: 21916462 00:29:57 INFO - Obtained file size: 21916462 00:30:02 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/1479360608/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 00:30:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 00:30:02 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 00:30:02 INFO - Http code: 200 00:30:02 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 00:30:02 INFO - x-amz-cf-id: dHpF_3LTLkzS91sX-7gW7wTgaxa_8cNSjQnOKpm4CeS1_KAnPdrM3g== 00:30:02 INFO - x-amz-replication-status: COMPLETED 00:30:02 INFO - x-amz-version-id: OhICoaFy8PLONlcooDAtv8IwMqi2PVGU 00:30:02 INFO - Expected file size: 14409389 00:30:02 INFO - Obtained file size: 14409389 00:30:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:02 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:30:02 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/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 00:30:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/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 00:30:03 INFO - Downloaded 59540806 bytes. 00:30:03 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:30:03 INFO - mkdir: /builds/slave/test/properties 00:30:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:30:03 INFO - Writing to file /builds/slave/test/properties/build_url 00:30:03 INFO - Contents: 00:30:03 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 00:30:03 INFO - Running post-action listener: _resource_record_post_action 00:30:03 INFO - Running post-action listener: set_extra_try_arguments 00:30:03 INFO - [mozharness: 2016-11-17 08:30:03.478877Z] Finished download-and-extract step (success) 00:30:03 INFO - [mozharness: 2016-11-17 08:30:03.479103Z] Running populate-webroot step. 00:30:03 INFO - Running pre-action listener: _resource_record_pre_action 00:30:03 INFO - Running main action method: populate_webroot 00:30:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:30:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:30:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:30:03 INFO - '--tppagecycles', 00:30:03 INFO - '7'], 00:30:03 INFO - 'tests': ['tsvgm']}}, 00:30:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:30:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:30:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:30:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:30:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 00:30:03 INFO - 'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:30:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 00:30:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:30:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 00:30:03 INFO - 'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['damp', 'tps']}, 00:30:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 00:30:03 INFO - 'tests': ['damp', 'tps']}, 00:30:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['dromaeo_dom']}, 00:30:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:30:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['basic_compositor_video']}, 00:30:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 00:30:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['a11yr', 00:30:03 INFO - 'ts_paint', 00:30:03 INFO - 'tpaint', 00:30:03 INFO - 'sessionrestore', 00:30:03 INFO - 'sessionrestore_no_auto_restore', 00:30:03 INFO - 'tabpaint']}, 00:30:03 INFO - 'other-e10s': {'tests': ['a11yr', 00:30:03 INFO - 'ts_paint', 00:30:03 INFO - 'tpaint', 00:30:03 INFO - 'sessionrestore', 00:30:03 INFO - 'sessionrestore_no_auto_restore', 00:30:03 INFO - 'tabpaint']}, 00:30:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:30:03 INFO - 'ts_paint', 00:30:03 INFO - 'tpaint', 00:30:03 INFO - 'sessionrestore', 00:30:03 INFO - 'sessionrestore_no_auto_restore', 00:30:03 INFO - 'tabpaint']}, 00:30:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:30:03 INFO - 'ts_paint', 00:30:03 INFO - 'tpaint', 00:30:03 INFO - 'sessionrestore', 00:30:03 INFO - 'sessionrestore_no_auto_restore', 00:30:03 INFO - 'tabpaint']}, 00:30:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['a11yr', 00:30:03 INFO - 'ts_paint', 00:30:03 INFO - 'tpaint', 00:30:03 INFO - 'sessionrestore', 00:30:03 INFO - 'sessionrestore_no_auto_restore', 00:30:03 INFO - 'tabpaint']}, 00:30:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['a11yr', 00:30:03 INFO - 'ts_paint', 00:30:03 INFO - 'tpaint', 00:30:03 INFO - 'sessionrestore', 00:30:03 INFO - 'sessionrestore_no_auto_restore', 00:30:03 INFO - 'tabpaint']}, 00:30:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['tsvgx', 00:30:03 INFO - 'tsvgr_opacity', 00:30:03 INFO - 'tart', 00:30:03 INFO - 'tscrollx', 00:30:03 INFO - 'cart']}, 00:30:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:30:03 INFO - 'tsvgr_opacity', 00:30:03 INFO - 'tart', 00:30:03 INFO - 'tscrollx', 00:30:03 INFO - 'cart']}, 00:30:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 00:30:03 INFO - 'talos_options': ['--disable-e10s'], 00:30:03 INFO - 'tests': ['tp5o']}, 00:30:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 00:30:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 00:30:03 INFO - 'talos_options': ['--disable-e10s', 00:30:03 INFO - '--xperf_path', 00:30:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:30:03 INFO - 'tests': ['tp5n']}, 00:30:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 00:30:03 INFO - 'talos_options': ['--xperf_path', 00:30:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:30:03 INFO - 'tests': ['tp5n']}}, 00:30:03 INFO - 'talos.zip': {'path': '', 00:30:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:30:03 INFO - Running post-action listener: _resource_record_post_action 00:30:03 INFO - [mozharness: 2016-11-17 08:30:03.496579Z] Finished populate-webroot step (success) 00:30:03 INFO - [mozharness: 2016-11-17 08:30:03.496666Z] Running create-virtualenv step. 00:30:03 INFO - Running pre-action listener: _resource_record_pre_action 00:30:03 INFO - Running main action method: create_virtualenv 00:30:03 INFO - Creating virtualenv /builds/slave/test/build/venv 00:30:03 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 00:30:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:30:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:30:03 INFO - Using real prefix '/usr' 00:30:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:30:04 INFO - Installing distribute.............................................................................................................................................................................................done. 00:30:06 INFO - Installing pip.................done. 00:30:06 INFO - Return code: 0 00:30:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 00:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 00:30:06 INFO - Reading from file tmpfile_stdout 00:30:06 INFO - Output received: 00:30:06 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) 00:30:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:30: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')]} 00:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30: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')]} 00:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b6dad8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', '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 00:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 00:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 00:30:06 INFO - Using env: {'DISPLAY': ':0', 00:30:06 INFO - 'HOME': '/home/cltbld', 00:30:06 INFO - 'LANG': 'en_US.UTF-8', 00:30:06 INFO - 'LANGUAGE': 'en_US:en', 00:30:06 INFO - 'LOGNAME': 'cltbld', 00:30:06 INFO - 'MAIL': '/var/mail/cltbld', 00:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:06 INFO - 'MOZ_NO_REMOTE': '1', 00:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:06 INFO - 'NO_EM_RESTART': '1', 00:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:06 INFO - 'PWD': '/builds/slave/test', 00:30:06 INFO - 'SHELL': '/bin/bash', 00:30:06 INFO - 'SHLVL': '1', 00:30:06 INFO - 'TERM': 'linux', 00:30:06 INFO - 'TMOUT': '86400', 00:30:06 INFO - 'USER': 'cltbld', 00:30:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:06 INFO - '_': '/tools/buildbot/bin/python'} 00:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:06 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 00:30:06 INFO - Cleaning up... 00:30:06 INFO - Return code: 0 00:30:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 00:30: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')]} 00:30:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30: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')]} 00:30:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3b6dad8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', '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 00:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 00:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 00:30:06 INFO - Using env: {'DISPLAY': ':0', 00:30:06 INFO - 'HOME': '/home/cltbld', 00:30:06 INFO - 'LANG': 'en_US.UTF-8', 00:30:06 INFO - 'LANGUAGE': 'en_US:en', 00:30:06 INFO - 'LOGNAME': 'cltbld', 00:30:06 INFO - 'MAIL': '/var/mail/cltbld', 00:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:06 INFO - 'MOZ_NO_REMOTE': '1', 00:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:06 INFO - 'NO_EM_RESTART': '1', 00:30:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:06 INFO - 'PWD': '/builds/slave/test', 00:30:06 INFO - 'SHELL': '/bin/bash', 00:30:06 INFO - 'SHLVL': '1', 00:30:06 INFO - 'TERM': 'linux', 00:30:06 INFO - 'TMOUT': '86400', 00:30:06 INFO - 'USER': 'cltbld', 00:30:06 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:06 INFO - '_': '/tools/buildbot/bin/python'} 00:30:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:06 INFO - Downloading/unpacking psutil>=3.1.1 00:30:06 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 00:30:06 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 00:30:06 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 00:30:06 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 00:30:06 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 00:30:06 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 00:30:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:30:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:30:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:30:08 INFO - Installing collected packages: psutil 00:30:08 INFO - Running setup.py install for psutil 00:30:08 INFO - building 'psutil._psutil_linux' extension 00:30:08 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 00:30:09 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 00:30:09 INFO - building 'psutil._psutil_posix' extension 00:30:09 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 00:30:09 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 00:30:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:30:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:30:09 INFO - Successfully installed psutil 00:30:09 INFO - Cleaning up... 00:30:09 INFO - Return code: 0 00:30:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 00:30:09 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')]} 00:30:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:09 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')]} 00:30:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:09 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 0x7f3b6dad8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', '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 00:30:09 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 00:30:09 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 00:30:09 INFO - Using env: {'DISPLAY': ':0', 00:30:09 INFO - 'HOME': '/home/cltbld', 00:30:09 INFO - 'LANG': 'en_US.UTF-8', 00:30:09 INFO - 'LANGUAGE': 'en_US:en', 00:30:09 INFO - 'LOGNAME': 'cltbld', 00:30:09 INFO - 'MAIL': '/var/mail/cltbld', 00:30:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:09 INFO - 'MOZ_NO_REMOTE': '1', 00:30:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:09 INFO - 'NO_EM_RESTART': '1', 00:30:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:09 INFO - 'PWD': '/builds/slave/test', 00:30:09 INFO - 'SHELL': '/bin/bash', 00:30:09 INFO - 'SHLVL': '1', 00:30:09 INFO - 'TERM': 'linux', 00:30:09 INFO - 'TMOUT': '86400', 00:30:09 INFO - 'USER': 'cltbld', 00:30:09 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:09 INFO - '_': '/tools/buildbot/bin/python'} 00:30:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 00:30:09 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 00:30:09 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 00:30:09 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 00:30:09 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 00:30:09 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 00:30:09 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 00:30:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 00:30:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:30:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 00:30:11 INFO - Installing collected packages: mozsystemmonitor 00:30:11 INFO - Running setup.py install for mozsystemmonitor 00:30:11 INFO - Successfully installed mozsystemmonitor 00:30:11 INFO - Cleaning up... 00:30:11 INFO - Return code: 0 00:30:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 00:30:11 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')]} 00:30:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:11 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')]} 00:30:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:11 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 0x7f3b6dad8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', '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 00:30:11 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 00:30:11 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 00:30:11 INFO - Using env: {'DISPLAY': ':0', 00:30:11 INFO - 'HOME': '/home/cltbld', 00:30:11 INFO - 'LANG': 'en_US.UTF-8', 00:30:11 INFO - 'LANGUAGE': 'en_US:en', 00:30:11 INFO - 'LOGNAME': 'cltbld', 00:30:11 INFO - 'MAIL': '/var/mail/cltbld', 00:30:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:11 INFO - 'MOZ_NO_REMOTE': '1', 00:30:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:11 INFO - 'NO_EM_RESTART': '1', 00:30:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:11 INFO - 'PWD': '/builds/slave/test', 00:30:11 INFO - 'SHELL': '/bin/bash', 00:30:11 INFO - 'SHLVL': '1', 00:30:11 INFO - 'TERM': 'linux', 00:30:11 INFO - 'TMOUT': '86400', 00:30:11 INFO - 'USER': 'cltbld', 00:30:11 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:11 INFO - '_': '/tools/buildbot/bin/python'} 00:30:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:11 INFO - Downloading/unpacking jsonschema==2.5.1 00:30:11 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 00:30:11 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 00:30:11 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 00:30:11 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 00:30:11 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 00:30:11 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 00:30:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:30:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 00:30:13 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 00:30:13 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 00:30:13 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 00:30:13 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 00:30:13 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 00:30:13 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 00:30:14 INFO - Downloading functools32-3.2.3-2.tar.gz 00:30:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:30:14 INFO - warning: no files found matching '*.txt' 00:30:14 INFO - no previously-included directories found matching 'build' 00:30:14 INFO - no previously-included directories found matching 'dist' 00:30:14 INFO - no previously-included directories found matching '.git*' 00:30:14 INFO - Installing collected packages: jsonschema, functools32 00:30:14 INFO - Running setup.py install for functools32 00:30:14 INFO - warning: no files found matching '*.txt' 00:30:14 INFO - no previously-included directories found matching 'build' 00:30:14 INFO - no previously-included directories found matching 'dist' 00:30:14 INFO - no previously-included directories found matching '.git*' 00:30:14 INFO - Successfully installed jsonschema functools32 00:30:14 INFO - Cleaning up... 00:30:14 INFO - Return code: 0 00:30:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 00:30:14 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')]} 00:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:14 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')]} 00:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:14 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 0x7f3b6dad8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', '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 00:30:14 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 00:30:14 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 00:30:14 INFO - Using env: {'DISPLAY': ':0', 00:30:14 INFO - 'HOME': '/home/cltbld', 00:30:14 INFO - 'LANG': 'en_US.UTF-8', 00:30:14 INFO - 'LANGUAGE': 'en_US:en', 00:30:14 INFO - 'LOGNAME': 'cltbld', 00:30:14 INFO - 'MAIL': '/var/mail/cltbld', 00:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:14 INFO - 'MOZ_NO_REMOTE': '1', 00:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:14 INFO - 'NO_EM_RESTART': '1', 00:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:14 INFO - 'PWD': '/builds/slave/test', 00:30:14 INFO - 'SHELL': '/bin/bash', 00:30:14 INFO - 'SHLVL': '1', 00:30:14 INFO - 'TERM': 'linux', 00:30:14 INFO - 'TMOUT': '86400', 00:30:14 INFO - 'USER': 'cltbld', 00:30:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:14 INFO - '_': '/tools/buildbot/bin/python'} 00:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 00:30:14 INFO - Cleaning up... 00:30:14 INFO - Return code: 0 00:30:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:30:14 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')]} 00:30:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:14 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')]} 00:30:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:14 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 0x7f3b6dad8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', '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 00:30:14 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 00:30:14 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 00:30:14 INFO - Using env: {'DISPLAY': ':0', 00:30:14 INFO - 'HOME': '/home/cltbld', 00:30:14 INFO - 'LANG': 'en_US.UTF-8', 00:30:14 INFO - 'LANGUAGE': 'en_US:en', 00:30:14 INFO - 'LOGNAME': 'cltbld', 00:30:14 INFO - 'MAIL': '/var/mail/cltbld', 00:30:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:14 INFO - 'MOZ_NO_REMOTE': '1', 00:30:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:14 INFO - 'NO_EM_RESTART': '1', 00:30:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:14 INFO - 'PWD': '/builds/slave/test', 00:30:14 INFO - 'SHELL': '/bin/bash', 00:30:14 INFO - 'SHLVL': '1', 00:30:14 INFO - 'TERM': 'linux', 00:30:14 INFO - 'TMOUT': '86400', 00:30:14 INFO - 'USER': 'cltbld', 00:30:14 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:14 INFO - '_': '/tools/buildbot/bin/python'} 00:30:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:14 INFO - Downloading/unpacking blobuploader==1.2.4 00:30:14 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 00:30:14 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 00:30:14 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 00:30:14 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 00:30:14 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 00:30:14 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 00:30:16 INFO - Downloading blobuploader-1.2.4.tar.gz 00:30:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:30:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:30:16 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 00:30:16 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 00:30:16 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 00:30:16 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 00:30:16 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 00:30:16 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 00:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:30:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:30:17 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 00:30:17 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 00:30:17 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 00:30:17 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 00:30:17 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 00:30:17 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 00:30:17 INFO - Downloading docopt-0.6.1.tar.gz 00:30:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:30:17 INFO - Installing collected packages: blobuploader, requests, docopt 00:30:17 INFO - Running setup.py install for blobuploader 00:30:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:30:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:30:17 INFO - Running setup.py install for requests 00:30:17 INFO - Running setup.py install for docopt 00:30:18 INFO - Successfully installed blobuploader requests docopt 00:30:18 INFO - Cleaning up... 00:30:18 INFO - Return code: 0 00:30:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:30:18 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')]} 00:30:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:18 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')]} 00:30:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:18 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 0x7f3b6dad8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', '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 00:30:18 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 00:30:18 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 00:30:18 INFO - Using env: {'DISPLAY': ':0', 00:30:18 INFO - 'HOME': '/home/cltbld', 00:30:18 INFO - 'LANG': 'en_US.UTF-8', 00:30:18 INFO - 'LANGUAGE': 'en_US:en', 00:30:18 INFO - 'LOGNAME': 'cltbld', 00:30:18 INFO - 'MAIL': '/var/mail/cltbld', 00:30:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:18 INFO - 'MOZ_NO_REMOTE': '1', 00:30:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:18 INFO - 'NO_EM_RESTART': '1', 00:30:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:18 INFO - 'PWD': '/builds/slave/test', 00:30:18 INFO - 'SHELL': '/bin/bash', 00:30:18 INFO - 'SHLVL': '1', 00:30:18 INFO - 'TERM': 'linux', 00:30:18 INFO - 'TMOUT': '86400', 00:30:18 INFO - 'USER': 'cltbld', 00:30:18 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:18 INFO - '_': '/tools/buildbot/bin/python'} 00:30:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:30:18 INFO - Running setup.py (path:/tmp/pip-IqzvXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:30:18 INFO - Running setup.py (path:/tmp/pip-SlhRDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:30:18 INFO - Running setup.py (path:/tmp/pip-uQ9KPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:30:18 INFO - Running setup.py (path:/tmp/pip-Ihe8Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:30:18 INFO - Running setup.py (path:/tmp/pip-0A2_df-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:30:18 INFO - Running setup.py (path:/tmp/pip-eG_2br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:30:18 INFO - Running setup.py (path:/tmp/pip-zMRhAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:30:18 INFO - Running setup.py (path:/tmp/pip-Qxhq5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:30:18 INFO - Running setup.py (path:/tmp/pip-IYea_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:30:18 INFO - Running setup.py (path:/tmp/pip-MqpLXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:30:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:30:18 INFO - Running setup.py (path:/tmp/pip-B7Yu1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:30:19 INFO - Running setup.py (path:/tmp/pip-wkPJNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:30:19 INFO - Running setup.py (path:/tmp/pip-OTk3wm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:30:19 INFO - Running setup.py (path:/tmp/pip-74qhkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:30:19 INFO - Running setup.py (path:/tmp/pip-suR7KU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:30:19 INFO - Running setup.py (path:/tmp/pip-0PCsbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:30:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:30:19 INFO - Running setup.py (path:/tmp/pip-HQO5bT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:30:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:30:19 INFO - Running setup.py install for manifestparser 00:30:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:30:19 INFO - Running setup.py install for mozcrash 00:30:19 INFO - Running setup.py install for mozdebug 00:30:19 INFO - Running setup.py install for mozdevice 00:30:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:30:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:30:19 INFO - Running setup.py install for mozfile 00:30:20 INFO - Running setup.py install for mozhttpd 00:30:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Running setup.py install for mozinfo 00:30:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Running setup.py install for mozInstall 00:30:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Running setup.py install for mozleak 00:30:20 INFO - Running setup.py install for mozlog 00:30:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Running setup.py install for moznetwork 00:30:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Running setup.py install for mozprocess 00:30:20 INFO - Running setup.py install for mozprofile 00:30:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Running setup.py install for mozrunner 00:30:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:30:20 INFO - Running setup.py install for mozscreenshot 00:30:21 INFO - Running setup.py install for moztest 00:30:21 INFO - Running setup.py install for mozversion 00:30:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:30:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:30:21 INFO - Cleaning up... 00:30:21 INFO - Return code: 0 00:30:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:21 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 0x7f3b6dad8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', '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 00:30:21 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 00:30:21 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 00:30:21 INFO - Using env: {'DISPLAY': ':0', 00:30:21 INFO - 'HOME': '/home/cltbld', 00:30:21 INFO - 'LANG': 'en_US.UTF-8', 00:30:21 INFO - 'LANGUAGE': 'en_US:en', 00:30:21 INFO - 'LOGNAME': 'cltbld', 00:30:21 INFO - 'MAIL': '/var/mail/cltbld', 00:30:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:21 INFO - 'MOZ_NO_REMOTE': '1', 00:30:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:21 INFO - 'NO_EM_RESTART': '1', 00:30:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:21 INFO - 'PWD': '/builds/slave/test', 00:30:21 INFO - 'SHELL': '/bin/bash', 00:30:21 INFO - 'SHLVL': '1', 00:30:21 INFO - 'TERM': 'linux', 00:30:21 INFO - 'TMOUT': '86400', 00:30:21 INFO - 'USER': 'cltbld', 00:30:21 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:21 INFO - '_': '/tools/buildbot/bin/python'} 00:30:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:30:21 INFO - Running setup.py (path:/tmp/pip-XvM34r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:30:21 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)) 00:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:30:21 INFO - Running setup.py (path:/tmp/pip-Ai8nwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:30:21 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)) 00:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:30:21 INFO - Running setup.py (path:/tmp/pip-JHioT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:30:21 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)) 00:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:30:21 INFO - Running setup.py (path:/tmp/pip-z_CFc7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:30:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:30:21 INFO - Running setup.py (path:/tmp/pip-biDyQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:30:21 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)) 00:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:30:21 INFO - Running setup.py (path:/tmp/pip-Je9rnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:30:21 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)) 00:30:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:30:21 INFO - Running setup.py (path:/tmp/pip-r0nugN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:30:22 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)) 00:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:30:22 INFO - Running setup.py (path:/tmp/pip-OS73BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:30:22 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)) 00:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:30:22 INFO - Running setup.py (path:/tmp/pip-hgdj2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:30:22 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)) 00:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:30:22 INFO - Running setup.py (path:/tmp/pip-LXAYUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:30:22 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)) 00:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:30:22 INFO - Running setup.py (path:/tmp/pip-laBZ4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:30:22 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)) 00:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:30:22 INFO - Running setup.py (path:/tmp/pip-4wdgKA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:30:22 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)) 00:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:30:22 INFO - Running setup.py (path:/tmp/pip-No0P4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:30:22 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)) 00:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:30:22 INFO - Running setup.py (path:/tmp/pip-Q9UP1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:30:22 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)) 00:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:30:22 INFO - Running setup.py (path:/tmp/pip-jOcnEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:30:22 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)) 00:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:30:22 INFO - Running setup.py (path:/tmp/pip-iq6Z_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:30:22 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)) 00:30:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:30:22 INFO - Running setup.py (path:/tmp/pip-riWwJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:30:22 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)) 00:30:22 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)) 00:30:22 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)) 00:30:22 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)) 00:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:30:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 00:30:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:30:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:30:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:30:24 INFO - Downloading blessings-1.6.tar.gz 00:30:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:30:24 INFO - Installing collected packages: blessings 00:30:24 INFO - Running setup.py install for blessings 00:30:24 INFO - Successfully installed blessings 00:30:24 INFO - Cleaning up... 00:30:24 INFO - Return code: 0 00:30:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:30:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:30:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:30:25 INFO - Reading from file tmpfile_stdout 00:30:25 INFO - Current package versions: 00:30:25 INFO - argparse == 1.2.1 00:30:25 INFO - blessings == 1.6 00:30:25 INFO - blobuploader == 1.2.4 00:30:25 INFO - docopt == 0.6.1 00:30:25 INFO - functools32 == 3.2.3-2 00:30:25 INFO - jsonschema == 2.5.1 00:30:25 INFO - manifestparser == 1.1 00:30:25 INFO - mozInstall == 1.12 00:30:25 INFO - mozcrash == 1.0 00:30:25 INFO - mozdebug == 0.1 00:30:25 INFO - mozdevice == 0.48 00:30:25 INFO - mozfile == 1.2 00:30:25 INFO - mozhttpd == 0.7 00:30:25 INFO - mozinfo == 0.9 00:30:25 INFO - mozleak == 0.1 00:30:25 INFO - mozlog == 3.4 00:30:25 INFO - moznetwork == 0.27 00:30:25 INFO - mozprocess == 0.23 00:30:25 INFO - mozprofile == 0.28 00:30:25 INFO - mozrunner == 6.13 00:30:25 INFO - mozscreenshot == 0.1 00:30:25 INFO - mozsystemmonitor == 0.3 00:30:25 INFO - moztest == 0.7 00:30:25 INFO - mozversion == 1.4 00:30:25 INFO - psutil == 3.1.1 00:30:25 INFO - requests == 1.2.3 00:30:25 INFO - wsgiref == 0.1.2 00:30:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:30: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')]} 00:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30: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')]} 00:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30:25 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 0x7f3b6dad8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', '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 00:30:25 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 00:30:25 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 00:30:25 INFO - Using env: {'DISPLAY': ':0', 00:30:25 INFO - 'HOME': '/home/cltbld', 00:30:25 INFO - 'LANG': 'en_US.UTF-8', 00:30:25 INFO - 'LANGUAGE': 'en_US:en', 00:30:25 INFO - 'LOGNAME': 'cltbld', 00:30:25 INFO - 'MAIL': '/var/mail/cltbld', 00:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:25 INFO - 'MOZ_NO_REMOTE': '1', 00:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:25 INFO - 'NO_EM_RESTART': '1', 00:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:25 INFO - 'PWD': '/builds/slave/test', 00:30:25 INFO - 'SHELL': '/bin/bash', 00:30:25 INFO - 'SHLVL': '1', 00:30:25 INFO - 'TERM': 'linux', 00:30:25 INFO - 'TMOUT': '86400', 00:30:25 INFO - 'USER': 'cltbld', 00:30:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:25 INFO - '_': '/tools/buildbot/bin/python'} 00:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:25 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)) 00:30:25 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)) 00:30:25 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)) 00:30:25 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)) 00:30:25 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)) 00:30:25 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)) 00:30:25 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)) 00:30:25 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)) 00:30:25 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)) 00:30:25 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)) 00:30:25 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)) 00:30:25 INFO - Cleaning up... 00:30:25 INFO - Return code: 0 00:30:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:30: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')]} 00:30:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:30:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30: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')]} 00:30:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:30:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:30: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3b6dad8e30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x238ab70>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2526130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', '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 00:30: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'] in /builds/slave/test/build 00:30: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 00:30:25 INFO - Using env: {'DISPLAY': ':0', 00:30:25 INFO - 'HOME': '/home/cltbld', 00:30:25 INFO - 'LANG': 'en_US.UTF-8', 00:30:25 INFO - 'LANGUAGE': 'en_US:en', 00:30:25 INFO - 'LOGNAME': 'cltbld', 00:30:25 INFO - 'MAIL': '/var/mail/cltbld', 00:30:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:25 INFO - 'MOZ_NO_REMOTE': '1', 00:30:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:25 INFO - 'NO_EM_RESTART': '1', 00:30:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:25 INFO - 'PWD': '/builds/slave/test', 00:30:25 INFO - 'SHELL': '/bin/bash', 00:30:25 INFO - 'SHLVL': '1', 00:30:25 INFO - 'TERM': 'linux', 00:30:25 INFO - 'TMOUT': '86400', 00:30:25 INFO - 'USER': 'cltbld', 00:30:25 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:25 INFO - '_': '/tools/buildbot/bin/python'} 00:30:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:30:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 00:30:25 INFO - Cleaning up... 00:30:25 INFO - Return code: 0 00:30:25 INFO - Running post-action listener: _resource_record_post_action 00:30:25 INFO - Running post-action listener: _start_resource_monitoring 00:30:25 INFO - Starting resource monitoring. 00:30:25 INFO - [mozharness: 2016-11-17 08:30:25.654807Z] Finished create-virtualenv step (success) 00:30:25 INFO - [mozharness: 2016-11-17 08:30:25.655325Z] Running install step. 00:30:25 INFO - Running pre-action listener: _resource_record_pre_action 00:30:25 INFO - Running main action method: install 00:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:30:25 INFO - Reading from file tmpfile_stdout 00:30:25 INFO - Detecting whether we're running mozinstall >=1.0... 00:30:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:30:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:30:25 INFO - Reading from file tmpfile_stdout 00:30:25 INFO - Output received: 00:30:25 INFO - Usage: mozinstall [options] installer 00:30:25 INFO - Options: 00:30:25 INFO - -h, --help show this help message and exit 00:30:25 INFO - -d DEST, --destination=DEST 00:30:25 INFO - Directory to install application into. [default: 00:30:25 INFO - "/builds/slave/test"] 00:30:25 INFO - --app=APP Application being installed. [default: firefox] 00:30:25 INFO - mkdir: /builds/slave/test/build/application 00:30:25 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'] 00:30:25 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 00:30:42 INFO - Reading from file tmpfile_stdout 00:30:42 INFO - Output received: 00:30:42 INFO - /builds/slave/test/build/application/firefox/firefox 00:30:42 INFO - Running post-action listener: _resource_record_post_action 00:30:42 INFO - [mozharness: 2016-11-17 08:30:42.927056Z] Finished install step (success) 00:30:42 INFO - [mozharness: 2016-11-17 08:30:42.927328Z] Running run-tests step. 00:30:42 INFO - Running pre-action listener: _resource_record_pre_action 00:30:42 INFO - Running main action method: run_tests 00:30:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:30:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:30:42 INFO - Python 2.7.3 00:30:42 INFO - Return code: 0 00:30:42 INFO - grabbing minidump binary from tooltool 00:30:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 00:30:42 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 0x25b4fc0>, '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 0x25b5ec0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x25b6350>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:30:42 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 00:30:42 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 00:30:42 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 00:30:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:30:43 INFO - Return code: 0 00:30:43 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:30:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:30:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:30:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:30:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:30:43 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/1479360608/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 00:30:43 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/1479360608/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 00:30:43 INFO - Using env: {'DISPLAY': ':0', 00:30:43 INFO - 'HOME': '/home/cltbld', 00:30:43 INFO - 'LANG': 'en_US.UTF-8', 00:30:43 INFO - 'LANGUAGE': 'en_US:en', 00:30:43 INFO - 'LOGNAME': 'cltbld', 00:30:43 INFO - 'MAIL': '/var/mail/cltbld', 00:30:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:30:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:30:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:30:43 INFO - 'MOZ_NO_REMOTE': '1', 00:30:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:30:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:30:43 INFO - 'NO_EM_RESTART': '1', 00:30:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:30:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:30:43 INFO - 'PWD': '/builds/slave/test', 00:30:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:30:43 INFO - 'SHELL': '/bin/bash', 00:30:43 INFO - 'SHLVL': '1', 00:30:43 INFO - 'TERM': 'linux', 00:30:43 INFO - 'TMOUT': '86400', 00:30:43 INFO - 'USER': 'cltbld', 00:30:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068', 00:30:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:30:43 INFO - '_': '/tools/buildbot/bin/python'} 00:30:43 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/1479360608/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 00:30:43 INFO - mozversion application_buildid: 20161116213008 00:30:43 INFO - mozversion application_changeset: b1ad7c0aadfbcff130dc8570784148f1e4e85d85 00:30:43 INFO - mozversion application_display_name: Nightly 00:30:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:30:43 INFO - mozversion application_name: Firefox 00:30:43 INFO - mozversion application_remotingname: firefox 00:30:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:30:43 INFO - mozversion application_vendor: Mozilla 00:30:43 INFO - mozversion application_version: 53.0a1 00:30:43 INFO - mozversion platform_buildid: 20161116213008 00:30:43 INFO - mozversion platform_changeset: b1ad7c0aadfbcff130dc8570784148f1e4e85d85 00:30:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 00:30:43 INFO - mozversion platform_version: 53.0a1 00:30:43 INFO - using testdate: 1479371443 00:30:43 INFO - actual date: 1479371443 00:30:43 INFO - starting webserver on 'localhost:35488' 00:30:43 INFO - SUITE-START | Running 2 tests 00:30:43 INFO - TEST-START | dromaeo_css 00:30:43 INFO - operating with platform_type : linux_ 00:30:43 INFO - Initialising browser for dromaeo_css test... 00:30:43 INFO - TEST-INFO | started process 11392 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu0R9QJ/profile http://localhost:35488/getInfo.html) 00:30:48 INFO - PROCESS | 11392 | __metrics Screen width/height:1600/1200 00:30:48 INFO - PROCESS | 11392 | colorDepth:24 00:30:48 INFO - PROCESS | 11392 | Browser inner width/height: 1024/697 00:30:48 INFO - PROCESS | 11392 | __metrics 00:30:48 ERROR - PROCESS | 11392 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 00:30:49 INFO - TEST-INFO | 11392: exit 0 00:30:49 INFO - Browser initialized. 00:30:49 INFO - Running cycle 1/1 for dromaeo_css test... 00:30:49 INFO - TEST-INFO | started process 11518 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu0R9QJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:31:01 INFO - PROCESS | 11518 | RSS: Main: 185950208 00:31:01 INFO - PROCESS | 11518 | 00:31:51 INFO - PROCESS | 11518 | 1479371511298 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] 00:34:02 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:35488/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35488/tests/dromaeo/cssquery-ext.html) 00:34:04 INFO - PROCESS | 11518 | RSS: Main: 193482752 00:34:04 INFO - PROCESS | 11518 | 00:37:06 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:35488/tests/dromaeo/cssquery-ext.html (next: http://localhost:35488/tests/dromaeo/cssquery-jquery.html) 00:37:07 INFO - PROCESS | 11518 | RSS: Main: 196063232 00:37:07 INFO - PROCESS | 11518 | 00:40:09 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:35488/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35488/tests/dromaeo/cssquery-mootools.html) 00:40:10 INFO - PROCESS | 11518 | RSS: Main: 194650112 00:40:10 INFO - PROCESS | 11518 | 00:43:11 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:35488/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35488/tests/dromaeo/cssquery-prototype.html) 00:43:12 INFO - PROCESS | 11518 | RSS: Main: 197951488 00:43:12 INFO - PROCESS | 11518 | 00:46:15 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:35488/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35488/tests/dromaeo/cssquery-yui.html) 00:46:15 INFO - PROCESS | 11518 | RSS: Main: 195158016 00:46:15 INFO - PROCESS | 11518 | 00:49:18 INFO - PROCESS | 11518 | Cycle 1(1): loaded http://localhost:35488/tests/dromaeo/cssquery-yui.html (next: http://localhost:35488/tests/dromaeo/cssquery-dojo.html) 00:49:18 INFO - PROCESS | 11518 | RSS: Main: 198471680 00:49:18 INFO - PROCESS | 11518 | 00:49:18 INFO - PROCESS | 11518 | __start_tp_report 00:49:18 INFO - PROCESS | 11518 | _x_x_mozilla_page_load 00:49:18 INFO - PROCESS | 11518 | _x_x_mozilla_page_load_details 00:49:18 INFO - PROCESS | 11518 | |i|pagename|runs| 00:49:18 INFO - PROCESS | 11518 | |0;dojo.html;3107.5960125183724;3109.8600562974666;3139.995201535508;3147.150269427255;3156.3845050215205;5156.974215128928;5378.46215378462;5398.757055932482;5425.9576615421465;5453.5364494018;5247.449017853118;5330.227117068032;5368.248445217672;5388.43421440748;5405.594580406466;4863.732494712789;4883.633727470445;4954.380702412199;4954.851354459372;4999.275105109757;4847.660663753539;4918.631102667297;5042.117629414856;5071.492850714936;5103.928175083219;4783.091212669582;4825.541573550507;4943.703377797344;5019.64862459628;5035.974820125876;4869.659123861331;4871.12319782439;4872.805087796484;4878.926816097762;4881;4811.182099043171;4816.25348071046;4817.638677099197;4819.734914579697;4821.180399332122;5211.957608478319;5218.973905130488;5283.894322113575;5295.338082739658;5301.867453313659;5677.517411020027;5703.230063941356;5713.057345537981;5730.885382292373;5759.510441612468;5682.431756824326;5692.601517893749;5738.454846789548;5743.684097374643;5750.453706897838;5176.792928282902;5200.609954253446;5230.581553475713;5275.235090911873;5325.547328477084;5714.000049991235;5737.282839645044;5787.102999035072;5814.651120932757;5829.94170058294;5621.903728772932;5628.324601047901;5633.098704207389;5681.204631351614;5685.204071430003;5711.200431939532;5726.570507211975;5741.827745167651;5745.971270143623;5752.798652047159;5462.808801692001;5595.496405323541;5610.523105535994;5616.550675945915;5628.296462942132;5687.488126068673;5687.829365119053;5696.629719068247;5713.657180569179;5715.657060576379;4312.094460163401;4322.675799315064;4323.956760432356;4335.913281734348;4367.825286988485;3731.6641502264924;3802.619738026175;3804.6766024887643;3824.29250588642;3923.156521347924;5425.159100339453;5505.339359276913;5514.338279406497;5601.915971260434;5605.0751625982075;5780.479756821906;5818.098194779731;5826.242588463558;5826.271716035496;5870.647761134345;5547.916781248285;5553.111502159635;5556.138798486241;5559.277293951841;5562.527185189223;4637.489876113625;4637.86086417408;4780.521947805261;4792.688475249098;4811.422629284508;6068.939310606926;6071.271447426248;6071.726772295346;6100.603460775035;6114.938850611437;5789;5814.331351894417;5822.563307752021;5844.094165404369;5857.58996870232;5741.425857414225;5783.363829978614;5805.564582656402;5985.191999080069;6009.429104235091;5618.073017951992;5624.381318055092;5656.915146272727;5666.801661941977;5756.30924289088;5766.625169363978;5781.4507621775865;5781.682007489629;5807.622504537191;5808.535317174531;5648.71756412186;5679.801206957736;5692.829215123553;5703.315602127771;5714.9142762857755;5355.384130825005;5448.482394172547;5476.534494568006;5482.862928426821;5560.5829562783765;5444.237806706985;5469.316335458067;5491.752871120889;5553.194786755978;5563.77596928675;5478.91781623268;5494.120940649477;5517.5585953124455;5551.111822108443;5573.164025396223;5455.236266922713;5476.67139971603;5514.834554963358;5561.610687252015;5570.164475328571 00:49:18 INFO - PROCESS | 11518 | |1;ext.html;577.2034592262677;587.4947545111205;590.1030433740714;591.8372447576916;596.6330706615432;26933.192004239878;29018.419631607354;34598.30803383934;35487.46768798464;35535.644643553554;34570.827145864234;34902.65097349026;34962;34985.47521787169;35049;6782.593044417326;6883.967404889282;6922.930770692279;6938.306169383071;6970.686319115626;7090.71637134514;7204.171520275183;7208.56748595086;7224.422046236288;7252.0572325597595;7173.928260717378;7200.171980222263;7269.527480713737;7288.344049035612;7293.38006269465;7253.782386528413;7257.346838784509;7304.452166087538;7312.1956584775635;7332.890006649851;7193.748218812369;7197.280271972813;7242.203357630657;7253.093363329584;7259.237780033073;32958;33156.50265246023;33234.83382583096;33242.33515329704;33310;3347.8828241011693;3493.930121397583;3503.2292895562937;3591.7844929304324;3673.687736542397;22969.88515057414;23313.650295245585;23601.7639823603;24217.515649686906;24234.757652423603;3103.4103520331064;3106.2389714519863;3133.6082989626298;3156.621205455337;3166.176794033545;351873;352139;352402;353039;353815.23092384374;57744.133837992464;58364.708176458844;58513.70743146257;58555;58764.7061764697;62653.373466264755;63020;64055.35944640587;64072.67963660245;64085;16344.427945021867;16710;16742.916285418738;16762.329506819835;16781.412650557173;12644.494220231089;12685;12699.238045717286;12704.745905081847;12740.299283539494;18311.40620920996;18948.715769263472;18971.24115035383;18995.43013709591;19251.903740481208;3337.6495467975997;6787.389134977876;7139;7161.856762864713;7488.966968377816;951.4529145741088;984.4241118945354;1004.3471743366724;1072.5816931396762;1088.4231357380602;31308.53037204444;31485.685143148734;31650.841745791586;31814.681853181635;32084;1082.4209048159198;1094.956201751937;1109.1514991031868;1156.3119943633524;1156.8322593223936;16533.83466165347;16660.16699165037;16688;16734.49796506107;17023.829761702473;469568;469731;469996;471670;471678;53317;53700.462995370326;53780.46219537754;53847.46152538424;54164;1318.4989703912643;1347.8989075819352;1367.0499003192685;1367.6170672211995;1379.558541266785;29037.274068148465;30052.24869378283;30548;30682;30709.03967393245;49349.25976110289;49722.50277497323;49828;49858;49861;396208;396569;399012;402470.9505809926;403131;26627.866860665574;27072.593911090957;27095;27104.864475678285;27179.86410067937;41889.37165942574;42215;42563.93590160271;43015.35476967911;43678;35918;36789;37210.25579488341;37679.43480847844;37916.43125353067;36525.81737091298;36880.63119368772;36925.63074369222;37112.44331334978;37941.430878537394;36662.8166859164;37194.62805371912;37269.627303726615;37333.81333093317;37480.437793433666;29977.250568735082;33586.83206583952;33681.32637347288;34793.47809782805;34810;26373.73626263713;26388;26475.470490590465;26510.204693859214;26812.59781103246 00:49:18 INFO - PROCESS | 11518 | |2;jquery.html;381.4507109761943;393.6103257774803;393.9212157568487;396.47071160001394;423.4918098282062;14944.77582836257;16071.919640401811;16106.51680449587;16134.273957671903;16296.429624963128;18192.636147277048;18517.90741046293;18780.62438751224;19159.329423470183;19166.808331916676;4972.950270497294;5197.428282888879;5245.44922783108;5249.448807875176;5254.185601231815;5000.52495012975;5173.430922598511;5181.844544663647;5182.3262975813095;5190.299309593213;5106.872328191787;5125.974370128163;5154.871128221787;5155.71643559604;5174.042802081608;4891.339669144673;5072.163093089635;5087.542121209109;5104.183330667075;5151.17581187012;4648.279516674921;4652.860414187579;4664.230401983668;4666.766661666937;4667.299905014241;19399.90300048505;19846.1069251884;20289.492762680904;20438.79561204384;20540.07569659369;2360.7403185649564;2449.9387515312083;2481.900723971039;2861.4420188063336;2969.198316454545;12121;12712.555060572928;12784.552540661125;13111.737765244641;13310.401031953585;1684.0569281202443;1719.7162468192732;1773.813749556291;1816.2644129127725;1823.4256209294163;74400.62799685966;76838.23161768423;77497.61251193708;77967.64388273387;78556.60721696413;10176.796464070678;10295.94852025735;10329.40341548004;10451.738706532398;10792.298500597593;14699.92650036743;14767.483138090116;14792.334344954503;14794.630134246514;14906.850931490546;7811.921880781119;8154.796130096795;8182.590870456573;8296.460730052528;8367.665293388318;7889.526628402315;7952.443328966917;8008.239217274349;8206.876896846552;8230.053543842416;6260.24877014752;6483.802782283869;6503.28463868974;6505.60966342021;6508.837279067967;1841.4291569613463;1888.1220232591636;1899.9620007599772;1917.2331067573082;1917.7027560728109;901.6168128545341;920.7375897869075;996.7458298133929;1018.3940555369543;1043.6868939318326;19233.326833560757;19485.415437536896;19561.315353962542;19606.80393196078;19997.300094496914;983.6262220356361;992.161623428202;993.2302465589082;1013.7009582173276;1016.9338992965434;9265.72202833916;11014.173936954761;11257.140574441823;11341.206115571831;11380.374079425712;442468;446976;448981;449607;460206;69666;73398;73790.26209737941;74969.62515187389;79965.20034799694;953.7806304549854;983.4246965525248;1027;1029.4749677664445;1032.76762728387;16365.372024329688;16522.25649845736;16939.32242710278;17065.146742663066;17615.471535853943;39229.215415692095;39615.80192099021;40134.39798402968;40675.389869152576;41250.099976006146;53989.460105400016;54063;57863;57931.420685792604;58983.11525327038;7278.126624805057;7480.887786683313;7624.771256862303;7828.099768526692;8050.6779728812535;12543.56097536582;12797.232166070065;12848.293343866177;13048.54330098442;13482.797758033834;10858.891411085788;10952.178586605876;11110.333379997226;11387.373694446886;11462.713432164262;11278.548858045586;11471.885281147415;11632.76734465289;11647.30116193031;11854.407279636156;11447.885521144683;11513.712157196138;11565.826512602149;11568.190226684388;11858.881411185777;7722.073351197668;7903.723369682263;7964.362850971793;7977.641006154621;8012.959935200287;9702.320837541587;10404.375737455777;10689;11316.623509063189;11587.768244635228 00:49:18 INFO - PROCESS | 11518 | |3;mootools.html;1459.044325966492;1460.9853901460986;1577.392703809034;1687.6540309236607;1716.948491545254;7081.681324340404;7374.1151061872515;7551.187714948414;7559.244075592438;7622.428317876168;7802.726904558342;7939.48393354433;7959.442839001258;7964.880526792088;7971.641276142573;2034.1049938027295;2060.0832629479887;2060.2994981706215;2074.8547601667888;2077.1379877350882;1957.168203513501;1974.9012549372546;1989.0452582760283;2014.798520147988;2016.3850025742142;1938.7188857615638;1946.3577019583574;1953.9902300488477;1954.6872500399938;1968.3406058970263;1994.670879304913;2017.757869055708;2024.1700902629998;2026.1490174126902;2029.1883246701364;2013.124290933434;2013.2852837242715;2059.855810093294;2060.5569802492387;2062.360668192865;7740.342070923978;7790.45466817323;7848.489848159908;7851.21487851216;7859.52842829432;4756.429228492603;4914.0908931847725;4915.729634870081;4937.037277730844;4955.30625712397;2932.574776657394;3104.332568497784;3121.750259979196;3126.7342275906576;3230;943.9764005899839;983.7442265011077;1021.3769600543662;1046.7749433871677;1054.3041592548882;10847.349159050404;11031.282966607225;11051.17116216279;11060.502277397536;11063.502142403611;3967.1272320089533;4214.515330736943;4255.87232383029;4278.7004909656025;4296.441462609903;8746.125387461203;8746.56267186638;8750.124987501198;8754.69358572447;8763.605637746317;4859.562639362474;4906.828261010847;4917.311576379309;4917.5082491751255;4934.950650493521;4030.0730831908827;4214.136102099063;4522.3668686383935;4633.142868569325;4669.229577119805;3525.753197276217;3561.661642143992;3673.559172899269;3681.337359275356;3693.741438099361;1163.96508104757;1191.53530123252;1206.927584344942;1219.71336735867;1240.8138779183196;910.8178364327028;918.3617385916857;920.0983036624145;934.0332755597924;936.2507368640048;5258.789648414021;5450.563954883679;5475.945240547543;5491.203775452537;5509.696966666872;933.3373304953424;934.1639232886529;946.758576562972;973.3575839945744;988.1205726903062;3563.982180089083;3783.981080094637;3829.310724069694;3865.8260378283044;3916.6475017248586;9334.06659334061;9576.521173941414;9667.951660241653;9676.080772326617;9747.902520974842;9387.436753794795;9487.051294870596;9489.051094890456;9564.66523671682;9652.179564736936;7054.435645148375;7353.558786472829;7495.437842161859;7508.361789247975;7513.2862378074;5058;5267.841964741064;5326.25432439451;5341;5634.52106570946;8481.830363392573;8724.825503490021;8908.5991130398;8953.418027828171;9091.136342047495;8826.117388261122;8827.863161627685;9141;9196.12636799503;9300.906990930003;6901.827454313682;7083.82290442743;7203.891941620985;7284.67218975158;7332.266773322838;7514.286142816423;7561.7353392633195;7584.241575842371;7594.202608726005;7664.616769161408;6839.2818754032105;6945.513814033171;6957.860842783015;6973.895391569232;7193.928060719535;6938.23679395256;7018.368346848604;7060.293970603104;7083.610401427971;7117.7152913882865;6214.9067763984485;6321;6331.715072821827;6389.041643753474;6429.38920802523;4680.882977925579;4741.099191153669;4758.357621721023;4778.546038126373;4833.275008748716;4750.19246728064;4781.832635857728;4794.496577859414;4876.731779752147;4932 00:49:18 INFO - PROCESS | 11518 | |4;prototype.html;321.7249251889634;333.54138060167264;333.8230737709014;344.33543261505315;348.0342050809004;5286.629935904488;5406.459354064592;5420.810271640498;5469.179623056543;5504.4495550444935;5246.8688282792855;5334.626576139662;5391.813800963791;5397.919031214535;5422.186671999192;4274.444322238105;4287.571242875703;4292.411807631165;4304.354346847967;4329.177456283312;4195.643370313527;4262.232798096342;4267.743935363873;4299.505556860954;4316.309390497521;4231.4499115114995;4248.9575104249025;4255.680823938202;4261.382099595557;4272.764997925113;4264.25375559279;4271.380649805761;4274.166537525184;4285.828566857337;4295.52749197588;3625.438057101127;3686.2811751708427;3699.7595156315024;3699.8150092495266;3835.8082095895093;5205.245239440298;5263.605229607795;5294.523492885659;5311.893762124736;5353.57171426285;4855.223164293696;4855.5387238212315;4864.756762161913;4872.4640289568115;4885.36490256268;5496;5641.279409780015;5701.287339082614;5707.315122185364;5711.428857114255;4110.794460277004;4113.835446582133;4126.381042843567;4134.131832315217;4152.335626299808;5916;5960.582759206857;5965.4631083202285;5970.0746384310505;5974.193483879664;4045.4627241648573;4121.91756164875;4136.358864376027;4137.455464889072;4147;4180.366369187393;4213.536510983789;4217.840093974181;4224.598663126998;4240.257954857888;4820.156472617348;4844.006978569385;4846.781894814671;4855.732934688555;4864.927026094611;5651.4348565143155;5651.841372518624;5672.837068400968;5742.052561327418;5798.8550286242335;1387.9236641984585;1405.8734713875801;1421.4527406948193;1426.2013272567397;1432.7277817214697;938.7840796616816;970.3450171134597;977.941323520591;981.6073570571829;983.8622592837008;5284.9917031527775;5307.442718514578;5326.680399176062;5327.893442131136;5339.422586866808;5618.690971996498;5632.690202038927;5649.519790817744;5706.942930570641;5707.461373948096;5170.560502357266;5289.523942845162;5318.574514038867;5347.625666203407;5380.300560927054;2903.2596687844466;2963.4517614241436;2986.925326866846;2995.3859458810894;3003.2041509000132;5718;5743.339515955635;5809.88380232393;5828.542864283929;5852.678102704393;5446.828931779686;5638.43615638441;5658.207850900877;5669.943300566942;5697.971510142423;5777.248957635565;5808.215890854681;5814.186013957965;5823.417658234227;5879.794207202727;5613.764971706218;5613.971930140323;5674.517665998271;5687.744051517774;5868.38381969887;5844.970775146097;5845.09401042839;5847.181394604674;5874.559408044328;5876.236089308362;6099.176611157614;6171.352008039271;6192.318844927145;6203.751849925952;6216.627002379872;3986.6810655146937;4169.854055108057;4188;4205.747655140702;4205.978970105252;5824.242848429677;5934.7922822701;5949;5963.880722385441;5984.725804194378;5807.245058142415;5814.5348372130975;5835.854103647443;5839.532837372915;5873.4126587340925;5746.482816546531;5772.249607550992;5776.768929242783;5783.15420245532;5792.94207057924;5633.971830140987;5722.284714410699;5770.855728606818;5785.3636100028125;5798.768049277982;5835;5840.912386314294;5877.23595932526;5913.10780550237;5924.289085309791;5391.514763671288;5642.6614403135945;5709.486146246858;5740.454656807597;5780.797672081457 00:49:18 INFO - PROCESS | 11518 | |5;yui.html;680.9591424514532;686.5537400689552;720.3408880874;727.3017902813299;732.6117157906311;13496.122752021112;13722.725545489084;14166.220857852813;14222.00445968784;14411.711765764678;12790.360481975911;13006.73986520269;13012.674683132902;13025.413856376463;13037;761.931426171643;769.1731388757108;769.2576663519702;770.0489894979696;773.4740376543948;755.4221020918974;789.3842802613971;791.4301702773994;791.6041979010495;795.0896223823747;813.5322189740893;817.2236375443323;820.0118856777568;822.48183644304;822.7367242482408;814.0678922633581;814.2915663372903;817.207308910356;817.3134566963749;818.3575892924026;600.1238192239335;600.2706711345736;600.6726334147857;601.0863487498978;601.5278006764712;11879.40602969848;11914;11937.34344611046;11948.103892208032;11966.521339146511;10408.5836566538;10438.164946804314;10540.841887371696;10726.946365268124;10837.241393102486;9368.110029547182;9825.754356141082;9912.306138570302;10012.849807252896;10057.446840423774;3057.342671325676;3084.7532197424375;3085.336652619675;3087.6449208341105;3146.1033605422344;58806.41193588095;60351;60621;61038.694806526124;61351;8399.622017009127;8541.871871921927;8776.25401840838;8785.297176225886;8934.776630584287;16348;16397;16443;16454.341826326814;16539.50381488557;7920.564368959763;7957.244061814118;8042.075161356402;8175.2233537815;8251.793705157419;4294.720843145185;4402.361657559636;4414.448193975753;4421.46942366918;4430.534793846664;3263.7225835804225;3363.024722830352;3364.0580637421563;3366.7474939379645;3371.7302615790677;596.239794262319;610.3774150366601;610.6000569626901;611.9296280927662;612.6018088242678;539.2773683264445;700.6846918886522;709.8864181731002;731.4075598765018;747.7382915979364;8584.48493090404;9088.869052665184;9202;9286.210672092948;9366.484843333683;574.6437208930406;603.0050416812295;691.381213813634;698.2982102986567;737.0492065235786;4156.189543039139;4233.555476674905;4477.7313361197785;4493.662975276868;4543;85870;85873;88827.55586222156;90469;92635.53682231545;72120;76357.61821190859;77085;78274;80160.59919700364;67746.32253677498;70553.64723176454;70945;71380.2861971384;72550.27449725436;8485.490870547786;8513.914860851311;8600.956995214983;8798.868016979623;9071.138241867013;31534.925552113153;33113.834430827694;42033.159336813704;45535.31697024481;45733.77133114313;59683.403165969525;61409.385906140364;61768.38231617626;61947.38052619416;63578.68210659102;10390.948045260027;10464.581416743245;10681.8931810684;11247.268927519684;11733.237339572901;11796.3512006837;11842.407879606157;12235.204711693712;12335.75328493443;13137.277449740355;10961.342319460859;11061.391623460788;11126;11290.774184516427;11315;11730.824037639271;11741.412929353328;11764.470598822902;11773.882261177621;11840.76318473643;9992.550335234786;10129.088382045356;10135.898641013495;10490.947545262225;10526.52630631608;8794.516301603473;8983.910160898307;9214.585343659417;9310.534473276444;9345.766355840886;9206.217471514728;9312.813743725223;9318.62725491;9351.812963740551;9392.389494682824 00:49:18 INFO - PROCESS | 11518 | __end_tp_report 00:49:18 INFO - PROCESS | 11518 | __start_cc_report 00:49:18 INFO - PROCESS | 11518 | _x_x_mozilla_cycle_collect,323 00:49:18 INFO - PROCESS | 11518 | __end_cc_report 00:49:18 INFO - PROCESS | 11518 | __startTimestamp1479372558960__endTimestamp 00:49:18 INFO - PROCESS | 11518 | 00:49:18 INFO - PROCESS | 11518 | ------- Summary: start ------- 00:49:18 INFO - PROCESS | 11518 | Number of tests: 6 00:49:18 INFO - PROCESS | 11518 | 00:49:18 INFO - PROCESS | 11518 | [#0] dojo.html Cycles:165 Average:5317.87 Median:5547.92 stddev:616.30 (11.1%) stddev-sans-first:593.30 00:49:18 INFO - PROCESS | 11518 | Values: 3107.6 3109.9 3140.0 3147.2 3156.4 5157.0 5378.5 5398.8 5426.0 5453.5 5247.4 5330.2 5368.2 5388.4 5405.6 4863.7 4883.6 4954.4 4954.9 4999.3 4847.7 4918.6 5042.1 5071.5 5103.9 4783.1 4825.5 4943.7 5019.6 5036.0 4869.7 4871.1 4872.8 4878.9 4881.0 4811.2 4816.3 4817.6 4819.7 4821.2 5212.0 5219.0 5283.9 5295.3 5301.9 5677.5 5703.2 5713.1 5730.9 5759.5 5682.4 5692.6 5738.5 5743.7 5750.5 5176.8 5200.6 5230.6 5275.2 5325.5 5714.0 5737.3 5787.1 5814.7 5829.9 5621.9 5628.3 5633.1 5681.2 5685.2 5711.2 5726.6 5741.8 5746.0 5752.8 5462.8 5595.5 5610.5 5616.6 5628.3 5687.5 5687.8 5696.6 5713.7 5715.7 4312.1 4322.7 4324.0 4335.9 4367.8 3731.7 3802.6 3804.7 3824.3 3923.2 5425.2 5505.3 5514.3 5601.9 5605.1 5780.5 5818.1 5826.2 5826.3 5870.6 5547.9 5553.1 5556.1 5559.3 5562.5 4637.5 4637.9 4780.5 4792.7 4811.4 6068.9 6071.3 6071.7 6100.6 6114.9 5789.0 5814.3 5822.6 5844.1 5857.6 5741.4 5783.4 5805.6 5985.2 6009.4 5618.1 5624.4 5656.9 5666.8 5756.3 5766.6 5781.5 5781.7 5807.6 5808.5 5648.7 5679.8 5692.8 5703.3 5714.9 5355.4 5448.5 5476.5 5482.9 5560.6 5444.2 5469.3 5491.8 5553.2 5563.8 5478.9 5494.1 5517.6 5551.1 5573.2 5455.2 5476.7 5514.8 5561.6 5570.2 00:49:18 INFO - PROCESS | 11518 | 00:49:18 INFO - PROCESS | 11518 | [#1] ext.html Cycles:180 Average:55359.80 Median:35511.56 stddev:108776.93 (306.3%) stddev-sans-first:109004.31 00:49:18 INFO - PROCESS | 11518 | Values: 577.2 587.5 590.1 591.8 596.6 26933.2 29018.4 34598.3 35487.5 35535.6 34570.8 34902.7 34962.0 34985.5 35049.0 6782.6 6884.0 6922.9 6938.3 6970.7 7090.7 7204.2 7208.6 7224.4 7252.1 7173.9 7200.2 7269.5 7288.3 7293.4 7253.8 7257.3 7304.5 7312.2 7332.9 7193.7 7197.3 7242.2 7253.1 7259.2 32958.0 33156.5 33234.8 33242.3 33310.0 3347.9 3493.9 3503.2 3591.8 3673.7 22969.9 23313.7 23601.8 24217.5 24234.8 3103.4 3106.2 3133.6 3156.6 3166.2 351873.0 352139.0 352402.0 353039.0 353815.2 57744.1 58364.7 58513.7 58555.0 58764.7 62653.4 63020.0 64055.4 64072.7 64085.0 16344.4 16710.0 16742.9 16762.3 16781.4 12644.5 12685.0 12699.2 12704.7 12740.3 18311.4 18948.7 18971.2 18995.4 19251.9 3337.6 6787.4 7139.0 7161.9 7489.0 951.5 984.4 1004.3 1072.6 1088.4 31308.5 31485.7 31650.8 31814.7 32084.0 1082.4 1095.0 1109.2 1156.3 1156.8 16533.8 16660.2 16688.0 16734.5 17023.8 469568.0 469731.0 469996.0 471670.0 471678.0 53317.0 53700.5 53780.5 53847.5 54164.0 1318.5 1347.9 1367.0 1367.6 1379.6 29037.3 30052.2 30548.0 30682.0 30709.0 49349.3 49722.5 49828.0 49858.0 49861.0 396208.0 396569.0 399012.0 402471.0 403131.0 26627.9 27072.6 27095.0 27104.9 27179.9 41889.4 42215.0 42563.9 43015.4 43678.0 35918.0 36789.0 37210.3 37679.4 37916.4 36525.8 36880.6 36925.6 37112.4 37941.4 36662.8 37194.6 37269.6 37333.8 37480.4 29977.3 33586.8 33681.3 34793.5 34810.0 26373.7 26388.0 26475.5 26510.2 26812.6 00:49:18 INFO - PROCESS | 11518 | 00:49:18 INFO - PROCESS | 11518 | [#2] jquery.html Cycles:180 Average:26917.31 Median:19805.33 stddev:73961.29 (373.4%) stddev-sans-first:74141.93 00:49:18 INFO - PROCESS | 11518 | Values: 381.5 393.6 393.9 396.5 423.5 14944.8 16071.9 16106.5 16134.3 16296.4 18192.6 18517.9 18780.6 19159.3 19166.8 4973.0 5197.4 5245.4 5249.4 5254.2 5000.5 5173.4 5181.8 5182.3 5190.3 5106.9 5126.0 5154.9 5155.7 5174.0 4891.3 5072.2 5087.5 5104.2 5151.2 4648.3 4652.9 4664.2 4666.8 4667.3 19399.9 19846.1 20289.5 20438.8 20540.1 2360.7 2449.9 2481.9 2861.4 2969.2 12121.0 12712.6 12784.6 13111.7 13310.4 1684.1 1719.7 1773.8 1816.3 1823.4 74400.6 76838.2 77497.6 77967.6 78556.6 10176.8 10295.9 10329.4 10451.7 10792.3 14699.9 14767.5 14792.3 14794.6 14906.9 7811.9 8154.8 8182.6 8296.5 8367.7 7889.5 7952.4 8008.2 8206.9 8230.1 6260.2 6483.8 6503.3 6505.6 6508.8 1841.4 1888.1 1900.0 1917.2 1917.7 901.6 920.7 996.7 1018.4 1043.7 19233.3 19485.4 19561.3 19606.8 19997.3 983.6 992.2 993.2 1013.7 1016.9 9265.7 11014.2 11257.1 11341.2 11380.4 442468.0 446976.0 448981.0 449607.0 460206.0 69666.0 73398.0 73790.3 74969.6 79965.2 953.8 983.4 1027.0 1029.5 1032.8 16365.4 16522.3 16939.3 17065.1 17615.5 39229.2 39615.8 40134.4 40675.4 41250.1 53989.5 54063.0 57863.0 57931.4 58983.1 7278.1 7480.9 7624.8 7828.1 8050.7 12543.6 12797.2 12848.3 13048.5 13482.8 10858.9 10952.2 11110.3 11387.4 11462.7 11278.5 11471.9 11632.8 11647.3 11854.4 11447.9 11513.7 11565.8 11568.2 11858.9 7722.1 7903.7 7964.4 7977.6 8013.0 9702.3 10404.4 10689.0 11316.6 11587.8 00:49:18 INFO - PROCESS | 11518 | 00:49:18 INFO - PROCESS | 11518 | [#3] mootools.html Cycles:180 Average:5207.63 Median:5297.05 stddev:2890.54 (54.6%) stddev-sans-first:2884.92 00:49:18 INFO - PROCESS | 11518 | Values: 1459.0 1461.0 1577.4 1687.7 1716.9 7081.7 7374.1 7551.2 7559.2 7622.4 7802.7 7939.5 7959.4 7964.9 7971.6 2034.1 2060.1 2060.3 2074.9 2077.1 1957.2 1974.9 1989.0 2014.8 2016.4 1938.7 1946.4 1954.0 1954.7 1968.3 1994.7 2017.8 2024.2 2026.1 2029.2 2013.1 2013.3 2059.9 2060.6 2062.4 7740.3 7790.5 7848.5 7851.2 7859.5 4756.4 4914.1 4915.7 4937.0 4955.3 2932.6 3104.3 3121.8 3126.7 3230.0 944.0 983.7 1021.4 1046.8 1054.3 10847.3 11031.3 11051.2 11060.5 11063.5 3967.1 4214.5 4255.9 4278.7 4296.4 8746.1 8746.6 8750.1 8754.7 8763.6 4859.6 4906.8 4917.3 4917.5 4935.0 4030.1 4214.1 4522.4 4633.1 4669.2 3525.8 3561.7 3673.6 3681.3 3693.7 1164.0 1191.5 1206.9 1219.7 1240.8 910.8 918.4 920.1 934.0 936.3 5258.8 5450.6 5475.9 5491.2 5509.7 933.3 934.2 946.8 973.4 988.1 3564.0 3784.0 3829.3 3865.8 3916.6 9334.1 9576.5 9668.0 9676.1 9747.9 9387.4 9487.1 9489.1 9564.7 9652.2 7054.4 7353.6 7495.4 7508.4 7513.3 5058.0 5267.8 5326.3 5341.0 5634.5 8481.8 8724.8 8908.6 8953.4 9091.1 8826.1 8827.9 9141.0 9196.1 9300.9 6901.8 7083.8 7203.9 7284.7 7332.3 7514.3 7561.7 7584.2 7594.2 7664.6 6839.3 6945.5 6957.9 6973.9 7193.9 6938.2 7018.4 7060.3 7083.6 7117.7 6214.9 6321.0 6331.7 6389.0 6429.4 4680.9 4741.1 4758.4 4778.5 4833.3 4750.2 4781.8 4794.5 4876.7 4932.0 00:49:18 INFO - PROCESS | 11518 | 00:49:18 INFO - PROCESS | 11518 | [#4] prototype.html Cycles:180 Average:4784.79 Median:5402.19 stddev:1409.52 (26.1%) stddev-sans-first:1373.09 00:49:18 INFO - PROCESS | 11518 | Values: 321.7 333.5 333.8 344.3 348.0 5286.6 5406.5 5420.8 5469.2 5504.4 5246.9 5334.6 5391.8 5397.9 5422.2 4274.4 4287.6 4292.4 4304.4 4329.2 4195.6 4262.2 4267.7 4299.5 4316.3 4231.4 4249.0 4255.7 4261.4 4272.8 4264.3 4271.4 4274.2 4285.8 4295.5 3625.4 3686.3 3699.8 3699.8 3835.8 5205.2 5263.6 5294.5 5311.9 5353.6 4855.2 4855.5 4864.8 4872.5 4885.4 5496.0 5641.3 5701.3 5707.3 5711.4 4110.8 4113.8 4126.4 4134.1 4152.3 5916.0 5960.6 5965.5 5970.1 5974.2 4045.5 4121.9 4136.4 4137.5 4147.0 4180.4 4213.5 4217.8 4224.6 4240.3 4820.2 4844.0 4846.8 4855.7 4864.9 5651.4 5651.8 5672.8 5742.1 5798.9 1387.9 1405.9 1421.5 1426.2 1432.7 938.8 970.3 977.9 981.6 983.9 5285.0 5307.4 5326.7 5327.9 5339.4 5618.7 5632.7 5649.5 5706.9 5707.5 5170.6 5289.5 5318.6 5347.6 5380.3 2903.3 2963.5 2986.9 2995.4 3003.2 5718.0 5743.3 5809.9 5828.5 5852.7 5446.8 5638.4 5658.2 5669.9 5698.0 5777.2 5808.2 5814.2 5823.4 5879.8 5613.8 5614.0 5674.5 5687.7 5868.4 5845.0 5845.1 5847.2 5874.6 5876.2 6099.2 6171.4 6192.3 6203.8 6216.6 3986.7 4169.9 4188.0 4205.7 4206.0 5824.2 5934.8 5949.0 5963.9 5984.7 5807.2 5814.5 5835.9 5839.5 5873.4 5746.5 5772.2 5776.8 5783.2 5792.9 5634.0 5722.3 5770.9 5785.4 5798.8 5835.0 5840.9 5877.2 5913.1 5924.3 5391.5 5642.7 5709.5 5740.5 5780.8 00:49:18 INFO - PROCESS | 11518 | 00:49:18 INFO - PROCESS | 11518 | [#5] yui.html Cycles:180 Average:16796.05 Median:30824.65 stddev:23542.89 (76.4%) stddev-sans-first:23577.84 00:49:18 INFO - PROCESS | 11518 | Values: 681.0 686.6 720.3 727.3 732.6 13496.1 13722.7 14166.2 14222.0 14411.7 12790.4 13006.7 13012.7 13025.4 13037.0 761.9 769.2 769.3 770.0 773.5 755.4 789.4 791.4 791.6 795.1 813.5 817.2 820.0 822.5 822.7 814.1 814.3 817.2 817.3 818.4 600.1 600.3 600.7 601.1 601.5 11879.4 11914.0 11937.3 11948.1 11966.5 10408.6 10438.2 10540.8 10726.9 10837.2 9368.1 9825.8 9912.3 10012.8 10057.4 3057.3 3084.8 3085.3 3087.6 3146.1 58806.4 60351.0 60621.0 61038.7 61351.0 8399.6 8541.9 8776.3 8785.3 8934.8 16348.0 16397.0 16443.0 16454.3 16539.5 7920.6 7957.2 8042.1 8175.2 8251.8 4294.7 4402.4 4414.4 4421.5 4430.5 3263.7 3363.0 3364.1 3366.7 3371.7 596.2 610.4 610.6 611.9 612.6 539.3 700.7 709.9 731.4 747.7 8584.5 9088.9 9202.0 9286.2 9366.5 574.6 603.0 691.4 698.3 737.0 4156.2 4233.6 4477.7 4493.7 4543.0 85870.0 85873.0 88827.6 90469.0 92635.5 72120.0 76357.6 77085.0 78274.0 80160.6 67746.3 70553.6 70945.0 71380.3 72550.3 8485.5 8513.9 8601.0 8798.9 9071.1 31534.9 33113.8 42033.2 45535.3 45733.8 59683.4 61409.4 61768.4 61947.4 63578.7 10390.9 10464.6 10681.9 11247.3 11733.2 11796.4 11842.4 12235.2 12335.8 13137.3 10961.3 11061.4 11126.0 11290.8 11315.0 11730.8 11741.4 11764.5 11773.9 11840.8 9992.6 10129.1 10135.9 10490.9 10526.5 8794.5 8983.9 9214.6 9310.5 9345.8 9206.2 9312.8 9318.6 9351.8 9392.4 00:49:18 INFO - PROCESS | 11518 | -------- Summary: end -------- 00:49:18 INFO - PROCESS | 11518 | 00:49:19 INFO - PROCESS | 11518 | 00:49:19 INFO - PROCESS | 11518 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 00:49:19 INFO - PROCESS | 11518 | 00:49:19 INFO - PROCESS | 11518 | 00:49:19 INFO - PROCESS | 11518 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 00:49:19 INFO - PROCESS | 11518 | 00:49:19 INFO - PROCESS | 11518 | 00:49:19 INFO - PROCESS | 11518 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 00:49:19 INFO - PROCESS | 11518 | 00:49:19 INFO - PROCESS | 11518 | 00:49:19 INFO - PROCESS | 11518 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 00:49:19 INFO - PROCESS | 11518 | 00:49:19 INFO - PROCESS | 11518 | 00:49:19 INFO - PROCESS | 11518 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 00:49:19 INFO - PROCESS | 11518 | 00:49:19 INFO - TEST-INFO | 11518: exit 0 00:49:19 INFO - TEST-OK | dromaeo_css | took 1116688ms 00:49:19 INFO - TEST-START | kraken 00:49:19 INFO - operating with platform_type : linux_ 00:49:19 INFO - Initialising browser for kraken test... 00:49:19 INFO - TEST-INFO | started process 11883 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4cbfgx/profile http://localhost:35488/getInfo.html) 00:49:24 INFO - PROCESS | 11883 | __metrics Screen width/height:1600/1200 00:49:24 INFO - PROCESS | 11883 | colorDepth:24 00:49:24 INFO - PROCESS | 11883 | Browser inner width/height: 1024/697 00:49:24 INFO - PROCESS | 11883 | __metrics 00:49:25 ERROR - PROCESS | 11883 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 00:49:26 INFO - TEST-INFO | 11883: exit 0 00:49:26 INFO - Browser initialized. 00:49:26 INFO - Running cycle 1/1 for kraken test... 00:49:26 INFO - TEST-INFO | started process 12004 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4cbfgx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:49:38 INFO - PROCESS | 12004 | RSS: Main: 185819136 00:49:38 INFO - PROCESS | 12004 | 00:49:41 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35488/tests/kraken/driver.html?testName=audio-beat-detection) 00:49:42 INFO - PROCESS | 12004 | RSS: Main: 198389760 00:49:42 INFO - PROCESS | 12004 | 00:49:44 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35488/tests/kraken/driver.html?testName=audio-dft) 00:49:45 INFO - PROCESS | 12004 | RSS: Main: 196866048 00:49:45 INFO - PROCESS | 12004 | 00:49:48 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35488/tests/kraken/driver.html?testName=audio-fft) 00:49:48 INFO - PROCESS | 12004 | RSS: Main: 193384448 00:49:48 INFO - PROCESS | 12004 | 00:49:51 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35488/tests/kraken/driver.html?testName=audio-oscillator) 00:49:51 INFO - PROCESS | 12004 | RSS: Main: 194039808 00:49:51 INFO - PROCESS | 12004 | 00:49:53 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35488/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:49:54 INFO - PROCESS | 12004 | RSS: Main: 194351104 00:49:54 INFO - PROCESS | 12004 | 00:49:57 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35488/tests/kraken/driver.html?testName=imaging-darkroom) 00:49:58 INFO - PROCESS | 12004 | RSS: Main: 199049216 00:49:58 INFO - PROCESS | 12004 | 00:50:01 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35488/tests/kraken/driver.html?testName=imaging-desaturate) 00:50:02 INFO - PROCESS | 12004 | RSS: Main: 199639040 00:50:02 INFO - PROCESS | 12004 | 00:50:04 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35488/tests/kraken/driver.html?testName=json-parse-financial) 00:50:05 INFO - PROCESS | 12004 | RSS: Main: 199045120 00:50:05 INFO - PROCESS | 12004 | 00:50:07 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35488/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:50:07 INFO - PROCESS | 12004 | RSS: Main: 199008256 00:50:07 INFO - PROCESS | 12004 | 00:50:09 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35488/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:50:10 INFO - PROCESS | 12004 | RSS: Main: 199032832 00:50:10 INFO - PROCESS | 12004 | 00:50:12 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35488/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:50:12 INFO - PROCESS | 12004 | RSS: Main: 199286784 00:50:12 INFO - PROCESS | 12004 | 00:50:15 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:50:16 INFO - PROCESS | 12004 | RSS: Main: 199200768 00:50:16 INFO - PROCESS | 12004 | 00:50:19 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:50:19 INFO - PROCESS | 12004 | RSS: Main: 199335936 00:50:19 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | Cycle 1(1): loaded http://localhost:35488/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35488/tests/kraken/driver.html?testName=ai-astar) 00:50:21 INFO - PROCESS | 12004 | RSS: Main: 200736768 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | __start_tp_report 00:50:21 INFO - PROCESS | 12004 | _x_x_mozilla_page_load 00:50:21 INFO - PROCESS | 12004 | _x_x_mozilla_page_load_details 00:50:21 INFO - PROCESS | 12004 | |i|pagename|runs| 00:50:21 INFO - PROCESS | 12004 | |0;ai-astar;105;113;111;114;111;111;113;111;111;113 00:50:21 INFO - PROCESS | 12004 | |1;audio-beat-detection;161;128;126;168;126;129;132;131;159;132 00:50:21 INFO - PROCESS | 12004 | |2;audio-dft;165;165;168;175;164;167;162;162;163;163 00:50:21 INFO - PROCESS | 12004 | |3;audio-fft;75;75;76;121;77;75;76;76;112;75 00:50:21 INFO - PROCESS | 12004 | |4;audio-oscillator;84;83;116;82;82;83;99;82;83;104 00:50:21 INFO - PROCESS | 12004 | |5;imaging-gaussian-blur;117;117;117;118;118;118;118;118;119;117 00:50:21 INFO - PROCESS | 12004 | |6;imaging-darkroom;147;148;149;147;146;147;147;147;147;148 00:50:21 INFO - PROCESS | 12004 | |7;imaging-desaturate;97;97;96;96;96;96;96;96;96;96 00:50:21 INFO - PROCESS | 12004 | |8;json-parse-financial;52;53;54;52;52;55;53;53;53;53 00:50:21 INFO - PROCESS | 12004 | |9;json-stringify-tinderbox;63;64;65;69;64;62;63;62;63;66 00:50:21 INFO - PROCESS | 12004 | |10;stanford-crypto-aes;87;81;91;80;85;80;81;80;80;79 00:50:21 INFO - PROCESS | 12004 | |11;stanford-crypto-ccm;136;149;131;139;132;145;133;141;178;136 00:50:21 INFO - PROCESS | 12004 | |12;stanford-crypto-pbkdf2;171;167;170;168;164;169;171;166;168;166 00:50:21 INFO - PROCESS | 12004 | |13;stanford-crypto-sha256-iterative;65;66;65;65;71;66;67;64;63;66 00:50:21 INFO - PROCESS | 12004 | __end_tp_report 00:50:21 INFO - PROCESS | 12004 | __start_cc_report 00:50:21 INFO - PROCESS | 12004 | _x_x_mozilla_cycle_collect,807 00:50:21 INFO - PROCESS | 12004 | __end_cc_report 00:50:21 INFO - PROCESS | 12004 | __startTimestamp1479372621718__endTimestamp 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | ------- Summary: start ------- 00:50:21 INFO - PROCESS | 12004 | Number of tests: 14 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:2.50 (2.2%) stddev-sans-first:1.22 00:50:21 INFO - PROCESS | 12004 | Values: 105.0 113.0 111.0 114.0 111.0 111.0 113.0 111.0 111.0 113.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#1] audio-beat-detection Cycles:10 Average:139.20 Median:132.00 stddev:16.48 (12.5%) stddev-sans-first:15.48 00:50:21 INFO - PROCESS | 12004 | Values: 161.0 128.0 126.0 168.0 126.0 129.0 132.0 131.0 159.0 132.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#2] audio-dft Cycles:10 Average:165.40 Median:165.00 stddev:3.92 (2.4%) stddev-sans-first:4.16 00:50:21 INFO - PROCESS | 12004 | Values: 165.0 165.0 168.0 175.0 164.0 167.0 162.0 162.0 163.0 163.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#3] audio-fft Cycles:10 Average:83.80 Median:75.50 stddev:17.38 (23.0%) stddev-sans-first:18.14 00:50:21 INFO - PROCESS | 12004 | Values: 75.0 75.0 76.0 121.0 77.0 75.0 76.0 76.0 112.0 75.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:83.00 stddev:12.15 (14.6%) stddev-sans-first:12.70 00:50:21 INFO - PROCESS | 12004 | Values: 84.0 83.0 116.0 82.0 82.0 83.0 99.0 82.0 83.0 104.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.67 00:50:21 INFO - PROCESS | 12004 | Values: 117.0 117.0 117.0 118.0 118.0 118.0 118.0 118.0 119.0 117.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 00:50:21 INFO - PROCESS | 12004 | Values: 147.0 148.0 149.0 147.0 146.0 147.0 147.0 147.0 147.0 148.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 00:50:21 INFO - PROCESS | 12004 | Values: 97.0 97.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#8] json-parse-financial Cycles:10 Average:53.00 Median:53.00 stddev:0.94 (1.8%) stddev-sans-first:0.93 00:50:21 INFO - PROCESS | 12004 | Values: 52.0 53.0 54.0 52.0 52.0 55.0 53.0 53.0 53.0 53.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:2.13 (3.3%) stddev-sans-first:2.22 00:50:21 INFO - PROCESS | 12004 | Values: 63.0 64.0 65.0 69.0 64.0 62.0 63.0 62.0 63.0 66.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.00 stddev:3.95 (4.9%) stddev-sans-first:3.82 00:50:21 INFO - PROCESS | 12004 | Values: 87.0 81.0 91.0 80.0 85.0 80.0 81.0 80.0 80.0 79.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:140.00 stddev:13.90 (9.9%) stddev-sans-first:14.57 00:50:21 INFO - PROCESS | 12004 | Values: 136.0 149.0 131.0 139.0 132.0 145.0 133.0 141.0 178.0 136.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.00 Median:168.50 stddev:2.31 (1.4%) stddev-sans-first:2.18 00:50:21 INFO - PROCESS | 12004 | Values: 171.0 167.0 170.0 168.0 164.0 169.0 171.0 166.0 168.0 166.0 00:50:21 INFO - PROCESS | 12004 | 00:50:21 INFO - PROCESS | 12004 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:2.15 (3.3%) stddev-sans-first:2.26 00:50:21 INFO - PROCESS | 12004 | Values: 65.0 66.0 65.0 65.0 71.0 66.0 67.0 64.0 63.0 66.0 00:50:21 INFO - PROCESS | 12004 | -------- Summary: end -------- 00:50:21 INFO - PROCESS | 12004 | 00:50:22 INFO - TEST-INFO | 12004: exit 0 00:50:22 INFO - TEST-OK | kraken | took 63047ms 00:50:22 INFO - SUITE-END | took 1179s 00:50:23 INFO - Completed test suite (00:19:40) 00:50:23 INFO - javascript benchmark 00:50:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6832.041863478652, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3107.5960125183724, 3109.8600562974666, 3139.995201535508, 3147.150269427255, 3156.3845050215205, 5156.974215128928, 5378.46215378462, 5398.757055932482, 5425.9576615421465, 5453.5364494018, 5247.449017853118, 5330.227117068032, 5368.248445217672, 5388.43421440748, 5405.594580406466, 4863.732494712789, 4883.633727470445, 4954.380702412199, 4954.851354459372, 4999.275105109757, 4847.660663753539, 4918.631102667297, 5042.117629414856, 5071.492850714936, 5103.928175083219, 4783.091212669582, 4825.541573550507, 4943.703377797344, 5019.64862459628, 5035.974820125876, 4869.659123861331, 4871.12319782439, 4872.805087796484, 4878.926816097762, 4881.0, 4811.182099043171, 4816.25348071046, 4817.638677099197, 4819.734914579697, 4821.180399332122, 5211.957608478319, 5218.973905130488, 5283.894322113575, 5295.338082739658, 5301.867453313659, 5677.517411020027, 5703.230063941356, 5713.057345537981, 5730.885382292373, 5759.510441612468, 5682.431756824326, 5692.601517893749, 5738.454846789548, 5743.684097374643, 5750.453706897838, 5176.792928282902, 5200.609954253446, 5230.581553475713, 5275.235090911873, 5325.547328477084, 5714.000049991235, 5737.282839645044, 5787.102999035072, 5814.651120932757, 5829.94170058294, 5621.903728772932, 5628.324601047901, 5633.098704207389, 5681.204631351614, 5685.204071430003, 5711.200431939532, 5726.570507211975, 5741.827745167651, 5745.971270143623, 5752.798652047159, 5462.808801692001, 5595.496405323541, 5610.523105535994, 5616.550675945915, 5628.296462942132, 5687.488126068673, 5687.829365119053, 5696.629719068247, 5713.657180569179, 5715.657060576379, 4312.094460163401, 4322.675799315064, 4323.956760432356, 4335.913281734348, 4367.825286988485, 3731.6641502264924, 3802.619738026175, 3804.6766024887643, 3824.29250588642, 3923.156521347924, 5425.159100339453, 5505.339359276913, 5514.338279406497, 5601.915971260434, 5605.0751625982075, 5780.479756821906, 5818.098194779731, 5826.242588463558, 5826.271716035496, 5870.647761134345, 5547.916781248285, 5553.111502159635, 5556.138798486241, 5559.277293951841, 5562.527185189223, 4637.489876113625, 4637.86086417408, 4780.521947805261, 4792.688475249098, 4811.422629284508, 6068.939310606926, 6071.271447426248, 6071.726772295346, 6100.603460775035, 6114.938850611437, 5789.0, 5814.331351894417, 5822.563307752021, 5844.094165404369, 5857.58996870232, 5741.425857414225, 5783.363829978614, 5805.564582656402, 5985.191999080069, 6009.429104235091, 5618.073017951992, 5624.381318055092, 5656.915146272727, 5666.801661941977, 5756.30924289088, 5766.625169363978, 5781.4507621775865, 5781.682007489629, 5807.622504537191, 5808.535317174531, 5648.71756412186, 5679.801206957736, 5692.829215123553, 5703.315602127771, 5714.9142762857755, 5355.384130825005, 5448.482394172547, 5476.534494568006, 5482.862928426821, 5560.5829562783765, 5444.237806706985, 5469.316335458067, 5491.752871120889, 5553.194786755978, 5563.77596928675, 5478.91781623268, 5494.120940649477, 5517.5585953124455, 5551.111822108443, 5573.164025396223, 5455.236266922713, 5476.67139971603, 5514.834554963358, 5561.610687252015, 5570.164475328571], "value": 5275.7154400682075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.2034592262677, 587.4947545111205, 590.1030433740714, 591.8372447576916, 596.6330706615432, 26933.192004239878, 29018.419631607354, 34598.30803383934, 35487.46768798464, 35535.644643553554, 34570.827145864234, 34902.65097349026, 34962.0, 34985.47521787169, 35049.0, 6782.593044417326, 6883.967404889282, 6922.930770692279, 6938.306169383071, 6970.686319115626, 7090.71637134514, 7204.171520275183, 7208.56748595086, 7224.422046236288, 7252.0572325597595, 7173.928260717378, 7200.171980222263, 7269.527480713737, 7288.344049035612, 7293.38006269465, 7253.782386528413, 7257.346838784509, 7304.452166087538, 7312.1956584775635, 7332.890006649851, 7193.748218812369, 7197.280271972813, 7242.203357630657, 7253.093363329584, 7259.237780033073, 32958.0, 33156.50265246023, 33234.83382583096, 33242.33515329704, 33310.0, 3347.8828241011693, 3493.930121397583, 3503.2292895562937, 3591.7844929304324, 3673.687736542397, 22969.88515057414, 23313.650295245585, 23601.7639823603, 24217.515649686906, 24234.757652423603, 3103.4103520331064, 3106.2389714519863, 3133.6082989626298, 3156.621205455337, 3166.176794033545, 351873.0, 352139.0, 352402.0, 353039.0, 353815.23092384374, 57744.133837992464, 58364.708176458844, 58513.70743146257, 58555.0, 58764.7061764697, 62653.373466264755, 63020.0, 64055.35944640587, 64072.67963660245, 64085.0, 16344.427945021867, 16710.0, 16742.916285418738, 16762.329506819835, 16781.412650557173, 12644.494220231089, 12685.0, 12699.238045717286, 12704.745905081847, 12740.299283539494, 18311.40620920996, 18948.715769263472, 18971.24115035383, 18995.43013709591, 19251.903740481208, 3337.6495467975997, 6787.389134977876, 7139.0, 7161.856762864713, 7488.966968377816, 951.4529145741088, 984.4241118945354, 1004.3471743366724, 1072.5816931396762, 1088.4231357380602, 31308.53037204444, 31485.685143148734, 31650.841745791586, 31814.681853181635, 32084.0, 1082.4209048159198, 1094.956201751937, 1109.1514991031868, 1156.3119943633524, 1156.8322593223936, 16533.83466165347, 16660.16699165037, 16688.0, 16734.49796506107, 17023.829761702473, 469568.0, 469731.0, 469996.0, 471670.0, 471678.0, 53317.0, 53700.462995370326, 53780.46219537754, 53847.46152538424, 54164.0, 1318.4989703912643, 1347.8989075819352, 1367.0499003192685, 1367.6170672211995, 1379.558541266785, 29037.274068148465, 30052.24869378283, 30548.0, 30682.0, 30709.03967393245, 49349.25976110289, 49722.50277497323, 49828.0, 49858.0, 49861.0, 396208.0, 396569.0, 399012.0, 402470.9505809926, 403131.0, 26627.866860665574, 27072.593911090957, 27095.0, 27104.864475678285, 27179.86410067937, 41889.37165942574, 42215.0, 42563.93590160271, 43015.35476967911, 43678.0, 35918.0, 36789.0, 37210.25579488341, 37679.43480847844, 37916.43125353067, 36525.81737091298, 36880.63119368772, 36925.63074369222, 37112.44331334978, 37941.430878537394, 36662.8166859164, 37194.62805371912, 37269.627303726615, 37333.81333093317, 37480.437793433666, 29977.250568735082, 33586.83206583952, 33681.32637347288, 34793.47809782805, 34810.0, 26373.73626263713, 26388.0, 26475.470490590465, 26510.204693859214, 26812.59781103246], "value": 18216.270940960298, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.4507109761943, 393.6103257774803, 393.9212157568487, 396.47071160001394, 423.4918098282062, 14944.77582836257, 16071.919640401811, 16106.51680449587, 16134.273957671903, 16296.429624963128, 18192.636147277048, 18517.90741046293, 18780.62438751224, 19159.329423470183, 19166.808331916676, 4972.950270497294, 5197.428282888879, 5245.44922783108, 5249.448807875176, 5254.185601231815, 5000.52495012975, 5173.430922598511, 5181.844544663647, 5182.3262975813095, 5190.299309593213, 5106.872328191787, 5125.974370128163, 5154.871128221787, 5155.71643559604, 5174.042802081608, 4891.339669144673, 5072.163093089635, 5087.542121209109, 5104.183330667075, 5151.17581187012, 4648.279516674921, 4652.860414187579, 4664.230401983668, 4666.766661666937, 4667.299905014241, 19399.90300048505, 19846.1069251884, 20289.492762680904, 20438.79561204384, 20540.07569659369, 2360.7403185649564, 2449.9387515312083, 2481.900723971039, 2861.4420188063336, 2969.198316454545, 12121.0, 12712.555060572928, 12784.552540661125, 13111.737765244641, 13310.401031953585, 1684.0569281202443, 1719.7162468192732, 1773.813749556291, 1816.2644129127725, 1823.4256209294163, 74400.62799685966, 76838.23161768423, 77497.61251193708, 77967.64388273387, 78556.60721696413, 10176.796464070678, 10295.94852025735, 10329.40341548004, 10451.738706532398, 10792.298500597593, 14699.92650036743, 14767.483138090116, 14792.334344954503, 14794.630134246514, 14906.850931490546, 7811.921880781119, 8154.796130096795, 8182.590870456573, 8296.460730052528, 8367.665293388318, 7889.526628402315, 7952.443328966917, 8008.239217274349, 8206.876896846552, 8230.053543842416, 6260.24877014752, 6483.802782283869, 6503.28463868974, 6505.60966342021, 6508.837279067967, 1841.4291569613463, 1888.1220232591636, 1899.9620007599772, 1917.2331067573082, 1917.7027560728109, 901.6168128545341, 920.7375897869075, 996.7458298133929, 1018.3940555369543, 1043.6868939318326, 19233.326833560757, 19485.415437536896, 19561.315353962542, 19606.80393196078, 19997.300094496914, 983.6262220356361, 992.161623428202, 993.2302465589082, 1013.7009582173276, 1016.9338992965434, 9265.72202833916, 11014.173936954761, 11257.140574441823, 11341.206115571831, 11380.374079425712, 442468.0, 446976.0, 448981.0, 449607.0, 460206.0, 69666.0, 73398.0, 73790.26209737941, 74969.62515187389, 79965.20034799694, 953.7806304549854, 983.4246965525248, 1027.0, 1029.4749677664445, 1032.76762728387, 16365.372024329688, 16522.25649845736, 16939.32242710278, 17065.146742663066, 17615.471535853943, 39229.215415692095, 39615.80192099021, 40134.39798402968, 40675.389869152576, 41250.099976006146, 53989.460105400016, 54063.0, 57863.0, 57931.420685792604, 58983.11525327038, 7278.126624805057, 7480.887786683313, 7624.771256862303, 7828.099768526692, 8050.6779728812535, 12543.56097536582, 12797.232166070065, 12848.293343866177, 13048.54330098442, 13482.797758033834, 10858.891411085788, 10952.178586605876, 11110.333379997226, 11387.373694446886, 11462.713432164262, 11278.548858045586, 11471.885281147415, 11632.76734465289, 11647.30116193031, 11854.407279636156, 11447.885521144683, 11513.712157196138, 11565.826512602149, 11568.190226684388, 11858.881411185777, 7722.073351197668, 7903.723369682263, 7964.362850971793, 7977.641006154621, 8012.959935200287, 9702.320837541587, 10404.375737455777, 10689.0, 11316.623509063189, 11587.768244635228], "value": 8895.839874204572, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1459.044325966492, 1460.9853901460986, 1577.392703809034, 1687.6540309236607, 1716.948491545254, 7081.681324340404, 7374.1151061872515, 7551.187714948414, 7559.244075592438, 7622.428317876168, 7802.726904558342, 7939.48393354433, 7959.442839001258, 7964.880526792088, 7971.641276142573, 2034.1049938027295, 2060.0832629479887, 2060.2994981706215, 2074.8547601667888, 2077.1379877350882, 1957.168203513501, 1974.9012549372546, 1989.0452582760283, 2014.798520147988, 2016.3850025742142, 1938.7188857615638, 1946.3577019583574, 1953.9902300488477, 1954.6872500399938, 1968.3406058970263, 1994.670879304913, 2017.757869055708, 2024.1700902629998, 2026.1490174126902, 2029.1883246701364, 2013.124290933434, 2013.2852837242715, 2059.855810093294, 2060.5569802492387, 2062.360668192865, 7740.342070923978, 7790.45466817323, 7848.489848159908, 7851.21487851216, 7859.52842829432, 4756.429228492603, 4914.0908931847725, 4915.729634870081, 4937.037277730844, 4955.30625712397, 2932.574776657394, 3104.332568497784, 3121.750259979196, 3126.7342275906576, 3230.0, 943.9764005899839, 983.7442265011077, 1021.3769600543662, 1046.7749433871677, 1054.3041592548882, 10847.349159050404, 11031.282966607225, 11051.17116216279, 11060.502277397536, 11063.502142403611, 3967.1272320089533, 4214.515330736943, 4255.87232383029, 4278.7004909656025, 4296.441462609903, 8746.125387461203, 8746.56267186638, 8750.124987501198, 8754.69358572447, 8763.605637746317, 4859.562639362474, 4906.828261010847, 4917.311576379309, 4917.5082491751255, 4934.950650493521, 4030.0730831908827, 4214.136102099063, 4522.3668686383935, 4633.142868569325, 4669.229577119805, 3525.753197276217, 3561.661642143992, 3673.559172899269, 3681.337359275356, 3693.741438099361, 1163.96508104757, 1191.53530123252, 1206.927584344942, 1219.71336735867, 1240.8138779183196, 910.8178364327028, 918.3617385916857, 920.0983036624145, 934.0332755597924, 936.2507368640048, 5258.789648414021, 5450.563954883679, 5475.945240547543, 5491.203775452537, 5509.696966666872, 933.3373304953424, 934.1639232886529, 946.758576562972, 973.3575839945744, 988.1205726903062, 3563.982180089083, 3783.981080094637, 3829.310724069694, 3865.8260378283044, 3916.6475017248586, 9334.06659334061, 9576.521173941414, 9667.951660241653, 9676.080772326617, 9747.902520974842, 9387.436753794795, 9487.051294870596, 9489.051094890456, 9564.66523671682, 9652.179564736936, 7054.435645148375, 7353.558786472829, 7495.437842161859, 7508.361789247975, 7513.2862378074, 5058.0, 5267.841964741064, 5326.25432439451, 5341.0, 5634.52106570946, 8481.830363392573, 8724.825503490021, 8908.5991130398, 8953.418027828171, 9091.136342047495, 8826.117388261122, 8827.863161627685, 9141.0, 9196.12636799503, 9300.906990930003, 6901.827454313682, 7083.82290442743, 7203.891941620985, 7284.67218975158, 7332.266773322838, 7514.286142816423, 7561.7353392633195, 7584.241575842371, 7594.202608726005, 7664.616769161408, 6839.2818754032105, 6945.513814033171, 6957.860842783015, 6973.895391569232, 7193.928060719535, 6938.23679395256, 7018.368346848604, 7060.293970603104, 7083.610401427971, 7117.7152913882865, 6214.9067763984485, 6321.0, 6331.715072821827, 6389.041643753474, 6429.38920802523, 4680.882977925579, 4741.099191153669, 4758.357621721023, 4778.546038126373, 4833.275008748716, 4750.19246728064, 4781.832635857728, 4794.496577859414, 4876.731779752147, 4932.0], "value": 4206.211361363172, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.7249251889634, 333.54138060167264, 333.8230737709014, 344.33543261505315, 348.0342050809004, 5286.629935904488, 5406.459354064592, 5420.810271640498, 5469.179623056543, 5504.4495550444935, 5246.8688282792855, 5334.626576139662, 5391.813800963791, 5397.919031214535, 5422.186671999192, 4274.444322238105, 4287.571242875703, 4292.411807631165, 4304.354346847967, 4329.177456283312, 4195.643370313527, 4262.232798096342, 4267.743935363873, 4299.505556860954, 4316.309390497521, 4231.4499115114995, 4248.9575104249025, 4255.680823938202, 4261.382099595557, 4272.764997925113, 4264.25375559279, 4271.380649805761, 4274.166537525184, 4285.828566857337, 4295.52749197588, 3625.438057101127, 3686.2811751708427, 3699.7595156315024, 3699.8150092495266, 3835.8082095895093, 5205.245239440298, 5263.605229607795, 5294.523492885659, 5311.893762124736, 5353.57171426285, 4855.223164293696, 4855.5387238212315, 4864.756762161913, 4872.4640289568115, 4885.36490256268, 5496.0, 5641.279409780015, 5701.287339082614, 5707.315122185364, 5711.428857114255, 4110.794460277004, 4113.835446582133, 4126.381042843567, 4134.131832315217, 4152.335626299808, 5916.0, 5960.582759206857, 5965.4631083202285, 5970.0746384310505, 5974.193483879664, 4045.4627241648573, 4121.91756164875, 4136.358864376027, 4137.455464889072, 4147.0, 4180.366369187393, 4213.536510983789, 4217.840093974181, 4224.598663126998, 4240.257954857888, 4820.156472617348, 4844.006978569385, 4846.781894814671, 4855.732934688555, 4864.927026094611, 5651.4348565143155, 5651.841372518624, 5672.837068400968, 5742.052561327418, 5798.8550286242335, 1387.9236641984585, 1405.8734713875801, 1421.4527406948193, 1426.2013272567397, 1432.7277817214697, 938.7840796616816, 970.3450171134597, 977.941323520591, 981.6073570571829, 983.8622592837008, 5284.9917031527775, 5307.442718514578, 5326.680399176062, 5327.893442131136, 5339.422586866808, 5618.690971996498, 5632.690202038927, 5649.519790817744, 5706.942930570641, 5707.461373948096, 5170.560502357266, 5289.523942845162, 5318.574514038867, 5347.625666203407, 5380.300560927054, 2903.2596687844466, 2963.4517614241436, 2986.925326866846, 2995.3859458810894, 3003.2041509000132, 5718.0, 5743.339515955635, 5809.88380232393, 5828.542864283929, 5852.678102704393, 5446.828931779686, 5638.43615638441, 5658.207850900877, 5669.943300566942, 5697.971510142423, 5777.248957635565, 5808.215890854681, 5814.186013957965, 5823.417658234227, 5879.794207202727, 5613.764971706218, 5613.971930140323, 5674.517665998271, 5687.744051517774, 5868.38381969887, 5844.970775146097, 5845.09401042839, 5847.181394604674, 5874.559408044328, 5876.236089308362, 6099.176611157614, 6171.352008039271, 6192.318844927145, 6203.751849925952, 6216.627002379872, 3986.6810655146937, 4169.854055108057, 4188.0, 4205.747655140702, 4205.978970105252, 5824.242848429677, 5934.7922822701, 5949.0, 5963.880722385441, 5984.725804194378, 5807.245058142415, 5814.5348372130975, 5835.854103647443, 5839.532837372915, 5873.4126587340925, 5746.482816546531, 5772.249607550992, 5776.768929242783, 5783.15420245532, 5792.94207057924, 5633.971830140987, 5722.284714410699, 5770.855728606818, 5785.3636100028125, 5798.768049277982, 5835.0, 5840.912386314294, 5877.23595932526, 5913.10780550237, 5924.289085309791, 5391.514763671288, 5642.6614403135945, 5709.486146246858, 5740.454656807597, 5780.797672081457], "value": 4332.4353206350515, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [680.9591424514532, 686.5537400689552, 720.3408880874, 727.3017902813299, 732.6117157906311, 13496.122752021112, 13722.725545489084, 14166.220857852813, 14222.00445968784, 14411.711765764678, 12790.360481975911, 13006.73986520269, 13012.674683132902, 13025.413856376463, 13037.0, 761.931426171643, 769.1731388757108, 769.2576663519702, 770.0489894979696, 773.4740376543948, 755.4221020918974, 789.3842802613971, 791.4301702773994, 791.6041979010495, 795.0896223823747, 813.5322189740893, 817.2236375443323, 820.0118856777568, 822.48183644304, 822.7367242482408, 814.0678922633581, 814.2915663372903, 817.207308910356, 817.3134566963749, 818.3575892924026, 600.1238192239335, 600.2706711345736, 600.6726334147857, 601.0863487498978, 601.5278006764712, 11879.40602969848, 11914.0, 11937.34344611046, 11948.103892208032, 11966.521339146511, 10408.5836566538, 10438.164946804314, 10540.841887371696, 10726.946365268124, 10837.241393102486, 9368.110029547182, 9825.754356141082, 9912.306138570302, 10012.849807252896, 10057.446840423774, 3057.342671325676, 3084.7532197424375, 3085.336652619675, 3087.6449208341105, 3146.1033605422344, 58806.41193588095, 60351.0, 60621.0, 61038.694806526124, 61351.0, 8399.622017009127, 8541.871871921927, 8776.25401840838, 8785.297176225886, 8934.776630584287, 16348.0, 16397.0, 16443.0, 16454.341826326814, 16539.50381488557, 7920.564368959763, 7957.244061814118, 8042.075161356402, 8175.2233537815, 8251.793705157419, 4294.720843145185, 4402.361657559636, 4414.448193975753, 4421.46942366918, 4430.534793846664, 3263.7225835804225, 3363.024722830352, 3364.0580637421563, 3366.7474939379645, 3371.7302615790677, 596.239794262319, 610.3774150366601, 610.6000569626901, 611.9296280927662, 612.6018088242678, 539.2773683264445, 700.6846918886522, 709.8864181731002, 731.4075598765018, 747.7382915979364, 8584.48493090404, 9088.869052665184, 9202.0, 9286.210672092948, 9366.484843333683, 574.6437208930406, 603.0050416812295, 691.381213813634, 698.2982102986567, 737.0492065235786, 4156.189543039139, 4233.555476674905, 4477.7313361197785, 4493.662975276868, 4543.0, 85870.0, 85873.0, 88827.55586222156, 90469.0, 92635.53682231545, 72120.0, 76357.61821190859, 77085.0, 78274.0, 80160.59919700364, 67746.32253677498, 70553.64723176454, 70945.0, 71380.2861971384, 72550.27449725436, 8485.490870547786, 8513.914860851311, 8600.956995214983, 8798.868016979623, 9071.138241867013, 31534.925552113153, 33113.834430827694, 42033.159336813704, 45535.31697024481, 45733.77133114313, 59683.403165969525, 61409.385906140364, 61768.38231617626, 61947.38052619416, 63578.68210659102, 10390.948045260027, 10464.581416743245, 10681.8931810684, 11247.268927519684, 11733.237339572901, 11796.3512006837, 11842.407879606157, 12235.204711693712, 12335.75328493443, 13137.277449740355, 10961.342319460859, 11061.391623460788, 11126.0, 11290.774184516427, 11315.0, 11730.824037639271, 11741.412929353328, 11764.470598822902, 11773.882261177621, 11840.76318473643, 9992.550335234786, 10129.088382045356, 10135.898641013495, 10490.947545262225, 10526.52630631608, 8794.516301603473, 8983.910160898307, 9214.585343659417, 9310.534473276444, 9345.766355840886, 9206.217471514728, 9312.813743725223, 9318.62725491, 9351.812963740551, 9392.389494682824], "value": 6526.923756704802, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1526.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 111.0, 114.0, 111.0, 111.0, 113.0, 111.0, 111.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 128.0, 126.0, 168.0, 126.0, 129.0, 132.0, 131.0, 159.0, 132.0], "value": 139.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 168.0, 175.0, 164.0, 167.0, 162.0, 162.0, 163.0, 163.0], "value": 165.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 121.0, 77.0, 75.0, 76.0, 76.0, 112.0, 75.0], "value": 83.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 116.0, 82.0, 82.0, 83.0, 99.0, 82.0, 83.0, 104.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 119.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 53.0, 54.0, 52.0, 52.0, 55.0, 53.0, 53.0, 53.0, 53.0], "value": 53.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 69.0, 64.0, 62.0, 63.0, 62.0, 63.0, 66.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 91.0, 80.0, 85.0, 80.0, 81.0, 80.0, 80.0, 79.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 149.0, 131.0, 139.0, 132.0, 145.0, 133.0, 141.0, 178.0, 136.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 167.0, 170.0, 168.0, 164.0, 169.0, 171.0, 166.0, 168.0, 166.0], "value": 168.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 65.0, 71.0, 66.0, 67.0, 64.0, 63.0, 66.0], "value": 65.8, "unit": "score"}]}]} 00:50:23 INFO - Return code: 0 00:50:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:50:23 ERROR - # TBPL SUCCESS # 00:50:23 INFO - Running post-action listener: _resource_record_post_action 00:50:23 INFO - [mozharness: 2016-11-17 08:50:23.530389Z] Finished run-tests step (success) 00:50:23 INFO - Running post-run listener: _resource_record_post_run 00:50:23 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407109632; Read time: 16; Write time: 278828 00:50:23 INFO - TinderboxPrint: CPU usage
13.4% 00:50:23 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 00:50:23 INFO - TinderboxPrint: I/O write bytes / time
407,109,632 / 278,828 00:50:23 INFO - TinderboxPrint: CPU idle
8,261.5 (86.5%) 00:50:23 INFO - TinderboxPrint: CPU user
1,220.1 (12.8%) 00:50:23 INFO - TinderboxPrint: Swap in / out
0 / 0 00:50:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115474432; Read time: 0; Write time: 92448 00:50:23 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288079872; Read time: 0; Write time: 185524 00:50:24 INFO - Running post-run listener: _upload_blobber_files 00:50:24 INFO - Blob upload gear active. 00:50:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:50:24 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 00:50:24 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'] 00:50:24 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 00:50:24 INFO - (blobuploader) - INFO - Open directory for files ... 00:50:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 00:50:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:50:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:50:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 00:50:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:50:25 INFO - (blobuploader) - INFO - Done attempting. 00:50:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 00:50:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:50:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:50:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 00:50:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:50:26 INFO - (blobuploader) - INFO - Done attempting. 00:50:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:50:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:50:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:50:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:50:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:50:29 INFO - (blobuploader) - INFO - Done attempting. 00:50:29 INFO - (blobuploader) - INFO - Iteration through files over. 00:50:29 INFO - Return code: 0 00:50:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:50:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:50:29 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/482d6ff63a6b97f53512eb6721f147506a0ab5cbd995c9457c2a46a8d802cbb37687f2d1a9ee1f98b65404bc02b184dfb5efe50e36641aa9355c14525d0244fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/10f19b5ef50a7c350e4a280434f504933a98f3066c63e5941216ddd35b53855c4a39fd411d69ba760d305da70a86c35802342cdba4023ec1527e7c8edd752793", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6122e1cf868b801cdfd998788bb5a2fbc7361ff6ab2059e67252b704c0d1214a46733833d2cfcd41c8695051340c6f7b722bb3a537cd942916a591b8c396bb84"} 00:50:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:50:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:50:29 INFO - Contents: 00:50:29 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/482d6ff63a6b97f53512eb6721f147506a0ab5cbd995c9457c2a46a8d802cbb37687f2d1a9ee1f98b65404bc02b184dfb5efe50e36641aa9355c14525d0244fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/10f19b5ef50a7c350e4a280434f504933a98f3066c63e5941216ddd35b53855c4a39fd411d69ba760d305da70a86c35802342cdba4023ec1527e7c8edd752793", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6122e1cf868b801cdfd998788bb5a2fbc7361ff6ab2059e67252b704c0d1214a46733833d2cfcd41c8695051340c6f7b722bb3a537cd942916a591b8c396bb84"} 00:50:29 INFO - Running post-run listener: copy_logs_to_upload_dir 00:50:29 INFO - Copying logs to upload dir... 00:50:29 INFO - mkdir: /builds/slave/test/build/upload/logs 00:50:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.918412 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-17 00:50:29.662484) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 00:50:29.665761) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068 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/482d6ff63a6b97f53512eb6721f147506a0ab5cbd995c9457c2a46a8d802cbb37687f2d1a9ee1f98b65404bc02b184dfb5efe50e36641aa9355c14525d0244fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/10f19b5ef50a7c350e4a280434f504933a98f3066c63e5941216ddd35b53855c4a39fd411d69ba760d305da70a86c35802342cdba4023ec1527e7c8edd752793", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6122e1cf868b801cdfd998788bb5a2fbc7361ff6ab2059e67252b704c0d1214a46733833d2cfcd41c8695051340c6f7b722bb3a537cd942916a591b8c396bb84"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011722 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479360608/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/482d6ff63a6b97f53512eb6721f147506a0ab5cbd995c9457c2a46a8d802cbb37687f2d1a9ee1f98b65404bc02b184dfb5efe50e36641aa9355c14525d0244fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/10f19b5ef50a7c350e4a280434f504933a98f3066c63e5941216ddd35b53855c4a39fd411d69ba760d305da70a86c35802342cdba4023ec1527e7c8edd752793", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/6122e1cf868b801cdfd998788bb5a2fbc7361ff6ab2059e67252b704c0d1214a46733833d2cfcd41c8695051340c6f7b722bb3a537cd942916a591b8c396bb84"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-17 00:50:29.692127) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 00:50:29.692504) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1479369851.659788-629195068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004412 ========= master_lag: 0.93 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-17 00:50:30.622851) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 00:50:30.623201) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-17 00:50:30.627027) ========= ========= Total master_lag: 1.06 =========