builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-068 starttime: 1477272778.66 results: success (0) buildid: 20161023183247 builduid: 95e1b8784b3c457f80d01b5d6634be14 revision: 9adfea13296e07e6ef662362d9f871c065c66505 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:58.658341) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:58.658790) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:58.659070) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:58.681078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:58.681373) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-23 18:33:00-- 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% 46.5M=0s 2016-10-23 18:33:00 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.090351 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:58.787022) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:58.787343) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013848 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:58.841048) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:58.841405) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 9adfea13296e07e6ef662362d9f871c065c66505 --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 9adfea13296e07e6ef662362d9f871c065c66505 --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=97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-23 18:33:00,480 truncating revision to first 12 chars 2016-10-23 18:33:00,481 Setting DEBUG logging. 2016-10-23 18:33:00,481 attempt 1/10 2016-10-23 18:33:00,481 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/9adfea13296e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-23 18:33:00,918 unpacking tar archive at: mozilla-inbound-9adfea13296e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.822056 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:59.677834) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:59.678192) ========= script_repo_revision: 9adfea13296e07e6ef662362d9f871c065c66505 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:59.678594) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:59.678869) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-23 18:32:59.687592) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-23 18:32:59.687934) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:33:01 INFO - MultiFileLogger online at 20161023 18:33:01 in /builds/slave/test 18:33:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:33:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:33:01 INFO - {'append_to_log': False, 18:33:01 INFO - 'base_work_dir': '/builds/slave/test', 18:33:01 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:33:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:33:01 INFO - 'branch': 'Mozilla-Inbound', 18:33:01 INFO - 'buildbot_json_path': 'buildprops.json', 18:33:01 INFO - 'config_files': ('talos/linux_config.py',), 18:33:01 INFO - 'default_actions': ('clobber', 18:33:01 INFO - 'read-buildbot-config', 18:33:01 INFO - 'download-and-extract', 18:33:01 INFO - 'populate-webroot', 18:33:01 INFO - 'create-virtualenv', 18:33:01 INFO - 'install', 18:33:01 INFO - 'run-tests'), 18:33:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:33:01 INFO - 'download_minidump_stackwalk': True, 18:33:01 INFO - 'download_symbols': 'ondemand', 18:33:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:33:01 INFO - 'tooltool.py': '/tools/tooltool.py', 18:33:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:33:01 INFO - '/tools/misc-python/virtualenv.py')}, 18:33:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:33:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:33:01 INFO - 'installer_path': 'installer.exe', 18:33:01 INFO - 'log_level': 'info', 18:33:01 INFO - 'log_name': 'talos', 18:33:01 INFO - 'log_to_console': True, 18:33:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:33:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:33:01 INFO - 'opt_config_files': (), 18:33:01 INFO - 'pip_index': False, 18:33:01 INFO - 'sps_profile': False, 18:33:01 INFO - 'sps_profile_interval': 0, 18:33:01 INFO - 'suite': 'dromaeojs', 18:33:01 INFO - 'system_bits': '32', 18:33:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:33:01 INFO - 'title': 'talos-linux64-ix-068', 18:33:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:33:01 INFO - 'use_talos_json': True, 18:33:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:33:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:33:01 INFO - 'work_dir': 'build'} 18:33:01 INFO - [mozharness: 2016-10-24 01:33:01.431736Z] Running clobber step. 18:33:01 INFO - Running pre-action listener: _resource_record_pre_action 18:33:01 INFO - Running main action method: clobber 18:33:01 INFO - rmtree: /builds/slave/test/build 18:33:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:33:01 INFO - Running post-action listener: _resource_record_post_action 18:33:01 INFO - [mozharness: 2016-10-24 01:33:01.894351Z] Finished clobber step (success) 18:33:01 INFO - [mozharness: 2016-10-24 01:33:01.894451Z] Running read-buildbot-config step. 18:33:01 INFO - Running pre-action listener: _resource_record_pre_action 18:33:01 INFO - Running main action method: read_buildbot_config 18:33:01 INFO - Using buildbot properties: 18:33:01 INFO - { 18:33:01 INFO - "project": "", 18:33:01 INFO - "product": "firefox", 18:33:01 INFO - "script_repo_revision": "production", 18:33:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:33:01 INFO - "repository": "", 18:33:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:33:01 INFO - "buildid": "20161023183247", 18:33:01 INFO - "stage_platform": "linux64-pgo", 18:33:01 INFO - "basedir": "/builds/slave/test", 18:33:01 INFO - "buildnumber": 1775, 18:33:01 INFO - "platform": "ubuntu64_hw", 18:33:01 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:33:01 INFO - "slavebuilddir": "test", 18:33:01 INFO - "branch": "mozilla-inbound", 18:33:01 INFO - "revision": "9adfea13296e07e6ef662362d9f871c065c66505", 18:33:01 INFO - "slavename": "talos-linux64-ix-068", 18:33:01 INFO - "builduid": "95e1b8784b3c457f80d01b5d6634be14", 18:33:01 INFO - "repo_path": "integration/mozilla-inbound" 18:33:01 INFO - } 18:33:01 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:33:01 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 18:33:01 INFO - Running post-action listener: _resource_record_post_action 18:33:01 INFO - [mozharness: 2016-10-24 01:33:01.897060Z] Finished read-buildbot-config step (success) 18:33:01 INFO - [mozharness: 2016-10-24 01:33:01.897148Z] Running download-and-extract step. 18:33:01 INFO - Running pre-action listener: _resource_record_pre_action 18:33:01 INFO - Running main action method: download_and_extract 18:33:01 INFO - mkdir: /builds/slave/test/build/tests 18:33:01 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')]} 18:33:01 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:33:01 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:33:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:33:01 INFO - Downloaded 1361 bytes. 18:33:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:33:01 INFO - Using the following test package requirements: 18:33:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:33:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:33:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:33:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:01 INFO - u'jsshell-linux-x86_64.zip'], 18:33:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:33:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:33:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:33:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:33:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:33:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:33:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:33:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:33:01 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/1477261808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:33:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:33:01 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:33:01 INFO - Http code: 200 18:33:01 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 18:33:01 INFO - x-amz-cf-id: j0HKhcgiTEqQ5aNjiMqSYA6QWaA8rQaLIvRh5p2o7rOAOgXOgh_D3A== 18:33:01 INFO - x-amz-replication-status: PENDING 18:33:01 INFO - x-amz-version-id: TxBKA7rCloShm7gH74R2oFB0dVLVcGkf 18:33:02 INFO - Expected file size: 22038355 18:33:02 INFO - Obtained file size: 22038355 18:33:06 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:33:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:33:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:33:06 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:33:06 INFO - Http code: 200 18:33:06 INFO - via: 1.1 76bce8bb4fbd102fc0b3aa2e41094b79.cloudfront.net (CloudFront) 18:33:06 INFO - x-amz-cf-id: g9mg17E1blM9bRVkn2xV88PeNDCfaNdv1yFEHS-YfY6aUIuFjqc5oA== 18:33:06 INFO - x-amz-replication-status: PENDING 18:33:06 INFO - x-amz-version-id: TxBKA7rCloShm7gH74R2oFB0dVLVcGkf 18:33:06 INFO - Expected file size: 22038355 18:33:06 INFO - Obtained file size: 22038355 18:33:11 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/1477261808/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:33:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:33:11 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:33:11 INFO - Http code: 200 18:33:11 INFO - via: 1.1 ccaa055c9a26ce13da709353563e04a5.cloudfront.net (CloudFront) 18:33:11 INFO - x-amz-cf-id: yW3p4kOhQL3hm15Fj6Xliy3caHKVw89CDdTLVdvnyKOOABK5yie1Hg== 18:33:11 INFO - x-amz-replication-status: PENDING 18:33:11 INFO - x-amz-version-id: 8a2uSqrUj3ueeDbS1u0I9EiVm1bZrRQW 18:33:11 INFO - Expected file size: 14409028 18:33:11 INFO - Obtained file size: 14409028 18:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:11 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:33:11 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:33:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:33:12 INFO - Downloaded 59378710 bytes. 18:33:12 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:33:12 INFO - mkdir: /builds/slave/test/properties 18:33:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:33:12 INFO - Writing to file /builds/slave/test/properties/build_url 18:33:12 INFO - Contents: 18:33:12 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:33:12 INFO - Running post-action listener: _resource_record_post_action 18:33:12 INFO - Running post-action listener: set_extra_try_arguments 18:33:12 INFO - [mozharness: 2016-10-24 01:33:12.730892Z] Finished download-and-extract step (success) 18:33:12 INFO - [mozharness: 2016-10-24 01:33:12.731120Z] Running populate-webroot step. 18:33:12 INFO - Running pre-action listener: _resource_record_pre_action 18:33:12 INFO - Running main action method: populate_webroot 18:33:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:33:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:33:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:33:12 INFO - '--tppagecycles', 18:33:12 INFO - '7'], 18:33:12 INFO - 'tests': ['tsvgm']}}, 18:33:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:33:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:33:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:33:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:33:12 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:12 INFO - 'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:12 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:33:12 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:12 INFO - 'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['damp', 'tps']}, 18:33:12 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:12 INFO - 'tests': ['damp', 'tps']}, 18:33:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['dromaeo_dom']}, 18:33:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:33:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['basic_compositor_video']}, 18:33:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:33:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['a11yr', 18:33:12 INFO - 'ts_paint', 18:33:12 INFO - 'tpaint', 18:33:12 INFO - 'sessionrestore', 18:33:12 INFO - 'sessionrestore_no_auto_restore', 18:33:12 INFO - 'tabpaint']}, 18:33:12 INFO - 'other-e10s': {'tests': ['a11yr', 18:33:12 INFO - 'ts_paint', 18:33:12 INFO - 'tpaint', 18:33:12 INFO - 'sessionrestore', 18:33:12 INFO - 'sessionrestore_no_auto_restore', 18:33:12 INFO - 'tabpaint']}, 18:33:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:33:12 INFO - 'ts_paint', 18:33:12 INFO - 'tpaint', 18:33:12 INFO - 'sessionrestore', 18:33:12 INFO - 'sessionrestore_no_auto_restore', 18:33:12 INFO - 'tabpaint']}, 18:33:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:33:12 INFO - 'ts_paint', 18:33:12 INFO - 'tpaint', 18:33:12 INFO - 'sessionrestore', 18:33:12 INFO - 'sessionrestore_no_auto_restore', 18:33:12 INFO - 'tabpaint']}, 18:33:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['a11yr', 18:33:12 INFO - 'ts_paint', 18:33:12 INFO - 'tpaint', 18:33:12 INFO - 'sessionrestore', 18:33:12 INFO - 'sessionrestore_no_auto_restore', 18:33:12 INFO - 'tabpaint']}, 18:33:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['a11yr', 18:33:12 INFO - 'ts_paint', 18:33:12 INFO - 'tpaint', 18:33:12 INFO - 'sessionrestore', 18:33:12 INFO - 'sessionrestore_no_auto_restore', 18:33:12 INFO - 'tabpaint']}, 18:33:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['tsvgx', 18:33:12 INFO - 'tsvgr_opacity', 18:33:12 INFO - 'tart', 18:33:12 INFO - 'tscrollx', 18:33:12 INFO - 'cart']}, 18:33:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:33:12 INFO - 'tsvgr_opacity', 18:33:12 INFO - 'tart', 18:33:12 INFO - 'tscrollx', 18:33:12 INFO - 'cart']}, 18:33:12 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:12 INFO - 'talos_options': ['--disable-e10s'], 18:33:12 INFO - 'tests': ['tp5o']}, 18:33:12 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:12 INFO - 'tests': ['tp5o']}, 18:33:12 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:12 INFO - 'talos_options': ['--disable-e10s', 18:33:12 INFO - '--xperf_path', 18:33:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:12 INFO - 'tests': ['tp5n']}, 18:33:12 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:33:12 INFO - 'talos_options': ['--xperf_path', 18:33:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:33:12 INFO - 'tests': ['tp5n']}}, 18:33:12 INFO - 'talos.zip': {'path': '', 18:33:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:33:12 INFO - Running post-action listener: _resource_record_post_action 18:33:12 INFO - [mozharness: 2016-10-24 01:33:12.752779Z] Finished populate-webroot step (success) 18:33:12 INFO - [mozharness: 2016-10-24 01:33:12.752867Z] Running create-virtualenv step. 18:33:12 INFO - Running pre-action listener: _resource_record_pre_action 18:33:12 INFO - Running main action method: create_virtualenv 18:33:12 INFO - Creating virtualenv /builds/slave/test/build/venv 18:33:12 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 18:33:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:33:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:33:12 INFO - Using real prefix '/usr' 18:33:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:33:13 INFO - Installing distribute.............................................................................................................................................................................................done. 18:33:15 INFO - Installing pip.................done. 18:33:15 INFO - Return code: 0 18:33:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:33:15 INFO - Reading from file tmpfile_stdout 18:33:15 INFO - Output received: 18:33:15 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) 18:33:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:15 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 0x7fc99a6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', '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 18:33:15 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 18:33:15 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 18:33:15 INFO - Using env: {'DISPLAY': ':0', 18:33:15 INFO - 'HOME': '/home/cltbld', 18:33:15 INFO - 'LANG': 'en_US.UTF-8', 18:33:15 INFO - 'LANGUAGE': 'en_US:en', 18:33:15 INFO - 'LOGNAME': 'cltbld', 18:33:15 INFO - 'MAIL': '/var/mail/cltbld', 18:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:15 INFO - 'MOZ_NO_REMOTE': '1', 18:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:15 INFO - 'NO_EM_RESTART': '1', 18:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:15 INFO - 'PWD': '/builds/slave/test', 18:33:15 INFO - 'SHELL': '/bin/bash', 18:33:15 INFO - 'SHLVL': '1', 18:33:15 INFO - 'TERM': 'linux', 18:33:15 INFO - 'TMOUT': '86400', 18:33:15 INFO - 'USER': 'cltbld', 18:33:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:15 INFO - '_': '/tools/buildbot/bin/python'} 18:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:15 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 18:33:15 INFO - Cleaning up... 18:33:15 INFO - Return code: 0 18:33:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:15 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 0x7fc99a6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', '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 18:33:15 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 18:33:15 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 18:33:15 INFO - Using env: {'DISPLAY': ':0', 18:33:15 INFO - 'HOME': '/home/cltbld', 18:33:15 INFO - 'LANG': 'en_US.UTF-8', 18:33:15 INFO - 'LANGUAGE': 'en_US:en', 18:33:15 INFO - 'LOGNAME': 'cltbld', 18:33:15 INFO - 'MAIL': '/var/mail/cltbld', 18:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:15 INFO - 'MOZ_NO_REMOTE': '1', 18:33:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:15 INFO - 'NO_EM_RESTART': '1', 18:33:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:15 INFO - 'PWD': '/builds/slave/test', 18:33:15 INFO - 'SHELL': '/bin/bash', 18:33:15 INFO - 'SHLVL': '1', 18:33:15 INFO - 'TERM': 'linux', 18:33:15 INFO - 'TMOUT': '86400', 18:33:15 INFO - 'USER': 'cltbld', 18:33:15 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:15 INFO - '_': '/tools/buildbot/bin/python'} 18:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:15 INFO - Downloading/unpacking psutil>=3.1.1 18:33:15 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 18:33:15 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 18:33:15 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 18:33:15 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 18:33:15 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 18:33:15 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 18:33:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:33:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:18 INFO - Installing collected packages: psutil 18:33:18 INFO - Running setup.py install for psutil 18:33:18 INFO - building 'psutil._psutil_linux' extension 18:33:18 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 18:33:18 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 18:33:18 INFO - building 'psutil._psutil_posix' extension 18:33:18 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 18:33:18 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 18:33:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:33:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:33:18 INFO - Successfully installed psutil 18:33:18 INFO - Cleaning up... 18:33:18 INFO - Return code: 0 18:33:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:18 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 0x7fc99a6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', '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 18:33:18 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 18:33:18 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 18:33:18 INFO - Using env: {'DISPLAY': ':0', 18:33:18 INFO - 'HOME': '/home/cltbld', 18:33:18 INFO - 'LANG': 'en_US.UTF-8', 18:33:18 INFO - 'LANGUAGE': 'en_US:en', 18:33:18 INFO - 'LOGNAME': 'cltbld', 18:33:18 INFO - 'MAIL': '/var/mail/cltbld', 18:33:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:18 INFO - 'MOZ_NO_REMOTE': '1', 18:33:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:18 INFO - 'NO_EM_RESTART': '1', 18:33:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:18 INFO - 'PWD': '/builds/slave/test', 18:33:18 INFO - 'SHELL': '/bin/bash', 18:33:18 INFO - 'SHLVL': '1', 18:33:18 INFO - 'TERM': 'linux', 18:33:18 INFO - 'TMOUT': '86400', 18:33:18 INFO - 'USER': 'cltbld', 18:33:18 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:18 INFO - '_': '/tools/buildbot/bin/python'} 18:33:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:33:18 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 18:33:18 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 18:33:18 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 18:33:18 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 18:33:18 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 18:33:18 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 18:33:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:33:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:33:20 INFO - Installing collected packages: mozsystemmonitor 18:33:20 INFO - Running setup.py install for mozsystemmonitor 18:33:20 INFO - Successfully installed mozsystemmonitor 18:33:20 INFO - Cleaning up... 18:33:20 INFO - Return code: 0 18:33:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc99a6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', '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 18:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:33:20 INFO - Using env: {'DISPLAY': ':0', 18:33:20 INFO - 'HOME': '/home/cltbld', 18:33:20 INFO - 'LANG': 'en_US.UTF-8', 18:33:20 INFO - 'LANGUAGE': 'en_US:en', 18:33:20 INFO - 'LOGNAME': 'cltbld', 18:33:20 INFO - 'MAIL': '/var/mail/cltbld', 18:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:20 INFO - 'MOZ_NO_REMOTE': '1', 18:33:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:20 INFO - 'NO_EM_RESTART': '1', 18:33:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:20 INFO - 'PWD': '/builds/slave/test', 18:33:20 INFO - 'SHELL': '/bin/bash', 18:33:20 INFO - 'SHLVL': '1', 18:33:20 INFO - 'TERM': 'linux', 18:33:20 INFO - 'TMOUT': '86400', 18:33:20 INFO - 'USER': 'cltbld', 18:33:20 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:20 INFO - '_': '/tools/buildbot/bin/python'} 18:33:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:21 INFO - Downloading/unpacking jsonschema==2.5.1 18:33:21 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 18:33:21 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 18:33:21 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 18:33:21 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 18:33:21 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 18:33:21 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 18:33:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:33:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:33:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:33:23 INFO - Downloading functools32-3.2.3-2.tar.gz 18:33:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:33:23 INFO - warning: no files found matching '*.txt' 18:33:23 INFO - no previously-included directories found matching 'build' 18:33:23 INFO - no previously-included directories found matching 'dist' 18:33:23 INFO - no previously-included directories found matching '.git*' 18:33:23 INFO - Installing collected packages: jsonschema, functools32 18:33:23 INFO - Running setup.py install for functools32 18:33:23 INFO - warning: no files found matching '*.txt' 18:33:23 INFO - no previously-included directories found matching 'build' 18:33:23 INFO - no previously-included directories found matching 'dist' 18:33:23 INFO - no previously-included directories found matching '.git*' 18:33:23 INFO - Successfully installed jsonschema functools32 18:33:23 INFO - Cleaning up... 18:33:23 INFO - Return code: 0 18:33:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:33:23 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')]} 18:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:23 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')]} 18:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc99a6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', '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 18:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:33:23 INFO - Using env: {'DISPLAY': ':0', 18:33:23 INFO - 'HOME': '/home/cltbld', 18:33:23 INFO - 'LANG': 'en_US.UTF-8', 18:33:23 INFO - 'LANGUAGE': 'en_US:en', 18:33:23 INFO - 'LOGNAME': 'cltbld', 18:33:23 INFO - 'MAIL': '/var/mail/cltbld', 18:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:23 INFO - 'MOZ_NO_REMOTE': '1', 18:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:23 INFO - 'NO_EM_RESTART': '1', 18:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:23 INFO - 'PWD': '/builds/slave/test', 18:33:23 INFO - 'SHELL': '/bin/bash', 18:33:23 INFO - 'SHLVL': '1', 18:33:23 INFO - 'TERM': 'linux', 18:33:23 INFO - 'TMOUT': '86400', 18:33:23 INFO - 'USER': 'cltbld', 18:33:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:23 INFO - '_': '/tools/buildbot/bin/python'} 18:33:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:33:23 INFO - Cleaning up... 18:33:23 INFO - Return code: 0 18:33:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:33:23 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')]} 18:33:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:23 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')]} 18:33:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:23 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc99a6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', '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 18:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:33:23 INFO - Using env: {'DISPLAY': ':0', 18:33:23 INFO - 'HOME': '/home/cltbld', 18:33:23 INFO - 'LANG': 'en_US.UTF-8', 18:33:23 INFO - 'LANGUAGE': 'en_US:en', 18:33:23 INFO - 'LOGNAME': 'cltbld', 18:33:23 INFO - 'MAIL': '/var/mail/cltbld', 18:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:23 INFO - 'MOZ_NO_REMOTE': '1', 18:33:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:23 INFO - 'NO_EM_RESTART': '1', 18:33:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:23 INFO - 'PWD': '/builds/slave/test', 18:33:23 INFO - 'SHELL': '/bin/bash', 18:33:23 INFO - 'SHLVL': '1', 18:33:23 INFO - 'TERM': 'linux', 18:33:23 INFO - 'TMOUT': '86400', 18:33:23 INFO - 'USER': 'cltbld', 18:33:23 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:23 INFO - '_': '/tools/buildbot/bin/python'} 18:33:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:24 INFO - Downloading/unpacking blobuploader==1.2.4 18:33:24 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 18:33:24 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 18:33:24 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 18:33:24 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 18:33:24 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 18:33:24 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 18:33:25 INFO - Downloading blobuploader-1.2.4.tar.gz 18:33:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:33:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:33:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 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 18:33:26 INFO - Downloading docopt-0.6.1.tar.gz 18:33:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:33:26 INFO - Installing collected packages: blobuploader, requests, docopt 18:33:26 INFO - Running setup.py install for blobuploader 18:33:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:33:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:33:26 INFO - Running setup.py install for requests 18:33:27 INFO - Running setup.py install for docopt 18:33:27 INFO - Successfully installed blobuploader requests docopt 18:33:27 INFO - Cleaning up... 18:33:27 INFO - Return code: 0 18:33:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:27 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 0x7fc99a6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', '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 18:33:27 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 18:33:27 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 18:33:27 INFO - Using env: {'DISPLAY': ':0', 18:33:27 INFO - 'HOME': '/home/cltbld', 18:33:27 INFO - 'LANG': 'en_US.UTF-8', 18:33:27 INFO - 'LANGUAGE': 'en_US:en', 18:33:27 INFO - 'LOGNAME': 'cltbld', 18:33:27 INFO - 'MAIL': '/var/mail/cltbld', 18:33:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:27 INFO - 'MOZ_NO_REMOTE': '1', 18:33:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:27 INFO - 'NO_EM_RESTART': '1', 18:33:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:27 INFO - 'PWD': '/builds/slave/test', 18:33:27 INFO - 'SHELL': '/bin/bash', 18:33:27 INFO - 'SHLVL': '1', 18:33:27 INFO - 'TERM': 'linux', 18:33:27 INFO - 'TMOUT': '86400', 18:33:27 INFO - 'USER': 'cltbld', 18:33:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:27 INFO - '_': '/tools/buildbot/bin/python'} 18:33:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:27 INFO - Running setup.py (path:/tmp/pip-JBoAPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:27 INFO - Running setup.py (path:/tmp/pip-CpdWs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:27 INFO - Running setup.py (path:/tmp/pip-nq1ISL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:27 INFO - Running setup.py (path:/tmp/pip-y1Il4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:27 INFO - Running setup.py (path:/tmp/pip-ROIUF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:27 INFO - Running setup.py (path:/tmp/pip-BK_sI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:27 INFO - Running setup.py (path:/tmp/pip-T9TW_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:28 INFO - Running setup.py (path:/tmp/pip-MmpGXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:28 INFO - Running setup.py (path:/tmp/pip-XewB8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:28 INFO - Running setup.py (path:/tmp/pip-H7l3uD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:28 INFO - Running setup.py (path:/tmp/pip-28afWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:28 INFO - Running setup.py (path:/tmp/pip-qKmVcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:28 INFO - Running setup.py (path:/tmp/pip-IqDJNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:28 INFO - Running setup.py (path:/tmp/pip-LRcTU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:28 INFO - Running setup.py (path:/tmp/pip-ltNwpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:28 INFO - Running setup.py (path:/tmp/pip-eCa8PU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:28 INFO - Running setup.py (path:/tmp/pip-gsLlwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:33:28 INFO - Running setup.py install for manifestparser 18:33:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:33:28 INFO - Running setup.py install for mozcrash 18:33:28 INFO - Running setup.py install for mozdebug 18:33:29 INFO - Running setup.py install for mozdevice 18:33:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:33:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:33:29 INFO - Running setup.py install for mozfile 18:33:29 INFO - Running setup.py install for mozhttpd 18:33:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:33:29 INFO - Running setup.py install for mozinfo 18:33:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:33:29 INFO - Running setup.py install for mozInstall 18:33:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:33:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:33:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:33:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:33:29 INFO - Running setup.py install for mozleak 18:33:29 INFO - Running setup.py install for mozlog 18:33:29 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:33:29 INFO - Running setup.py install for moznetwork 18:33:29 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:33:29 INFO - Running setup.py install for mozprocess 18:33:30 INFO - Running setup.py install for mozprofile 18:33:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:33:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:33:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:33:30 INFO - Running setup.py install for mozrunner 18:33:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:33:30 INFO - Running setup.py install for mozscreenshot 18:33:30 INFO - Running setup.py install for moztest 18:33:30 INFO - Running setup.py install for mozversion 18:33:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:33:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:33:30 INFO - Cleaning up... 18:33:30 INFO - Return code: 0 18:33:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:30 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')]} 18:33:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:30 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')]} 18:33:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:30 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 0x7fc99a6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', '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 18:33:30 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 18:33:30 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 18:33:30 INFO - Using env: {'DISPLAY': ':0', 18:33:30 INFO - 'HOME': '/home/cltbld', 18:33:30 INFO - 'LANG': 'en_US.UTF-8', 18:33:30 INFO - 'LANGUAGE': 'en_US:en', 18:33:30 INFO - 'LOGNAME': 'cltbld', 18:33:30 INFO - 'MAIL': '/var/mail/cltbld', 18:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:30 INFO - 'MOZ_NO_REMOTE': '1', 18:33:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:30 INFO - 'NO_EM_RESTART': '1', 18:33:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:30 INFO - 'PWD': '/builds/slave/test', 18:33:30 INFO - 'SHELL': '/bin/bash', 18:33:30 INFO - 'SHLVL': '1', 18:33:30 INFO - 'TERM': 'linux', 18:33:30 INFO - 'TMOUT': '86400', 18:33:30 INFO - 'USER': 'cltbld', 18:33:30 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:30 INFO - '_': '/tools/buildbot/bin/python'} 18:33:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:33:30 INFO - Running setup.py (path:/tmp/pip-QXvcdq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:33:30 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)) 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:33:30 INFO - Running setup.py (path:/tmp/pip-BfpcZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:33:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:33:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:33:30 INFO - Running setup.py (path:/tmp/pip-6o0ekZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:33:31 INFO - Running setup.py (path:/tmp/pip-XHho98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:33:31 INFO - Running setup.py (path:/tmp/pip-sNqfUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:33:31 INFO - Running setup.py (path:/tmp/pip-dp_UWI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:33:31 INFO - Running setup.py (path:/tmp/pip-WAtVTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:33:31 INFO - Running setup.py (path:/tmp/pip-PIkkkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:33:31 INFO - Running setup.py (path:/tmp/pip-YsuVzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:33:31 INFO - Running setup.py (path:/tmp/pip-tp99cg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:33:31 INFO - Running setup.py (path:/tmp/pip-TMHQZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:33:31 INFO - Running setup.py (path:/tmp/pip-0CXtLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:33:31 INFO - Running setup.py (path:/tmp/pip-XC8bQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:33:31 INFO - Running setup.py (path:/tmp/pip-2Ffqvn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:33:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:31 INFO - Running setup.py (path:/tmp/pip-6MGSY2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:33:31 INFO - Running setup.py (path:/tmp/pip-827OYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:33:31 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)) 18:33:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:33:31 INFO - Running setup.py (path:/tmp/pip-RDIWzh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:33:32 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)) 18:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:33:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:33:32 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)) 18:33:32 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)) 18:33:32 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)) 18:33:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:33:32 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 18:33:32 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 18:33:32 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 18:33:32 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 18:33:32 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 18:33:32 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 18:33:33 INFO - Downloading blessings-1.6.tar.gz 18:33:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:33:34 INFO - Installing collected packages: blessings 18:33:34 INFO - Running setup.py install for blessings 18:33:34 INFO - Successfully installed blessings 18:33:34 INFO - Cleaning up... 18:33:34 INFO - Return code: 0 18:33:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:33:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:34 INFO - Reading from file tmpfile_stdout 18:33:34 INFO - Current package versions: 18:33:34 INFO - argparse == 1.2.1 18:33:34 INFO - blessings == 1.6 18:33:34 INFO - blobuploader == 1.2.4 18:33:34 INFO - docopt == 0.6.1 18:33:34 INFO - functools32 == 3.2.3-2 18:33:34 INFO - jsonschema == 2.5.1 18:33:34 INFO - manifestparser == 1.1 18:33:34 INFO - mozInstall == 1.12 18:33:34 INFO - mozcrash == 0.17 18:33:34 INFO - mozdebug == 0.1 18:33:34 INFO - mozdevice == 0.48 18:33:34 INFO - mozfile == 1.2 18:33:34 INFO - mozhttpd == 0.7 18:33:34 INFO - mozinfo == 0.9 18:33:34 INFO - mozleak == 0.1 18:33:34 INFO - mozlog == 3.4 18:33:34 INFO - moznetwork == 0.27 18:33:34 INFO - mozprocess == 0.23 18:33:34 INFO - mozprofile == 0.28 18:33:34 INFO - mozrunner == 6.12 18:33:34 INFO - mozscreenshot == 0.1 18:33:34 INFO - mozsystemmonitor == 0.3 18:33:34 INFO - moztest == 0.7 18:33:34 INFO - mozversion == 1.4 18:33:34 INFO - psutil == 3.1.1 18:33:34 INFO - requests == 1.2.3 18:33:34 INFO - wsgiref == 0.1.2 18:33:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:34 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 0x7fc99a6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', '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 18:33:34 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 18:33:34 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 18:33:34 INFO - Using env: {'DISPLAY': ':0', 18:33:34 INFO - 'HOME': '/home/cltbld', 18:33:34 INFO - 'LANG': 'en_US.UTF-8', 18:33:34 INFO - 'LANGUAGE': 'en_US:en', 18:33:34 INFO - 'LOGNAME': 'cltbld', 18:33:34 INFO - 'MAIL': '/var/mail/cltbld', 18:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:34 INFO - 'MOZ_NO_REMOTE': '1', 18:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:34 INFO - 'NO_EM_RESTART': '1', 18:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:34 INFO - 'PWD': '/builds/slave/test', 18:33:34 INFO - 'SHELL': '/bin/bash', 18:33:34 INFO - 'SHLVL': '1', 18:33:34 INFO - 'TERM': 'linux', 18:33:34 INFO - 'TMOUT': '86400', 18:33:34 INFO - 'USER': 'cltbld', 18:33:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:34 INFO - '_': '/tools/buildbot/bin/python'} 18:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:34 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)) 18:33:34 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)) 18:33:34 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)) 18:33:34 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)) 18:33:34 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)) 18:33:34 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)) 18:33:34 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)) 18:33:34 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)) 18:33:34 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)) 18:33:34 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)) 18:33:34 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)) 18:33:34 INFO - Cleaning up... 18:33:34 INFO - Return code: 0 18:33:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:33:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:33:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:33:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:33:34 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 0x7fc99a6e7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x228d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x235aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', '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 18:33:34 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 18:33:34 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 18:33:34 INFO - Using env: {'DISPLAY': ':0', 18:33:34 INFO - 'HOME': '/home/cltbld', 18:33:34 INFO - 'LANG': 'en_US.UTF-8', 18:33:34 INFO - 'LANGUAGE': 'en_US:en', 18:33:34 INFO - 'LOGNAME': 'cltbld', 18:33:34 INFO - 'MAIL': '/var/mail/cltbld', 18:33:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:34 INFO - 'MOZ_NO_REMOTE': '1', 18:33:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:34 INFO - 'NO_EM_RESTART': '1', 18:33:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:34 INFO - 'PWD': '/builds/slave/test', 18:33:34 INFO - 'SHELL': '/bin/bash', 18:33:34 INFO - 'SHLVL': '1', 18:33:34 INFO - 'TERM': 'linux', 18:33:34 INFO - 'TMOUT': '86400', 18:33:34 INFO - 'USER': 'cltbld', 18:33:34 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:34 INFO - '_': '/tools/buildbot/bin/python'} 18:33:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:33:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:33:34 INFO - Cleaning up... 18:33:34 INFO - Return code: 0 18:33:34 INFO - Running post-action listener: _resource_record_post_action 18:33:34 INFO - Running post-action listener: _start_resource_monitoring 18:33:34 INFO - Starting resource monitoring. 18:33:34 INFO - [mozharness: 2016-10-24 01:33:34.948791Z] Finished create-virtualenv step (success) 18:33:34 INFO - [mozharness: 2016-10-24 01:33:34.949366Z] Running install step. 18:33:34 INFO - Running pre-action listener: _resource_record_pre_action 18:33:34 INFO - Running main action method: install 18:33:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:33:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:33:35 INFO - Reading from file tmpfile_stdout 18:33:35 INFO - Detecting whether we're running mozinstall >=1.0... 18:33:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:33:35 INFO - Reading from file tmpfile_stdout 18:33:35 INFO - Output received: 18:33:35 INFO - Usage: mozinstall [options] installer 18:33:35 INFO - Options: 18:33:35 INFO - -h, --help show this help message and exit 18:33:35 INFO - -d DEST, --destination=DEST 18:33:35 INFO - Directory to install application into. [default: 18:33:35 INFO - "/builds/slave/test"] 18:33:35 INFO - --app=APP Application being installed. [default: firefox] 18:33:35 INFO - mkdir: /builds/slave/test/build/application 18:33:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:33:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:33:52 INFO - Reading from file tmpfile_stdout 18:33:52 INFO - Output received: 18:33:52 INFO - /builds/slave/test/build/application/firefox/firefox 18:33:52 INFO - Running post-action listener: _resource_record_post_action 18:33:52 INFO - [mozharness: 2016-10-24 01:33:52.150207Z] Finished install step (success) 18:33:52 INFO - [mozharness: 2016-10-24 01:33:52.150483Z] Running run-tests step. 18:33:52 INFO - Running pre-action listener: _resource_record_pre_action 18:33:52 INFO - Running main action method: run_tests 18:33:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:33:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:33:52 INFO - Python 2.7.3 18:33:52 INFO - Return code: 0 18:33:52 INFO - grabbing minidump binary from tooltool 18:33: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')]} 18:33:52 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 0x2357f60>, '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 0x2358d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23591d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:33:52 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 18:33:52 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 18:33:52 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 18:33:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:33:52 INFO - Return code: 0 18:33:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:33:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:33:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:33:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:33:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:33:52 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:33:52 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-068 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:33:52 INFO - Using env: {'DISPLAY': ':0', 18:33:52 INFO - 'HOME': '/home/cltbld', 18:33:52 INFO - 'LANG': 'en_US.UTF-8', 18:33:52 INFO - 'LANGUAGE': 'en_US:en', 18:33:52 INFO - 'LOGNAME': 'cltbld', 18:33:52 INFO - 'MAIL': '/var/mail/cltbld', 18:33:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:33:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:33:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:33:52 INFO - 'MOZ_NO_REMOTE': '1', 18:33:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:33:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:33:52 INFO - 'NO_EM_RESTART': '1', 18:33:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:33:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:33:52 INFO - 'PWD': '/builds/slave/test', 18:33:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:33:52 INFO - 'SHELL': '/bin/bash', 18:33:52 INFO - 'SHLVL': '1', 18:33:52 INFO - 'TERM': 'linux', 18:33:52 INFO - 'TMOUT': '86400', 18:33:52 INFO - 'USER': 'cltbld', 18:33:52 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430', 18:33:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:33:52 INFO - '_': '/tools/buildbot/bin/python'} 18:33:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:33:52 INFO - mozversion application_buildid: 20161023153008 18:33:52 INFO - mozversion application_changeset: 9adfea13296e07e6ef662362d9f871c065c66505 18:33:52 INFO - mozversion application_display_name: Nightly 18:33:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:33:52 INFO - mozversion application_name: Firefox 18:33:52 INFO - mozversion application_remotingname: firefox 18:33:52 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:33:52 INFO - mozversion application_vendor: Mozilla 18:33:52 INFO - mozversion application_version: 52.0a1 18:33:52 INFO - mozversion platform_buildid: 20161023153008 18:33:52 INFO - mozversion platform_changeset: 9adfea13296e07e6ef662362d9f871c065c66505 18:33:52 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:33:52 INFO - mozversion platform_version: 52.0a1 18:33:52 INFO - using testdate: 1477272832 18:33:52 INFO - actual date: 1477272832 18:33:52 INFO - starting webserver on 'localhost:53956' 18:33:52 INFO - SUITE-START | Running 2 tests 18:33:52 INFO - TEST-START | dromaeo_css 18:33:52 INFO - operating with platform_type : linux_ 18:33:52 INFO - Initialising browser for dromaeo_css test... 18:33:52 INFO - TEST-INFO | started process 11418 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOHeE3/profile http://localhost:53956/getInfo.html) 18:33:56 INFO - PROCESS | 11418 | __metrics Screen width/height:1600/1200 18:33:56 INFO - PROCESS | 11418 | colorDepth:24 18:33:56 INFO - PROCESS | 11418 | Browser inner width/height: 1024/697 18:33:56 INFO - PROCESS | 11418 | __metrics 18:33:56 INFO - PROCESS | 11418 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:33:56 INFO - PROCESS | 11418 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:33:57 INFO - PROCESS | 11418 | console.error: PushService: 18:33:57 INFO - PROCESS | 11418 | stateChangeProcessEnqueue: Error transitioning state 18:33:57 INFO - PROCESS | 11418 | UnknownError 18:33:58 INFO - TEST-INFO | 11418: exit 0 18:33:58 INFO - Browser initialized. 18:33:58 INFO - Running cycle 1/1 for dromaeo_css test... 18:33:58 INFO - TEST-INFO | started process 11497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNOHeE3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:34:10 INFO - PROCESS | 11497 | RSS: Main: 171925504 18:34:10 INFO - PROCESS | 11497 | 18:35:01 INFO - PROCESS | 11497 | 1477272901411 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] 18:37:12 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:53956/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53956/tests/dromaeo/cssquery-ext.html) 18:37:14 INFO - PROCESS | 11497 | RSS: Main: 290316288 18:37:14 INFO - PROCESS | 11497 | 18:40:16 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:53956/tests/dromaeo/cssquery-ext.html (next: http://localhost:53956/tests/dromaeo/cssquery-jquery.html) 18:40:17 INFO - PROCESS | 11497 | RSS: Main: 280113152 18:40:17 INFO - PROCESS | 11497 | 18:43:19 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:53956/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53956/tests/dromaeo/cssquery-mootools.html) 18:43:19 INFO - PROCESS | 11497 | RSS: Main: 215498752 18:43:19 INFO - PROCESS | 11497 | 18:46:22 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:53956/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53956/tests/dromaeo/cssquery-prototype.html) 18:46:22 INFO - PROCESS | 11497 | RSS: Main: 214646784 18:46:22 INFO - PROCESS | 11497 | 18:49:25 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:53956/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53956/tests/dromaeo/cssquery-yui.html) 18:49:25 INFO - PROCESS | 11497 | RSS: Main: 215736320 18:49:25 INFO - PROCESS | 11497 | 18:52:28 INFO - PROCESS | 11497 | Cycle 1(1): loaded http://localhost:53956/tests/dromaeo/cssquery-yui.html (next: http://localhost:53956/tests/dromaeo/cssquery-dojo.html) 18:52:29 INFO - PROCESS | 11497 | RSS: Main: 306384896 18:52:29 INFO - PROCESS | 11497 | 18:52:29 INFO - PROCESS | 11497 | __start_tp_report 18:52:29 INFO - PROCESS | 11497 | _x_x_mozilla_page_load 18:52:29 INFO - PROCESS | 11497 | _x_x_mozilla_page_load_details 18:52:29 INFO - PROCESS | 11497 | |i|pagename|runs| 18:52:29 INFO - PROCESS | 11497 | |0;dojo.html;3067.6932306769318;3089.366679830635;3114.71967522923;3130.968690313098;3135.2005238664137;5272.971770504753;5306.416294207639;5332.413434522199;5386.865328366788;5473.890522189554;5368.62419630625;5371.4897084776985;5372.167314066316;5379.488948549892;5385.488378604026;4826.686265392756;4853.174960256747;4877.829275975341;4888.975555122237;4939.50604939505;4949.7030178189425;5004;5009.02324046811;5010.574101201402;5013.3482647255805;4939;4972.627052971024;4998.600111991032;5011.949880501203;5019.673721208128;5039.496050394986;5057.620678449131;5059.418166910816;5066.164082926312;5123.257127716461;4789.568938795525;4835.540623640783;4847.079054979543;4939.431965323998;4946.975265123688;5338.119210330291;5351.732413379315;5374.113271310229;5402.405735369106;5415.918761218585;5784.07454807233;5784.71076446176;5792.420757924216;5793.391693872125;5801;5621.8594535136945;5692.943070569324;5815.709214539256;5840.386759390245;5842.795502157446;5373.785048598052;5418.024755543961;5420.13277875538;5420.268263784417;5492.340919089655;5894.38108998549;5940.732667029994;5944.167816505693;5951.077582974646;5954.55340849438;5581.6930068845795;5705.914411283751;5705.942940570624;5706.201131841545;5707.0583353747;5716.799912003143;5744.770209191585;5825.970870145622;5836.824895253149;5858.004139296329;5665.206871038058;5699.943000570024;5703.258576385127;5726.055200891889;5743.62666426681;5729.398413166641;5732.742026608813;5742.856428589319;5756.798512052058;5804.796832110856;4315.870523884289;4353.281708518059;4354.695171337976;4384.890377740582;4413.117376524708;3922.2155568886337;3935.5080614923136;3958.2677204716642;3974.6025397460603;3981;5397.27136836522;5431;5439.374471935778;5448.754806033738;5449.427810079964;5661.858453538694;5710.486056254874;5807.157962095557;5813;5826.2134611827705;5502.779888804483;5516.531094856982;5524.8342549723575;5581.079121944915;5602.047651899187;4855.6115510759055;4865.294532292868;4866.124097662455;4880.536349046835;4884.169691152512;5764.827055188351;5813.476787089182;6006.33930267679;6014.097885317237;6021.789237376671;5798.188253644409;5858.033424485083;5862.882742345215;5872.970635146797;5936.732847021981;5997.3402925677265;6007.098935159761;6012.939870601238;6015.939840601538;6016.037434010537;5578.944210557843;5723.112917497794;5757.625754326123;5771.163181338767;5775.8556036099435;5726.370099288992;5805.970970145122;5846.619969701956;5881.9705901470215;5953.76184952597;5688.601797874109;5712.914306285492;5715.142728590745;5718.399568045295;5722.341930678025;5695.345035320991;5711.8857622848145;5713.600047996601;5720.199172115824;5721;5431.456854314695;5477.452254774491;5642.097264437671;5686.374498805211;5692.715364231854;5732.856678583069;5743.396943321059;5743.4543718346695;5744.684042377709;5786.826395208151;5396.9730151348995;5443.836684899459;5606.6636001840025;5620.718964051699;5626.887462250814 18:52:29 INFO - PROCESS | 11497 | |1;ext.html;546.0680764868689;578.4215784215784;601.2394321183704;616.0728104203174;636.5385095805539;33706.325873482514;34422;40904;42176;42246;43747;44056.339154912625;44217.55782442175;44222.33666495005;44565.331520027226;8672.566371681438;8870.024297327289;8872.37893347466;8876.511791851446;8879.600417981206;7922.841543169133;8119;8665.610047547876;10300.07299343059;10552.525136368844;10641.148708103334;10687.679369618885;10704.78590428191;10709.839352409721;10740.194485413585;10544.736381590445;10613.57545698171;10619.840702389432;10620.522076506499;10632.946835265851;7756.224377562198;8008.959955200245;10012.849807252824;10184.847227291597;10362.481875906175;41616;41966.37050444246;41988;41988.79005604983;42009.57990420087;3032.9545056824163;3149.291409432882;3158.147300228948;3509.7016753575977;3688.1517251032146;31649.367012659848;31760.841195794103;32037.038888833373;33078.834605827054;33229;4029.2747305485;4073.837046518165;4111.362738775495;4151.7924103794685;4162.562930892243;322720;322959;324037.9999999976;324212;324265;56151.43848561462;56353;56439.43560564424;56505;56607;58953.41046589565;59644.40355596389;59875;59879.40120598825;59951.70024149851;15723.21383930799;15858.920705396398;15974.041557506587;15984.76022859658;16000.199990000454;11409.372484513266;12254.08094392924;12347.506099756089;12348.753024939451;12359.25844449336;14453.710925781636;15941.920290398706;16421.425250116426;16492.17539123063;17115.486535403958;5125.820596279187;5799.159121927381;5821.390737742542;5873.353931067579;5883.882322353529;820.3683163963715;861.8104017116225;914.826183025223;941.275218082073;968.3441315350829;28225.576616350772;29827.40345193084;30417.543736843523;30581.847090764404;30799.538006929914;1001.6043662753171;1026.235454586338;1043.9895601043893;1059.8940105989493;1100.3507930320989;14943.925280373745;15925.681486370207;15975.12136832462;15977.281022354022;16152.596185095466;469921;473559;473901;474403;474725;56822.71588642113;57059;57124.42875571274;57202.14196787051;57242;1264.563725514696;1289.7807372746656;1297.4680381043916;1313.1136482874213;1326.0916272353468;27826;29774.25564360908;29834;29908.551371729005;30580.235494112825;48336.5166348332;48660.75669621629;48709.756451217516;48722.5127748718;48753.5124648749;443359;444578;445113;445908.39320623624;450291;24095.404304828524;24210.636840447758;24621;27147.72852271452;27758.583621245292;39778.60221397749;39955.80022099871;40400.3939940907;43291.56708432875;46860.29709554427;37573.62426375701;39161;40156.79921600373;40710.389344159266;42137.15725685408;39373.60626393699;40242.1951560973;40750.38874416827;41159.588404116774;41508.58491415168;37630.247395052495;38408;38498.2300353997;38724.612753873225;39303.60696393;33837;36012.45981310335;36404;36559.26881462409;36723.081922951074;26543.416638753522;26886.193414197605;26943.86528067347;27228.007091666816;27240 18:52:29 INFO - PROCESS | 11497 | |2;jquery.html;349.7621617300238;374.98125093745324;375.13157041449045;379.3853956590323;394.4339872283274;14166.504172353956;17969.910150449246;17997.91001044993;18338.35815746446;19513.804861951412;17547;17998.280068797267;18113.275468981257;18250.361237356694;18389.356372526963;5047.697138171703;5271.7874888775605;5277.498637629419;5278.181881808326;5285.445028272034;3817.179306449113;4173.853915112972;5151.6908985461;5224.503672151159;5227.424983251839;4346.5436129206455;6472.546921715481;6524.478041756648;6527.216733991928;6528.738850445977;5679.630823996468;5721.227634269362;6032.517398608101;6528.3145269746465;6531.542792004561;5542.279503664538;5545.861353466155;5549.334079910396;5552.69460179694;5557.083081291582;12625.684357891034;16338.264778085015;21058.789412105834;21744.34766956994;21903.780962190493;2097.7902209779054;2172.055156007142;2257.9661305080435;2476.628505724138;2602.167306461933;9737.172340351079;9982.401055936667;10030.749231269278;10173.796524069478;10353.171746260356;1860.0699650174913;1891.8770279931898;1925.3165126380075;1973.6644770389069;1974.1116497576147;76492.61753691251;77616.22383776147;78310.21689783086;78670;79856;10075.395476271447;10389.532471038821;10485.318454300446;10850.29473084247;10915.945420273007;14954.327055282538;15082.396704131712;15111.773323400157;15122.697546049018;15131.47039853622;7445.292697193866;7586.835068167542;7728.574928378993;7789.7273595423885;8018.759437216893;6978.197507286727;7167.605781681953;7480.588567628833;7760.844783104306;7774.183710710294;4557.817687292538;4587.472440669299;4607.308903664477;4765.451973023078;4783.402074740658;1840.1816231320065;1917.3001854323072;1950.9317173898846;1958.177565422526;1974.1215159254282;402.92143032109044;409.80534246233395;423.8580075674622;810.4610434061401;925.9537023148815;10654.307470014424;10768.94615526933;10938.781224375469;10968.670939871816;11258.21192516516;446.8525386622407;452.1544711389657;455.71062375391864;459.0474764862923;463.9141758774638;5681.2330335404195;5736.942630573724;5886.587938844325;5951.9107213391835;6054.334023257438;433560;456101;480363;482374;485482;69671.65164174147;93069;96709.51645241729;96730;98494;467.5698357511098;478.26824957814597;478.7414796010185;481.29009710676473;482.45482604656513;10182.847257291294;10740.892591073989;11227.101831853268;11500.424978750862;11632.709182270173;40942.385864211465;41360.17621232946;41776.373354399104;42905.785471073694;43326;55091;55490.16764748613;55995;56659.15011274752;56667;7863.174366691415;8001.439899207233;8075.434719569574;8261.958690206511;8516.61675224604;10594.31136976094;12544;12688;12723.55467558631;12775.169613975062;10609.416482093558;10776.461176941279;10863.239573229797;10911.399873007062;10924.781504369708;9775.21798256152;9941.751456213653;10029;11534.365609891536;11617.419129043683;10956.123510119012;11607.409620555654;11628.6511404658;11956.282623042645;12257.14200005991;8481.745547633582;8525.87211191845;8618.267447266802;8654.913450865663;8835.249003834746;10304.433256170683;11262.718432039264;11281.943590281997;11419.429028548373;11776.11679124052 18:52:29 INFO - PROCESS | 11497 | |3;mootools.html;1427.2007675701611;1448.2830998655663;1583.3349993002937;1702.31056422149;1704.7016772064885;8008.55952922589;8294.419390642657;8444.113368096347;9107.49908755019;9112.544372781367;8543.145685431453;8869.645214191441;8902.643894244238;9131.2238459731;9133.908660913388;2135.3914134471715;2179.553191595719;2179.7057397251406;2184.3992901951933;2186.147402513021;1875.1468082022648;1949.4151754473671;2132.701421800949;2178.9891050544725;2193.9561208775813;2090.205721825712;2176.3906106290265;2176.81497072749;2182.039902442928;2187;2147.688585155159;2167.3931299236237;2172.31572054803;2177.7060096887035;2184.028107492167;2143.7749036351115;2145.1955516681246;2145.5065334972887;2146.474113842103;2149.022194901316;8868.46789192644;9049.411788233743;9100.226480749145;9103.453792772454;9112.043235460314;5094.847154585368;5238.973805130988;5246.97376513115;5249.685018898878;5254.08053590624;3211.3256216194627;3230.644629090798;3269.476883698597;3298.7855789373616;3446.5347178130883;1144.765084664918;1154.584349634131;1186.1643883127606;1209.3046498263445;1212.6422705301957;12896;12989.41547630359;13029.543965961146;13034.869651303556;13038.608841734764;4282.785860706952;4360.825566977349;4557.475890272661;4575.2450845610765;4588.810776510293;10742.409167495707;10756.946215268874;10760.139188864872;10763.461826908624;10769.461526923622;5282.339707536558;5303.363596368384;5305.495977882095;5305.920411193835;5309.123994540934;4731.408573928259;4838.395200599925;4860.198067318924;4880.804767809248;4881.536254055859;3904.336262835268;3906.824192911269;3982.203559288154;4016.1324983882637;4171.374293855946;1125.2348403085816;1166.1370585766472;1240.1195151442396;1278.7506436244844;1296.9935150324188;869.8738682890945;920.5213289089636;931.3759780946782;937.2033771294346;943.7263193673895;5781.82654520365;5997.250343707036;6021.819345419644;6042.39576042401;6195.008798592204;882.5851849630664;895.9596818143199;916.8140711029254;953.993536818663;958.3962103874654;3697.5008373869723;3970.920581588352;3985.740926839746;4015.297322968469;4100.979495102565;11219.887801121884;11535.19253652253;11565.537378504765;11641.76716465666;11686.18196726238;11618.360990145624;11636.185467017396;11648.65054048363;11651.708707282385;11659.591914282959;7983.680652773824;8300.584970751439;8394.664213431517;8574.056853746082;8592.957035214784;5947.193537475916;5977.252843394575;6039.849003774941;6109.602875813058;6130.356312587114;10457.738556536147;10616;10636.52135653882;10693.198010149426;10760.246782725135;10425.113865321533;10563.366198028143;10708.625198118028;10847.728806779578;10912.61805836792;7740.6903723852665;7950.880736789069;7951.369969156424;7952.085510166174;7958.602069896598;8626.223639872442;8644.870326945227;8666.046734859287;8676.175763302475;8723.694670686495;7525.623718814147;7868.213178682086;8032.518048917083;8074.87887681697;8113.229243221885;7773.4169937256065;7814.804629884071;7847.176046515034;7850.332721718718;7908.209179082046;6650;6869.278725733926;6873.656317184221;6943;7027.824304392431;4970.080535101018;5071.39143302806;5088.262201980618;5125.820596279113;5137.023965446553;4958.513241936521;5028.421731500925;5113.51421614946;5194.636375453833;5216.035033518811 18:52:29 INFO - PROCESS | 11497 | |4;prototype.html;314.7214714977245;321.8921661243483;323.13060026960585;329.1376593325486;332.2524320279371;5308.416074231836;5326.387465441476;5363.651362661429;5365.490278423548;5408.378036525801;5288.101022826119;5346.224797404374;5379.919301210485;5398;5399.19012148178;3981.781002044901;4012.7592344459354;4139.77231252281;4147.294959856831;4159.417681524574;4153.605407486299;4178.937315940263;4188.4136220929095;4201.1807697499;4223.218704539655;4149.439825623533;4153.646940010103;4161.667066634662;4199.4120823084795;4202.159568086379;3983.143624120799;4127.587241275878;4156.605122513356;4169.666426685858;4179.665626749883;3664.523611930432;3673.3938900081453;3673.412254039368;3677.2461645362637;3704.240630670706;5118.667286626394;5155.948440515622;5189.974050129763;5190.24741412493;5221.73891305437;4679.940826036533;4749.216379297412;4751.714897106184;4786.808527658889;4792.634099281688;5497.405752331819;5505.724713764296;5514.6139770216105;5526.47498487647;5528.44715528448;4055.2295063938054;4056.371262454295;4062.5124985001694;4065.715399922007;4067.4712287402745;5703.629264097862;5751.654900705929;5764.740586673568;5838.970805145947;5858.355580886099;4115.691323150776;4121.1345617420075;4134.958650413518;4144.979275103605;4156.397322388237;4201.852935147316;4204.201201771653;4205.3271476563605;4206.537280899099;4219.641330486882;4597.632189424838;4761.333413322138;4769.35613692154;4791.401074865642;4792.95207047932;5555.611107222456;5565.471280228453;5579.13523403873;5630.662160270397;5649.152627105885;1435.978460323096;1451.7459444597152;1454.1420561868338;1471.3673120558049;1479.6226962124804;910.0657913804628;932.8227636748996;942.9434233945985;945.5366870233536;963.9036096390305;5194.714290713971;5226.275329141375;5422.349318081855;5439.972800135974;5445.428230035868;5754.769809207669;5788.479036886701;5791.478766910998;5808.157817116495;5815.957909253113;5295.17316525798;5380.596455265871;5401.108817045144;5442.455754424526;5506.614536982373;3013.6835632258735;3032.529957856536;3042.300270937697;3044.4672182368;3058.6023816904103;5907.409259074144;5910.408959104056;5912.556558258062;5924.526037916957;5938.317093534299;5600.52395546375;5934.584579079423;5938.257717785277;5957.940420595825;5983.910241346383;5998.520118390518;6010.248718910137;6013.909791353133;6015.368386319548;6021.337652858182;5590.273264475592;5748.5688573358;5797.246357973437;5805.3033635962265;5848.56135789826;5720.885582288414;5731.312242530923;5737.967165910176;5738.68437235956;5745.597808153389;5852.678102704393;5866.2960444746905;5997.230816908935;6005.849853753691;6019.849503762441;4086.3053280941717;4088.366303223005;4105.363668631367;4105.958940410677;4122.2579935611875;5785.508231800344;5812.3025236971835;5816.098504731774;5822.097574875901;5850.678212698343;5546.833594992157;5683.8010669626365;5755.064916892331;5765.164051212467;5770;5608.663480191201;5618.831435056954;5619.381867994435;5635.9436405635415;5658.20785090096;5595.63628364155;5616.943830561806;5639.830805075854;5671.858203544779;5685;5301.284326615858;5386.622936394571;5635.380108188178;5649.576281778801;5656.490915817596;5525.834224973257;5529.806456773994;5571.331440227199;5579;5580.693061881473 18:52:29 INFO - PROCESS | 11497 | |5;yui.html;655.6951017776732;688.3254410677536;694.9861002779948;707.169076335306;736.6500912066767;14946.10323380598;15817;16078.59803504913;16354.427595034176;16365.42721004765;14867;14950.925245373784;15397.230138493058;15853.762193567105;16125.516234512954;642.1683919324486;785.9921400786005;808.2160304504621;808.4138999225573;809.5426084262373;660.7489154121428;769.7152053740124;790.3005839831761;801.5391150088693;802.4262652203673;846.1453931529138;847.3263755314509;848.5248260973874;849.583703985046;850.5407080176698;676.6346173066538;844.8690452979768;845.0282175498165;845.0408786027841;845.2435070611799;508.7379999300363;598.0550729846875;613.3804857094323;614.665007570875;618.3538202578271;15208.467703630431;15222.238888055665;15242.695146097016;15247.39010439581;15252.542423727306;14004.22976736279;14102.153870767786;14268.357923893449;14599.343029563588;14755.26223688822;13105.737885242337;13335.333233338295;13454.461821527128;13469.12450690702;13650.112742671694;4341.45731783527;4417.889552761175;4426.84506042287;4452.821887124511;4477.776111194427;76797.61601191958;77545.99999999943;78220.60889695572;78649.60675196645;78981;10801;10992.725181870517;11257.71855703614;11320;11487.655370338904;19364.515887102654;20574.69137962932;20671.379858603967;20700.48248793762;21316.655167931516;8538.914610853812;8816.823663526693;8932.821343573092;8934.195922367018;9001.729948101567;4638.652101092364;4718.528147185254;4731.384919960452;4789.640776941744;4804.711717296904;3516.1033936346066;3638.9636103639154;3643.362411577963;3651.94522082169;3652.2878038782183;625.9874802503924;627.576385939489;632.2110016624091;635.5011316116826;638.9297177310492;520.8958208358343;533.9519443250049;543.9610344242557;569.6212019007314;608.3369127650882;9640.90359096414;9709.36889102206;9807.460589667637;9823.901760982299;9970.205363034724;618.981430557084;636.8471566823929;644.5359341274275;650.2294780684904;657.9868402631921;4514.378838166043;4688;4741.881452963704;4868.477770786141;4921.778519966539;85540.14459855322;99236;103267;103273;110184;80634;84033.57983210045;85064;89388.5530572356;92836.0716392841;80602;80611.59694201492;80805.19194808094;83166.75249871257;84289;9136.406133601295;9999.15007224365;10025.398476091457;10140.645077422254;10238;48046.5195348042;49083.5091649079;49612.50387496223;49969;50273.74863125661;72161;72559.63720181577;73508;74589.53239251858;76024.61987690027;12141.939290303491;12548.560800371943;12568.560100396442;12629.621111366674;13342.733145336844;13872;14062.648433788829;14317.296348801638;14370.928145359207;14657.853421465648;13343;13385.933070334586;13475.528356507475;13680.247586382844;14532.27338633043;12789.61631151067;13052.738945221232;13333.933330333286;13450.730985380042;13569.321533923066;13119.934400328319;13169.604911852659;13264.270465124126;13896.652583685489;13935.163890166623;11029.669109926715;11034.724131896766;11121.27711698737;11249.1563132767;11335.773284534098;10969.177311701815;11297.830532541853;11323.943380283046;11467.885321146681;11578.652640420802 18:52:29 INFO - PROCESS | 11497 | __end_tp_report 18:52:29 INFO - PROCESS | 11497 | __start_cc_report 18:52:29 INFO - PROCESS | 11497 | _x_x_mozilla_cycle_collect,1098 18:52:29 INFO - PROCESS | 11497 | __end_cc_report 18:52:29 INFO - PROCESS | 11497 | __startTimestamp1477273949141__endTimestamp 18:52:29 INFO - PROCESS | 11497 | 18:52:29 INFO - PROCESS | 11497 | ------- Summary: start ------- 18:52:29 INFO - PROCESS | 11497 | Number of tests: 6 18:52:29 INFO - PROCESS | 11497 | 18:52:29 INFO - PROCESS | 11497 | [#0] dojo.html Cycles:165 Average:5377.79 Median:5620.72 stddev:616.92 (11.0%) stddev-sans-first:591.59 18:52:29 INFO - PROCESS | 11497 | Values: 3067.7 3089.4 3114.7 3131.0 3135.2 5273.0 5306.4 5332.4 5386.9 5473.9 5368.6 5371.5 5372.2 5379.5 5385.5 4826.7 4853.2 4877.8 4889.0 4939.5 4949.7 5004.0 5009.0 5010.6 5013.3 4939.0 4972.6 4998.6 5011.9 5019.7 5039.5 5057.6 5059.4 5066.2 5123.3 4789.6 4835.5 4847.1 4939.4 4947.0 5338.1 5351.7 5374.1 5402.4 5415.9 5784.1 5784.7 5792.4 5793.4 5801.0 5621.9 5692.9 5815.7 5840.4 5842.8 5373.8 5418.0 5420.1 5420.3 5492.3 5894.4 5940.7 5944.2 5951.1 5954.6 5581.7 5705.9 5705.9 5706.2 5707.1 5716.8 5744.8 5826.0 5836.8 5858.0 5665.2 5699.9 5703.3 5726.1 5743.6 5729.4 5732.7 5742.9 5756.8 5804.8 4315.9 4353.3 4354.7 4384.9 4413.1 3922.2 3935.5 3958.3 3974.6 3981.0 5397.3 5431.0 5439.4 5448.8 5449.4 5661.9 5710.5 5807.2 5813.0 5826.2 5502.8 5516.5 5524.8 5581.1 5602.0 4855.6 4865.3 4866.1 4880.5 4884.2 5764.8 5813.5 6006.3 6014.1 6021.8 5798.2 5858.0 5862.9 5873.0 5936.7 5997.3 6007.1 6012.9 6015.9 6016.0 5578.9 5723.1 5757.6 5771.2 5775.9 5726.4 5806.0 5846.6 5882.0 5953.8 5688.6 5712.9 5715.1 5718.4 5722.3 5695.3 5711.9 5713.6 5720.2 5721.0 5431.5 5477.5 5642.1 5686.4 5692.7 5732.9 5743.4 5743.5 5744.7 5786.8 5397.0 5443.8 5606.7 5620.7 5626.9 18:52:29 INFO - PROCESS | 11497 | 18:52:29 INFO - PROCESS | 11497 | [#1] ext.html Cycles:180 Average:57117.51 Median:38611.42 stddev:111006.13 (287.5%) stddev-sans-first:111236.27 18:52:29 INFO - PROCESS | 11497 | Values: 546.1 578.4 601.2 616.1 636.5 33706.3 34422.0 40904.0 42176.0 42246.0 43747.0 44056.3 44217.6 44222.3 44565.3 8672.6 8870.0 8872.4 8876.5 8879.6 7922.8 8119.0 8665.6 10300.1 10552.5 10641.1 10687.7 10704.8 10709.8 10740.2 10544.7 10613.6 10619.8 10620.5 10632.9 7756.2 8009.0 10012.8 10184.8 10362.5 41616.0 41966.4 41988.0 41988.8 42009.6 3033.0 3149.3 3158.1 3509.7 3688.2 31649.4 31760.8 32037.0 33078.8 33229.0 4029.3 4073.8 4111.4 4151.8 4162.6 322720.0 322959.0 324038.0 324212.0 324265.0 56151.4 56353.0 56439.4 56505.0 56607.0 58953.4 59644.4 59875.0 59879.4 59951.7 15723.2 15858.9 15974.0 15984.8 16000.2 11409.4 12254.1 12347.5 12348.8 12359.3 14453.7 15941.9 16421.4 16492.2 17115.5 5125.8 5799.2 5821.4 5873.4 5883.9 820.4 861.8 914.8 941.3 968.3 28225.6 29827.4 30417.5 30581.8 30799.5 1001.6 1026.2 1044.0 1059.9 1100.4 14943.9 15925.7 15975.1 15977.3 16152.6 469921.0 473559.0 473901.0 474403.0 474725.0 56822.7 57059.0 57124.4 57202.1 57242.0 1264.6 1289.8 1297.5 1313.1 1326.1 27826.0 29774.3 29834.0 29908.6 30580.2 48336.5 48660.8 48709.8 48722.5 48753.5 443359.0 444578.0 445113.0 445908.4 450291.0 24095.4 24210.6 24621.0 27147.7 27758.6 39778.6 39955.8 40400.4 43291.6 46860.3 37573.6 39161.0 40156.8 40710.4 42137.2 39373.6 40242.2 40750.4 41159.6 41508.6 37630.2 38408.0 38498.2 38724.6 39303.6 33837.0 36012.5 36404.0 36559.3 36723.1 26543.4 26886.2 26943.9 27228.0 27240.0 18:52:29 INFO - PROCESS | 11497 | 18:52:29 INFO - PROCESS | 11497 | [#2] jquery.html Cycles:180 Average:27264.74 Median:238443.00 stddev:77401.73 (32.5%) stddev-sans-first:77592.48 18:52:29 INFO - PROCESS | 11497 | Values: 349.8 375.0 375.1 379.4 394.4 14166.5 17969.9 17997.9 18338.4 19513.8 17547.0 17998.3 18113.3 18250.4 18389.4 5047.7 5271.8 5277.5 5278.2 5285.4 3817.2 4173.9 5151.7 5224.5 5227.4 4346.5 6472.5 6524.5 6527.2 6528.7 5679.6 5721.2 6032.5 6528.3 6531.5 5542.3 5545.9 5549.3 5552.7 5557.1 12625.7 16338.3 21058.8 21744.3 21903.8 2097.8 2172.1 2258.0 2476.6 2602.2 9737.2 9982.4 10030.7 10173.8 10353.2 1860.1 1891.9 1925.3 1973.7 1974.1 76492.6 77616.2 78310.2 78670.0 79856.0 10075.4 10389.5 10485.3 10850.3 10915.9 14954.3 15082.4 15111.8 15122.7 15131.5 7445.3 7586.8 7728.6 7789.7 8018.8 6978.2 7167.6 7480.6 7760.8 7774.2 4557.8 4587.5 4607.3 4765.5 4783.4 1840.2 1917.3 1950.9 1958.2 1974.1 402.9 409.8 423.9 810.5 926.0 10654.3 10768.9 10938.8 10968.7 11258.2 446.9 452.2 455.7 459.0 463.9 5681.2 5736.9 5886.6 5951.9 6054.3 433560.0 456101.0 480363.0 482374.0 485482.0 69671.7 93069.0 96709.5 96730.0 98494.0 467.6 478.3 478.7 481.3 482.5 10182.8 10740.9 11227.1 11500.4 11632.7 40942.4 41360.2 41776.4 42905.8 43326.0 55091.0 55490.2 55995.0 56659.2 56667.0 7863.2 8001.4 8075.4 8262.0 8516.6 10594.3 12544.0 12688.0 12723.6 12775.2 10609.4 10776.5 10863.2 10911.4 10924.8 9775.2 9941.8 10029.0 11534.4 11617.4 10956.1 11607.4 11628.7 11956.3 12257.1 8481.7 8525.9 8618.3 8654.9 8835.2 10304.4 11262.7 11281.9 11419.4 11776.1 18:52:29 INFO - PROCESS | 11497 | 18:52:29 INFO - PROCESS | 11497 | [#3] mootools.html Cycles:180 Average:5895.20 Median:4784.90 stddev:3505.82 (73.3%) stddev-sans-first:3499.58 18:52:29 INFO - PROCESS | 11497 | Values: 1427.2 1448.3 1583.3 1702.3 1704.7 8008.6 8294.4 8444.1 9107.5 9112.5 8543.1 8869.6 8902.6 9131.2 9133.9 2135.4 2179.6 2179.7 2184.4 2186.1 1875.1 1949.4 2132.7 2179.0 2194.0 2090.2 2176.4 2176.8 2182.0 2187.0 2147.7 2167.4 2172.3 2177.7 2184.0 2143.8 2145.2 2145.5 2146.5 2149.0 8868.5 9049.4 9100.2 9103.5 9112.0 5094.8 5239.0 5247.0 5249.7 5254.1 3211.3 3230.6 3269.5 3298.8 3446.5 1144.8 1154.6 1186.2 1209.3 1212.6 12896.0 12989.4 13029.5 13034.9 13038.6 4282.8 4360.8 4557.5 4575.2 4588.8 10742.4 10756.9 10760.1 10763.5 10769.5 5282.3 5303.4 5305.5 5305.9 5309.1 4731.4 4838.4 4860.2 4880.8 4881.5 3904.3 3906.8 3982.2 4016.1 4171.4 1125.2 1166.1 1240.1 1278.8 1297.0 869.9 920.5 931.4 937.2 943.7 5781.8 5997.3 6021.8 6042.4 6195.0 882.6 896.0 916.8 954.0 958.4 3697.5 3970.9 3985.7 4015.3 4101.0 11219.9 11535.2 11565.5 11641.8 11686.2 11618.4 11636.2 11648.7 11651.7 11659.6 7983.7 8300.6 8394.7 8574.1 8593.0 5947.2 5977.3 6039.8 6109.6 6130.4 10457.7 10616.0 10636.5 10693.2 10760.2 10425.1 10563.4 10708.6 10847.7 10912.6 7740.7 7950.9 7951.4 7952.1 7958.6 8626.2 8644.9 8666.0 8676.2 8723.7 7525.6 7868.2 8032.5 8074.9 8113.2 7773.4 7814.8 7847.2 7850.3 7908.2 6650.0 6869.3 6873.7 6943.0 7027.8 4970.1 5071.4 5088.3 5125.8 5137.0 4958.5 5028.4 5113.5 5194.6 5216.0 18:52:29 INFO - PROCESS | 11497 | 18:52:29 INFO - PROCESS | 11497 | [#4] prototype.html Cycles:180 Average:4735.30 Median:5404.74 stddev:1396.99 (25.8%) stddev-sans-first:1360.93 18:52:29 INFO - PROCESS | 11497 | Values: 314.7 321.9 323.1 329.1 332.3 5308.4 5326.4 5363.7 5365.5 5408.4 5288.1 5346.2 5379.9 5398.0 5399.2 3981.8 4012.8 4139.8 4147.3 4159.4 4153.6 4178.9 4188.4 4201.2 4223.2 4149.4 4153.6 4161.7 4199.4 4202.2 3983.1 4127.6 4156.6 4169.7 4179.7 3664.5 3673.4 3673.4 3677.2 3704.2 5118.7 5155.9 5190.0 5190.2 5221.7 4679.9 4749.2 4751.7 4786.8 4792.6 5497.4 5505.7 5514.6 5526.5 5528.4 4055.2 4056.4 4062.5 4065.7 4067.5 5703.6 5751.7 5764.7 5839.0 5858.4 4115.7 4121.1 4135.0 4145.0 4156.4 4201.9 4204.2 4205.3 4206.5 4219.6 4597.6 4761.3 4769.4 4791.4 4793.0 5555.6 5565.5 5579.1 5630.7 5649.2 1436.0 1451.7 1454.1 1471.4 1479.6 910.1 932.8 942.9 945.5 963.9 5194.7 5226.3 5422.3 5440.0 5445.4 5754.8 5788.5 5791.5 5808.2 5816.0 5295.2 5380.6 5401.1 5442.5 5506.6 3013.7 3032.5 3042.3 3044.5 3058.6 5907.4 5910.4 5912.6 5924.5 5938.3 5600.5 5934.6 5938.3 5957.9 5983.9 5998.5 6010.2 6013.9 6015.4 6021.3 5590.3 5748.6 5797.2 5805.3 5848.6 5720.9 5731.3 5738.0 5738.7 5745.6 5852.7 5866.3 5997.2 6005.8 6019.8 4086.3 4088.4 4105.4 4106.0 4122.3 5785.5 5812.3 5816.1 5822.1 5850.7 5546.8 5683.8 5755.1 5765.2 5770.0 5608.7 5618.8 5619.4 5635.9 5658.2 5595.6 5616.9 5639.8 5671.9 5685.0 5301.3 5386.6 5635.4 5649.6 5656.5 5525.8 5529.8 5571.3 5579.0 5580.7 18:52:29 INFO - PROCESS | 11497 | 18:52:29 INFO - PROCESS | 11497 | [#5] yui.html Cycles:180 Average:19944.14 Median:4736.63 stddev:27536.11 (581.3%) stddev-sans-first:27575.27 18:52:29 INFO - PROCESS | 11497 | Values: 655.7 688.3 695.0 707.2 736.7 14946.1 15817.0 16078.6 16354.4 16365.4 14867.0 14950.9 15397.2 15853.8 16125.5 642.2 786.0 808.2 808.4 809.5 660.7 769.7 790.3 801.5 802.4 846.1 847.3 848.5 849.6 850.5 676.6 844.9 845.0 845.0 845.2 508.7 598.1 613.4 614.7 618.4 15208.5 15222.2 15242.7 15247.4 15252.5 14004.2 14102.2 14268.4 14599.3 14755.3 13105.7 13335.3 13454.5 13469.1 13650.1 4341.5 4417.9 4426.8 4452.8 4477.8 76797.6 77546.0 78220.6 78649.6 78981.0 10801.0 10992.7 11257.7 11320.0 11487.7 19364.5 20574.7 20671.4 20700.5 21316.7 8538.9 8816.8 8932.8 8934.2 9001.7 4638.7 4718.5 4731.4 4789.6 4804.7 3516.1 3639.0 3643.4 3651.9 3652.3 626.0 627.6 632.2 635.5 638.9 520.9 534.0 544.0 569.6 608.3 9640.9 9709.4 9807.5 9823.9 9970.2 619.0 636.8 644.5 650.2 658.0 4514.4 4688.0 4741.9 4868.5 4921.8 85540.1 99236.0 103267.0 103273.0 110184.0 80634.0 84033.6 85064.0 89388.6 92836.1 80602.0 80611.6 80805.2 83166.8 84289.0 9136.4 9999.2 10025.4 10140.6 10238.0 48046.5 49083.5 49612.5 49969.0 50273.7 72161.0 72559.6 73508.0 74589.5 76024.6 12141.9 12548.6 12568.6 12629.6 13342.7 13872.0 14062.6 14317.3 14370.9 14657.9 13343.0 13385.9 13475.5 13680.2 14532.3 12789.6 13052.7 13333.9 13450.7 13569.3 13119.9 13169.6 13264.3 13896.7 13935.2 11029.7 11034.7 11121.3 11249.2 11335.8 10969.2 11297.8 11323.9 11467.9 11578.7 18:52:29 INFO - PROCESS | 11497 | -------- Summary: end -------- 18:52:29 INFO - PROCESS | 11497 | 18:52:30 INFO - TEST-INFO | 11497: exit 0 18:52:30 INFO - TEST-OK | dromaeo_css | took 1117694ms 18:52:30 INFO - TEST-START | kraken 18:52:30 INFO - operating with platform_type : linux_ 18:52:30 INFO - Initialising browser for kraken test... 18:52:30 INFO - TEST-INFO | started process 11801 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpudtK1M/profile http://localhost:53956/getInfo.html) 18:52:33 INFO - PROCESS | 11801 | __metrics Screen width/height:1600/1200 18:52:33 INFO - PROCESS | 11801 | colorDepth:24 18:52:33 INFO - PROCESS | 11801 | Browser inner width/height: 1024/697 18:52:33 INFO - PROCESS | 11801 | __metrics 18:52:34 INFO - PROCESS | 11801 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:52:34 INFO - PROCESS | 11801 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:52:35 INFO - PROCESS | 11801 | console.error: PushService: 18:52:35 INFO - PROCESS | 11801 | stateChangeProcessEnqueue: Error transitioning state 18:52:35 INFO - PROCESS | 11801 | UnknownError 18:52:35 INFO - TEST-INFO | 11801: exit 0 18:52:35 INFO - Browser initialized. 18:52:35 INFO - Running cycle 1/1 for kraken test... 18:52:35 INFO - TEST-INFO | started process 11887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpudtK1M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:52:47 INFO - PROCESS | 11887 | RSS: Main: 172400640 18:52:47 INFO - PROCESS | 11887 | 18:52:50 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53956/tests/kraken/driver.html?testName=audio-beat-detection) 18:52:51 INFO - PROCESS | 11887 | RSS: Main: 229347328 18:52:51 INFO - PROCESS | 11887 | 18:52:54 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53956/tests/kraken/driver.html?testName=audio-dft) 18:52:54 INFO - PROCESS | 11887 | RSS: Main: 216064000 18:52:54 INFO - PROCESS | 11887 | 18:52:57 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53956/tests/kraken/driver.html?testName=audio-fft) 18:52:58 INFO - PROCESS | 11887 | RSS: Main: 297463808 18:52:58 INFO - PROCESS | 11887 | 18:53:00 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53956/tests/kraken/driver.html?testName=audio-oscillator) 18:53:01 INFO - PROCESS | 11887 | RSS: Main: 208814080 18:53:01 INFO - PROCESS | 11887 | 18:53:03 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53956/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:53:03 INFO - PROCESS | 11887 | RSS: Main: 211759104 18:53:03 INFO - PROCESS | 11887 | 18:53:06 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53956/tests/kraken/driver.html?testName=imaging-darkroom) 18:53:07 INFO - PROCESS | 11887 | RSS: Main: 247717888 18:53:07 INFO - PROCESS | 11887 | 18:53:10 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53956/tests/kraken/driver.html?testName=imaging-desaturate) 18:53:11 INFO - PROCESS | 11887 | RSS: Main: 247390208 18:53:11 INFO - PROCESS | 11887 | 18:53:13 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53956/tests/kraken/driver.html?testName=json-parse-financial) 18:53:14 INFO - PROCESS | 11887 | RSS: Main: 246652928 18:53:14 INFO - PROCESS | 11887 | 18:53:16 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53956/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:53:16 INFO - PROCESS | 11887 | RSS: Main: 208936960 18:53:16 INFO - PROCESS | 11887 | 18:53:18 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53956/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:53:18 INFO - PROCESS | 11887 | RSS: Main: 216469504 18:53:18 INFO - PROCESS | 11887 | 18:53:21 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53956/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:53:21 INFO - PROCESS | 11887 | RSS: Main: 225861632 18:53:21 INFO - PROCESS | 11887 | 18:53:24 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:53:25 INFO - PROCESS | 11887 | RSS: Main: 234299392 18:53:25 INFO - PROCESS | 11887 | 18:53:27 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:53:28 INFO - PROCESS | 11887 | RSS: Main: 231698432 18:53:28 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | Cycle 1(1): loaded http://localhost:53956/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53956/tests/kraken/driver.html?testName=ai-astar) 18:53:30 INFO - PROCESS | 11887 | RSS: Main: 283561984 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | __start_tp_report 18:53:30 INFO - PROCESS | 11887 | _x_x_mozilla_page_load 18:53:30 INFO - PROCESS | 11887 | _x_x_mozilla_page_load_details 18:53:30 INFO - PROCESS | 11887 | |i|pagename|runs| 18:53:30 INFO - PROCESS | 11887 | |0;ai-astar;105;113;113;113;113;114;114;113;114;112 18:53:30 INFO - PROCESS | 11887 | |1;audio-beat-detection;155;127;124;164;124;125;123;127;162;123 18:53:30 INFO - PROCESS | 11887 | |2;audio-dft;162;161;162;161;162;163;162;162;162;162 18:53:30 INFO - PROCESS | 11887 | |3;audio-fft;75;77;76;114;78;75;78;76;101;76 18:53:30 INFO - PROCESS | 11887 | |4;audio-oscillator;83;83;112;85;84;84;103;83;84;114 18:53:30 INFO - PROCESS | 11887 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;117;119 18:53:30 INFO - PROCESS | 11887 | |6;imaging-darkroom;146;147;146;146;145;147;146;146;145;145 18:53:30 INFO - PROCESS | 11887 | |7;imaging-desaturate;84;85;84;84;85;85;84;84;84;85 18:53:30 INFO - PROCESS | 11887 | |8;json-parse-financial;54;53;54;54;54;54;54;54;53;54 18:53:30 INFO - PROCESS | 11887 | |9;json-stringify-tinderbox;59;59;59;60;59;58;59;59;59;59 18:53:30 INFO - PROCESS | 11887 | |10;stanford-crypto-aes;81;89;80;89;86;80;81;87;84;80 18:53:30 INFO - PROCESS | 11887 | |11;stanford-crypto-ccm;139;135;140;130;134;131;130;132;170;143 18:53:30 INFO - PROCESS | 11887 | |12;stanford-crypto-pbkdf2;165;165;162;162;166;165;166;164;166;167 18:53:30 INFO - PROCESS | 11887 | |13;stanford-crypto-sha256-iterative;66;68;67;67;65;65;64;65;65;65 18:53:30 INFO - PROCESS | 11887 | __end_tp_report 18:53:30 INFO - PROCESS | 11887 | __start_cc_report 18:53:30 INFO - PROCESS | 11887 | _x_x_mozilla_cycle_collect,1681 18:53:30 INFO - PROCESS | 11887 | __end_cc_report 18:53:30 INFO - PROCESS | 11887 | __startTimestamp1477274010357__endTimestamp 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | ------- Summary: start ------- 18:53:30 INFO - PROCESS | 11887 | Number of tests: 14 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:2.67 (2.4%) stddev-sans-first:0.67 18:53:30 INFO - PROCESS | 11887 | Values: 105.0 113.0 113.0 113.0 113.0 114.0 114.0 113.0 114.0 112.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:127.00 stddev:17.40 (13.7%) stddev-sans-first:16.95 18:53:30 INFO - PROCESS | 11887 | Values: 155.0 127.0 124.0 164.0 124.0 125.0 123.0 127.0 162.0 123.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 18:53:30 INFO - PROCESS | 11887 | Values: 162.0 161.0 162.0 161.0 162.0 163.0 162.0 162.0 162.0 162.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#3] audio-fft Cycles:10 Average:82.60 Median:76.00 stddev:13.52 (17.8%) stddev-sans-first:14.05 18:53:30 INFO - PROCESS | 11887 | Values: 75.0 77.0 76.0 114.0 78.0 75.0 78.0 76.0 101.0 76.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.50 stddev:12.85 (15.4%) stddev-sans-first:13.26 18:53:30 INFO - PROCESS | 11887 | Values: 83.0 83.0 112.0 85.0 84.0 84.0 103.0 83.0 84.0 114.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 18:53:30 INFO - PROCESS | 11887 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 119.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 18:53:30 INFO - PROCESS | 11887 | Values: 146.0 147.0 146.0 146.0 145.0 147.0 146.0 146.0 145.0 145.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.53 18:53:30 INFO - PROCESS | 11887 | Values: 84.0 85.0 84.0 84.0 85.0 85.0 84.0 84.0 84.0 85.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:0.42 (0.8%) stddev-sans-first:0.44 18:53:30 INFO - PROCESS | 11887 | Values: 54.0 53.0 54.0 54.0 54.0 54.0 54.0 54.0 53.0 54.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#9] json-stringify-tinderbox Cycles:10 Average:59.00 Median:59.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 18:53:30 INFO - PROCESS | 11887 | Values: 59.0 59.0 59.0 60.0 59.0 58.0 59.0 59.0 59.0 59.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:85.00 stddev:3.77 (4.4%) stddev-sans-first:3.87 18:53:30 INFO - PROCESS | 11887 | Values: 81.0 89.0 80.0 89.0 86.0 80.0 81.0 87.0 84.0 80.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#11] stanford-crypto-ccm Cycles:10 Average:138.40 Median:137.00 stddev:11.97 (8.7%) stddev-sans-first:12.70 18:53:30 INFO - PROCESS | 11887 | Values: 139.0 135.0 140.0 130.0 134.0 131.0 130.0 132.0 170.0 143.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.80 Median:165.50 stddev:1.69 (1.0%) stddev-sans-first:1.79 18:53:30 INFO - PROCESS | 11887 | Values: 165.0 165.0 162.0 162.0 166.0 165.0 166.0 164.0 166.0 167.0 18:53:30 INFO - PROCESS | 11887 | 18:53:30 INFO - PROCESS | 11887 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:1.32 18:53:30 INFO - PROCESS | 11887 | Values: 66.0 68.0 67.0 67.0 65.0 65.0 64.0 65.0 65.0 65.0 18:53:30 INFO - PROCESS | 11887 | -------- Summary: end -------- 18:53:30 INFO - PROCESS | 11887 | 18:53:31 INFO - TEST-INFO | 11887: exit 0 18:53:31 INFO - TEST-OK | kraken | took 61462ms 18:53:31 INFO - SUITE-END | took 1179s 18:53:32 INFO - Completed test suite (00:19:39) 18:53:32 INFO - javascript benchmark 18:53:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3067.6932306769318, 3089.366679830635, 3114.71967522923, 3130.968690313098, 3135.2005238664137, 5272.971770504753, 5306.416294207639, 5332.413434522199, 5386.865328366788, 5473.890522189554, 5368.62419630625, 5371.4897084776985, 5372.167314066316, 5379.488948549892, 5385.488378604026, 4826.686265392756, 4853.174960256747, 4877.829275975341, 4888.975555122237, 4939.50604939505, 4949.7030178189425, 5004.0, 5009.02324046811, 5010.574101201402, 5013.3482647255805, 4939.0, 4972.627052971024, 4998.600111991032, 5011.949880501203, 5019.673721208128, 5039.496050394986, 5057.620678449131, 5059.418166910816, 5066.164082926312, 5123.257127716461, 4789.568938795525, 4835.540623640783, 4847.079054979543, 4939.431965323998, 4946.975265123688, 5338.119210330291, 5351.732413379315, 5374.113271310229, 5402.405735369106, 5415.918761218585, 5784.07454807233, 5784.71076446176, 5792.420757924216, 5793.391693872125, 5801.0, 5621.8594535136945, 5692.943070569324, 5815.709214539256, 5840.386759390245, 5842.795502157446, 5373.785048598052, 5418.024755543961, 5420.13277875538, 5420.268263784417, 5492.340919089655, 5894.38108998549, 5940.732667029994, 5944.167816505693, 5951.077582974646, 5954.55340849438, 5581.6930068845795, 5705.914411283751, 5705.942940570624, 5706.201131841545, 5707.0583353747, 5716.799912003143, 5744.770209191585, 5825.970870145622, 5836.824895253149, 5858.004139296329, 5665.206871038058, 5699.943000570024, 5703.258576385127, 5726.055200891889, 5743.62666426681, 5729.398413166641, 5732.742026608813, 5742.856428589319, 5756.798512052058, 5804.796832110856, 4315.870523884289, 4353.281708518059, 4354.695171337976, 4384.890377740582, 4413.117376524708, 3922.2155568886337, 3935.5080614923136, 3958.2677204716642, 3974.6025397460603, 3981.0, 5397.27136836522, 5431.0, 5439.374471935778, 5448.754806033738, 5449.427810079964, 5661.858453538694, 5710.486056254874, 5807.157962095557, 5813.0, 5826.2134611827705, 5502.779888804483, 5516.531094856982, 5524.8342549723575, 5581.079121944915, 5602.047651899187, 4855.6115510759055, 4865.294532292868, 4866.124097662455, 4880.536349046835, 4884.169691152512, 5764.827055188351, 5813.476787089182, 6006.33930267679, 6014.097885317237, 6021.789237376671, 5798.188253644409, 5858.033424485083, 5862.882742345215, 5872.970635146797, 5936.732847021981, 5997.3402925677265, 6007.098935159761, 6012.939870601238, 6015.939840601538, 6016.037434010537, 5578.944210557843, 5723.112917497794, 5757.625754326123, 5771.163181338767, 5775.8556036099435, 5726.370099288992, 5805.970970145122, 5846.619969701956, 5881.9705901470215, 5953.76184952597, 5688.601797874109, 5712.914306285492, 5715.142728590745, 5718.399568045295, 5722.341930678025, 5695.345035320991, 5711.8857622848145, 5713.600047996601, 5720.199172115824, 5721.0, 5431.456854314695, 5477.452254774491, 5642.097264437671, 5686.374498805211, 5692.715364231854, 5732.856678583069, 5743.396943321059, 5743.4543718346695, 5744.684042377709, 5786.826395208151, 5396.9730151348995, 5443.836684899459, 5606.6636001840025, 5620.718964051699, 5626.887462250814], "value": 5335.541409555177, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.0680764868689, 578.4215784215784, 601.2394321183704, 616.0728104203174, 636.5385095805539, 33706.325873482514, 34422.0, 40904.0, 42176.0, 42246.0, 43747.0, 44056.339154912625, 44217.55782442175, 44222.33666495005, 44565.331520027226, 8672.566371681438, 8870.024297327289, 8872.37893347466, 8876.511791851446, 8879.600417981206, 7922.841543169133, 8119.0, 8665.610047547876, 10300.07299343059, 10552.525136368844, 10641.148708103334, 10687.679369618885, 10704.78590428191, 10709.839352409721, 10740.194485413585, 10544.736381590445, 10613.57545698171, 10619.840702389432, 10620.522076506499, 10632.946835265851, 7756.224377562198, 8008.959955200245, 10012.849807252824, 10184.847227291597, 10362.481875906175, 41616.0, 41966.37050444246, 41988.0, 41988.79005604983, 42009.57990420087, 3032.9545056824163, 3149.291409432882, 3158.147300228948, 3509.7016753575977, 3688.1517251032146, 31649.367012659848, 31760.841195794103, 32037.038888833373, 33078.834605827054, 33229.0, 4029.2747305485, 4073.837046518165, 4111.362738775495, 4151.7924103794685, 4162.562930892243, 322720.0, 322959.0, 324037.9999999976, 324212.0, 324265.0, 56151.43848561462, 56353.0, 56439.43560564424, 56505.0, 56607.0, 58953.41046589565, 59644.40355596389, 59875.0, 59879.40120598825, 59951.70024149851, 15723.21383930799, 15858.920705396398, 15974.041557506587, 15984.76022859658, 16000.199990000454, 11409.372484513266, 12254.08094392924, 12347.506099756089, 12348.753024939451, 12359.25844449336, 14453.710925781636, 15941.920290398706, 16421.425250116426, 16492.17539123063, 17115.486535403958, 5125.820596279187, 5799.159121927381, 5821.390737742542, 5873.353931067579, 5883.882322353529, 820.3683163963715, 861.8104017116225, 914.826183025223, 941.275218082073, 968.3441315350829, 28225.576616350772, 29827.40345193084, 30417.543736843523, 30581.847090764404, 30799.538006929914, 1001.6043662753171, 1026.235454586338, 1043.9895601043893, 1059.8940105989493, 1100.3507930320989, 14943.925280373745, 15925.681486370207, 15975.12136832462, 15977.281022354022, 16152.596185095466, 469921.0, 473559.0, 473901.0, 474403.0, 474725.0, 56822.71588642113, 57059.0, 57124.42875571274, 57202.14196787051, 57242.0, 1264.563725514696, 1289.7807372746656, 1297.4680381043916, 1313.1136482874213, 1326.0916272353468, 27826.0, 29774.25564360908, 29834.0, 29908.551371729005, 30580.235494112825, 48336.5166348332, 48660.75669621629, 48709.756451217516, 48722.5127748718, 48753.5124648749, 443359.0, 444578.0, 445113.0, 445908.39320623624, 450291.0, 24095.404304828524, 24210.636840447758, 24621.0, 27147.72852271452, 27758.583621245292, 39778.60221397749, 39955.80022099871, 40400.3939940907, 43291.56708432875, 46860.29709554427, 37573.62426375701, 39161.0, 40156.79921600373, 40710.389344159266, 42137.15725685408, 39373.60626393699, 40242.1951560973, 40750.38874416827, 41159.588404116774, 41508.58491415168, 37630.247395052495, 38408.0, 38498.2300353997, 38724.612753873225, 39303.60696393, 33837.0, 36012.45981310335, 36404.0, 36559.26881462409, 36723.081922951074, 26543.416638753522, 26886.193414197605, 26943.86528067347, 27228.007091666816, 27240.0], "value": 19328.348817391867, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.7621617300238, 374.98125093745324, 375.13157041449045, 379.3853956590323, 394.4339872283274, 14166.504172353956, 17969.910150449246, 17997.91001044993, 18338.35815746446, 19513.804861951412, 17547.0, 17998.280068797267, 18113.275468981257, 18250.361237356694, 18389.356372526963, 5047.697138171703, 5271.7874888775605, 5277.498637629419, 5278.181881808326, 5285.445028272034, 3817.179306449113, 4173.853915112972, 5151.6908985461, 5224.503672151159, 5227.424983251839, 4346.5436129206455, 6472.546921715481, 6524.478041756648, 6527.216733991928, 6528.738850445977, 5679.630823996468, 5721.227634269362, 6032.517398608101, 6528.3145269746465, 6531.542792004561, 5542.279503664538, 5545.861353466155, 5549.334079910396, 5552.69460179694, 5557.083081291582, 12625.684357891034, 16338.264778085015, 21058.789412105834, 21744.34766956994, 21903.780962190493, 2097.7902209779054, 2172.055156007142, 2257.9661305080435, 2476.628505724138, 2602.167306461933, 9737.172340351079, 9982.401055936667, 10030.749231269278, 10173.796524069478, 10353.171746260356, 1860.0699650174913, 1891.8770279931898, 1925.3165126380075, 1973.6644770389069, 1974.1116497576147, 76492.61753691251, 77616.22383776147, 78310.21689783086, 78670.0, 79856.0, 10075.395476271447, 10389.532471038821, 10485.318454300446, 10850.29473084247, 10915.945420273007, 14954.327055282538, 15082.396704131712, 15111.773323400157, 15122.697546049018, 15131.47039853622, 7445.292697193866, 7586.835068167542, 7728.574928378993, 7789.7273595423885, 8018.759437216893, 6978.197507286727, 7167.605781681953, 7480.588567628833, 7760.844783104306, 7774.183710710294, 4557.817687292538, 4587.472440669299, 4607.308903664477, 4765.451973023078, 4783.402074740658, 1840.1816231320065, 1917.3001854323072, 1950.9317173898846, 1958.177565422526, 1974.1215159254282, 402.92143032109044, 409.80534246233395, 423.8580075674622, 810.4610434061401, 925.9537023148815, 10654.307470014424, 10768.94615526933, 10938.781224375469, 10968.670939871816, 11258.21192516516, 446.8525386622407, 452.1544711389657, 455.71062375391864, 459.0474764862923, 463.9141758774638, 5681.2330335404195, 5736.942630573724, 5886.587938844325, 5951.9107213391835, 6054.334023257438, 433560.0, 456101.0, 480363.0, 482374.0, 485482.0, 69671.65164174147, 93069.0, 96709.51645241729, 96730.0, 98494.0, 467.5698357511098, 478.26824957814597, 478.7414796010185, 481.29009710676473, 482.45482604656513, 10182.847257291294, 10740.892591073989, 11227.101831853268, 11500.424978750862, 11632.709182270173, 40942.385864211465, 41360.17621232946, 41776.373354399104, 42905.785471073694, 43326.0, 55091.0, 55490.16764748613, 55995.0, 56659.15011274752, 56667.0, 7863.174366691415, 8001.439899207233, 8075.434719569574, 8261.958690206511, 8516.61675224604, 10594.31136976094, 12544.0, 12688.0, 12723.55467558631, 12775.169613975062, 10609.416482093558, 10776.461176941279, 10863.239573229797, 10911.399873007062, 10924.781504369708, 9775.21798256152, 9941.751456213653, 10029.0, 11534.365609891536, 11617.419129043683, 10956.123510119012, 11607.409620555654, 11628.6511404658, 11956.282623042645, 12257.14200005991, 8481.745547633582, 8525.87211191845, 8618.267447266802, 8654.913450865663, 8835.249003834746, 10304.433256170683, 11262.718432039264, 11281.943590281997, 11419.429028548373, 11776.11679124052], "value": 8040.49132363621, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.2007675701611, 1448.2830998655663, 1583.3349993002937, 1702.31056422149, 1704.7016772064885, 8008.55952922589, 8294.419390642657, 8444.113368096347, 9107.49908755019, 9112.544372781367, 8543.145685431453, 8869.645214191441, 8902.643894244238, 9131.2238459731, 9133.908660913388, 2135.3914134471715, 2179.553191595719, 2179.7057397251406, 2184.3992901951933, 2186.147402513021, 1875.1468082022648, 1949.4151754473671, 2132.701421800949, 2178.9891050544725, 2193.9561208775813, 2090.205721825712, 2176.3906106290265, 2176.81497072749, 2182.039902442928, 2187.0, 2147.688585155159, 2167.3931299236237, 2172.31572054803, 2177.7060096887035, 2184.028107492167, 2143.7749036351115, 2145.1955516681246, 2145.5065334972887, 2146.474113842103, 2149.022194901316, 8868.46789192644, 9049.411788233743, 9100.226480749145, 9103.453792772454, 9112.043235460314, 5094.847154585368, 5238.973805130988, 5246.97376513115, 5249.685018898878, 5254.08053590624, 3211.3256216194627, 3230.644629090798, 3269.476883698597, 3298.7855789373616, 3446.5347178130883, 1144.765084664918, 1154.584349634131, 1186.1643883127606, 1209.3046498263445, 1212.6422705301957, 12896.0, 12989.41547630359, 13029.543965961146, 13034.869651303556, 13038.608841734764, 4282.785860706952, 4360.825566977349, 4557.475890272661, 4575.2450845610765, 4588.810776510293, 10742.409167495707, 10756.946215268874, 10760.139188864872, 10763.461826908624, 10769.461526923622, 5282.339707536558, 5303.363596368384, 5305.495977882095, 5305.920411193835, 5309.123994540934, 4731.408573928259, 4838.395200599925, 4860.198067318924, 4880.804767809248, 4881.536254055859, 3904.336262835268, 3906.824192911269, 3982.203559288154, 4016.1324983882637, 4171.374293855946, 1125.2348403085816, 1166.1370585766472, 1240.1195151442396, 1278.7506436244844, 1296.9935150324188, 869.8738682890945, 920.5213289089636, 931.3759780946782, 937.2033771294346, 943.7263193673895, 5781.82654520365, 5997.250343707036, 6021.819345419644, 6042.39576042401, 6195.008798592204, 882.5851849630664, 895.9596818143199, 916.8140711029254, 953.993536818663, 958.3962103874654, 3697.5008373869723, 3970.920581588352, 3985.740926839746, 4015.297322968469, 4100.979495102565, 11219.887801121884, 11535.19253652253, 11565.537378504765, 11641.76716465666, 11686.18196726238, 11618.360990145624, 11636.185467017396, 11648.65054048363, 11651.708707282385, 11659.591914282959, 7983.680652773824, 8300.584970751439, 8394.664213431517, 8574.056853746082, 8592.957035214784, 5947.193537475916, 5977.252843394575, 6039.849003774941, 6109.602875813058, 6130.356312587114, 10457.738556536147, 10616.0, 10636.52135653882, 10693.198010149426, 10760.246782725135, 10425.113865321533, 10563.366198028143, 10708.625198118028, 10847.728806779578, 10912.61805836792, 7740.6903723852665, 7950.880736789069, 7951.369969156424, 7952.085510166174, 7958.602069896598, 8626.223639872442, 8644.870326945227, 8666.046734859287, 8676.175763302475, 8723.694670686495, 7525.623718814147, 7868.213178682086, 8032.518048917083, 8074.87887681697, 8113.229243221885, 7773.4169937256065, 7814.804629884071, 7847.176046515034, 7850.332721718718, 7908.209179082046, 6650.0, 6869.278725733926, 6873.656317184221, 6943.0, 7027.824304392431, 4970.080535101018, 5071.39143302806, 5088.262201980618, 5125.820596279113, 5137.023965446553, 4958.513241936521, 5028.421731500925, 5113.51421614946, 5194.636375453833, 5216.035033518811], "value": 4631.710958091508, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.7214714977245, 321.8921661243483, 323.13060026960585, 329.1376593325486, 332.2524320279371, 5308.416074231836, 5326.387465441476, 5363.651362661429, 5365.490278423548, 5408.378036525801, 5288.101022826119, 5346.224797404374, 5379.919301210485, 5398.0, 5399.19012148178, 3981.781002044901, 4012.7592344459354, 4139.77231252281, 4147.294959856831, 4159.417681524574, 4153.605407486299, 4178.937315940263, 4188.4136220929095, 4201.1807697499, 4223.218704539655, 4149.439825623533, 4153.646940010103, 4161.667066634662, 4199.4120823084795, 4202.159568086379, 3983.143624120799, 4127.587241275878, 4156.605122513356, 4169.666426685858, 4179.665626749883, 3664.523611930432, 3673.3938900081453, 3673.412254039368, 3677.2461645362637, 3704.240630670706, 5118.667286626394, 5155.948440515622, 5189.974050129763, 5190.24741412493, 5221.73891305437, 4679.940826036533, 4749.216379297412, 4751.714897106184, 4786.808527658889, 4792.634099281688, 5497.405752331819, 5505.724713764296, 5514.6139770216105, 5526.47498487647, 5528.44715528448, 4055.2295063938054, 4056.371262454295, 4062.5124985001694, 4065.715399922007, 4067.4712287402745, 5703.629264097862, 5751.654900705929, 5764.740586673568, 5838.970805145947, 5858.355580886099, 4115.691323150776, 4121.1345617420075, 4134.958650413518, 4144.979275103605, 4156.397322388237, 4201.852935147316, 4204.201201771653, 4205.3271476563605, 4206.537280899099, 4219.641330486882, 4597.632189424838, 4761.333413322138, 4769.35613692154, 4791.401074865642, 4792.95207047932, 5555.611107222456, 5565.471280228453, 5579.13523403873, 5630.662160270397, 5649.152627105885, 1435.978460323096, 1451.7459444597152, 1454.1420561868338, 1471.3673120558049, 1479.6226962124804, 910.0657913804628, 932.8227636748996, 942.9434233945985, 945.5366870233536, 963.9036096390305, 5194.714290713971, 5226.275329141375, 5422.349318081855, 5439.972800135974, 5445.428230035868, 5754.769809207669, 5788.479036886701, 5791.478766910998, 5808.157817116495, 5815.957909253113, 5295.17316525798, 5380.596455265871, 5401.108817045144, 5442.455754424526, 5506.614536982373, 3013.6835632258735, 3032.529957856536, 3042.300270937697, 3044.4672182368, 3058.6023816904103, 5907.409259074144, 5910.408959104056, 5912.556558258062, 5924.526037916957, 5938.317093534299, 5600.52395546375, 5934.584579079423, 5938.257717785277, 5957.940420595825, 5983.910241346383, 5998.520118390518, 6010.248718910137, 6013.909791353133, 6015.368386319548, 6021.337652858182, 5590.273264475592, 5748.5688573358, 5797.246357973437, 5805.3033635962265, 5848.56135789826, 5720.885582288414, 5731.312242530923, 5737.967165910176, 5738.68437235956, 5745.597808153389, 5852.678102704393, 5866.2960444746905, 5997.230816908935, 6005.849853753691, 6019.849503762441, 4086.3053280941717, 4088.366303223005, 4105.363668631367, 4105.958940410677, 4122.2579935611875, 5785.508231800344, 5812.3025236971835, 5816.098504731774, 5822.097574875901, 5850.678212698343, 5546.833594992157, 5683.8010669626365, 5755.064916892331, 5765.164051212467, 5770.0, 5608.663480191201, 5618.831435056954, 5619.381867994435, 5635.9436405635415, 5658.20785090096, 5595.63628364155, 5616.943830561806, 5639.830805075854, 5671.858203544779, 5685.0, 5301.284326615858, 5386.622936394571, 5635.380108188178, 5649.576281778801, 5656.490915817596, 5525.834224973257, 5529.806456773994, 5571.331440227199, 5579.0, 5580.693061881473], "value": 4285.681547647337, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.6951017776732, 688.3254410677536, 694.9861002779948, 707.169076335306, 736.6500912066767, 14946.10323380598, 15817.0, 16078.59803504913, 16354.427595034176, 16365.42721004765, 14867.0, 14950.925245373784, 15397.230138493058, 15853.762193567105, 16125.516234512954, 642.1683919324486, 785.9921400786005, 808.2160304504621, 808.4138999225573, 809.5426084262373, 660.7489154121428, 769.7152053740124, 790.3005839831761, 801.5391150088693, 802.4262652203673, 846.1453931529138, 847.3263755314509, 848.5248260973874, 849.583703985046, 850.5407080176698, 676.6346173066538, 844.8690452979768, 845.0282175498165, 845.0408786027841, 845.2435070611799, 508.7379999300363, 598.0550729846875, 613.3804857094323, 614.665007570875, 618.3538202578271, 15208.467703630431, 15222.238888055665, 15242.695146097016, 15247.39010439581, 15252.542423727306, 14004.22976736279, 14102.153870767786, 14268.357923893449, 14599.343029563588, 14755.26223688822, 13105.737885242337, 13335.333233338295, 13454.461821527128, 13469.12450690702, 13650.112742671694, 4341.45731783527, 4417.889552761175, 4426.84506042287, 4452.821887124511, 4477.776111194427, 76797.61601191958, 77545.99999999943, 78220.60889695572, 78649.60675196645, 78981.0, 10801.0, 10992.725181870517, 11257.71855703614, 11320.0, 11487.655370338904, 19364.515887102654, 20574.69137962932, 20671.379858603967, 20700.48248793762, 21316.655167931516, 8538.914610853812, 8816.823663526693, 8932.821343573092, 8934.195922367018, 9001.729948101567, 4638.652101092364, 4718.528147185254, 4731.384919960452, 4789.640776941744, 4804.711717296904, 3516.1033936346066, 3638.9636103639154, 3643.362411577963, 3651.94522082169, 3652.2878038782183, 625.9874802503924, 627.576385939489, 632.2110016624091, 635.5011316116826, 638.9297177310492, 520.8958208358343, 533.9519443250049, 543.9610344242557, 569.6212019007314, 608.3369127650882, 9640.90359096414, 9709.36889102206, 9807.460589667637, 9823.901760982299, 9970.205363034724, 618.981430557084, 636.8471566823929, 644.5359341274275, 650.2294780684904, 657.9868402631921, 4514.378838166043, 4688.0, 4741.881452963704, 4868.477770786141, 4921.778519966539, 85540.14459855322, 99236.0, 103267.0, 103273.0, 110184.0, 80634.0, 84033.57983210045, 85064.0, 89388.5530572356, 92836.0716392841, 80602.0, 80611.59694201492, 80805.19194808094, 83166.75249871257, 84289.0, 9136.406133601295, 9999.15007224365, 10025.398476091457, 10140.645077422254, 10238.0, 48046.5195348042, 49083.5091649079, 49612.50387496223, 49969.0, 50273.74863125661, 72161.0, 72559.63720181577, 73508.0, 74589.53239251858, 76024.61987690027, 12141.939290303491, 12548.560800371943, 12568.560100396442, 12629.621111366674, 13342.733145336844, 13872.0, 14062.648433788829, 14317.296348801638, 14370.928145359207, 14657.853421465648, 13343.0, 13385.933070334586, 13475.528356507475, 13680.247586382844, 14532.27338633043, 12789.61631151067, 13052.738945221232, 13333.933330333286, 13450.730985380042, 13569.321533923066, 13119.934400328319, 13169.604911852659, 13264.270465124126, 13896.652583685489, 13935.163890166623, 11029.669109926715, 11034.724131896766, 11121.27711698737, 11249.1563132767, 11335.773284534098, 10969.177311701815, 11297.830532541853, 11323.943380283046, 11467.885321146681, 11578.652640420802], "value": 7421.392497165879, "unit": "score"}], "name": "dromaeo_css", "value": 7044.075870992947, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 113.0, 113.0, 113.0, 114.0, 114.0, 113.0, 114.0, 112.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 127.0, 124.0, 164.0, 124.0, 125.0, 123.0, 127.0, 162.0, 123.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 161.0, 162.0, 163.0, 162.0, 162.0, 162.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 114.0, 78.0, 75.0, 78.0, 76.0, 101.0, 76.0], "value": 82.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 112.0, 85.0, 84.0, 84.0, 103.0, 83.0, 84.0, 114.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 119.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 145.0, 147.0, 146.0, 146.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 59.0, 60.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0], "value": 59.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 89.0, 80.0, 89.0, 86.0, 80.0, 81.0, 87.0, 84.0, 80.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 135.0, 140.0, 130.0, 134.0, 131.0, 130.0, 132.0, 170.0, 143.0], "value": 138.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 162.0, 162.0, 166.0, 165.0, 166.0, 164.0, 166.0, 167.0], "value": 164.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 67.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1496.5000000000002, "alertThreshold": 2.0}]} 18:53:32 INFO - Return code: 0 18:53:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:53:32 INFO - # TBPL SUCCESS # 18:53:32 INFO - Running post-action listener: _resource_record_post_action 18:53:32 INFO - [mozharness: 2016-10-24 01:53:32.156843Z] Finished run-tests step (success) 18:53:32 INFO - Running post-run listener: _resource_record_post_run 18:53:32 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 406519808; Read time: 8; Write time: 328620 18:53:32 INFO - TinderboxPrint: CPU usage
13.1% 18:53:32 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 18:53:32 INFO - TinderboxPrint: I/O write bytes / time
406,519,808 / 328,620 18:53:32 INFO - TinderboxPrint: CPU idle
8,303.3 (86.9%) 18:53:32 INFO - TinderboxPrint: CPU user
1,199.7 (12.6%) 18:53:32 INFO - TinderboxPrint: Swap in / out
0 / 0 18:53:32 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 115437568; Read time: 0; Write time: 98452 18:53:32 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 4096; Write bytes: 287170560; Read time: 8; Write time: 228920 18:53:32 INFO - Running post-run listener: _upload_blobber_files 18:53:32 INFO - Blob upload gear active. 18:53:32 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:53:32 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 18:53:32 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'] 18:53:32 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 18:53:33 INFO - (blobuploader) - INFO - Open directory for files ... 18:53:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:53:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:53:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:37 INFO - (blobuploader) - INFO - Done attempting. 18:53:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:53:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:53:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:37 INFO - (blobuploader) - INFO - Done attempting. 18:53:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:53:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:53:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:53:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:53:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:53:38 INFO - (blobuploader) - INFO - Done attempting. 18:53:38 INFO - (blobuploader) - INFO - Iteration through files over. 18:53:38 INFO - Return code: 0 18:53:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:53:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:53:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c0d41563d921f9ded119189297441f70d77029a3a01a3ddd0b5e06ceef093ddcdffe29dadbceed30e6df83b84f111865d593c3037fdfe424e9eebd638c71a4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/54d555635cbadc80300c9199c024f379551a9960ee10e39c76903a02436e7fb5391b62a90b41f1d44d44fd311eb488fc563c5d45701429cb366560ef728249eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa27a7a3c78c9a3b8e24b2a8f69603f511415e1cbbfdf62bb89223a16e33b761ef247c0f63385106900aabb630eb6498f7030ab7d87eab6e092e03ed9ffc26c0"} 18:53:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:53:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:53:38 INFO - Contents: 18:53:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c0d41563d921f9ded119189297441f70d77029a3a01a3ddd0b5e06ceef093ddcdffe29dadbceed30e6df83b84f111865d593c3037fdfe424e9eebd638c71a4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/54d555635cbadc80300c9199c024f379551a9960ee10e39c76903a02436e7fb5391b62a90b41f1d44d44fd311eb488fc563c5d45701429cb366560ef728249eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa27a7a3c78c9a3b8e24b2a8f69603f511415e1cbbfdf62bb89223a16e33b761ef247c0f63385106900aabb630eb6498f7030ab7d87eab6e092e03ed9ffc26c0"} 18:53:38 INFO - Running post-run listener: copy_logs_to_upload_dir 18:53:38 INFO - Copying logs to upload dir... 18:53:38 INFO - mkdir: /builds/slave/test/build/upload/logs 18:53:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.306965 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-10-23 18:53:36.992022) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 18:53:36.995789) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c0d41563d921f9ded119189297441f70d77029a3a01a3ddd0b5e06ceef093ddcdffe29dadbceed30e6df83b84f111865d593c3037fdfe424e9eebd638c71a4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/54d555635cbadc80300c9199c024f379551a9960ee10e39c76903a02436e7fb5391b62a90b41f1d44d44fd311eb488fc563c5d45701429cb366560ef728249eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa27a7a3c78c9a3b8e24b2a8f69603f511415e1cbbfdf62bb89223a16e33b761ef247c0f63385106900aabb630eb6498f7030ab7d87eab6e092e03ed9ffc26c0"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011326 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1477261808/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/9c0d41563d921f9ded119189297441f70d77029a3a01a3ddd0b5e06ceef093ddcdffe29dadbceed30e6df83b84f111865d593c3037fdfe424e9eebd638c71a4a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/54d555635cbadc80300c9199c024f379551a9960ee10e39c76903a02436e7fb5391b62a90b41f1d44d44fd311eb488fc563c5d45701429cb366560ef728249eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/fa27a7a3c78c9a3b8e24b2a8f69603f511415e1cbbfdf62bb89223a16e33b761ef247c0f63385106900aabb630eb6498f7030ab7d87eab6e092e03ed9ffc26c0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-23 18:53:37.021494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:53:37.021842) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1477272426.332978-1467252430 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004578 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-23 18:53:37.104182) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 18:53:37.104509) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-23 18:53:37.104805) ========= ========= Total master_lag: 0.16 =========