builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-064 starttime: 1478098065.97 results: success (0) buildid: 20161102065411 builduid: 9434415faab646eb84af03a066c5964c revision: 4cde141bbedfd7355bdf3e9ac41740fb8fa2f06d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:45.972005) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:45.972560) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:45.972848) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:45.987884) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:45.988272) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-02 07:47:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.3M=0s 2016-11-02 07:47:47 (24.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122240 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:46.125423) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:46.125893) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019577 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:46.176105) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 07:47:46.176525) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4cde141bbedfd7355bdf3e9ac41740fb8fa2f06d --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 4cde141bbedfd7355bdf3e9ac41740fb8fa2f06d --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=a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-02 07:47:47,534 truncating revision to first 12 chars 2016-11-02 07:47:47,534 Setting DEBUG logging. 2016-11-02 07:47:47,534 attempt 1/10 2016-11-02 07:47:47,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4cde141bbedf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-02 07:47:47,878 unpacking tar archive at: mozilla-inbound-4cde141bbedf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.459676 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-02 07:47:47.649948) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:47.650326) ========= script_repo_revision: 4cde141bbedfd7355bdf3e9ac41740fb8fa2f06d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:47.650795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:47.651170) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-02 07:47:47.661852) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-02 07:47:47.662431) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:47:49 INFO - MultiFileLogger online at 20161102 07:47:49 in /builds/slave/test 07:47:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 07:47:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:47:49 INFO - {'append_to_log': False, 07:47:49 INFO - 'base_work_dir': '/builds/slave/test', 07:47:49 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 07:47:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:47:49 INFO - 'branch': 'Mozilla-Inbound', 07:47:49 INFO - 'buildbot_json_path': 'buildprops.json', 07:47:49 INFO - 'config_files': ('talos/linux_config.py',), 07:47:49 INFO - 'default_actions': ('clobber', 07:47:49 INFO - 'read-buildbot-config', 07:47:49 INFO - 'download-and-extract', 07:47:49 INFO - 'populate-webroot', 07:47:49 INFO - 'create-virtualenv', 07:47:49 INFO - 'install', 07:47:49 INFO - 'run-tests'), 07:47:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:47:49 INFO - 'download_minidump_stackwalk': True, 07:47:49 INFO - 'download_symbols': 'ondemand', 07:47:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:47:49 INFO - 'tooltool.py': '/tools/tooltool.py', 07:47:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:47:49 INFO - '/tools/misc-python/virtualenv.py')}, 07:47:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:47:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:47:49 INFO - 'installer_path': 'installer.exe', 07:47:49 INFO - 'log_level': 'info', 07:47:49 INFO - 'log_name': 'talos', 07:47:49 INFO - 'log_to_console': True, 07:47:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:47:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:47:49 INFO - 'opt_config_files': (), 07:47:49 INFO - 'pip_index': False, 07:47:49 INFO - 'sps_profile': False, 07:47:49 INFO - 'sps_profile_interval': 0, 07:47:49 INFO - 'suite': 'dromaeojs-e10s', 07:47:49 INFO - 'system_bits': '32', 07:47:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:47:49 INFO - 'title': 'talos-linux64-ix-064', 07:47:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:47:49 INFO - 'use_talos_json': True, 07:47:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:47:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:47:49 INFO - 'work_dir': 'build'} 07:47:49 INFO - [mozharness: 2016-11-02 14:47:49.122775Z] Running clobber step. 07:47:49 INFO - Running pre-action listener: _resource_record_pre_action 07:47:49 INFO - Running main action method: clobber 07:47:49 INFO - rmtree: /builds/slave/test/build 07:47:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:47:50 INFO - Running post-action listener: _resource_record_post_action 07:47:50 INFO - [mozharness: 2016-11-02 14:47:50.102017Z] Finished clobber step (success) 07:47:50 INFO - [mozharness: 2016-11-02 14:47:50.102117Z] Running read-buildbot-config step. 07:47:50 INFO - Running pre-action listener: _resource_record_pre_action 07:47:50 INFO - Running main action method: read_buildbot_config 07:47:50 INFO - Using buildbot properties: 07:47:50 INFO - { 07:47:50 INFO - "project": "", 07:47:50 INFO - "product": "firefox", 07:47:50 INFO - "script_repo_revision": "production", 07:47:50 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 07:47:50 INFO - "repository": "", 07:47:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 07:47:50 INFO - "buildid": "20161102065411", 07:47:50 INFO - "stage_platform": "linux64-pgo", 07:47:50 INFO - "basedir": "/builds/slave/test", 07:47:50 INFO - "buildnumber": 1483, 07:47:50 INFO - "platform": "ubuntu64_hw", 07:47:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:47:50 INFO - "slavebuilddir": "test", 07:47:50 INFO - "branch": "mozilla-inbound", 07:47:50 INFO - "revision": "4cde141bbedfd7355bdf3e9ac41740fb8fa2f06d", 07:47:50 INFO - "slavename": "talos-linux64-ix-064", 07:47:50 INFO - "builduid": "9434415faab646eb84af03a066c5964c", 07:47:50 INFO - "repo_path": "integration/mozilla-inbound" 07:47:50 INFO - } 07:47:50 INFO - Found installer url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 07:47:50 INFO - Found a test packages url https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.test_packages.json. 07:47:50 INFO - Running post-action listener: _resource_record_post_action 07:47:50 INFO - [mozharness: 2016-11-02 14:47:50.104486Z] Finished read-buildbot-config step (success) 07:47:50 INFO - [mozharness: 2016-11-02 14:47:50.104573Z] Running download-and-extract step. 07:47:50 INFO - Running pre-action listener: _resource_record_pre_action 07:47:50 INFO - Running main action method: download_and_extract 07:47:50 INFO - mkdir: /builds/slave/test/build/tests 07:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:50 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:47:50 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/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 07:47:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/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 07:47:50 INFO - Downloaded 1361 bytes. 07:47:50 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 07:47:50 INFO - Using the following test package requirements: 07:47:50 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:47:50 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:47:50 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:47:50 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:50 INFO - u'jsshell-linux-x86_64.zip'], 07:47:50 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:47:50 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 07:47:50 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:47:50 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:47:50 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:47:50 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 07:47:50 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:47:50 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:47:50 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/1478018213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:47:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:47:50 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:47:50 INFO - Http code: 200 07:47:50 INFO - via: 1.1 990c804118e679d7ea0f4d3ca3cc4534.cloudfront.net (CloudFront) 07:47:50 INFO - x-amz-cf-id: iq7RyhyRq21B7z07CtMMITnqR5_DFaykfwSZaDys3Fp-IKLWPoAaqg== 07:47:50 INFO - x-amz-replication-status: COMPLETED 07:47:50 INFO - x-amz-version-id: O3YI5AOgvvvh5foLsk_XA2dPz9xKiFs3 07:47:50 INFO - Expected file size: 22019704 07:47:50 INFO - Obtained file size: 22019704 07:47:54 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 07:47:54 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/1478018213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 07:47:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:47:54 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 07:47:54 INFO - Http code: 200 07:47:54 INFO - via: 1.1 aa96a51fedae85199c643eb5c8eca4e4.cloudfront.net (CloudFront) 07:47:54 INFO - x-amz-cf-id: HFzkshRi1236gQtugWPPUHXHUI6SN6u4oCuCRh5q9Xya-rMJETT8Hw== 07:47:54 INFO - x-amz-replication-status: COMPLETED 07:47:54 INFO - x-amz-version-id: O3YI5AOgvvvh5foLsk_XA2dPz9xKiFs3 07:47:54 INFO - Expected file size: 22019704 07:47:54 INFO - Obtained file size: 22019704 07:47:59 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/1478018213/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 07:47:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:47:59 INFO - Fetch https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 07:47:59 INFO - Http code: 200 07:47:59 INFO - via: 1.1 ca024aca72de992a25bcd7fdcfe84b67.cloudfront.net (CloudFront) 07:47:59 INFO - x-amz-cf-id: qkuMv-QHaCCFq20oYM8kklmbYBFUC6w9l85ZColCGKvhPC5oO28qsw== 07:47:59 INFO - x-amz-replication-status: COMPLETED 07:47:59 INFO - x-amz-version-id: QFwy5O85qMiDaDDyyzicLSI96nxBMWxK 07:47:59 INFO - Expected file size: 14409038 07:47:59 INFO - Obtained file size: 14409038 07:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:59 INFO - trying https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:47:59 INFO - Downloading https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/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 07:47:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/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 07:48:00 INFO - Downloaded 59610653 bytes. 07:48:00 INFO - Setting buildbot property build_url to https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:48:00 INFO - mkdir: /builds/slave/test/properties 07:48:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:48:00 INFO - Writing to file /builds/slave/test/properties/build_url 07:48:00 INFO - Contents: 07:48:00 INFO - build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 07:48:00 INFO - Running post-action listener: _resource_record_post_action 07:48:00 INFO - Running post-action listener: set_extra_try_arguments 07:48:00 INFO - [mozharness: 2016-11-02 14:48:00.770923Z] Finished download-and-extract step (success) 07:48:00 INFO - [mozharness: 2016-11-02 14:48:00.771181Z] Running populate-webroot step. 07:48:00 INFO - Running pre-action listener: _resource_record_pre_action 07:48:00 INFO - Running main action method: populate_webroot 07:48:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:48:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:48:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:48:00 INFO - '--tppagecycles', 07:48:00 INFO - '7'], 07:48:00 INFO - 'tests': ['tsvgm']}}, 07:48:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:48:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:48:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:48:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:48:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:00 INFO - 'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:48:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:00 INFO - 'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['damp', 'tps']}, 07:48:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:00 INFO - 'tests': ['damp', 'tps']}, 07:48:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['dromaeo_dom']}, 07:48:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:48:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['basic_compositor_video']}, 07:48:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:48:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['a11yr', 07:48:00 INFO - 'ts_paint', 07:48:00 INFO - 'tpaint', 07:48:00 INFO - 'sessionrestore', 07:48:00 INFO - 'sessionrestore_no_auto_restore', 07:48:00 INFO - 'tabpaint']}, 07:48:00 INFO - 'other-e10s': {'tests': ['a11yr', 07:48:00 INFO - 'ts_paint', 07:48:00 INFO - 'tpaint', 07:48:00 INFO - 'sessionrestore', 07:48:00 INFO - 'sessionrestore_no_auto_restore', 07:48:00 INFO - 'tabpaint']}, 07:48:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:48:00 INFO - 'ts_paint', 07:48:00 INFO - 'tpaint', 07:48:00 INFO - 'sessionrestore', 07:48:00 INFO - 'sessionrestore_no_auto_restore', 07:48:00 INFO - 'tabpaint']}, 07:48:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:48:00 INFO - 'ts_paint', 07:48:00 INFO - 'tpaint', 07:48:00 INFO - 'sessionrestore', 07:48:00 INFO - 'sessionrestore_no_auto_restore', 07:48:00 INFO - 'tabpaint']}, 07:48:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['a11yr', 07:48:00 INFO - 'ts_paint', 07:48:00 INFO - 'tpaint', 07:48:00 INFO - 'sessionrestore', 07:48:00 INFO - 'sessionrestore_no_auto_restore', 07:48:00 INFO - 'tabpaint']}, 07:48:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['a11yr', 07:48:00 INFO - 'ts_paint', 07:48:00 INFO - 'tpaint', 07:48:00 INFO - 'sessionrestore', 07:48:00 INFO - 'sessionrestore_no_auto_restore', 07:48:00 INFO - 'tabpaint']}, 07:48:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['tsvgx', 07:48:00 INFO - 'tsvgr_opacity', 07:48:00 INFO - 'tart', 07:48:00 INFO - 'tscrollx', 07:48:00 INFO - 'cart']}, 07:48:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:48:00 INFO - 'tsvgr_opacity', 07:48:00 INFO - 'tart', 07:48:00 INFO - 'tscrollx', 07:48:00 INFO - 'cart']}, 07:48:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:00 INFO - 'talos_options': ['--disable-e10s'], 07:48:00 INFO - 'tests': ['tp5o']}, 07:48:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:00 INFO - 'tests': ['tp5o']}, 07:48:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:00 INFO - 'talos_options': ['--disable-e10s', 07:48:00 INFO - '--xperf_path', 07:48:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:00 INFO - 'tests': ['tp5n']}, 07:48:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:48:00 INFO - 'talos_options': ['--xperf_path', 07:48:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:48:00 INFO - 'tests': ['tp5n']}}, 07:48:00 INFO - 'talos.zip': {'path': '', 07:48:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:48:00 INFO - Running post-action listener: _resource_record_post_action 07:48:00 INFO - [mozharness: 2016-11-02 14:48:00.792066Z] Finished populate-webroot step (success) 07:48:00 INFO - [mozharness: 2016-11-02 14:48:00.792154Z] Running create-virtualenv step. 07:48:00 INFO - Running pre-action listener: _resource_record_pre_action 07:48:00 INFO - Running main action method: create_virtualenv 07:48:00 INFO - Creating virtualenv /builds/slave/test/build/venv 07:48:00 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 07:48:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:48:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:48:00 INFO - Using real prefix '/usr' 07:48:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:48:01 INFO - Installing distribute.............................................................................................................................................................................................done. 07:48:03 INFO - Installing pip.................done. 07:48:03 INFO - Return code: 0 07:48:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:48:03 INFO - Reading from file tmpfile_stdout 07:48:03 INFO - Output received: 07:48:03 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) 07:48:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7d5615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', '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 07:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:48:03 INFO - Using env: {'DISPLAY': ':0', 07:48:03 INFO - 'HOME': '/home/cltbld', 07:48:03 INFO - 'LANG': 'en_US.UTF-8', 07:48:03 INFO - 'LANGUAGE': 'en_US:en', 07:48:03 INFO - 'LOGNAME': 'cltbld', 07:48:03 INFO - 'MAIL': '/var/mail/cltbld', 07:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:03 INFO - 'MOZ_NO_REMOTE': '1', 07:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:03 INFO - 'NO_EM_RESTART': '1', 07:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:03 INFO - 'PWD': '/builds/slave/test', 07:48:03 INFO - 'SHELL': '/bin/bash', 07:48:03 INFO - 'SHLVL': '1', 07:48:03 INFO - 'TERM': 'linux', 07:48:03 INFO - 'TMOUT': '86400', 07:48:03 INFO - 'USER': 'cltbld', 07:48:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:03 INFO - '_': '/tools/buildbot/bin/python'} 07:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:03 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 07:48:03 INFO - Cleaning up... 07:48:03 INFO - Return code: 0 07:48:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd7d5615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', '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 07:48:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:48:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:48:03 INFO - Using env: {'DISPLAY': ':0', 07:48:03 INFO - 'HOME': '/home/cltbld', 07:48:03 INFO - 'LANG': 'en_US.UTF-8', 07:48:03 INFO - 'LANGUAGE': 'en_US:en', 07:48:03 INFO - 'LOGNAME': 'cltbld', 07:48:03 INFO - 'MAIL': '/var/mail/cltbld', 07:48:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:03 INFO - 'MOZ_NO_REMOTE': '1', 07:48:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:03 INFO - 'NO_EM_RESTART': '1', 07:48:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:03 INFO - 'PWD': '/builds/slave/test', 07:48:03 INFO - 'SHELL': '/bin/bash', 07:48:03 INFO - 'SHLVL': '1', 07:48:03 INFO - 'TERM': 'linux', 07:48:03 INFO - 'TMOUT': '86400', 07:48:03 INFO - 'USER': 'cltbld', 07:48:03 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:03 INFO - '_': '/tools/buildbot/bin/python'} 07:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:04 INFO - Downloading/unpacking psutil>=3.1.1 07:48:04 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 07:48:04 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 07:48:04 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 07:48:04 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 07:48:04 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 07:48:04 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 07:48:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:48:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:06 INFO - Installing collected packages: psutil 07:48:06 INFO - Running setup.py install for psutil 07:48:06 INFO - building 'psutil._psutil_linux' extension 07:48:06 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 07:48:06 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 07:48:06 INFO - building 'psutil._psutil_posix' extension 07:48:06 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 07:48:06 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 07:48:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:48:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:48:06 INFO - Successfully installed psutil 07:48:06 INFO - Cleaning up... 07:48:06 INFO - Return code: 0 07:48:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd7d5615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', '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 07:48:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:48:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:48:06 INFO - Using env: {'DISPLAY': ':0', 07:48:06 INFO - 'HOME': '/home/cltbld', 07:48:06 INFO - 'LANG': 'en_US.UTF-8', 07:48:06 INFO - 'LANGUAGE': 'en_US:en', 07:48:06 INFO - 'LOGNAME': 'cltbld', 07:48:06 INFO - 'MAIL': '/var/mail/cltbld', 07:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:06 INFO - 'MOZ_NO_REMOTE': '1', 07:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:06 INFO - 'NO_EM_RESTART': '1', 07:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:06 INFO - 'PWD': '/builds/slave/test', 07:48:06 INFO - 'SHELL': '/bin/bash', 07:48:06 INFO - 'SHLVL': '1', 07:48:06 INFO - 'TERM': 'linux', 07:48:06 INFO - 'TMOUT': '86400', 07:48:06 INFO - 'USER': 'cltbld', 07:48:06 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:06 INFO - '_': '/tools/buildbot/bin/python'} 07:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:48:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:48:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:48:08 INFO - Installing collected packages: mozsystemmonitor 07:48:08 INFO - Running setup.py install for mozsystemmonitor 07:48:08 INFO - Successfully installed mozsystemmonitor 07:48:08 INFO - Cleaning up... 07:48:09 INFO - Return code: 0 07:48:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd7d5615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', '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 07:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:48:09 INFO - Using env: {'DISPLAY': ':0', 07:48:09 INFO - 'HOME': '/home/cltbld', 07:48:09 INFO - 'LANG': 'en_US.UTF-8', 07:48:09 INFO - 'LANGUAGE': 'en_US:en', 07:48:09 INFO - 'LOGNAME': 'cltbld', 07:48:09 INFO - 'MAIL': '/var/mail/cltbld', 07:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:09 INFO - 'MOZ_NO_REMOTE': '1', 07:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:09 INFO - 'NO_EM_RESTART': '1', 07:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:09 INFO - 'PWD': '/builds/slave/test', 07:48:09 INFO - 'SHELL': '/bin/bash', 07:48:09 INFO - 'SHLVL': '1', 07:48:09 INFO - 'TERM': 'linux', 07:48:09 INFO - 'TMOUT': '86400', 07:48:09 INFO - 'USER': 'cltbld', 07:48:09 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:09 INFO - '_': '/tools/buildbot/bin/python'} 07:48:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:09 INFO - Downloading/unpacking jsonschema==2.5.1 07:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:48:11 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:11 INFO - Downloading functools32-3.2.3-2.tar.gz 07:48:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:48:11 INFO - warning: no files found matching '*.txt' 07:48:11 INFO - no previously-included directories found matching 'build' 07:48:11 INFO - no previously-included directories found matching 'dist' 07:48:11 INFO - no previously-included directories found matching '.git*' 07:48:11 INFO - Installing collected packages: jsonschema, functools32 07:48:11 INFO - Running setup.py install for functools32 07:48:11 INFO - warning: no files found matching '*.txt' 07:48:11 INFO - no previously-included directories found matching 'build' 07:48:11 INFO - no previously-included directories found matching 'dist' 07:48:11 INFO - no previously-included directories found matching '.git*' 07:48:11 INFO - Successfully installed jsonschema functools32 07:48:11 INFO - Cleaning up... 07:48:11 INFO - Return code: 0 07:48:11 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:48: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')]} 07:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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')]} 07:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd7d5615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', '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 07:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:48:11 INFO - Using env: {'DISPLAY': ':0', 07:48:11 INFO - 'HOME': '/home/cltbld', 07:48:11 INFO - 'LANG': 'en_US.UTF-8', 07:48:11 INFO - 'LANGUAGE': 'en_US:en', 07:48:11 INFO - 'LOGNAME': 'cltbld', 07:48:11 INFO - 'MAIL': '/var/mail/cltbld', 07:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:11 INFO - 'MOZ_NO_REMOTE': '1', 07:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:11 INFO - 'NO_EM_RESTART': '1', 07:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:11 INFO - 'PWD': '/builds/slave/test', 07:48:11 INFO - 'SHELL': '/bin/bash', 07:48:11 INFO - 'SHLVL': '1', 07:48:11 INFO - 'TERM': 'linux', 07:48:11 INFO - 'TMOUT': '86400', 07:48:11 INFO - 'USER': 'cltbld', 07:48:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:11 INFO - '_': '/tools/buildbot/bin/python'} 07:48:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:11 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:48:11 INFO - Cleaning up... 07:48:11 INFO - Return code: 0 07:48:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:48: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')]} 07:48:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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')]} 07:48:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd7d5615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', '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 07:48:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:48:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:48:11 INFO - Using env: {'DISPLAY': ':0', 07:48:11 INFO - 'HOME': '/home/cltbld', 07:48:11 INFO - 'LANG': 'en_US.UTF-8', 07:48:11 INFO - 'LANGUAGE': 'en_US:en', 07:48:11 INFO - 'LOGNAME': 'cltbld', 07:48:11 INFO - 'MAIL': '/var/mail/cltbld', 07:48:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:11 INFO - 'MOZ_NO_REMOTE': '1', 07:48:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:11 INFO - 'NO_EM_RESTART': '1', 07:48:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:11 INFO - 'PWD': '/builds/slave/test', 07:48:11 INFO - 'SHELL': '/bin/bash', 07:48:11 INFO - 'SHLVL': '1', 07:48:11 INFO - 'TERM': 'linux', 07:48:11 INFO - 'TMOUT': '86400', 07:48:11 INFO - 'USER': 'cltbld', 07:48:11 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:11 INFO - '_': '/tools/buildbot/bin/python'} 07:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:12 INFO - Downloading/unpacking blobuploader==1.2.4 07:48:12 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 07:48:12 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 07:48:12 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 07:48:12 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 07:48:12 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 07:48:12 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 07:48:14 INFO - Downloading blobuploader-1.2.4.tar.gz 07:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:48:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:48:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:14 INFO - Downloading docopt-0.6.1.tar.gz 07:48:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:48:14 INFO - Installing collected packages: blobuploader, requests, docopt 07:48:14 INFO - Running setup.py install for blobuploader 07:48:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:48:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:48:14 INFO - Running setup.py install for requests 07:48:15 INFO - Running setup.py install for docopt 07:48:15 INFO - Successfully installed blobuploader requests docopt 07:48:15 INFO - Cleaning up... 07:48:15 INFO - Return code: 0 07:48:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48: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')]} 07:48:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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')]} 07:48:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:15 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 0x7fd7d5615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', '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 07:48:15 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 07:48:15 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 07:48:15 INFO - Using env: {'DISPLAY': ':0', 07:48:15 INFO - 'HOME': '/home/cltbld', 07:48:15 INFO - 'LANG': 'en_US.UTF-8', 07:48:15 INFO - 'LANGUAGE': 'en_US:en', 07:48:15 INFO - 'LOGNAME': 'cltbld', 07:48:15 INFO - 'MAIL': '/var/mail/cltbld', 07:48:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:15 INFO - 'MOZ_NO_REMOTE': '1', 07:48:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:15 INFO - 'NO_EM_RESTART': '1', 07:48:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:15 INFO - 'PWD': '/builds/slave/test', 07:48:15 INFO - 'SHELL': '/bin/bash', 07:48:15 INFO - 'SHLVL': '1', 07:48:15 INFO - 'TERM': 'linux', 07:48:15 INFO - 'TMOUT': '86400', 07:48:15 INFO - 'USER': 'cltbld', 07:48:15 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:15 INFO - '_': '/tools/buildbot/bin/python'} 07:48:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:15 INFO - Running setup.py (path:/tmp/pip-zfvm2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:15 INFO - Running setup.py (path:/tmp/pip-CXYH_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:15 INFO - Running setup.py (path:/tmp/pip-ZlY3r1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:15 INFO - Running setup.py (path:/tmp/pip-z0eVjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:15 INFO - Running setup.py (path:/tmp/pip-OSnDLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:16 INFO - Running setup.py (path:/tmp/pip-d17mIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:16 INFO - Running setup.py (path:/tmp/pip-2zkTXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:16 INFO - Running setup.py (path:/tmp/pip-1046j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:16 INFO - Running setup.py (path:/tmp/pip-_si3qT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:16 INFO - Running setup.py (path:/tmp/pip-hFCcI8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:16 INFO - Running setup.py (path:/tmp/pip-CF3cgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:16 INFO - Running setup.py (path:/tmp/pip-rzPjVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:16 INFO - Running setup.py (path:/tmp/pip-73FL_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:16 INFO - Running setup.py (path:/tmp/pip-0u8n9L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:16 INFO - Running setup.py (path:/tmp/pip-42SFoi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:16 INFO - Running setup.py (path:/tmp/pip-6xDga5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:16 INFO - Running setup.py (path:/tmp/pip-MKI8eP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:48:16 INFO - Running setup.py install for manifestparser 07:48:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Running setup.py install for mozcrash 07:48:17 INFO - Running setup.py install for mozdebug 07:48:17 INFO - Running setup.py install for mozdevice 07:48:17 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Running setup.py install for mozfile 07:48:17 INFO - Running setup.py install for mozhttpd 07:48:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Running setup.py install for mozinfo 07:48:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Running setup.py install for mozInstall 07:48:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Running setup.py install for mozleak 07:48:17 INFO - Running setup.py install for mozlog 07:48:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:48:17 INFO - Running setup.py install for moznetwork 07:48:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Running setup.py install for mozprocess 07:48:18 INFO - Running setup.py install for mozprofile 07:48:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Running setup.py install for mozrunner 07:48:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Running setup.py install for mozscreenshot 07:48:18 INFO - Running setup.py install for moztest 07:48:18 INFO - Running setup.py install for mozversion 07:48:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:48:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:48:18 INFO - Cleaning up... 07:48:18 INFO - Return code: 0 07:48:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48: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')]} 07:48:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48: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')]} 07:48:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:18 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 0x7fd7d5615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', '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 07:48:18 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 07:48:18 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 07:48:18 INFO - Using env: {'DISPLAY': ':0', 07:48:18 INFO - 'HOME': '/home/cltbld', 07:48:18 INFO - 'LANG': 'en_US.UTF-8', 07:48:18 INFO - 'LANGUAGE': 'en_US:en', 07:48:18 INFO - 'LOGNAME': 'cltbld', 07:48:18 INFO - 'MAIL': '/var/mail/cltbld', 07:48:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:18 INFO - 'MOZ_NO_REMOTE': '1', 07:48:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:18 INFO - 'NO_EM_RESTART': '1', 07:48:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:18 INFO - 'PWD': '/builds/slave/test', 07:48:18 INFO - 'SHELL': '/bin/bash', 07:48:18 INFO - 'SHLVL': '1', 07:48:18 INFO - 'TERM': 'linux', 07:48:18 INFO - 'TMOUT': '86400', 07:48:18 INFO - 'USER': 'cltbld', 07:48:18 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:18 INFO - '_': '/tools/buildbot/bin/python'} 07:48:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:48:18 INFO - Running setup.py (path:/tmp/pip-RHdpTP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:48:19 INFO - Running setup.py (path:/tmp/pip-dSM7vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:48:19 INFO - Running setup.py (path:/tmp/pip-_qYio9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:48:19 INFO - Running setup.py (path:/tmp/pip-bnNUe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:48:19 INFO - Running setup.py (path:/tmp/pip-FtOOiy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:48:19 INFO - Running setup.py (path:/tmp/pip-ipfyIY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:48:19 INFO - Running setup.py (path:/tmp/pip-hkwvjl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:48:19 INFO - Running setup.py (path:/tmp/pip-8iL4yp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:48:19 INFO - Running setup.py (path:/tmp/pip-nDyCuU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:48:19 INFO - Running setup.py (path:/tmp/pip-wiTOXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:48:19 INFO - Running setup.py (path:/tmp/pip-BRmCir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:48:19 INFO - Running setup.py (path:/tmp/pip-hM4nQy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:48:19 INFO - Running setup.py (path:/tmp/pip-ImDlzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:48:19 INFO - Running setup.py (path:/tmp/pip-X5YVlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:48:19 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)) 07:48:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:19 INFO - Running setup.py (path:/tmp/pip-M5pd3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:48:20 INFO - Running setup.py (path:/tmp/pip-N7X2j0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:48:20 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)) 07:48:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:48:20 INFO - Running setup.py (path:/tmp/pip-dAHKO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:48:20 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)) 07:48:20 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)) 07:48:20 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)) 07:48:20 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)) 07:48:20 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)) 07:48:20 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)) 07:48:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:48:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:48:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:48:22 INFO - Downloading blessings-1.6.tar.gz 07:48:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:48:22 INFO - Installing collected packages: blessings 07:48:22 INFO - Running setup.py install for blessings 07:48:22 INFO - Successfully installed blessings 07:48:22 INFO - Cleaning up... 07:48:22 INFO - Return code: 0 07:48:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:48:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:22 INFO - Reading from file tmpfile_stdout 07:48:22 INFO - Current package versions: 07:48:22 INFO - argparse == 1.2.1 07:48:22 INFO - blessings == 1.6 07:48:22 INFO - blobuploader == 1.2.4 07:48:22 INFO - docopt == 0.6.1 07:48:22 INFO - functools32 == 3.2.3-2 07:48:22 INFO - jsonschema == 2.5.1 07:48:22 INFO - manifestparser == 1.1 07:48:22 INFO - mozInstall == 1.12 07:48:22 INFO - mozcrash == 0.17 07:48:22 INFO - mozdebug == 0.1 07:48:22 INFO - mozdevice == 0.48 07:48:22 INFO - mozfile == 1.2 07:48:22 INFO - mozhttpd == 0.7 07:48:22 INFO - mozinfo == 0.9 07:48:22 INFO - mozleak == 0.1 07:48:22 INFO - mozlog == 3.4 07:48:22 INFO - moznetwork == 0.27 07:48:22 INFO - mozprocess == 0.23 07:48:22 INFO - mozprofile == 0.28 07:48:22 INFO - mozrunner == 6.12 07:48:22 INFO - mozscreenshot == 0.1 07:48:22 INFO - mozsystemmonitor == 0.3 07:48:22 INFO - moztest == 0.7 07:48:22 INFO - mozversion == 1.4 07:48:22 INFO - psutil == 3.1.1 07:48:22 INFO - requests == 1.2.3 07:48:22 INFO - wsgiref == 0.1.2 07:48:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:22 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 0x7fd7d5615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', '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 07:48:22 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 07:48:22 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 07:48:22 INFO - Using env: {'DISPLAY': ':0', 07:48:22 INFO - 'HOME': '/home/cltbld', 07:48:22 INFO - 'LANG': 'en_US.UTF-8', 07:48:22 INFO - 'LANGUAGE': 'en_US:en', 07:48:22 INFO - 'LOGNAME': 'cltbld', 07:48:22 INFO - 'MAIL': '/var/mail/cltbld', 07:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:22 INFO - 'MOZ_NO_REMOTE': '1', 07:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:22 INFO - 'NO_EM_RESTART': '1', 07:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:22 INFO - 'PWD': '/builds/slave/test', 07:48:22 INFO - 'SHELL': '/bin/bash', 07:48:22 INFO - 'SHLVL': '1', 07:48:22 INFO - 'TERM': 'linux', 07:48:22 INFO - 'TMOUT': '86400', 07:48:22 INFO - 'USER': 'cltbld', 07:48:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:22 INFO - '_': '/tools/buildbot/bin/python'} 07:48:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:22 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)) 07:48:22 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)) 07:48:22 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)) 07:48:22 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)) 07:48:22 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)) 07:48:22 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)) 07:48:22 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)) 07:48:22 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)) 07:48:22 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)) 07:48:22 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)) 07:48:22 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)) 07:48:22 INFO - Cleaning up... 07:48:22 INFO - Return code: 0 07:48:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:48:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:48:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:48:22 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 0x7fd7d5615f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1272ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, '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': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', '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 07:48:22 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 07:48:22 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 07:48:22 INFO - Using env: {'DISPLAY': ':0', 07:48:22 INFO - 'HOME': '/home/cltbld', 07:48:22 INFO - 'LANG': 'en_US.UTF-8', 07:48:22 INFO - 'LANGUAGE': 'en_US:en', 07:48:22 INFO - 'LOGNAME': 'cltbld', 07:48:22 INFO - 'MAIL': '/var/mail/cltbld', 07:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:22 INFO - 'MOZ_NO_REMOTE': '1', 07:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:22 INFO - 'NO_EM_RESTART': '1', 07:48:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:22 INFO - 'PWD': '/builds/slave/test', 07:48:22 INFO - 'SHELL': '/bin/bash', 07:48:22 INFO - 'SHLVL': '1', 07:48:22 INFO - 'TERM': 'linux', 07:48:22 INFO - 'TMOUT': '86400', 07:48:22 INFO - 'USER': 'cltbld', 07:48:22 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:22 INFO - '_': '/tools/buildbot/bin/python'} 07:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:48:23 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:48:23 INFO - Cleaning up... 07:48:23 INFO - Return code: 0 07:48:23 INFO - Running post-action listener: _resource_record_post_action 07:48:23 INFO - Running post-action listener: _start_resource_monitoring 07:48:23 INFO - Starting resource monitoring. 07:48:23 INFO - [mozharness: 2016-11-02 14:48:23.095788Z] Finished create-virtualenv step (success) 07:48:23 INFO - [mozharness: 2016-11-02 14:48:23.096244Z] Running install step. 07:48:23 INFO - Running pre-action listener: _resource_record_pre_action 07:48:23 INFO - Running main action method: install 07:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:48:23 INFO - Reading from file tmpfile_stdout 07:48:23 INFO - Detecting whether we're running mozinstall >=1.0... 07:48:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:48:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:48:23 INFO - Reading from file tmpfile_stdout 07:48:23 INFO - Output received: 07:48:23 INFO - Usage: mozinstall [options] installer 07:48:23 INFO - Options: 07:48:23 INFO - -h, --help show this help message and exit 07:48:23 INFO - -d DEST, --destination=DEST 07:48:23 INFO - Directory to install application into. [default: 07:48:23 INFO - "/builds/slave/test"] 07:48:23 INFO - --app=APP Application being installed. [default: firefox] 07:48:23 INFO - mkdir: /builds/slave/test/build/application 07:48:23 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'] 07:48:23 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 07:48:40 INFO - Reading from file tmpfile_stdout 07:48:40 INFO - Output received: 07:48:40 INFO - /builds/slave/test/build/application/firefox/firefox 07:48:40 INFO - Running post-action listener: _resource_record_post_action 07:48:40 INFO - [mozharness: 2016-11-02 14:48:40.384113Z] Finished install step (success) 07:48:40 INFO - [mozharness: 2016-11-02 14:48:40.384385Z] Running run-tests step. 07:48:40 INFO - Running pre-action listener: _resource_record_pre_action 07:48:40 INFO - Running main action method: run_tests 07:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:48:40 INFO - Python 2.7.3 07:48:40 INFO - Return code: 0 07:48:40 INFO - grabbing minidump binary from tooltool 07:48:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:48:40 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 0x126ff60>, '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 0x1270d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12711d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:48:40 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 07:48:40 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 07:48:40 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 07:48:40 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:48:40 INFO - Return code: 0 07:48:40 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:48:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:48:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:48:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:48:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 07:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-064 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 07:48:40 INFO - Using env: {'DISPLAY': ':0', 07:48:40 INFO - 'HOME': '/home/cltbld', 07:48:40 INFO - 'LANG': 'en_US.UTF-8', 07:48:40 INFO - 'LANGUAGE': 'en_US:en', 07:48:40 INFO - 'LOGNAME': 'cltbld', 07:48:40 INFO - 'MAIL': '/var/mail/cltbld', 07:48:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:48:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:48:40 INFO - 'MOZ_NO_REMOTE': '1', 07:48:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:48:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:48:40 INFO - 'NO_EM_RESTART': '1', 07:48:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:48:40 INFO - 'PWD': '/builds/slave/test', 07:48:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:48:40 INFO - 'SHELL': '/bin/bash', 07:48:40 INFO - 'SHLVL': '1', 07:48:40 INFO - 'TERM': 'linux', 07:48:40 INFO - 'TMOUT': '86400', 07:48:40 INFO - 'USER': 'cltbld', 07:48:40 INFO - 'XDG_SESSION_COOKIE': 'a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777', 07:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:48:40 INFO - '_': '/tools/buildbot/bin/python'} 07:48:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-064', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 07:48:40 INFO - mozversion application_buildid: 20161101093653 07:48:40 INFO - mozversion application_changeset: 4cde141bbedfd7355bdf3e9ac41740fb8fa2f06d 07:48:40 INFO - mozversion application_display_name: Nightly 07:48:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:48:40 INFO - mozversion application_name: Firefox 07:48:40 INFO - mozversion application_remotingname: firefox 07:48:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:48:40 INFO - mozversion application_vendor: Mozilla 07:48:40 INFO - mozversion application_version: 52.0a1 07:48:40 INFO - mozversion platform_buildid: 20161101093653 07:48:40 INFO - mozversion platform_changeset: 4cde141bbedfd7355bdf3e9ac41740fb8fa2f06d 07:48:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 07:48:40 INFO - mozversion platform_version: 52.0a1 07:48:40 INFO - using testdate: 1478098120 07:48:40 INFO - actual date: 1478098120 07:48:40 INFO - starting webserver on 'localhost:57959' 07:48:40 INFO - SUITE-START | Running 2 tests 07:48:40 INFO - TEST-START | dromaeo_css 07:48:40 INFO - operating with platform_type : linux_ 07:48:40 INFO - Initialising browser for dromaeo_css test... 07:48:40 INFO - TEST-INFO | started process 26108 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6xclt9/profile http://localhost:57959/getInfo.html) 07:48:45 INFO - PROCESS | 26108 | __metrics Screen width/height:1600/1200 07:48:45 INFO - PROCESS | 26108 | colorDepth:24 07:48:45 INFO - PROCESS | 26108 | Browser inner width/height: 1024/697 07:48:45 INFO - PROCESS | 26108 | __metrics 07:48:46 ERROR - PROCESS | 26108 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 07:48:47 INFO - TEST-INFO | 26108: exit 0 07:48:47 INFO - Browser initialized. 07:48:47 INFO - Running cycle 1/1 for dromaeo_css test... 07:48:47 INFO - TEST-INFO | started process 26229 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6xclt9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:48:59 INFO - PROCESS | 26229 | RSS: Main: 185430016 07:48:59 INFO - PROCESS | 26229 | 07:49:49 INFO - PROCESS | 26229 | 1478098189080 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] 07:52:01 INFO - PROCESS | 26229 | Cycle 1(1): loaded http://localhost:57959/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57959/tests/dromaeo/cssquery-ext.html) 07:52:02 INFO - PROCESS | 26229 | RSS: Main: 198471680 07:52:02 INFO - PROCESS | 26229 | 07:55:04 INFO - PROCESS | 26229 | Cycle 1(1): loaded http://localhost:57959/tests/dromaeo/cssquery-ext.html (next: http://localhost:57959/tests/dromaeo/cssquery-jquery.html) 07:55:05 INFO - PROCESS | 26229 | RSS: Main: 196128768 07:55:05 INFO - PROCESS | 26229 | 07:58:07 INFO - PROCESS | 26229 | Cycle 1(1): loaded http://localhost:57959/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57959/tests/dromaeo/cssquery-mootools.html) 07:58:08 INFO - PROCESS | 26229 | RSS: Main: 198864896 07:58:08 INFO - PROCESS | 26229 | 08:01:10 INFO - PROCESS | 26229 | Cycle 1(1): loaded http://localhost:57959/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57959/tests/dromaeo/cssquery-prototype.html) 08:01:10 INFO - PROCESS | 26229 | RSS: Main: 194977792 08:01:10 INFO - PROCESS | 26229 | 08:04:13 INFO - PROCESS | 26229 | Cycle 1(1): loaded http://localhost:57959/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57959/tests/dromaeo/cssquery-yui.html) 08:04:13 INFO - PROCESS | 26229 | RSS: Main: 198483968 08:04:13 INFO - PROCESS | 26229 | 08:07:16 INFO - PROCESS | 26229 | Cycle 1(1): loaded http://localhost:57959/tests/dromaeo/cssquery-yui.html (next: http://localhost:57959/tests/dromaeo/cssquery-dojo.html) 08:07:16 INFO - PROCESS | 26229 | RSS: Main: 198754304 08:07:16 INFO - PROCESS | 26229 | 08:07:16 INFO - PROCESS | 26229 | __start_tp_report 08:07:16 INFO - PROCESS | 26229 | _x_x_mozilla_page_load 08:07:16 INFO - PROCESS | 26229 | _x_x_mozilla_page_load_details 08:07:16 INFO - PROCESS | 26229 | |i|pagename|runs| 08:07:16 INFO - PROCESS | 26229 | |0;dojo.html;3091.19628896487;3092.8453577321156;3098.4732595458768;3104.1308433638574;3115.704008119228;5348.652337598053;5366.409694933559;5450.1552259399805;5459.563234941205;5541.861453463665;5347.946520534793;5458.099413596752;5459.535939445142;5529.198266251391;5539.41836107209;4940.802367905279;4976.129177393951;5035.295058691786;5048.318477005612;5065.518775716319;4992.101421744084;5020.523050310233;5041.848744537651;5092.923606145892;5095.592352611782;4880.365552478155;4995.075910956485;5016.799328026875;5078.974605126969;5102.540771330598;4892.0705066037335;4947.9505204947845;4954.603631709455;4958.528939750754;4968.1554135797005;4906.337644418029;4909.140900342426;4913.336699545552;4916.975415122937;4922.581580565657;5360.16917377807;5383.488568585978;5400.594955378362;5411.080116380185;5427.810026649087;5783.942160578425;5789.392113828029;5789.8263052108505;5801.0428279333855;5804.187413762077;5845.941540584582;5863.325717542494;5872.677002764846;5927.1405646181065;5930.822075337746;5475.315585551806;5519.116941289374;5522.502974732293;5523.2543606613;5526.392096869301;5901.3213480450295;5910.674912879746;5922.911156332572;6030;6034.5172386209;5759.827205183851;5774.480296773227;5778;5778.16216648592;5780.797672081457;5656.547476201894;5716.685582293014;5785.1322301654245;5794.942050579524;5856.326522449887;5844;5845.736941837543;5851.531877449794;5896.705164741831;5909.6158749681135;5819.709014549256;5822.679752613562;5857.150713146655;5862.208601838783;5863.560232982543;4396.648268138541;4444.599986001275;4475.26158183896;4477.731336119843;4490.393796837385;3936.193080418507;3946.7631942083567;3951.7431366961055;3983.92032159361;4054.2094291612852;5533.695646739468;5577.498025177672;5587.664740115606;5590.440955904458;5600.4399560044485;5871.207387002785;5890;5905.4685078343155;5921.200637913913;5947.1079338099635;5574.9442505574425;5640.294963129609;5642.379338272869;5687;5729.4843464088435;5109.080365534165;5154.098032844237;5174.120399532013;5175.689458632494;5232.607554433356;5924.9703751480965;5989.041753319448;6101.095933926387;6115;6220.595661282002;5912.260967379078;5917.911231331447;5927.110933360031;5976;5981.730822112929;6113.969430152821;6137.263528376623;6150.600210986271;6158.199434073721;6178.196834411498;5674.375818660027;5720.771169153188;5747.9137812932;5791.797287094932;5849.181114644039;5951.732172052181;5952.0476723724;5958.76164953397;5981.162637230878;6028.517718582415;5750.827475175752;5789.160571716993;5813.15709222152;5813.9534883721335;5819.534437244925;5542;5594.580406469449;5723.513501352431;5729.054705973468;5777.74000169985;5746.741396637245;5780.768769249351;5816.214811000461;5853.560982926383;5878.2064421302575;5805.419458054161;5846.736896839738;5852.50761055928;5865.5600829937075;5870.823875283749;5501.394846566955;5636.718164091861;5719.199312096393;5744.569157313302;5745.569082318759 08:07:16 INFO - PROCESS | 26229 | |1;ext.html;559.7788873395009;571.1204744693173;573.2891214893531;580.1066357808975;592.2478452365496;40633.59366406335;42467.15065698688;42497;44666.776666116704;44716.552834471644;43186.35220471695;43549.564504354945;43636.345454818125;43743;43831.78084109583;8731.126887311282;8885.866711999326;8903.95548022259;8906.376553641248;8912.8663070054;8740.606672699712;8807.691730789424;8856.867146992769;8872.778180545474;8881.866771998426;8864.423812452202;8920.643174273022;8935.821283574325;8969.596368163415;8985.281177505783;8797.7800554986;8808.911910880937;8851;8875.245604123626;8930.955345223298;8741.912580874237;8796.164364385373;8810.339224558184;8826.955865220632;8839.425437346616;41215.58784412177;41249.79375103135;41438.1712365754;41495.1700965982;41540.79229603833;3464.133966508373;3496.6852983231634;3506.754527183098;3574.8391322390553;3710.591834898159;30635.693643063507;30991.535126973115;31090.378192436252;31739.682603174133;31793.84103079493;4281.357796330544;4285.528591854893;4318.114786468798;4343.2399330117105;4424.60178583929;320408;320773;321159;321347;322547.3872630645;52544.21183682171;52914.73542632262;52939.47060529423;53030.73484632552;53183;52903.73548132235;53117.2032419514;53281.46718532765;53377;53394.73302633462;15210.923945380202;15394.07635541871;15429.691406171814;15435.536933892;15454;11353.432328383547;11396.373199474108;11403.315801051964;11425.771484570429;11430.828537571942;15507.302171402314;16176.67646647084;16352.591185220464;16383.83616163847;16427;6066.4540191382985;6122.357152498924;6227.314995350508;6241.500679945593;6291.182146321041;969.5443141723379;1003.9196864250988;1033.7415646088477;1093.830456279278;1128.1707944660668;30390.240243994078;30455.847720761256;30606.69393306083;30637;31181.376372472423;954.4130359828655;1073.313079629038;1075.451519724946;1103.7240689827543;1112.9109671226445;15737.606559835867;16583.253753580877;16655.6668866622;16678;16970.660586788195;438197;438622;441380;441477;442140;53350.46649533455;53520;53570.46429535733;53660;53707.19439208415;1290.7483040806953;1318.9142705724098;1320.4586119691073;1335.5325636027508;1342.9059965802496;29601.703982959894;31182.37635247328;31502.212444689067;31809.52476168145;32188.678113219506;46887.765561171975;47306.76346618245;47324.290135648684;47570;47653.76173119112;335834;338936;339624;340526;340606;27265.182044538695;27327.45345093127;27512.174634760988;27610.447791043665;27665.861670691516;43771.12457750891;44313;44860;45275.32087018631;45710;38973.81218112173;39011.41482877816;39341.6065839338;39632.2073558533;40644.1871162581;38568.6143138565;38596.80701596474;38717.03207419837;39052.80473597614;39722.60277397189;38958.2208355837;39390;39523;40196.3970540448;40410.79794601008;32786;34834.82582587071;35506.112347190494;35665;36129.819350903075;26766.19701408961;26813.329666757705;27150.864245678644;27198;27308.453830923667 08:07:16 INFO - PROCESS | 26229 | |2;jquery.html;384.70185606155246;385.1565072491242;394.11717752234995;402.12136481787286;420.16597054846125;18425.539361515952;20129.59740805185;20152.89923550382;20378.796212037912;20630.690539641917;18070.186841592127;18621.627567448642;18755;18930.81069189311;19740;5167.509086636773;5175.8188463403785;5252.6323157379;5290.576753859682;5310;5218.269442278065;5279.5512381447625;5289.788408463657;5292.761825717833;5295.4969277918535;5166.586673066165;5185.144451165553;5249.396319423277;5278.392984806758;5299.761510732026;5165.431802501703;5217.791288348461;5228.712420816853;5237.554807841338;5290.841274761744;4902.534259245366;5063.493650634944;5093.923591146136;5096.286519887219;5132.692038477703;13396.799048014287;13456.192628442226;13486.797698034537;16435.83564164355;22498.325050248517;2460.2127319257843;2460.561859798717;2788.958165627497;2924.0204531481977;2958.4378967996013;9695.563699633534;9905.306628535933;9931.851022234672;10373.688789336333;10411.739706507398;1843.8064003279596;1885.4060970794155;1923.4614307993645;1988.6321030609383;1993.8105879941381;71876.28123718748;75559.62220188919;75713;78131.21868781353;80290.16082828802;10833.133349332034;10891.67324980252;11083.057940075023;11098;11350.772984540263;15387.076775393289;15407.460738874086;15456.459023934332;15458.845411545966;15459.61350966235;7366.594837283894;7537.9623101884135;7562.546247225184;7749;7939.64271607779;6966.825829354205;7067.6112813795735;7112.50212485121;7352.522086064496;7368.59472729005;4683;4705.670603057822;4741.739204343794;4762.809487620526;4779.235322348477;1895.5120230618897;1942.2036964844347;1956.735840661521;1966.154553541962;1993.9900300498696;924.0528458330265;955.4171955107379;989.4014121456415;1005.9144972677258;1012.9493525323704;18712.25150993945;19526.21895124179;19800.405987820388;19837;20001.399958001282;967.5452537307455;999.980000399988;1012.417859730643;1020.4030642074321;1028.9022542858415;9947.154491868272;10950.945245273722;11013.339199648046;11017.724556886142;11032.669019929415;403852;422458;441372;442814;442965.5627549853;86307.56846215729;88396.5580172095;89024.55487722649;89871.55064224637;90165.09834901567;980.9460479673686;999.5202302894651;1037.1547189040907;1037.3620223562455;1039.3400190878695;16464.588385290463;16720.832791671928;16797.832021679627;16972.66054678924;17781.46655600334;29960;40676.59323406847;41379.58620413757;41432.58567414287;42818.93220144081;51358.48641513537;53146.67133321543;55624;55910;57616.423835762784;8042.195780422145;8114.43198976066;8224.62989165477;8430.957845210734;8542.957285213783;9118.088191180828;12613;13185.60443186706;13266.872315853261;13677;11536.769264614493;11597.710057248636;11942.104342174545;11963.940180299043;12057.81913271284;11317.094632429222;11459.140564457532;11540.134489913122;11555.537778488766;11866.347350895783;11779.88220117788;11847.170698051053;12168.75662486763;12229.571964981538;12244.265344079027;8269;8515.574221288787;8561.35789815754;8750.868736969078;8877.20105190536;10623.734406639896;11867.287962722265;11900.226485278428;11900.40497975115;12298.508059677513 08:07:16 INFO - PROCESS | 26229 | |3;mootools.html;1453.9781903271453;1468.8678018978292;1602.7836242107312;1684.9663006739859;1734.0722713348362;7510.81222969426;7737.92262077379;8153.347732181426;8750.168733970278;8784.604692788831;8256.91743082569;8474.661013559451;8495.78760530987;8759.21167094963;8769.035406105339;2171.174953517665;2205.106931692667;2207.23850271656;2208.5141268920893;2208.9558208835815;2095.298075144821;2140.283005193254;2157.1694897464513;2192.177933275022;2196.0556960506974;2100.8109270165683;2133.4133113393864;2142.528643698384;2149.1940522304135;2152.2251989283845;2088.634488964433;2119.1205649655376;2120.416885356524;2121.427214652043;2122.6603743400983;2100.7479102507646;2131.7868213178713;2133.232036466871;2141.4432247615578;2146.0450099705636;8363.623636936352;8452.112528184574;8457.53483558404;8476.23713865755;8482.872756908651;5029.2958985742025;5091.338126043591;5151.742412879378;5161.071007218699;5177.404598471148;3293.4236508610898;3417.333619944112;3531.2760884018717;3536.3104194682046;3547.255076433952;1030.5002073994183;1079.098952374768;1116.4919961417536;1133.3596517967321;1135.1656532448644;10957.452127393679;11174;11233.719157021058;11513.078953683686;11766.352850593128;4098.508179018537;4189.706720529533;4289.185054839633;4313.417688611998;4320.935185972213;9332.113449222314;9336.346455748033;9354.438733675865;9366.953165234267;9374.765630859147;4938.38270216223;4942.802287908516;4951.108800415887;4956.553910148032;4962.404511458648;4562.771861406983;4644.744539050384;4652.371929789435;4655.674102812771;4690.695104818176;3440.673136052071;3502.6322236165347;3523.136831476305;3552.342816578941;3601.567811862541;1100.8403781451805;1105.9170562207867;1110.816715241976;1113.1929351220463;1114.8327750837439;842.0400743152811;911.3666002128457;943.7546237978038;950.619752099152;958.9808203836023;5754.223179870748;5788.594798364158;5827.17325923021;5841.620294680833;5897.941020589825;394.57386023095563;398.79462077030354;400.3314464843718;412.2044454203356;421.3006409360508;3942.7634341939574;4001.5398229203433;4015.3374693175297;4040.9797951010055;4098.098418347959;9706;10171.237157213238;10206.897931020743;10218.335808172445;10261.230407719451;10079.69760907174;10092.697219083439;10133.341332813343;10136.898631013595;10155.035271649182;7627.351675107567;7760.689572417153;7895.328897043815;7917.406194535318;7919.920800791919;5681.375048744552;5706.400827913176;5938.584299099021;5958.076498142795;5961.254843144607;9402.717918462457;9496.525173741424;9601.087896649808;9612.423254604746;9718.271129665161;9352.766180845261;9419.293552983416;9530.237580993642;9766.365186263154;9783.26625503076;7357.77926662201;7530.774076777706;7603.20166382544;7605.201453847267;7791.454598178073;8371.748847534584;8418.494890306602;8443.07126216128;8456.492610443393;8461.450005749606;7303.671334790053;7307.451941104332;7389.371903388057;7427.740029098955;7521.586312752851;7338.229485903903;7341.70633174667;7399.48203625741;7451.739189128354;7463.216362282099;6726.3273672634305;6868.484863635347;6871.175458944958;6886.173659160932;6894.896576551256;4934.309196712535;4940.333055037524;4997;5087.4149472811105;5158.174692049254;4993.475685053162;5062.797488100435;5069.366329208849;5086;5166.483351664803 08:07:16 INFO - PROCESS | 26229 | |4;prototype.html;319.99520007199897;333.5946824608101;337.34723310394384;343.7816986213754;345.6612519730662;5312.840614781553;5356.491133342336;5400.783968641254;5454.618176727626;5464.508194262516;5196.818111366103;5309.230161626571;5369.8723268113645;5373.059714549958;5388.407275199735;4245.150969806035;4246.575342465744;4261.829526818923;4281.400603915455;4290.785460726966;4195.1190250047375;4222.577742225783;4269.380939763732;4270.765107919063;4278.700490965633;4212.789360531977;4222.831086756526;4223.880671622022;4229.957700423002;4240.194363071007;4220.2192594370135;4239.385289133089;4243.681723870722;4253.255680255943;4258.893527661802;3724.515812944327;3795.7153213509096;3798.6961043116485;3809.314323421783;3812.4662547243406;5215.965773348397;5248.5538729208065;5253.737313134328;5269.341332333458;5294.285271488377;4833.250846118822;4836.960053588496;4840.782164802592;4859.416869975626;4894.681845680019;5367.436419176009;5589.776408943638;5621.409751976024;5627.242651100972;5631.9718401408145;4035.313996620552;4046.7944969991427;4061.3145544598956;4063.1467391847746;4072.3891416287497;5829.271341082364;5869.295684517842;5873.588848780544;5935.49548288396;5943.821685349447;4049.311617025113;4143.917121657611;4151.709380343407;4153;4154.771487568213;4061.2080644274083;4103.322951712994;4110.7328023678365;4117.423560701444;4143.218416081114;4703.31801888731;4705.341252224691;4725.621950243973;4749.453812811502;4781.808727650855;5518.448155184449;5699.974004679198;5724;5729.854029194178;5761.596688231783;1445.9060161089496;1450.760624496946;1458.8614081662224;1463.3926920328158;1468.4933697874217;887.9600417981077;925.2690374604122;926.8795056642593;933.705882646964;934.1592566690033;4851.733154676526;4865.9756701216265;4874.46380898101;4886.828960986349;4921.532454416824;4996.6752161110135;5045.520675535819;5108.489151084862;5116.462771409023;5157.58739300855;4739.597134243628;4819.975900120477;4828.758562071883;4847.80608775645;5161.4322424533275;3069.969300307013;3118.719315261592;3124.5781819454082;3125.578046963676;3134.9216269593444;6120.540959427972;6124.203853499017;6127.172831667757;6131.570790044743;6137.84655383619;5659.518940889988;5985.922533943932;5993.190919225849;6016.157737916695;6021.976264035037;6090.878182436327;6145.754169833246;6157.568970172135;6169.285514373751;6183.690815459209;5579.358373786904;5794.913076303775;5871.7651293947765;5915.733791979457;5918.188860291327;5777.277840269966;5786.623869448473;5790.652560846363;5790.884182316246;5795.913061304168;6052.303985041776;6090.076763153623;6109.511239100772;6159.67566973085;6164.568480206342;3958.6437220650278;4141.399497072847;4163.813313205722;4165.312723400605;4182.623563879265;5800.651960882361;5808.796692115756;5819.243498345188;5819.883602328015;5844.853878652898;5394.352677678704;5566.832995010156;5647.265855438766;5691.857703557444;5698.515626171822;5643.492085712305;5682.971585142048;5683.60214784961;5701.401352858056;5718.399568045295;5652.378238393856;5696.231008813757;5697.601167918372;5717.371089180104;5727.570432217683;5649.576281778801;5651.47570743186;5719.256496655575;5750.25246717924;5769.769209231584;5633.4084921082695;5637;5649.350324712546;5663.773449061991;5665.12190610456 08:07:16 INFO - PROCESS | 26229 | |5;yui.html;792.3423558446489;793.6864938349352;810.3760104719364;823.5182418285303;825.5830805443254;15693.45072922448;16437.506874793744;16474.588135296624;16485.917570412144;16494.42269520567;14797;14941.327640256188;14949.177795221258;14954.252287385614;14992.400303987828;783.996080019602;788.8580055590006;795.2405452792598;796.7012370361115;798.1738900238255;797.0196658110527;802.7270727952495;804.5574933786423;805.1787177079376;805.8267472493412;846.3863698818369;850.9829803403959;851.2423942691009;856.1695155698962;857.4855086947844;845.3237410071918;847.3221422861748;847.9830403391928;849.7450764770545;852.8081181734091;621.7668374359615;623.6819222196713;623.7692053940026;626.7461678020409;627.5199472403615;13545.322733863268;13807.17156970575;13815.447382104703;13884.861151388457;14404.423823047171;12442.13336244236;13018.544350947672;13150.210987340695;13233.602991910258;13361.03564008317;11352;11368.261063030877;11369.886301136965;11478.885211147865;12071.275723456622;3776.773393596393;3829.5596006459054;3994.7003974702016;4042.6967977401814;4046.9595304046875;53334.999999999614;68107.65946170238;70199.64900175517;71622.28377716261;71685.64157179232;10998.615048473264;11089.445527723581;11235.719107022227;11583.536658533732;11588.76822463546;19302.13140408685;19576;19654.21383144687;19665.508362291057;19684.70472942907;8150;8286.751397458085;8507.702230421906;8549.658013679384;8572.657093716181;4690.859274221779;4713.363695901009;4739.786709598076;4742.762861856893;4835.178019736653;3433.124553238908;3499.685028347461;3512.5784905811465;3563.893083207508;3615.9276814464088;619.7397093220858;625.1747693045137;627.5105417774143;636.9076483909807;646.6992848325551;697.4629535257925;701.396798753072;734.6547122852251;738.7119023580808;743.9665215065335;8605.526696031779;9182.632694692138;9210.309226808016;9487.914463961635;9698.127168554864;652.6964961293022;662;686.807693845724;703.050881310227;704.3379223529865;4604.493505714368;4637.188492013884;4670.64970127235;4803.8318658847475;4805.183118869801;50818.237726434134;53147.73426132845;89401;90341;92308.53845730863;48514.27228591574;54896.41243050779;73962.26037739553;75548.24451755521;76443.61778191185;63883.36116638774;64307;66173.669131655;66465.6676716623;67029.66485167544;9167.816643667224;9437.528123593656;9503.192228660364;9566.952165239129;9618.903810961801;47304;47365;47536.286955696385;47842;47864;59759.70120149371;60305;64915.67542162448;65865.34134658784;66591.66704166448;11070.446477676245;11204.88795112071;11477.139214559109;11787.705307367385;12195.817062744243;12627.494900203888;12897.613071607866;12902.354882256037;12961.935190324366;13110.803337950128;10970.000549349046;11135.160534064085;11389.487473063566;11455.255408398427;12628.43172057278;11566;11962.283762714518;13284.80072798928;13339.19964802115;13350.132241404277;12958.611241662766;13303.46786128544;13679.589612311647;13782.93108534451;14166.362513687114;10466.790664186827;10901.781964360827;11151.665450036511;11558.479868405773;12039.939800301292;9649.614015439585;9926.457774214934;10447.268691191848;11581.768364632828;11931.701707457383 08:07:16 INFO - PROCESS | 26229 | __end_tp_report 08:07:16 INFO - PROCESS | 26229 | __start_cc_report 08:07:16 INFO - PROCESS | 26229 | _x_x_mozilla_cycle_collect,342 08:07:16 INFO - PROCESS | 26229 | __end_cc_report 08:07:16 INFO - PROCESS | 26229 | __startTimestamp1478099236864__endTimestamp 08:07:16 INFO - PROCESS | 26229 | 08:07:16 INFO - PROCESS | 26229 | ------- Summary: start ------- 08:07:16 INFO - PROCESS | 26229 | Number of tests: 6 08:07:16 INFO - PROCESS | 26229 | 08:07:16 INFO - PROCESS | 26229 | [#0] dojo.html Cycles:165 Average:5459.80 Median:5720.77 stddev:636.63 (11.1%) stddev-sans-first:610.87 08:07:16 INFO - PROCESS | 26229 | Values: 3091.2 3092.8 3098.5 3104.1 3115.7 5348.7 5366.4 5450.2 5459.6 5541.9 5347.9 5458.1 5459.5 5529.2 5539.4 4940.8 4976.1 5035.3 5048.3 5065.5 4992.1 5020.5 5041.8 5092.9 5095.6 4880.4 4995.1 5016.8 5079.0 5102.5 4892.1 4948.0 4954.6 4958.5 4968.2 4906.3 4909.1 4913.3 4917.0 4922.6 5360.2 5383.5 5400.6 5411.1 5427.8 5783.9 5789.4 5789.8 5801.0 5804.2 5845.9 5863.3 5872.7 5927.1 5930.8 5475.3 5519.1 5522.5 5523.3 5526.4 5901.3 5910.7 5922.9 6030.0 6034.5 5759.8 5774.5 5778.0 5778.2 5780.8 5656.5 5716.7 5785.1 5794.9 5856.3 5844.0 5845.7 5851.5 5896.7 5909.6 5819.7 5822.7 5857.2 5862.2 5863.6 4396.6 4444.6 4475.3 4477.7 4490.4 3936.2 3946.8 3951.7 3983.9 4054.2 5533.7 5577.5 5587.7 5590.4 5600.4 5871.2 5890.0 5905.5 5921.2 5947.1 5574.9 5640.3 5642.4 5687.0 5729.5 5109.1 5154.1 5174.1 5175.7 5232.6 5925.0 5989.0 6101.1 6115.0 6220.6 5912.3 5917.9 5927.1 5976.0 5981.7 6114.0 6137.3 6150.6 6158.2 6178.2 5674.4 5720.8 5747.9 5791.8 5849.2 5951.7 5952.0 5958.8 5981.2 6028.5 5750.8 5789.2 5813.2 5814.0 5819.5 5542.0 5594.6 5723.5 5729.1 5777.7 5746.7 5780.8 5816.2 5853.6 5878.2 5805.4 5846.7 5852.5 5865.6 5870.8 5501.4 5636.7 5719.2 5744.6 5745.6 08:07:16 INFO - PROCESS | 26229 | 08:07:16 INFO - PROCESS | 26229 | [#1] ext.html Cycles:180 Average:52866.37 Median:40303.60 stddev:97646.21 (242.3%) stddev-sans-first:97841.16 08:07:16 INFO - PROCESS | 26229 | Values: 559.8 571.1 573.3 580.1 592.2 40633.6 42467.2 42497.0 44666.8 44716.6 43186.4 43549.6 43636.3 43743.0 43831.8 8731.1 8885.9 8904.0 8906.4 8912.9 8740.6 8807.7 8856.9 8872.8 8881.9 8864.4 8920.6 8935.8 8969.6 8985.3 8797.8 8808.9 8851.0 8875.2 8931.0 8741.9 8796.2 8810.3 8827.0 8839.4 41215.6 41249.8 41438.2 41495.2 41540.8 3464.1 3496.7 3506.8 3574.8 3710.6 30635.7 30991.5 31090.4 31739.7 31793.8 4281.4 4285.5 4318.1 4343.2 4424.6 320408.0 320773.0 321159.0 321347.0 322547.4 52544.2 52914.7 52939.5 53030.7 53183.0 52903.7 53117.2 53281.5 53377.0 53394.7 15210.9 15394.1 15429.7 15435.5 15454.0 11353.4 11396.4 11403.3 11425.8 11430.8 15507.3 16176.7 16352.6 16383.8 16427.0 6066.5 6122.4 6227.3 6241.5 6291.2 969.5 1003.9 1033.7 1093.8 1128.2 30390.2 30455.8 30606.7 30637.0 31181.4 954.4 1073.3 1075.5 1103.7 1112.9 15737.6 16583.3 16655.7 16678.0 16970.7 438197.0 438622.0 441380.0 441477.0 442140.0 53350.5 53520.0 53570.5 53660.0 53707.2 1290.7 1318.9 1320.5 1335.5 1342.9 29601.7 31182.4 31502.2 31809.5 32188.7 46887.8 47306.8 47324.3 47570.0 47653.8 335834.0 338936.0 339624.0 340526.0 340606.0 27265.2 27327.5 27512.2 27610.4 27665.9 43771.1 44313.0 44860.0 45275.3 45710.0 38973.8 39011.4 39341.6 39632.2 40644.2 38568.6 38596.8 38717.0 39052.8 39722.6 38958.2 39390.0 39523.0 40196.4 40410.8 32786.0 34834.8 35506.1 35665.0 36129.8 26766.2 26813.3 27150.9 27198.0 27308.5 08:07:16 INFO - PROCESS | 26229 | 08:07:16 INFO - PROCESS | 26229 | [#2] jquery.html Cycles:180 Average:26671.63 Median:389.64 stddev:71262.85 (18289.6%) stddev-sans-first:71435.43 08:07:16 INFO - PROCESS | 26229 | Values: 384.7 385.2 394.1 402.1 420.2 18425.5 20129.6 20152.9 20378.8 20630.7 18070.2 18621.6 18755.0 18930.8 19740.0 5167.5 5175.8 5252.6 5290.6 5310.0 5218.3 5279.6 5289.8 5292.8 5295.5 5166.6 5185.1 5249.4 5278.4 5299.8 5165.4 5217.8 5228.7 5237.6 5290.8 4902.5 5063.5 5093.9 5096.3 5132.7 13396.8 13456.2 13486.8 16435.8 22498.3 2460.2 2460.6 2789.0 2924.0 2958.4 9695.6 9905.3 9931.9 10373.7 10411.7 1843.8 1885.4 1923.5 1988.6 1993.8 71876.3 75559.6 75713.0 78131.2 80290.2 10833.1 10891.7 11083.1 11098.0 11350.8 15387.1 15407.5 15456.5 15458.8 15459.6 7366.6 7538.0 7562.5 7749.0 7939.6 6966.8 7067.6 7112.5 7352.5 7368.6 4683.0 4705.7 4741.7 4762.8 4779.2 1895.5 1942.2 1956.7 1966.2 1994.0 924.1 955.4 989.4 1005.9 1012.9 18712.3 19526.2 19800.4 19837.0 20001.4 967.5 1000.0 1012.4 1020.4 1028.9 9947.2 10950.9 11013.3 11017.7 11032.7 403852.0 422458.0 441372.0 442814.0 442965.6 86307.6 88396.6 89024.6 89871.6 90165.1 980.9 999.5 1037.2 1037.4 1039.3 16464.6 16720.8 16797.8 16972.7 17781.5 29960.0 40676.6 41379.6 41432.6 42818.9 51358.5 53146.7 55624.0 55910.0 57616.4 8042.2 8114.4 8224.6 8431.0 8543.0 9118.1 12613.0 13185.6 13266.9 13677.0 11536.8 11597.7 11942.1 11963.9 12057.8 11317.1 11459.1 11540.1 11555.5 11866.3 11779.9 11847.2 12168.8 12229.6 12244.3 8269.0 8515.6 8561.4 8750.9 8877.2 10623.7 11867.3 11900.2 11900.4 12298.5 08:07:16 INFO - PROCESS | 26229 | 08:07:16 INFO - PROCESS | 26229 | [#3] mootools.html Cycles:180 Average:5508.39 Median:4977.94 stddev:3119.36 (62.7%) stddev-sans-first:3113.23 08:07:16 INFO - PROCESS | 26229 | Values: 1454.0 1468.9 1602.8 1685.0 1734.1 7510.8 7737.9 8153.3 8750.2 8784.6 8256.9 8474.7 8495.8 8759.2 8769.0 2171.2 2205.1 2207.2 2208.5 2209.0 2095.3 2140.3 2157.2 2192.2 2196.1 2100.8 2133.4 2142.5 2149.2 2152.2 2088.6 2119.1 2120.4 2121.4 2122.7 2100.7 2131.8 2133.2 2141.4 2146.0 8363.6 8452.1 8457.5 8476.2 8482.9 5029.3 5091.3 5151.7 5161.1 5177.4 3293.4 3417.3 3531.3 3536.3 3547.3 1030.5 1079.1 1116.5 1133.4 1135.2 10957.5 11174.0 11233.7 11513.1 11766.4 4098.5 4189.7 4289.2 4313.4 4320.9 9332.1 9336.3 9354.4 9367.0 9374.8 4938.4 4942.8 4951.1 4956.6 4962.4 4562.8 4644.7 4652.4 4655.7 4690.7 3440.7 3502.6 3523.1 3552.3 3601.6 1100.8 1105.9 1110.8 1113.2 1114.8 842.0 911.4 943.8 950.6 959.0 5754.2 5788.6 5827.2 5841.6 5897.9 394.6 398.8 400.3 412.2 421.3 3942.8 4001.5 4015.3 4041.0 4098.1 9706.0 10171.2 10206.9 10218.3 10261.2 10079.7 10092.7 10133.3 10136.9 10155.0 7627.4 7760.7 7895.3 7917.4 7919.9 5681.4 5706.4 5938.6 5958.1 5961.3 9402.7 9496.5 9601.1 9612.4 9718.3 9352.8 9419.3 9530.2 9766.4 9783.3 7357.8 7530.8 7603.2 7605.2 7791.5 8371.7 8418.5 8443.1 8456.5 8461.5 7303.7 7307.5 7389.4 7427.7 7521.6 7338.2 7341.7 7399.5 7451.7 7463.2 6726.3 6868.5 6871.2 6886.2 6894.9 4934.3 4940.3 4997.0 5087.4 5158.2 4993.5 5062.8 5069.4 5086.0 5166.5 08:07:16 INFO - PROCESS | 26229 | 08:07:16 INFO - PROCESS | 26229 | [#4] prototype.html Cycles:180 Average:4740.71 Median:5301.76 stddev:1399.44 (26.4%) stddev-sans-first:1363.47 08:07:16 INFO - PROCESS | 26229 | Values: 320.0 333.6 337.3 343.8 345.7 5312.8 5356.5 5400.8 5454.6 5464.5 5196.8 5309.2 5369.9 5373.1 5388.4 4245.2 4246.6 4261.8 4281.4 4290.8 4195.1 4222.6 4269.4 4270.8 4278.7 4212.8 4222.8 4223.9 4230.0 4240.2 4220.2 4239.4 4243.7 4253.3 4258.9 3724.5 3795.7 3798.7 3809.3 3812.5 5216.0 5248.6 5253.7 5269.3 5294.3 4833.3 4837.0 4840.8 4859.4 4894.7 5367.4 5589.8 5621.4 5627.2 5632.0 4035.3 4046.8 4061.3 4063.1 4072.4 5829.3 5869.3 5873.6 5935.5 5943.8 4049.3 4143.9 4151.7 4153.0 4154.8 4061.2 4103.3 4110.7 4117.4 4143.2 4703.3 4705.3 4725.6 4749.5 4781.8 5518.4 5700.0 5724.0 5729.9 5761.6 1445.9 1450.8 1458.9 1463.4 1468.5 888.0 925.3 926.9 933.7 934.2 4851.7 4866.0 4874.5 4886.8 4921.5 4996.7 5045.5 5108.5 5116.5 5157.6 4739.6 4820.0 4828.8 4847.8 5161.4 3070.0 3118.7 3124.6 3125.6 3134.9 6120.5 6124.2 6127.2 6131.6 6137.8 5659.5 5985.9 5993.2 6016.2 6022.0 6090.9 6145.8 6157.6 6169.3 6183.7 5579.4 5794.9 5871.8 5915.7 5918.2 5777.3 5786.6 5790.7 5790.9 5795.9 6052.3 6090.1 6109.5 6159.7 6164.6 3958.6 4141.4 4163.8 4165.3 4182.6 5800.7 5808.8 5819.2 5819.9 5844.9 5394.4 5566.8 5647.3 5691.9 5698.5 5643.5 5683.0 5683.6 5701.4 5718.4 5652.4 5696.2 5697.6 5717.4 5727.6 5649.6 5651.5 5719.3 5750.3 5769.8 5633.4 5637.0 5649.4 5663.8 5665.1 08:07:16 INFO - PROCESS | 26229 | 08:07:16 INFO - PROCESS | 26229 | [#5] yui.html Cycles:180 Average:17229.13 Median:4804.51 stddev:22291.24 (464.0%) stddev-sans-first:22319.61 08:07:16 INFO - PROCESS | 26229 | Values: 792.3 793.7 810.4 823.5 825.6 15693.5 16437.5 16474.6 16485.9 16494.4 14797.0 14941.3 14949.2 14954.3 14992.4 784.0 788.9 795.2 796.7 798.2 797.0 802.7 804.6 805.2 805.8 846.4 851.0 851.2 856.2 857.5 845.3 847.3 848.0 849.7 852.8 621.8 623.7 623.8 626.7 627.5 13545.3 13807.2 13815.4 13884.9 14404.4 12442.1 13018.5 13150.2 13233.6 13361.0 11352.0 11368.3 11369.9 11478.9 12071.3 3776.8 3829.6 3994.7 4042.7 4047.0 53335.0 68107.7 70199.6 71622.3 71685.6 10998.6 11089.4 11235.7 11583.5 11588.8 19302.1 19576.0 19654.2 19665.5 19684.7 8150.0 8286.8 8507.7 8549.7 8572.7 4690.9 4713.4 4739.8 4742.8 4835.2 3433.1 3499.7 3512.6 3563.9 3615.9 619.7 625.2 627.5 636.9 646.7 697.5 701.4 734.7 738.7 744.0 8605.5 9182.6 9210.3 9487.9 9698.1 652.7 662.0 686.8 703.1 704.3 4604.5 4637.2 4670.6 4803.8 4805.2 50818.2 53147.7 89401.0 90341.0 92308.5 48514.3 54896.4 73962.3 75548.2 76443.6 63883.4 64307.0 66173.7 66465.7 67029.7 9167.8 9437.5 9503.2 9567.0 9618.9 47304.0 47365.0 47536.3 47842.0 47864.0 59759.7 60305.0 64915.7 65865.3 66591.7 11070.4 11204.9 11477.1 11787.7 12195.8 12627.5 12897.6 12902.4 12961.9 13110.8 10970.0 11135.2 11389.5 11455.3 12628.4 11566.0 11962.3 13284.8 13339.2 13350.1 12958.6 13303.5 13679.6 13782.9 14166.4 10466.8 10901.8 11151.7 11558.5 12039.9 9649.6 9926.5 10447.3 11581.8 11931.7 08:07:16 INFO - PROCESS | 26229 | -------- Summary: end -------- 08:07:16 INFO - PROCESS | 26229 | 08:07:17 INFO - TEST-INFO | 26229: exit 0 08:07:17 INFO - TEST-OK | dromaeo_css | took 1117234ms 08:07:17 INFO - TEST-START | kraken 08:07:17 INFO - operating with platform_type : linux_ 08:07:17 INFO - Initialising browser for kraken test... 08:07:17 INFO - TEST-INFO | started process 26586 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuaWu_a/profile http://localhost:57959/getInfo.html) 08:07:22 INFO - PROCESS | 26586 | __metrics Screen width/height:1600/1200 08:07:22 INFO - PROCESS | 26586 | colorDepth:24 08:07:22 INFO - PROCESS | 26586 | Browser inner width/height: 1024/697 08:07:22 INFO - PROCESS | 26586 | __metrics 08:07:23 ERROR - PROCESS | 26586 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3158: TypeError: this.tabs is undefined 08:07:24 INFO - TEST-INFO | 26586: exit 0 08:07:24 INFO - Browser initialized. 08:07:24 INFO - Running cycle 1/1 for kraken test... 08:07:24 INFO - TEST-INFO | started process 26710 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuaWu_a/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:07:36 INFO - PROCESS | 26710 | RSS: Main: 184881152 08:07:36 INFO - PROCESS | 26710 | 08:07:39 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57959/tests/kraken/driver.html?testName=audio-beat-detection) 08:07:40 INFO - PROCESS | 26710 | RSS: Main: 198303744 08:07:40 INFO - PROCESS | 26710 | 08:07:42 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57959/tests/kraken/driver.html?testName=audio-dft) 08:07:43 INFO - PROCESS | 26710 | RSS: Main: 196476928 08:07:43 INFO - PROCESS | 26710 | 08:07:46 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57959/tests/kraken/driver.html?testName=audio-fft) 08:07:46 INFO - PROCESS | 26710 | RSS: Main: 192786432 08:07:46 INFO - PROCESS | 26710 | 08:07:49 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57959/tests/kraken/driver.html?testName=audio-oscillator) 08:07:49 INFO - PROCESS | 26710 | RSS: Main: 193712128 08:07:49 INFO - PROCESS | 26710 | 08:07:51 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57959/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:07:52 INFO - PROCESS | 26710 | RSS: Main: 193568768 08:07:52 INFO - PROCESS | 26710 | 08:07:55 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57959/tests/kraken/driver.html?testName=imaging-darkroom) 08:07:56 INFO - PROCESS | 26710 | RSS: Main: 193900544 08:07:56 INFO - PROCESS | 26710 | 08:07:59 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57959/tests/kraken/driver.html?testName=imaging-desaturate) 08:08:00 INFO - PROCESS | 26710 | RSS: Main: 193978368 08:08:00 INFO - PROCESS | 26710 | 08:08:02 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57959/tests/kraken/driver.html?testName=json-parse-financial) 08:08:03 INFO - PROCESS | 26710 | RSS: Main: 193986560 08:08:03 INFO - PROCESS | 26710 | 08:08:05 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57959/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:08:05 INFO - PROCESS | 26710 | RSS: Main: 194371584 08:08:05 INFO - PROCESS | 26710 | 08:08:07 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57959/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:08:08 INFO - PROCESS | 26710 | RSS: Main: 194289664 08:08:08 INFO - PROCESS | 26710 | 08:08:10 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57959/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:08:10 INFO - PROCESS | 26710 | RSS: Main: 194625536 08:08:10 INFO - PROCESS | 26710 | 08:08:13 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:08:14 INFO - PROCESS | 26710 | RSS: Main: 194392064 08:08:14 INFO - PROCESS | 26710 | 08:08:17 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:08:17 INFO - PROCESS | 26710 | RSS: Main: 194871296 08:08:17 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | Cycle 1(1): loaded http://localhost:57959/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57959/tests/kraken/driver.html?testName=ai-astar) 08:08:19 INFO - PROCESS | 26710 | RSS: Main: 196116480 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | __start_tp_report 08:08:19 INFO - PROCESS | 26710 | _x_x_mozilla_page_load 08:08:19 INFO - PROCESS | 26710 | _x_x_mozilla_page_load_details 08:08:19 INFO - PROCESS | 26710 | |i|pagename|runs| 08:08:19 INFO - PROCESS | 26710 | |0;ai-astar;106;112;112;112;111;112;112;113;112;111 08:08:19 INFO - PROCESS | 26710 | |1;audio-beat-detection;150;125;127;170;125;125;125;124;153;126 08:08:19 INFO - PROCESS | 26710 | |2;audio-dft;163;164;164;176;164;162;163;163;166;163 08:08:19 INFO - PROCESS | 26710 | |3;audio-fft;75;76;76;114;78;78;76;76;105;77 08:08:19 INFO - PROCESS | 26710 | |4;audio-oscillator;83;82;111;84;82;84;98;82;81;123 08:08:19 INFO - PROCESS | 26710 | |5;imaging-gaussian-blur;120;118;119;117;119;117;117;120;117;118 08:08:19 INFO - PROCESS | 26710 | |6;imaging-darkroom;148;146;149;149;149;147;148;148;150;147 08:08:19 INFO - PROCESS | 26710 | |7;imaging-desaturate;88;86;85;85;86;85;86;85;87;86 08:08:19 INFO - PROCESS | 26710 | |8;json-parse-financial;57;55;57;56;56;57;57;57;55;60 08:08:19 INFO - PROCESS | 26710 | |9;json-stringify-tinderbox;60;62;61;61;62;61;61;61;61;61 08:08:19 INFO - PROCESS | 26710 | |10;stanford-crypto-aes;81;82;82;90;81;79;87;81;81;82 08:08:19 INFO - PROCESS | 26710 | |11;stanford-crypto-ccm;146;150;145;137;142;136;138;138;176;131 08:08:19 INFO - PROCESS | 26710 | |12;stanford-crypto-pbkdf2;177;166;168;172;170;167;169;176;165;172 08:08:19 INFO - PROCESS | 26710 | |13;stanford-crypto-sha256-iterative;65;66;75;63;65;63;71;64;70;63 08:08:19 INFO - PROCESS | 26710 | __end_tp_report 08:08:19 INFO - PROCESS | 26710 | __start_cc_report 08:08:19 INFO - PROCESS | 26710 | _x_x_mozilla_cycle_collect,794 08:08:19 INFO - PROCESS | 26710 | __end_cc_report 08:08:19 INFO - PROCESS | 26710 | __startTimestamp1478099299759__endTimestamp 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | ------- Summary: start ------- 08:08:19 INFO - PROCESS | 26710 | Number of tests: 14 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#0] ai-astar Cycles:10 Average:111.30 Median:112.00 stddev:1.95 (1.7%) stddev-sans-first:0.60 08:08:19 INFO - PROCESS | 26710 | Values: 106.0 112.0 112.0 112.0 111.0 112.0 112.0 113.0 112.0 111.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#1] audio-beat-detection Cycles:10 Average:135.00 Median:126.50 stddev:16.47 (13.0%) stddev-sans-first:16.55 08:08:19 INFO - PROCESS | 26710 | Values: 150.0 125.0 127.0 170.0 125.0 125.0 125.0 124.0 153.0 126.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:4.08 (2.5%) stddev-sans-first:4.27 08:08:19 INFO - PROCESS | 26710 | Values: 163.0 164.0 164.0 176.0 164.0 162.0 163.0 163.0 166.0 163.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.00 stddev:14.11 (18.6%) stddev-sans-first:14.65 08:08:19 INFO - PROCESS | 26710 | Values: 75.0 76.0 76.0 114.0 78.0 78.0 76.0 76.0 105.0 77.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#4] audio-oscillator Cycles:10 Average:91.00 Median:82.50 stddev:14.82 (18.0%) stddev-sans-first:15.44 08:08:19 INFO - PROCESS | 26710 | Values: 83.0 82.0 111.0 84.0 82.0 84.0 98.0 82.0 81.0 123.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.50 stddev:1.23 (1.0%) stddev-sans-first:1.12 08:08:19 INFO - PROCESS | 26710 | Values: 120.0 118.0 119.0 117.0 119.0 117.0 117.0 120.0 117.0 118.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.50 stddev:1.20 (0.8%) stddev-sans-first:1.27 08:08:19 INFO - PROCESS | 26710 | Values: 148.0 146.0 149.0 149.0 149.0 147.0 148.0 148.0 150.0 147.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:0.99 (1.2%) stddev-sans-first:0.71 08:08:19 INFO - PROCESS | 26710 | Values: 88.0 86.0 85.0 85.0 86.0 85.0 86.0 85.0 87.0 86.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:57.00 stddev:1.42 (2.5%) stddev-sans-first:1.50 08:08:19 INFO - PROCESS | 26710 | Values: 57.0 55.0 57.0 56.0 56.0 57.0 57.0 57.0 55.0 60.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#9] json-stringify-tinderbox Cycles:10 Average:61.10 Median:61.00 stddev:0.57 (0.9%) stddev-sans-first:0.44 08:08:19 INFO - PROCESS | 26710 | Values: 60.0 62.0 61.0 61.0 62.0 61.0 61.0 61.0 61.0 61.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.00 stddev:3.31 (4.0%) stddev-sans-first:3.46 08:08:19 INFO - PROCESS | 26710 | Values: 81.0 82.0 82.0 90.0 81.0 79.0 87.0 81.0 81.0 82.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:143.50 stddev:12.57 (8.8%) stddev-sans-first:13.31 08:08:19 INFO - PROCESS | 26710 | Values: 146.0 150.0 145.0 137.0 142.0 136.0 138.0 138.0 176.0 131.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.20 Median:171.00 stddev:4.05 (2.4%) stddev-sans-first:3.47 08:08:19 INFO - PROCESS | 26710 | Values: 177.0 166.0 168.0 172.0 170.0 167.0 169.0 176.0 165.0 172.0 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:65.50 stddev:4.12 (6.3%) stddev-sans-first:4.33 08:08:19 INFO - PROCESS | 26710 | Values: 65.0 66.0 75.0 63.0 65.0 63.0 71.0 64.0 70.0 63.0 08:08:19 INFO - PROCESS | 26710 | -------- Summary: end -------- 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | ###!!! [Parent][RunMessage] Error: Channel error: cannot send/recv 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | 08:08:19 INFO - PROCESS | 26710 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 08:08:19 INFO - PROCESS | 26710 | 08:08:20 INFO - TEST-INFO | 26710: exit 0 08:08:21 INFO - TEST-OK | kraken | took 63118ms 08:08:21 INFO - SUITE-END | took 1180s 08:08:21 INFO - Completed test suite (00:19:40) 08:08:21 INFO - javascript benchmark 08:08:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7033.584539287006, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3091.19628896487, 3092.8453577321156, 3098.4732595458768, 3104.1308433638574, 3115.704008119228, 5348.652337598053, 5366.409694933559, 5450.1552259399805, 5459.563234941205, 5541.861453463665, 5347.946520534793, 5458.099413596752, 5459.535939445142, 5529.198266251391, 5539.41836107209, 4940.802367905279, 4976.129177393951, 5035.295058691786, 5048.318477005612, 5065.518775716319, 4992.101421744084, 5020.523050310233, 5041.848744537651, 5092.923606145892, 5095.592352611782, 4880.365552478155, 4995.075910956485, 5016.799328026875, 5078.974605126969, 5102.540771330598, 4892.0705066037335, 4947.9505204947845, 4954.603631709455, 4958.528939750754, 4968.1554135797005, 4906.337644418029, 4909.140900342426, 4913.336699545552, 4916.975415122937, 4922.581580565657, 5360.16917377807, 5383.488568585978, 5400.594955378362, 5411.080116380185, 5427.810026649087, 5783.942160578425, 5789.392113828029, 5789.8263052108505, 5801.0428279333855, 5804.187413762077, 5845.941540584582, 5863.325717542494, 5872.677002764846, 5927.1405646181065, 5930.822075337746, 5475.315585551806, 5519.116941289374, 5522.502974732293, 5523.2543606613, 5526.392096869301, 5901.3213480450295, 5910.674912879746, 5922.911156332572, 6030.0, 6034.5172386209, 5759.827205183851, 5774.480296773227, 5778.0, 5778.16216648592, 5780.797672081457, 5656.547476201894, 5716.685582293014, 5785.1322301654245, 5794.942050579524, 5856.326522449887, 5844.0, 5845.736941837543, 5851.531877449794, 5896.705164741831, 5909.6158749681135, 5819.709014549256, 5822.679752613562, 5857.150713146655, 5862.208601838783, 5863.560232982543, 4396.648268138541, 4444.599986001275, 4475.26158183896, 4477.731336119843, 4490.393796837385, 3936.193080418507, 3946.7631942083567, 3951.7431366961055, 3983.92032159361, 4054.2094291612852, 5533.695646739468, 5577.498025177672, 5587.664740115606, 5590.440955904458, 5600.4399560044485, 5871.207387002785, 5890.0, 5905.4685078343155, 5921.200637913913, 5947.1079338099635, 5574.9442505574425, 5640.294963129609, 5642.379338272869, 5687.0, 5729.4843464088435, 5109.080365534165, 5154.098032844237, 5174.120399532013, 5175.689458632494, 5232.607554433356, 5924.9703751480965, 5989.041753319448, 6101.095933926387, 6115.0, 6220.595661282002, 5912.260967379078, 5917.911231331447, 5927.110933360031, 5976.0, 5981.730822112929, 6113.969430152821, 6137.263528376623, 6150.600210986271, 6158.199434073721, 6178.196834411498, 5674.375818660027, 5720.771169153188, 5747.9137812932, 5791.797287094932, 5849.181114644039, 5951.732172052181, 5952.0476723724, 5958.76164953397, 5981.162637230878, 6028.517718582415, 5750.827475175752, 5789.160571716993, 5813.15709222152, 5813.9534883721335, 5819.534437244925, 5542.0, 5594.580406469449, 5723.513501352431, 5729.054705973468, 5777.74000169985, 5746.741396637245, 5780.768769249351, 5816.214811000461, 5853.560982926383, 5878.2064421302575, 5805.419458054161, 5846.736896839738, 5852.50761055928, 5865.5600829937075, 5870.823875283749, 5501.394846566955, 5636.718164091861, 5719.199312096393, 5744.569157313302, 5745.569082318759], "value": 5415.109330462891, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.7788873395009, 571.1204744693173, 573.2891214893531, 580.1066357808975, 592.2478452365496, 40633.59366406335, 42467.15065698688, 42497.0, 44666.776666116704, 44716.552834471644, 43186.35220471695, 43549.564504354945, 43636.345454818125, 43743.0, 43831.78084109583, 8731.126887311282, 8885.866711999326, 8903.95548022259, 8906.376553641248, 8912.8663070054, 8740.606672699712, 8807.691730789424, 8856.867146992769, 8872.778180545474, 8881.866771998426, 8864.423812452202, 8920.643174273022, 8935.821283574325, 8969.596368163415, 8985.281177505783, 8797.7800554986, 8808.911910880937, 8851.0, 8875.245604123626, 8930.955345223298, 8741.912580874237, 8796.164364385373, 8810.339224558184, 8826.955865220632, 8839.425437346616, 41215.58784412177, 41249.79375103135, 41438.1712365754, 41495.1700965982, 41540.79229603833, 3464.133966508373, 3496.6852983231634, 3506.754527183098, 3574.8391322390553, 3710.591834898159, 30635.693643063507, 30991.535126973115, 31090.378192436252, 31739.682603174133, 31793.84103079493, 4281.357796330544, 4285.528591854893, 4318.114786468798, 4343.2399330117105, 4424.60178583929, 320408.0, 320773.0, 321159.0, 321347.0, 322547.3872630645, 52544.21183682171, 52914.73542632262, 52939.47060529423, 53030.73484632552, 53183.0, 52903.73548132235, 53117.2032419514, 53281.46718532765, 53377.0, 53394.73302633462, 15210.923945380202, 15394.07635541871, 15429.691406171814, 15435.536933892, 15454.0, 11353.432328383547, 11396.373199474108, 11403.315801051964, 11425.771484570429, 11430.828537571942, 15507.302171402314, 16176.67646647084, 16352.591185220464, 16383.83616163847, 16427.0, 6066.4540191382985, 6122.357152498924, 6227.314995350508, 6241.500679945593, 6291.182146321041, 969.5443141723379, 1003.9196864250988, 1033.7415646088477, 1093.830456279278, 1128.1707944660668, 30390.240243994078, 30455.847720761256, 30606.69393306083, 30637.0, 31181.376372472423, 954.4130359828655, 1073.313079629038, 1075.451519724946, 1103.7240689827543, 1112.9109671226445, 15737.606559835867, 16583.253753580877, 16655.6668866622, 16678.0, 16970.660586788195, 438197.0, 438622.0, 441380.0, 441477.0, 442140.0, 53350.46649533455, 53520.0, 53570.46429535733, 53660.0, 53707.19439208415, 1290.7483040806953, 1318.9142705724098, 1320.4586119691073, 1335.5325636027508, 1342.9059965802496, 29601.703982959894, 31182.37635247328, 31502.212444689067, 31809.52476168145, 32188.678113219506, 46887.765561171975, 47306.76346618245, 47324.290135648684, 47570.0, 47653.76173119112, 335834.0, 338936.0, 339624.0, 340526.0, 340606.0, 27265.182044538695, 27327.45345093127, 27512.174634760988, 27610.447791043665, 27665.861670691516, 43771.12457750891, 44313.0, 44860.0, 45275.32087018631, 45710.0, 38973.81218112173, 39011.41482877816, 39341.6065839338, 39632.2073558533, 40644.1871162581, 38568.6143138565, 38596.80701596474, 38717.03207419837, 39052.80473597614, 39722.60277397189, 38958.2208355837, 39390.0, 39523.0, 40196.3970540448, 40410.79794601008, 32786.0, 34834.82582587071, 35506.112347190494, 35665.0, 36129.819350903075, 26766.19701408961, 26813.329666757705, 27150.864245678644, 27198.0, 27308.453830923667], "value": 19040.295243994162, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.70185606155246, 385.1565072491242, 394.11717752234995, 402.12136481787286, 420.16597054846125, 18425.539361515952, 20129.59740805185, 20152.89923550382, 20378.796212037912, 20630.690539641917, 18070.186841592127, 18621.627567448642, 18755.0, 18930.81069189311, 19740.0, 5167.509086636773, 5175.8188463403785, 5252.6323157379, 5290.576753859682, 5310.0, 5218.269442278065, 5279.5512381447625, 5289.788408463657, 5292.761825717833, 5295.4969277918535, 5166.586673066165, 5185.144451165553, 5249.396319423277, 5278.392984806758, 5299.761510732026, 5165.431802501703, 5217.791288348461, 5228.712420816853, 5237.554807841338, 5290.841274761744, 4902.534259245366, 5063.493650634944, 5093.923591146136, 5096.286519887219, 5132.692038477703, 13396.799048014287, 13456.192628442226, 13486.797698034537, 16435.83564164355, 22498.325050248517, 2460.2127319257843, 2460.561859798717, 2788.958165627497, 2924.0204531481977, 2958.4378967996013, 9695.563699633534, 9905.306628535933, 9931.851022234672, 10373.688789336333, 10411.739706507398, 1843.8064003279596, 1885.4060970794155, 1923.4614307993645, 1988.6321030609383, 1993.8105879941381, 71876.28123718748, 75559.62220188919, 75713.0, 78131.21868781353, 80290.16082828802, 10833.133349332034, 10891.67324980252, 11083.057940075023, 11098.0, 11350.772984540263, 15387.076775393289, 15407.460738874086, 15456.459023934332, 15458.845411545966, 15459.61350966235, 7366.594837283894, 7537.9623101884135, 7562.546247225184, 7749.0, 7939.64271607779, 6966.825829354205, 7067.6112813795735, 7112.50212485121, 7352.522086064496, 7368.59472729005, 4683.0, 4705.670603057822, 4741.739204343794, 4762.809487620526, 4779.235322348477, 1895.5120230618897, 1942.2036964844347, 1956.735840661521, 1966.154553541962, 1993.9900300498696, 924.0528458330265, 955.4171955107379, 989.4014121456415, 1005.9144972677258, 1012.9493525323704, 18712.25150993945, 19526.21895124179, 19800.405987820388, 19837.0, 20001.399958001282, 967.5452537307455, 999.980000399988, 1012.417859730643, 1020.4030642074321, 1028.9022542858415, 9947.154491868272, 10950.945245273722, 11013.339199648046, 11017.724556886142, 11032.669019929415, 403852.0, 422458.0, 441372.0, 442814.0, 442965.5627549853, 86307.56846215729, 88396.5580172095, 89024.55487722649, 89871.55064224637, 90165.09834901567, 980.9460479673686, 999.5202302894651, 1037.1547189040907, 1037.3620223562455, 1039.3400190878695, 16464.588385290463, 16720.832791671928, 16797.832021679627, 16972.66054678924, 17781.46655600334, 29960.0, 40676.59323406847, 41379.58620413757, 41432.58567414287, 42818.93220144081, 51358.48641513537, 53146.67133321543, 55624.0, 55910.0, 57616.423835762784, 8042.195780422145, 8114.43198976066, 8224.62989165477, 8430.957845210734, 8542.957285213783, 9118.088191180828, 12613.0, 13185.60443186706, 13266.872315853261, 13677.0, 11536.769264614493, 11597.710057248636, 11942.104342174545, 11963.940180299043, 12057.81913271284, 11317.094632429222, 11459.140564457532, 11540.134489913122, 11555.537778488766, 11866.347350895783, 11779.88220117788, 11847.170698051053, 12168.75662486763, 12229.571964981538, 12244.265344079027, 8269.0, 8515.574221288787, 8561.35789815754, 8750.868736969078, 8877.20105190536, 10623.734406639896, 11867.287962722265, 11900.226485278428, 11900.40497975115, 12298.508059677513], "value": 8911.250594501114, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.9781903271453, 1468.8678018978292, 1602.7836242107312, 1684.9663006739859, 1734.0722713348362, 7510.81222969426, 7737.92262077379, 8153.347732181426, 8750.168733970278, 8784.604692788831, 8256.91743082569, 8474.661013559451, 8495.78760530987, 8759.21167094963, 8769.035406105339, 2171.174953517665, 2205.106931692667, 2207.23850271656, 2208.5141268920893, 2208.9558208835815, 2095.298075144821, 2140.283005193254, 2157.1694897464513, 2192.177933275022, 2196.0556960506974, 2100.8109270165683, 2133.4133113393864, 2142.528643698384, 2149.1940522304135, 2152.2251989283845, 2088.634488964433, 2119.1205649655376, 2120.416885356524, 2121.427214652043, 2122.6603743400983, 2100.7479102507646, 2131.7868213178713, 2133.232036466871, 2141.4432247615578, 2146.0450099705636, 8363.623636936352, 8452.112528184574, 8457.53483558404, 8476.23713865755, 8482.872756908651, 5029.2958985742025, 5091.338126043591, 5151.742412879378, 5161.071007218699, 5177.404598471148, 3293.4236508610898, 3417.333619944112, 3531.2760884018717, 3536.3104194682046, 3547.255076433952, 1030.5002073994183, 1079.098952374768, 1116.4919961417536, 1133.3596517967321, 1135.1656532448644, 10957.452127393679, 11174.0, 11233.719157021058, 11513.078953683686, 11766.352850593128, 4098.508179018537, 4189.706720529533, 4289.185054839633, 4313.417688611998, 4320.935185972213, 9332.113449222314, 9336.346455748033, 9354.438733675865, 9366.953165234267, 9374.765630859147, 4938.38270216223, 4942.802287908516, 4951.108800415887, 4956.553910148032, 4962.404511458648, 4562.771861406983, 4644.744539050384, 4652.371929789435, 4655.674102812771, 4690.695104818176, 3440.673136052071, 3502.6322236165347, 3523.136831476305, 3552.342816578941, 3601.567811862541, 1100.8403781451805, 1105.9170562207867, 1110.816715241976, 1113.1929351220463, 1114.8327750837439, 842.0400743152811, 911.3666002128457, 943.7546237978038, 950.619752099152, 958.9808203836023, 5754.223179870748, 5788.594798364158, 5827.17325923021, 5841.620294680833, 5897.941020589825, 394.57386023095563, 398.79462077030354, 400.3314464843718, 412.2044454203356, 421.3006409360508, 3942.7634341939574, 4001.5398229203433, 4015.3374693175297, 4040.9797951010055, 4098.098418347959, 9706.0, 10171.237157213238, 10206.897931020743, 10218.335808172445, 10261.230407719451, 10079.69760907174, 10092.697219083439, 10133.341332813343, 10136.898631013595, 10155.035271649182, 7627.351675107567, 7760.689572417153, 7895.328897043815, 7917.406194535318, 7919.920800791919, 5681.375048744552, 5706.400827913176, 5938.584299099021, 5958.076498142795, 5961.254843144607, 9402.717918462457, 9496.525173741424, 9601.087896649808, 9612.423254604746, 9718.271129665161, 9352.766180845261, 9419.293552983416, 9530.237580993642, 9766.365186263154, 9783.26625503076, 7357.77926662201, 7530.774076777706, 7603.20166382544, 7605.201453847267, 7791.454598178073, 8371.748847534584, 8418.494890306602, 8443.07126216128, 8456.492610443393, 8461.450005749606, 7303.671334790053, 7307.451941104332, 7389.371903388057, 7427.740029098955, 7521.586312752851, 7338.229485903903, 7341.70633174667, 7399.48203625741, 7451.739189128354, 7463.216362282099, 6726.3273672634305, 6868.484863635347, 6871.175458944958, 6886.173659160932, 6894.896576551256, 4934.309196712535, 4940.333055037524, 4997.0, 5087.4149472811105, 5158.174692049254, 4993.475685053162, 5062.797488100435, 5069.366329208849, 5086.0, 5166.483351664803], "value": 4323.335255091087, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.99520007199897, 333.5946824608101, 337.34723310394384, 343.7816986213754, 345.6612519730662, 5312.840614781553, 5356.491133342336, 5400.783968641254, 5454.618176727626, 5464.508194262516, 5196.818111366103, 5309.230161626571, 5369.8723268113645, 5373.059714549958, 5388.407275199735, 4245.150969806035, 4246.575342465744, 4261.829526818923, 4281.400603915455, 4290.785460726966, 4195.1190250047375, 4222.577742225783, 4269.380939763732, 4270.765107919063, 4278.700490965633, 4212.789360531977, 4222.831086756526, 4223.880671622022, 4229.957700423002, 4240.194363071007, 4220.2192594370135, 4239.385289133089, 4243.681723870722, 4253.255680255943, 4258.893527661802, 3724.515812944327, 3795.7153213509096, 3798.6961043116485, 3809.314323421783, 3812.4662547243406, 5215.965773348397, 5248.5538729208065, 5253.737313134328, 5269.341332333458, 5294.285271488377, 4833.250846118822, 4836.960053588496, 4840.782164802592, 4859.416869975626, 4894.681845680019, 5367.436419176009, 5589.776408943638, 5621.409751976024, 5627.242651100972, 5631.9718401408145, 4035.313996620552, 4046.7944969991427, 4061.3145544598956, 4063.1467391847746, 4072.3891416287497, 5829.271341082364, 5869.295684517842, 5873.588848780544, 5935.49548288396, 5943.821685349447, 4049.311617025113, 4143.917121657611, 4151.709380343407, 4153.0, 4154.771487568213, 4061.2080644274083, 4103.322951712994, 4110.7328023678365, 4117.423560701444, 4143.218416081114, 4703.31801888731, 4705.341252224691, 4725.621950243973, 4749.453812811502, 4781.808727650855, 5518.448155184449, 5699.974004679198, 5724.0, 5729.854029194178, 5761.596688231783, 1445.9060161089496, 1450.760624496946, 1458.8614081662224, 1463.3926920328158, 1468.4933697874217, 887.9600417981077, 925.2690374604122, 926.8795056642593, 933.705882646964, 934.1592566690033, 4851.733154676526, 4865.9756701216265, 4874.46380898101, 4886.828960986349, 4921.532454416824, 4996.6752161110135, 5045.520675535819, 5108.489151084862, 5116.462771409023, 5157.58739300855, 4739.597134243628, 4819.975900120477, 4828.758562071883, 4847.80608775645, 5161.4322424533275, 3069.969300307013, 3118.719315261592, 3124.5781819454082, 3125.578046963676, 3134.9216269593444, 6120.540959427972, 6124.203853499017, 6127.172831667757, 6131.570790044743, 6137.84655383619, 5659.518940889988, 5985.922533943932, 5993.190919225849, 6016.157737916695, 6021.976264035037, 6090.878182436327, 6145.754169833246, 6157.568970172135, 6169.285514373751, 6183.690815459209, 5579.358373786904, 5794.913076303775, 5871.7651293947765, 5915.733791979457, 5918.188860291327, 5777.277840269966, 5786.623869448473, 5790.652560846363, 5790.884182316246, 5795.913061304168, 6052.303985041776, 6090.076763153623, 6109.511239100772, 6159.67566973085, 6164.568480206342, 3958.6437220650278, 4141.399497072847, 4163.813313205722, 4165.312723400605, 4182.623563879265, 5800.651960882361, 5808.796692115756, 5819.243498345188, 5819.883602328015, 5844.853878652898, 5394.352677678704, 5566.832995010156, 5647.265855438766, 5691.857703557444, 5698.515626171822, 5643.492085712305, 5682.971585142048, 5683.60214784961, 5701.401352858056, 5718.399568045295, 5652.378238393856, 5696.231008813757, 5697.601167918372, 5717.371089180104, 5727.570432217683, 5649.576281778801, 5651.47570743186, 5719.256496655575, 5750.25246717924, 5769.769209231584, 5633.4084921082695, 5637.0, 5649.350324712546, 5663.773449061991, 5665.12190610456], "value": 4293.655617593496, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [792.3423558446489, 793.6864938349352, 810.3760104719364, 823.5182418285303, 825.5830805443254, 15693.45072922448, 16437.506874793744, 16474.588135296624, 16485.917570412144, 16494.42269520567, 14797.0, 14941.327640256188, 14949.177795221258, 14954.252287385614, 14992.400303987828, 783.996080019602, 788.8580055590006, 795.2405452792598, 796.7012370361115, 798.1738900238255, 797.0196658110527, 802.7270727952495, 804.5574933786423, 805.1787177079376, 805.8267472493412, 846.3863698818369, 850.9829803403959, 851.2423942691009, 856.1695155698962, 857.4855086947844, 845.3237410071918, 847.3221422861748, 847.9830403391928, 849.7450764770545, 852.8081181734091, 621.7668374359615, 623.6819222196713, 623.7692053940026, 626.7461678020409, 627.5199472403615, 13545.322733863268, 13807.17156970575, 13815.447382104703, 13884.861151388457, 14404.423823047171, 12442.13336244236, 13018.544350947672, 13150.210987340695, 13233.602991910258, 13361.03564008317, 11352.0, 11368.261063030877, 11369.886301136965, 11478.885211147865, 12071.275723456622, 3776.773393596393, 3829.5596006459054, 3994.7003974702016, 4042.6967977401814, 4046.9595304046875, 53334.999999999614, 68107.65946170238, 70199.64900175517, 71622.28377716261, 71685.64157179232, 10998.615048473264, 11089.445527723581, 11235.719107022227, 11583.536658533732, 11588.76822463546, 19302.13140408685, 19576.0, 19654.21383144687, 19665.508362291057, 19684.70472942907, 8150.0, 8286.751397458085, 8507.702230421906, 8549.658013679384, 8572.657093716181, 4690.859274221779, 4713.363695901009, 4739.786709598076, 4742.762861856893, 4835.178019736653, 3433.124553238908, 3499.685028347461, 3512.5784905811465, 3563.893083207508, 3615.9276814464088, 619.7397093220858, 625.1747693045137, 627.5105417774143, 636.9076483909807, 646.6992848325551, 697.4629535257925, 701.396798753072, 734.6547122852251, 738.7119023580808, 743.9665215065335, 8605.526696031779, 9182.632694692138, 9210.309226808016, 9487.914463961635, 9698.127168554864, 652.6964961293022, 662.0, 686.807693845724, 703.050881310227, 704.3379223529865, 4604.493505714368, 4637.188492013884, 4670.64970127235, 4803.8318658847475, 4805.183118869801, 50818.237726434134, 53147.73426132845, 89401.0, 90341.0, 92308.53845730863, 48514.27228591574, 54896.41243050779, 73962.26037739553, 75548.24451755521, 76443.61778191185, 63883.36116638774, 64307.0, 66173.669131655, 66465.6676716623, 67029.66485167544, 9167.816643667224, 9437.528123593656, 9503.192228660364, 9566.952165239129, 9618.903810961801, 47304.0, 47365.0, 47536.286955696385, 47842.0, 47864.0, 59759.70120149371, 60305.0, 64915.67542162448, 65865.34134658784, 66591.66704166448, 11070.446477676245, 11204.88795112071, 11477.139214559109, 11787.705307367385, 12195.817062744243, 12627.494900203888, 12897.613071607866, 12902.354882256037, 12961.935190324366, 13110.803337950128, 10970.000549349046, 11135.160534064085, 11389.487473063566, 11455.255408398427, 12628.43172057278, 11566.0, 11962.283762714518, 13284.80072798928, 13339.19964802115, 13350.132241404277, 12958.611241662766, 13303.46786128544, 13679.589612311647, 13782.93108534451, 14166.362513687114, 10466.790664186827, 10901.781964360827, 11151.665450036511, 11558.479868405773, 12039.939800301292, 9649.614015439585, 9926.457774214934, 10447.268691191848, 11581.768364632828, 11931.701707457383], "value": 7098.237734533524, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1518.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 112.0, 112.0, 111.0, 112.0, 112.0, 113.0, 112.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 127.0, 170.0, 125.0, 125.0, 125.0, 124.0, 153.0, 126.0], "value": 135.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 164.0, 176.0, 164.0, 162.0, 163.0, 163.0, 166.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 78.0, 78.0, 76.0, 76.0, 105.0, 77.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 111.0, 84.0, 82.0, 84.0, 98.0, 82.0, 81.0, 123.0], "value": 91.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 118.0, 119.0, 117.0, 119.0, 117.0, 117.0, 120.0, 117.0, 118.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 149.0, 149.0, 149.0, 147.0, 148.0, 148.0, 150.0, 147.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 85.0, 85.0, 86.0, 85.0, 86.0, 85.0, 87.0, 86.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 57.0, 56.0, 56.0, 57.0, 57.0, 57.0, 55.0, 60.0], "value": 56.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 61.0, 61.0, 61.0], "value": 61.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 82.0, 90.0, 81.0, 79.0, 87.0, 81.0, 81.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 150.0, 145.0, 137.0, 142.0, 136.0, 138.0, 138.0, 176.0, 131.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 166.0, 168.0, 172.0, 170.0, 167.0, 169.0, 176.0, 165.0, 172.0], "value": 170.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 75.0, 63.0, 65.0, 63.0, 71.0, 64.0, 70.0, 63.0], "value": 66.5, "unit": "score"}]}]} 08:08:21 INFO - Return code: 0 08:08:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:08:21 ERROR - # TBPL SUCCESS # 08:08:21 INFO - Running post-action listener: _resource_record_post_action 08:08:21 INFO - [mozharness: 2016-11-02 15:08:21.588178Z] Finished run-tests step (success) 08:08:21 INFO - Running post-run listener: _resource_record_post_run 08:08:21 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 0; Write bytes: 393920512; Read time: 0; Write time: 276896 08:08:21 INFO - TinderboxPrint: CPU usage
13.4% 08:08:21 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 08:08:21 INFO - TinderboxPrint: I/O write bytes / time
393,920,512 / 276,896 08:08:21 INFO - TinderboxPrint: CPU idle
8,267.6 (86.5%) 08:08:21 INFO - TinderboxPrint: CPU user
1,219.5 (12.8%) 08:08:21 INFO - TinderboxPrint: Swap in / out
0 / 0 08:08:21 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103469056; Read time: 0; Write time: 89576 08:08:21 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 289837056; Read time: 0; Write time: 187320 08:08:22 INFO - Running post-run listener: _upload_blobber_files 08:08:22 INFO - Blob upload gear active. 08:08:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:08:22 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 08:08:22 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'] 08:08:22 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 08:08:22 INFO - (blobuploader) - INFO - Open directory for files ... 08:08:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:08:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:08:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:23 INFO - (blobuploader) - INFO - Done attempting. 08:08:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:08:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:08:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:26 INFO - (blobuploader) - INFO - Done attempting. 08:08:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:08:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:08:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:08:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:08:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:08:27 INFO - (blobuploader) - INFO - Done attempting. 08:08:27 INFO - (blobuploader) - INFO - Iteration through files over. 08:08:27 INFO - Return code: 0 08:08:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:08:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:08:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24d5b4cec9283a1f975e0f909ae103520e988ae50fca9bae03053f2d2d6df512f394c693b96628c5574430c0c7e863b312498e3d82c27d2e1dd340107abccad5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6a4016630f26ea1ee522a5ed1a9000c1a2532108f48e41b1336f1a77a78c7dc37a3f977a3b35384b97ec1f015577db8ec7c9a83d9321f7fee762502d5ea6e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aee54e652539979cbbbac0490d89b649d9bf223e80261acbde390b5dbbf7cd6bb066c13888dfc702ce1983290fe7d0d0b9bcdd2e600e1799ed620bb85d90d5d3"} 08:08:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:08:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:08:27 INFO - Contents: 08:08:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24d5b4cec9283a1f975e0f909ae103520e988ae50fca9bae03053f2d2d6df512f394c693b96628c5574430c0c7e863b312498e3d82c27d2e1dd340107abccad5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6a4016630f26ea1ee522a5ed1a9000c1a2532108f48e41b1336f1a77a78c7dc37a3f977a3b35384b97ec1f015577db8ec7c9a83d9321f7fee762502d5ea6e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aee54e652539979cbbbac0490d89b649d9bf223e80261acbde390b5dbbf7cd6bb066c13888dfc702ce1983290fe7d0d0b9bcdd2e600e1799ed620bb85d90d5d3"} 08:08:27 INFO - Running post-run listener: copy_logs_to_upload_dir 08:08:27 INFO - Copying logs to upload dir... 08:08:27 INFO - mkdir: /builds/slave/test/build/upload/logs 08:08:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.242962 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-11-02 08:08:25.898984) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 08:08:25.902504) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24d5b4cec9283a1f975e0f909ae103520e988ae50fca9bae03053f2d2d6df512f394c693b96628c5574430c0c7e863b312498e3d82c27d2e1dd340107abccad5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6a4016630f26ea1ee522a5ed1a9000c1a2532108f48e41b1336f1a77a78c7dc37a3f977a3b35384b97ec1f015577db8ec7c9a83d9321f7fee762502d5ea6e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aee54e652539979cbbbac0490d89b649d9bf223e80261acbde390b5dbbf7cd6bb066c13888dfc702ce1983290fe7d0d0b9bcdd2e600e1799ed620bb85d90d5d3"} build_url:https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011227 build_url: 'https://archive.mozilla.org/pub/firefox/tinderbox-builds/mozilla-inbound-linux64-pgo/1478018213/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/24d5b4cec9283a1f975e0f909ae103520e988ae50fca9bae03053f2d2d6df512f394c693b96628c5574430c0c7e863b312498e3d82c27d2e1dd340107abccad5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/b6a4016630f26ea1ee522a5ed1a9000c1a2532108f48e41b1336f1a77a78c7dc37a3f977a3b35384b97ec1f015577db8ec7c9a83d9321f7fee762502d5ea6e55", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/aee54e652539979cbbbac0490d89b649d9bf223e80261acbde390b5dbbf7cd6bb066c13888dfc702ce1983290fe7d0d0b9bcdd2e600e1799ed620bb85d90d5d3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-02 08:08:25.929466) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 08:08:25.929795) ========= 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=a12cd81e0ef515edd9e0d800000001bb-1478098066.573117-115522777 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-02 08:08:25.981799) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 08:08:25.982161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-02 08:08:25.982463) ========= ========= Total master_lag: 0.12 =========