builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-038 starttime: 1479253462.99 results: success (0) buildid: 20161115152722 builduid: b3946dfbb66e4677a04684d13f05ea40 revision: 9822e0525b82bcca19078eab6532c8972977a156 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:22.993362) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:22.994348) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:22.995069) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:23.010623) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:23.010937) ========= 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=8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-15 15:44:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-11-15 15:44:23 (221 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.346958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:23.373254) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:23.373632) ========= 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=8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018428 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:23.423404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 15:44:23.423774) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9822e0525b82bcca19078eab6532c8972977a156 --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 9822e0525b82bcca19078eab6532c8972977a156 --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=8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-15 15:44:23,561 truncating revision to first 12 chars 2016-11-15 15:44:23,561 Setting DEBUG logging. 2016-11-15 15:44:23,561 attempt 1/10 2016-11-15 15:44:23,561 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9822e0525b82?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-15 15:44:25,158 unpacking tar archive at: mozilla-inbound-9822e0525b82/testing/mozharness/ program finished with exit code 0 elapsedTime=1.884768 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-15 15:44:25.322835) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:25.323255) ========= script_repo_revision: 9822e0525b82bcca19078eab6532c8972977a156 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:25.323755) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:25.324105) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-15 15:44:25.335621) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-15 15:44:25.336174) ========= /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=8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:44:25 INFO - MultiFileLogger online at 20161115 15:44:25 in /builds/slave/test 15:44:25 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 15:44:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:44:25 INFO - {'append_to_log': False, 15:44:25 INFO - 'base_work_dir': '/builds/slave/test', 15:44:25 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:44:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:44:25 INFO - 'branch': 'Mozilla-Inbound', 15:44:25 INFO - 'buildbot_json_path': 'buildprops.json', 15:44:25 INFO - 'config_files': ('talos/linux_config.py',), 15:44:25 INFO - 'default_actions': ('clobber', 15:44:25 INFO - 'read-buildbot-config', 15:44:25 INFO - 'download-and-extract', 15:44:25 INFO - 'populate-webroot', 15:44:25 INFO - 'create-virtualenv', 15:44:25 INFO - 'install', 15:44:25 INFO - 'run-tests'), 15:44:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:44:25 INFO - 'download_minidump_stackwalk': True, 15:44:25 INFO - 'download_symbols': 'ondemand', 15:44:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:44:25 INFO - 'tooltool.py': '/tools/tooltool.py', 15:44:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:44:25 INFO - '/tools/misc-python/virtualenv.py')}, 15:44:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:44:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:44:25 INFO - 'installer_path': 'installer.exe', 15:44:25 INFO - 'log_level': 'info', 15:44:25 INFO - 'log_name': 'talos', 15:44:25 INFO - 'log_to_console': True, 15:44:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:44:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:44:25 INFO - 'opt_config_files': (), 15:44:25 INFO - 'pip_index': False, 15:44:25 INFO - 'sps_profile': False, 15:44:25 INFO - 'sps_profile_interval': 0, 15:44:25 INFO - 'suite': 'dromaeojs-e10s', 15:44:25 INFO - 'system_bits': '32', 15:44:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:44:25 INFO - 'title': 'talos-linux64-ix-038', 15:44:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:44:25 INFO - 'use_talos_json': True, 15:44:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:44:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:44:25 INFO - 'work_dir': 'build'} 15:44:25 INFO - [mozharness: 2016-11-15 23:44:25.569629Z] Running clobber step. 15:44:25 INFO - Running pre-action listener: _resource_record_pre_action 15:44:25 INFO - Running main action method: clobber 15:44:25 INFO - rmtree: /builds/slave/test/build 15:44:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:44:26 INFO - Running post-action listener: _resource_record_post_action 15:44:26 INFO - [mozharness: 2016-11-15 23:44:26.543647Z] Finished clobber step (success) 15:44:26 INFO - [mozharness: 2016-11-15 23:44:26.543744Z] Running read-buildbot-config step. 15:44:26 INFO - Running pre-action listener: _resource_record_pre_action 15:44:26 INFO - Running main action method: read_buildbot_config 15:44:26 INFO - Using buildbot properties: 15:44:26 INFO - { 15:44:26 INFO - "project": "", 15:44:26 INFO - "product": "firefox", 15:44:26 INFO - "script_repo_revision": "production", 15:44:26 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:44:26 INFO - "repository": "", 15:44:26 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:44:26 INFO - "buildid": "20161115152722", 15:44:26 INFO - "stage_platform": "linux64-pgo", 15:44:26 INFO - "basedir": "/builds/slave/test", 15:44:26 INFO - "buildnumber": 2074, 15:44:26 INFO - "platform": "ubuntu64_hw", 15:44:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:44:26 INFO - "slavebuilddir": "test", 15:44:26 INFO - "branch": "mozilla-inbound", 15:44:26 INFO - "revision": "9822e0525b82bcca19078eab6532c8972977a156", 15:44:26 INFO - "slavename": "talos-linux64-ix-038", 15:44:26 INFO - "builduid": "b3946dfbb66e4677a04684d13f05ea40", 15:44:26 INFO - "repo_path": "integration/mozilla-inbound" 15:44:26 INFO - } 15:44:26 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 15:44:26 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.test_packages.json. 15:44:26 INFO - Running post-action listener: _resource_record_post_action 15:44:26 INFO - [mozharness: 2016-11-15 23:44:26.546079Z] Finished read-buildbot-config step (success) 15:44:26 INFO - [mozharness: 2016-11-15 23:44:26.546165Z] Running download-and-extract step. 15:44:26 INFO - Running pre-action listener: _resource_record_pre_action 15:44:26 INFO - Running main action method: download_and_extract 15:44:26 INFO - mkdir: /builds/slave/test/build/tests 15:44:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:26 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:44:26 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/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 15:44:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/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 15:44:26 INFO - Downloaded 1361 bytes. 15:44:26 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 15:44:26 INFO - Using the following test package requirements: 15:44:26 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:26 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:44:26 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:44:26 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:26 INFO - u'jsshell-linux-x86_64.zip'], 15:44:26 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:44:26 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 15:44:26 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:44:26 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:44:26 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:44:26 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 15:44:26 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:44:26 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:44:26 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/1479242106/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:44:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:44:26 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:44:26 INFO - Http code: 200 15:44:26 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 15:44:26 INFO - x-amz-cf-id: XWwVyA9lXr66HOlsGDcLx-fVh-yGGpclgk2wqkNDNcvY3jqP85KIGA== 15:44:26 INFO - x-amz-replication-status: COMPLETED 15:44:26 INFO - x-amz-version-id: M_gW6MYG2mW8vtfzlTeaxNbgaLKg0867 15:44:26 INFO - Expected file size: 21977131 15:44:26 INFO - Obtained file size: 21977131 15:44:31 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 15:44:31 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/1479242106/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 15:44:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:44:31 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 15:44:31 INFO - Http code: 200 15:44:31 INFO - via: 1.1 7f9e159e8ac7593f5d3d995abc6d2db3.cloudfront.net (CloudFront) 15:44:31 INFO - x-amz-cf-id: AwDiLY5EZBic-mT_Zwl-9lYVxA0UGl1r4mHmGAN1NxX_RYyx3W46HA== 15:44:31 INFO - x-amz-replication-status: COMPLETED 15:44:31 INFO - x-amz-version-id: M_gW6MYG2mW8vtfzlTeaxNbgaLKg0867 15:44:31 INFO - Expected file size: 21977131 15:44:31 INFO - Obtained file size: 21977131 15:44:36 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/1479242106/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 15:44:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:44:36 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 15:44:36 INFO - Http code: 200 15:44:36 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 15:44:36 INFO - x-amz-cf-id: DzoVEict558EPS6ls3RSZLyJiNh0Pp5QDMSB8xOoVoxHcX4kBQsU5g== 15:44:36 INFO - x-amz-replication-status: COMPLETED 15:44:36 INFO - x-amz-version-id: 1vGUclcTGZaDtsT71mY7tRR1y8af2L96 15:44:36 INFO - Expected file size: 14409038 15:44:36 INFO - Obtained file size: 14409038 15:44:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:36 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:44:36 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/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 15:44:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/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 15:44:37 INFO - Downloaded 59519083 bytes. 15:44:37 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:44:37 INFO - mkdir: /builds/slave/test/properties 15:44:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:44:37 INFO - Writing to file /builds/slave/test/properties/build_url 15:44:37 INFO - Contents: 15:44:37 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 15:44:37 INFO - Running post-action listener: _resource_record_post_action 15:44:37 INFO - Running post-action listener: set_extra_try_arguments 15:44:37 INFO - [mozharness: 2016-11-15 23:44:37.559818Z] Finished download-and-extract step (success) 15:44:37 INFO - [mozharness: 2016-11-15 23:44:37.560045Z] Running populate-webroot step. 15:44:37 INFO - Running pre-action listener: _resource_record_pre_action 15:44:37 INFO - Running main action method: populate_webroot 15:44:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:44:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:44:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:44:37 INFO - '--tppagecycles', 15:44:37 INFO - '7'], 15:44:37 INFO - 'tests': ['tsvgm']}}, 15:44:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:44:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:44:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:44:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:44:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:37 INFO - 'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:44:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:37 INFO - 'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['damp', 'tps']}, 15:44:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:37 INFO - 'tests': ['damp', 'tps']}, 15:44:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['dromaeo_dom']}, 15:44:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:44:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['basic_compositor_video']}, 15:44:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:44:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['a11yr', 15:44:37 INFO - 'ts_paint', 15:44:37 INFO - 'tpaint', 15:44:37 INFO - 'sessionrestore', 15:44:37 INFO - 'sessionrestore_no_auto_restore', 15:44:37 INFO - 'tabpaint']}, 15:44:37 INFO - 'other-e10s': {'tests': ['a11yr', 15:44:37 INFO - 'ts_paint', 15:44:37 INFO - 'tpaint', 15:44:37 INFO - 'sessionrestore', 15:44:37 INFO - 'sessionrestore_no_auto_restore', 15:44:37 INFO - 'tabpaint']}, 15:44:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:44:37 INFO - 'ts_paint', 15:44:37 INFO - 'tpaint', 15:44:37 INFO - 'sessionrestore', 15:44:37 INFO - 'sessionrestore_no_auto_restore', 15:44:37 INFO - 'tabpaint']}, 15:44:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:44:37 INFO - 'ts_paint', 15:44:37 INFO - 'tpaint', 15:44:37 INFO - 'sessionrestore', 15:44:37 INFO - 'sessionrestore_no_auto_restore', 15:44:37 INFO - 'tabpaint']}, 15:44:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['a11yr', 15:44:37 INFO - 'ts_paint', 15:44:37 INFO - 'tpaint', 15:44:37 INFO - 'sessionrestore', 15:44:37 INFO - 'sessionrestore_no_auto_restore', 15:44:37 INFO - 'tabpaint']}, 15:44:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['a11yr', 15:44:37 INFO - 'ts_paint', 15:44:37 INFO - 'tpaint', 15:44:37 INFO - 'sessionrestore', 15:44:37 INFO - 'sessionrestore_no_auto_restore', 15:44:37 INFO - 'tabpaint']}, 15:44:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['tsvgx', 15:44:37 INFO - 'tsvgr_opacity', 15:44:37 INFO - 'tart', 15:44:37 INFO - 'tscrollx', 15:44:37 INFO - 'cart']}, 15:44:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:44:37 INFO - 'tsvgr_opacity', 15:44:37 INFO - 'tart', 15:44:37 INFO - 'tscrollx', 15:44:37 INFO - 'cart']}, 15:44:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:37 INFO - 'talos_options': ['--disable-e10s'], 15:44:37 INFO - 'tests': ['tp5o']}, 15:44:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:37 INFO - 'tests': ['tp5o']}, 15:44:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:37 INFO - 'talos_options': ['--disable-e10s', 15:44:37 INFO - '--xperf_path', 15:44:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:37 INFO - 'tests': ['tp5n']}, 15:44:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:44:37 INFO - 'talos_options': ['--xperf_path', 15:44:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:44:37 INFO - 'tests': ['tp5n']}}, 15:44:37 INFO - 'talos.zip': {'path': '', 15:44:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:44:37 INFO - Running post-action listener: _resource_record_post_action 15:44:37 INFO - [mozharness: 2016-11-15 23:44:37.576674Z] Finished populate-webroot step (success) 15:44:37 INFO - [mozharness: 2016-11-15 23:44:37.576761Z] Running create-virtualenv step. 15:44:37 INFO - Running pre-action listener: _resource_record_pre_action 15:44:37 INFO - Running main action method: create_virtualenv 15:44:37 INFO - Creating virtualenv /builds/slave/test/build/venv 15:44:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:44:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:44:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:44:37 INFO - Using real prefix '/usr' 15:44:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:44:38 INFO - Installing distribute.............................................................................................................................................................................................done. 15:44:40 INFO - Installing pip.................done. 15:44:40 INFO - Return code: 0 15:44:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:44:40 INFO - Reading from file tmpfile_stdout 15:44:40 INFO - Output received: 15:44:40 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:44:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:40 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 0x7f838815bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd40ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, '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': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:44:40 INFO - Using env: {'DISPLAY': ':0', 15:44:40 INFO - 'HOME': '/home/cltbld', 15:44:40 INFO - 'LANG': 'en_US.UTF-8', 15:44:40 INFO - 'LANGUAGE': 'en_US:en', 15:44:40 INFO - 'LOGNAME': 'cltbld', 15:44:40 INFO - 'MAIL': '/var/mail/cltbld', 15:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:40 INFO - 'MOZ_NO_REMOTE': '1', 15:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:40 INFO - 'NO_EM_RESTART': '1', 15:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:40 INFO - 'PWD': '/builds/slave/test', 15:44:40 INFO - 'SHELL': '/bin/bash', 15:44:40 INFO - 'SHLVL': '1', 15:44:40 INFO - 'TERM': 'linux', 15:44:40 INFO - 'TMOUT': '86400', 15:44:40 INFO - 'USER': 'cltbld', 15:44:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:40 INFO - '_': '/tools/buildbot/bin/python'} 15:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:44:40 INFO - Cleaning up... 15:44:40 INFO - Return code: 0 15:44:40 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:40 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 0x7f838815bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd40ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, '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': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:44:40 INFO - Using env: {'DISPLAY': ':0', 15:44:40 INFO - 'HOME': '/home/cltbld', 15:44:40 INFO - 'LANG': 'en_US.UTF-8', 15:44:40 INFO - 'LANGUAGE': 'en_US:en', 15:44:40 INFO - 'LOGNAME': 'cltbld', 15:44:40 INFO - 'MAIL': '/var/mail/cltbld', 15:44:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:40 INFO - 'MOZ_NO_REMOTE': '1', 15:44:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:40 INFO - 'NO_EM_RESTART': '1', 15:44:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:40 INFO - 'PWD': '/builds/slave/test', 15:44:40 INFO - 'SHELL': '/bin/bash', 15:44:40 INFO - 'SHLVL': '1', 15:44:40 INFO - 'TERM': 'linux', 15:44:40 INFO - 'TMOUT': '86400', 15:44:40 INFO - 'USER': 'cltbld', 15:44:40 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:44:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:40 INFO - '_': '/tools/buildbot/bin/python'} 15:44:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:40 INFO - Downloading/unpacking psutil>=3.1.1 15:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:44:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:42 INFO - Installing collected packages: psutil 15:44:42 INFO - Running setup.py install for psutil 15:44:42 INFO - building 'psutil._psutil_linux' extension 15:44:42 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:44:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:44:43 INFO - building 'psutil._psutil_posix' extension 15:44:43 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:44:43 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:44:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:44:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:44:43 INFO - Successfully installed psutil 15:44:43 INFO - Cleaning up... 15:44:43 INFO - Return code: 0 15:44:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f838815bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd40ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, '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': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:44:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:44:43 INFO - Using env: {'DISPLAY': ':0', 15:44:43 INFO - 'HOME': '/home/cltbld', 15:44:43 INFO - 'LANG': 'en_US.UTF-8', 15:44:43 INFO - 'LANGUAGE': 'en_US:en', 15:44:43 INFO - 'LOGNAME': 'cltbld', 15:44:43 INFO - 'MAIL': '/var/mail/cltbld', 15:44:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:43 INFO - 'MOZ_NO_REMOTE': '1', 15:44:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:43 INFO - 'NO_EM_RESTART': '1', 15:44:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:43 INFO - 'PWD': '/builds/slave/test', 15:44:43 INFO - 'SHELL': '/bin/bash', 15:44:43 INFO - 'SHLVL': '1', 15:44:43 INFO - 'TERM': 'linux', 15:44:43 INFO - 'TMOUT': '86400', 15:44:43 INFO - 'USER': 'cltbld', 15:44:43 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:44:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:43 INFO - '_': '/tools/buildbot/bin/python'} 15:44:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:44:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:44:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:44:45 INFO - Installing collected packages: mozsystemmonitor 15:44:45 INFO - Running setup.py install for mozsystemmonitor 15:44:45 INFO - Successfully installed mozsystemmonitor 15:44:45 INFO - Cleaning up... 15:44:45 INFO - Return code: 0 15:44:45 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f838815bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd40ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, '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': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:44:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:44:45 INFO - Using env: {'DISPLAY': ':0', 15:44:45 INFO - 'HOME': '/home/cltbld', 15:44:45 INFO - 'LANG': 'en_US.UTF-8', 15:44:45 INFO - 'LANGUAGE': 'en_US:en', 15:44:45 INFO - 'LOGNAME': 'cltbld', 15:44:45 INFO - 'MAIL': '/var/mail/cltbld', 15:44:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:45 INFO - 'MOZ_NO_REMOTE': '1', 15:44:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:45 INFO - 'NO_EM_RESTART': '1', 15:44:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:45 INFO - 'PWD': '/builds/slave/test', 15:44:45 INFO - 'SHELL': '/bin/bash', 15:44:45 INFO - 'SHLVL': '1', 15:44:45 INFO - 'TERM': 'linux', 15:44:45 INFO - 'TMOUT': '86400', 15:44:45 INFO - 'USER': 'cltbld', 15:44:45 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:44:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:45 INFO - '_': '/tools/buildbot/bin/python'} 15:44:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:45 INFO - Downloading/unpacking jsonschema==2.5.1 15:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:44:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:48 INFO - Downloading functools32-3.2.3-2.tar.gz 15:44:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:44:48 INFO - warning: no files found matching '*.txt' 15:44:48 INFO - no previously-included directories found matching 'build' 15:44:48 INFO - no previously-included directories found matching 'dist' 15:44:48 INFO - no previously-included directories found matching '.git*' 15:44:48 INFO - Installing collected packages: jsonschema, functools32 15:44:48 INFO - Running setup.py install for functools32 15:44:48 INFO - warning: no files found matching '*.txt' 15:44:48 INFO - no previously-included directories found matching 'build' 15:44:48 INFO - no previously-included directories found matching 'dist' 15:44:48 INFO - no previously-included directories found matching '.git*' 15:44:48 INFO - Successfully installed jsonschema functools32 15:44:48 INFO - Cleaning up... 15:44:48 INFO - Return code: 0 15:44:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f838815bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd40ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, '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': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:44:48 INFO - Using env: {'DISPLAY': ':0', 15:44:48 INFO - 'HOME': '/home/cltbld', 15:44:48 INFO - 'LANG': 'en_US.UTF-8', 15:44:48 INFO - 'LANGUAGE': 'en_US:en', 15:44:48 INFO - 'LOGNAME': 'cltbld', 15:44:48 INFO - 'MAIL': '/var/mail/cltbld', 15:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:48 INFO - 'MOZ_NO_REMOTE': '1', 15:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:48 INFO - 'NO_EM_RESTART': '1', 15:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:48 INFO - 'PWD': '/builds/slave/test', 15:44:48 INFO - 'SHELL': '/bin/bash', 15:44:48 INFO - 'SHLVL': '1', 15:44:48 INFO - 'TERM': 'linux', 15:44:48 INFO - 'TMOUT': '86400', 15:44:48 INFO - 'USER': 'cltbld', 15:44:48 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:48 INFO - '_': '/tools/buildbot/bin/python'} 15:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:44:48 INFO - Cleaning up... 15:44:48 INFO - Return code: 0 15:44:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f838815bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd40ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, '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': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:44:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:44:48 INFO - Using env: {'DISPLAY': ':0', 15:44:48 INFO - 'HOME': '/home/cltbld', 15:44:48 INFO - 'LANG': 'en_US.UTF-8', 15:44:48 INFO - 'LANGUAGE': 'en_US:en', 15:44:48 INFO - 'LOGNAME': 'cltbld', 15:44:48 INFO - 'MAIL': '/var/mail/cltbld', 15:44:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:48 INFO - 'MOZ_NO_REMOTE': '1', 15:44:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:48 INFO - 'NO_EM_RESTART': '1', 15:44:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:48 INFO - 'PWD': '/builds/slave/test', 15:44:48 INFO - 'SHELL': '/bin/bash', 15:44:48 INFO - 'SHLVL': '1', 15:44:48 INFO - 'TERM': 'linux', 15:44:48 INFO - 'TMOUT': '86400', 15:44:48 INFO - 'USER': 'cltbld', 15:44:48 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:44:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:48 INFO - '_': '/tools/buildbot/bin/python'} 15:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:48 INFO - Downloading/unpacking blobuploader==1.2.4 15:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:50 INFO - Downloading blobuploader-1.2.4.tar.gz 15:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:44:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:44:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:51 INFO - Downloading docopt-0.6.1.tar.gz 15:44:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:44:51 INFO - Installing collected packages: blobuploader, requests, docopt 15:44:51 INFO - Running setup.py install for blobuploader 15:44:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:44:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:44:51 INFO - Running setup.py install for requests 15:44:52 INFO - Running setup.py install for docopt 15:44:52 INFO - Successfully installed blobuploader requests docopt 15:44:52 INFO - Cleaning up... 15:44:52 INFO - Return code: 0 15:44:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:52 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 0x7f838815bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd40ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, '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': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:44:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:44:52 INFO - Using env: {'DISPLAY': ':0', 15:44:52 INFO - 'HOME': '/home/cltbld', 15:44:52 INFO - 'LANG': 'en_US.UTF-8', 15:44:52 INFO - 'LANGUAGE': 'en_US:en', 15:44:52 INFO - 'LOGNAME': 'cltbld', 15:44:52 INFO - 'MAIL': '/var/mail/cltbld', 15:44:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:52 INFO - 'MOZ_NO_REMOTE': '1', 15:44:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:52 INFO - 'NO_EM_RESTART': '1', 15:44:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:52 INFO - 'PWD': '/builds/slave/test', 15:44:52 INFO - 'SHELL': '/bin/bash', 15:44:52 INFO - 'SHLVL': '1', 15:44:52 INFO - 'TERM': 'linux', 15:44:52 INFO - 'TMOUT': '86400', 15:44:52 INFO - 'USER': 'cltbld', 15:44:52 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:44:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:52 INFO - '_': '/tools/buildbot/bin/python'} 15:44:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:52 INFO - Running setup.py (path:/tmp/pip-vu0jPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:52 INFO - Running setup.py (path:/tmp/pip-OQSJnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:52 INFO - Running setup.py (path:/tmp/pip-AM0GeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:52 INFO - Running setup.py (path:/tmp/pip-8G1rD_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:52 INFO - Running setup.py (path:/tmp/pip-jx4F0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:52 INFO - Running setup.py (path:/tmp/pip-JgdMPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:52 INFO - Running setup.py (path:/tmp/pip-pDhGXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:52 INFO - Running setup.py (path:/tmp/pip-18pTXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:52 INFO - Running setup.py (path:/tmp/pip-cUH5G8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:53 INFO - Running setup.py (path:/tmp/pip-oCkNa_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:53 INFO - Running setup.py (path:/tmp/pip-FDzEIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:53 INFO - Running setup.py (path:/tmp/pip-HFh4f2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:53 INFO - Running setup.py (path:/tmp/pip-ezT9AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:53 INFO - Running setup.py (path:/tmp/pip-I92_wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:53 INFO - Running setup.py (path:/tmp/pip-JtMf2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:53 INFO - Running setup.py (path:/tmp/pip-4GSIS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:53 INFO - Running setup.py (path:/tmp/pip-OAUTu9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:44:53 INFO - Running setup.py install for manifestparser 15:44:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:44:53 INFO - Running setup.py install for mozcrash 15:44:53 INFO - Running setup.py install for mozdebug 15:44:53 INFO - Running setup.py install for mozdevice 15:44:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Running setup.py install for mozfile 15:44:54 INFO - Running setup.py install for mozhttpd 15:44:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Running setup.py install for mozinfo 15:44:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Running setup.py install for mozInstall 15:44:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Running setup.py install for mozleak 15:44:54 INFO - Running setup.py install for mozlog 15:44:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Running setup.py install for moznetwork 15:44:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Running setup.py install for mozprocess 15:44:54 INFO - Running setup.py install for mozprofile 15:44:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:44:54 INFO - Running setup.py install for mozrunner 15:44:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:44:55 INFO - Running setup.py install for mozscreenshot 15:44:55 INFO - Running setup.py install for moztest 15:44:55 INFO - Running setup.py install for mozversion 15:44:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:44:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:44:55 INFO - Cleaning up... 15:44:55 INFO - Return code: 0 15:44:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:55 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 0x7f838815bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd40ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, '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': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:44:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:44:55 INFO - Using env: {'DISPLAY': ':0', 15:44:55 INFO - 'HOME': '/home/cltbld', 15:44:55 INFO - 'LANG': 'en_US.UTF-8', 15:44:55 INFO - 'LANGUAGE': 'en_US:en', 15:44:55 INFO - 'LOGNAME': 'cltbld', 15:44:55 INFO - 'MAIL': '/var/mail/cltbld', 15:44:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:55 INFO - 'MOZ_NO_REMOTE': '1', 15:44:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:55 INFO - 'NO_EM_RESTART': '1', 15:44:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:55 INFO - 'PWD': '/builds/slave/test', 15:44:55 INFO - 'SHELL': '/bin/bash', 15:44:55 INFO - 'SHLVL': '1', 15:44:55 INFO - 'TERM': 'linux', 15:44:55 INFO - 'TMOUT': '86400', 15:44:55 INFO - 'USER': 'cltbld', 15:44:55 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:44:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:55 INFO - '_': '/tools/buildbot/bin/python'} 15:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:44:55 INFO - Running setup.py (path:/tmp/pip-2yqB6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:44:55 INFO - Running setup.py (path:/tmp/pip-mIEOAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:44:55 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)) 15:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:44:55 INFO - Running setup.py (path:/tmp/pip-XGrHxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:44:55 INFO - Running setup.py (path:/tmp/pip-gwRfpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:44:55 INFO - Running setup.py (path:/tmp/pip-9EJMlA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:44:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:44:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:44:55 INFO - Running setup.py (path:/tmp/pip-nt6q1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:44:56 INFO - Running setup.py (path:/tmp/pip-i00E5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:44:56 INFO - Running setup.py (path:/tmp/pip-jDJwIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:44:56 INFO - Running setup.py (path:/tmp/pip-w2OR42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:44:56 INFO - Running setup.py (path:/tmp/pip-DzCul4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:44:56 INFO - Running setup.py (path:/tmp/pip-ep5vmW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:44:56 INFO - Running setup.py (path:/tmp/pip-lH0GPc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:44:56 INFO - Running setup.py (path:/tmp/pip-8clVWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:44:56 INFO - Running setup.py (path:/tmp/pip-DRMB87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:44:56 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)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:56 INFO - Running setup.py (path:/tmp/pip-9EmLNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:44:56 INFO - Running setup.py (path:/tmp/pip-8bhjVg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:44:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:44:56 INFO - Running setup.py (path:/tmp/pip-RqKVTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:44:56 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)) 15:44:56 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)) 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:44:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:44:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:44:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:44:58 INFO - Downloading blessings-1.6.tar.gz 15:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:44:58 INFO - Installing collected packages: blessings 15:44:58 INFO - Running setup.py install for blessings 15:44:58 INFO - Successfully installed blessings 15:44:58 INFO - Cleaning up... 15:44:59 INFO - Return code: 0 15:44:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:59 INFO - Reading from file tmpfile_stdout 15:44:59 INFO - Current package versions: 15:44:59 INFO - argparse == 1.2.1 15:44:59 INFO - blessings == 1.6 15:44:59 INFO - blobuploader == 1.2.4 15:44:59 INFO - docopt == 0.6.1 15:44:59 INFO - functools32 == 3.2.3-2 15:44:59 INFO - jsonschema == 2.5.1 15:44:59 INFO - manifestparser == 1.1 15:44:59 INFO - mozInstall == 1.12 15:44:59 INFO - mozcrash == 1.0 15:44:59 INFO - mozdebug == 0.1 15:44:59 INFO - mozdevice == 0.48 15:44:59 INFO - mozfile == 1.2 15:44:59 INFO - mozhttpd == 0.7 15:44:59 INFO - mozinfo == 0.9 15:44:59 INFO - mozleak == 0.1 15:44:59 INFO - mozlog == 3.4 15:44:59 INFO - moznetwork == 0.27 15:44:59 INFO - mozprocess == 0.23 15:44:59 INFO - mozprofile == 0.28 15:44:59 INFO - mozrunner == 6.13 15:44:59 INFO - mozscreenshot == 0.1 15:44:59 INFO - mozsystemmonitor == 0.3 15:44:59 INFO - moztest == 0.7 15:44:59 INFO - mozversion == 1.4 15:44:59 INFO - psutil == 3.1.1 15:44:59 INFO - requests == 1.2.3 15:44:59 INFO - wsgiref == 0.1.2 15:44:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 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 0x7f838815bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd40ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, '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': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:44:59 INFO - Using env: {'DISPLAY': ':0', 15:44:59 INFO - 'HOME': '/home/cltbld', 15:44:59 INFO - 'LANG': 'en_US.UTF-8', 15:44:59 INFO - 'LANGUAGE': 'en_US:en', 15:44:59 INFO - 'LOGNAME': 'cltbld', 15:44:59 INFO - 'MAIL': '/var/mail/cltbld', 15:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:59 INFO - 'MOZ_NO_REMOTE': '1', 15:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:59 INFO - 'NO_EM_RESTART': '1', 15:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:59 INFO - 'PWD': '/builds/slave/test', 15:44:59 INFO - 'SHELL': '/bin/bash', 15:44:59 INFO - 'SHLVL': '1', 15:44:59 INFO - 'TERM': 'linux', 15:44:59 INFO - 'TMOUT': '86400', 15:44:59 INFO - 'USER': 'cltbld', 15:44:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:59 INFO - '_': '/tools/buildbot/bin/python'} 15:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:44:59 INFO - Cleaning up... 15:44:59 INFO - Return code: 0 15:44:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:44:59 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 0x7f838815bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xc738a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd40ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, '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': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:44:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:44:59 INFO - Using env: {'DISPLAY': ':0', 15:44:59 INFO - 'HOME': '/home/cltbld', 15:44:59 INFO - 'LANG': 'en_US.UTF-8', 15:44:59 INFO - 'LANGUAGE': 'en_US:en', 15:44:59 INFO - 'LOGNAME': 'cltbld', 15:44:59 INFO - 'MAIL': '/var/mail/cltbld', 15:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:44:59 INFO - 'MOZ_NO_REMOTE': '1', 15:44:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:44:59 INFO - 'NO_EM_RESTART': '1', 15:44:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:44:59 INFO - 'PWD': '/builds/slave/test', 15:44:59 INFO - 'SHELL': '/bin/bash', 15:44:59 INFO - 'SHLVL': '1', 15:44:59 INFO - 'TERM': 'linux', 15:44:59 INFO - 'TMOUT': '86400', 15:44:59 INFO - 'USER': 'cltbld', 15:44:59 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:44:59 INFO - '_': '/tools/buildbot/bin/python'} 15:44:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:44:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:44:59 INFO - Cleaning up... 15:44:59 INFO - Return code: 0 15:44:59 INFO - Running post-action listener: _resource_record_post_action 15:44:59 INFO - Running post-action listener: _start_resource_monitoring 15:44:59 INFO - Starting resource monitoring. 15:44:59 INFO - [mozharness: 2016-11-15 23:44:59.756055Z] Finished create-virtualenv step (success) 15:44:59 INFO - [mozharness: 2016-11-15 23:44:59.756510Z] Running install step. 15:44:59 INFO - Running pre-action listener: _resource_record_pre_action 15:44:59 INFO - Running main action method: install 15:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:44:59 INFO - Reading from file tmpfile_stdout 15:44:59 INFO - Detecting whether we're running mozinstall >=1.0... 15:44:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:44:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:45:00 INFO - Reading from file tmpfile_stdout 15:45:00 INFO - Output received: 15:45:00 INFO - Usage: mozinstall [options] installer 15:45:00 INFO - Options: 15:45:00 INFO - -h, --help show this help message and exit 15:45:00 INFO - -d DEST, --destination=DEST 15:45:00 INFO - Directory to install application into. [default: 15:45:00 INFO - "/builds/slave/test"] 15:45:00 INFO - --app=APP Application being installed. [default: firefox] 15:45:00 INFO - mkdir: /builds/slave/test/build/application 15:45:00 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'] 15:45:00 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 15:45:16 INFO - Reading from file tmpfile_stdout 15:45:16 INFO - Output received: 15:45:16 INFO - /builds/slave/test/build/application/firefox/firefox 15:45:16 INFO - Running post-action listener: _resource_record_post_action 15:45:16 INFO - [mozharness: 2016-11-15 23:45:16.965930Z] Finished install step (success) 15:45:16 INFO - [mozharness: 2016-11-15 23:45:16.966204Z] Running run-tests step. 15:45:16 INFO - Running pre-action listener: _resource_record_pre_action 15:45:16 INFO - Running main action method: run_tests 15:45:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:45:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:45:16 INFO - Python 2.7.3 15:45:16 INFO - Return code: 0 15:45:16 INFO - grabbing minidump binary from tooltool 15:45:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:45:16 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 0xd3df60>, '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 0xd3ed40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xd3f1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:45:16 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:45:16 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:45:16 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:45:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:45:17 INFO - Return code: 0 15:45:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:45:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:45:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:45:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:45:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:45:17 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/1479242106/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 15:45:17 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/1479242106/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:45:17 INFO - Using env: {'DISPLAY': ':0', 15:45:17 INFO - 'HOME': '/home/cltbld', 15:45:17 INFO - 'LANG': 'en_US.UTF-8', 15:45:17 INFO - 'LANGUAGE': 'en_US:en', 15:45:17 INFO - 'LOGNAME': 'cltbld', 15:45:17 INFO - 'MAIL': '/var/mail/cltbld', 15:45:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:45:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:45:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:17 INFO - 'MOZ_NO_REMOTE': '1', 15:45:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:45:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:17 INFO - 'NO_EM_RESTART': '1', 15:45:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:45:17 INFO - 'PWD': '/builds/slave/test', 15:45:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:45:17 INFO - 'SHELL': '/bin/bash', 15:45:17 INFO - 'SHLVL': '1', 15:45:17 INFO - 'TERM': 'linux', 15:45:17 INFO - 'TMOUT': '86400', 15:45:17 INFO - 'USER': 'cltbld', 15:45:17 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401', 15:45:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:17 INFO - '_': '/tools/buildbot/bin/python'} 15:45:17 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/1479242106/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:45:17 INFO - mozversion application_buildid: 20161115123506 15:45:17 INFO - mozversion application_changeset: 9822e0525b82bcca19078eab6532c8972977a156 15:45:17 INFO - mozversion application_display_name: Nightly 15:45:17 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:45:17 INFO - mozversion application_name: Firefox 15:45:17 INFO - mozversion application_remotingname: firefox 15:45:17 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:45:17 INFO - mozversion application_vendor: Mozilla 15:45:17 INFO - mozversion application_version: 53.0a1 15:45:17 INFO - mozversion platform_buildid: 20161115123506 15:45:17 INFO - mozversion platform_changeset: 9822e0525b82bcca19078eab6532c8972977a156 15:45:17 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:45:17 INFO - mozversion platform_version: 53.0a1 15:45:17 INFO - using testdate: 1479253517 15:45:17 INFO - actual date: 1479253517 15:45:17 INFO - starting webserver on 'localhost:45704' 15:45:17 INFO - SUITE-START | Running 2 tests 15:45:17 INFO - TEST-START | dromaeo_css 15:45:17 INFO - operating with platform_type : linux_ 15:45:17 INFO - Initialising browser for dromaeo_css test... 15:45:17 INFO - TEST-INFO | started process 7504 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQCu2DW/profile http://localhost:45704/getInfo.html) 15:45:21 INFO - PROCESS | 7504 | __metrics Screen width/height:1600/1200 15:45:22 INFO - PROCESS | 7504 | colorDepth:24 15:45:22 INFO - PROCESS | 7504 | Browser inner width/height: 1024/697 15:45:22 INFO - PROCESS | 7504 | __metrics 15:45:22 ERROR - PROCESS | 7504 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 15:45:23 INFO - TEST-INFO | 7504: exit 0 15:45:23 INFO - Browser initialized. 15:45:23 INFO - Running cycle 1/1 for dromaeo_css test... 15:45:23 INFO - TEST-INFO | started process 7630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQCu2DW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:45:35 INFO - PROCESS | 7630 | RSS: Main: 185995264 15:45:35 INFO - PROCESS | 7630 | 15:46:25 INFO - PROCESS | 7630 | 1479253585602 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:48:36 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:45704/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45704/tests/dromaeo/cssquery-ext.html) 15:48:37 INFO - PROCESS | 7630 | RSS: Main: 198139904 15:48:37 INFO - PROCESS | 7630 | 15:51:39 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:45704/tests/dromaeo/cssquery-ext.html (next: http://localhost:45704/tests/dromaeo/cssquery-jquery.html) 15:51:40 INFO - PROCESS | 7630 | RSS: Main: 196403200 15:51:40 INFO - PROCESS | 7630 | 15:54:42 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:45704/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45704/tests/dromaeo/cssquery-mootools.html) 15:54:42 INFO - PROCESS | 7630 | RSS: Main: 198758400 15:54:42 INFO - PROCESS | 7630 | 15:57:44 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:45704/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45704/tests/dromaeo/cssquery-prototype.html) 15:57:45 INFO - PROCESS | 7630 | RSS: Main: 195481600 15:57:45 INFO - PROCESS | 7630 | 16:00:48 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:45704/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45704/tests/dromaeo/cssquery-yui.html) 16:00:48 INFO - PROCESS | 7630 | RSS: Main: 203206656 16:00:48 INFO - PROCESS | 7630 | 16:03:51 INFO - PROCESS | 7630 | Cycle 1(1): loaded http://localhost:45704/tests/dromaeo/cssquery-yui.html (next: http://localhost:45704/tests/dromaeo/cssquery-dojo.html) 16:03:51 INFO - PROCESS | 7630 | RSS: Main: 203448320 16:03:51 INFO - PROCESS | 7630 | 16:03:51 INFO - PROCESS | 7630 | __start_tp_report 16:03:51 INFO - PROCESS | 7630 | _x_x_mozilla_page_load 16:03:51 INFO - PROCESS | 7630 | _x_x_mozilla_page_load_details 16:03:51 INFO - PROCESS | 7630 | |i|pagename|runs| 16:03:51 INFO - PROCESS | 7630 | |0;dojo.html;2968.257935516121;3042.954355684664;3046.4820980433324;3048.8628011739484;3073.6926307369267;5298.258243845865;5349.679019258847;5353.277307563482;5395.163749618806;5516.668999860011;5388.757505912234;5391.757370918308;5398.541124004454;5423.457654234575;5427.294451721271;4888.535589119028;4892.094962431944;4895.755212239392;4924.532169443915;5009.899802003976;4835.443923948738;4938.358013458245;4986.75066246688;4987.027529631723;4989.052080104769;256.28758884636426;4976.054549635558;4981.775820088104;4993.126202914494;5039.899202015958;3875.5155605549307;4984.40187177541;5010.323606313137;5018.172001619729;5041.621878359138;4966.379202599675;4972.279019542146;4979.30289759434;4987.426445958725;4997.175466048097;5296.761645725952;5347.786088556453;5361.758720857571;5369.40936496985;5418.187271909206;5731.168980497804;5738.598298119134;5765.221695071195;5768.250127483442;5791.768329266824;5858.326292476378;5867.823965281005;5890.823275301748;5896.086106653475;5896.145058966469;5273.9736301318635;5281.577473802086;5291.841244762663;5316.3354580677415;5355.7857685692525;5814.912776308359;5825.0679891217205;5852.882942341129;5855.121731740273;5885.146653735184;5592.245046918695;5596.2165296858475;5599.160125981135;5604.131359639263;5606;5701.971490142606;5741.62679425836;5774.566907481955;5782.2483077199695;5832.854178645568;5726.826000669853;5773.711314434261;5782.884342313214;5820.272465941757;5884.08796636522;5762.596618236767;5814.098814683731;5814.796482123105;5822.70886455684;5841.912371314434;4280.315149576053;4370.016746232136;4374.409454723572;4426.867193984185;4461.107778444324;3889.630485103911;3893.201893611803;3918.7060970427333;3919.118198405393;3949.289127956938;5516.282883225155;5524;5533.391326954032;5536.114221724505;5566.025945459528;5707.74315155819;5817.7963771267805;5818.069108942634;5818.389069147764;5818.79634212809;5394.487523685244;5465.617406781487;5499.697516636624;5501.532369748536;5540.750666220029;4908.337374454474;4909.754512274372;4910.729909854921;4934.67924584908;4948.925766113512;5915.438033386821;5974.970125149346;5996.820095397058;6001;6017.518598512109;5740.339860916049;5754.5684073695475;5771.509421699035;5775.422457754191;5879.911801323069;5896.498797602252;5934.673592952429;5936.614120082181;5953.166556682155;5955.196048533393;5578.246936663499;5685.061964775766;5689.829305120853;5725.828225153252;5749.137629355463;5761.8559536011935;5782.739776710142;5795.565332599987;5798.391168927371;5820.883582328414;5587.972060139673;5616.69108199053;5623.803166889139;5681.801136960186;5697;5617.606767526398;5634.943650563442;5639.436056394327;5647.88704225905;5710.086386178192;5631.986242476393;5638.126090455986;5648.265725455664;5648.943510564842;5653.604247702621;5612.905483430692;5695.288088988877;5718.971405142947;5723.7996670116345;5740.913886291625;5488.643238189505;5560.277163968658;5586.944130558642;5619.831405057855;5647.661140331593 16:03:51 INFO - PROCESS | 7630 | |1;ext.html;570.6119838509813;581.8167277307646;585.271337185204;588.1354409018744;600.8918394688957;35126.12184695381;36533.634663653385;36552.634473655286;38323.61676383235;38367.04082397941;35708.82145589275;36011.63988360116;36109;36135.45796813043;36226.456603150975;6825.351591598803;6966.12923384577;6978.720851165973;6984.720611175547;6985.860282794341;7161.427085833121;7253.419726421874;7253.56478611285;7268.963655181717;7271.200167981518;7230.421566274686;7236.49344545882;7290.307420795016;7303.415726741874;7312.085989251344;7188.388986936091;7203.135623725134;7205.711771529132;7224.6026468544205;7229.313215244543;7182.281771822776;7259.310365515267;7261.709531618729;7276.381507571863;7295.452841036943;32695.346093078006;32935.835320823244;33005.6699433005;33163.33673326544;33244.50133248003;3365.074604483762;3404.676555727202;3566.340227057977;3620.6741393274733;3876.127871228951;22795.31614051581;22906.65640015401;23019;23091.422714432105;23823.16618918347;3476.3948497854026;3517.82410879455;3569.1790888095625;3588.3002814451193;3607.350676878161;346776;349895;351010;352114;352127;56891.431085689444;56927;57257.71371143118;57447;57502;58706.41293587095;58778.706106469195;58986.705066474395;59085;59264;14792.11247325164;14849.331780069922;14879.10725356482;14967.401303947938;14990.550283491295;10951.671449856518;10980.725481862857;10980.780384392267;10983.231173817756;11025.393603351893;15132.243387830564;15920.442784502487;15947.44183953556;16111;16173.191340432932;5712.885742285131;5774.971125144431;5823.621464604787;5899.351071382144;5997.331187621467;898.5417437107122;966.3380584299778;981.9410835349902;1002.0280328081749;1058.899404556566;31508.36983260368;31837.8408107958;31859;31986;32124.83937580297;1035.1822060572215;1039.7452624107143;1049.7900419916048;1077.956881724738;1106.983395249072;15618.76571851423;16213.189340532927;16392.344306227857;16503.257353419125;16724.24740886663;508375;512040;512794;513944;514895;52969.735151324;53635;53879.730601347524;54153.729231353595;54249;1271.465984286602;1320.518010926005;1323.5698398020681;1333.7532556477083;1334.312828893121;29758;30810.537841931942;31360;31687.52468712925;32035.519467208476;49199;51219.231711523615;51228.74385628048;51266.23100653568;54845.72577137089;366542;368455;369187;373301;374332;26400.735992639828;26463.33841653974;26801.195964121107;26912.865435672695;27062;43155.568444315155;43675;43829.34255986226;45085.32372014488;45276;36697.63302366942;36989.815050924575;37740.43389349217;38356.232875342896;38654.420183696704;37592;37649.43525847169;37716.62283377131;38081.4287785689;38741.806290968365;31590.368192636477;33904.83047584746;37985.43021854619;38153.61846381501;38923.610763892;29718.851405742833;34006.48990265198;34696;34734.13164670904;35004;26214.73785262123;26596.335091622863;26771.464570708868;26808.195754127406;26896.462070758866 16:03:51 INFO - PROCESS | 7630 | |2;jquery.html;387.8060969515244;388.19643338289717;404.6398705152415;409.50858969236907;415.6010230179028;14741;15963.600909977256;15963.84036159638;15989;16355.100469474204;17910.462686119405;18752.531186720305;18767.343142989997;18770.155343009563;18921;4967.528084831944;5144.6913185209005;5267.394249661281;5285.207218917155;5287.180487024498;5061.620378471611;5162.8709282268055;5168.638195326329;5185;5232.398274198459;5146.125158723007;5166.612504062192;5188.429272779991;5190.221466779975;5199.428062913095;4975.800967961277;5103.591712662978;5128.102582048145;5155.072087024334;5169.069567477853;4647.279671650866;4666.416697912761;4682.367880336179;4683.5082316356975;4692.389989301369;19424.154705302975;20062.498437539034;20181.798182018138;20326;20427.182912683475;2241.775095482096;2266.2747920665392;2277.7152855893014;2281.327008532487;2333.4866329407505;12339.259644421363;12655.873441265561;12735.23588584688;12917.22496650204;13138.069911456068;1634.182908545727;1753.6672129181786;1766.4259115787293;1778.4931294580983;1785.7678501794815;80350.59824700898;83204.58397707973;83828;83950;83974.5801271002;10434.739131521772;10512.1590272778;10623.097036751962;10813.459327033617;11045.889541104647;15141.470048548248;15168.08991460516;15199;15218.46735364279;15288.312025958858;7559.112836920922;7741.574213418204;7798.805029874298;7898;7950.761477155695;7241.637918104179;7359.8160045999275;7524.473286869867;7590.8102297443;7605.353544948742;6292.874142517124;6361.61830290184;6463.159789227464;6519.348065193538;6578.605283682994;1865.1979648750896;1927.2772710233662;1952.3654812186096;1955.217912834849;1984.82136607706;899.1907283444821;946.3186505715873;1006.0392325329293;1009.8081364540714;1024.6721049264313;19028.524286892938;19442.805571944384;19466.902665486865;19554.41336759871;19908.402747917295;987.5457289646843;994.7612572982576;1009.369144284822;1025.4052649463292;1040.089921318846;9786.510674466248;10574.471276436147;10637.73405664849;10680.305780124267;11216.831747523795;452462;460489;462478;466418;493964;90539;91595.54202228946;96121;99084.50457747665;103859;991.4249735153594;1052.6999805055523;1056.1867362131115;1056.2078441169124;1057.836035414512;17148.142592870056;17167.484975450257;17840.821591784435;17891.46325610234;18127.36554220596;42828.14343713171;43755.56244437515;44021.77989110034;44081.77959110184;44646.990885409585;54782.726086369315;59577.40422595719;60540.69729651324;61221.387786121566;62245.37754622396;8445.577721114043;8514.659413623385;8537.573121343783;8636.913630863863;8761.474311541328;12907.677308067374;13248.668783280495;13482.52811151605;13705;13955.441782328593;5775.8556036099435;8768.868466973128;11606.24559403636;11785.646430607096;11818.940905295418;11579.478923448634;11607.245529040585;11686.474108664961;11866.288022718665;12029.15795894279;11524.711882203012;11614.187006909435;11870.406479676154;11880.762384752084;11895.82156267674;7462.403007759258;7849.803754906173;8008.83982320362;8170;9095.408798428081;10923.726906827393;11603.6518904433;11625.18623696333;11679.357635330138;11728.472218750007 16:03:51 INFO - PROCESS | 7630 | |3;mootools.html;1470.3236511204846;1488.2112480385392;1595.1226825246113;1712.7859017622798;1722.4488163787594;7025.402840758542;7256.709731610729;7333.779986600404;7651.1583725790115;7724.459287849852;7363.6318184090715;7647.732329368473;7653.272939070794;7817.257360550739;7823.061232652076;2009.2967461388507;2036.6435873722114;2036.7657719362242;2045.243259993797;2047.7952204779476;2025.6556385414515;2031.1164643380102;2052.0150327842643;2058.310465993894;2061.505238742706;2042.9387118386398;2054.260466232155;2071.1922350283403;2072.7823578524262;2077.626027315083;1976.911039003241;1991.0442987366;1997.3708281891231;1998.9400317990483;2000.1799262302459;1914.7702275726863;1955.1299671646123;1969.803019698033;1987.8111579399933;1993.7707163676218;7732.1108072571815;7829.138794732575;7897.289243968071;7898.80252993674;7906.288434040964;4900.362952816146;5016.799328026875;5059.19052951526;5059.974700126476;5060.443351231362;2996.805207661495;3218.5333126696733;3235.385276797401;3249.496328069153;3342.866285348583;967.6060225968456;982.1651596143292;1015.0610685116238;1031.257494603884;1068.417712346773;11047.116230701524;11166.832497512543;11219.495122719498;11221.495032723547;11226.775464490745;4280.400743895857;4432.29083346663;4477.194105061055;4496.19068567661;4598;9318.161365477139;9343.159115679622;9357.625694972125;9360.063993600585;9365.672201472917;5095.261187127846;5108.540231379119;5113.948860511422;5125.1287281162295;5125.333706618116;4000.4799376080923;4462.352958820953;4646.372739680168;4726;4734.928976065362;3743.5320584926885;3766.849326026983;3815.1988082502985;3821.4840996465678;3835.67396771272;1273.2805964629954;1278.2713853103828;1296.0733075850812;1302.4920281090383;1308.3065975033248;812.2283830361181;895.2077411490877;903.263839970422;909.4770506958525;915.9496227707407;5430.429804870431;5437.157240627709;5531.806386776443;5540.667559946416;5578.637388569811;460.9792559334838;464.15987063415326;477.94981526939864;478.7414796010116;482.5632802313841;3716.2939041582013;3801.6388443097862;3836.5971572984995;3914.1780226152828;3981.303271927401;9838.36050656705;10222.591096356062;10226.079652831133;10239.744006399751;10241.129503992244;10099.596016159272;10127.64553240633;10142.594296228068;10143.898561014443;10147.391156530484;7141.785746427616;7142.142942846892;7168.784936451915;7430.294122058396;7460.70157193717;5364.3830959440165;5377.677339359651;5551.2228288040515;5606.299212598426;5625.324961004706;8926.241269491906;8976.28189744832;8993.595288211915;9013.278937685101;9145.908540914506;9081.455112692995;9111.589978450853;9204.263658907137;9227;9286.953565232401;6836.692348844414;6877.518573699993;7080.4335653148655;7182.425405967406;7187.101612298463;7911.960440197762;7964.482308649919;7978.561179135203;8001.559914204542;8009.319207867164;7067.081279433641;7151.32062454066;7182;7235.63821808897;7307.488475806643;6896.965515172593;6931.098957135742;7038.40173585251;7161.140663120459;7289.635518223961;6552.8361790955605;6621;6643.900341494785;6689.130413046468;6710.094137291403;4589.747563883885;4643.210654188729;4678.064387122521;4703.20045592257;4725.716457012591;4690.906181876411;4691.695039822401;4776.402949631296;4835.95164048369;5050.141475949024 16:03:51 INFO - PROCESS | 7630 | |4;prototype.html;324.8018708587762;335.3209750255732;336.45662255457427;342.08833458832214;343.78513429106806;5328.760205790739;5475.972620136904;5566.693831839248;5615.21387005819;5632.971835140829;5248.658837175581;5400.648957817739;5467.906418716253;5485.753141108649;5493.478119578634;4309.612134907858;4319.136172765444;4320.459942507195;4325.22146013719;4359.520452750211;4206.369044643313;4314.395984562164;4338.978305108486;4341.196878577458;4341.956580434186;4271.594198551133;4287.871363859089;4293.119910418357;4311.741295522263;4312.654987600984;4286.6570674346285;4298.656107511391;4307.655387568987;4308.310670292738;4343.435353404069;3762.0625377930387;3840.1935593525395;3842.6541611254843;3862.9613703862883;3881.1655494068627;5302.204669299597;5310.787568497255;5351.491608297206;5377.274068000848;5385.973070134663;4930.186519224324;4930.728809915453;4935.1363511385725;4941.332920055783;4979.278004689299;5487.533559647395;5655.264815573949;5660.830175094713;5700.287464066992;5786.305643322786;4161.25097482453;4167.9583204167875;4175.728577642443;4186.727862688916;4190.643795277375;5914.76340946366;5937.287525496925;5945.137954996545;5993.101034844808;6001.279846418414;3994.121293315466;4194;4294.3558466230315;4300.978495107504;4303.655707543389;4253.340732186516;4260.850870219528;4262.211490874136;4262.549034305287;4286.957130428718;4862.975685121552;4896.261827051417;4915.5330243626795;4919.7540122993705;4927.507249275115;5608.747606357642;5750.683712395775;5811.854703632358;5822;5834.5624078194305;1404.56458497866;1431.8210223722035;1433.4409580263705;1440.107133577189;1443.985560144406;954.4654993203828;985.6106837799173;997.1922742578535;1000.7097941596855;1000.7147962830559;5355.866103347447;5382.515573598395;5410.215518749838;5451.591130665216;5454.427285135083;5644.57665675076;5669.574781891375;5672.142942798854;5703.914441283384;5718.914216286676;5099.69401835891;5274.868128296746;5300.946990530122;5380.650257733235;5384.219288203189;3021.456137895156;3023.3046399327836;3034.1201051695202;3037.726604605596;3037.8632961516787;5804.24298458229;5857;5872.383399743051;5873.559483038789;5893.1712777866005;5743.8851222976145;6027.679343452803;6043.8489037773525;6046.516278697782;6067.24159480065;6137.41694539018;6137.9079313810325;6156.707091510743;6160.661163636043;6171.290301615371;5743.4256574342235;5943.821685349447;5950.9702451487465;5953.523718102628;5998.49012833914;5880.588358814842;5920.407959204045;5924.31870334917;5935.762569497172;5988.221531200916;6079.102406455313;6096.512279017757;6212.937870621417;6240.719167637377;6285.43431091204;4217.198732240864;4259.212045771542;4262.232798096373;4265.850695225652;4269.7224680395675;5753.741081651252;5931;5946;6003.519718422428;6008.098785182083;5832.9708351457975;5851.297844258716;5856.560757943086;5880.500157486662;5883.411658834082;5829.504492118217;5840.269966254218;5848.56135789826;5862.794802181903;5895.351511333835;5610.635308704921;5774.769009239583;5810.564207684525;5817.447342502455;5824.708764561839;5880.176775251553;5885.852853678693;5906.789108232716;5938.910916336172;5943.762249509971;5451.727413629382;5691.459311365414;5705.857353566194;5712.028955077563;5744.133156723998 16:03:51 INFO - PROCESS | 7630 | |5;yui.html;691.4952084977966;698.3679769808322;702.4099756204787;748.6107224243393;794.8489786940482;12445.191062580938;13240.271785051818;13374.933125334359;13456.192628442288;13510.932445337785;11823.290602563853;12901.419436125374;12992.54526091587;13049.347532623378;13227.801582976239;768.7847402727232;785.2696991797626;788.8658927982257;794.8728203487443;795.3994733975869;769.9114601820806;784.6665167303873;794.2375319693073;794.6702118620766;800.5436900966452;842.2377748137945;845.526505157114;848.6732607945924;849.7280870121564;852.2415050604967;841.1798496465958;841.4614646626164;842.9536375499345;842.970496032639;844.2190973349658;616.5067945643467;617.5862172344495;618.4155972605889;618.8886000519905;619.7149311316799;12506.874931250662;12737.872621273762;12830.358482075952;12872.742545149138;12915.806262906064;9800.803983920354;10223.284370094096;10315.79368412635;10546.578136874516;10777.892221077767;8947.50788706621;8978.775530611721;9160.129787670161;9234.6306147754;9499.43003419797;3045.451818672638;3114.361555881039;3140.042287102433;3205.95806362933;3206.3587282543585;60812.695936520475;60908.39091609071;61662.69168654173;62841.37158628401;63247;8151.388645851584;8157.67369305233;8198.959005204935;8210;8247.546384948766;15026.323815428332;15111;15155.848441515443;15273;15482.380704771684;7442.925570744332;7514.173440921494;7660.3488703460835;7744.8451030980195;7754.1470438251745;4330.2205602991135;4498.190325741398;4499.52754960731;4503.909921801545;4528.660350473728;3311.106001379614;3427.8286085696113;3429.1255729788745;3435.347284016029;3448.258624395767;594.242341015209;594.9434803693642;595.3421469276387;602.4397310501275;611.4710775179437;633.0441034038635;643.0482885329739;674.5851301449574;704.8766465868453;710.9466789990771;8446.775217593415;9242.76893077665;9329.393589416666;9512;9873.358231714916;660.2209392916309;669.3172963577124;673.4274277654768;698.6402002968475;701.3442431326624;4165.854195103157;4483.14820184164;4509.549045095464;4583.885402864888;4653.348531205634;85339;87371;88943.55528222317;89052;93015;75377.62311188519;75739;76472.61763691145;78121.21878781253;82162;68707.65646171838;72269.63865180641;72595.27404725991;73422;76280;8747.30021598258;8958.865617015881;8985.910140898508;9086.107235399693;9130.406523575946;36353.45469817902;46323.30515042209;46387.53612463832;47822;48643.75678121587;62293.688531557054;62781;64150.35849641444;66841.66579167073;67595.66202168958;10105.797884042131;10644.627438039632;10791.892081079088;10997.12023038139;11491.253068550517;11981.28112313264;12004.459799308877;12670.493180272686;12777;12912.741745165233;10682;11903.702407439538;11917.880821191677;12370.381480925738;12476.688082798002;10950.288231264942;11394.316341019565;11506;11807.23252988553;11820.29078255273;9530.523473826419;11215.60745373908;11384.829227561759;11519.942400287944;11618.709532261422;9316.906830931875;9719.17387022111;9739.513024348897;10104.44425556572;10202.33684810485;9746.658866939622;10141.138003269805;10215.948920255649;10508.316959397614;10580.629677961235 16:03:51 INFO - PROCESS | 7630 | __end_tp_report 16:03:51 INFO - PROCESS | 7630 | __start_cc_report 16:03:51 INFO - PROCESS | 7630 | _x_x_mozilla_cycle_collect,330 16:03:51 INFO - PROCESS | 7630 | __end_cc_report 16:03:51 INFO - PROCESS | 7630 | __startTimestamp1479254631851__endTimestamp 16:03:51 INFO - PROCESS | 7630 | 16:03:51 INFO - PROCESS | 7630 | ------- Summary: start ------- 16:03:51 INFO - PROCESS | 7630 | Number of tests: 6 16:03:51 INFO - PROCESS | 7630 | 16:03:51 INFO - PROCESS | 7630 | [#0] dojo.html Cycles:165 Average:5335.12 Median:5599.16 stddev:743.81 (13.3%) stddev-sans-first:722.55 16:03:51 INFO - PROCESS | 7630 | Values: 2968.3 3043.0 3046.5 3048.9 3073.7 5298.3 5349.7 5353.3 5395.2 5516.7 5388.8 5391.8 5398.5 5423.5 5427.3 4888.5 4892.1 4895.8 4924.5 5009.9 4835.4 4938.4 4986.8 4987.0 4989.1 256.3 4976.1 4981.8 4993.1 5039.9 3875.5 4984.4 5010.3 5018.2 5041.6 4966.4 4972.3 4979.3 4987.4 4997.2 5296.8 5347.8 5361.8 5369.4 5418.2 5731.2 5738.6 5765.2 5768.3 5791.8 5858.3 5867.8 5890.8 5896.1 5896.1 5274.0 5281.6 5291.8 5316.3 5355.8 5814.9 5825.1 5852.9 5855.1 5885.1 5592.2 5596.2 5599.2 5604.1 5606.0 5702.0 5741.6 5774.6 5782.2 5832.9 5726.8 5773.7 5782.9 5820.3 5884.1 5762.6 5814.1 5814.8 5822.7 5841.9 4280.3 4370.0 4374.4 4426.9 4461.1 3889.6 3893.2 3918.7 3919.1 3949.3 5516.3 5524.0 5533.4 5536.1 5566.0 5707.7 5817.8 5818.1 5818.4 5818.8 5394.5 5465.6 5499.7 5501.5 5540.8 4908.3 4909.8 4910.7 4934.7 4948.9 5915.4 5975.0 5996.8 6001.0 6017.5 5740.3 5754.6 5771.5 5775.4 5879.9 5896.5 5934.7 5936.6 5953.2 5955.2 5578.2 5685.1 5689.8 5725.8 5749.1 5761.9 5782.7 5795.6 5798.4 5820.9 5588.0 5616.7 5623.8 5681.8 5697.0 5617.6 5634.9 5639.4 5647.9 5710.1 5632.0 5638.1 5648.3 5648.9 5653.6 5612.9 5695.3 5719.0 5723.8 5740.9 5488.6 5560.3 5586.9 5619.8 5647.7 16:03:51 INFO - PROCESS | 7630 | 16:03:51 INFO - PROCESS | 7630 | [#1] ext.html Cycles:180 Average:55573.44 Median:201547.32 stddev:110835.75 (55.0%) stddev-sans-first:111069.74 16:03:51 INFO - PROCESS | 7630 | Values: 570.6 581.8 585.3 588.1 600.9 35126.1 36533.6 36552.6 38323.6 38367.0 35708.8 36011.6 36109.0 36135.5 36226.5 6825.4 6966.1 6978.7 6984.7 6985.9 7161.4 7253.4 7253.6 7269.0 7271.2 7230.4 7236.5 7290.3 7303.4 7312.1 7188.4 7203.1 7205.7 7224.6 7229.3 7182.3 7259.3 7261.7 7276.4 7295.5 32695.3 32935.8 33005.7 33163.3 33244.5 3365.1 3404.7 3566.3 3620.7 3876.1 22795.3 22906.7 23019.0 23091.4 23823.2 3476.4 3517.8 3569.2 3588.3 3607.4 346776.0 349895.0 351010.0 352114.0 352127.0 56891.4 56927.0 57257.7 57447.0 57502.0 58706.4 58778.7 58986.7 59085.0 59264.0 14792.1 14849.3 14879.1 14967.4 14990.6 10951.7 10980.7 10980.8 10983.2 11025.4 15132.2 15920.4 15947.4 16111.0 16173.2 5712.9 5775.0 5823.6 5899.4 5997.3 898.5 966.3 981.9 1002.0 1058.9 31508.4 31837.8 31859.0 31986.0 32124.8 1035.2 1039.7 1049.8 1078.0 1107.0 15618.8 16213.2 16392.3 16503.3 16724.2 508375.0 512040.0 512794.0 513944.0 514895.0 52969.7 53635.0 53879.7 54153.7 54249.0 1271.5 1320.5 1323.6 1333.8 1334.3 29758.0 30810.5 31360.0 31687.5 32035.5 49199.0 51219.2 51228.7 51266.2 54845.7 366542.0 368455.0 369187.0 373301.0 374332.0 26400.7 26463.3 26801.2 26912.9 27062.0 43155.6 43675.0 43829.3 45085.3 45276.0 36697.6 36989.8 37740.4 38356.2 38654.4 37592.0 37649.4 37716.6 38081.4 38741.8 31590.4 33904.8 37985.4 38153.6 38923.6 29718.9 34006.5 34696.0 34734.1 35004.0 26214.7 26596.3 26771.5 26808.2 26896.5 16:03:51 INFO - PROCESS | 7630 | 16:03:51 INFO - PROCESS | 7630 | [#2] jquery.html Cycles:180 Average:28399.67 Median:2279.52 stddev:77411.49 (3396.0%) stddev-sans-first:77600.08 16:03:51 INFO - PROCESS | 7630 | Values: 387.8 388.2 404.6 409.5 415.6 14741.0 15963.6 15963.8 15989.0 16355.1 17910.5 18752.5 18767.3 18770.2 18921.0 4967.5 5144.7 5267.4 5285.2 5287.2 5061.6 5162.9 5168.6 5185.0 5232.4 5146.1 5166.6 5188.4 5190.2 5199.4 4975.8 5103.6 5128.1 5155.1 5169.1 4647.3 4666.4 4682.4 4683.5 4692.4 19424.2 20062.5 20181.8 20326.0 20427.2 2241.8 2266.3 2277.7 2281.3 2333.5 12339.3 12655.9 12735.2 12917.2 13138.1 1634.2 1753.7 1766.4 1778.5 1785.8 80350.6 83204.6 83828.0 83950.0 83974.6 10434.7 10512.2 10623.1 10813.5 11045.9 15141.5 15168.1 15199.0 15218.5 15288.3 7559.1 7741.6 7798.8 7898.0 7950.8 7241.6 7359.8 7524.5 7590.8 7605.4 6292.9 6361.6 6463.2 6519.3 6578.6 1865.2 1927.3 1952.4 1955.2 1984.8 899.2 946.3 1006.0 1009.8 1024.7 19028.5 19442.8 19466.9 19554.4 19908.4 987.5 994.8 1009.4 1025.4 1040.1 9786.5 10574.5 10637.7 10680.3 11216.8 452462.0 460489.0 462478.0 466418.0 493964.0 90539.0 91595.5 96121.0 99084.5 103859.0 991.4 1052.7 1056.2 1056.2 1057.8 17148.1 17167.5 17840.8 17891.5 18127.4 42828.1 43755.6 44021.8 44081.8 44647.0 54782.7 59577.4 60540.7 61221.4 62245.4 8445.6 8514.7 8537.6 8636.9 8761.5 12907.7 13248.7 13482.5 13705.0 13955.4 5775.9 8768.9 11606.2 11785.6 11818.9 11579.5 11607.2 11686.5 11866.3 12029.2 11524.7 11614.2 11870.4 11880.8 11895.8 7462.4 7849.8 8008.8 8170.0 9095.4 10923.7 11603.7 11625.2 11679.4 11728.5 16:03:51 INFO - PROCESS | 7630 | 16:03:51 INFO - PROCESS | 7630 | [#3] mootools.html Cycles:180 Average:5302.66 Median:4868.16 stddev:2997.54 (61.6%) stddev-sans-first:2992.12 16:03:51 INFO - PROCESS | 7630 | Values: 1470.3 1488.2 1595.1 1712.8 1722.4 7025.4 7256.7 7333.8 7651.2 7724.5 7363.6 7647.7 7653.3 7817.3 7823.1 2009.3 2036.6 2036.8 2045.2 2047.8 2025.7 2031.1 2052.0 2058.3 2061.5 2042.9 2054.3 2071.2 2072.8 2077.6 1976.9 1991.0 1997.4 1998.9 2000.2 1914.8 1955.1 1969.8 1987.8 1993.8 7732.1 7829.1 7897.3 7898.8 7906.3 4900.4 5016.8 5059.2 5060.0 5060.4 2996.8 3218.5 3235.4 3249.5 3342.9 967.6 982.2 1015.1 1031.3 1068.4 11047.1 11166.8 11219.5 11221.5 11226.8 4280.4 4432.3 4477.2 4496.2 4598.0 9318.2 9343.2 9357.6 9360.1 9365.7 5095.3 5108.5 5113.9 5125.1 5125.3 4000.5 4462.4 4646.4 4726.0 4734.9 3743.5 3766.8 3815.2 3821.5 3835.7 1273.3 1278.3 1296.1 1302.5 1308.3 812.2 895.2 903.3 909.5 915.9 5430.4 5437.2 5531.8 5540.7 5578.6 461.0 464.2 477.9 478.7 482.6 3716.3 3801.6 3836.6 3914.2 3981.3 9838.4 10222.6 10226.1 10239.7 10241.1 10099.6 10127.6 10142.6 10143.9 10147.4 7141.8 7142.1 7168.8 7430.3 7460.7 5364.4 5377.7 5551.2 5606.3 5625.3 8926.2 8976.3 8993.6 9013.3 9145.9 9081.5 9111.6 9204.3 9227.0 9287.0 6836.7 6877.5 7080.4 7182.4 7187.1 7912.0 7964.5 7978.6 8001.6 8009.3 7067.1 7151.3 7182.0 7235.6 7307.5 6897.0 6931.1 7038.4 7161.1 7289.6 6552.8 6621.0 6643.9 6689.1 6710.1 4589.7 4643.2 4678.1 4703.2 4725.7 4690.9 4691.7 4776.4 4836.0 5050.1 16:03:51 INFO - PROCESS | 7630 | 16:03:51 INFO - PROCESS | 7630 | [#4] prototype.html Cycles:180 Average:4852.52 Median:5461.17 stddev:1428.27 (26.2%) stddev-sans-first:1391.26 16:03:51 INFO - PROCESS | 7630 | Values: 324.8 335.3 336.5 342.1 343.8 5328.8 5476.0 5566.7 5615.2 5633.0 5248.7 5400.6 5467.9 5485.8 5493.5 4309.6 4319.1 4320.5 4325.2 4359.5 4206.4 4314.4 4339.0 4341.2 4342.0 4271.6 4287.9 4293.1 4311.7 4312.7 4286.7 4298.7 4307.7 4308.3 4343.4 3762.1 3840.2 3842.7 3863.0 3881.2 5302.2 5310.8 5351.5 5377.3 5386.0 4930.2 4930.7 4935.1 4941.3 4979.3 5487.5 5655.3 5660.8 5700.3 5786.3 4161.3 4168.0 4175.7 4186.7 4190.6 5914.8 5937.3 5945.1 5993.1 6001.3 3994.1 4194.0 4294.4 4301.0 4303.7 4253.3 4260.9 4262.2 4262.5 4287.0 4863.0 4896.3 4915.5 4919.8 4927.5 5608.7 5750.7 5811.9 5822.0 5834.6 1404.6 1431.8 1433.4 1440.1 1444.0 954.5 985.6 997.2 1000.7 1000.7 5355.9 5382.5 5410.2 5451.6 5454.4 5644.6 5669.6 5672.1 5703.9 5718.9 5099.7 5274.9 5300.9 5380.7 5384.2 3021.5 3023.3 3034.1 3037.7 3037.9 5804.2 5857.0 5872.4 5873.6 5893.2 5743.9 6027.7 6043.8 6046.5 6067.2 6137.4 6137.9 6156.7 6160.7 6171.3 5743.4 5943.8 5951.0 5953.5 5998.5 5880.6 5920.4 5924.3 5935.8 5988.2 6079.1 6096.5 6212.9 6240.7 6285.4 4217.2 4259.2 4262.2 4265.9 4269.7 5753.7 5931.0 5946.0 6003.5 6008.1 5833.0 5851.3 5856.6 5880.5 5883.4 5829.5 5840.3 5848.6 5862.8 5895.4 5610.6 5774.8 5810.6 5817.4 5824.7 5880.2 5885.9 5906.8 5938.9 5943.8 5451.7 5691.5 5705.9 5712.0 5744.1 16:03:51 INFO - PROCESS | 7630 | 16:03:51 INFO - PROCESS | 7630 | [#5] yui.html Cycles:180 Average:17169.11 Median:619.30 stddev:24111.48 (3893.3%) stddev-sans-first:24147.37 16:03:51 INFO - PROCESS | 7630 | Values: 691.5 698.4 702.4 748.6 794.8 12445.2 13240.3 13374.9 13456.2 13510.9 11823.3 12901.4 12992.5 13049.3 13227.8 768.8 785.3 788.9 794.9 795.4 769.9 784.7 794.2 794.7 800.5 842.2 845.5 848.7 849.7 852.2 841.2 841.5 843.0 843.0 844.2 616.5 617.6 618.4 618.9 619.7 12506.9 12737.9 12830.4 12872.7 12915.8 9800.8 10223.3 10315.8 10546.6 10777.9 8947.5 8978.8 9160.1 9234.6 9499.4 3045.5 3114.4 3140.0 3206.0 3206.4 60812.7 60908.4 61662.7 62841.4 63247.0 8151.4 8157.7 8199.0 8210.0 8247.5 15026.3 15111.0 15155.8 15273.0 15482.4 7442.9 7514.2 7660.3 7744.8 7754.1 4330.2 4498.2 4499.5 4503.9 4528.7 3311.1 3427.8 3429.1 3435.3 3448.3 594.2 594.9 595.3 602.4 611.5 633.0 643.0 674.6 704.9 710.9 8446.8 9242.8 9329.4 9512.0 9873.4 660.2 669.3 673.4 698.6 701.3 4165.9 4483.1 4509.5 4583.9 4653.3 85339.0 87371.0 88943.6 89052.0 93015.0 75377.6 75739.0 76472.6 78121.2 82162.0 68707.7 72269.6 72595.3 73422.0 76280.0 8747.3 8958.9 8985.9 9086.1 9130.4 36353.5 46323.3 46387.5 47822.0 48643.8 62293.7 62781.0 64150.4 66841.7 67595.7 10105.8 10644.6 10791.9 10997.1 11491.3 11981.3 12004.5 12670.5 12777.0 12912.7 10682.0 11903.7 11917.9 12370.4 12476.7 10950.3 11394.3 11506.0 11807.2 11820.3 9530.5 11215.6 11384.8 11519.9 11618.7 9316.9 9719.2 9739.5 10104.4 10202.3 9746.7 10141.1 10215.9 10508.3 10580.6 16:03:51 INFO - PROCESS | 7630 | -------- Summary: end -------- 16:03:51 INFO - PROCESS | 7630 | 16:03:52 INFO - TEST-INFO | 7630: exit 0 16:03:52 INFO - TEST-OK | dromaeo_css | took 1115690ms 16:03:52 INFO - TEST-START | kraken 16:03:52 INFO - operating with platform_type : linux_ 16:03:52 INFO - Initialising browser for kraken test... 16:03:52 INFO - TEST-INFO | started process 7987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbVVVKq/profile http://localhost:45704/getInfo.html) 16:03:57 INFO - PROCESS | 7987 | __metrics Screen width/height:1600/1200 16:03:57 INFO - PROCESS | 7987 | colorDepth:24 16:03:57 INFO - PROCESS | 7987 | Browser inner width/height: 1024/697 16:03:57 INFO - PROCESS | 7987 | __metrics 16:03:58 ERROR - PROCESS | 7987 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3179: TypeError: this.tabs is undefined 16:03:59 INFO - TEST-INFO | 7987: exit 0 16:03:59 INFO - Browser initialized. 16:03:59 INFO - Running cycle 1/1 for kraken test... 16:03:59 INFO - TEST-INFO | started process 8113 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbVVVKq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:04:11 INFO - PROCESS | 8113 | RSS: Main: 186118144 16:04:11 INFO - PROCESS | 8113 | 16:04:14 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45704/tests/kraken/driver.html?testName=audio-beat-detection) 16:04:15 INFO - PROCESS | 8113 | RSS: Main: 198873088 16:04:15 INFO - PROCESS | 8113 | 16:04:17 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45704/tests/kraken/driver.html?testName=audio-dft) 16:04:18 INFO - PROCESS | 8113 | RSS: Main: 197132288 16:04:18 INFO - PROCESS | 8113 | 16:04:21 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45704/tests/kraken/driver.html?testName=audio-fft) 16:04:21 INFO - PROCESS | 8113 | RSS: Main: 193015808 16:04:21 INFO - PROCESS | 8113 | 16:04:24 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45704/tests/kraken/driver.html?testName=audio-oscillator) 16:04:24 INFO - PROCESS | 8113 | RSS: Main: 194015232 16:04:24 INFO - PROCESS | 8113 | 16:04:26 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45704/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:04:27 INFO - PROCESS | 8113 | RSS: Main: 194076672 16:04:27 INFO - PROCESS | 8113 | 16:04:30 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45704/tests/kraken/driver.html?testName=imaging-darkroom) 16:04:31 INFO - PROCESS | 8113 | RSS: Main: 199626752 16:04:31 INFO - PROCESS | 8113 | 16:04:34 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45704/tests/kraken/driver.html?testName=imaging-desaturate) 16:04:35 INFO - PROCESS | 8113 | RSS: Main: 195895296 16:04:35 INFO - PROCESS | 8113 | 16:04:38 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45704/tests/kraken/driver.html?testName=json-parse-financial) 16:04:38 INFO - PROCESS | 8113 | RSS: Main: 196943872 16:04:38 INFO - PROCESS | 8113 | 16:04:40 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45704/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:04:40 INFO - PROCESS | 8113 | RSS: Main: 196558848 16:04:40 INFO - PROCESS | 8113 | 16:04:42 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45704/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:04:43 INFO - PROCESS | 8113 | RSS: Main: 196890624 16:04:43 INFO - PROCESS | 8113 | 16:04:45 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45704/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:04:46 INFO - PROCESS | 8113 | RSS: Main: 197107712 16:04:46 INFO - PROCESS | 8113 | 16:04:48 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:04:49 INFO - PROCESS | 8113 | RSS: Main: 197541888 16:04:49 INFO - PROCESS | 8113 | 16:04:52 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:04:52 INFO - PROCESS | 8113 | RSS: Main: 197931008 16:04:52 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | Cycle 1(1): loaded http://localhost:45704/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45704/tests/kraken/driver.html?testName=ai-astar) 16:04:54 INFO - PROCESS | 8113 | RSS: Main: 199266304 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | __start_tp_report 16:04:54 INFO - PROCESS | 8113 | _x_x_mozilla_page_load 16:04:54 INFO - PROCESS | 8113 | _x_x_mozilla_page_load_details 16:04:54 INFO - PROCESS | 8113 | |i|pagename|runs| 16:04:54 INFO - PROCESS | 8113 | |0;ai-astar;107;112;113;113;113;112;113;114;113;113 16:04:54 INFO - PROCESS | 8113 | |1;audio-beat-detection;154;124;127;170;125;124;124;124;155;129 16:04:54 INFO - PROCESS | 8113 | |2;audio-dft;166;173;164;168;175;162;163;165;164;161 16:04:54 INFO - PROCESS | 8113 | |3;audio-fft;75;74;75;111;77;77;77;77;116;77 16:04:54 INFO - PROCESS | 8113 | |4;audio-oscillator;83;82;122;82;82;82;97;82;83;111 16:04:54 INFO - PROCESS | 8113 | |5;imaging-gaussian-blur;117;118;117;118;117;118;117;117;118;117 16:04:54 INFO - PROCESS | 8113 | |6;imaging-darkroom;146;150;149;147;148;147;148;146;147;147 16:04:54 INFO - PROCESS | 8113 | |7;imaging-desaturate;97;96;95;105;96;96;96;97;97;96 16:04:54 INFO - PROCESS | 8113 | |8;json-parse-financial;55;58;58;54;56;53;54;53;55;53 16:04:54 INFO - PROCESS | 8113 | |9;json-stringify-tinderbox;63;63;62;62;64;62;63;63;63;63 16:04:54 INFO - PROCESS | 8113 | |10;stanford-crypto-aes;80;80;80;85;81;82;81;82;87;81 16:04:54 INFO - PROCESS | 8113 | |11;stanford-crypto-ccm;139;140;143;135;134;148;142;146;207;133 16:04:54 INFO - PROCESS | 8113 | |12;stanford-crypto-pbkdf2;171;164;170;166;167;167;164;167;165;166 16:04:54 INFO - PROCESS | 8113 | |13;stanford-crypto-sha256-iterative;66;65;67;66;75;73;64;70;63;64 16:04:54 INFO - PROCESS | 8113 | __end_tp_report 16:04:54 INFO - PROCESS | 8113 | __start_cc_report 16:04:54 INFO - PROCESS | 8113 | _x_x_mozilla_cycle_collect,818 16:04:54 INFO - PROCESS | 8113 | __end_cc_report 16:04:54 INFO - PROCESS | 8113 | __startTimestamp1479254694960__endTimestamp 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | ------- Summary: start ------- 16:04:54 INFO - PROCESS | 8113 | Number of tests: 14 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:1.95 (1.7%) stddev-sans-first:0.60 16:04:54 INFO - PROCESS | 8113 | Values: 107.0 112.0 113.0 113.0 113.0 112.0 113.0 114.0 113.0 113.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#1] audio-beat-detection Cycles:10 Average:135.60 Median:128.00 stddev:17.21 (13.4%) stddev-sans-first:16.92 16:04:54 INFO - PROCESS | 8113 | Values: 154.0 124.0 127.0 170.0 125.0 124.0 124.0 124.0 155.0 129.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#2] audio-dft Cycles:10 Average:166.10 Median:165.50 stddev:4.63 (2.8%) stddev-sans-first:4.91 16:04:54 INFO - PROCESS | 8113 | Values: 166.0 173.0 164.0 168.0 175.0 162.0 163.0 165.0 164.0 161.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#3] audio-fft Cycles:10 Average:83.60 Median:77.00 stddev:15.84 (20.6%) stddev-sans-first:16.49 16:04:54 INFO - PROCESS | 8113 | Values: 75.0 74.0 75.0 111.0 77.0 77.0 77.0 77.0 116.0 77.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#4] audio-oscillator Cycles:10 Average:90.60 Median:82.00 stddev:14.64 (17.9%) stddev-sans-first:15.27 16:04:54 INFO - PROCESS | 8113 | Values: 83.0 82.0 122.0 82.0 82.0 82.0 97.0 82.0 83.0 111.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:04:54 INFO - PROCESS | 8113 | Values: 117.0 118.0 117.0 118.0 117.0 118.0 117.0 117.0 118.0 117.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.50 stddev:1.27 (0.9%) stddev-sans-first:1.22 16:04:54 INFO - PROCESS | 8113 | Values: 146.0 150.0 149.0 147.0 148.0 147.0 148.0 146.0 147.0 147.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#7] imaging-desaturate Cycles:10 Average:97.10 Median:96.00 stddev:2.85 (3.0%) stddev-sans-first:3.02 16:04:54 INFO - PROCESS | 8113 | Values: 97.0 96.0 95.0 105.0 96.0 96.0 96.0 97.0 97.0 96.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.91 (3.5%) stddev-sans-first:2.03 16:04:54 INFO - PROCESS | 8113 | Values: 55.0 58.0 58.0 54.0 56.0 53.0 54.0 53.0 55.0 53.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#9] json-stringify-tinderbox Cycles:10 Average:62.80 Median:63.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 16:04:54 INFO - PROCESS | 8113 | Values: 63.0 63.0 62.0 62.0 64.0 62.0 63.0 63.0 63.0 63.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:81.50 stddev:2.33 (2.9%) stddev-sans-first:2.37 16:04:54 INFO - PROCESS | 8113 | Values: 80.0 80.0 80.0 85.0 81.0 82.0 81.0 82.0 87.0 81.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:142.50 stddev:21.77 (15.3%) stddev-sans-first:22.91 16:04:54 INFO - PROCESS | 8113 | Values: 139.0 140.0 143.0 135.0 134.0 148.0 142.0 146.0 207.0 133.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.70 Median:167.00 stddev:2.31 (1.4%) stddev-sans-first:1.86 16:04:54 INFO - PROCESS | 8113 | Values: 171.0 164.0 170.0 166.0 167.0 167.0 164.0 167.0 165.0 166.0 16:04:54 INFO - PROCESS | 8113 | 16:04:54 INFO - PROCESS | 8113 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:66.50 stddev:4.06 (6.1%) stddev-sans-first:4.28 16:04:54 INFO - PROCESS | 8113 | Values: 66.0 65.0 67.0 66.0 75.0 73.0 64.0 70.0 63.0 64.0 16:04:54 INFO - PROCESS | 8113 | -------- Summary: end -------- 16:04:54 INFO - PROCESS | 8113 | 16:04:56 INFO - TEST-INFO | 8113: exit 0 16:04:56 INFO - TEST-OK | kraken | took 63253ms 16:04:56 INFO - SUITE-END | took 1178s 16:04:56 INFO - Completed test suite (00:19:39) 16:04:56 INFO - javascript benchmark 16:04:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6869.620372840391, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2968.257935516121, 3042.954355684664, 3046.4820980433324, 3048.8628011739484, 3073.6926307369267, 5298.258243845865, 5349.679019258847, 5353.277307563482, 5395.163749618806, 5516.668999860011, 5388.757505912234, 5391.757370918308, 5398.541124004454, 5423.457654234575, 5427.294451721271, 4888.535589119028, 4892.094962431944, 4895.755212239392, 4924.532169443915, 5009.899802003976, 4835.443923948738, 4938.358013458245, 4986.75066246688, 4987.027529631723, 4989.052080104769, 256.28758884636426, 4976.054549635558, 4981.775820088104, 4993.126202914494, 5039.899202015958, 3875.5155605549307, 4984.40187177541, 5010.323606313137, 5018.172001619729, 5041.621878359138, 4966.379202599675, 4972.279019542146, 4979.30289759434, 4987.426445958725, 4997.175466048097, 5296.761645725952, 5347.786088556453, 5361.758720857571, 5369.40936496985, 5418.187271909206, 5731.168980497804, 5738.598298119134, 5765.221695071195, 5768.250127483442, 5791.768329266824, 5858.326292476378, 5867.823965281005, 5890.823275301748, 5896.086106653475, 5896.145058966469, 5273.9736301318635, 5281.577473802086, 5291.841244762663, 5316.3354580677415, 5355.7857685692525, 5814.912776308359, 5825.0679891217205, 5852.882942341129, 5855.121731740273, 5885.146653735184, 5592.245046918695, 5596.2165296858475, 5599.160125981135, 5604.131359639263, 5606.0, 5701.971490142606, 5741.62679425836, 5774.566907481955, 5782.2483077199695, 5832.854178645568, 5726.826000669853, 5773.711314434261, 5782.884342313214, 5820.272465941757, 5884.08796636522, 5762.596618236767, 5814.098814683731, 5814.796482123105, 5822.70886455684, 5841.912371314434, 4280.315149576053, 4370.016746232136, 4374.409454723572, 4426.867193984185, 4461.107778444324, 3889.630485103911, 3893.201893611803, 3918.7060970427333, 3919.118198405393, 3949.289127956938, 5516.282883225155, 5524.0, 5533.391326954032, 5536.114221724505, 5566.025945459528, 5707.74315155819, 5817.7963771267805, 5818.069108942634, 5818.389069147764, 5818.79634212809, 5394.487523685244, 5465.617406781487, 5499.697516636624, 5501.532369748536, 5540.750666220029, 4908.337374454474, 4909.754512274372, 4910.729909854921, 4934.67924584908, 4948.925766113512, 5915.438033386821, 5974.970125149346, 5996.820095397058, 6001.0, 6017.518598512109, 5740.339860916049, 5754.5684073695475, 5771.509421699035, 5775.422457754191, 5879.911801323069, 5896.498797602252, 5934.673592952429, 5936.614120082181, 5953.166556682155, 5955.196048533393, 5578.246936663499, 5685.061964775766, 5689.829305120853, 5725.828225153252, 5749.137629355463, 5761.8559536011935, 5782.739776710142, 5795.565332599987, 5798.391168927371, 5820.883582328414, 5587.972060139673, 5616.69108199053, 5623.803166889139, 5681.801136960186, 5697.0, 5617.606767526398, 5634.943650563442, 5639.436056394327, 5647.88704225905, 5710.086386178192, 5631.986242476393, 5638.126090455986, 5648.265725455664, 5648.943510564842, 5653.604247702621, 5612.905483430692, 5695.288088988877, 5718.971405142947, 5723.7996670116345, 5740.913886291625, 5488.643238189505, 5560.277163968658, 5586.944130558642, 5619.831405057855, 5647.661140331593], "value": 5286.133176608663, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [570.6119838509813, 581.8167277307646, 585.271337185204, 588.1354409018744, 600.8918394688957, 35126.12184695381, 36533.634663653385, 36552.634473655286, 38323.61676383235, 38367.04082397941, 35708.82145589275, 36011.63988360116, 36109.0, 36135.45796813043, 36226.456603150975, 6825.351591598803, 6966.12923384577, 6978.720851165973, 6984.720611175547, 6985.860282794341, 7161.427085833121, 7253.419726421874, 7253.56478611285, 7268.963655181717, 7271.200167981518, 7230.421566274686, 7236.49344545882, 7290.307420795016, 7303.415726741874, 7312.085989251344, 7188.388986936091, 7203.135623725134, 7205.711771529132, 7224.6026468544205, 7229.313215244543, 7182.281771822776, 7259.310365515267, 7261.709531618729, 7276.381507571863, 7295.452841036943, 32695.346093078006, 32935.835320823244, 33005.6699433005, 33163.33673326544, 33244.50133248003, 3365.074604483762, 3404.676555727202, 3566.340227057977, 3620.6741393274733, 3876.127871228951, 22795.31614051581, 22906.65640015401, 23019.0, 23091.422714432105, 23823.16618918347, 3476.3948497854026, 3517.82410879455, 3569.1790888095625, 3588.3002814451193, 3607.350676878161, 346776.0, 349895.0, 351010.0, 352114.0, 352127.0, 56891.431085689444, 56927.0, 57257.71371143118, 57447.0, 57502.0, 58706.41293587095, 58778.706106469195, 58986.705066474395, 59085.0, 59264.0, 14792.11247325164, 14849.331780069922, 14879.10725356482, 14967.401303947938, 14990.550283491295, 10951.671449856518, 10980.725481862857, 10980.780384392267, 10983.231173817756, 11025.393603351893, 15132.243387830564, 15920.442784502487, 15947.44183953556, 16111.0, 16173.191340432932, 5712.885742285131, 5774.971125144431, 5823.621464604787, 5899.351071382144, 5997.331187621467, 898.5417437107122, 966.3380584299778, 981.9410835349902, 1002.0280328081749, 1058.899404556566, 31508.36983260368, 31837.8408107958, 31859.0, 31986.0, 32124.83937580297, 1035.1822060572215, 1039.7452624107143, 1049.7900419916048, 1077.956881724738, 1106.983395249072, 15618.76571851423, 16213.189340532927, 16392.344306227857, 16503.257353419125, 16724.24740886663, 508375.0, 512040.0, 512794.0, 513944.0, 514895.0, 52969.735151324, 53635.0, 53879.730601347524, 54153.729231353595, 54249.0, 1271.465984286602, 1320.518010926005, 1323.5698398020681, 1333.7532556477083, 1334.312828893121, 29758.0, 30810.537841931942, 31360.0, 31687.52468712925, 32035.519467208476, 49199.0, 51219.231711523615, 51228.74385628048, 51266.23100653568, 54845.72577137089, 366542.0, 368455.0, 369187.0, 373301.0, 374332.0, 26400.735992639828, 26463.33841653974, 26801.195964121107, 26912.865435672695, 27062.0, 43155.568444315155, 43675.0, 43829.34255986226, 45085.32372014488, 45276.0, 36697.63302366942, 36989.815050924575, 37740.43389349217, 38356.232875342896, 38654.420183696704, 37592.0, 37649.43525847169, 37716.62283377131, 38081.4287785689, 38741.806290968365, 31590.368192636477, 33904.83047584746, 37985.43021854619, 38153.61846381501, 38923.610763892, 29718.851405742833, 34006.48990265198, 34696.0, 34734.13164670904, 35004.0, 26214.73785262123, 26596.335091622863, 26771.464570708868, 26808.195754127406, 26896.462070758866], "value": 18034.78808135047, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [387.8060969515244, 388.19643338289717, 404.6398705152415, 409.50858969236907, 415.6010230179028, 14741.0, 15963.600909977256, 15963.84036159638, 15989.0, 16355.100469474204, 17910.462686119405, 18752.531186720305, 18767.343142989997, 18770.155343009563, 18921.0, 4967.528084831944, 5144.6913185209005, 5267.394249661281, 5285.207218917155, 5287.180487024498, 5061.620378471611, 5162.8709282268055, 5168.638195326329, 5185.0, 5232.398274198459, 5146.125158723007, 5166.612504062192, 5188.429272779991, 5190.221466779975, 5199.428062913095, 4975.800967961277, 5103.591712662978, 5128.102582048145, 5155.072087024334, 5169.069567477853, 4647.279671650866, 4666.416697912761, 4682.367880336179, 4683.5082316356975, 4692.389989301369, 19424.154705302975, 20062.498437539034, 20181.798182018138, 20326.0, 20427.182912683475, 2241.775095482096, 2266.2747920665392, 2277.7152855893014, 2281.327008532487, 2333.4866329407505, 12339.259644421363, 12655.873441265561, 12735.23588584688, 12917.22496650204, 13138.069911456068, 1634.182908545727, 1753.6672129181786, 1766.4259115787293, 1778.4931294580983, 1785.7678501794815, 80350.59824700898, 83204.58397707973, 83828.0, 83950.0, 83974.5801271002, 10434.739131521772, 10512.1590272778, 10623.097036751962, 10813.459327033617, 11045.889541104647, 15141.470048548248, 15168.08991460516, 15199.0, 15218.46735364279, 15288.312025958858, 7559.112836920922, 7741.574213418204, 7798.805029874298, 7898.0, 7950.761477155695, 7241.637918104179, 7359.8160045999275, 7524.473286869867, 7590.8102297443, 7605.353544948742, 6292.874142517124, 6361.61830290184, 6463.159789227464, 6519.348065193538, 6578.605283682994, 1865.1979648750896, 1927.2772710233662, 1952.3654812186096, 1955.217912834849, 1984.82136607706, 899.1907283444821, 946.3186505715873, 1006.0392325329293, 1009.8081364540714, 1024.6721049264313, 19028.524286892938, 19442.805571944384, 19466.902665486865, 19554.41336759871, 19908.402747917295, 987.5457289646843, 994.7612572982576, 1009.369144284822, 1025.4052649463292, 1040.089921318846, 9786.510674466248, 10574.471276436147, 10637.73405664849, 10680.305780124267, 11216.831747523795, 452462.0, 460489.0, 462478.0, 466418.0, 493964.0, 90539.0, 91595.54202228946, 96121.0, 99084.50457747665, 103859.0, 991.4249735153594, 1052.6999805055523, 1056.1867362131115, 1056.2078441169124, 1057.836035414512, 17148.142592870056, 17167.484975450257, 17840.821591784435, 17891.46325610234, 18127.36554220596, 42828.14343713171, 43755.56244437515, 44021.77989110034, 44081.77959110184, 44646.990885409585, 54782.726086369315, 59577.40422595719, 60540.69729651324, 61221.387786121566, 62245.37754622396, 8445.577721114043, 8514.659413623385, 8537.573121343783, 8636.913630863863, 8761.474311541328, 12907.677308067374, 13248.668783280495, 13482.52811151605, 13705.0, 13955.441782328593, 5775.8556036099435, 8768.868466973128, 11606.24559403636, 11785.646430607096, 11818.940905295418, 11579.478923448634, 11607.245529040585, 11686.474108664961, 11866.288022718665, 12029.15795894279, 11524.711882203012, 11614.187006909435, 11870.406479676154, 11880.762384752084, 11895.82156267674, 7462.403007759258, 7849.803754906173, 8008.83982320362, 8170.0, 9095.408798428081, 10923.726906827393, 11603.6518904433, 11625.18623696333, 11679.357635330138, 11728.472218750007], "value": 9032.615170884383, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1470.3236511204846, 1488.2112480385392, 1595.1226825246113, 1712.7859017622798, 1722.4488163787594, 7025.402840758542, 7256.709731610729, 7333.779986600404, 7651.1583725790115, 7724.459287849852, 7363.6318184090715, 7647.732329368473, 7653.272939070794, 7817.257360550739, 7823.061232652076, 2009.2967461388507, 2036.6435873722114, 2036.7657719362242, 2045.243259993797, 2047.7952204779476, 2025.6556385414515, 2031.1164643380102, 2052.0150327842643, 2058.310465993894, 2061.505238742706, 2042.9387118386398, 2054.260466232155, 2071.1922350283403, 2072.7823578524262, 2077.626027315083, 1976.911039003241, 1991.0442987366, 1997.3708281891231, 1998.9400317990483, 2000.1799262302459, 1914.7702275726863, 1955.1299671646123, 1969.803019698033, 1987.8111579399933, 1993.7707163676218, 7732.1108072571815, 7829.138794732575, 7897.289243968071, 7898.80252993674, 7906.288434040964, 4900.362952816146, 5016.799328026875, 5059.19052951526, 5059.974700126476, 5060.443351231362, 2996.805207661495, 3218.5333126696733, 3235.385276797401, 3249.496328069153, 3342.866285348583, 967.6060225968456, 982.1651596143292, 1015.0610685116238, 1031.257494603884, 1068.417712346773, 11047.116230701524, 11166.832497512543, 11219.495122719498, 11221.495032723547, 11226.775464490745, 4280.400743895857, 4432.29083346663, 4477.194105061055, 4496.19068567661, 4598.0, 9318.161365477139, 9343.159115679622, 9357.625694972125, 9360.063993600585, 9365.672201472917, 5095.261187127846, 5108.540231379119, 5113.948860511422, 5125.1287281162295, 5125.333706618116, 4000.4799376080923, 4462.352958820953, 4646.372739680168, 4726.0, 4734.928976065362, 3743.5320584926885, 3766.849326026983, 3815.1988082502985, 3821.4840996465678, 3835.67396771272, 1273.2805964629954, 1278.2713853103828, 1296.0733075850812, 1302.4920281090383, 1308.3065975033248, 812.2283830361181, 895.2077411490877, 903.263839970422, 909.4770506958525, 915.9496227707407, 5430.429804870431, 5437.157240627709, 5531.806386776443, 5540.667559946416, 5578.637388569811, 460.9792559334838, 464.15987063415326, 477.94981526939864, 478.7414796010116, 482.5632802313841, 3716.2939041582013, 3801.6388443097862, 3836.5971572984995, 3914.1780226152828, 3981.303271927401, 9838.36050656705, 10222.591096356062, 10226.079652831133, 10239.744006399751, 10241.129503992244, 10099.596016159272, 10127.64553240633, 10142.594296228068, 10143.898561014443, 10147.391156530484, 7141.785746427616, 7142.142942846892, 7168.784936451915, 7430.294122058396, 7460.70157193717, 5364.3830959440165, 5377.677339359651, 5551.2228288040515, 5606.299212598426, 5625.324961004706, 8926.241269491906, 8976.28189744832, 8993.595288211915, 9013.278937685101, 9145.908540914506, 9081.455112692995, 9111.589978450853, 9204.263658907137, 9227.0, 9286.953565232401, 6836.692348844414, 6877.518573699993, 7080.4335653148655, 7182.425405967406, 7187.101612298463, 7911.960440197762, 7964.482308649919, 7978.561179135203, 8001.559914204542, 8009.319207867164, 7067.081279433641, 7151.32062454066, 7182.0, 7235.63821808897, 7307.488475806643, 6896.965515172593, 6931.098957135742, 7038.40173585251, 7161.140663120459, 7289.635518223961, 6552.8361790955605, 6621.0, 6643.900341494785, 6689.130413046468, 6710.094137291403, 4589.747563883885, 4643.210654188729, 4678.064387122521, 4703.20045592257, 4725.716457012591, 4690.906181876411, 4691.695039822401, 4776.402949631296, 4835.95164048369, 5050.141475949024], "value": 4196.524297016046, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.8018708587762, 335.3209750255732, 336.45662255457427, 342.08833458832214, 343.78513429106806, 5328.760205790739, 5475.972620136904, 5566.693831839248, 5615.21387005819, 5632.971835140829, 5248.658837175581, 5400.648957817739, 5467.906418716253, 5485.753141108649, 5493.478119578634, 4309.612134907858, 4319.136172765444, 4320.459942507195, 4325.22146013719, 4359.520452750211, 4206.369044643313, 4314.395984562164, 4338.978305108486, 4341.196878577458, 4341.956580434186, 4271.594198551133, 4287.871363859089, 4293.119910418357, 4311.741295522263, 4312.654987600984, 4286.6570674346285, 4298.656107511391, 4307.655387568987, 4308.310670292738, 4343.435353404069, 3762.0625377930387, 3840.1935593525395, 3842.6541611254843, 3862.9613703862883, 3881.1655494068627, 5302.204669299597, 5310.787568497255, 5351.491608297206, 5377.274068000848, 5385.973070134663, 4930.186519224324, 4930.728809915453, 4935.1363511385725, 4941.332920055783, 4979.278004689299, 5487.533559647395, 5655.264815573949, 5660.830175094713, 5700.287464066992, 5786.305643322786, 4161.25097482453, 4167.9583204167875, 4175.728577642443, 4186.727862688916, 4190.643795277375, 5914.76340946366, 5937.287525496925, 5945.137954996545, 5993.101034844808, 6001.279846418414, 3994.121293315466, 4194.0, 4294.3558466230315, 4300.978495107504, 4303.655707543389, 4253.340732186516, 4260.850870219528, 4262.211490874136, 4262.549034305287, 4286.957130428718, 4862.975685121552, 4896.261827051417, 4915.5330243626795, 4919.7540122993705, 4927.507249275115, 5608.747606357642, 5750.683712395775, 5811.854703632358, 5822.0, 5834.5624078194305, 1404.56458497866, 1431.8210223722035, 1433.4409580263705, 1440.107133577189, 1443.985560144406, 954.4654993203828, 985.6106837799173, 997.1922742578535, 1000.7097941596855, 1000.7147962830559, 5355.866103347447, 5382.515573598395, 5410.215518749838, 5451.591130665216, 5454.427285135083, 5644.57665675076, 5669.574781891375, 5672.142942798854, 5703.914441283384, 5718.914216286676, 5099.69401835891, 5274.868128296746, 5300.946990530122, 5380.650257733235, 5384.219288203189, 3021.456137895156, 3023.3046399327836, 3034.1201051695202, 3037.726604605596, 3037.8632961516787, 5804.24298458229, 5857.0, 5872.383399743051, 5873.559483038789, 5893.1712777866005, 5743.8851222976145, 6027.679343452803, 6043.8489037773525, 6046.516278697782, 6067.24159480065, 6137.41694539018, 6137.9079313810325, 6156.707091510743, 6160.661163636043, 6171.290301615371, 5743.4256574342235, 5943.821685349447, 5950.9702451487465, 5953.523718102628, 5998.49012833914, 5880.588358814842, 5920.407959204045, 5924.31870334917, 5935.762569497172, 5988.221531200916, 6079.102406455313, 6096.512279017757, 6212.937870621417, 6240.719167637377, 6285.43431091204, 4217.198732240864, 4259.212045771542, 4262.232798096373, 4265.850695225652, 4269.7224680395675, 5753.741081651252, 5931.0, 5946.0, 6003.519718422428, 6008.098785182083, 5832.9708351457975, 5851.297844258716, 5856.560757943086, 5880.500157486662, 5883.411658834082, 5829.504492118217, 5840.269966254218, 5848.56135789826, 5862.794802181903, 5895.351511333835, 5610.635308704921, 5774.769009239583, 5810.564207684525, 5817.447342502455, 5824.708764561839, 5880.176775251553, 5885.852853678693, 5906.789108232716, 5938.910916336172, 5943.762249509971, 5451.727413629382, 5691.459311365414, 5705.857353566194, 5712.028955077563, 5744.133156723998], "value": 4393.087381353449, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.4952084977966, 698.3679769808322, 702.4099756204787, 748.6107224243393, 794.8489786940482, 12445.191062580938, 13240.271785051818, 13374.933125334359, 13456.192628442288, 13510.932445337785, 11823.290602563853, 12901.419436125374, 12992.54526091587, 13049.347532623378, 13227.801582976239, 768.7847402727232, 785.2696991797626, 788.8658927982257, 794.8728203487443, 795.3994733975869, 769.9114601820806, 784.6665167303873, 794.2375319693073, 794.6702118620766, 800.5436900966452, 842.2377748137945, 845.526505157114, 848.6732607945924, 849.7280870121564, 852.2415050604967, 841.1798496465958, 841.4614646626164, 842.9536375499345, 842.970496032639, 844.2190973349658, 616.5067945643467, 617.5862172344495, 618.4155972605889, 618.8886000519905, 619.7149311316799, 12506.874931250662, 12737.872621273762, 12830.358482075952, 12872.742545149138, 12915.806262906064, 9800.803983920354, 10223.284370094096, 10315.79368412635, 10546.578136874516, 10777.892221077767, 8947.50788706621, 8978.775530611721, 9160.129787670161, 9234.6306147754, 9499.43003419797, 3045.451818672638, 3114.361555881039, 3140.042287102433, 3205.95806362933, 3206.3587282543585, 60812.695936520475, 60908.39091609071, 61662.69168654173, 62841.37158628401, 63247.0, 8151.388645851584, 8157.67369305233, 8198.959005204935, 8210.0, 8247.546384948766, 15026.323815428332, 15111.0, 15155.848441515443, 15273.0, 15482.380704771684, 7442.925570744332, 7514.173440921494, 7660.3488703460835, 7744.8451030980195, 7754.1470438251745, 4330.2205602991135, 4498.190325741398, 4499.52754960731, 4503.909921801545, 4528.660350473728, 3311.106001379614, 3427.8286085696113, 3429.1255729788745, 3435.347284016029, 3448.258624395767, 594.242341015209, 594.9434803693642, 595.3421469276387, 602.4397310501275, 611.4710775179437, 633.0441034038635, 643.0482885329739, 674.5851301449574, 704.8766465868453, 710.9466789990771, 8446.775217593415, 9242.76893077665, 9329.393589416666, 9512.0, 9873.358231714916, 660.2209392916309, 669.3172963577124, 673.4274277654768, 698.6402002968475, 701.3442431326624, 4165.854195103157, 4483.14820184164, 4509.549045095464, 4583.885402864888, 4653.348531205634, 85339.0, 87371.0, 88943.55528222317, 89052.0, 93015.0, 75377.62311188519, 75739.0, 76472.61763691145, 78121.21878781253, 82162.0, 68707.65646171838, 72269.63865180641, 72595.27404725991, 73422.0, 76280.0, 8747.30021598258, 8958.865617015881, 8985.910140898508, 9086.107235399693, 9130.406523575946, 36353.45469817902, 46323.30515042209, 46387.53612463832, 47822.0, 48643.75678121587, 62293.688531557054, 62781.0, 64150.35849641444, 66841.66579167073, 67595.66202168958, 10105.797884042131, 10644.627438039632, 10791.892081079088, 10997.12023038139, 11491.253068550517, 11981.28112313264, 12004.459799308877, 12670.493180272686, 12777.0, 12912.741745165233, 10682.0, 11903.702407439538, 11917.880821191677, 12370.381480925738, 12476.688082798002, 10950.288231264942, 11394.316341019565, 11506.0, 11807.23252988553, 11820.29078255273, 9530.523473826419, 11215.60745373908, 11384.829227561759, 11519.942400287944, 11618.709532261422, 9316.906830931875, 9719.17387022111, 9739.513024348897, 10104.44425556572, 10202.33684810485, 9746.658866939622, 10141.138003269805, 10215.948920255649, 10508.316959397614, 10580.629677961235], "value": 6619.592378000487, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1530.5000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 112.0, 113.0, 113.0, 113.0, 112.0, 113.0, 114.0, 113.0, 113.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 124.0, 127.0, 170.0, 125.0, 124.0, 124.0, 124.0, 155.0, 129.0], "value": 135.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 173.0, 164.0, 168.0, 175.0, 162.0, 163.0, 165.0, 164.0, 161.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 75.0, 111.0, 77.0, 77.0, 77.0, 77.0, 116.0, 77.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 122.0, 82.0, 82.0, 82.0, 97.0, 82.0, 83.0, 111.0], "value": 90.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 117.0, 117.0, 118.0, 117.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 150.0, 149.0, 147.0, 148.0, 147.0, 148.0, 146.0, 147.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 95.0, 105.0, 96.0, 96.0, 96.0, 97.0, 97.0, 96.0], "value": 97.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 58.0, 54.0, 56.0, 53.0, 54.0, 53.0, 55.0, 53.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 85.0, 81.0, 82.0, 81.0, 82.0, 87.0, 81.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 143.0, 135.0, 134.0, 148.0, 142.0, 146.0, 207.0, 133.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 164.0, 170.0, 166.0, 167.0, 167.0, 164.0, 167.0, 165.0, 166.0], "value": 166.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 66.0, 75.0, 73.0, 64.0, 70.0, 63.0, 64.0], "value": 67.3, "unit": "score"}]}]} 16:04:56 INFO - Return code: 0 16:04:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:04:56 ERROR - # TBPL SUCCESS # 16:04:56 INFO - Running post-action listener: _resource_record_post_action 16:04:56 INFO - [mozharness: 2016-11-16 00:04:56.759080Z] Finished run-tests step (success) 16:04:56 INFO - Running post-run listener: _resource_record_post_run 16:04:56 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394186752; Read time: 12; Write time: 477340 16:04:56 INFO - TinderboxPrint: CPU usage
13.4% 16:04:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:04:56 INFO - TinderboxPrint: I/O write bytes / time
394,186,752 / 477,340 16:04:56 INFO - TinderboxPrint: CPU idle
8,255.3 (86.5%) 16:04:56 INFO - TinderboxPrint: CPU user
1,217.7 (12.8%) 16:04:56 INFO - TinderboxPrint: Swap in / out
0 / 0 16:04:56 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 106536960; Read time: 0; Write time: 173716 16:04:56 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 0; Write bytes: 287289344; Read time: 0; Write time: 303624 16:04:57 INFO - Running post-run listener: _upload_blobber_files 16:04:57 INFO - Blob upload gear active. 16:04:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:04:57 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:04:57 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'] 16:04:57 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 16:04:57 INFO - (blobuploader) - INFO - Open directory for files ... 16:04:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:04:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:04:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:04:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:04:58 INFO - (blobuploader) - INFO - Done attempting. 16:04:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:04:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:04:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:05:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:01 INFO - (blobuploader) - INFO - Done attempting. 16:05:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:05:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:05:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:05:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:05:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:05:02 INFO - (blobuploader) - INFO - Done attempting. 16:05:02 INFO - (blobuploader) - INFO - Iteration through files over. 16:05:02 INFO - Return code: 0 16:05:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:05:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:05:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79a0103e596426150dcf67693b5d734c9a1eaf61111d074682cb99bb4dcf86924a7879f507641275f4c4670a8df33a79c1aa7201bb8a3c86a6a2f0b12bb2bce9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94b48f514eff6c43517fe8faa3f88496f1b7af2031adbb8f4b67ab0ab39f5c218d70cbde45a1aca8c48fd2984cd6a48983b5076f99e70720a671cb31b5f64e47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/769830f03b77f88e294b0598e3f7299e4b2faec94a28e6c529708c4541bb180e98206341dacb14167f6eab2d8c98e93bd64835831295ab9ad797c489417b81ba"} 16:05:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:05:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:05:02 INFO - Contents: 16:05:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/79a0103e596426150dcf67693b5d734c9a1eaf61111d074682cb99bb4dcf86924a7879f507641275f4c4670a8df33a79c1aa7201bb8a3c86a6a2f0b12bb2bce9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94b48f514eff6c43517fe8faa3f88496f1b7af2031adbb8f4b67ab0ab39f5c218d70cbde45a1aca8c48fd2984cd6a48983b5076f99e70720a671cb31b5f64e47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/769830f03b77f88e294b0598e3f7299e4b2faec94a28e6c529708c4541bb180e98206341dacb14167f6eab2d8c98e93bd64835831295ab9ad797c489417b81ba"} 16:05:02 INFO - Running post-run listener: copy_logs_to_upload_dir 16:05:02 INFO - Copying logs to upload dir... 16:05:02 INFO - mkdir: /builds/slave/test/build/upload/logs 16:05:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.250287 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-11-15 16:05:02.605475) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 16:05:02.609063) ========= 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=8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401 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/79a0103e596426150dcf67693b5d734c9a1eaf61111d074682cb99bb4dcf86924a7879f507641275f4c4670a8df33a79c1aa7201bb8a3c86a6a2f0b12bb2bce9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94b48f514eff6c43517fe8faa3f88496f1b7af2031adbb8f4b67ab0ab39f5c218d70cbde45a1aca8c48fd2984cd6a48983b5076f99e70720a671cb31b5f64e47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/769830f03b77f88e294b0598e3f7299e4b2faec94a28e6c529708c4541bb180e98206341dacb14167f6eab2d8c98e93bd64835831295ab9ad797c489417b81ba"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011866 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1479242106/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/79a0103e596426150dcf67693b5d734c9a1eaf61111d074682cb99bb4dcf86924a7879f507641275f4c4670a8df33a79c1aa7201bb8a3c86a6a2f0b12bb2bce9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/94b48f514eff6c43517fe8faa3f88496f1b7af2031adbb8f4b67ab0ab39f5c218d70cbde45a1aca8c48fd2984cd6a48983b5076f99e70720a671cb31b5f64e47", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/769830f03b77f88e294b0598e3f7299e4b2faec94a28e6c529708c4541bb180e98206341dacb14167f6eab2d8c98e93bd64835831295ab9ad797c489417b81ba"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-15 16:05:02.635050) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 16:05:02.635381) ========= 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=8783db0840cc980e80bb0bd400000236-1479253462.335433-515499401 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004494 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-15 16:05:02.719875) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 16:05:02.720256) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-15 16:05:02.720581) ========= ========= Total master_lag: 0.17 =========