builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-088 starttime: 1494501670.39 results: success (0) revision: 86754a7acc0e12cf3c575e9867958c2bacc8f465 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:10.385821) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:10.386230) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:10.386542) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:10.407490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:10.407789) ========= 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=9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-11 04:21:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 37.6M=0s 2017-05-11 04:21:10 (37.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.172466 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:10.594316) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:10.594635) ========= 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=9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020624 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:10.644791) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:10.645117) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 86754a7acc0e12cf3c575e9867958c2bacc8f465 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 86754a7acc0e12cf3c575e9867958c2bacc8f465 --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=9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-11 04:21:10,804 truncating revision to first 12 chars 2017-05-11 04:21:10,804 Setting DEBUG logging. 2017-05-11 04:21:10,804 attempt 1/10 2017-05-11 04:21:10,804 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/86754a7acc0e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-11 04:21:11,232 unpacking tar archive at: mozilla-central-86754a7acc0e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.805323 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:11.463726) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:11.464095) ========= script_repo_revision: 86754a7acc0e12cf3c575e9867958c2bacc8f465 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:11.464562) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:11.464849) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-11 04:21:11.478795) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-05-11 04:21:11.479238) ========= /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=9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:21:11 INFO - MultiFileLogger online at 20170511 04:21:11 in /builds/slave/test 04:21:11 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 04:21:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:21:11 INFO - {'append_to_log': False, 04:21:11 INFO - 'base_work_dir': '/builds/slave/test', 04:21:11 INFO - 'blob_upload_branch': 'Firefox', 04:21:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:21:11 INFO - 'branch': 'Firefox', 04:21:11 INFO - 'buildbot_json_path': 'buildprops.json', 04:21:11 INFO - 'config_files': ('talos/linux_config.py',), 04:21:11 INFO - 'default_actions': ('clobber', 04:21:11 INFO - 'read-buildbot-config', 04:21:11 INFO - 'download-and-extract', 04:21:11 INFO - 'populate-webroot', 04:21:11 INFO - 'create-virtualenv', 04:21:11 INFO - 'install', 04:21:11 INFO - 'run-tests'), 04:21:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:21:11 INFO - 'download_minidump_stackwalk': True, 04:21:11 INFO - 'download_symbols': 'ondemand', 04:21:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:21:11 INFO - 'tooltool.py': '/tools/tooltool.py', 04:21:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:21:11 INFO - '/tools/misc-python/virtualenv.py')}, 04:21:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:21:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:21:11 INFO - 'gecko_profile': False, 04:21:11 INFO - 'gecko_profile_interval': 0, 04:21:11 INFO - 'installer_path': 'installer.exe', 04:21:11 INFO - 'log_level': 'info', 04:21:11 INFO - 'log_name': 'talos', 04:21:11 INFO - 'log_to_console': True, 04:21:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:21:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:21:11 INFO - 'opt_config_files': (), 04:21:11 INFO - 'pip_index': False, 04:21:11 INFO - 'suite': 'dromaeojs-e10s', 04:21:11 INFO - 'system_bits': '32', 04:21:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:21:11 INFO - 'title': 'talos-linux64-ix-088', 04:21:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:21:11 INFO - 'use_talos_json': True, 04:21:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:21:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:21:11 INFO - 'work_dir': 'build'} 04:21:11 INFO - [mozharness: 2017-05-11 11:21:11.741577Z] Running clobber step. 04:21:11 INFO - Running pre-action listener: _resource_record_pre_action 04:21:11 INFO - Running main action method: clobber 04:21:11 INFO - rmtree: /builds/slave/test/build 04:21:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:21:12 INFO - Running post-action listener: _resource_record_post_action 04:21:12 INFO - [mozharness: 2017-05-11 11:21:12.677788Z] Finished clobber step (success) 04:21:12 INFO - [mozharness: 2017-05-11 11:21:12.677888Z] Running read-buildbot-config step. 04:21:12 INFO - Running pre-action listener: _resource_record_pre_action 04:21:12 INFO - Running main action method: read_buildbot_config 04:21:12 INFO - Using buildbot properties: 04:21:12 INFO - { 04:21:12 INFO - "project": "", 04:21:12 INFO - "product": "firefox", 04:21:12 INFO - "who": "cbook@mozilla.com", 04:21:12 INFO - "installer_path": "public/build/target.tar.bz2", 04:21:12 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 04:21:12 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:21:12 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 04:21:12 INFO - "stage_platform": "linux64-stylo", 04:21:12 INFO - "basedir": "/builds/slave/test", 04:21:12 INFO - "buildnumber": 77, 04:21:12 INFO - "platform": "ubuntu64_hw_stylo", 04:21:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:21:12 INFO - "slavebuilddir": "test", 04:21:12 INFO - "taskId": "f2-oHXP1RSyVAPKdDR3CEg", 04:21:12 INFO - "branch": "mozilla-central", 04:21:12 INFO - "script_repo_revision": "production", 04:21:12 INFO - "revision": "86754a7acc0e12cf3c575e9867958c2bacc8f465", 04:21:12 INFO - "slavename": "talos-linux64-ix-088", 04:21:12 INFO - "repo_path": "mozilla-central" 04:21:12 INFO - } 04:21:12 INFO - Finding installer, test and symbols from parent task. 04:21:12 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f2-oHXP1RSyVAPKdDR3CEg'}, attempt #1 04:21:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f2-oHXP1RSyVAPKdDR3CEg'}, attempt #1 04:21:13 INFO - Task dependencies: PcSUnUguQIy26YLH-FWgaQ 04:21:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ'}, attempt #1 04:21:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.tar.bz2 04:21:14 INFO - Set test_url: https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/test_packages.json 04:21:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.crashreporter-symbols.zip 04:21:14 INFO - Running post-action listener: _resource_record_post_action 04:21:14 INFO - [mozharness: 2017-05-11 11:21:14.051377Z] Finished read-buildbot-config step (success) 04:21:14 INFO - [mozharness: 2017-05-11 11:21:14.051595Z] Running download-and-extract step. 04:21:14 INFO - Running pre-action listener: _resource_record_pre_action 04:21:14 INFO - Running main action method: download_and_extract 04:21:14 INFO - mkdir: /builds/slave/test/build/tests 04:21:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:14 INFO - trying https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.test_packages.json 04:21:14 INFO - Downloading https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:21:14 INFO - Downloaded 986 bytes. 04:21:14 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:21:14 INFO - Using the following test package requirements: 04:21:14 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:21:14 INFO - u'common': [u'target.common.tests.zip'], 04:21:14 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:21:14 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:21:14 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:21:14 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:21:14 INFO - u'mozbase': [u'target.common.tests.zip'], 04:21:14 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:21:14 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:21:14 INFO - u'web-platform': [u'target.common.tests.zip', 04:21:14 INFO - u'target.web-platform.tests.zip'], 04:21:14 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:21:14 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:21:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.common.tests.zip 04:21:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:21:14 INFO - Fetch https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.common.tests.zip into memory 04:21:16 INFO - Content-Length response header: 58595057 04:21:16 INFO - Bytes received: 58595057 04:21:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:21:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.common.tests.zip 04:21:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:21:26 INFO - Fetch https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.common.tests.zip into memory 04:21:27 INFO - Content-Length response header: 58595057 04:21:27 INFO - Bytes received: 58595057 04:21:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.talos.tests.zip 04:21:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:21:38 INFO - Fetch https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.talos.tests.zip into memory 04:21:39 INFO - Content-Length response header: 14409352 04:21:39 INFO - Bytes received: 14409352 04:21:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:40 INFO - trying https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.tar.bz2 04:21:40 INFO - Downloading https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:21:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:21:43 INFO - Downloaded 64566614 bytes. 04:21:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.tar.bz2 04:21:43 INFO - mkdir: /builds/slave/test/properties 04:21:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:21:43 INFO - Writing to file /builds/slave/test/properties/build_url 04:21:43 INFO - Contents: 04:21:43 INFO - build_url:https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.tar.bz2 04:21:43 INFO - Running post-action listener: _resource_record_post_action 04:21:43 INFO - Running post-action listener: set_extra_try_arguments 04:21:43 INFO - [mozharness: 2017-05-11 11:21:43.614737Z] Finished download-and-extract step (success) 04:21:43 INFO - [mozharness: 2017-05-11 11:21:43.614963Z] Running populate-webroot step. 04:21:43 INFO - Running pre-action listener: _resource_record_pre_action 04:21:43 INFO - Running main action method: populate_webroot 04:21:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:21:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:21:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:21:43 INFO - '--tppagecycles', 04:21:43 INFO - '7'], 04:21:43 INFO - 'tests': ['tsvgm']}}, 04:21:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:21:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:21:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:21:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:21:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:21:43 INFO - 'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:21:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:21:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:21:43 INFO - 'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['damp', 'tps']}, 04:21:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:21:43 INFO - 'tests': ['damp', 'tps']}, 04:21:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['dromaeo_dom']}, 04:21:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:21:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:21:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:21:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['a11yr', 04:21:43 INFO - 'ts_paint', 04:21:43 INFO - 'tpaint', 04:21:43 INFO - 'sessionrestore', 04:21:43 INFO - 'sessionrestore_no_auto_restore', 04:21:43 INFO - 'tabpaint']}, 04:21:43 INFO - 'other-e10s': {'tests': ['a11yr', 04:21:43 INFO - 'ts_paint', 04:21:43 INFO - 'tpaint', 04:21:43 INFO - 'sessionrestore', 04:21:43 INFO - 'sessionrestore_no_auto_restore', 04:21:43 INFO - 'tabpaint']}, 04:21:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:21:43 INFO - 'ts_paint', 04:21:43 INFO - 'tpaint', 04:21:43 INFO - 'sessionrestore', 04:21:43 INFO - 'sessionrestore_no_auto_restore', 04:21:43 INFO - 'tabpaint']}, 04:21:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:21:43 INFO - 'ts_paint', 04:21:43 INFO - 'tpaint', 04:21:43 INFO - 'sessionrestore', 04:21:43 INFO - 'sessionrestore_no_auto_restore', 04:21:43 INFO - 'tabpaint']}, 04:21:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['a11yr', 04:21:43 INFO - 'ts_paint', 04:21:43 INFO - 'tpaint', 04:21:43 INFO - 'sessionrestore', 04:21:43 INFO - 'sessionrestore_no_auto_restore', 04:21:43 INFO - 'tabpaint']}, 04:21:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['a11yr', 04:21:43 INFO - 'ts_paint', 04:21:43 INFO - 'tpaint', 04:21:43 INFO - 'sessionrestore', 04:21:43 INFO - 'sessionrestore_no_auto_restore', 04:21:43 INFO - 'tabpaint']}, 04:21:43 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:21:43 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:21:43 INFO - 'bloom_basic_ref']}, 04:21:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['tsvgx', 04:21:43 INFO - 'tsvgr_opacity', 04:21:43 INFO - 'tart', 04:21:43 INFO - 'tscrollx', 04:21:43 INFO - 'cart', 04:21:43 INFO - 'tsvg_static']}, 04:21:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:21:43 INFO - 'tsvgr_opacity', 04:21:43 INFO - 'tart', 04:21:43 INFO - 'tscrollx', 04:21:43 INFO - 'cart', 04:21:43 INFO - 'tsvg_static']}, 04:21:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:21:43 INFO - 'talos_options': ['--disable-e10s'], 04:21:43 INFO - 'tests': ['tp5o']}, 04:21:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:21:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:21:43 INFO - 'talos_options': ['--disable-e10s', 04:21:43 INFO - '--xperf_path', 04:21:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:43 INFO - 'tests': ['tp5n']}, 04:21:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:21:43 INFO - 'talos_options': ['--xperf_path', 04:21:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:21:43 INFO - 'tests': ['tp5n']}}, 04:21:43 INFO - 'talos.zip': {'path': '', 04:21:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:21:43 INFO - Running post-action listener: _resource_record_post_action 04:21:43 INFO - [mozharness: 2017-05-11 11:21:43.634984Z] Finished populate-webroot step (success) 04:21:43 INFO - [mozharness: 2017-05-11 11:21:43.635073Z] Running create-virtualenv step. 04:21:43 INFO - Running pre-action listener: _resource_record_pre_action 04:21:43 INFO - Running main action method: create_virtualenv 04:21:43 INFO - Creating virtualenv /builds/slave/test/build/venv 04:21:43 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 04:21:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:21:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:21:43 INFO - Using real prefix '/usr' 04:21:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:21:44 INFO - Installing distribute.............................................................................................................................................................................................done. 04:21:46 INFO - Installing pip.................done. 04:21:46 INFO - Return code: 0 04:21:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:21:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:21:46 INFO - Reading from file tmpfile_stdout 04:21:46 INFO - Output received: 04:21:46 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) 04:21:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:21:46 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')]} 04:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:46 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')]} 04:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:46 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 0xeae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1220770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, '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': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', '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 04:21:46 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 04:21:46 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 04:21:46 INFO - Using env: {'DISPLAY': ':0', 04:21:46 INFO - 'HOME': '/home/cltbld', 04:21:46 INFO - 'LANG': 'en_US.UTF-8', 04:21:46 INFO - 'LANGUAGE': 'en_US:en', 04:21:46 INFO - 'LOGNAME': 'cltbld', 04:21:46 INFO - 'MAIL': '/var/mail/cltbld', 04:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:46 INFO - 'MOZ_NO_REMOTE': '1', 04:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:46 INFO - 'NO_EM_RESTART': '1', 04:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:46 INFO - 'PWD': '/builds/slave/test', 04:21:46 INFO - 'SHELL': '/bin/bash', 04:21:46 INFO - 'SHLVL': '1', 04:21:46 INFO - 'TERM': 'linux', 04:21:46 INFO - 'TMOUT': '86400', 04:21:46 INFO - 'USER': 'cltbld', 04:21:46 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:46 INFO - '_': '/tools/buildbot/bin/python'} 04:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:46 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 04:21:46 INFO - Cleaning up... 04:21:46 INFO - Return code: 0 04:21:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:21:46 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')]} 04:21:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:46 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')]} 04:21:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:46 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 0xeae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1220770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, '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': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', '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 04:21:46 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 04:21:46 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 04:21:46 INFO - Using env: {'DISPLAY': ':0', 04:21:46 INFO - 'HOME': '/home/cltbld', 04:21:46 INFO - 'LANG': 'en_US.UTF-8', 04:21:46 INFO - 'LANGUAGE': 'en_US:en', 04:21:46 INFO - 'LOGNAME': 'cltbld', 04:21:46 INFO - 'MAIL': '/var/mail/cltbld', 04:21:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:46 INFO - 'MOZ_NO_REMOTE': '1', 04:21:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:46 INFO - 'NO_EM_RESTART': '1', 04:21:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:46 INFO - 'PWD': '/builds/slave/test', 04:21:46 INFO - 'SHELL': '/bin/bash', 04:21:46 INFO - 'SHLVL': '1', 04:21:46 INFO - 'TERM': 'linux', 04:21:46 INFO - 'TMOUT': '86400', 04:21:46 INFO - 'USER': 'cltbld', 04:21:46 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:21:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:46 INFO - '_': '/tools/buildbot/bin/python'} 04:21:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:46 INFO - Downloading/unpacking psutil>=3.1.1 04:21:46 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 04:21:46 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 04:21:46 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 04:21:46 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 04:21:46 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 04:21:46 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 04:21:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:21:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:48 INFO - Installing collected packages: psutil 04:21:48 INFO - Running setup.py install for psutil 04:21:48 INFO - building 'psutil._psutil_linux' extension 04:21:48 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 04:21:48 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 04:21:48 INFO - building 'psutil._psutil_posix' extension 04:21:48 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 04:21:48 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 04:21:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:21:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:21:48 INFO - Successfully installed psutil 04:21:48 INFO - Cleaning up... 04:21:48 INFO - Return code: 0 04:21:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xeae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1220770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, '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': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', '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 04:21:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:21:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:21:48 INFO - Using env: {'DISPLAY': ':0', 04:21:48 INFO - 'HOME': '/home/cltbld', 04:21:48 INFO - 'LANG': 'en_US.UTF-8', 04:21:48 INFO - 'LANGUAGE': 'en_US:en', 04:21:48 INFO - 'LOGNAME': 'cltbld', 04:21:48 INFO - 'MAIL': '/var/mail/cltbld', 04:21:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:48 INFO - 'MOZ_NO_REMOTE': '1', 04:21:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:48 INFO - 'NO_EM_RESTART': '1', 04:21:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:48 INFO - 'PWD': '/builds/slave/test', 04:21:48 INFO - 'SHELL': '/bin/bash', 04:21:48 INFO - 'SHLVL': '1', 04:21:48 INFO - 'TERM': 'linux', 04:21:48 INFO - 'TMOUT': '86400', 04:21:48 INFO - 'USER': 'cltbld', 04:21:48 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:21:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:48 INFO - '_': '/tools/buildbot/bin/python'} 04:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:21:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:21:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:21:50 INFO - Installing collected packages: mozsystemmonitor 04:21:50 INFO - Running setup.py install for mozsystemmonitor 04:21:50 INFO - Successfully installed mozsystemmonitor 04:21:50 INFO - Cleaning up... 04:21:50 INFO - Return code: 0 04:21:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:50 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 0xeae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1220770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, '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': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', '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 04:21:50 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 04:21:50 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 04:21:50 INFO - Using env: {'DISPLAY': ':0', 04:21:50 INFO - 'HOME': '/home/cltbld', 04:21:50 INFO - 'LANG': 'en_US.UTF-8', 04:21:50 INFO - 'LANGUAGE': 'en_US:en', 04:21:50 INFO - 'LOGNAME': 'cltbld', 04:21:50 INFO - 'MAIL': '/var/mail/cltbld', 04:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:50 INFO - 'MOZ_NO_REMOTE': '1', 04:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:50 INFO - 'NO_EM_RESTART': '1', 04:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:50 INFO - 'PWD': '/builds/slave/test', 04:21:50 INFO - 'SHELL': '/bin/bash', 04:21:50 INFO - 'SHLVL': '1', 04:21:50 INFO - 'TERM': 'linux', 04:21:50 INFO - 'TMOUT': '86400', 04:21:50 INFO - 'USER': 'cltbld', 04:21:50 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:50 INFO - '_': '/tools/buildbot/bin/python'} 04:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:50 INFO - Downloading/unpacking jsonschema==2.5.1 04:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:21:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:21:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:21:51 INFO - Downloading functools32-3.2.3-2.tar.gz 04:21:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:21:51 INFO - warning: no files found matching '*.txt' 04:21:51 INFO - no previously-included directories found matching 'build' 04:21:51 INFO - no previously-included directories found matching 'dist' 04:21:51 INFO - no previously-included directories found matching '.git*' 04:21:51 INFO - Installing collected packages: jsonschema, functools32 04:21:51 INFO - Running setup.py install for functools32 04:21:51 INFO - warning: no files found matching '*.txt' 04:21:51 INFO - no previously-included directories found matching 'build' 04:21:51 INFO - no previously-included directories found matching 'dist' 04:21:51 INFO - no previously-included directories found matching '.git*' 04:21:51 INFO - Successfully installed jsonschema functools32 04:21:51 INFO - Cleaning up... 04:21:51 INFO - Return code: 0 04:21:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:21:51 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')]} 04:21:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:51 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')]} 04:21:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:51 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 0xeae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1220770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, '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': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', '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 04:21:51 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 04:21:51 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 04:21:51 INFO - Using env: {'DISPLAY': ':0', 04:21:51 INFO - 'HOME': '/home/cltbld', 04:21:51 INFO - 'LANG': 'en_US.UTF-8', 04:21:51 INFO - 'LANGUAGE': 'en_US:en', 04:21:51 INFO - 'LOGNAME': 'cltbld', 04:21:51 INFO - 'MAIL': '/var/mail/cltbld', 04:21:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:51 INFO - 'MOZ_NO_REMOTE': '1', 04:21:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:51 INFO - 'NO_EM_RESTART': '1', 04:21:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:51 INFO - 'PWD': '/builds/slave/test', 04:21:51 INFO - 'SHELL': '/bin/bash', 04:21:51 INFO - 'SHLVL': '1', 04:21:51 INFO - 'TERM': 'linux', 04:21:51 INFO - 'TMOUT': '86400', 04:21:51 INFO - 'USER': 'cltbld', 04:21:51 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:21:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:51 INFO - '_': '/tools/buildbot/bin/python'} 04:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:21:52 INFO - Cleaning up... 04:21:52 INFO - Return code: 0 04:21:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:21:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:52 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 0xeae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1220770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, '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': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', '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 04:21:52 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 04:21:52 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 04:21:52 INFO - Using env: {'DISPLAY': ':0', 04:21:52 INFO - 'HOME': '/home/cltbld', 04:21:52 INFO - 'LANG': 'en_US.UTF-8', 04:21:52 INFO - 'LANGUAGE': 'en_US:en', 04:21:52 INFO - 'LOGNAME': 'cltbld', 04:21:52 INFO - 'MAIL': '/var/mail/cltbld', 04:21:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:52 INFO - 'MOZ_NO_REMOTE': '1', 04:21:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:52 INFO - 'NO_EM_RESTART': '1', 04:21:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:52 INFO - 'PWD': '/builds/slave/test', 04:21:52 INFO - 'SHELL': '/bin/bash', 04:21:52 INFO - 'SHLVL': '1', 04:21:52 INFO - 'TERM': 'linux', 04:21:52 INFO - 'TMOUT': '86400', 04:21:52 INFO - 'USER': 'cltbld', 04:21:52 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:21:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:52 INFO - '_': '/tools/buildbot/bin/python'} 04:21:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:52 INFO - Downloading/unpacking blobuploader==1.2.4 04:21:52 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 04:21:52 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 04:21:52 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 04:21:52 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 04:21:52 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 04:21:52 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 04:21:53 INFO - Downloading blobuploader-1.2.4.tar.gz 04:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:21:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:21:53 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 04:21:53 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 04:21:53 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 04:21:53 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 04:21:53 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 04:21:53 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 04:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:21:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:21:53 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 04:21:53 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 04:21:53 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 04:21:53 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 04:21:53 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 04:21:53 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 04:21:53 INFO - Downloading docopt-0.6.1.tar.gz 04:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:21:54 INFO - Installing collected packages: blobuploader, requests, docopt 04:21:54 INFO - Running setup.py install for blobuploader 04:21:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:21:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:21:54 INFO - Running setup.py install for requests 04:21:54 INFO - Running setup.py install for docopt 04:21:54 INFO - Successfully installed blobuploader requests docopt 04:21:54 INFO - Cleaning up... 04:21:54 INFO - Return code: 0 04:21:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:54 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')]} 04:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:54 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')]} 04:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:54 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 0xeae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1220770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, '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': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', '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 04:21:54 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 04:21:54 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 04:21:54 INFO - Using env: {'DISPLAY': ':0', 04:21:54 INFO - 'HOME': '/home/cltbld', 04:21:54 INFO - 'LANG': 'en_US.UTF-8', 04:21:54 INFO - 'LANGUAGE': 'en_US:en', 04:21:54 INFO - 'LOGNAME': 'cltbld', 04:21:54 INFO - 'MAIL': '/var/mail/cltbld', 04:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:54 INFO - 'MOZ_NO_REMOTE': '1', 04:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:54 INFO - 'NO_EM_RESTART': '1', 04:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:54 INFO - 'PWD': '/builds/slave/test', 04:21:54 INFO - 'SHELL': '/bin/bash', 04:21:54 INFO - 'SHLVL': '1', 04:21:54 INFO - 'TERM': 'linux', 04:21:54 INFO - 'TMOUT': '86400', 04:21:54 INFO - 'USER': 'cltbld', 04:21:54 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:54 INFO - '_': '/tools/buildbot/bin/python'} 04:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:54 INFO - Running setup.py (path:/tmp/pip-s7KMjZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:54 INFO - Running setup.py (path:/tmp/pip-gfoFXX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:54 INFO - Running setup.py (path:/tmp/pip-4ku9Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:55 INFO - Running setup.py (path:/tmp/pip-khqlph-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:55 INFO - Running setup.py (path:/tmp/pip-ZvJl_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:55 INFO - Running setup.py (path:/tmp/pip-3SANeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:55 INFO - Running setup.py (path:/tmp/pip-DCesbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:55 INFO - Running setup.py (path:/tmp/pip-5_HnbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:55 INFO - Running setup.py (path:/tmp/pip-oQ7rG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:55 INFO - Running setup.py (path:/tmp/pip-4cHtII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:55 INFO - Running setup.py (path:/tmp/pip-k8zHY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:55 INFO - Running setup.py (path:/tmp/pip-2qMst7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:55 INFO - Running setup.py (path:/tmp/pip-fl_adV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:55 INFO - Running setup.py (path:/tmp/pip-Z2hTl6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:55 INFO - Running setup.py (path:/tmp/pip-ICZqmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:55 INFO - Running setup.py (path:/tmp/pip-zwXWdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:55 INFO - Running setup.py (path:/tmp/pip-dssZ7z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:21:56 INFO - Running setup.py install for manifestparser 04:21:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:21:56 INFO - Running setup.py install for mozcrash 04:21:56 INFO - Running setup.py install for mozdebug 04:21:56 INFO - Running setup.py install for mozdevice 04:21:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:21:56 INFO - Running setup.py install for mozfile 04:21:56 INFO - Running setup.py install for mozhttpd 04:21:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:21:56 INFO - Running setup.py install for mozinfo 04:21:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:21:56 INFO - Running setup.py install for mozInstall 04:21:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:21:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:21:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:21:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:21:56 INFO - Running setup.py install for mozleak 04:21:56 INFO - Running setup.py install for mozlog 04:21:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:21:57 INFO - Running setup.py install for moznetwork 04:21:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:21:57 INFO - Running setup.py install for mozprocess 04:21:57 INFO - Running setup.py install for mozprofile 04:21:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:21:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:21:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:21:57 INFO - Running setup.py install for mozrunner 04:21:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:21:57 INFO - Running setup.py install for mozscreenshot 04:21:57 INFO - Running setup.py install for moztest 04:21:57 INFO - Running setup.py install for mozversion 04:21:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:21:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:21:57 INFO - Cleaning up... 04:21:57 INFO - Return code: 0 04:21:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:21:57 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')]} 04:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:57 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')]} 04:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:21:57 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 0xeae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1220770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, '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': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', '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 04:21:57 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 04:21:57 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 04:21:57 INFO - Using env: {'DISPLAY': ':0', 04:21:57 INFO - 'HOME': '/home/cltbld', 04:21:57 INFO - 'LANG': 'en_US.UTF-8', 04:21:57 INFO - 'LANGUAGE': 'en_US:en', 04:21:57 INFO - 'LOGNAME': 'cltbld', 04:21:57 INFO - 'MAIL': '/var/mail/cltbld', 04:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:21:57 INFO - 'MOZ_NO_REMOTE': '1', 04:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:21:57 INFO - 'NO_EM_RESTART': '1', 04:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:21:57 INFO - 'PWD': '/builds/slave/test', 04:21:57 INFO - 'SHELL': '/bin/bash', 04:21:57 INFO - 'SHLVL': '1', 04:21:57 INFO - 'TERM': 'linux', 04:21:57 INFO - 'TMOUT': '86400', 04:21:57 INFO - 'USER': 'cltbld', 04:21:57 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:21:57 INFO - '_': '/tools/buildbot/bin/python'} 04:21:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:21:58 INFO - Running setup.py (path:/tmp/pip-bDGRMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:21:58 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:21:58 INFO - Running setup.py (path:/tmp/pip-Iuh4nC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:21:58 INFO - Running setup.py (path:/tmp/pip-uzuqTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:21:58 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:21:58 INFO - Running setup.py (path:/tmp/pip-5UBzLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:21:58 INFO - Running setup.py (path:/tmp/pip-XquBWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:21:58 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:21:58 INFO - Running setup.py (path:/tmp/pip-dPqrc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:21:58 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:21:58 INFO - Running setup.py (path:/tmp/pip-oOBPgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:21:58 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:21:58 INFO - Running setup.py (path:/tmp/pip-Pd0XKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:21:58 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:21:58 INFO - Running setup.py (path:/tmp/pip-L0rQRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:21:58 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:21:58 INFO - Running setup.py (path:/tmp/pip-zhPupz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:21:58 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:21:58 INFO - Running setup.py (path:/tmp/pip-b4j_9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:21:58 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:21:58 INFO - Running setup.py (path:/tmp/pip-Vu9qq4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:21:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:21:58 INFO - Running setup.py (path:/tmp/pip-phw2eT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:21:59 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)) 04:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:21:59 INFO - Running setup.py (path:/tmp/pip-bktX2j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:59 INFO - Running setup.py (path:/tmp/pip-KlNU59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:21:59 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)) 04:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:21:59 INFO - Running setup.py (path:/tmp/pip-iaeWpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 04:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:21:59 INFO - Running setup.py (path:/tmp/pip-BO8HPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:21:59 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)) 04:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:21:59 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)) 04:21:59 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:21:59 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:21:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:21:59 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 04:21:59 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 04:21:59 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 04:21:59 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 04:21:59 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 04:21:59 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 04:22:00 INFO - Downloading blessings-1.6.tar.gz 04:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:22:00 INFO - Installing collected packages: blessings 04:22:00 INFO - Running setup.py install for blessings 04:22:00 INFO - Successfully installed blessings 04:22:00 INFO - Cleaning up... 04:22:00 INFO - Return code: 0 04:22:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:22:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:00 INFO - Reading from file tmpfile_stdout 04:22:00 INFO - Current package versions: 04:22:00 INFO - argparse == 1.2.1 04:22:00 INFO - blessings == 1.6 04:22:00 INFO - blobuploader == 1.2.4 04:22:00 INFO - docopt == 0.6.1 04:22:00 INFO - functools32 == 3.2.3-2 04:22:00 INFO - jsonschema == 2.5.1 04:22:00 INFO - manifestparser == 1.1 04:22:00 INFO - mozInstall == 1.12 04:22:00 INFO - mozcrash == 1.0 04:22:00 INFO - mozdebug == 0.1 04:22:00 INFO - mozdevice == 0.50 04:22:00 INFO - mozfile == 1.2 04:22:00 INFO - mozhttpd == 0.7 04:22:00 INFO - mozinfo == 0.9 04:22:00 INFO - mozleak == 0.1 04:22:00 INFO - mozlog == 3.4 04:22:00 INFO - moznetwork == 0.27 04:22:00 INFO - mozprocess == 0.25 04:22:00 INFO - mozprofile == 0.28 04:22:00 INFO - mozrunner == 6.13 04:22:00 INFO - mozscreenshot == 0.1 04:22:00 INFO - mozsystemmonitor == 0.3 04:22:00 INFO - moztest == 0.8 04:22:00 INFO - mozversion == 1.4 04:22:00 INFO - psutil == 3.1.1 04:22:00 INFO - requests == 1.2.3 04:22:00 INFO - wsgiref == 0.1.2 04:22:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:22:00 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')]} 04:22:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:00 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')]} 04:22:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:00 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 0xeae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1220770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, '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': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', '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 04:22:00 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 04:22:00 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 04:22:00 INFO - Using env: {'DISPLAY': ':0', 04:22:00 INFO - 'HOME': '/home/cltbld', 04:22:00 INFO - 'LANG': 'en_US.UTF-8', 04:22:00 INFO - 'LANGUAGE': 'en_US:en', 04:22:00 INFO - 'LOGNAME': 'cltbld', 04:22:00 INFO - 'MAIL': '/var/mail/cltbld', 04:22:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:00 INFO - 'MOZ_NO_REMOTE': '1', 04:22:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:00 INFO - 'NO_EM_RESTART': '1', 04:22:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:00 INFO - 'PWD': '/builds/slave/test', 04:22:00 INFO - 'SHELL': '/bin/bash', 04:22:00 INFO - 'SHLVL': '1', 04:22:00 INFO - 'TERM': 'linux', 04:22:00 INFO - 'TMOUT': '86400', 04:22:00 INFO - 'USER': 'cltbld', 04:22:00 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:22:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:00 INFO - '_': '/tools/buildbot/bin/python'} 04:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:01 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)) 04:22:01 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)) 04:22:01 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)) 04:22:01 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)) 04:22:01 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)) 04:22:01 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)) 04:22:01 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)) 04:22:01 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)) 04:22:01 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)) 04:22:01 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)) 04:22:01 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)) 04:22:01 INFO - Cleaning up... 04:22:01 INFO - Return code: 0 04:22:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:22:01 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 0xeae1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107aa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1220770>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, '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': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', '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 04:22:01 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 04:22:01 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 04:22:01 INFO - Using env: {'DISPLAY': ':0', 04:22:01 INFO - 'HOME': '/home/cltbld', 04:22:01 INFO - 'LANG': 'en_US.UTF-8', 04:22:01 INFO - 'LANGUAGE': 'en_US:en', 04:22:01 INFO - 'LOGNAME': 'cltbld', 04:22:01 INFO - 'MAIL': '/var/mail/cltbld', 04:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:01 INFO - 'MOZ_NO_REMOTE': '1', 04:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:01 INFO - 'NO_EM_RESTART': '1', 04:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:01 INFO - 'PWD': '/builds/slave/test', 04:22:01 INFO - 'SHELL': '/bin/bash', 04:22:01 INFO - 'SHLVL': '1', 04:22:01 INFO - 'TERM': 'linux', 04:22:01 INFO - 'TMOUT': '86400', 04:22:01 INFO - 'USER': 'cltbld', 04:22:01 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:01 INFO - '_': '/tools/buildbot/bin/python'} 04:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:22:01 INFO - Cleaning up... 04:22:01 INFO - Return code: 0 04:22:01 INFO - Running post-action listener: _resource_record_post_action 04:22:01 INFO - Running post-action listener: _start_resource_monitoring 04:22:01 INFO - Starting resource monitoring. 04:22:01 INFO - [mozharness: 2017-05-11 11:22:01.345013Z] Finished create-virtualenv step (success) 04:22:01 INFO - [mozharness: 2017-05-11 11:22:01.345642Z] Running install step. 04:22:01 INFO - Running pre-action listener: _resource_record_pre_action 04:22:01 INFO - Running main action method: install 04:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:22:01 INFO - Reading from file tmpfile_stdout 04:22:01 INFO - Detecting whether we're running mozinstall >=1.0... 04:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:22:01 INFO - Reading from file tmpfile_stdout 04:22:01 INFO - Output received: 04:22:01 INFO - Usage: mozinstall [options] installer 04:22:01 INFO - Options: 04:22:01 INFO - -h, --help show this help message and exit 04:22:01 INFO - -d DEST, --destination=DEST 04:22:01 INFO - Directory to install application into. [default: 04:22:01 INFO - "/builds/slave/test"] 04:22:01 INFO - --app=APP Application being installed. [default: firefox] 04:22:01 INFO - mkdir: /builds/slave/test/build/application 04:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:22:17 INFO - Reading from file tmpfile_stdout 04:22:17 INFO - Output received: 04:22:17 INFO - /builds/slave/test/build/application/firefox/firefox 04:22:17 INFO - Running post-action listener: _resource_record_post_action 04:22:17 INFO - [mozharness: 2017-05-11 11:22:17.863056Z] Finished install step (success) 04:22:17 INFO - [mozharness: 2017-05-11 11:22:17.863329Z] Running run-tests step. 04:22:17 INFO - Running pre-action listener: _resource_record_pre_action 04:22:17 INFO - Running main action method: run_tests 04:22:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:22:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:22:17 INFO - Python 2.7.3 04:22:17 INFO - Return code: 0 04:22:17 INFO - grabbing minidump binary from tooltool 04:22: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')]} 04:22:17 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 0x121da30>, '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 0x121e7f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x121eca0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:22:17 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 04:22:17 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 04:22:17 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 04:22:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:22:17 INFO - Return code: 0 04:22:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:22:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:22:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:22:17 INFO - ENV: RUST_BACKTRACE is now 1 04:22:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:22:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:22:17 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/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 04:22:17 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/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-088 --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 04:22:17 INFO - Using env: {'DISPLAY': ':0', 04:22:17 INFO - 'HOME': '/home/cltbld', 04:22:17 INFO - 'LANG': 'en_US.UTF-8', 04:22:17 INFO - 'LANGUAGE': 'en_US:en', 04:22:17 INFO - 'LOGNAME': 'cltbld', 04:22:17 INFO - 'MAIL': '/var/mail/cltbld', 04:22:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:22:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:22:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:22:17 INFO - 'MOZ_NO_REMOTE': '1', 04:22:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:22:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:22:17 INFO - 'NO_EM_RESTART': '1', 04:22:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:22:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:22:17 INFO - 'PWD': '/builds/slave/test', 04:22:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:22:17 INFO - 'RUST_BACKTRACE': '1', 04:22:17 INFO - 'SHELL': '/bin/bash', 04:22:17 INFO - 'SHLVL': '1', 04:22:17 INFO - 'TERM': 'linux', 04:22:17 INFO - 'TMOUT': '86400', 04:22:17 INFO - 'USER': 'cltbld', 04:22:17 INFO - 'XDG_SESSION_COOKIE': '9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726', 04:22:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:22:17 INFO - '_': '/tools/buildbot/bin/python'} 04:22:17 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/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-088', '--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 04:22:18 INFO - mozversion application_buildid: 20170511104437 04:22:18 INFO - mozversion application_changeset: 86754a7acc0e12cf3c575e9867958c2bacc8f465 04:22:18 INFO - mozversion application_display_name: Nightly 04:22:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:22:18 INFO - mozversion application_name: Firefox 04:22:18 INFO - mozversion application_remotingname: firefox 04:22:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:22:18 INFO - mozversion application_vendor: Mozilla 04:22:18 INFO - mozversion application_version: 55.0a1 04:22:18 INFO - mozversion platform_buildid: 20170511104437 04:22:18 INFO - mozversion platform_changeset: 86754a7acc0e12cf3c575e9867958c2bacc8f465 04:22:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:22:18 INFO - mozversion platform_version: 55.0a1 04:22:18 INFO - using testdate: 1494501738 04:22:18 INFO - actual date: 1494501738 04:22:18 INFO - starting webserver on 'localhost:44210' 04:22:18 INFO - SUITE-START | Running 2 tests 04:22:18 INFO - TEST-START | dromaeo_css 04:22:18 INFO - operating with platform_type : linux_ 04:22:18 INFO - Initialising browser for dromaeo_css test... 04:22:18 INFO - TEST-INFO | started process 5674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBXOGfk/profile http://localhost:44210/getInfo.html) 04:22:21 INFO - PID 5674 | __metrics Screen width/height:1600/1200 04:22:21 INFO - PID 5674 | colorDepth:24 04:22:21 INFO - PID 5674 | Browser inner width/height: 1024/695 04:22:21 INFO - PID 5674 | __metrics 04:22:23 INFO - TEST-INFO | 5674: exit 0 04:22:23 INFO - Browser initialized. 04:22:23 INFO - Running cycle 1/1 for dromaeo_css test... 04:22:23 INFO - TEST-INFO | started process 5868 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBXOGfk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:22:35 INFO - PID 5868 | RSS: Main: 167432192 04:22:35 INFO - PID 5868 | 04:25:41 INFO - PID 5868 | Cycle 1(1): loaded http://localhost:44210/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44210/tests/dromaeo/cssquery-ext.html) 04:25:43 INFO - PID 5868 | RSS: Main: 182095872 04:25:43 INFO - PID 5868 | 04:28:45 INFO - PID 5868 | Cycle 1(1): loaded http://localhost:44210/tests/dromaeo/cssquery-ext.html (next: http://localhost:44210/tests/dromaeo/cssquery-jquery.html) 04:28:45 INFO - PID 5868 | RSS: Main: 179318784 04:28:45 INFO - PID 5868 | 04:31:47 INFO - PID 5868 | Cycle 1(1): loaded http://localhost:44210/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44210/tests/dromaeo/cssquery-mootools.html) 04:31:48 INFO - PID 5868 | RSS: Main: 188059648 04:31:48 INFO - PID 5868 | 04:34:50 INFO - PID 5868 | Cycle 1(1): loaded http://localhost:44210/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44210/tests/dromaeo/cssquery-prototype.html) 04:34:50 INFO - PID 5868 | RSS: Main: 182493184 04:34:50 INFO - PID 5868 | 04:37:53 INFO - PID 5868 | Cycle 1(1): loaded http://localhost:44210/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44210/tests/dromaeo/cssquery-yui.html) 04:37:54 INFO - PID 5868 | RSS: Main: 186273792 04:37:54 INFO - PID 5868 | 04:40:56 INFO - PID 5868 | Cycle 1(1): loaded http://localhost:44210/tests/dromaeo/cssquery-yui.html (next: http://localhost:44210/tests/dromaeo/cssquery-dojo.html) 04:40:56 INFO - PID 5868 | RSS: Main: 190160896 04:40:56 INFO - PID 5868 | 04:40:56 INFO - PID 5868 | __start_tp_report 04:40:56 INFO - PID 5868 | _x_x_mozilla_page_load 04:40:56 INFO - PID 5868 | _x_x_mozilla_page_load_details 04:40:56 INFO - PID 5868 | |i|pagename|runs| 04:40:56 INFO - PID 5868 | |0;dojo.html;2728.386113124547;2772.639556857608;2779.902703405379;2795.9860200699;2813.8311701297926;5287.524122828944;5374.462553744628;5377.542908852743;5393.325834270721;5407.864803379917;5311.760970756315;5331.120365139757;5408.540274076709;5409.377921539014;5432.158015507593;4499.822492209392;4748.928766068494;4770.165221086296;4772.069446457942;4787.760611969405;4821.541953514428;4847.612191024709;4855.028994201156;4867.245576935563;4890.682105663121;4705.082508910764;4714.504976977402;4759.4764575896625;4773.379460670126;4800.735959522225;4803.807847686088;4805.567498925078;4827.831025914112;4850.466448690641;4873.707577545359;4746.477887432379;4758.428988521365;4789.449213340476;4789.832355867528;4812.278158276252;5176.0683077046115;5218.086834803894;5223.764930578095;5290.1800220965815;5327.760250788724;5758.913616295759;5767.711614419304;5848.5321174305955;5849.473547380713;5874.060150375962;5844.766209351621;5858.443447872445;5859.121131830217;5859.384764599698;5875.471207591338;5399.946000540023;5410.1343784994215;5414.187871819258;5420.972895135499;5426.131818908955;5887.941120588739;5959.910601340984;5964.85087872798;6023.939760602426;6034.275886893513;5608.551315894719;5633.267675202197;5670.801521946794;5671.489565939085;5681.119426488901;5755.424457554211;5813.360530341659;5823.767049317979;5832.445917637818;5834.912476312858;5748.137779333133;5752;5760.8271751847515;5763.971180144073;5773.364929857797;5751.4536119068625;5754.05058165398;5754.223179870748;5759.366469688331;5773.566982476331;4872.6832755870755;4874.902501949941;4875.878103047452;4877.097736918681;4884.413870335582;4071.796410179479;4075.9796201018803;4105.91788164235;4137.441445404892;4218.261804184255;4930.827421040246;4939.431965324034;4940.258961155855;4946.777395017233;4965.577925876269;5733.741981610838;5762.625429347079;5812.651240925474;5877.764889404461;5879.52963762898;4949.034938187019;4951.480094590088;4952.356193694796;4955.306257124005;4997.350344455198;5185.144451165591;5196.584273258206;5197.29836472079;5203.531682148549;5245.055889939771;5288.735563221747;5322.095243808484;5366.6243362964215;5399.83800485986;5417;5866.67733274674;5868.061110222344;5871.500922421642;5881.411858814085;5888.3228428731245;5380.973095134499;5396.1905714143195;5409.918851217156;5413.458654134555;5419.729013549386;5619.606627536034;5672.9221447924765;5688.0330343840815;5688.857778555569;5689.288838895138;5721.284839395075;5737.08206686928;5762.884742305214;5817.360090389969;5833.795817146549;5564.360098588714;5602.355729091207;5619.438056194512;5651.886962260814;5652.660840349592;5586.86032849182;5608.551315894637;5620.943790562042;5622.662640241599;5634.718264086698;5476.205950137288;5485.232067510472;5546.195801608825;5561.5272701820795;5603.579731520071;5584.748686309207;5586.413426590149;5635.211070450222;5642.351129620146;5662.490375866192;5436.918446223231;5491.093969494988;5502.202180683698;5508;5519.034169020486 04:40:56 INFO - PID 5868 | |1;ext.html;694.2190036209265;748.2143749063483;767.8848172774083;1071.1751950997736;1071.2768881005325;31654.841725791397;32727.836360818193;32803;32837.507437388456;32952.83523582379;33624.83187584059;34103.317933641316;34122;34195;34222;6683.2314283857495;6755.527113102073;6797.898031529531;6851.9657401713175;6871.656417179146;6880.587164770105;6900.3099690031095;6931.064306318633;6938.132733408324;6942.090924995641;6883;6953.54801937875;6973.686184121727;6978.546394484342;6979.162500499921;6898.48261380396;6920.4809639276755;6920.688569014406;6930.826729331757;6959.51283410164;6788.355106264897;6826.283240259801;6877.58734475933;6883.793486195422;6895.448364130857;31673.52489712656;31962.520562191585;31996.360072798645;32130.678693213;32198;3131.4989601663624;3180.2685382361956;3181.490961446181;3191.9680803191904;3192.201949512622;24543.50912981748;24559.877200613882;24630.261092167264;24646.630300545505;24817.50364992708;3054.1906394805396;3058.7858849880517;3083.4449799036165;3084.90745277642;3122.3443076953868;143761;143806;152139.2393038039;156348.99999999886;156866;40454.79772601177;40472;40512.59487405147;40524.59475405208;40579.7971010149;41698.1660366791;41717.58282417198;41827.7908610455;41833.37249941253;41949.580504195175;12842.614721558368;12843.100982931104;12924.870751292554;13055.151415157985;13057.738845223043;10409.947950260352;10425.530851111718;10438.164946804238;10455.320404173704;10491.108255798343;12757.42591583381;12845.48618055286;12904.677383065498;12926.482940682268;13061.346932653329;5437.510624043776;5440.891182176334;5468.890622187613;5565.638233514808;5612.326520817446;877.622622272429;886.1227384888914;902.8443592201992;922.197688011421;952.7475219066953;20025;20656.793432065486;21191.894040530005;21372.145114195257;21641.13435462564;991.3308516751164;1009.2178561614661;1009.2430676992255;1030.7114008077751;1033.075397519216;10852.240343175901;10949.945250273699;11192.720181995515;11236.83144752813;11323.716907077223;180284;181073;181456;181578;181986;41097;41361.79319103385;41425.378619320734;41429;41473;1233.0998371189082;1268.5433244031956;1277.150694787974;1280.2830414967648;1303.9348032598332;19721.70417443768;20061.398158055283;20548.589028219052;20561.38315850527;20675.276365327743;29518.376489293296;29764.85117574398;29858.552121717756;29871;29930.25174370658;147693;148021.25989369984;148249;148542;148552.25723871312;29157.70842291635;29295.56056659109;29453.410931781673;30947.226319342197;30984.971953645883;36606.816965915;36817.447738284485;37335.626643733216;37402.625973739916;37458.812705936296;26693.19920402391;27493.86253068722;27599.17202483929;28061.438771224868;28508;27699.44601108007;28190.85904570464;28455.857720711265;29158;29406.852965735034;31356.686433135375;31759.36481270408;31772.187337519645;31814.204644884063;31835.681643184198;26937.730622694307;27181.738191417156;27741.861290693418;28194.154175374773;28904.132876013755;21762.12951481923;22658;22673.546529069656;22823.20118795834;22949.311520654406 04:40:56 INFO - PID 5868 | |2;jquery.html;427.14784005908217;428.7491817286887;433.1321300783999;446.3572455663844;452.5316297631949;16602.252898619576;17644.206010729515;17977.64044719105;18184.454466365998;18312.175952082154;18328.81671183288;18510.35213767515;18956.526086847836;18986.71519927202;19027.143778529964;5485.341758988927;5498.285222921015;5683;5693.715314234271;5701.743421546041;5601.495865372116;5607.663540187602;5610.495055445009;5614.522765564911;5625.634333768312;5391.622586418933;5576.442355764431;5591.440855914417;5592.133219351007;5593.636413633121;5505.678637127061;5529.30883639545;5571.5513966369035;5572.442755724415;5611.494965453129;4993.975030124826;5064.822731204427;5078.5937125029905;5126.2054381570915;5133.204353325241;21906.45233869166;21950;22495.550088998127;22683.659745103836;22770.886145569333;1538.5615099696533;1540.614846288428;1540.6225474758755;1540.9152496612683;1572.874170066392;14498.565043048726;14686.706265874624;14919.925400373037;14996.700065998619;15041.398344066334;1997.4107638246608;2067.4934641013047;2117.5553133841913;2119.448943274744;2123.5540536487356;80725.59637201835;83755;88166;100139.49930250303;101337;11191.32852028881;11553.191276610556;11569.88430115705;11583.478743456564;11784.646460606196;16191.676166476604;16211.432599858948;16213.59466013359;16214.59463513398;16236.67526649484;7570.735024274234;7873.763787086396;7900.44696871225;8049.51702897828;8092.190780921861;6858.759943401957;6940.895886561706;7191.244919283505;7412.592307423036;7414.925850741532;7104.92895071053;7240.239774823673;7263.92736072643;7351.926480735124;7352;2101.978980210209;2134.509062915538;2135.11392772001;2141.5181584143443;2240.1375470443995;860.9053004169537;892.0856122474515;893.821235752852;894.7763059235191;930.5998420679038;17299;17406.39077632302;18006.459806205836;18112.72830907511;18408.17163227658;858.2661824140395;872.2803686958284;882.6028287270753;882.8675698645126;898.2544488074882;9533.90466095344;9619.615215391446;9918.404895706137;9933.801323973625;10064.345817521838;340424;344769;375031;378592;381415;76183.23816761872;79929.60035199787;82275.58862205771;82405;83070.58464707638;1104.1994553948323;1109.9001089901785;1161.2103769436865;1164.470166074434;1170.4206417823232;17372.47882563525;18184.181711823265;18567.628647426707;18650.626987459902;18789.90605046966;39269.803650981565;39381;39407.60592394039;39504;39580.40629390619;48636.5136348632;48660.5133948656;48685.51314486952;50439.74780126222;50755.74622126866;8400.747977560683;8441.071482137082;8564.143585641386;8649.6972605961;8878.733637990612;13031.218126912416;13198.868011319764;13237.536686215935;13248.403821827847;13391.598252052454;11165.38590377537;11263.493142808757;11273.267237629529;11380.829287560859;11630.360330181922;10454.843177352497;10551.736206594896;10752.516136773707;10754.354738715701;10980.560777569128;11410.258333208314;11469;11555.248908821237;11923.224990375598;12011;8291.83416331658;8318.542480163407;8510.276626486819;8531.8720219198;8564.357673174662;10394.272400931863;10496.475176241005;10952.178586605876;11022.724431889266;11303.095752339957 04:40:56 INFO - PID 5868 | |3;mootools.html;1280.206272111291;1324.7482978234134;1327.7875539913612;1334.2661536155113;1340.323136815908;9768.218542516599;10037.447940363296;10166.898331016697;10169.237307201962;10452;10070.949645251763;10245.743856403575;10264.127549158331;10267.281290309662;10296.48517574122;2222.611043067465;2239.216274303989;2251.0883092347626;2259.3334966184934;2259.728832540089;2206.4263291544235;2239.9104035838545;2246.2362796649136;2248.4378905273684;2253.2902135827244;2177.682502086239;2177.8693278403266;2219.034719896842;2219.556088782242;2221.677856710776;2059.8361925512186;2129.595376878396;2162.2216002239184;2164.7835216478384;2168.4795649044195;2022;2156.2884248198056;2158.6006588781124;2161.9567608647894;2166.7724888886596;9672.22622190223;9681.903180968242;9745.463999480025;9753.073458021476;9762.853557196648;5656.151577263402;5865.824025279248;5867.8533036674;5893.882122357529;5898.970505147447;3241.448953677857;3429.176997520602;3487.581490221164;3490.5811302643847;3514.525539052246;1082.1937656445918;1107.5625128074366;1110.0675432636624;1180.984353456027;1190.8630507491662;15135.545933622008;15209.011414258148;15239.23803809805;15286.923565382102;15349.769753453707;4584.358189853423;4683.906321873544;4887.780049897692;4896.853094407174;4954.157793175169;10631.202659800545;10643.308184967953;10648.893511064945;10654.414007229676;10656.627018054485;5599.888002239933;5622.212890195376;5629.54963602919;5635.21107045014;5636.802711905146;5172.172452407597;5200.453952335026;5216.921746173811;5233.979374022106;5347.465253474621;3771.6794072503594;3925;3931.4889064422014;3955.88132356024;4012.7191096622955;1124.1681155944705;1127.3236058364917;1136.7499150186945;1146.266389510714;1153.0544953138515;679.1714108787272;708.2421808664782;709.2765379313072;724.1961422820665;725.354434553248;5171.534561889448;5288.338957630296;5330.893382132335;5330.9604627098115;5424.457554244544;815.1563132158187;831.7587899509075;835.1690068381998;835.4026870787416;842.073718909195;3493.8951831445097;3654.634536546377;3695.2978934002454;3709.109813644706;3721.2557488502407;12702.491900323883;13556;13562.321883905764;13583.32083395846;13597.388117534734;13380.6654833628;13435.193888366533;13527;13539.59381218565;13561.186328820106;7466.440016998638;7540.434467414966;7571.962140189374;7658.081030276402;7668.501547399401;5492.176173573996;5527.309086364205;5645.943540564542;5675.4040825714355;5804.709764511673;11758.3532905691;11801.586944456903;11835.112366572714;11921.403929803648;11933;12020.939895300467;12068;12210.206336588093;12324.19892707007;12334.876651233373;7347.8163045924275;7543.924560754542;7545.50954187976;7552.735654252075;7569.394448444001;9439.05609439078;9510.524473776422;9535.427874327563;9536.666216682383;9561.043895610383;7751;8139.267465928095;8352.206540378655;8367.62345694433;8379;7957.5225486471;7968.920310796818;7989.640466179152;8011.359091272568;8068.07217170033;7287.526310789782;7397.445191610758;7405.074365704287;7441.144268409203;7471.663775130023;5007.098722230034;5156.510131537498;5184.248283998874;5214.191800270964;5429.049916264717;5322.866928326823;5355.544778693855;5359;5446.21029950647;5593.860153496195 04:40:56 INFO - PID 5868 | |4;prototype.html;377.0253893684825;398.57153559923074;398.59144377013564;400.8897553172877;404.46408508725943;5494.752736126874;5541.390447050821;5576.219329293902;5623.212750214968;5627.7186140693;5407.972960135204;5492.423295553969;5498.615096943216;5504.119340905456;5512.834614961547;4168.812403441852;4172.248995180867;4184.7070705050655;4189.141226048653;4197.958020419803;4094;4149.502059752834;4171.332586786115;4183.309753890604;4190.161967606491;4091.8363265469347;4095.7542547447247;4116.9090191099385;4123.309637874116;4137.1725654869;4114.547399786021;4115.362118871565;4121.443605113316;4129.070959034223;4139.2963196256405;3593.4969104325414;3620.945685814715;3623.547056617923;3629.1108678373703;3634;5045.369328833895;5215.16557350822;5241.528262456397;5273.182656688219;5274.97362513185;4884.169691152512;4892.902141957176;4904.337914381548;4910.90178196434;4927.137750893579;5746.9712651436475;5843.474087332161;5847.122931560258;5863.442972917566;5872.295324561037;4041.3129767939226;4043.898902527431;4054.2702313583545;4057.5942405759483;4068.3897415387632;6006.738584897177;6140.201773769426;6149.938500614981;6178.980468222738;6187.969060154715;4112.177564487115;4118.9588104118575;4120.690948178899;4125.525564560114;4125.91748165035;4209.190048279208;4218.578142185757;4224.683148763855;4226.281532139544;4227.281362168439;4752.500987396343;4831.130396528659;4864.36763220779;4866.562009419169;4874.975625121851;5806;5812.3025236971835;5814.186013958049;5815.389384114607;5825.592208545361;1435.1245740098532;1440.2654646130338;1448.0804689022546;1450.0574626492653;1458.5259790568107;936.7470782888582;964.7973925475588;966.8743063401713;981.5484876956538;983.306768728045;4980.8046068943195;4999.725015124203;5008.549230569193;5023.472535383805;5023.899522009612;5974;5991.370906054802;5998.760049597967;6004.129401236796;6022.759089636453;4916.115099282163;4982.501749824988;5000.249962505581;5007.4491805901325;5027.974860125676;3160.6997335253113;3167.7782555220915;3184.490481522945;3195.012663159953;3201.183698156955;5450.672959622356;5538.307711536058;5550.555955523549;5550.91673624896;5566.359868615161;6143.385661433821;6157.96921015401;6163.506919446433;6172.814815555541;6179.5056395488255;5513.558915286768;5549.417311182267;5549.861253468614;5553.888922221533;5574.804881829116;5810.6513609183585;5997.880042399041;6047.123167140828;6117.694115294306;6135.913789311477;5784.363719990713;6003.249593800775;6019.458248757633;6023.156758053964;6031.019527112085;5593.440655934374;5594.0769772987005;5617.269754931833;5617.5505959522325;5634.605577609692;4104.117614712851;4139.461869956886;4155.8961025974595;4164.541900391016;4168.979155104205;5874.265716785402;6011.699415029144;6018.428249316308;6049.51603871698;6060.878782424415;5836.620619659709;5851.1515830205235;5859.2382990211;5859.531237501075;5879;5758.913616295675;5835.716142448655;5836.737346819318;5854.4730974212525;5901.5868889177345;5756.856078598069;5810.76756929735;5815.534757219497;5823.621464604787;5834.358220595816;5922.851928701644;5929.814037192493;5943.762249509971;5952.821415357546;5960.374160713236;5662.66024038559;5744;5753.626014309057;5762.250907382014;5790.1893734877995 04:40:56 INFO - PID 5868 | |5;yui.html;671.919369675639;671.9764808231713;679.2833560593573;684.6063513479747;687.1513680604454;12682.61952141435;13045.412956416973;13067.150635208705;14150.221737804417;15327.080375177497;14060.859391406082;14584.854151458483;14781.260936953136;14923.925380373083;14940.477083302087;885.1900511032413;905.4069584422214;910.0535443139128;910.8360495110877;911.2300106410106;850.2093053460279;889.7820034091657;899.2670973156889;899.5771987166022;899.8560230363144;906.026022026321;937.3485427627768;941.3645789092369;941.3880977364734;944.1832814615343;888.6534251641865;930.3115694386173;935.6257497001186;936.2135805923024;936.6768464879606;659.2747977225062;673.2997682410287;687.2131409536103;688.686647575352;691.9584824910521;13393.464261429532;13468.797968030487;13544.187348759106;13585.52450664222;13908.721825563533;15600.921995390065;15708.68582628341;15901.284442200129;16058.919705401515;16104.355825766956;12359.25844449336;12498.687532811662;12604.936975315064;12628.179168354027;12637.052221083455;2678.8660566971575;2694.393761403688;2710.986445067782;2714.5520989036786;2714.6335244742104;62873.68563157201;63014.68492657553;63261.683691581246;64753;70715;12129.575464858865;12665.860072593327;12831.807522887164;12941.09412341146;12953;19239.615207695766;19609.215631374584;19802.70295945562;19827.603447931248;20641.48396290105;6172.351903050205;6251.4061164189325;6303.779367722108;6358.682065896779;6375.968120159369;2882.5964364988918;2910.8690108944725;2920.2115428834095;2929.033418971734;2932.0910517739567;3489.755717099779;3542.929141417157;3560.038789526865;3563.768355056913;3570.553680789901;769.9923000770033;779.2129948751689;780.4614815777096;785.3010820369761;788.8146285622875;562.9915551266735;575.5453191978374;578.1587789765881;579.3135134865198;605.2555356911024;9880.160186384237;10166.186705063577;10277.845832312521;10287.691369258935;10385.896141038493;550.2461627570254;559.2533967153895;560.5039540007123;575.318247876268;588.0326862311474;4468.128714900628;4623.69945953512;4636.44362676481;4663.253879379283;4776.832810851603;60522.69738651367;61546.384536154066;61661;62221.68889155616;62266;56167.43832561704;56376.43623563794;56812.43187568154;57196.42803571911;57803;50871.23693144606;52157.913683452236;52430.47569524332;52572.21141682878;52806.20790688143;9390.201832844285;9410.717678469657;9595.952020239854;9662.75843103928;9763.707088787347;26507;26673.46653066889;27164.592531111655;27409.58885616757;27892.58161127544;31635.36729265356;31934.083954962778;31958.201044974063;32357.676423235465;32509;11686;11850.822237666614;11940.701482463008;12033.157678962738;12172.878271217174;12571.245725256515;12727.872721272668;12852.614421567368;13027.153235039692;13114.803277951029;11848.407579621156;13366.86633133695;13781.655458613615;14649;14758.262086895398;14403.9197060223;14509;14793.704125917206;14896.702065958403;15021.248937553297;13792.310384480536;14006.36971336272;14048.297585120907;14257.287135643384;14453.927730361282;9763.804723905625;9841.409515429097;10254.897451025394;10296.433696146783;10617.150627949592;10230.48847557634;11035.337879727242;11518.424078796193;11526.59656912004;11561.884381156417 04:40:56 INFO - PID 5868 | __end_tp_report 04:40:56 INFO - PID 5868 | __start_cc_report 04:40:56 INFO - PID 5868 | _x_x_mozilla_cycle_collect,350 04:40:56 INFO - PID 5868 | __end_cc_report 04:40:56 INFO - PID 5868 | __startTimestamp1494502856472__endTimestamp 04:40:56 INFO - PID 5868 | 04:40:56 INFO - PID 5868 | ------- Summary: start ------- 04:40:56 INFO - PID 5868 | Number of tests: 6 04:40:56 INFO - PID 5868 | 04:40:56 INFO - PID 5868 | [#0] dojo.html Cycles:165 Average:5292.31 Median:5420.97 stddev:624.51 (11.5%) stddev-sans-first:593.15 04:40:56 INFO - PID 5868 | Values: 2728.4 2772.6 2779.9 2796.0 2813.8 5287.5 5374.5 5377.5 5393.3 5407.9 5311.8 5331.1 5408.5 5409.4 5432.2 4499.8 4748.9 4770.2 4772.1 4787.8 4821.5 4847.6 4855.0 4867.2 4890.7 4705.1 4714.5 4759.5 4773.4 4800.7 4803.8 4805.6 4827.8 4850.5 4873.7 4746.5 4758.4 4789.4 4789.8 4812.3 5176.1 5218.1 5223.8 5290.2 5327.8 5758.9 5767.7 5848.5 5849.5 5874.1 5844.8 5858.4 5859.1 5859.4 5875.5 5399.9 5410.1 5414.2 5421.0 5426.1 5887.9 5959.9 5964.9 6023.9 6034.3 5608.6 5633.3 5670.8 5671.5 5681.1 5755.4 5813.4 5823.8 5832.4 5834.9 5748.1 5752.0 5760.8 5764.0 5773.4 5751.5 5754.1 5754.2 5759.4 5773.6 4872.7 4874.9 4875.9 4877.1 4884.4 4071.8 4076.0 4105.9 4137.4 4218.3 4930.8 4939.4 4940.3 4946.8 4965.6 5733.7 5762.6 5812.7 5877.8 5879.5 4949.0 4951.5 4952.4 4955.3 4997.4 5185.1 5196.6 5197.3 5203.5 5245.1 5288.7 5322.1 5366.6 5399.8 5417.0 5866.7 5868.1 5871.5 5881.4 5888.3 5381.0 5396.2 5409.9 5413.5 5419.7 5619.6 5672.9 5688.0 5688.9 5689.3 5721.3 5737.1 5762.9 5817.4 5833.8 5564.4 5602.4 5619.4 5651.9 5652.7 5586.9 5608.6 5620.9 5622.7 5634.7 5476.2 5485.2 5546.2 5561.5 5603.6 5584.7 5586.4 5635.2 5642.4 5662.5 5436.9 5491.1 5502.2 5508.0 5519.0 04:40:56 INFO - PID 5868 | 04:40:56 INFO - PID 5868 | [#1] ext.html Cycles:180 Average:30588.65 Median:3071.12 stddev:41464.85 (1350.2%) stddev-sans-first:41520.41 04:40:56 INFO - PID 5868 | Values: 694.2 748.2 767.9 1071.2 1071.3 31654.8 32727.8 32803.0 32837.5 32952.8 33624.8 34103.3 34122.0 34195.0 34222.0 6683.2 6755.5 6797.9 6852.0 6871.7 6880.6 6900.3 6931.1 6938.1 6942.1 6883.0 6953.5 6973.7 6978.5 6979.2 6898.5 6920.5 6920.7 6930.8 6959.5 6788.4 6826.3 6877.6 6883.8 6895.4 31673.5 31962.5 31996.4 32130.7 32198.0 3131.5 3180.3 3181.5 3192.0 3192.2 24543.5 24559.9 24630.3 24646.6 24817.5 3054.2 3058.8 3083.4 3084.9 3122.3 143761.0 143806.0 152139.2 156349.0 156866.0 40454.8 40472.0 40512.6 40524.6 40579.8 41698.2 41717.6 41827.8 41833.4 41949.6 12842.6 12843.1 12924.9 13055.2 13057.7 10409.9 10425.5 10438.2 10455.3 10491.1 12757.4 12845.5 12904.7 12926.5 13061.3 5437.5 5440.9 5468.9 5565.6 5612.3 877.6 886.1 902.8 922.2 952.7 20025.0 20656.8 21191.9 21372.1 21641.1 991.3 1009.2 1009.2 1030.7 1033.1 10852.2 10949.9 11192.7 11236.8 11323.7 180284.0 181073.0 181456.0 181578.0 181986.0 41097.0 41361.8 41425.4 41429.0 41473.0 1233.1 1268.5 1277.2 1280.3 1303.9 19721.7 20061.4 20548.6 20561.4 20675.3 29518.4 29764.9 29858.6 29871.0 29930.3 147693.0 148021.3 148249.0 148542.0 148552.3 29157.7 29295.6 29453.4 30947.2 30985.0 36606.8 36817.4 37335.6 37402.6 37458.8 26693.2 27493.9 27599.2 28061.4 28508.0 27699.4 28190.9 28455.9 29158.0 29406.9 31356.7 31759.4 31772.2 31814.2 31835.7 26937.7 27181.7 27741.9 28194.2 28904.1 21762.1 22658.0 22673.5 22823.2 22949.3 04:40:56 INFO - PID 5868 | 04:40:56 INFO - PID 5868 | [#2] jquery.html Cycles:180 Average:25155.50 Median:376811.50 stddev:60858.49 (16.2%) stddev-sans-first:61000.89 04:40:56 INFO - PID 5868 | Values: 427.1 428.7 433.1 446.4 452.5 16602.3 17644.2 17977.6 18184.5 18312.2 18328.8 18510.4 18956.5 18986.7 19027.1 5485.3 5498.3 5683.0 5693.7 5701.7 5601.5 5607.7 5610.5 5614.5 5625.6 5391.6 5576.4 5591.4 5592.1 5593.6 5505.7 5529.3 5571.6 5572.4 5611.5 4994.0 5064.8 5078.6 5126.2 5133.2 21906.5 21950.0 22495.6 22683.7 22770.9 1538.6 1540.6 1540.6 1540.9 1572.9 14498.6 14686.7 14919.9 14996.7 15041.4 1997.4 2067.5 2117.6 2119.4 2123.6 80725.6 83755.0 88166.0 100139.5 101337.0 11191.3 11553.2 11569.9 11583.5 11784.6 16191.7 16211.4 16213.6 16214.6 16236.7 7570.7 7873.8 7900.4 8049.5 8092.2 6858.8 6940.9 7191.2 7412.6 7414.9 7104.9 7240.2 7263.9 7351.9 7352.0 2102.0 2134.5 2135.1 2141.5 2240.1 860.9 892.1 893.8 894.8 930.6 17299.0 17406.4 18006.5 18112.7 18408.2 858.3 872.3 882.6 882.9 898.3 9533.9 9619.6 9918.4 9933.8 10064.3 340424.0 344769.0 375031.0 378592.0 381415.0 76183.2 79929.6 82275.6 82405.0 83070.6 1104.2 1109.9 1161.2 1164.5 1170.4 17372.5 18184.2 18567.6 18650.6 18789.9 39269.8 39381.0 39407.6 39504.0 39580.4 48636.5 48660.5 48685.5 50439.7 50755.7 8400.7 8441.1 8564.1 8649.7 8878.7 13031.2 13198.9 13237.5 13248.4 13391.6 11165.4 11263.5 11273.3 11380.8 11630.4 10454.8 10551.7 10752.5 10754.4 10980.6 11410.3 11469.0 11555.2 11923.2 12011.0 8291.8 8318.5 8510.3 8531.9 8564.4 10394.3 10496.5 10952.2 11022.7 11303.1 04:40:56 INFO - PID 5868 | 04:40:56 INFO - PID 5868 | [#3] mootools.html Cycles:180 Average:6256.89 Median:3928.24 stddev:4031.19 (102.6%) stddev-sans-first:4025.16 04:40:56 INFO - PID 5868 | Values: 1280.2 1324.7 1327.8 1334.3 1340.3 9768.2 10037.4 10166.9 10169.2 10452.0 10070.9 10245.7 10264.1 10267.3 10296.5 2222.6 2239.2 2251.1 2259.3 2259.7 2206.4 2239.9 2246.2 2248.4 2253.3 2177.7 2177.9 2219.0 2219.6 2221.7 2059.8 2129.6 2162.2 2164.8 2168.5 2022.0 2156.3 2158.6 2162.0 2166.8 9672.2 9681.9 9745.5 9753.1 9762.9 5656.2 5865.8 5867.9 5893.9 5899.0 3241.4 3429.2 3487.6 3490.6 3514.5 1082.2 1107.6 1110.1 1181.0 1190.9 15135.5 15209.0 15239.2 15286.9 15349.8 4584.4 4683.9 4887.8 4896.9 4954.2 10631.2 10643.3 10648.9 10654.4 10656.6 5599.9 5622.2 5629.5 5635.2 5636.8 5172.2 5200.5 5216.9 5234.0 5347.5 3771.7 3925.0 3931.5 3955.9 4012.7 1124.2 1127.3 1136.7 1146.3 1153.1 679.2 708.2 709.3 724.2 725.4 5171.5 5288.3 5330.9 5331.0 5424.5 815.2 831.8 835.2 835.4 842.1 3493.9 3654.6 3695.3 3709.1 3721.3 12702.5 13556.0 13562.3 13583.3 13597.4 13380.7 13435.2 13527.0 13539.6 13561.2 7466.4 7540.4 7572.0 7658.1 7668.5 5492.2 5527.3 5645.9 5675.4 5804.7 11758.4 11801.6 11835.1 11921.4 11933.0 12020.9 12068.0 12210.2 12324.2 12334.9 7347.8 7543.9 7545.5 7552.7 7569.4 9439.1 9510.5 9535.4 9536.7 9561.0 7751.0 8139.3 8352.2 8367.6 8379.0 7957.5 7968.9 7989.6 8011.4 8068.1 7287.5 7397.4 7405.1 7441.1 7471.7 5007.1 5156.5 5184.2 5214.2 5429.0 5322.9 5355.5 5359.0 5446.2 5593.9 04:40:56 INFO - PID 5868 | 04:40:56 INFO - PID 5868 | [#4] prototype.html Cycles:180 Average:4793.08 Median:5508.48 stddev:1426.73 (25.9%) stddev-sans-first:1391.70 04:40:56 INFO - PID 5868 | Values: 377.0 398.6 398.6 400.9 404.5 5494.8 5541.4 5576.2 5623.2 5627.7 5408.0 5492.4 5498.6 5504.1 5512.8 4168.8 4172.2 4184.7 4189.1 4198.0 4094.0 4149.5 4171.3 4183.3 4190.2 4091.8 4095.8 4116.9 4123.3 4137.2 4114.5 4115.4 4121.4 4129.1 4139.3 3593.5 3620.9 3623.5 3629.1 3634.0 5045.4 5215.2 5241.5 5273.2 5275.0 4884.2 4892.9 4904.3 4910.9 4927.1 5747.0 5843.5 5847.1 5863.4 5872.3 4041.3 4043.9 4054.3 4057.6 4068.4 6006.7 6140.2 6149.9 6179.0 6188.0 4112.2 4119.0 4120.7 4125.5 4125.9 4209.2 4218.6 4224.7 4226.3 4227.3 4752.5 4831.1 4864.4 4866.6 4875.0 5806.0 5812.3 5814.2 5815.4 5825.6 1435.1 1440.3 1448.1 1450.1 1458.5 936.7 964.8 966.9 981.5 983.3 4980.8 4999.7 5008.5 5023.5 5023.9 5974.0 5991.4 5998.8 6004.1 6022.8 4916.1 4982.5 5000.2 5007.4 5028.0 3160.7 3167.8 3184.5 3195.0 3201.2 5450.7 5538.3 5550.6 5550.9 5566.4 6143.4 6158.0 6163.5 6172.8 6179.5 5513.6 5549.4 5549.9 5553.9 5574.8 5810.7 5997.9 6047.1 6117.7 6135.9 5784.4 6003.2 6019.5 6023.2 6031.0 5593.4 5594.1 5617.3 5617.6 5634.6 4104.1 4139.5 4155.9 4164.5 4169.0 5874.3 6011.7 6018.4 6049.5 6060.9 5836.6 5851.2 5859.2 5859.5 5879.0 5758.9 5835.7 5836.7 5854.5 5901.6 5756.9 5810.8 5815.5 5823.6 5834.4 5922.9 5929.8 5943.8 5952.8 5960.4 5662.7 5744.0 5753.6 5762.3 5790.2 04:40:56 INFO - PID 5868 | 04:40:56 INFO - PID 5868 | [#5] yui.html Cycles:180 Average:14808.06 Median:32433.34 stddev:17396.39 (53.6%) stddev-sans-first:17412.80 04:40:56 INFO - PID 5868 | Values: 671.9 672.0 679.3 684.6 687.2 12682.6 13045.4 13067.2 14150.2 15327.1 14060.9 14584.9 14781.3 14923.9 14940.5 885.2 905.4 910.1 910.8 911.2 850.2 889.8 899.3 899.6 899.9 906.0 937.3 941.4 941.4 944.2 888.7 930.3 935.6 936.2 936.7 659.3 673.3 687.2 688.7 692.0 13393.5 13468.8 13544.2 13585.5 13908.7 15600.9 15708.7 15901.3 16058.9 16104.4 12359.3 12498.7 12604.9 12628.2 12637.1 2678.9 2694.4 2711.0 2714.6 2714.6 62873.7 63014.7 63261.7 64753.0 70715.0 12129.6 12665.9 12831.8 12941.1 12953.0 19239.6 19609.2 19802.7 19827.6 20641.5 6172.4 6251.4 6303.8 6358.7 6376.0 2882.6 2910.9 2920.2 2929.0 2932.1 3489.8 3542.9 3560.0 3563.8 3570.6 770.0 779.2 780.5 785.3 788.8 563.0 575.5 578.2 579.3 605.3 9880.2 10166.2 10277.8 10287.7 10385.9 550.2 559.3 560.5 575.3 588.0 4468.1 4623.7 4636.4 4663.3 4776.8 60522.7 61546.4 61661.0 62221.7 62266.0 56167.4 56376.4 56812.4 57196.4 57803.0 50871.2 52157.9 52430.5 52572.2 52806.2 9390.2 9410.7 9596.0 9662.8 9763.7 26507.0 26673.5 27164.6 27409.6 27892.6 31635.4 31934.1 31958.2 32357.7 32509.0 11686.0 11850.8 11940.7 12033.2 12172.9 12571.2 12727.9 12852.6 13027.2 13114.8 11848.4 13366.9 13781.7 14649.0 14758.3 14403.9 14509.0 14793.7 14896.7 15021.2 13792.3 14006.4 14048.3 14257.3 14453.9 9763.8 9841.4 10254.9 10296.4 10617.2 10230.5 11035.3 11518.4 11526.6 11561.9 04:40:56 INFO - PID 5868 | -------- Summary: end -------- 04:40:56 INFO - PID 5868 | 04:40:57 INFO - TEST-INFO | 5868: exit 0 04:40:57 INFO - TEST-OK | dromaeo_css | took 1119135ms 04:40:57 INFO - TEST-START | kraken 04:40:57 INFO - operating with platform_type : linux_ 04:40:57 INFO - Initialising browser for kraken test... 04:40:57 INFO - TEST-INFO | started process 6302 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7V7Z98/profile http://localhost:44210/getInfo.html) 04:41:00 INFO - PID 6302 | __metrics Screen width/height:1600/1200 04:41:00 INFO - PID 6302 | colorDepth:24 04:41:00 INFO - PID 6302 | Browser inner width/height: 1024/695 04:41:00 INFO - PID 6302 | __metrics 04:41:02 INFO - TEST-INFO | 6302: exit 0 04:41:02 INFO - Browser initialized. 04:41:02 INFO - Running cycle 1/1 for kraken test... 04:41:02 INFO - TEST-INFO | started process 6497 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7V7Z98/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:41:14 INFO - PID 6497 | RSS: Main: 164851712 04:41:14 INFO - PID 6497 | 04:41:17 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44210/tests/kraken/driver.html?testName=audio-beat-detection) 04:41:18 INFO - PID 6497 | RSS: Main: 174723072 04:41:18 INFO - PID 6497 | 04:41:20 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44210/tests/kraken/driver.html?testName=audio-dft) 04:41:21 INFO - PID 6497 | RSS: Main: 174096384 04:41:21 INFO - PID 6497 | 04:41:24 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44210/tests/kraken/driver.html?testName=audio-fft) 04:41:24 INFO - PID 6497 | RSS: Main: 170586112 04:41:24 INFO - PID 6497 | 04:41:27 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44210/tests/kraken/driver.html?testName=audio-oscillator) 04:41:27 INFO - PID 6497 | RSS: Main: 171606016 04:41:27 INFO - PID 6497 | 04:41:29 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44210/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:41:30 INFO - PID 6497 | RSS: Main: 172724224 04:41:30 INFO - PID 6497 | 04:41:33 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44210/tests/kraken/driver.html?testName=imaging-darkroom) 04:41:34 INFO - PID 6497 | RSS: Main: 176705536 04:41:34 INFO - PID 6497 | 04:41:37 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44210/tests/kraken/driver.html?testName=imaging-desaturate) 04:41:38 INFO - PID 6497 | RSS: Main: 175894528 04:41:38 INFO - PID 6497 | 04:41:41 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44210/tests/kraken/driver.html?testName=json-parse-financial) 04:41:41 INFO - PID 6497 | RSS: Main: 176824320 04:41:41 INFO - PID 6497 | 04:41:43 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44210/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:41:44 INFO - PID 6497 | RSS: Main: 177868800 04:41:44 INFO - PID 6497 | 04:41:45 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44210/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:41:46 INFO - PID 6497 | RSS: Main: 178761728 04:41:46 INFO - PID 6497 | 04:41:48 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44210/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:41:49 INFO - PID 6497 | RSS: Main: 178425856 04:41:49 INFO - PID 6497 | 04:41:52 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:41:52 INFO - PID 6497 | RSS: Main: 177250304 04:41:52 INFO - PID 6497 | 04:41:56 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:41:56 INFO - PID 6497 | RSS: Main: 177991680 04:41:56 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | Cycle 1(1): loaded http://localhost:44210/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44210/tests/kraken/driver.html?testName=ai-astar) 04:41:58 INFO - PID 6497 | RSS: Main: 179113984 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | __start_tp_report 04:41:58 INFO - PID 6497 | _x_x_mozilla_page_load 04:41:58 INFO - PID 6497 | _x_x_mozilla_page_load_details 04:41:58 INFO - PID 6497 | |i|pagename|runs| 04:41:58 INFO - PID 6497 | |0;ai-astar;104;111;112;110;112;112;112;112;112;117 04:41:58 INFO - PID 6497 | |1;audio-beat-detection;151;121;126;164;124;124;123;124;142;124 04:41:58 INFO - PID 6497 | |2;audio-dft;165;165;165;164;167;165;173;163;165;163 04:41:58 INFO - PID 6497 | |3;audio-fft;74;75;75;112;76;74;78;76;93;75 04:41:58 INFO - PID 6497 | |4;audio-oscillator;82;83;116;84;84;83;103;84;82;110 04:41:58 INFO - PID 6497 | |5;imaging-gaussian-blur;117;113;114;114;114;116;114;117;113;113 04:41:58 INFO - PID 6497 | |6;imaging-darkroom;151;150;149;149;152;151;150;150;155;155 04:41:58 INFO - PID 6497 | |7;imaging-desaturate;94;95;95;95;97;95;94;95;94;94 04:41:58 INFO - PID 6497 | |8;json-parse-financial;53;52;53;54;55;55;53;56;54;55 04:41:58 INFO - PID 6497 | |9;json-stringify-tinderbox;56;57;55;55;56;56;58;60;56;55 04:41:58 INFO - PID 6497 | |10;stanford-crypto-aes;83;81;82;81;82;83;91;82;81;94 04:41:58 INFO - PID 6497 | |11;stanford-crypto-ccm;140;134;135;131;129;132;132;139;193;134 04:41:58 INFO - PID 6497 | |12;stanford-crypto-pbkdf2;181;188;188;195;191;189;187;187;190;195 04:41:58 INFO - PID 6497 | |13;stanford-crypto-sha256-iterative;78;74;73;77;76;79;74;77;77;74 04:41:58 INFO - PID 6497 | __end_tp_report 04:41:58 INFO - PID 6497 | __start_cc_report 04:41:58 INFO - PID 6497 | _x_x_mozilla_cycle_collect,854 04:41:58 INFO - PID 6497 | __end_cc_report 04:41:58 INFO - PID 6497 | __startTimestamp1494502918746__endTimestamp 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | ------- Summary: start ------- 04:41:58 INFO - PID 6497 | Number of tests: 14 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.00 stddev:3.17 (2.8%) stddev-sans-first:1.92 04:41:58 INFO - PID 6497 | Values: 104.0 111.0 112.0 110.0 112.0 112.0 112.0 112.0 112.0 117.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:125.00 stddev:14.83 (11.9%) stddev-sans-first:14.10 04:41:58 INFO - PID 6497 | Values: 151.0 121.0 126.0 164.0 124.0 124.0 123.0 124.0 142.0 124.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#2] audio-dft Cycles:10 Average:165.50 Median:165.00 stddev:2.88 (1.7%) stddev-sans-first:3.05 04:41:58 INFO - PID 6497 | Values: 165.0 165.0 165.0 164.0 167.0 165.0 173.0 163.0 165.0 163.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#3] audio-fft Cycles:10 Average:80.80 Median:75.50 stddev:12.34 (16.3%) stddev-sans-first:12.84 04:41:58 INFO - PID 6497 | Values: 74.0 75.0 75.0 112.0 76.0 74.0 78.0 76.0 93.0 75.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:83.00 stddev:13.19 (15.9%) stddev-sans-first:13.58 04:41:58 INFO - PID 6497 | Values: 82.0 83.0 116.0 84.0 84.0 83.0 103.0 84.0 82.0 110.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#5] imaging-gaussian-blur Cycles:10 Average:114.50 Median:114.00 stddev:1.58 (1.4%) stddev-sans-first:1.39 04:41:58 INFO - PID 6497 | Values: 117.0 113.0 114.0 114.0 114.0 116.0 114.0 117.0 113.0 113.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#6] imaging-darkroom Cycles:10 Average:151.20 Median:151.00 stddev:2.20 (1.5%) stddev-sans-first:2.33 04:41:58 INFO - PID 6497 | Values: 151.0 150.0 149.0 149.0 152.0 151.0 150.0 150.0 155.0 155.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.92 (1.0%) stddev-sans-first:0.93 04:41:58 INFO - PID 6497 | Values: 94.0 95.0 95.0 95.0 97.0 95.0 94.0 95.0 94.0 94.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.50 stddev:1.25 (2.3%) stddev-sans-first:1.27 04:41:58 INFO - PID 6497 | Values: 53.0 52.0 53.0 54.0 55.0 55.0 53.0 56.0 54.0 55.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#9] json-stringify-tinderbox Cycles:10 Average:56.40 Median:56.00 stddev:1.58 (2.8%) stddev-sans-first:1.67 04:41:58 INFO - PID 6497 | Values: 56.0 57.0 55.0 55.0 56.0 56.0 58.0 60.0 56.0 55.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:82.50 stddev:4.59 (5.6%) stddev-sans-first:4.86 04:41:58 INFO - PID 6497 | Values: 83.0 81.0 82.0 81.0 82.0 83.0 91.0 82.0 81.0 94.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#11] stanford-crypto-ccm Cycles:10 Average:139.90 Median:134.50 stddev:18.96 (14.1%) stddev-sans-first:20.11 04:41:58 INFO - PID 6497 | Values: 140.0 134.0 135.0 131.0 129.0 132.0 132.0 139.0 193.0 134.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.10 Median:189.50 stddev:4.09 (2.2%) stddev-sans-first:3.12 04:41:58 INFO - PID 6497 | Values: 181.0 188.0 188.0 195.0 191.0 189.0 187.0 187.0 190.0 195.0 04:41:58 INFO - PID 6497 | 04:41:58 INFO - PID 6497 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.90 Median:77.00 stddev:2.02 (2.6%) stddev-sans-first:2.00 04:41:58 INFO - PID 6497 | Values: 78.0 74.0 73.0 77.0 76.0 79.0 74.0 77.0 77.0 74.0 04:41:58 INFO - PID 6497 | -------- Summary: end -------- 04:41:58 INFO - PID 6497 | 04:41:59 INFO - TEST-INFO | 6497: exit 0 04:42:00 INFO - TEST-OK | kraken | took 62721ms 04:42:00 INFO - SUITE-END | took 1181s 04:42:00 INFO - Completed test suite (00:19:42) 04:42:00 INFO - javascript benchmark 04:42:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6761.145869441712, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2728.386113124547, 2772.639556857608, 2779.902703405379, 2795.9860200699, 2813.8311701297926, 5287.524122828944, 5374.462553744628, 5377.542908852743, 5393.325834270721, 5407.864803379917, 5311.760970756315, 5331.120365139757, 5408.540274076709, 5409.377921539014, 5432.158015507593, 4499.822492209392, 4748.928766068494, 4770.165221086296, 4772.069446457942, 4787.760611969405, 4821.541953514428, 4847.612191024709, 4855.028994201156, 4867.245576935563, 4890.682105663121, 4705.082508910764, 4714.504976977402, 4759.4764575896625, 4773.379460670126, 4800.735959522225, 4803.807847686088, 4805.567498925078, 4827.831025914112, 4850.466448690641, 4873.707577545359, 4746.477887432379, 4758.428988521365, 4789.449213340476, 4789.832355867528, 4812.278158276252, 5176.0683077046115, 5218.086834803894, 5223.764930578095, 5290.1800220965815, 5327.760250788724, 5758.913616295759, 5767.711614419304, 5848.5321174305955, 5849.473547380713, 5874.060150375962, 5844.766209351621, 5858.443447872445, 5859.121131830217, 5859.384764599698, 5875.471207591338, 5399.946000540023, 5410.1343784994215, 5414.187871819258, 5420.972895135499, 5426.131818908955, 5887.941120588739, 5959.910601340984, 5964.85087872798, 6023.939760602426, 6034.275886893513, 5608.551315894719, 5633.267675202197, 5670.801521946794, 5671.489565939085, 5681.119426488901, 5755.424457554211, 5813.360530341659, 5823.767049317979, 5832.445917637818, 5834.912476312858, 5748.137779333133, 5752.0, 5760.8271751847515, 5763.971180144073, 5773.364929857797, 5751.4536119068625, 5754.05058165398, 5754.223179870748, 5759.366469688331, 5773.566982476331, 4872.6832755870755, 4874.902501949941, 4875.878103047452, 4877.097736918681, 4884.413870335582, 4071.796410179479, 4075.9796201018803, 4105.91788164235, 4137.441445404892, 4218.261804184255, 4930.827421040246, 4939.431965324034, 4940.258961155855, 4946.777395017233, 4965.577925876269, 5733.741981610838, 5762.625429347079, 5812.651240925474, 5877.764889404461, 5879.52963762898, 4949.034938187019, 4951.480094590088, 4952.356193694796, 4955.306257124005, 4997.350344455198, 5185.144451165591, 5196.584273258206, 5197.29836472079, 5203.531682148549, 5245.055889939771, 5288.735563221747, 5322.095243808484, 5366.6243362964215, 5399.83800485986, 5417.0, 5866.67733274674, 5868.061110222344, 5871.500922421642, 5881.411858814085, 5888.3228428731245, 5380.973095134499, 5396.1905714143195, 5409.918851217156, 5413.458654134555, 5419.729013549386, 5619.606627536034, 5672.9221447924765, 5688.0330343840815, 5688.857778555569, 5689.288838895138, 5721.284839395075, 5737.08206686928, 5762.884742305214, 5817.360090389969, 5833.795817146549, 5564.360098588714, 5602.355729091207, 5619.438056194512, 5651.886962260814, 5652.660840349592, 5586.86032849182, 5608.551315894637, 5620.943790562042, 5622.662640241599, 5634.718264086698, 5476.205950137288, 5485.232067510472, 5546.195801608825, 5561.5272701820795, 5603.579731520071, 5584.748686309207, 5586.413426590149, 5635.211070450222, 5642.351129620146, 5662.490375866192, 5436.918446223231, 5491.093969494988, 5502.202180683698, 5508.0, 5519.034169020486], "value": 5246.506605395516, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.2190036209265, 748.2143749063483, 767.8848172774083, 1071.1751950997736, 1071.2768881005325, 31654.841725791397, 32727.836360818193, 32803.0, 32837.507437388456, 32952.83523582379, 33624.83187584059, 34103.317933641316, 34122.0, 34195.0, 34222.0, 6683.2314283857495, 6755.527113102073, 6797.898031529531, 6851.9657401713175, 6871.656417179146, 6880.587164770105, 6900.3099690031095, 6931.064306318633, 6938.132733408324, 6942.090924995641, 6883.0, 6953.54801937875, 6973.686184121727, 6978.546394484342, 6979.162500499921, 6898.48261380396, 6920.4809639276755, 6920.688569014406, 6930.826729331757, 6959.51283410164, 6788.355106264897, 6826.283240259801, 6877.58734475933, 6883.793486195422, 6895.448364130857, 31673.52489712656, 31962.520562191585, 31996.360072798645, 32130.678693213, 32198.0, 3131.4989601663624, 3180.2685382361956, 3181.490961446181, 3191.9680803191904, 3192.201949512622, 24543.50912981748, 24559.877200613882, 24630.261092167264, 24646.630300545505, 24817.50364992708, 3054.1906394805396, 3058.7858849880517, 3083.4449799036165, 3084.90745277642, 3122.3443076953868, 143761.0, 143806.0, 152139.2393038039, 156348.99999999886, 156866.0, 40454.79772601177, 40472.0, 40512.59487405147, 40524.59475405208, 40579.7971010149, 41698.1660366791, 41717.58282417198, 41827.7908610455, 41833.37249941253, 41949.580504195175, 12842.614721558368, 12843.100982931104, 12924.870751292554, 13055.151415157985, 13057.738845223043, 10409.947950260352, 10425.530851111718, 10438.164946804238, 10455.320404173704, 10491.108255798343, 12757.42591583381, 12845.48618055286, 12904.677383065498, 12926.482940682268, 13061.346932653329, 5437.510624043776, 5440.891182176334, 5468.890622187613, 5565.638233514808, 5612.326520817446, 877.622622272429, 886.1227384888914, 902.8443592201992, 922.197688011421, 952.7475219066953, 20025.0, 20656.793432065486, 21191.894040530005, 21372.145114195257, 21641.13435462564, 991.3308516751164, 1009.2178561614661, 1009.2430676992255, 1030.7114008077751, 1033.075397519216, 10852.240343175901, 10949.945250273699, 11192.720181995515, 11236.83144752813, 11323.716907077223, 180284.0, 181073.0, 181456.0, 181578.0, 181986.0, 41097.0, 41361.79319103385, 41425.378619320734, 41429.0, 41473.0, 1233.0998371189082, 1268.5433244031956, 1277.150694787974, 1280.2830414967648, 1303.9348032598332, 19721.70417443768, 20061.398158055283, 20548.589028219052, 20561.38315850527, 20675.276365327743, 29518.376489293296, 29764.85117574398, 29858.552121717756, 29871.0, 29930.25174370658, 147693.0, 148021.25989369984, 148249.0, 148542.0, 148552.25723871312, 29157.70842291635, 29295.56056659109, 29453.410931781673, 30947.226319342197, 30984.971953645883, 36606.816965915, 36817.447738284485, 37335.626643733216, 37402.625973739916, 37458.812705936296, 26693.19920402391, 27493.86253068722, 27599.17202483929, 28061.438771224868, 28508.0, 27699.44601108007, 28190.85904570464, 28455.857720711265, 29158.0, 29406.852965735034, 31356.686433135375, 31759.36481270408, 31772.187337519645, 31814.204644884063, 31835.681643184198, 26937.730622694307, 27181.738191417156, 27741.861290693418, 28194.154175374773, 28904.132876013755, 21762.12951481923, 22658.0, 22673.546529069656, 22823.20118795834, 22949.311520654406], "value": 14641.435146149834, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.14784005908217, 428.7491817286887, 433.1321300783999, 446.3572455663844, 452.5316297631949, 16602.252898619576, 17644.206010729515, 17977.64044719105, 18184.454466365998, 18312.175952082154, 18328.81671183288, 18510.35213767515, 18956.526086847836, 18986.71519927202, 19027.143778529964, 5485.341758988927, 5498.285222921015, 5683.0, 5693.715314234271, 5701.743421546041, 5601.495865372116, 5607.663540187602, 5610.495055445009, 5614.522765564911, 5625.634333768312, 5391.622586418933, 5576.442355764431, 5591.440855914417, 5592.133219351007, 5593.636413633121, 5505.678637127061, 5529.30883639545, 5571.5513966369035, 5572.442755724415, 5611.494965453129, 4993.975030124826, 5064.822731204427, 5078.5937125029905, 5126.2054381570915, 5133.204353325241, 21906.45233869166, 21950.0, 22495.550088998127, 22683.659745103836, 22770.886145569333, 1538.5615099696533, 1540.614846288428, 1540.6225474758755, 1540.9152496612683, 1572.874170066392, 14498.565043048726, 14686.706265874624, 14919.925400373037, 14996.700065998619, 15041.398344066334, 1997.4107638246608, 2067.4934641013047, 2117.5553133841913, 2119.448943274744, 2123.5540536487356, 80725.59637201835, 83755.0, 88166.0, 100139.49930250303, 101337.0, 11191.32852028881, 11553.191276610556, 11569.88430115705, 11583.478743456564, 11784.646460606196, 16191.676166476604, 16211.432599858948, 16213.59466013359, 16214.59463513398, 16236.67526649484, 7570.735024274234, 7873.763787086396, 7900.44696871225, 8049.51702897828, 8092.190780921861, 6858.759943401957, 6940.895886561706, 7191.244919283505, 7412.592307423036, 7414.925850741532, 7104.92895071053, 7240.239774823673, 7263.92736072643, 7351.926480735124, 7352.0, 2101.978980210209, 2134.509062915538, 2135.11392772001, 2141.5181584143443, 2240.1375470443995, 860.9053004169537, 892.0856122474515, 893.821235752852, 894.7763059235191, 930.5998420679038, 17299.0, 17406.39077632302, 18006.459806205836, 18112.72830907511, 18408.17163227658, 858.2661824140395, 872.2803686958284, 882.6028287270753, 882.8675698645126, 898.2544488074882, 9533.90466095344, 9619.615215391446, 9918.404895706137, 9933.801323973625, 10064.345817521838, 340424.0, 344769.0, 375031.0, 378592.0, 381415.0, 76183.23816761872, 79929.60035199787, 82275.58862205771, 82405.0, 83070.58464707638, 1104.1994553948323, 1109.9001089901785, 1161.2103769436865, 1164.470166074434, 1170.4206417823232, 17372.47882563525, 18184.181711823265, 18567.628647426707, 18650.626987459902, 18789.90605046966, 39269.803650981565, 39381.0, 39407.60592394039, 39504.0, 39580.40629390619, 48636.5136348632, 48660.5133948656, 48685.51314486952, 50439.74780126222, 50755.74622126866, 8400.747977560683, 8441.071482137082, 8564.143585641386, 8649.6972605961, 8878.733637990612, 13031.218126912416, 13198.868011319764, 13237.536686215935, 13248.403821827847, 13391.598252052454, 11165.38590377537, 11263.493142808757, 11273.267237629529, 11380.829287560859, 11630.360330181922, 10454.843177352497, 10551.736206594896, 10752.516136773707, 10754.354738715701, 10980.560777569128, 11410.258333208314, 11469.0, 11555.248908821237, 11923.224990375598, 12011.0, 8291.83416331658, 8318.542480163407, 8510.276626486819, 8531.8720219198, 8564.357673174662, 10394.272400931863, 10496.475176241005, 10952.178586605876, 11022.724431889266, 11303.095752339957], "value": 9056.108964902258, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1280.206272111291, 1324.7482978234134, 1327.7875539913612, 1334.2661536155113, 1340.323136815908, 9768.218542516599, 10037.447940363296, 10166.898331016697, 10169.237307201962, 10452.0, 10070.949645251763, 10245.743856403575, 10264.127549158331, 10267.281290309662, 10296.48517574122, 2222.611043067465, 2239.216274303989, 2251.0883092347626, 2259.3334966184934, 2259.728832540089, 2206.4263291544235, 2239.9104035838545, 2246.2362796649136, 2248.4378905273684, 2253.2902135827244, 2177.682502086239, 2177.8693278403266, 2219.034719896842, 2219.556088782242, 2221.677856710776, 2059.8361925512186, 2129.595376878396, 2162.2216002239184, 2164.7835216478384, 2168.4795649044195, 2022.0, 2156.2884248198056, 2158.6006588781124, 2161.9567608647894, 2166.7724888886596, 9672.22622190223, 9681.903180968242, 9745.463999480025, 9753.073458021476, 9762.853557196648, 5656.151577263402, 5865.824025279248, 5867.8533036674, 5893.882122357529, 5898.970505147447, 3241.448953677857, 3429.176997520602, 3487.581490221164, 3490.5811302643847, 3514.525539052246, 1082.1937656445918, 1107.5625128074366, 1110.0675432636624, 1180.984353456027, 1190.8630507491662, 15135.545933622008, 15209.011414258148, 15239.23803809805, 15286.923565382102, 15349.769753453707, 4584.358189853423, 4683.906321873544, 4887.780049897692, 4896.853094407174, 4954.157793175169, 10631.202659800545, 10643.308184967953, 10648.893511064945, 10654.414007229676, 10656.627018054485, 5599.888002239933, 5622.212890195376, 5629.54963602919, 5635.21107045014, 5636.802711905146, 5172.172452407597, 5200.453952335026, 5216.921746173811, 5233.979374022106, 5347.465253474621, 3771.6794072503594, 3925.0, 3931.4889064422014, 3955.88132356024, 4012.7191096622955, 1124.1681155944705, 1127.3236058364917, 1136.7499150186945, 1146.266389510714, 1153.0544953138515, 679.1714108787272, 708.2421808664782, 709.2765379313072, 724.1961422820665, 725.354434553248, 5171.534561889448, 5288.338957630296, 5330.893382132335, 5330.9604627098115, 5424.457554244544, 815.1563132158187, 831.7587899509075, 835.1690068381998, 835.4026870787416, 842.073718909195, 3493.8951831445097, 3654.634536546377, 3695.2978934002454, 3709.109813644706, 3721.2557488502407, 12702.491900323883, 13556.0, 13562.321883905764, 13583.32083395846, 13597.388117534734, 13380.6654833628, 13435.193888366533, 13527.0, 13539.59381218565, 13561.186328820106, 7466.440016998638, 7540.434467414966, 7571.962140189374, 7658.081030276402, 7668.501547399401, 5492.176173573996, 5527.309086364205, 5645.943540564542, 5675.4040825714355, 5804.709764511673, 11758.3532905691, 11801.586944456903, 11835.112366572714, 11921.403929803648, 11933.0, 12020.939895300467, 12068.0, 12210.206336588093, 12324.19892707007, 12334.876651233373, 7347.8163045924275, 7543.924560754542, 7545.50954187976, 7552.735654252075, 7569.394448444001, 9439.05609439078, 9510.524473776422, 9535.427874327563, 9536.666216682383, 9561.043895610383, 7751.0, 8139.267465928095, 8352.206540378655, 8367.62345694433, 8379.0, 7957.5225486471, 7968.920310796818, 7989.640466179152, 8011.359091272568, 8068.07217170033, 7287.526310789782, 7397.445191610758, 7405.074365704287, 7441.144268409203, 7471.663775130023, 5007.098722230034, 5156.510131537498, 5184.248283998874, 5214.191800270964, 5429.049916264717, 5322.866928326823, 5355.544778693855, 5359.0, 5446.21029950647, 5593.860153496195], "value": 4728.684284414028, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.0253893684825, 398.57153559923074, 398.59144377013564, 400.8897553172877, 404.46408508725943, 5494.752736126874, 5541.390447050821, 5576.219329293902, 5623.212750214968, 5627.7186140693, 5407.972960135204, 5492.423295553969, 5498.615096943216, 5504.119340905456, 5512.834614961547, 4168.812403441852, 4172.248995180867, 4184.7070705050655, 4189.141226048653, 4197.958020419803, 4094.0, 4149.502059752834, 4171.332586786115, 4183.309753890604, 4190.161967606491, 4091.8363265469347, 4095.7542547447247, 4116.9090191099385, 4123.309637874116, 4137.1725654869, 4114.547399786021, 4115.362118871565, 4121.443605113316, 4129.070959034223, 4139.2963196256405, 3593.4969104325414, 3620.945685814715, 3623.547056617923, 3629.1108678373703, 3634.0, 5045.369328833895, 5215.16557350822, 5241.528262456397, 5273.182656688219, 5274.97362513185, 4884.169691152512, 4892.902141957176, 4904.337914381548, 4910.90178196434, 4927.137750893579, 5746.9712651436475, 5843.474087332161, 5847.122931560258, 5863.442972917566, 5872.295324561037, 4041.3129767939226, 4043.898902527431, 4054.2702313583545, 4057.5942405759483, 4068.3897415387632, 6006.738584897177, 6140.201773769426, 6149.938500614981, 6178.980468222738, 6187.969060154715, 4112.177564487115, 4118.9588104118575, 4120.690948178899, 4125.525564560114, 4125.91748165035, 4209.190048279208, 4218.578142185757, 4224.683148763855, 4226.281532139544, 4227.281362168439, 4752.500987396343, 4831.130396528659, 4864.36763220779, 4866.562009419169, 4874.975625121851, 5806.0, 5812.3025236971835, 5814.186013958049, 5815.389384114607, 5825.592208545361, 1435.1245740098532, 1440.2654646130338, 1448.0804689022546, 1450.0574626492653, 1458.5259790568107, 936.7470782888582, 964.7973925475588, 966.8743063401713, 981.5484876956538, 983.306768728045, 4980.8046068943195, 4999.725015124203, 5008.549230569193, 5023.472535383805, 5023.899522009612, 5974.0, 5991.370906054802, 5998.760049597967, 6004.129401236796, 6022.759089636453, 4916.115099282163, 4982.501749824988, 5000.249962505581, 5007.4491805901325, 5027.974860125676, 3160.6997335253113, 3167.7782555220915, 3184.490481522945, 3195.012663159953, 3201.183698156955, 5450.672959622356, 5538.307711536058, 5550.555955523549, 5550.91673624896, 5566.359868615161, 6143.385661433821, 6157.96921015401, 6163.506919446433, 6172.814815555541, 6179.5056395488255, 5513.558915286768, 5549.417311182267, 5549.861253468614, 5553.888922221533, 5574.804881829116, 5810.6513609183585, 5997.880042399041, 6047.123167140828, 6117.694115294306, 6135.913789311477, 5784.363719990713, 6003.249593800775, 6019.458248757633, 6023.156758053964, 6031.019527112085, 5593.440655934374, 5594.0769772987005, 5617.269754931833, 5617.5505959522325, 5634.605577609692, 4104.117614712851, 4139.461869956886, 4155.8961025974595, 4164.541900391016, 4168.979155104205, 5874.265716785402, 6011.699415029144, 6018.428249316308, 6049.51603871698, 6060.878782424415, 5836.620619659709, 5851.1515830205235, 5859.2382990211, 5859.531237501075, 5879.0, 5758.913616295675, 5835.716142448655, 5836.737346819318, 5854.4730974212525, 5901.5868889177345, 5756.856078598069, 5810.76756929735, 5815.534757219497, 5823.621464604787, 5834.358220595816, 5922.851928701644, 5929.814037192493, 5943.762249509971, 5952.821415357546, 5960.374160713236, 5662.66024038559, 5744.0, 5753.626014309057, 5762.250907382014, 5790.1893734877995], "value": 4354.9052040622, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [671.919369675639, 671.9764808231713, 679.2833560593573, 684.6063513479747, 687.1513680604454, 12682.61952141435, 13045.412956416973, 13067.150635208705, 14150.221737804417, 15327.080375177497, 14060.859391406082, 14584.854151458483, 14781.260936953136, 14923.925380373083, 14940.477083302087, 885.1900511032413, 905.4069584422214, 910.0535443139128, 910.8360495110877, 911.2300106410106, 850.2093053460279, 889.7820034091657, 899.2670973156889, 899.5771987166022, 899.8560230363144, 906.026022026321, 937.3485427627768, 941.3645789092369, 941.3880977364734, 944.1832814615343, 888.6534251641865, 930.3115694386173, 935.6257497001186, 936.2135805923024, 936.6768464879606, 659.2747977225062, 673.2997682410287, 687.2131409536103, 688.686647575352, 691.9584824910521, 13393.464261429532, 13468.797968030487, 13544.187348759106, 13585.52450664222, 13908.721825563533, 15600.921995390065, 15708.68582628341, 15901.284442200129, 16058.919705401515, 16104.355825766956, 12359.25844449336, 12498.687532811662, 12604.936975315064, 12628.179168354027, 12637.052221083455, 2678.8660566971575, 2694.393761403688, 2710.986445067782, 2714.5520989036786, 2714.6335244742104, 62873.68563157201, 63014.68492657553, 63261.683691581246, 64753.0, 70715.0, 12129.575464858865, 12665.860072593327, 12831.807522887164, 12941.09412341146, 12953.0, 19239.615207695766, 19609.215631374584, 19802.70295945562, 19827.603447931248, 20641.48396290105, 6172.351903050205, 6251.4061164189325, 6303.779367722108, 6358.682065896779, 6375.968120159369, 2882.5964364988918, 2910.8690108944725, 2920.2115428834095, 2929.033418971734, 2932.0910517739567, 3489.755717099779, 3542.929141417157, 3560.038789526865, 3563.768355056913, 3570.553680789901, 769.9923000770033, 779.2129948751689, 780.4614815777096, 785.3010820369761, 788.8146285622875, 562.9915551266735, 575.5453191978374, 578.1587789765881, 579.3135134865198, 605.2555356911024, 9880.160186384237, 10166.186705063577, 10277.845832312521, 10287.691369258935, 10385.896141038493, 550.2461627570254, 559.2533967153895, 560.5039540007123, 575.318247876268, 588.0326862311474, 4468.128714900628, 4623.69945953512, 4636.44362676481, 4663.253879379283, 4776.832810851603, 60522.69738651367, 61546.384536154066, 61661.0, 62221.68889155616, 62266.0, 56167.43832561704, 56376.43623563794, 56812.43187568154, 57196.42803571911, 57803.0, 50871.23693144606, 52157.913683452236, 52430.47569524332, 52572.21141682878, 52806.20790688143, 9390.201832844285, 9410.717678469657, 9595.952020239854, 9662.75843103928, 9763.707088787347, 26507.0, 26673.46653066889, 27164.592531111655, 27409.58885616757, 27892.58161127544, 31635.36729265356, 31934.083954962778, 31958.201044974063, 32357.676423235465, 32509.0, 11686.0, 11850.822237666614, 11940.701482463008, 12033.157678962738, 12172.878271217174, 12571.245725256515, 12727.872721272668, 12852.614421567368, 13027.153235039692, 13114.803277951029, 11848.407579621156, 13366.86633133695, 13781.655458613615, 14649.0, 14758.262086895398, 14403.9197060223, 14509.0, 14793.704125917206, 14896.702065958403, 15021.248937553297, 13792.310384480536, 14006.36971336272, 14048.297585120907, 14257.287135643384, 14453.927730361282, 9763.804723905625, 9841.409515429097, 10254.897451025394, 10296.433696146783, 10617.150627949592, 10230.48847557634, 11035.337879727242, 11518.424078796193, 11526.59656912004, 11561.884381156417], "value": 6667.693267596117, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1540.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 110.0, 112.0, 112.0, 112.0, 112.0, 112.0, 117.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 121.0, 126.0, 164.0, 124.0, 124.0, 123.0, 124.0, 142.0, 124.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 165.0, 164.0, 167.0, 165.0, 173.0, 163.0, 165.0, 163.0], "value": 165.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 112.0, 76.0, 74.0, 78.0, 76.0, 93.0, 75.0], "value": 80.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 116.0, 84.0, 84.0, 83.0, 103.0, 84.0, 82.0, 110.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 113.0, 114.0, 114.0, 114.0, 116.0, 114.0, 117.0, 113.0, 113.0], "value": 114.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 149.0, 149.0, 152.0, 151.0, 150.0, 150.0, 155.0, 155.0], "value": 151.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 97.0, 95.0, 94.0, 95.0, 94.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 53.0, 54.0, 55.0, 55.0, 53.0, 56.0, 54.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 55.0, 55.0, 56.0, 56.0, 58.0, 60.0, 56.0, 55.0], "value": 56.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 81.0, 82.0, 83.0, 91.0, 82.0, 81.0, 94.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 134.0, 135.0, 131.0, 129.0, 132.0, 132.0, 139.0, 193.0, 134.0], "value": 139.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 188.0, 188.0, 195.0, 191.0, 189.0, 187.0, 187.0, 190.0, 195.0], "value": 189.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 74.0, 73.0, 77.0, 76.0, 79.0, 74.0, 77.0, 77.0, 74.0], "value": 75.9, "unit": "score"}]}]} 04:42:00 INFO - Return code: 0 04:42:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:42:00 INFO - # TBPL SUCCESS # 04:42:00 INFO - Running post-action listener: _resource_record_post_action 04:42:00 INFO - [mozharness: 2017-05-11 11:42:00.562972Z] Finished run-tests step (success) 04:42:00 INFO - Running post-run listener: _resource_record_post_run 04:42:00 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 0; Write bytes: 375365632; Read time: 0; Write time: 227480 04:42:00 INFO - TinderboxPrint: CPU usage
13.3% 04:42:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:42:00 INFO - TinderboxPrint: I/O write bytes / time
375,365,632 / 227,480 04:42:00 INFO - TinderboxPrint: CPU idle
8,296.6 (86.7%) 04:42:00 INFO - TinderboxPrint: CPU user
1,220.1 (12.7%) 04:42:00 INFO - TinderboxPrint: Swap in / out
0 / 0 04:42:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 95346688; Read time: 0; Write time: 71352 04:42:00 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 0; Write bytes: 280018944; Read time: 0; Write time: 156128 04:42:01 INFO - Running post-run listener: _upload_blobber_files 04:42:01 INFO - Blob upload gear active. 04:42:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:42:01 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 04:42:01 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'] 04:42:01 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 04:42:01 INFO - (blobuploader) - INFO - Open directory for files ... 04:42:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:42:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:42:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:03 INFO - (blobuploader) - INFO - Done attempting. 04:42:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:42:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:42:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:08 INFO - (blobuploader) - INFO - Done attempting. 04:42:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:42:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:42:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:10 INFO - (blobuploader) - INFO - Done attempting. 04:42:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:42:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:42:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:42:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:42:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:42:11 INFO - (blobuploader) - INFO - Done attempting. 04:42:11 INFO - (blobuploader) - INFO - Iteration through files over. 04:42:11 INFO - Return code: 0 04:42:11 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:42:11 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:42:11 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d11698a16dbdbc779f4ef1994b611d8642bcbf5a57083abdc8fdb0b2b3de99af69ce47a389453b42d71b2e1abe7bf046cc9b8aa8698c224b01a7d68d58b67ed5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d01408a4ae296a9f7c432dd2937c8fed264e4566d288002a65ec9d9b4f921f9d8d3d30e62493b86daf234edc9cb039bd28c663e23e21a846404149d9751f33da", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e516fdc6b7c0c6dbf4750a286179fc473d1afbe29b454a8fb2ba33b300b0b6155d25569a473f6fd24233ef091ec33a9133cb4d5878754cd55e131aecc7e0de6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ac4c1bd47c51ad8f779cc60eedc9abe433f291abe5aae5aed34d4336f4edfca3875cb9cc9e1a0285fa3ab4f1a35320574fe7f0080cd46abba13aa7b1d7ceb6"} 04:42:11 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:42:11 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:42:11 INFO - Contents: 04:42:11 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d11698a16dbdbc779f4ef1994b611d8642bcbf5a57083abdc8fdb0b2b3de99af69ce47a389453b42d71b2e1abe7bf046cc9b8aa8698c224b01a7d68d58b67ed5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d01408a4ae296a9f7c432dd2937c8fed264e4566d288002a65ec9d9b4f921f9d8d3d30e62493b86daf234edc9cb039bd28c663e23e21a846404149d9751f33da", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e516fdc6b7c0c6dbf4750a286179fc473d1afbe29b454a8fb2ba33b300b0b6155d25569a473f6fd24233ef091ec33a9133cb4d5878754cd55e131aecc7e0de6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ac4c1bd47c51ad8f779cc60eedc9abe433f291abe5aae5aed34d4336f4edfca3875cb9cc9e1a0285fa3ab4f1a35320574fe7f0080cd46abba13aa7b1d7ceb6"} 04:42:11 INFO - Running post-run listener: copy_logs_to_upload_dir 04:42:11 INFO - Copying logs to upload dir... 04:42:11 INFO - mkdir: /builds/slave/test/build/upload/logs 04:42:11 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.050788 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-05-11 04:42:11.550943) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 04:42:11.555166) ========= 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=9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d11698a16dbdbc779f4ef1994b611d8642bcbf5a57083abdc8fdb0b2b3de99af69ce47a389453b42d71b2e1abe7bf046cc9b8aa8698c224b01a7d68d58b67ed5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d01408a4ae296a9f7c432dd2937c8fed264e4566d288002a65ec9d9b4f921f9d8d3d30e62493b86daf234edc9cb039bd28c663e23e21a846404149d9751f33da", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e516fdc6b7c0c6dbf4750a286179fc473d1afbe29b454a8fb2ba33b300b0b6155d25569a473f6fd24233ef091ec33a9133cb4d5878754cd55e131aecc7e0de6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ac4c1bd47c51ad8f779cc60eedc9abe433f291abe5aae5aed34d4336f4edfca3875cb9cc9e1a0285fa3ab4f1a35320574fe7f0080cd46abba13aa7b1d7ceb6"} build_url:https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011293 build_url: 'https://queue.taskcluster.net/v1/task/PcSUnUguQIy26YLH-FWgaQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d11698a16dbdbc779f4ef1994b611d8642bcbf5a57083abdc8fdb0b2b3de99af69ce47a389453b42d71b2e1abe7bf046cc9b8aa8698c224b01a7d68d58b67ed5", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d01408a4ae296a9f7c432dd2937c8fed264e4566d288002a65ec9d9b4f921f9d8d3d30e62493b86daf234edc9cb039bd28c663e23e21a846404149d9751f33da", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4e516fdc6b7c0c6dbf4750a286179fc473d1afbe29b454a8fb2ba33b300b0b6155d25569a473f6fd24233ef091ec33a9133cb4d5878754cd55e131aecc7e0de6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c5ac4c1bd47c51ad8f779cc60eedc9abe433f291abe5aae5aed34d4336f4edfca3875cb9cc9e1a0285fa3ab4f1a35320574fe7f0080cd46abba13aa7b1d7ceb6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-11 04:42:11.585461) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:42:11.585813) ========= 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=9f7544b6a75ada7b6b576032000001a7-1494501649.436951-1053586726 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-11 04:42:11.670826) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 04:42:11.671214) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-11 04:42:11.672014) ========= ========= Total master_lag: 0.18 =========