builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-049 starttime: 1476709063.63 results: success (0) buildid: 20161017030209 builduid: aa6a393275ef43e4b0f38fe1720d203d revision: 94b0fddf96b43942bdd851a3275042909ea37e09 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:43.630266) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:43.630723) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:43.631094) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:43.691355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:43.691625) ========= 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=db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-10-17 05:57:43-- 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% 43.0M=0s 2016-10-17 05:57:43 (43.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.164833 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:43.879316) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:43.879748) ========= 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=db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014039 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:43.930413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 05:57:43.930776) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 94b0fddf96b43942bdd851a3275042909ea37e09 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 94b0fddf96b43942bdd851a3275042909ea37e09 --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=db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-10-17 05:57:44,008 truncating revision to first 12 chars 2016-10-17 05:57:44,008 Setting DEBUG logging. 2016-10-17 05:57:44,008 attempt 1/10 2016-10-17 05:57:44,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/94b0fddf96b4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-17 05:57:44,932 unpacking tar archive at: mozilla-central-94b0fddf96b4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.233331 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-17 05:57:45.177657) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:45.177964) ========= script_repo_revision: 94b0fddf96b43942bdd851a3275042909ea37e09 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:45.178365) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:45.178646) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-17 05:57:45.186984) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-17 05:57:45.187258) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:57:45 INFO - MultiFileLogger online at 20161017 05:57:45 in /builds/slave/test 05:57:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:57:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:57:45 INFO - {'append_to_log': False, 05:57:45 INFO - 'base_work_dir': '/builds/slave/test', 05:57:45 INFO - 'blob_upload_branch': 'Firefox', 05:57:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:57:45 INFO - 'branch': 'Firefox', 05:57:45 INFO - 'buildbot_json_path': 'buildprops.json', 05:57:45 INFO - 'config_files': ('talos/linux_config.py',), 05:57:45 INFO - 'default_actions': ('clobber', 05:57:45 INFO - 'read-buildbot-config', 05:57:45 INFO - 'download-and-extract', 05:57:45 INFO - 'populate-webroot', 05:57:45 INFO - 'create-virtualenv', 05:57:45 INFO - 'install', 05:57:45 INFO - 'run-tests'), 05:57:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:57:45 INFO - 'download_minidump_stackwalk': True, 05:57:45 INFO - 'download_symbols': 'ondemand', 05:57:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:57:45 INFO - 'tooltool.py': '/tools/tooltool.py', 05:57:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:57:45 INFO - '/tools/misc-python/virtualenv.py')}, 05:57:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:57:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:57:45 INFO - 'installer_path': 'installer.exe', 05:57:45 INFO - 'log_level': 'info', 05:57:45 INFO - 'log_name': 'talos', 05:57:45 INFO - 'log_to_console': True, 05:57:45 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:57:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:57:45 INFO - 'opt_config_files': (), 05:57:45 INFO - 'pip_index': False, 05:57:45 INFO - 'sps_profile': False, 05:57:45 INFO - 'sps_profile_interval': 0, 05:57:45 INFO - 'suite': 'dromaeojs-e10s', 05:57:45 INFO - 'system_bits': '32', 05:57:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:57:45 INFO - 'title': 'talos-linux64-ix-049', 05:57:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:57:45 INFO - 'use_talos_json': True, 05:57:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:57:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:57:45 INFO - 'work_dir': 'build'} 05:57:45 INFO - [mozharness: 2016-10-17 12:57:45.358221Z] Running clobber step. 05:57:45 INFO - Running pre-action listener: _resource_record_pre_action 05:57:45 INFO - Running main action method: clobber 05:57:45 INFO - rmtree: /builds/slave/test/build 05:57:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:57:45 INFO - Running post-action listener: _resource_record_post_action 05:57:45 INFO - [mozharness: 2016-10-17 12:57:45.818328Z] Finished clobber step (success) 05:57:45 INFO - [mozharness: 2016-10-17 12:57:45.818445Z] Running read-buildbot-config step. 05:57:45 INFO - Running pre-action listener: _resource_record_pre_action 05:57:45 INFO - Running main action method: read_buildbot_config 05:57:45 INFO - Using buildbot properties: 05:57:45 INFO - { 05:57:45 INFO - "project": "", 05:57:45 INFO - "product": "firefox", 05:57:45 INFO - "script_repo_revision": "production", 05:57:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:57:45 INFO - "repository": "", 05:57:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 05:57:45 INFO - "buildid": "20161017030209", 05:57:45 INFO - "stage_platform": "linux64-pgo", 05:57:45 INFO - "basedir": "/builds/slave/test", 05:57:45 INFO - "nightly_build": "True", 05:57:45 INFO - "buildnumber": 116, 05:57:45 INFO - "slavename": "talos-linux64-ix-049", 05:57:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:57:45 INFO - "platform": "ubuntu64_hw", 05:57:45 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 05:57:45 INFO - "branch": "mozilla-central", 05:57:45 INFO - "repo_path": "mozilla-central", 05:57:45 INFO - "revision": "94b0fddf96b43942bdd851a3275042909ea37e09", 05:57:45 INFO - "pgo_build": "True", 05:57:45 INFO - "builduid": "aa6a393275ef43e4b0f38fe1720d203d", 05:57:45 INFO - "slavebuilddir": "test" 05:57:45 INFO - } 05:57:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 05:57:45 INFO - Running post-action listener: _resource_record_post_action 05:57:45 INFO - [mozharness: 2016-10-17 12:57:45.820927Z] Finished read-buildbot-config step (success) 05:57:45 INFO - [mozharness: 2016-10-17 12:57:45.821016Z] Running download-and-extract step. 05:57:45 INFO - Running pre-action listener: _resource_record_pre_action 05:57:45 INFO - Running main action method: download_and_extract 05:57:45 INFO - mkdir: /builds/slave/test/build/tests 05:57:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:45 INFO - trying https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:57:45 INFO - Downloading https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/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 05:57:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/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 05:57:46 INFO - Downloaded 1361 bytes. 05:57:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 05:57:46 INFO - Using the following test package requirements: 05:57:46 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:57:46 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:57:46 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:57:46 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:46 INFO - u'jsshell-linux-x86_64.zip'], 05:57:46 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:57:46 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 05:57:46 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:57:46 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:57:46 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:57:46 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 05:57:46 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:57:46 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:57:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:57:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:57:46 INFO - Fetch https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:57:46 INFO - Http code: 200 05:57:46 INFO - via: 1.1 aa96a51fedae85199c643eb5c8eca4e4.cloudfront.net (CloudFront) 05:57:46 INFO - x-amz-cf-id: oqFk3WtS1oqV7NN_K5lLBv4x9VjHfkAd7AN_LgBvUNf7JAiWSHZh1g== 05:57:46 INFO - x-amz-version-id: 2Ut0jIeMZLQK8DLkhb47wNnsXAkaBcZg 05:57:48 INFO - Expected file size: 22089250 05:57:48 INFO - Obtained file size: 22089250 05:57:52 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 05:57:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 05:57:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:57:52 INFO - Fetch https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 05:57:53 INFO - Http code: 200 05:57:53 INFO - via: 1.1 d01884a3320364227d925bce1a38f0ad.cloudfront.net (CloudFront) 05:57:53 INFO - x-amz-cf-id: SOGBmzoHn-Iy0fBvoB5SOed2cQ4yJ1nej7JWSLIFWkDQxCCWnVN-pQ== 05:57:53 INFO - x-amz-version-id: 2Ut0jIeMZLQK8DLkhb47wNnsXAkaBcZg 05:57:53 INFO - Expected file size: 22089250 05:57:53 INFO - Obtained file size: 22089250 05:57:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 05:57:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:57:58 INFO - Fetch https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 05:57:58 INFO - Http code: 200 05:57:58 INFO - via: 1.1 55676da1e5c0a9c4e60a94a95b01dc04.cloudfront.net (CloudFront) 05:57:58 INFO - x-amz-cf-id: XLRxyVRG8-Ab9sx3kfGd3YkKftdw1hARE6VHGME3h3PSvWHoO5Nu6Q== 05:57:58 INFO - x-amz-version-id: TFGmVLXotye_aswtOBNYHVQWG056S.Qb 05:57:59 INFO - Expected file size: 14409028 05:57:59 INFO - Obtained file size: 14409028 05:57: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')]} 05:57:59 INFO - trying https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:57:59 INFO - Downloading https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/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 05:57:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/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 05:58:02 INFO - Downloaded 59484207 bytes. 05:58:02 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:58:02 INFO - mkdir: /builds/slave/test/properties 05:58:02 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:58:02 INFO - Writing to file /builds/slave/test/properties/build_url 05:58:02 INFO - Contents: 05:58:02 INFO - build_url:https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 05:58:02 INFO - Running post-action listener: _resource_record_post_action 05:58:02 INFO - Running post-action listener: set_extra_try_arguments 05:58:02 INFO - [mozharness: 2016-10-17 12:58:02.758281Z] Finished download-and-extract step (success) 05:58:02 INFO - [mozharness: 2016-10-17 12:58:02.758547Z] Running populate-webroot step. 05:58:02 INFO - Running pre-action listener: _resource_record_pre_action 05:58:02 INFO - Running main action method: populate_webroot 05:58:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:58:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:58:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:58:02 INFO - '--tppagecycles', 05:58:02 INFO - '7'], 05:58:02 INFO - 'tests': ['tsvgm']}}, 05:58:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:58:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:58:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:58:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:58:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:02 INFO - 'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:58:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:02 INFO - 'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['damp', 'tps']}, 05:58:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:02 INFO - 'tests': ['damp', 'tps']}, 05:58:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['dromaeo_dom']}, 05:58:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:58:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['basic_compositor_video']}, 05:58:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:58:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['a11yr', 05:58:02 INFO - 'ts_paint', 05:58:02 INFO - 'tpaint', 05:58:02 INFO - 'sessionrestore', 05:58:02 INFO - 'sessionrestore_no_auto_restore', 05:58:02 INFO - 'tabpaint']}, 05:58:02 INFO - 'other-e10s': {'tests': ['a11yr', 05:58:02 INFO - 'ts_paint', 05:58:02 INFO - 'tpaint', 05:58:02 INFO - 'sessionrestore', 05:58:02 INFO - 'sessionrestore_no_auto_restore', 05:58:02 INFO - 'tabpaint']}, 05:58:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:58:02 INFO - 'ts_paint', 05:58:02 INFO - 'tpaint', 05:58:02 INFO - 'sessionrestore', 05:58:02 INFO - 'sessionrestore_no_auto_restore', 05:58:02 INFO - 'tabpaint']}, 05:58:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:58:02 INFO - 'ts_paint', 05:58:02 INFO - 'tpaint', 05:58:02 INFO - 'sessionrestore', 05:58:02 INFO - 'sessionrestore_no_auto_restore', 05:58:02 INFO - 'tabpaint']}, 05:58:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['a11yr', 05:58:02 INFO - 'ts_paint', 05:58:02 INFO - 'tpaint', 05:58:02 INFO - 'sessionrestore', 05:58:02 INFO - 'sessionrestore_no_auto_restore', 05:58:02 INFO - 'tabpaint']}, 05:58:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['a11yr', 05:58:02 INFO - 'ts_paint', 05:58:02 INFO - 'tpaint', 05:58:02 INFO - 'sessionrestore', 05:58:02 INFO - 'sessionrestore_no_auto_restore', 05:58:02 INFO - 'tabpaint']}, 05:58:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['tsvgx', 05:58:02 INFO - 'tsvgr_opacity', 05:58:02 INFO - 'tart', 05:58:02 INFO - 'tscrollx', 05:58:02 INFO - 'cart']}, 05:58:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:58:02 INFO - 'tsvgr_opacity', 05:58:02 INFO - 'tart', 05:58:02 INFO - 'tscrollx', 05:58:02 INFO - 'cart']}, 05:58:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:02 INFO - 'talos_options': ['--disable-e10s'], 05:58:02 INFO - 'tests': ['tp5o']}, 05:58:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:02 INFO - 'tests': ['tp5o']}, 05:58:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:02 INFO - 'talos_options': ['--disable-e10s', 05:58:02 INFO - '--xperf_path', 05:58:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:02 INFO - 'tests': ['tp5n']}, 05:58:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:58:02 INFO - 'talos_options': ['--xperf_path', 05:58:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:58:02 INFO - 'tests': ['tp5n']}}, 05:58:02 INFO - 'talos.zip': {'path': '', 05:58:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:58:02 INFO - Running post-action listener: _resource_record_post_action 05:58:02 INFO - [mozharness: 2016-10-17 12:58:02.776775Z] Finished populate-webroot step (success) 05:58:02 INFO - [mozharness: 2016-10-17 12:58:02.776863Z] Running create-virtualenv step. 05:58:02 INFO - Running pre-action listener: _resource_record_pre_action 05:58:02 INFO - Running main action method: create_virtualenv 05:58:02 INFO - Creating virtualenv /builds/slave/test/build/venv 05:58:02 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 05:58:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:58:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:58:02 INFO - Using real prefix '/usr' 05:58:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:58:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:58:05 INFO - Installing pip.................done. 05:58:05 INFO - Return code: 0 05:58:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:58:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:58:05 INFO - Reading from file tmpfile_stdout 05:58:05 INFO - Output received: 05:58:05 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) 05:58:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:58:05 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')]} 05:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:05 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')]} 05:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:05 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 0x7f59fdd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', '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 05:58:05 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 05:58:05 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 05:58:05 INFO - Using env: {'DISPLAY': ':0', 05:58:05 INFO - 'HOME': '/home/cltbld', 05:58:05 INFO - 'LANG': 'en_US.UTF-8', 05:58:05 INFO - 'LANGUAGE': 'en_US:en', 05:58:05 INFO - 'LOGNAME': 'cltbld', 05:58:05 INFO - 'MAIL': '/var/mail/cltbld', 05:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:05 INFO - 'MOZ_NO_REMOTE': '1', 05:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:05 INFO - 'NO_EM_RESTART': '1', 05:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:05 INFO - 'PWD': '/builds/slave/test', 05:58:05 INFO - 'SHELL': '/bin/bash', 05:58:05 INFO - 'SHLVL': '1', 05:58:05 INFO - 'TERM': 'linux', 05:58:05 INFO - 'TMOUT': '86400', 05:58:05 INFO - 'USER': 'cltbld', 05:58:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:05 INFO - '_': '/tools/buildbot/bin/python'} 05:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:05 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 05:58:05 INFO - Cleaning up... 05:58:05 INFO - Return code: 0 05:58:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:58:05 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')]} 05:58:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:05 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')]} 05:58:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:05 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 0x7f59fdd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', '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 05:58:05 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 05:58:05 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 05:58:05 INFO - Using env: {'DISPLAY': ':0', 05:58:05 INFO - 'HOME': '/home/cltbld', 05:58:05 INFO - 'LANG': 'en_US.UTF-8', 05:58:05 INFO - 'LANGUAGE': 'en_US:en', 05:58:05 INFO - 'LOGNAME': 'cltbld', 05:58:05 INFO - 'MAIL': '/var/mail/cltbld', 05:58:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:05 INFO - 'MOZ_NO_REMOTE': '1', 05:58:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:05 INFO - 'NO_EM_RESTART': '1', 05:58:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:05 INFO - 'PWD': '/builds/slave/test', 05:58:05 INFO - 'SHELL': '/bin/bash', 05:58:05 INFO - 'SHLVL': '1', 05:58:05 INFO - 'TERM': 'linux', 05:58:05 INFO - 'TMOUT': '86400', 05:58:05 INFO - 'USER': 'cltbld', 05:58:05 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:05 INFO - '_': '/tools/buildbot/bin/python'} 05:58:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:05 INFO - Downloading/unpacking psutil>=3.1.1 05:58:05 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 05:58:05 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 05:58:05 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 05:58:05 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 05:58:05 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 05:58:05 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 05:58:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:58:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:08 INFO - Installing collected packages: psutil 05:58:08 INFO - Running setup.py install for psutil 05:58:08 INFO - building 'psutil._psutil_linux' extension 05:58:08 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:58:08 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 05:58:08 INFO - building 'psutil._psutil_posix' extension 05:58:08 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 05:58:08 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 05:58:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:58:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:58:08 INFO - Successfully installed psutil 05:58:08 INFO - Cleaning up... 05:58:08 INFO - Return code: 0 05:58:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:58:08 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')]} 05:58:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:08 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')]} 05:58:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:08 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 0x7f59fdd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', '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 05:58:08 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 05:58:08 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 05:58:08 INFO - Using env: {'DISPLAY': ':0', 05:58:08 INFO - 'HOME': '/home/cltbld', 05:58:08 INFO - 'LANG': 'en_US.UTF-8', 05:58:08 INFO - 'LANGUAGE': 'en_US:en', 05:58:08 INFO - 'LOGNAME': 'cltbld', 05:58:08 INFO - 'MAIL': '/var/mail/cltbld', 05:58:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:08 INFO - 'MOZ_NO_REMOTE': '1', 05:58:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:08 INFO - 'NO_EM_RESTART': '1', 05:58:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:08 INFO - 'PWD': '/builds/slave/test', 05:58:08 INFO - 'SHELL': '/bin/bash', 05:58:08 INFO - 'SHLVL': '1', 05:58:08 INFO - 'TERM': 'linux', 05:58:08 INFO - 'TMOUT': '86400', 05:58:08 INFO - 'USER': 'cltbld', 05:58:08 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:08 INFO - '_': '/tools/buildbot/bin/python'} 05:58:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:58:08 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 05:58:08 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 05:58:08 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 05:58:08 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 05:58:08 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 05:58:08 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 05:58:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:58:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:58:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:58:10 INFO - Installing collected packages: mozsystemmonitor 05:58:10 INFO - Running setup.py install for mozsystemmonitor 05:58:10 INFO - Successfully installed mozsystemmonitor 05:58:10 INFO - Cleaning up... 05:58:11 INFO - Return code: 0 05:58:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:58: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')]} 05:58:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58: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')]} 05:58:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f59fdd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', '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 05:58:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:58:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:58:11 INFO - Using env: {'DISPLAY': ':0', 05:58:11 INFO - 'HOME': '/home/cltbld', 05:58:11 INFO - 'LANG': 'en_US.UTF-8', 05:58:11 INFO - 'LANGUAGE': 'en_US:en', 05:58:11 INFO - 'LOGNAME': 'cltbld', 05:58:11 INFO - 'MAIL': '/var/mail/cltbld', 05:58:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:11 INFO - 'MOZ_NO_REMOTE': '1', 05:58:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:11 INFO - 'NO_EM_RESTART': '1', 05:58:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:11 INFO - 'PWD': '/builds/slave/test', 05:58:11 INFO - 'SHELL': '/bin/bash', 05:58:11 INFO - 'SHLVL': '1', 05:58:11 INFO - 'TERM': 'linux', 05:58:11 INFO - 'TMOUT': '86400', 05:58:11 INFO - 'USER': 'cltbld', 05:58:11 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:11 INFO - '_': '/tools/buildbot/bin/python'} 05:58:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:11 INFO - Downloading/unpacking jsonschema==2.5.1 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:58:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:58:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:58:13 INFO - warning: no files found matching '*.txt' 05:58:13 INFO - no previously-included directories found matching 'build' 05:58:13 INFO - no previously-included directories found matching 'dist' 05:58:13 INFO - no previously-included directories found matching '.git*' 05:58:13 INFO - Installing collected packages: jsonschema, functools32 05:58:13 INFO - Running setup.py install for functools32 05:58:13 INFO - warning: no files found matching '*.txt' 05:58:13 INFO - no previously-included directories found matching 'build' 05:58:13 INFO - no previously-included directories found matching 'dist' 05:58:13 INFO - no previously-included directories found matching '.git*' 05:58:13 INFO - Successfully installed jsonschema functools32 05:58:13 INFO - Cleaning up... 05:58:13 INFO - Return code: 0 05:58:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:58:13 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')]} 05:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:13 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')]} 05:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:13 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 0x7f59fdd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', '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 05:58:13 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 05:58:13 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 05:58:13 INFO - Using env: {'DISPLAY': ':0', 05:58:13 INFO - 'HOME': '/home/cltbld', 05:58:13 INFO - 'LANG': 'en_US.UTF-8', 05:58:13 INFO - 'LANGUAGE': 'en_US:en', 05:58:13 INFO - 'LOGNAME': 'cltbld', 05:58:13 INFO - 'MAIL': '/var/mail/cltbld', 05:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:13 INFO - 'MOZ_NO_REMOTE': '1', 05:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:13 INFO - 'NO_EM_RESTART': '1', 05:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:13 INFO - 'PWD': '/builds/slave/test', 05:58:13 INFO - 'SHELL': '/bin/bash', 05:58:13 INFO - 'SHLVL': '1', 05:58:13 INFO - 'TERM': 'linux', 05:58:13 INFO - 'TMOUT': '86400', 05:58:13 INFO - 'USER': 'cltbld', 05:58:13 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:13 INFO - '_': '/tools/buildbot/bin/python'} 05:58:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:58:13 INFO - Cleaning up... 05:58:13 INFO - Return code: 0 05:58:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:58:13 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')]} 05:58:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:13 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')]} 05:58:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:13 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 0x7f59fdd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', '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 05:58:13 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 05:58:13 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 05:58:13 INFO - Using env: {'DISPLAY': ':0', 05:58:13 INFO - 'HOME': '/home/cltbld', 05:58:13 INFO - 'LANG': 'en_US.UTF-8', 05:58:13 INFO - 'LANGUAGE': 'en_US:en', 05:58:13 INFO - 'LOGNAME': 'cltbld', 05:58:13 INFO - 'MAIL': '/var/mail/cltbld', 05:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:13 INFO - 'MOZ_NO_REMOTE': '1', 05:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:13 INFO - 'NO_EM_RESTART': '1', 05:58:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:13 INFO - 'PWD': '/builds/slave/test', 05:58:13 INFO - 'SHELL': '/bin/bash', 05:58:13 INFO - 'SHLVL': '1', 05:58:13 INFO - 'TERM': 'linux', 05:58:13 INFO - 'TMOUT': '86400', 05:58:13 INFO - 'USER': 'cltbld', 05:58:13 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:13 INFO - '_': '/tools/buildbot/bin/python'} 05:58:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58: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 05:58:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:58:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:58:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:16 INFO - Downloading docopt-0.6.1.tar.gz 05:58:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:58:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:58:17 INFO - Running setup.py install for blobuploader 05:58:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:58:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:58:17 INFO - Running setup.py install for requests 05:58:17 INFO - Running setup.py install for docopt 05:58:17 INFO - Successfully installed blobuploader requests docopt 05:58:17 INFO - Cleaning up... 05:58:17 INFO - Return code: 0 05:58:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:17 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')]} 05:58:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:17 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')]} 05:58:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:17 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 0x7f59fdd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', '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 05:58:17 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 05:58:17 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 05:58:17 INFO - Using env: {'DISPLAY': ':0', 05:58:17 INFO - 'HOME': '/home/cltbld', 05:58:17 INFO - 'LANG': 'en_US.UTF-8', 05:58:17 INFO - 'LANGUAGE': 'en_US:en', 05:58:17 INFO - 'LOGNAME': 'cltbld', 05:58:17 INFO - 'MAIL': '/var/mail/cltbld', 05:58:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:17 INFO - 'MOZ_NO_REMOTE': '1', 05:58:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:17 INFO - 'NO_EM_RESTART': '1', 05:58:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:17 INFO - 'PWD': '/builds/slave/test', 05:58:17 INFO - 'SHELL': '/bin/bash', 05:58:17 INFO - 'SHLVL': '1', 05:58:17 INFO - 'TERM': 'linux', 05:58:17 INFO - 'TMOUT': '86400', 05:58:17 INFO - 'USER': 'cltbld', 05:58:17 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:17 INFO - '_': '/tools/buildbot/bin/python'} 05:58:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:17 INFO - Running setup.py (path:/tmp/pip-_8dAZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:17 INFO - Running setup.py (path:/tmp/pip-szWypX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:17 INFO - Running setup.py (path:/tmp/pip-qysIlw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:18 INFO - Running setup.py (path:/tmp/pip-LSSwEM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:18 INFO - Running setup.py (path:/tmp/pip-PSbSlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:18 INFO - Running setup.py (path:/tmp/pip-05EBxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:18 INFO - Running setup.py (path:/tmp/pip-2glFJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:18 INFO - Running setup.py (path:/tmp/pip-6YizlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:18 INFO - Running setup.py (path:/tmp/pip-bJD7et-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:18 INFO - Running setup.py (path:/tmp/pip-ljvbsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:18 INFO - Running setup.py (path:/tmp/pip-pS9R_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:18 INFO - Running setup.py (path:/tmp/pip-zWQcy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:18 INFO - Running setup.py (path:/tmp/pip-Bmn7I9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:18 INFO - Running setup.py (path:/tmp/pip-SdZQ6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:18 INFO - Running setup.py (path:/tmp/pip-bQ9W2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:18 INFO - Running setup.py (path:/tmp/pip-FRX_gH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:18 INFO - Running setup.py (path:/tmp/pip-Az7lmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:58:19 INFO - Running setup.py install for manifestparser 05:58:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:58:19 INFO - Running setup.py install for mozcrash 05:58:19 INFO - Running setup.py install for mozdebug 05:58:19 INFO - Running setup.py install for mozdevice 05:58:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:58:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:58:19 INFO - Running setup.py install for mozfile 05:58:19 INFO - Running setup.py install for mozhttpd 05:58:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:58:19 INFO - Running setup.py install for mozinfo 05:58:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:58:19 INFO - Running setup.py install for mozInstall 05:58:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:58:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:58:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:58:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:58:19 INFO - Running setup.py install for mozleak 05:58:19 INFO - Running setup.py install for mozlog 05:58:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:58:20 INFO - Running setup.py install for moznetwork 05:58:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:58:20 INFO - Running setup.py install for mozprocess 05:58:20 INFO - Running setup.py install for mozprofile 05:58:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:58:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:58:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:58:20 INFO - Running setup.py install for mozrunner 05:58:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:58:20 INFO - Running setup.py install for mozscreenshot 05:58:20 INFO - Running setup.py install for moztest 05:58:20 INFO - Running setup.py install for mozversion 05:58:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:58:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:58:20 INFO - Cleaning up... 05:58:20 INFO - Return code: 0 05:58:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:20 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 0x7f59fdd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', '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 05:58:20 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 05:58:20 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 05:58:20 INFO - Using env: {'DISPLAY': ':0', 05:58:20 INFO - 'HOME': '/home/cltbld', 05:58:20 INFO - 'LANG': 'en_US.UTF-8', 05:58:20 INFO - 'LANGUAGE': 'en_US:en', 05:58:20 INFO - 'LOGNAME': 'cltbld', 05:58:20 INFO - 'MAIL': '/var/mail/cltbld', 05:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:20 INFO - 'MOZ_NO_REMOTE': '1', 05:58:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:20 INFO - 'NO_EM_RESTART': '1', 05:58:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:20 INFO - 'PWD': '/builds/slave/test', 05:58:20 INFO - 'SHELL': '/bin/bash', 05:58:20 INFO - 'SHLVL': '1', 05:58:20 INFO - 'TERM': 'linux', 05:58:20 INFO - 'TMOUT': '86400', 05:58:20 INFO - 'USER': 'cltbld', 05:58:20 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:20 INFO - '_': '/tools/buildbot/bin/python'} 05:58:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:58:21 INFO - Running setup.py (path:/tmp/pip-ZsppsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:58:21 INFO - Running setup.py (path:/tmp/pip-nymxm4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:58:21 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)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:58:21 INFO - Running setup.py (path:/tmp/pip-3hxIn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:58:21 INFO - Running setup.py (path:/tmp/pip-fjr9U2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:58:21 INFO - Running setup.py (path:/tmp/pip-38OQqc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:58:21 INFO - Running setup.py (path:/tmp/pip-O8_1JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:58:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:58:21 INFO - Running setup.py (path:/tmp/pip-BUtQBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:58:21 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)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:58:21 INFO - Running setup.py (path:/tmp/pip-LwVXuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:58:21 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)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:58:21 INFO - Running setup.py (path:/tmp/pip-Te4zBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:58:21 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)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:58:21 INFO - Running setup.py (path:/tmp/pip-Y7fVcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:58:21 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)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:58:21 INFO - Running setup.py (path:/tmp/pip-TbUgus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:58:21 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)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:58:21 INFO - Running setup.py (path:/tmp/pip-VFuLu6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:58:21 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)) 05:58:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:58:21 INFO - Running setup.py (path:/tmp/pip-jpqVt7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:58:22 INFO - Running setup.py (path:/tmp/pip-W74JcD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:58:22 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)) 05:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:22 INFO - Running setup.py (path:/tmp/pip-nr5AUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:58:22 INFO - Running setup.py (path:/tmp/pip-Ww_j3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:58:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:58:22 INFO - Running setup.py (path:/tmp/pip-tjxAHv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:58:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:58:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:58:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:58:24 INFO - Downloading blessings-1.6.tar.gz 05:58:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:58:24 INFO - Installing collected packages: blessings 05:58:24 INFO - Running setup.py install for blessings 05:58:24 INFO - Successfully installed blessings 05:58:24 INFO - Cleaning up... 05:58:24 INFO - Return code: 0 05:58:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:58:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:24 INFO - Reading from file tmpfile_stdout 05:58:24 INFO - Current package versions: 05:58:24 INFO - argparse == 1.2.1 05:58:24 INFO - blessings == 1.6 05:58:24 INFO - blobuploader == 1.2.4 05:58:24 INFO - docopt == 0.6.1 05:58:24 INFO - functools32 == 3.2.3-2 05:58:24 INFO - jsonschema == 2.5.1 05:58:24 INFO - manifestparser == 1.1 05:58:24 INFO - mozInstall == 1.12 05:58:24 INFO - mozcrash == 0.17 05:58:24 INFO - mozdebug == 0.1 05:58:24 INFO - mozdevice == 0.48 05:58:24 INFO - mozfile == 1.2 05:58:24 INFO - mozhttpd == 0.7 05:58:24 INFO - mozinfo == 0.9 05:58:24 INFO - mozleak == 0.1 05:58:24 INFO - mozlog == 3.4 05:58:24 INFO - moznetwork == 0.27 05:58:24 INFO - mozprocess == 0.23 05:58:24 INFO - mozprofile == 0.28 05:58:24 INFO - mozrunner == 6.12 05:58:24 INFO - mozscreenshot == 0.1 05:58:24 INFO - mozsystemmonitor == 0.3 05:58:24 INFO - moztest == 0.7 05:58:24 INFO - mozversion == 1.4 05:58:24 INFO - psutil == 3.1.1 05:58:24 INFO - requests == 1.2.3 05:58:24 INFO - wsgiref == 0.1.2 05:58:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:58:24 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')]} 05:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:24 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')]} 05:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:24 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 0x7f59fdd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', '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 05:58:24 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 05:58:24 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 05:58:24 INFO - Using env: {'DISPLAY': ':0', 05:58:24 INFO - 'HOME': '/home/cltbld', 05:58:24 INFO - 'LANG': 'en_US.UTF-8', 05:58:24 INFO - 'LANGUAGE': 'en_US:en', 05:58:24 INFO - 'LOGNAME': 'cltbld', 05:58:24 INFO - 'MAIL': '/var/mail/cltbld', 05:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:24 INFO - 'MOZ_NO_REMOTE': '1', 05:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:24 INFO - 'NO_EM_RESTART': '1', 05:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:24 INFO - 'PWD': '/builds/slave/test', 05:58:24 INFO - 'SHELL': '/bin/bash', 05:58:24 INFO - 'SHLVL': '1', 05:58:24 INFO - 'TERM': 'linux', 05:58:24 INFO - 'TMOUT': '86400', 05:58:24 INFO - 'USER': 'cltbld', 05:58:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:24 INFO - '_': '/tools/buildbot/bin/python'} 05:58:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:24 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)) 05:58:24 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)) 05:58:24 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)) 05:58:24 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)) 05:58:24 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)) 05:58:24 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)) 05:58:24 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)) 05:58:24 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)) 05:58:24 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)) 05:58:24 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)) 05:58:24 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)) 05:58:24 INFO - Cleaning up... 05:58:24 INFO - Return code: 0 05:58:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:58:24 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')]} 05:58:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:58:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:24 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')]} 05:58:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:58:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:58:24 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 0x7f59fdd9cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28c08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x298d790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, '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': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', '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 05:58:24 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 05:58:24 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 05:58:24 INFO - Using env: {'DISPLAY': ':0', 05:58:24 INFO - 'HOME': '/home/cltbld', 05:58:24 INFO - 'LANG': 'en_US.UTF-8', 05:58:24 INFO - 'LANGUAGE': 'en_US:en', 05:58:24 INFO - 'LOGNAME': 'cltbld', 05:58:24 INFO - 'MAIL': '/var/mail/cltbld', 05:58:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:24 INFO - 'MOZ_NO_REMOTE': '1', 05:58:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:24 INFO - 'NO_EM_RESTART': '1', 05:58:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:24 INFO - 'PWD': '/builds/slave/test', 05:58:24 INFO - 'SHELL': '/bin/bash', 05:58:24 INFO - 'SHLVL': '1', 05:58:24 INFO - 'TERM': 'linux', 05:58:24 INFO - 'TMOUT': '86400', 05:58:24 INFO - 'USER': 'cltbld', 05:58:24 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:24 INFO - '_': '/tools/buildbot/bin/python'} 05:58:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:58:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:58:25 INFO - Cleaning up... 05:58:25 INFO - Return code: 0 05:58:25 INFO - Running post-action listener: _resource_record_post_action 05:58:25 INFO - Running post-action listener: _start_resource_monitoring 05:58:25 INFO - Starting resource monitoring. 05:58:25 INFO - [mozharness: 2016-10-17 12:58:25.210826Z] Finished create-virtualenv step (success) 05:58:25 INFO - [mozharness: 2016-10-17 12:58:25.211332Z] Running install step. 05:58:25 INFO - Running pre-action listener: _resource_record_pre_action 05:58:25 INFO - Running main action method: install 05:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:58:25 INFO - Reading from file tmpfile_stdout 05:58:25 INFO - Detecting whether we're running mozinstall >=1.0... 05:58:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:58:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:58:25 INFO - Reading from file tmpfile_stdout 05:58:25 INFO - Output received: 05:58:25 INFO - Usage: mozinstall [options] installer 05:58:25 INFO - Options: 05:58:25 INFO - -h, --help show this help message and exit 05:58:25 INFO - -d DEST, --destination=DEST 05:58:25 INFO - Directory to install application into. [default: 05:58:25 INFO - "/builds/slave/test"] 05:58:25 INFO - --app=APP Application being installed. [default: firefox] 05:58:25 INFO - mkdir: /builds/slave/test/build/application 05:58:25 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'] 05:58:25 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 05:58:42 INFO - Reading from file tmpfile_stdout 05:58:42 INFO - Output received: 05:58:42 INFO - /builds/slave/test/build/application/firefox/firefox 05:58:42 INFO - Running post-action listener: _resource_record_post_action 05:58:42 INFO - [mozharness: 2016-10-17 12:58:42.442079Z] Finished install step (success) 05:58:42 INFO - [mozharness: 2016-10-17 12:58:42.442321Z] Running run-tests step. 05:58:42 INFO - Running pre-action listener: _resource_record_pre_action 05:58:42 INFO - Running main action method: run_tests 05:58:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:58:42 INFO - Python 2.7.3 05:58:42 INFO - Return code: 0 05:58:42 INFO - grabbing minidump binary from tooltool 05:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:58:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298a930>, '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 0x298b830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x298bcc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:58:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:58:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:58:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:58:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:58:42 INFO - Return code: 0 05:58:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:58:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:58:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:58:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:58:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:58:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 05:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --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 05:58:42 INFO - Using env: {'DISPLAY': ':0', 05:58:42 INFO - 'HOME': '/home/cltbld', 05:58:42 INFO - 'LANG': 'en_US.UTF-8', 05:58:42 INFO - 'LANGUAGE': 'en_US:en', 05:58:42 INFO - 'LOGNAME': 'cltbld', 05:58:42 INFO - 'MAIL': '/var/mail/cltbld', 05:58:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:58:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:58:42 INFO - 'MOZ_NO_REMOTE': '1', 05:58:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:58:42 INFO - 'NO_EM_RESTART': '1', 05:58:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:58:42 INFO - 'PWD': '/builds/slave/test', 05:58:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:58:42 INFO - 'SHELL': '/bin/bash', 05:58:42 INFO - 'SHLVL': '1', 05:58:42 INFO - 'TERM': 'linux', 05:58:42 INFO - 'TMOUT': '86400', 05:58:42 INFO - 'USER': 'cltbld', 05:58:42 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726', 05:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:58:42 INFO - '_': '/tools/buildbot/bin/python'} 05:58:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--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 05:58:42 INFO - mozversion application_buildid: 20161017030209 05:58:42 INFO - mozversion application_changeset: 94b0fddf96b43942bdd851a3275042909ea37e09 05:58:42 INFO - mozversion application_display_name: Nightly 05:58:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:58:42 INFO - mozversion application_name: Firefox 05:58:42 INFO - mozversion application_remotingname: firefox 05:58:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:58:42 INFO - mozversion application_vendor: Mozilla 05:58:42 INFO - mozversion application_version: 52.0a1 05:58:42 INFO - mozversion platform_buildid: 20161017030209 05:58:42 INFO - mozversion platform_changeset: 94b0fddf96b43942bdd851a3275042909ea37e09 05:58:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:58:42 INFO - mozversion platform_version: 52.0a1 05:58:42 INFO - using testdate: 1476709122 05:58:42 INFO - actual date: 1476709122 05:58:42 INFO - starting webserver on 'localhost:49566' 05:58:42 INFO - SUITE-START | Running 2 tests 05:58:42 INFO - TEST-START | dromaeo_css 05:58:42 INFO - operating with platform_type : linux_ 05:58:42 INFO - Initialising browser for dromaeo_css test... 05:58:42 INFO - TEST-INFO | started process 5592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUaftc8/profile http://localhost:49566/getInfo.html) 05:58:47 INFO - PROCESS | 5592 | __metrics Screen width/height:1600/1200 05:58:47 INFO - PROCESS | 5592 | colorDepth:24 05:58:47 INFO - PROCESS | 5592 | Browser inner width/height: 1024/697 05:58:47 INFO - PROCESS | 5592 | __metrics 05:58:48 ERROR - PROCESS | 5592 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 05:58:49 INFO - TEST-INFO | 5592: exit 0 05:58:49 INFO - Browser initialized. 05:58:49 INFO - Running cycle 1/1 for dromaeo_css test... 05:58:49 INFO - TEST-INFO | started process 5715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUaftc8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:02 INFO - PROCESS | 5715 | RSS: Main: 182616064 05:59:02 INFO - PROCESS | 5715 | 05:59:51 INFO - PROCESS | 5715 | 1476709191692 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] 06:02:02 INFO - PROCESS | 5715 | Cycle 1(1): loaded http://localhost:49566/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49566/tests/dromaeo/cssquery-ext.html) 06:02:04 INFO - PROCESS | 5715 | RSS: Main: 196456448 06:02:04 INFO - PROCESS | 5715 | 06:05:06 INFO - PROCESS | 5715 | Cycle 1(1): loaded http://localhost:49566/tests/dromaeo/cssquery-ext.html (next: http://localhost:49566/tests/dromaeo/cssquery-jquery.html) 06:05:07 INFO - PROCESS | 5715 | RSS: Main: 195063808 06:05:07 INFO - PROCESS | 5715 | 06:08:08 INFO - PROCESS | 5715 | Cycle 1(1): loaded http://localhost:49566/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49566/tests/dromaeo/cssquery-mootools.html) 06:08:09 INFO - PROCESS | 5715 | RSS: Main: 197214208 06:08:09 INFO - PROCESS | 5715 | 06:11:11 INFO - PROCESS | 5715 | Cycle 1(1): loaded http://localhost:49566/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49566/tests/dromaeo/cssquery-prototype.html) 06:11:12 INFO - PROCESS | 5715 | RSS: Main: 193589248 06:11:12 INFO - PROCESS | 5715 | 06:14:14 INFO - PROCESS | 5715 | Cycle 1(1): loaded http://localhost:49566/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49566/tests/dromaeo/cssquery-yui.html) 06:14:15 INFO - PROCESS | 5715 | RSS: Main: 197185536 06:14:15 INFO - PROCESS | 5715 | 06:17:17 INFO - PROCESS | 5715 | Cycle 1(1): loaded http://localhost:49566/tests/dromaeo/cssquery-yui.html (next: http://localhost:49566/tests/dromaeo/cssquery-dojo.html) 06:17:18 INFO - PROCESS | 5715 | RSS: Main: 196636672 06:17:18 INFO - PROCESS | 5715 | 06:17:18 INFO - PROCESS | 5715 | __start_tp_report 06:17:18 INFO - PROCESS | 5715 | _x_x_mozilla_page_load 06:17:18 INFO - PROCESS | 5715 | _x_x_mozilla_page_load_details 06:17:18 INFO - PROCESS | 5715 | |i|pagename|runs| 06:17:18 INFO - PROCESS | 5715 | |0;dojo.html;2880.9423811523757;2901.3326934804995;2901.4922388581995;2991.9850400747987;3020.9697903020965;5153.915373737976;5170.198619214023;5201.791928322863;5225.059489291931;5305.8938821223555;5228.555572776309;5234.528892399683;5314.5748340132695;5317.042932272199;5411.648242864211;4782.115308667899;4870.4885986971385;4871.269309603553;4875.926861097087;4939.456659767423;4817.470078291385;4829.396325459317;4898.730569818658;4905.141600219965;4968.577670897978;4685.812567497296;4822.493638167977;4864;4888.657793954425;4896.657233993622;4677.7193368398;4710.3405523226775;4726;4729.361536192604;4749.7387643679585;4661.650376221797;4711.976440117812;4756.9286460703115;4765.69023013503;4775.5463230993;5242.004019236333;5254.028004819121;5261.394939581959;5276.366835979668;5347.037533244014;5493.807716729935;5556.805511807067;5591.916121258185;5607.355154157283;5616.269884914976;5609.803656872031;5644.604877658525;5660.716964151817;5668.866226754665;5697.373288938214;5209.817656382009;5295.549878260353;5306.310179676656;5314.7874085036165;5366.114591092504;5685.090385538377;5741.282339707536;5771.105478650816;5788.18965344852;5872.588918775645;5517;5576;5580.358258800209;5581.134924086773;5583.134614134816;5646.35066967304;5653.434656534314;5656.773729050792;5658.34928983164;5658.688772117573;5461.371942226615;5543.695096769717;5547.944520554743;5558.166275058774;5623.550115990711;5606.383297837235;5635.267415235993;5639.8590035249445;5640.971795140998;5641.266635337462;4385.890352741143;4389.517153113155;4393.494748104009;4393.714408563433;4397.076613911115;3821.082940094357;3863.2273545291055;3899.922001559953;3903.316919539069;3903.707221958308;5335.653182543122;5394.460553944653;5433.429489903582;5455.318085239345;5499.285092937893;5709.514691251207;5714.228579141846;5723.713814309268;5729.140628905698;5754.798582049608;5300.655457395257;5441.239178508801;5447.782088716486;5458.727063646802;5475.534579560782;4857.295692124622;4860.246661767432;4913.213885778258;4924.916518365953;4984.476629953875;5875.823725288248;5879;5886.3525012247765;5889.734961926723;5891.086881533369;5693.117566777156;5695.7436915338085;5699.9145012825675;5703.401142879938;5711.029125048669;5618.606697531133;5694.316681998187;5711.514521265739;5728.8567785804025;5757.683327417032;5408.621396502207;5514.696691681996;5526.336839579276;5527.198556209247;5585.385607583244;5560.805371811967;5606.943930560806;5609.775608975595;5619.80330688424;5620.213170156099;5461.15352120422;5473.452654734495;5557.305336832896;5559.916601251065;5567.832965011056;5502.147167189092;5538.584606154474;5546.889062218814;5613.607047506635;5624.831255062355;5460.781568737365;5511.944880551304;5512.090505066619;5543.833684989457;5545.306836645419;5428.294321738149;5494.36814766307;5615.157726341082;5628.549716022791;5688.800891968761;5356.491133342326;5386.48828361305;5410.78356865721;5417.674939503642;5467.371252306036 06:17:18 INFO - PROCESS | 5715 | |1;ext.html;568.8492549474388;569.8119620525227;572.2189211725995;578.3262499188446;599.7750843433712;45026;46078.5392146078;46559.06881862365;46656.30015549761;46689;42833.35749963753;43390.13219735603;43469.34795978063;43668.781656091676;43832.78083609585;8772;8937.329700272474;8940.15068568485;8951.060138685409;8957.77605559863;8697.913020869773;8762.430442021248;8791.868121978176;8830.690925817598;8842.646294148259;8805.911940880573;8819.338549608772;8878;8896.8665470018;8907.599158037903;8826.161514656129;8848.955755221215;8850.557472126433;8851.026387097414;8854.645814167425;8770.693025744133;8782.297416206751;8795.428297160664;8840.160184782435;8847.867281990775;40360.59639403598;40506.1898762026;40611.593884061076;40826.38760418596;40836;3411.232472693649;3411.567141800425;3428.879989200366;3489.790612563229;3626.8730594429067;30265.848670756506;30358;30557.38885222283;31096.86169310996;31616.525752113736;4291.270484017725;4339.761313127777;4396.868093957187;4472.150291444647;4547.499775024745;306351.4682426596;306466;307228;307389;308018;53251;53417;53421.73289133607;53466.465335346926;53535.46464535305;55562.72218638962;55760;55912;56056.439435605935;56120.719396403576;14731.484398046017;14855.628609284639;14893;14912.105273683397;14966.952313337963;10712.517936692868;10717.249792514449;10719.517621707042;10755.462226888625;10782.137429005661;14004.71990560183;15155;15155.318010689545;15315.540533784004;15570.610734731723;5454.554498291429;5704.919343554434;5778.55536115971;5857.765689372377;5945.554083443759;945.7257395355269;955.4840386191518;1031.118393773328;1032.7882784029257;1055.3298655353751;30032.14694604009;30901.227469313446;31247.531287030713;31308.686913131034;31419.685803141678;1068.0654427376046;1083.8482612434266;1088.7604726960055;1096.8464414981909;1115.6151127860876;15612.08219410882;16212.918935405483;16288.26702798377;16362.509124726277;16523.66952660964;440893;447052;447904;448206;451369;54619;54912.45087549153;54951.72524137354;55120.72439637776;55235.723821380634;1303.9608811735663;1318.7032917593656;1334.546254273571;1337.197681391177;1339.1228745171927;28678.569821452278;30082;30158.048273657536;30425.695743043172;31041.379172416877;47882.521174787806;47884.04231915412;47934.76032619815;48249;48488;403255;407285;407584;407984;411083;37385.81307093447;37546.249075018895;37812.81093594514;37889.62110378861;38249.808750956065;44418.77790611026;45218;45283.773581131885;45558.08883822371;45869.77065114653;38314;38350.424743629424;38711.2257754849;39687.40468892911;39739.60260397359;37470;38351;38403.807980959915;38731.2253754929;38780.80609597047;33687.32625347529;34026.489602656475;39478.802605986784;40057.39913901352;41666.16667666569;33682.8315858429;35379;35787.64212357843;35915;36394.81802591076;26731.465370692866;27079.052233171744;27139.45721085528;27343.589846151925;27678.861605691844 06:17:18 INFO - PROCESS | 5715 | |2;jquery.html;370.72566300937314;376.4522619588498;386.3644305118081;394.4261100099356;395.20958083832335;17091.65816683667;19010;19335.613287734253;19503.512412189666;19572.804271957295;18101.366452174178;18144.45566633;18548.629027419443;18581.070946452655;18669.25322987082;4777.877198858266;5506.201600767887;5753.856153596173;5769.624974376652;5779.306483221998;5606.467385598362;5696.515796157331;5728.22668939692;5738.167965645;5738.540916726673;5411.540019098381;5605.467480589337;5619.915701264485;5646.604737668365;5681.801136960207;5561.221428999943;5577.358603760579;5621.747021384027;5624.21261023457;5641.887162256752;4825.95174048262;4979.651424400294;4995.400551933792;5012.548870601627;5016.924746128811;21841.344759657237;22112.33662990113;22230;22322.77677223223;22459.43851403728;2274.510980139278;2328.336424119118;2354.976450235493;2643.378805980593;2680;13750.793738093937;14062.718745625132;14213.715725685428;14314;14342.784858227134;1832.2762508808946;1888.745019422388;1894.194967138974;1938.709193620954;2005.2480319880044;73609.26390736077;73847.82305747428;74715.25284747138;75491.62254188694;77368;9695.321327507148;9745.805083898282;9805.921348651642;9825.213982881352;9952.601895924226;13556.254406007763;13559.728805423836;13591.320433978459;13679.726405471834;13710.588682339545;7185.173705023989;7281.4538909582;7365.9631701841145;7511.812204694927;7531.924680753232;7053.294670533009;7095.290470952967;7222.674979625929;7285.162206346232;7335.4131669466315;6158.815235542851;6305.243370795534;6315.147455093595;6325.430711236011;6345.206849143857;1819.3541292841117;1829.5426143464133;1861.1345724238295;1865.8356306684182;1890.2250077468173;913.4062859141478;1013.2501948558014;1047.8794938582162;1052.7999680060764;1119.2487888911621;17993.2802687891;19226.615467690848;19326.32357867496;19444.902775486033;19762.90118549398;981.617169303972;992.4987881120132;995.1044060345747;1000.3797645459862;1055.1611468882256;10170.338927969658;10970.396628185526;10974.451277436096;10978.231523793258;11052.447377631086;395264;406618;421825;422133;423649;75807;76339.61830190924;77723.61138194273;78386.26780768989;79144;1027.4862568715641;1039.875214974208;1041.8020576090519;1045.6392544572263;1048.339546085961;16336;16713.582160446087;16827.91586042062;17443.30226790914;17818.821811781716;28462.57306140451;39247.89777328929;39693;40024.799256022365;40085;55856.72071639616;56040;56235.437645624654;56669.71665141648;57809.71095144498;7815.843683126419;7853.410994175346;8005.279524842792;8126.390520710852;8247.762835574711;12398.690032748893;12525;13019.804702929652;13334.666633334244;13492.392842322315;11065.723356916142;11459.140564457532;11483.827742584035;11494.597689080842;11504.712382190512;10038.447885366375;11347.205695601559;11573.537058517564;11598.594049208237;11682.591109311134;10413.739656508647;10616.84074738895;10696.144308455461;10700.678979630624;11040.889591103985;7978.601069946363;8110.756677299691;8253.79365515867;8257.180803615656;8625.69810056645;9638.614455421985;10372.481375931324;10401.115905148146;10456;10895.291806032583 06:17:18 INFO - PROCESS | 5715 | |3;mootools.html;1445.6024593236862;1502.872255858252;1627.894186877853;1768.1071059115145;1777.2535535075267;7633.084029916417;7897.960510197456;8434.156584341563;9102.590383432753;9133.817323653522;8517.574121293927;8834.469931804097;8841.867371989425;9119.680811171611;9131.132542408477;2167.1764729402803;2203.977960220401;2217.124235926808;2217.2793842001333;2226.6882636430832;2197.8571392859412;2210.6462965925457;2213.0926320208637;2221.677856710776;2236.9552608947893;2186.6501359782437;2187.0486338442747;2188.321620297705;2201.9889900550556;2269.614165591845;2217.868886867701;2218.7892150245702;2227.2538699535676;2230.02993697742;2237.004532982823;2219.889005549716;2249.460129568908;2251.8761468119246;2259.9322020339414;2263.1852533088077;8589.484630922103;8662.047174810767;8671.046184919654;9095.681651142178;9183.357164998453;5279.973600132013;5370.3287089113865;5377.81177658784;5399.325084364455;5407.945920540784;3406.2165701888457;3537.663921927413;3665.7067434605433;3669.7064234861145;3708.8331025103935;1087.6247694545368;1097.6597254851022;1108.983365249522;1123.8482804821408;1137.2380505061628;12443.191192572544;12467.314297713621;12484.563040293546;12499.062570307264;12516.561920332744;4574.519675434031;4627.514111018295;4805.37530121089;4832.661713680009;4857.927131093036;10508.789824203473;10509.9474502627;10514.684559463229;10534.36793792375;10538.947305263424;5418.376886658085;5430.266913966643;5435.429279925551;5437.592180586472;5457.399686034533;4290.549492303326;4698.882527936829;4876.268559716071;4955.578775804025;4990.90018199634;3800.9429858552144;3875.9224815504094;3886.941695874564;3934.6655534279907;4043.575424580377;1249.7375551134364;1262.3561983388538;1276.144982861485;1279.654493286826;1287.76820172368;878.3456325037888;892.1168043636753;897.3852910756153;934.2619330728784;944;5640.605157639008;5733;5801.071828507503;5815;5824.070563349358;948.5873644964324;974.1768205866032;977.4086677560116;987.9357841740264;1012.3976234140822;3980.7611543307494;4230.259704551691;4239.130978149472;4293.720908140961;4340.283853164256;10927.743309519507;11259.943700281447;11274.774504509864;11284;11304.547818087349;10945.343279403261;11099.889001110047;11159.94420027911;11263.592050993626;11310.434478276053;8302.501849889026;8307.37694672902;8352.039515455801;8353.498790072494;8363.874541881876;5757.193992841089;5817.825465236049;5883.852903677443;5921.289445266596;6004.969975150097;9993.800123997626;10137.746556336151;10169.796604068026;10170.644027459299;10294.742631433974;9910.405375677194;10561.735956601147;10614.469276535989;10620.309679870783;10626.990435908576;6451.258105317948;6563.3764792344655;7148.28517148281;7161.176464706626;7307.086614173229;8400.41197116196;8790.560471976247;8830.735077947671;8832.867506987272;8876;7782.649780759766;7934.246246606564;7934.404919630935;7974.880376794236;8058.073321568095;7334.816629584303;7523.510971786816;7598.12621548529;7600.619969001638;7626.923730762622;7195.280471952763;7198.604076775828;7205.963970180115;7241.601711905685;7244.60154691476;4682.719036857799;4815.879603009953;4904.705717656952;4920.360353154067;5043.470435604356;4944.307796908508;4985.850424487271;4997.20044792846;5062.620303477328;5124.385073791169 06:17:18 INFO - PROCESS | 5715 | |4;prototype.html;305.15319987035974;311.156765166399;316.0943895738708;331.9983400082999;335.4649334311772;5315.681059136455;5418.485243901823;5540.531759083846;5543.417941116185;5573.411577700351;5230.320058392404;5344.305240318753;5408.864138530904;5409.836885069709;5413.891722165564;4198.916021679564;4237.660987121023;4240.936385954213;4260.723053001545;4260.7656578888145;4105.774182419966;4208.284591619432;4219.556946520617;4235;4265.445492086024;4185.979070104645;4192.5116583612835;4195.328747400401;4196.874093777176;4199.55904630014;4193.475815523059;4210.936835947463;4213.43118678979;4226.175895700355;4242.8727138185905;3706.8188944243357;3753.60587138352;3767.3030489359558;3769.3968964965475;3778.4332350147697;5244.265802787613;5274.3913106502505;5276;5284.471552844723;5315.335583052119;4854.441739200002;4865.321464094882;4888.169011268093;4891;4894.045661096087;5308.787648494055;5616.185653080281;5662.207290979266;5664.716764161775;5728.2790674429725;4017.8593749218635;4026.6376026157495;4047.3321901886447;4048.9067951653183;4056.371262454324;5939.168516407706;5983.7434138830895;5997.730102145414;6049.546284028672;6061.8181454556;4029.7030692505577;4183.937240941388;4184.267753143188;4186.162767446523;4187.790610469525;4169.187008533307;4178.206140833232;4181.393697913785;4188.6649068074485;4199.501296728442;4847.345608342899;4848.636352273594;4868.294097355934;4875.975620121948;4882.12121818069;5615.803446879339;5785.334686511105;5841.474267315962;5845.707714614252;5857.47282744555;1411.6682579593787;1418.6240646228757;1423.3381477612959;1429.492530151802;1431.3272761801936;874.9343799215085;887.3655336434481;914.9862752058724;928.3362395886838;930.2743859789375;4862.7325497098;4871.561559459666;4875.609951203895;4889.828855990023;4931.50684931504;5139.715071232192;5159.458256883048;5176.482351764794;5187.896242075138;5192.234640222267;4698.788554515055;4780.163471392492;4859.975700121548;4897.877553061202;4918.532739389752;2722.9108356657493;2750.752432281104;2752.3119220194953;2752.8575641108714;2757.7518023377593;5245.449227831099;5271.367435907716;5298.675331167208;5306.495882891119;5358.3837858645975;5089.9745501273;5228.372595288513;5257.053730328577;5273.705937917019;5293.676580854786;5195.960807838372;5219.138842091088;5257.76340064698;5266.97366513165;5307.389650190277;5087.949120508895;5119.2100305334425;5121.539061484485;5135.6918584885025;5142.357205349332;4713.222318317439;5027.4218464877;5062.645614807076;5063.3417655704525;5088.033273678137;5201.023611027937;5306.469353064663;5325.707086110301;5348.679079255257;5356.5714742821265;3728.179800443898;3828.234353129441;3964.988927823502;3996.420519024783;4055.9594404055583;5776.942230577809;5779.624324418899;5787.160861675117;5803.970980145073;5807.796727114531;5620.690862002465;5686.57350698691;5690.630109042899;5748;5780.94219057804;5667.404922483245;5679.9148012779015;5687.744051517774;5724.713764311851;5752;5614.438556144516;5648.15277708347;5649.519790817826;5654.660720356792;5714.714264286686;5594.356648985256;5728.968785618628;5734.569907256889;5749.885002300014;5802.970985145047;5526.171074338881;5564.972175139098;5601.327840658984;5605.5515558756015;5655.1517272409465 06:17:18 INFO - PROCESS | 5715 | |5;yui.html;723.1851980801276;741.7033186725309;790.6955822008525;810.9472884262523;847.2882778466087;14978.850211497895;16650.417235396762;16708.74936875948;16754.83245167548;16758.245878935446;15075.547733567983;15312.157831319273;15359.692806143898;15390.923045384785;15416.3833446662;805.3798575097186;807.9474834135792;808.0989696488402;810.5298926622545;813.2924355810453;814.340384288728;817.1991448380561;818.4516374029384;819.0171793847406;822.3544517553721;861.8965724113115;866.2939704141137;867.3884911137633;867.4274978514181;867.6312567158964;854.3378881366959;855.2217482091298;857.0187135729554;857.3098655582254;859.1151114352195;635.4122436746038;637.6238019568477;637.9681015949184;639.6641763074376;641.7497176101324;14152.00935934485;14182.219977901212;14189.929050354682;14276.714465710731;14278.143311401349;12876.484940602364;13147.14543554666;13232.206067635972;13320.866791332059;13465;11412.71468213293;11426.714332141762;11507.539698412054;11608.825867611993;11621.53513859453;3778.452124441968;3796.52543432071;3799.4300854871713;3910.804459777028;3950.170464202521;75416;76931;77327.22672773256;77672.61163694145;79191.60404198;10078.143357814668;10133.898661013296;10189.592416303265;10438.37369757817;10640.467976601294;20599.176032958814;20635.071421786055;20667.896660516602;20719.792802071785;21156.78843211548;7894.250046245597;7970.242826931432;8221.630026648816;8492.40553161285;8766.693165739169;3877.96122038776;3882.2235552889533;3967;4316.942349124484;4365.934510982338;3539.7168226541817;3657.835397407123;3729.21686445844;3731.2164445466215;3746.9437958430644;597.3548567547039;610.4079043327964;619.6746707978348;620.4973971083347;639.9104125422444;595.5265563876728;643.2474005413677;731.7109741652124;733.1934871641153;734.9522281051715;9088.411725629392;9371.953140234391;9484.857727134098;9571.28215383849;9579.9042009579;670.0284587348365;702.4731451411442;705.4955706669654;712.5938215217276;738.4756822655975;4500.527444618333;4577.3362862384765;4731.534260772531;4770.236762118045;4842.225243960949;116082;118370;120244;120461;125103;96507.51746241364;99676.50161749145;100593;104849.47575262075;105451.4727426358;88020;88231;90786.54606726924;93704;95457.52271238738;8907.10928907104;9138.451692898447;9303.906960930575;9324.694542764155;9371.297152713438;51543;53351.733241333546;53721.19418208808;54634.726826365615;55082;44518;45400.86497837581;47578.76210618925;77474;81315;12092.39538023113;12098.455569499218;12286.569970051005;12404.81392779127;12698.301593412081;13632.454701812214;13781.86218137846;14386.784198237245;14763.852361476247;14961.850381496046;12497.56258530947;13352.799708004582;13469.865301346861;13583.45666173342;14236.145831250158;12706.491740330282;13207.867921321049;13407.597772066854;13454.730905382034;13548.254845983565;12325.568605098779;12644.557440489538;12939;13558.389872455566;13581.253031083384;10817.675469735921;10929.344239345664;10931.617393391192;10933.617323393642;11594.594189203337;11007.339559626447;11260.605878794202;11394.48724807369;11411.60059397917;11525.942370288094 06:17:18 INFO - PROCESS | 5715 | __end_tp_report 06:17:18 INFO - PROCESS | 5715 | __start_cc_report 06:17:18 INFO - PROCESS | 5715 | _x_x_mozilla_cycle_collect,317 06:17:18 INFO - PROCESS | 5715 | __end_cc_report 06:17:18 INFO - PROCESS | 5715 | __startTimestamp1476710238116__endTimestamp 06:17:18 INFO - PROCESS | 5715 | 06:17:18 INFO - PROCESS | 5715 | ------- Summary: start ------- 06:17:18 INFO - PROCESS | 5715 | Number of tests: 6 06:17:18 INFO - PROCESS | 5715 | 06:17:18 INFO - PROCESS | 5715 | [#0] dojo.html Cycles:165 Average:5248.63 Median:5467.37 stddev:601.32 (11.0%) stddev-sans-first:573.77 06:17:18 INFO - PROCESS | 5715 | Values: 2880.9 2901.3 2901.5 2992.0 3021.0 5153.9 5170.2 5201.8 5225.1 5305.9 5228.6 5234.5 5314.6 5317.0 5411.6 4782.1 4870.5 4871.3 4875.9 4939.5 4817.5 4829.4 4898.7 4905.1 4968.6 4685.8 4822.5 4864.0 4888.7 4896.7 4677.7 4710.3 4726.0 4729.4 4749.7 4661.7 4712.0 4756.9 4765.7 4775.5 5242.0 5254.0 5261.4 5276.4 5347.0 5493.8 5556.8 5591.9 5607.4 5616.3 5609.8 5644.6 5660.7 5668.9 5697.4 5209.8 5295.5 5306.3 5314.8 5366.1 5685.1 5741.3 5771.1 5788.2 5872.6 5517.0 5576.0 5580.4 5581.1 5583.1 5646.4 5653.4 5656.8 5658.3 5658.7 5461.4 5543.7 5547.9 5558.2 5623.6 5606.4 5635.3 5639.9 5641.0 5641.3 4385.9 4389.5 4393.5 4393.7 4397.1 3821.1 3863.2 3899.9 3903.3 3903.7 5335.7 5394.5 5433.4 5455.3 5499.3 5709.5 5714.2 5723.7 5729.1 5754.8 5300.7 5441.2 5447.8 5458.7 5475.5 4857.3 4860.2 4913.2 4924.9 4984.5 5875.8 5879.0 5886.4 5889.7 5891.1 5693.1 5695.7 5699.9 5703.4 5711.0 5618.6 5694.3 5711.5 5728.9 5757.7 5408.6 5514.7 5526.3 5527.2 5585.4 5560.8 5606.9 5609.8 5619.8 5620.2 5461.2 5473.5 5557.3 5559.9 5567.8 5502.1 5538.6 5546.9 5613.6 5624.8 5460.8 5511.9 5512.1 5543.8 5545.3 5428.3 5494.4 5615.2 5628.5 5688.8 5356.5 5386.5 5410.8 5417.7 5467.4 06:17:18 INFO - PROCESS | 5715 | 06:17:18 INFO - PROCESS | 5715 | [#1] ext.html Cycles:180 Average:54875.90 Median:223948.30 stddev:103403.81 (46.2%) stddev-sans-first:103613.49 06:17:18 INFO - PROCESS | 5715 | Values: 568.8 569.8 572.2 578.3 599.8 45026.0 46078.5 46559.1 46656.3 46689.0 42833.4 43390.1 43469.3 43668.8 43832.8 8772.0 8937.3 8940.2 8951.1 8957.8 8697.9 8762.4 8791.9 8830.7 8842.6 8805.9 8819.3 8878.0 8896.9 8907.6 8826.2 8849.0 8850.6 8851.0 8854.6 8770.7 8782.3 8795.4 8840.2 8847.9 40360.6 40506.2 40611.6 40826.4 40836.0 3411.2 3411.6 3428.9 3489.8 3626.9 30265.8 30358.0 30557.4 31096.9 31616.5 4291.3 4339.8 4396.9 4472.2 4547.5 306351.5 306466.0 307228.0 307389.0 308018.0 53251.0 53417.0 53421.7 53466.5 53535.5 55562.7 55760.0 55912.0 56056.4 56120.7 14731.5 14855.6 14893.0 14912.1 14967.0 10712.5 10717.2 10719.5 10755.5 10782.1 14004.7 15155.0 15155.3 15315.5 15570.6 5454.6 5704.9 5778.6 5857.8 5945.6 945.7 955.5 1031.1 1032.8 1055.3 30032.1 30901.2 31247.5 31308.7 31419.7 1068.1 1083.8 1088.8 1096.8 1115.6 15612.1 16212.9 16288.3 16362.5 16523.7 440893.0 447052.0 447904.0 448206.0 451369.0 54619.0 54912.5 54951.7 55120.7 55235.7 1304.0 1318.7 1334.5 1337.2 1339.1 28678.6 30082.0 30158.0 30425.7 31041.4 47882.5 47884.0 47934.8 48249.0 48488.0 403255.0 407285.0 407584.0 407984.0 411083.0 37385.8 37546.2 37812.8 37889.6 38249.8 44418.8 45218.0 45283.8 45558.1 45869.8 38314.0 38350.4 38711.2 39687.4 39739.6 37470.0 38351.0 38403.8 38731.2 38780.8 33687.3 34026.5 39478.8 40057.4 41666.2 33682.8 35379.0 35787.6 35915.0 36394.8 26731.5 27079.1 27139.5 27343.6 27678.9 06:17:18 INFO - PROCESS | 5715 | 06:17:18 INFO - PROCESS | 5715 | [#2] jquery.html Cycles:180 Average:25981.01 Median:14416.65 stddev:68284.74 (473.7%) stddev-sans-first:68449.22 06:17:18 INFO - PROCESS | 5715 | Values: 370.7 376.5 386.4 394.4 395.2 17091.7 19010.0 19335.6 19503.5 19572.8 18101.4 18144.5 18548.6 18581.1 18669.3 4777.9 5506.2 5753.9 5769.6 5779.3 5606.5 5696.5 5728.2 5738.2 5738.5 5411.5 5605.5 5619.9 5646.6 5681.8 5561.2 5577.4 5621.7 5624.2 5641.9 4826.0 4979.7 4995.4 5012.5 5016.9 21841.3 22112.3 22230.0 22322.8 22459.4 2274.5 2328.3 2355.0 2643.4 2680.0 13750.8 14062.7 14213.7 14314.0 14342.8 1832.3 1888.7 1894.2 1938.7 2005.2 73609.3 73847.8 74715.3 75491.6 77368.0 9695.3 9745.8 9805.9 9825.2 9952.6 13556.3 13559.7 13591.3 13679.7 13710.6 7185.2 7281.5 7366.0 7511.8 7531.9 7053.3 7095.3 7222.7 7285.2 7335.4 6158.8 6305.2 6315.1 6325.4 6345.2 1819.4 1829.5 1861.1 1865.8 1890.2 913.4 1013.3 1047.9 1052.8 1119.2 17993.3 19226.6 19326.3 19444.9 19762.9 981.6 992.5 995.1 1000.4 1055.2 10170.3 10970.4 10974.5 10978.2 11052.4 395264.0 406618.0 421825.0 422133.0 423649.0 75807.0 76339.6 77723.6 78386.3 79144.0 1027.5 1039.9 1041.8 1045.6 1048.3 16336.0 16713.6 16827.9 17443.3 17818.8 28462.6 39247.9 39693.0 40024.8 40085.0 55856.7 56040.0 56235.4 56669.7 57809.7 7815.8 7853.4 8005.3 8126.4 8247.8 12398.7 12525.0 13019.8 13334.7 13492.4 11065.7 11459.1 11483.8 11494.6 11504.7 10038.4 11347.2 11573.5 11598.6 11682.6 10413.7 10616.8 10696.1 10700.7 11040.9 7978.6 8110.8 8253.8 8257.2 8625.7 9638.6 10372.5 10401.1 10456.0 10895.3 06:17:18 INFO - PROCESS | 5715 | 06:17:18 INFO - PROCESS | 5715 | [#3] mootools.html Cycles:180 Average:5817.29 Median:4824.27 stddev:3360.78 (69.7%) stddev-sans-first:3354.15 06:17:18 INFO - PROCESS | 5715 | Values: 1445.6 1502.9 1627.9 1768.1 1777.3 7633.1 7898.0 8434.2 9102.6 9133.8 8517.6 8834.5 8841.9 9119.7 9131.1 2167.2 2204.0 2217.1 2217.3 2226.7 2197.9 2210.6 2213.1 2221.7 2237.0 2186.7 2187.0 2188.3 2202.0 2269.6 2217.9 2218.8 2227.3 2230.0 2237.0 2219.9 2249.5 2251.9 2259.9 2263.2 8589.5 8662.0 8671.0 9095.7 9183.4 5280.0 5370.3 5377.8 5399.3 5407.9 3406.2 3537.7 3665.7 3669.7 3708.8 1087.6 1097.7 1109.0 1123.8 1137.2 12443.2 12467.3 12484.6 12499.1 12516.6 4574.5 4627.5 4805.4 4832.7 4857.9 10508.8 10509.9 10514.7 10534.4 10538.9 5418.4 5430.3 5435.4 5437.6 5457.4 4290.5 4698.9 4876.3 4955.6 4990.9 3800.9 3875.9 3886.9 3934.7 4043.6 1249.7 1262.4 1276.1 1279.7 1287.8 878.3 892.1 897.4 934.3 944.0 5640.6 5733.0 5801.1 5815.0 5824.1 948.6 974.2 977.4 987.9 1012.4 3980.8 4230.3 4239.1 4293.7 4340.3 10927.7 11259.9 11274.8 11284.0 11304.5 10945.3 11099.9 11159.9 11263.6 11310.4 8302.5 8307.4 8352.0 8353.5 8363.9 5757.2 5817.8 5883.9 5921.3 6005.0 9993.8 10137.7 10169.8 10170.6 10294.7 9910.4 10561.7 10614.5 10620.3 10627.0 6451.3 6563.4 7148.3 7161.2 7307.1 8400.4 8790.6 8830.7 8832.9 8876.0 7782.6 7934.2 7934.4 7974.9 8058.1 7334.8 7523.5 7598.1 7600.6 7626.9 7195.3 7198.6 7206.0 7241.6 7244.6 4682.7 4815.9 4904.7 4920.4 5043.5 4944.3 4985.9 4997.2 5062.6 5124.4 06:17:18 INFO - PROCESS | 5715 | 06:17:18 INFO - PROCESS | 5715 | [#4] prototype.html Cycles:180 Average:4605.73 Median:5141.04 stddev:1340.31 (26.1%) stddev-sans-first:1304.62 06:17:18 INFO - PROCESS | 5715 | Values: 305.2 311.2 316.1 332.0 335.5 5315.7 5418.5 5540.5 5543.4 5573.4 5230.3 5344.3 5408.9 5409.8 5413.9 4198.9 4237.7 4240.9 4260.7 4260.8 4105.8 4208.3 4219.6 4235.0 4265.4 4186.0 4192.5 4195.3 4196.9 4199.6 4193.5 4210.9 4213.4 4226.2 4242.9 3706.8 3753.6 3767.3 3769.4 3778.4 5244.3 5274.4 5276.0 5284.5 5315.3 4854.4 4865.3 4888.2 4891.0 4894.0 5308.8 5616.2 5662.2 5664.7 5728.3 4017.9 4026.6 4047.3 4048.9 4056.4 5939.2 5983.7 5997.7 6049.5 6061.8 4029.7 4183.9 4184.3 4186.2 4187.8 4169.2 4178.2 4181.4 4188.7 4199.5 4847.3 4848.6 4868.3 4876.0 4882.1 5615.8 5785.3 5841.5 5845.7 5857.5 1411.7 1418.6 1423.3 1429.5 1431.3 874.9 887.4 915.0 928.3 930.3 4862.7 4871.6 4875.6 4889.8 4931.5 5139.7 5159.5 5176.5 5187.9 5192.2 4698.8 4780.2 4860.0 4897.9 4918.5 2722.9 2750.8 2752.3 2752.9 2757.8 5245.4 5271.4 5298.7 5306.5 5358.4 5090.0 5228.4 5257.1 5273.7 5293.7 5196.0 5219.1 5257.8 5267.0 5307.4 5087.9 5119.2 5121.5 5135.7 5142.4 4713.2 5027.4 5062.6 5063.3 5088.0 5201.0 5306.5 5325.7 5348.7 5356.6 3728.2 3828.2 3965.0 3996.4 4056.0 5776.9 5779.6 5787.2 5804.0 5807.8 5620.7 5686.6 5690.6 5748.0 5780.9 5667.4 5679.9 5687.7 5724.7 5752.0 5614.4 5648.2 5649.5 5654.7 5714.7 5594.4 5729.0 5734.6 5749.9 5803.0 5526.2 5565.0 5601.3 5605.6 5655.2 06:17:18 INFO - PROCESS | 5715 | 06:17:18 INFO - PROCESS | 5715 | [#5] yui.html Cycles:180 Average:20646.43 Median:4141.97 stddev:30519.36 (736.8%) stddev-sans-first:30568.31 06:17:18 INFO - PROCESS | 5715 | Values: 723.2 741.7 790.7 810.9 847.3 14978.9 16650.4 16708.7 16754.8 16758.2 15075.5 15312.2 15359.7 15390.9 15416.4 805.4 807.9 808.1 810.5 813.3 814.3 817.2 818.5 819.0 822.4 861.9 866.3 867.4 867.4 867.6 854.3 855.2 857.0 857.3 859.1 635.4 637.6 638.0 639.7 641.7 14152.0 14182.2 14189.9 14276.7 14278.1 12876.5 13147.1 13232.2 13320.9 13465.0 11412.7 11426.7 11507.5 11608.8 11621.5 3778.5 3796.5 3799.4 3910.8 3950.2 75416.0 76931.0 77327.2 77672.6 79191.6 10078.1 10133.9 10189.6 10438.4 10640.5 20599.2 20635.1 20667.9 20719.8 21156.8 7894.3 7970.2 8221.6 8492.4 8766.7 3878.0 3882.2 3967.0 4316.9 4365.9 3539.7 3657.8 3729.2 3731.2 3746.9 597.4 610.4 619.7 620.5 639.9 595.5 643.2 731.7 733.2 735.0 9088.4 9372.0 9484.9 9571.3 9579.9 670.0 702.5 705.5 712.6 738.5 4500.5 4577.3 4731.5 4770.2 4842.2 116082.0 118370.0 120244.0 120461.0 125103.0 96507.5 99676.5 100593.0 104849.5 105451.5 88020.0 88231.0 90786.5 93704.0 95457.5 8907.1 9138.5 9303.9 9324.7 9371.3 51543.0 53351.7 53721.2 54634.7 55082.0 44518.0 45400.9 47578.8 77474.0 81315.0 12092.4 12098.5 12286.6 12404.8 12698.3 13632.5 13781.9 14386.8 14763.9 14961.9 12497.6 13352.8 13469.9 13583.5 14236.1 12706.5 13207.9 13407.6 13454.7 13548.3 12325.6 12644.6 12939.0 13558.4 13581.3 10817.7 10929.3 10931.6 10933.6 11594.6 11007.3 11260.6 11394.5 11411.6 11525.9 06:17:18 INFO - PROCESS | 5715 | -------- Summary: end -------- 06:17:18 INFO - PROCESS | 5715 | 06:17:19 INFO - TEST-INFO | 5715: exit 0 06:17:19 INFO - TEST-OK | dromaeo_css | took 1116477ms 06:17:19 INFO - TEST-START | kraken 06:17:19 INFO - operating with platform_type : linux_ 06:17:19 INFO - Initialising browser for kraken test... 06:17:19 INFO - TEST-INFO | started process 6072 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_jnbuv/profile http://localhost:49566/getInfo.html) 06:17:23 INFO - PROCESS | 6072 | __metrics Screen width/height:1600/1200 06:17:23 INFO - PROCESS | 6072 | colorDepth:24 06:17:23 INFO - PROCESS | 6072 | Browser inner width/height: 1024/697 06:17:23 INFO - PROCESS | 6072 | __metrics 06:17:24 ERROR - PROCESS | 6072 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3087: TypeError: this.tabs is undefined 06:17:25 INFO - TEST-INFO | 6072: exit 0 06:17:25 INFO - Browser initialized. 06:17:25 INFO - Running cycle 1/1 for kraken test... 06:17:25 INFO - TEST-INFO | started process 6194 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_jnbuv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:17:37 INFO - PROCESS | 6194 | RSS: Main: 183123968 06:17:37 INFO - PROCESS | 6194 | 06:17:40 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49566/tests/kraken/driver.html?testName=audio-beat-detection) 06:17:41 INFO - PROCESS | 6194 | RSS: Main: 196907008 06:17:41 INFO - PROCESS | 6194 | 06:17:43 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49566/tests/kraken/driver.html?testName=audio-dft) 06:17:44 INFO - PROCESS | 6194 | RSS: Main: 194568192 06:17:44 INFO - PROCESS | 6194 | 06:17:47 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49566/tests/kraken/driver.html?testName=audio-fft) 06:17:47 INFO - PROCESS | 6194 | RSS: Main: 191328256 06:17:47 INFO - PROCESS | 6194 | 06:17:49 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49566/tests/kraken/driver.html?testName=audio-oscillator) 06:17:50 INFO - PROCESS | 6194 | RSS: Main: 192073728 06:17:50 INFO - PROCESS | 6194 | 06:17:52 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49566/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:17:53 INFO - PROCESS | 6194 | RSS: Main: 192208896 06:17:53 INFO - PROCESS | 6194 | 06:17:56 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49566/tests/kraken/driver.html?testName=imaging-darkroom) 06:17:57 INFO - PROCESS | 6194 | RSS: Main: 192135168 06:17:57 INFO - PROCESS | 6194 | 06:18:00 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49566/tests/kraken/driver.html?testName=imaging-desaturate) 06:18:01 INFO - PROCESS | 6194 | RSS: Main: 192344064 06:18:01 INFO - PROCESS | 6194 | 06:18:03 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49566/tests/kraken/driver.html?testName=json-parse-financial) 06:18:04 INFO - PROCESS | 6194 | RSS: Main: 192192512 06:18:04 INFO - PROCESS | 6194 | 06:18:06 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49566/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:18:06 INFO - PROCESS | 6194 | RSS: Main: 192495616 06:18:06 INFO - PROCESS | 6194 | 06:18:08 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49566/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:18:09 INFO - PROCESS | 6194 | RSS: Main: 192507904 06:18:09 INFO - PROCESS | 6194 | 06:18:11 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49566/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:18:11 INFO - PROCESS | 6194 | RSS: Main: 192430080 06:18:11 INFO - PROCESS | 6194 | 06:18:14 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49566/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:18:15 INFO - PROCESS | 6194 | RSS: Main: 192417792 06:18:15 INFO - PROCESS | 6194 | 06:18:18 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49566/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:18:18 INFO - PROCESS | 6194 | RSS: Main: 192843776 06:18:18 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | Cycle 1(1): loaded http://localhost:49566/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49566/tests/kraken/driver.html?testName=ai-astar) 06:18:20 INFO - PROCESS | 6194 | RSS: Main: 193748992 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | __start_tp_report 06:18:20 INFO - PROCESS | 6194 | _x_x_mozilla_page_load 06:18:20 INFO - PROCESS | 6194 | _x_x_mozilla_page_load_details 06:18:20 INFO - PROCESS | 6194 | |i|pagename|runs| 06:18:20 INFO - PROCESS | 6194 | |0;ai-astar;106;115;114;112;113;113;113;113;112;112 06:18:20 INFO - PROCESS | 6194 | |1;audio-beat-detection;171;123;133;168;131;126;126;126;150;124 06:18:20 INFO - PROCESS | 6194 | |2;audio-dft;163;165;167;174;162;164;162;165;165;161 06:18:20 INFO - PROCESS | 6194 | |3;audio-fft;76;76;76;108;77;76;75;75;109;75 06:18:20 INFO - PROCESS | 6194 | |4;audio-oscillator;83;81;124;83;85;82;105;85;82;107 06:18:20 INFO - PROCESS | 6194 | |5;imaging-gaussian-blur;118;118;118;118;117;119;117;118;118;119 06:18:20 INFO - PROCESS | 6194 | |6;imaging-darkroom;148;147;148;148;147;149;146;148;147;148 06:18:20 INFO - PROCESS | 6194 | |7;imaging-desaturate;87;85;85;86;86;85;86;85;85;84 06:18:20 INFO - PROCESS | 6194 | |8;json-parse-financial;57;54;57;54;55;56;56;56;57;54 06:18:20 INFO - PROCESS | 6194 | |9;json-stringify-tinderbox;59;59;60;60;61;60;60;59;60;60 06:18:20 INFO - PROCESS | 6194 | |10;stanford-crypto-aes;82;82;82;81;81;81;81;82;82;82 06:18:20 INFO - PROCESS | 6194 | |11;stanford-crypto-ccm;134;138;131;139;136;133;139;144;173;143 06:18:20 INFO - PROCESS | 6194 | |12;stanford-crypto-pbkdf2;172;170;173;168;173;171;175;171;171;169 06:18:20 INFO - PROCESS | 6194 | |13;stanford-crypto-sha256-iterative;67;72;70;65;74;66;70;67;69;67 06:18:20 INFO - PROCESS | 6194 | __end_tp_report 06:18:20 INFO - PROCESS | 6194 | __start_cc_report 06:18:20 INFO - PROCESS | 6194 | _x_x_mozilla_cycle_collect,805 06:18:20 INFO - PROCESS | 6194 | __end_cc_report 06:18:20 INFO - PROCESS | 6194 | __startTimestamp1476710300771__endTimestamp 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | ------- Summary: start ------- 06:18:20 INFO - PROCESS | 6194 | Number of tests: 14 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#0] ai-astar Cycles:10 Average:112.30 Median:113.00 stddev:2.41 (2.1%) stddev-sans-first:1.00 06:18:20 INFO - PROCESS | 6194 | Values: 106.0 115.0 114.0 112.0 113.0 113.0 113.0 113.0 112.0 112.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#1] audio-beat-detection Cycles:10 Average:137.80 Median:132.00 stddev:18.44 (14.0%) stddev-sans-first:15.14 06:18:20 INFO - PROCESS | 6194 | Values: 171.0 123.0 133.0 168.0 131.0 126.0 126.0 126.0 150.0 124.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#2] audio-dft Cycles:10 Average:164.80 Median:165.00 stddev:3.71 (2.2%) stddev-sans-first:3.87 06:18:20 INFO - PROCESS | 6194 | Values: 163.0 165.0 167.0 174.0 162.0 164.0 162.0 165.0 165.0 161.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#3] audio-fft Cycles:10 Average:82.30 Median:76.00 stddev:13.82 (18.2%) stddev-sans-first:14.47 06:18:20 INFO - PROCESS | 6194 | Values: 76.0 76.0 76.0 108.0 77.0 76.0 75.0 75.0 109.0 75.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:82.50 stddev:14.90 (18.1%) stddev-sans-first:15.47 06:18:20 INFO - PROCESS | 6194 | Values: 83.0 81.0 124.0 83.0 85.0 82.0 105.0 85.0 82.0 107.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 06:18:20 INFO - PROCESS | 6194 | Values: 118.0 118.0 118.0 118.0 117.0 119.0 117.0 118.0 118.0 119.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 06:18:20 INFO - PROCESS | 6194 | Values: 148.0 147.0 148.0 148.0 147.0 149.0 146.0 148.0 147.0 148.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:85.50 stddev:0.84 (1.0%) stddev-sans-first:0.67 06:18:20 INFO - PROCESS | 6194 | Values: 87.0 85.0 85.0 86.0 86.0 85.0 86.0 85.0 85.0 84.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:56.00 stddev:1.26 (2.3%) stddev-sans-first:1.24 06:18:20 INFO - PROCESS | 6194 | Values: 57.0 54.0 57.0 54.0 55.0 56.0 56.0 56.0 57.0 54.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.63 (1.1%) stddev-sans-first:0.60 06:18:20 INFO - PROCESS | 6194 | Values: 59.0 59.0 60.0 60.0 61.0 60.0 60.0 59.0 60.0 60.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:82.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 06:18:20 INFO - PROCESS | 6194 | Values: 82.0 82.0 82.0 81.0 81.0 81.0 81.0 82.0 82.0 82.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#11] stanford-crypto-ccm Cycles:10 Average:141.00 Median:139.00 stddev:11.98 (8.6%) stddev-sans-first:12.44 06:18:20 INFO - PROCESS | 6194 | Values: 134.0 138.0 131.0 139.0 136.0 133.0 139.0 144.0 173.0 143.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:2.06 (1.2%) stddev-sans-first:2.17 06:18:20 INFO - PROCESS | 6194 | Values: 172.0 170.0 173.0 168.0 173.0 171.0 175.0 171.0 171.0 169.0 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.50 stddev:2.83 (4.1%) stddev-sans-first:2.93 06:18:20 INFO - PROCESS | 6194 | Values: 67.0 72.0 70.0 65.0 74.0 66.0 70.0 67.0 69.0 67.0 06:18:20 INFO - PROCESS | 6194 | -------- Summary: end -------- 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | 06:18:20 INFO - PROCESS | 6194 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000A,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 06:18:20 INFO - PROCESS | 6194 | 06:18:21 INFO - TEST-INFO | 6194: exit 0 06:18:21 INFO - TEST-OK | kraken | took 62730ms 06:18:21 INFO - SUITE-END | took 1179s 06:18:21 INFO - Completed test suite (00:19:39) 06:18:21 INFO - javascript benchmark 06:18:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7103.03630403504, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2880.9423811523757, 2901.3326934804995, 2901.4922388581995, 2991.9850400747987, 3020.9697903020965, 5153.915373737976, 5170.198619214023, 5201.791928322863, 5225.059489291931, 5305.8938821223555, 5228.555572776309, 5234.528892399683, 5314.5748340132695, 5317.042932272199, 5411.648242864211, 4782.115308667899, 4870.4885986971385, 4871.269309603553, 4875.926861097087, 4939.456659767423, 4817.470078291385, 4829.396325459317, 4898.730569818658, 4905.141600219965, 4968.577670897978, 4685.812567497296, 4822.493638167977, 4864.0, 4888.657793954425, 4896.657233993622, 4677.7193368398, 4710.3405523226775, 4726.0, 4729.361536192604, 4749.7387643679585, 4661.650376221797, 4711.976440117812, 4756.9286460703115, 4765.69023013503, 4775.5463230993, 5242.004019236333, 5254.028004819121, 5261.394939581959, 5276.366835979668, 5347.037533244014, 5493.807716729935, 5556.805511807067, 5591.916121258185, 5607.355154157283, 5616.269884914976, 5609.803656872031, 5644.604877658525, 5660.716964151817, 5668.866226754665, 5697.373288938214, 5209.817656382009, 5295.549878260353, 5306.310179676656, 5314.7874085036165, 5366.114591092504, 5685.090385538377, 5741.282339707536, 5771.105478650816, 5788.18965344852, 5872.588918775645, 5517.0, 5576.0, 5580.358258800209, 5581.134924086773, 5583.134614134816, 5646.35066967304, 5653.434656534314, 5656.773729050792, 5658.34928983164, 5658.688772117573, 5461.371942226615, 5543.695096769717, 5547.944520554743, 5558.166275058774, 5623.550115990711, 5606.383297837235, 5635.267415235993, 5639.8590035249445, 5640.971795140998, 5641.266635337462, 4385.890352741143, 4389.517153113155, 4393.494748104009, 4393.714408563433, 4397.076613911115, 3821.082940094357, 3863.2273545291055, 3899.922001559953, 3903.316919539069, 3903.707221958308, 5335.653182543122, 5394.460553944653, 5433.429489903582, 5455.318085239345, 5499.285092937893, 5709.514691251207, 5714.228579141846, 5723.713814309268, 5729.140628905698, 5754.798582049608, 5300.655457395257, 5441.239178508801, 5447.782088716486, 5458.727063646802, 5475.534579560782, 4857.295692124622, 4860.246661767432, 4913.213885778258, 4924.916518365953, 4984.476629953875, 5875.823725288248, 5879.0, 5886.3525012247765, 5889.734961926723, 5891.086881533369, 5693.117566777156, 5695.7436915338085, 5699.9145012825675, 5703.401142879938, 5711.029125048669, 5618.606697531133, 5694.316681998187, 5711.514521265739, 5728.8567785804025, 5757.683327417032, 5408.621396502207, 5514.696691681996, 5526.336839579276, 5527.198556209247, 5585.385607583244, 5560.805371811967, 5606.943930560806, 5609.775608975595, 5619.80330688424, 5620.213170156099, 5461.15352120422, 5473.452654734495, 5557.305336832896, 5559.916601251065, 5567.832965011056, 5502.147167189092, 5538.584606154474, 5546.889062218814, 5613.607047506635, 5624.831255062355, 5460.781568737365, 5511.944880551304, 5512.090505066619, 5543.833684989457, 5545.306836645419, 5428.294321738149, 5494.36814766307, 5615.157726341082, 5628.549716022791, 5688.800891968761, 5356.491133342326, 5386.48828361305, 5410.78356865721, 5417.674939503642, 5467.371252306036], "value": 5206.698544683196, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.8492549474388, 569.8119620525227, 572.2189211725995, 578.3262499188446, 599.7750843433712, 45026.0, 46078.5392146078, 46559.06881862365, 46656.30015549761, 46689.0, 42833.35749963753, 43390.13219735603, 43469.34795978063, 43668.781656091676, 43832.78083609585, 8772.0, 8937.329700272474, 8940.15068568485, 8951.060138685409, 8957.77605559863, 8697.913020869773, 8762.430442021248, 8791.868121978176, 8830.690925817598, 8842.646294148259, 8805.911940880573, 8819.338549608772, 8878.0, 8896.8665470018, 8907.599158037903, 8826.161514656129, 8848.955755221215, 8850.557472126433, 8851.026387097414, 8854.645814167425, 8770.693025744133, 8782.297416206751, 8795.428297160664, 8840.160184782435, 8847.867281990775, 40360.59639403598, 40506.1898762026, 40611.593884061076, 40826.38760418596, 40836.0, 3411.232472693649, 3411.567141800425, 3428.879989200366, 3489.790612563229, 3626.8730594429067, 30265.848670756506, 30358.0, 30557.38885222283, 31096.86169310996, 31616.525752113736, 4291.270484017725, 4339.761313127777, 4396.868093957187, 4472.150291444647, 4547.499775024745, 306351.4682426596, 306466.0, 307228.0, 307389.0, 308018.0, 53251.0, 53417.0, 53421.73289133607, 53466.465335346926, 53535.46464535305, 55562.72218638962, 55760.0, 55912.0, 56056.439435605935, 56120.719396403576, 14731.484398046017, 14855.628609284639, 14893.0, 14912.105273683397, 14966.952313337963, 10712.517936692868, 10717.249792514449, 10719.517621707042, 10755.462226888625, 10782.137429005661, 14004.71990560183, 15155.0, 15155.318010689545, 15315.540533784004, 15570.610734731723, 5454.554498291429, 5704.919343554434, 5778.55536115971, 5857.765689372377, 5945.554083443759, 945.7257395355269, 955.4840386191518, 1031.118393773328, 1032.7882784029257, 1055.3298655353751, 30032.14694604009, 30901.227469313446, 31247.531287030713, 31308.686913131034, 31419.685803141678, 1068.0654427376046, 1083.8482612434266, 1088.7604726960055, 1096.8464414981909, 1115.6151127860876, 15612.08219410882, 16212.918935405483, 16288.26702798377, 16362.509124726277, 16523.66952660964, 440893.0, 447052.0, 447904.0, 448206.0, 451369.0, 54619.0, 54912.45087549153, 54951.72524137354, 55120.72439637776, 55235.723821380634, 1303.9608811735663, 1318.7032917593656, 1334.546254273571, 1337.197681391177, 1339.1228745171927, 28678.569821452278, 30082.0, 30158.048273657536, 30425.695743043172, 31041.379172416877, 47882.521174787806, 47884.04231915412, 47934.76032619815, 48249.0, 48488.0, 403255.0, 407285.0, 407584.0, 407984.0, 411083.0, 37385.81307093447, 37546.249075018895, 37812.81093594514, 37889.62110378861, 38249.808750956065, 44418.77790611026, 45218.0, 45283.773581131885, 45558.08883822371, 45869.77065114653, 38314.0, 38350.424743629424, 38711.2257754849, 39687.40468892911, 39739.60260397359, 37470.0, 38351.0, 38403.807980959915, 38731.2253754929, 38780.80609597047, 33687.32625347529, 34026.489602656475, 39478.802605986784, 40057.39913901352, 41666.16667666569, 33682.8315858429, 35379.0, 35787.64212357843, 35915.0, 36394.81802591076, 26731.465370692866, 27079.052233171744, 27139.45721085528, 27343.589846151925, 27678.861605691844], "value": 19171.81000330546, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.72566300937314, 376.4522619588498, 386.3644305118081, 394.4261100099356, 395.20958083832335, 17091.65816683667, 19010.0, 19335.613287734253, 19503.512412189666, 19572.804271957295, 18101.366452174178, 18144.45566633, 18548.629027419443, 18581.070946452655, 18669.25322987082, 4777.877198858266, 5506.201600767887, 5753.856153596173, 5769.624974376652, 5779.306483221998, 5606.467385598362, 5696.515796157331, 5728.22668939692, 5738.167965645, 5738.540916726673, 5411.540019098381, 5605.467480589337, 5619.915701264485, 5646.604737668365, 5681.801136960207, 5561.221428999943, 5577.358603760579, 5621.747021384027, 5624.21261023457, 5641.887162256752, 4825.95174048262, 4979.651424400294, 4995.400551933792, 5012.548870601627, 5016.924746128811, 21841.344759657237, 22112.33662990113, 22230.0, 22322.77677223223, 22459.43851403728, 2274.510980139278, 2328.336424119118, 2354.976450235493, 2643.378805980593, 2680.0, 13750.793738093937, 14062.718745625132, 14213.715725685428, 14314.0, 14342.784858227134, 1832.2762508808946, 1888.745019422388, 1894.194967138974, 1938.709193620954, 2005.2480319880044, 73609.26390736077, 73847.82305747428, 74715.25284747138, 75491.62254188694, 77368.0, 9695.321327507148, 9745.805083898282, 9805.921348651642, 9825.213982881352, 9952.601895924226, 13556.254406007763, 13559.728805423836, 13591.320433978459, 13679.726405471834, 13710.588682339545, 7185.173705023989, 7281.4538909582, 7365.9631701841145, 7511.812204694927, 7531.924680753232, 7053.294670533009, 7095.290470952967, 7222.674979625929, 7285.162206346232, 7335.4131669466315, 6158.815235542851, 6305.243370795534, 6315.147455093595, 6325.430711236011, 6345.206849143857, 1819.3541292841117, 1829.5426143464133, 1861.1345724238295, 1865.8356306684182, 1890.2250077468173, 913.4062859141478, 1013.2501948558014, 1047.8794938582162, 1052.7999680060764, 1119.2487888911621, 17993.2802687891, 19226.615467690848, 19326.32357867496, 19444.902775486033, 19762.90118549398, 981.617169303972, 992.4987881120132, 995.1044060345747, 1000.3797645459862, 1055.1611468882256, 10170.338927969658, 10970.396628185526, 10974.451277436096, 10978.231523793258, 11052.447377631086, 395264.0, 406618.0, 421825.0, 422133.0, 423649.0, 75807.0, 76339.61830190924, 77723.61138194273, 78386.26780768989, 79144.0, 1027.4862568715641, 1039.875214974208, 1041.8020576090519, 1045.6392544572263, 1048.339546085961, 16336.0, 16713.582160446087, 16827.91586042062, 17443.30226790914, 17818.821811781716, 28462.57306140451, 39247.89777328929, 39693.0, 40024.799256022365, 40085.0, 55856.72071639616, 56040.0, 56235.437645624654, 56669.71665141648, 57809.71095144498, 7815.843683126419, 7853.410994175346, 8005.279524842792, 8126.390520710852, 8247.762835574711, 12398.690032748893, 12525.0, 13019.804702929652, 13334.666633334244, 13492.392842322315, 11065.723356916142, 11459.140564457532, 11483.827742584035, 11494.597689080842, 11504.712382190512, 10038.447885366375, 11347.205695601559, 11573.537058517564, 11598.594049208237, 11682.591109311134, 10413.739656508647, 10616.84074738895, 10696.144308455461, 10700.678979630624, 11040.889591103985, 7978.601069946363, 8110.756677299691, 8253.79365515867, 8257.180803615656, 8625.69810056645, 9638.614455421985, 10372.481375931324, 10401.115905148146, 10456.0, 10895.291806032583], "value": 8956.167281233484, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1445.6024593236862, 1502.872255858252, 1627.894186877853, 1768.1071059115145, 1777.2535535075267, 7633.084029916417, 7897.960510197456, 8434.156584341563, 9102.590383432753, 9133.817323653522, 8517.574121293927, 8834.469931804097, 8841.867371989425, 9119.680811171611, 9131.132542408477, 2167.1764729402803, 2203.977960220401, 2217.124235926808, 2217.2793842001333, 2226.6882636430832, 2197.8571392859412, 2210.6462965925457, 2213.0926320208637, 2221.677856710776, 2236.9552608947893, 2186.6501359782437, 2187.0486338442747, 2188.321620297705, 2201.9889900550556, 2269.614165591845, 2217.868886867701, 2218.7892150245702, 2227.2538699535676, 2230.02993697742, 2237.004532982823, 2219.889005549716, 2249.460129568908, 2251.8761468119246, 2259.9322020339414, 2263.1852533088077, 8589.484630922103, 8662.047174810767, 8671.046184919654, 9095.681651142178, 9183.357164998453, 5279.973600132013, 5370.3287089113865, 5377.81177658784, 5399.325084364455, 5407.945920540784, 3406.2165701888457, 3537.663921927413, 3665.7067434605433, 3669.7064234861145, 3708.8331025103935, 1087.6247694545368, 1097.6597254851022, 1108.983365249522, 1123.8482804821408, 1137.2380505061628, 12443.191192572544, 12467.314297713621, 12484.563040293546, 12499.062570307264, 12516.561920332744, 4574.519675434031, 4627.514111018295, 4805.37530121089, 4832.661713680009, 4857.927131093036, 10508.789824203473, 10509.9474502627, 10514.684559463229, 10534.36793792375, 10538.947305263424, 5418.376886658085, 5430.266913966643, 5435.429279925551, 5437.592180586472, 5457.399686034533, 4290.549492303326, 4698.882527936829, 4876.268559716071, 4955.578775804025, 4990.90018199634, 3800.9429858552144, 3875.9224815504094, 3886.941695874564, 3934.6655534279907, 4043.575424580377, 1249.7375551134364, 1262.3561983388538, 1276.144982861485, 1279.654493286826, 1287.76820172368, 878.3456325037888, 892.1168043636753, 897.3852910756153, 934.2619330728784, 944.0, 5640.605157639008, 5733.0, 5801.071828507503, 5815.0, 5824.070563349358, 948.5873644964324, 974.1768205866032, 977.4086677560116, 987.9357841740264, 1012.3976234140822, 3980.7611543307494, 4230.259704551691, 4239.130978149472, 4293.720908140961, 4340.283853164256, 10927.743309519507, 11259.943700281447, 11274.774504509864, 11284.0, 11304.547818087349, 10945.343279403261, 11099.889001110047, 11159.94420027911, 11263.592050993626, 11310.434478276053, 8302.501849889026, 8307.37694672902, 8352.039515455801, 8353.498790072494, 8363.874541881876, 5757.193992841089, 5817.825465236049, 5883.852903677443, 5921.289445266596, 6004.969975150097, 9993.800123997626, 10137.746556336151, 10169.796604068026, 10170.644027459299, 10294.742631433974, 9910.405375677194, 10561.735956601147, 10614.469276535989, 10620.309679870783, 10626.990435908576, 6451.258105317948, 6563.3764792344655, 7148.28517148281, 7161.176464706626, 7307.086614173229, 8400.41197116196, 8790.560471976247, 8830.735077947671, 8832.867506987272, 8876.0, 7782.649780759766, 7934.246246606564, 7934.404919630935, 7974.880376794236, 8058.073321568095, 7334.816629584303, 7523.510971786816, 7598.12621548529, 7600.619969001638, 7626.923730762622, 7195.280471952763, 7198.604076775828, 7205.963970180115, 7241.601711905685, 7244.60154691476, 4682.719036857799, 4815.879603009953, 4904.705717656952, 4920.360353154067, 5043.470435604356, 4944.307796908508, 4985.850424487271, 4997.20044792846, 5062.620303477328, 5124.385073791169], "value": 4628.704096878913, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.15319987035974, 311.156765166399, 316.0943895738708, 331.9983400082999, 335.4649334311772, 5315.681059136455, 5418.485243901823, 5540.531759083846, 5543.417941116185, 5573.411577700351, 5230.320058392404, 5344.305240318753, 5408.864138530904, 5409.836885069709, 5413.891722165564, 4198.916021679564, 4237.660987121023, 4240.936385954213, 4260.723053001545, 4260.7656578888145, 4105.774182419966, 4208.284591619432, 4219.556946520617, 4235.0, 4265.445492086024, 4185.979070104645, 4192.5116583612835, 4195.328747400401, 4196.874093777176, 4199.55904630014, 4193.475815523059, 4210.936835947463, 4213.43118678979, 4226.175895700355, 4242.8727138185905, 3706.8188944243357, 3753.60587138352, 3767.3030489359558, 3769.3968964965475, 3778.4332350147697, 5244.265802787613, 5274.3913106502505, 5276.0, 5284.471552844723, 5315.335583052119, 4854.441739200002, 4865.321464094882, 4888.169011268093, 4891.0, 4894.045661096087, 5308.787648494055, 5616.185653080281, 5662.207290979266, 5664.716764161775, 5728.2790674429725, 4017.8593749218635, 4026.6376026157495, 4047.3321901886447, 4048.9067951653183, 4056.371262454324, 5939.168516407706, 5983.7434138830895, 5997.730102145414, 6049.546284028672, 6061.8181454556, 4029.7030692505577, 4183.937240941388, 4184.267753143188, 4186.162767446523, 4187.790610469525, 4169.187008533307, 4178.206140833232, 4181.393697913785, 4188.6649068074485, 4199.501296728442, 4847.345608342899, 4848.636352273594, 4868.294097355934, 4875.975620121948, 4882.12121818069, 5615.803446879339, 5785.334686511105, 5841.474267315962, 5845.707714614252, 5857.47282744555, 1411.6682579593787, 1418.6240646228757, 1423.3381477612959, 1429.492530151802, 1431.3272761801936, 874.9343799215085, 887.3655336434481, 914.9862752058724, 928.3362395886838, 930.2743859789375, 4862.7325497098, 4871.561559459666, 4875.609951203895, 4889.828855990023, 4931.50684931504, 5139.715071232192, 5159.458256883048, 5176.482351764794, 5187.896242075138, 5192.234640222267, 4698.788554515055, 4780.163471392492, 4859.975700121548, 4897.877553061202, 4918.532739389752, 2722.9108356657493, 2750.752432281104, 2752.3119220194953, 2752.8575641108714, 2757.7518023377593, 5245.449227831099, 5271.367435907716, 5298.675331167208, 5306.495882891119, 5358.3837858645975, 5089.9745501273, 5228.372595288513, 5257.053730328577, 5273.705937917019, 5293.676580854786, 5195.960807838372, 5219.138842091088, 5257.76340064698, 5266.97366513165, 5307.389650190277, 5087.949120508895, 5119.2100305334425, 5121.539061484485, 5135.6918584885025, 5142.357205349332, 4713.222318317439, 5027.4218464877, 5062.645614807076, 5063.3417655704525, 5088.033273678137, 5201.023611027937, 5306.469353064663, 5325.707086110301, 5348.679079255257, 5356.5714742821265, 3728.179800443898, 3828.234353129441, 3964.988927823502, 3996.420519024783, 4055.9594404055583, 5776.942230577809, 5779.624324418899, 5787.160861675117, 5803.970980145073, 5807.796727114531, 5620.690862002465, 5686.57350698691, 5690.630109042899, 5748.0, 5780.94219057804, 5667.404922483245, 5679.9148012779015, 5687.744051517774, 5724.713764311851, 5752.0, 5614.438556144516, 5648.15277708347, 5649.519790817826, 5654.660720356792, 5714.714264286686, 5594.356648985256, 5728.968785618628, 5734.569907256889, 5749.885002300014, 5802.970985145047, 5526.171074338881, 5564.972175139098, 5601.327840658984, 5605.5515558756015, 5655.1517272409465], "value": 4173.497711356568, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.1851980801276, 741.7033186725309, 790.6955822008525, 810.9472884262523, 847.2882778466087, 14978.850211497895, 16650.417235396762, 16708.74936875948, 16754.83245167548, 16758.245878935446, 15075.547733567983, 15312.157831319273, 15359.692806143898, 15390.923045384785, 15416.3833446662, 805.3798575097186, 807.9474834135792, 808.0989696488402, 810.5298926622545, 813.2924355810453, 814.340384288728, 817.1991448380561, 818.4516374029384, 819.0171793847406, 822.3544517553721, 861.8965724113115, 866.2939704141137, 867.3884911137633, 867.4274978514181, 867.6312567158964, 854.3378881366959, 855.2217482091298, 857.0187135729554, 857.3098655582254, 859.1151114352195, 635.4122436746038, 637.6238019568477, 637.9681015949184, 639.6641763074376, 641.7497176101324, 14152.00935934485, 14182.219977901212, 14189.929050354682, 14276.714465710731, 14278.143311401349, 12876.484940602364, 13147.14543554666, 13232.206067635972, 13320.866791332059, 13465.0, 11412.71468213293, 11426.714332141762, 11507.539698412054, 11608.825867611993, 11621.53513859453, 3778.452124441968, 3796.52543432071, 3799.4300854871713, 3910.804459777028, 3950.170464202521, 75416.0, 76931.0, 77327.22672773256, 77672.61163694145, 79191.60404198, 10078.143357814668, 10133.898661013296, 10189.592416303265, 10438.37369757817, 10640.467976601294, 20599.176032958814, 20635.071421786055, 20667.896660516602, 20719.792802071785, 21156.78843211548, 7894.250046245597, 7970.242826931432, 8221.630026648816, 8492.40553161285, 8766.693165739169, 3877.96122038776, 3882.2235552889533, 3967.0, 4316.942349124484, 4365.934510982338, 3539.7168226541817, 3657.835397407123, 3729.21686445844, 3731.2164445466215, 3746.9437958430644, 597.3548567547039, 610.4079043327964, 619.6746707978348, 620.4973971083347, 639.9104125422444, 595.5265563876728, 643.2474005413677, 731.7109741652124, 733.1934871641153, 734.9522281051715, 9088.411725629392, 9371.953140234391, 9484.857727134098, 9571.28215383849, 9579.9042009579, 670.0284587348365, 702.4731451411442, 705.4955706669654, 712.5938215217276, 738.4756822655975, 4500.527444618333, 4577.3362862384765, 4731.534260772531, 4770.236762118045, 4842.225243960949, 116082.0, 118370.0, 120244.0, 120461.0, 125103.0, 96507.51746241364, 99676.50161749145, 100593.0, 104849.47575262075, 105451.4727426358, 88020.0, 88231.0, 90786.54606726924, 93704.0, 95457.52271238738, 8907.10928907104, 9138.451692898447, 9303.906960930575, 9324.694542764155, 9371.297152713438, 51543.0, 53351.733241333546, 53721.19418208808, 54634.726826365615, 55082.0, 44518.0, 45400.86497837581, 47578.76210618925, 77474.0, 81315.0, 12092.39538023113, 12098.455569499218, 12286.569970051005, 12404.81392779127, 12698.301593412081, 13632.454701812214, 13781.86218137846, 14386.784198237245, 14763.852361476247, 14961.850381496046, 12497.56258530947, 13352.799708004582, 13469.865301346861, 13583.45666173342, 14236.145831250158, 12706.491740330282, 13207.867921321049, 13407.597772066854, 13454.730905382034, 13548.254845983565, 12325.568605098779, 12644.557440489538, 12939.0, 13558.389872455566, 13581.253031083384, 10817.675469735921, 10929.344239345664, 10931.617393391192, 10933.617323393642, 11594.594189203337, 11007.339559626447, 11260.605878794202, 11394.48724807369, 11411.60059397917, 11525.942370288094], "value": 7435.546214652444, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1517.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 114.0, 112.0, 113.0, 113.0, 113.0, 113.0, 112.0, 112.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 123.0, 133.0, 168.0, 131.0, 126.0, 126.0, 126.0, 150.0, 124.0], "value": 137.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 167.0, 174.0, 162.0, 164.0, 162.0, 165.0, 165.0, 161.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 108.0, 77.0, 76.0, 75.0, 75.0, 109.0, 75.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 124.0, 83.0, 85.0, 82.0, 105.0, 85.0, 82.0, 107.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 117.0, 118.0, 118.0, 119.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 148.0, 147.0, 149.0, 146.0, 148.0, 147.0, 148.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 86.0, 86.0, 85.0, 86.0, 85.0, 85.0, 84.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 54.0, 57.0, 54.0, 55.0, 56.0, 56.0, 56.0, 57.0, 54.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 59.0, 60.0, 60.0, 61.0, 60.0, 60.0, 59.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 82.0, 81.0, 81.0, 81.0, 81.0, 82.0, 82.0, 82.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 131.0, 139.0, 136.0, 133.0, 139.0, 144.0, 173.0, 143.0], "value": 141.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 170.0, 173.0, 168.0, 173.0, 171.0, 175.0, 171.0, 171.0, 169.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 70.0, 65.0, 74.0, 66.0, 70.0, 67.0, 69.0, 67.0], "value": 68.7, "unit": "score"}]}]} 06:18:22 INFO - Return code: 0 06:18:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:18:22 ERROR - # TBPL SUCCESS # 06:18:22 INFO - Running post-action listener: _resource_record_post_action 06:18:22 INFO - [mozharness: 2016-10-17 13:18:22.093143Z] Finished run-tests step (success) 06:18:22 INFO - Running post-run listener: _resource_record_post_run 06:18:22 INFO - Total resource usage - Wall time: 1196s; CPU: 13.0%; Read bytes: 536576; Write bytes: 390848512; Read time: 160; Write time: 297592 06:18:22 INFO - TinderboxPrint: CPU usage
13.5% 06:18:22 INFO - TinderboxPrint: I/O read bytes / time
536,576 / 160 06:18:22 INFO - TinderboxPrint: I/O write bytes / time
390,848,512 / 297,592 06:18:22 INFO - TinderboxPrint: CPU idle
8,250.9 (86.5%) 06:18:22 INFO - TinderboxPrint: CPU user
1,222.3 (12.8%) 06:18:22 INFO - TinderboxPrint: Swap in / out
0 / 0 06:18:22 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103501824; Read time: 0; Write time: 84748 06:18:22 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 532480; Write bytes: 286879744; Read time: 148; Write time: 212844 06:18:22 INFO - Running post-run listener: _upload_blobber_files 06:18:22 INFO - Blob upload gear active. 06:18:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:18: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 06:18: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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:18: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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:18:23 INFO - (blobuploader) - INFO - Open directory for files ... 06:18:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:18:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:18:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:24 INFO - (blobuploader) - INFO - Done attempting. 06:18:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:18:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:18:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:26 INFO - (blobuploader) - INFO - Done attempting. 06:18:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:18:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:18:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:18:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:18:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:18:33 INFO - (blobuploader) - INFO - Done attempting. 06:18:33 INFO - (blobuploader) - INFO - Iteration through files over. 06:18:33 INFO - Return code: 0 06:18:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:18:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:18:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f548e7b6403758ba7bf40547a06d45583f00b5a757b9c68f428675cb44337fba24b8f0c7974e08b1f7429ed47b4cd308706832d0f80046375e20d51467b85f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a919f3902e50d3041d723e2c75e14dca87b746ca5a9c41f1543bfa14abc92edb67b60ba294404c7a4849f11232decef23359f01da0cfee28b64efcfde38c711", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/388f18e806b374b0c646cd377e338b97b124b8b03ab4369563622c027708f8c3fdb8ff7278b94a9bc6b7251a78fa0e705098b418d7986ecca9d529506cc024b8"} 06:18:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:18:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:18:33 INFO - Contents: 06:18:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f548e7b6403758ba7bf40547a06d45583f00b5a757b9c68f428675cb44337fba24b8f0c7974e08b1f7429ed47b4cd308706832d0f80046375e20d51467b85f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a919f3902e50d3041d723e2c75e14dca87b746ca5a9c41f1543bfa14abc92edb67b60ba294404c7a4849f11232decef23359f01da0cfee28b64efcfde38c711", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/388f18e806b374b0c646cd377e338b97b124b8b03ab4369563622c027708f8c3fdb8ff7278b94a9bc6b7251a78fa0e705098b418d7986ecca9d529506cc024b8"} 06:18:33 INFO - Running post-run listener: copy_logs_to_upload_dir 06:18:33 INFO - Copying logs to upload dir... 06:18:33 INFO - mkdir: /builds/slave/test/build/upload/logs 06:18:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.272677 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-10-17 06:18:33.495625) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 06:18:33.500731) ========= 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=db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726 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/Firefox/sha512/3f548e7b6403758ba7bf40547a06d45583f00b5a757b9c68f428675cb44337fba24b8f0c7974e08b1f7429ed47b4cd308706832d0f80046375e20d51467b85f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a919f3902e50d3041d723e2c75e14dca87b746ca5a9c41f1543bfa14abc92edb67b60ba294404c7a4849f11232decef23359f01da0cfee28b64efcfde38c711", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/388f18e806b374b0c646cd377e338b97b124b8b03ab4369563622c027708f8c3fdb8ff7278b94a9bc6b7251a78fa0e705098b418d7986ecca9d529506cc024b8"} build_url:https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011355 build_url: 'https://queue.taskcluster.net/v1/task/CwaPa56TTZCBRzMgInMSLw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f548e7b6403758ba7bf40547a06d45583f00b5a757b9c68f428675cb44337fba24b8f0c7974e08b1f7429ed47b4cd308706832d0f80046375e20d51467b85f3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4a919f3902e50d3041d723e2c75e14dca87b746ca5a9c41f1543bfa14abc92edb67b60ba294404c7a4849f11232decef23359f01da0cfee28b64efcfde38c711", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/388f18e806b374b0c646cd377e338b97b124b8b03ab4369563622c027708f8c3fdb8ff7278b94a9bc6b7251a78fa0e705098b418d7986ecca9d529506cc024b8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-17 06:18:33.534100) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:18:33.534525) ========= 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=db7e7c15f3ca076d53731445000001ba-1476708553.389476-2109189726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004535 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-17 06:18:33.617230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 06:18:33.617812) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-17 06:18:33.618373) ========= ========= Total master_lag: 0.21 =========